builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0312 starttime: 1467167104.96 results: success (0) buildid: 20160628171728 builduid: b4b8b492ab254b3f86757e58e9619c88 revision: a1eab626db95522e838cdb9120e22d129fd08c01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:04.959985) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:04.960394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:04.960741) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:05.046641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:05.047026) ========= 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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-28 19:25:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.5M=0.001s 2016-06-28 19:25:05 (16.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.485691 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:05.559610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:05.559955) ========= 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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.025882 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:05.611722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-28 19:25:05.612397) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a1eab626db95522e838cdb9120e22d129fd08c01 --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 a1eab626db95522e838cdb9120e22d129fd08c01 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pUKqPSw1pK/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.0qQcSbzAvH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-28 19:25:05,693 truncating revision to first 12 chars 2016-06-28 19:25:05,693 Setting DEBUG logging. 2016-06-28 19:25:05,693 attempt 1/10 2016-06-28 19:25:05,693 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a1eab626db95?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 19:25:07,265 unpacking tar archive at: autoland-a1eab626db95/testing/mozharness/ program finished with exit code 0 elapsedTime=1.841463 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-28 19:25:07.872960) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:07.873292) ========= script_repo_revision: a1eab626db95522e838cdb9120e22d129fd08c01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:07.873733) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:07.874045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 19:25:07.925532) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-06-28 19:25:07.925936) ========= /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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:25:08 INFO - MultiFileLogger online at 20160628 19:25:08 in /builds/slave/test 19:25: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 19:25:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:25:08 INFO - {'append_to_log': False, 19:25:08 INFO - 'base_work_dir': '/builds/slave/test', 19:25:08 INFO - 'blob_upload_branch': 'Autoland', 19:25:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:25:08 INFO - 'branch': 'Autoland', 19:25:08 INFO - 'buildbot_json_path': 'buildprops.json', 19:25:08 INFO - 'config_files': ('talos/mac_config.py',), 19:25:08 INFO - 'default_actions': ('clobber', 19:25:08 INFO - 'read-buildbot-config', 19:25:08 INFO - 'download-and-extract', 19:25:08 INFO - 'populate-webroot', 19:25:08 INFO - 'create-virtualenv', 19:25:08 INFO - 'install', 19:25:08 INFO - 'run-tests'), 19:25:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:25:08 INFO - 'download_minidump_stackwalk': True, 19:25:08 INFO - 'download_symbols': 'ondemand', 19:25:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:25:08 INFO - 'tooltool.py': '/tools/tooltool.py', 19:25:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:25:08 INFO - '/tools/misc-python/virtualenv.py')}, 19:25:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:25:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:25:08 INFO - 'installer_path': 'installer.exe', 19:25:08 INFO - 'log_level': 'info', 19:25:08 INFO - 'log_name': 'talos', 19:25:08 INFO - 'log_to_console': True, 19:25:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:25:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:25:08 INFO - 'opt_config_files': (), 19:25:08 INFO - 'pip_index': False, 19:25:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:25:08 INFO - 'cmd': ('bash', 19:25:08 INFO - '-c', 19:25:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:25:08 INFO - 'enabled': True, 19:25:08 INFO - 'halt_on_failure': False, 19:25:08 INFO - 'name': 'check_screen_resolution'},), 19:25:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:25:08 INFO - 'cmd': ('bash', 19:25:08 INFO - '-c', 19:25:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:25:08 INFO - 'enabled': True, 19:25:08 INFO - 'halt_on_failure': False, 19:25:08 INFO - 'name': 'check_screen_resolution'},), 19:25:08 INFO - 'run_cmd_checks_enabled': True, 19:25:08 INFO - 'sps_profile': False, 19:25:08 INFO - 'sps_profile_interval': 0, 19:25:08 INFO - 'suite': 'dromaeojs', 19:25:08 INFO - 'system_bits': '32', 19:25:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:25:08 INFO - 'title': 't-yosemite-r7-0312', 19:25:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:25:08 INFO - 'use_talos_json': True, 19:25:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:25:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:25:08 INFO - 'work_dir': 'build'} 19:25:08 INFO - ##### 19:25:08 INFO - ##### Running clobber step. 19:25:08 INFO - ##### 19:25:08 INFO - Running pre-action listener: _resource_record_pre_action 19:25:08 INFO - Running main action method: clobber 19:25:08 INFO - rmtree: /builds/slave/test/build 19:25:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:25:09 INFO - Running post-action listener: _resource_record_post_action 19:25:09 INFO - ##### 19:25:09 INFO - ##### Finished clobber step (success) 19:25:09 INFO - ##### 19:25:09 INFO - ##### 19:25:09 INFO - ##### Running read-buildbot-config step. 19:25:09 INFO - ##### 19:25:09 INFO - Running pre-action listener: _resource_record_pre_action 19:25:09 INFO - Running main action method: read_buildbot_config 19:25:09 INFO - Using buildbot properties: 19:25:09 INFO - { 19:25:09 INFO - "project": "", 19:25:09 INFO - "product": "firefox", 19:25:09 INFO - "script_repo_revision": "production", 19:25:09 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 19:25:09 INFO - "repository": "", 19:25:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 19:25:09 INFO - "buildid": "20160628171728", 19:25:09 INFO - "pgo_build": "False", 19:25:09 INFO - "basedir": "/builds/slave/test", 19:25:09 INFO - "buildnumber": 0, 19:25:09 INFO - "slavename": "t-yosemite-r7-0312", 19:25:09 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 19:25:09 INFO - "platform": "yosemite_r7", 19:25:09 INFO - "scheduler": "tests-autoland-macosx64-talos", 19:25:09 INFO - "branch": "autoland", 19:25:09 INFO - "repo_path": "integration/autoland", 19:25:09 INFO - "revision": "a1eab626db95522e838cdb9120e22d129fd08c01", 19:25:09 INFO - "stage_platform": "macosx64", 19:25:09 INFO - "builduid": "b4b8b492ab254b3f86757e58e9619c88", 19:25:09 INFO - "slavebuilddir": "test" 19:25:09 INFO - } 19:25:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 19:25:09 INFO - Running post-action listener: _resource_record_post_action 19:25:09 INFO - ##### 19:25:09 INFO - ##### Finished read-buildbot-config step (success) 19:25:09 INFO - ##### 19:25:09 INFO - ##### 19:25:09 INFO - ##### Running download-and-extract step. 19:25:09 INFO - ##### 19:25:09 INFO - Running pre-action listener: _resource_record_pre_action 19:25:09 INFO - Running main action method: download_and_extract 19:25:09 INFO - mkdir: /builds/slave/test/build/tests 19:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:09 INFO - https://queue.taskcluster.net/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:25:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:25:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:25:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/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 19:25:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/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 19:25:16 INFO - Downloaded 1199 bytes. 19:25:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:25:16 INFO - Using the following test package requirements: 19:25:16 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:25:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:25:16 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 19:25:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:25:16 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 19:25:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:25:16 INFO - u'jsshell-mac.zip'], 19:25:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:25:16 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 19:25:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:25:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:25:16 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 19:25:16 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:25:16 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 19:25:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:25:16 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 19:25:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:25:16 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 19:25:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:16 INFO - https://queue.taskcluster.net/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:25:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:25:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:25:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/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 19:25:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/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 19:25:23 INFO - Downloaded 18786920 bytes. 19:25:23 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'] 19:25:23 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 19:25:26 INFO - Return code: 0 19:25:26 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 19:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:26 INFO - https://queue.taskcluster.net/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:25:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:25:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:25:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/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 19:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/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 19:25:33 INFO - Downloaded 18786920 bytes. 19:25:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:25:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:25:36 INFO - Return code: 0 19:25:36 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')]} 19:25:36 INFO - https://queue.taskcluster.net/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/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 19:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/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 19:25:38 INFO - Downloaded 14405245 bytes. 19:25:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:25:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:25:38 INFO - Return code: 0 19:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:38 INFO - https://queue.taskcluster.net/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:25:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:25:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:25:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 19:25:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjtId96RQsa4QTTO77mwTQ/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 19:25:42 INFO - Downloaded 112354456 bytes. 19:25:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:25:42 INFO - mkdir: /builds/slave/test/properties 19:25:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:25:42 INFO - Writing to file /builds/slave/test/properties/build_url 19:25:42 INFO - Contents: 19:25:42 INFO - build_url:https://queue.taskcluster.net/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:25:43 INFO - Running post-action listener: _resource_record_post_action 19:25:43 INFO - Running post-action listener: set_extra_try_arguments 19:25:43 INFO - ##### 19:25:43 INFO - ##### Finished download-and-extract step (success) 19:25:43 INFO - ##### 19:25:43 INFO - ##### 19:25:43 INFO - ##### Running populate-webroot step. 19:25:43 INFO - ##### 19:25:43 INFO - Running pre-action listener: _resource_record_pre_action 19:25:43 INFO - Running main action method: populate_webroot 19:25:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:25:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:25:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:25:43 INFO - '--tppagecycles', 19:25:43 INFO - '7'], 19:25:43 INFO - 'tests': ['tsvgm']}}, 19:25:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:25:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:25:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:25:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:25:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:25:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:25:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:43 INFO - 'talos_options': ['--disable-e10s'], 19:25:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:25:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:25:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:43 INFO - 'talos_options': ['--disable-e10s'], 19:25:43 INFO - 'tests': ['damp', 'tps']}, 19:25:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:43 INFO - 'tests': ['damp', 'tps']}, 19:25:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:25:43 INFO - 'tests': ['dromaeo_dom']}, 19:25:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:25:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:25:43 INFO - 'tests': ['basic_compositor_video']}, 19:25:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:25:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:25:43 INFO - 'tests': ['a11yr', 19:25:43 INFO - 'ts_paint', 19:25:43 INFO - 'tpaint', 19:25:43 INFO - 'sessionrestore', 19:25:43 INFO - 'sessionrestore_no_auto_restore', 19:25:43 INFO - 'tabpaint']}, 19:25:43 INFO - 'other-e10s': {'tests': ['a11yr', 19:25:43 INFO - 'ts_paint', 19:25:43 INFO - 'tpaint', 19:25:43 INFO - 'sessionrestore', 19:25:43 INFO - 'sessionrestore_no_auto_restore', 19:25:43 INFO - 'tabpaint']}, 19:25:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:25:43 INFO - 'ts_paint', 19:25:43 INFO - 'tpaint', 19:25:43 INFO - 'sessionrestore', 19:25:43 INFO - 'sessionrestore_no_auto_restore', 19:25:43 INFO - 'tabpaint']}, 19:25:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:25:43 INFO - 'ts_paint', 19:25:43 INFO - 'tpaint', 19:25:43 INFO - 'sessionrestore', 19:25:43 INFO - 'sessionrestore_no_auto_restore', 19:25:43 INFO - 'tabpaint']}, 19:25:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:25:43 INFO - 'tests': ['a11yr', 19:25:43 INFO - 'ts_paint', 19:25:43 INFO - 'tpaint', 19:25:43 INFO - 'sessionrestore', 19:25:43 INFO - 'sessionrestore_no_auto_restore', 19:25:43 INFO - 'tabpaint']}, 19:25:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:25:43 INFO - 'tests': ['a11yr', 19:25:43 INFO - 'ts_paint', 19:25:43 INFO - 'tpaint', 19:25:43 INFO - 'sessionrestore', 19:25:43 INFO - 'sessionrestore_no_auto_restore', 19:25:43 INFO - 'tabpaint']}, 19:25:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:25:43 INFO - 'tests': ['tsvgx', 19:25:43 INFO - 'tsvgr_opacity', 19:25:43 INFO - 'tart', 19:25:43 INFO - 'tscrollx', 19:25:43 INFO - 'cart']}, 19:25:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:25:43 INFO - 'tsvgr_opacity', 19:25:43 INFO - 'tart', 19:25:43 INFO - 'tscrollx', 19:25:43 INFO - 'cart']}, 19:25:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:43 INFO - 'talos_options': ['--disable-e10s'], 19:25:43 INFO - 'tests': ['tp5o']}, 19:25:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:43 INFO - 'tests': ['tp5o']}, 19:25:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:43 INFO - 'talos_options': ['--disable-e10s', 19:25:43 INFO - '--xperf_path', 19:25:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:25:43 INFO - 'tests': ['tp5n']}, 19:25:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:25:43 INFO - 'talos_options': ['--xperf_path', 19:25:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:25:43 INFO - 'tests': ['tp5n']}}, 19:25:43 INFO - 'talos.zip': {'path': '', 19:25:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:25:43 INFO - Running post-action listener: _resource_record_post_action 19:25:43 INFO - ##### 19:25:43 INFO - ##### Finished populate-webroot step (success) 19:25:43 INFO - ##### 19:25:43 INFO - ##### 19:25:43 INFO - ##### Running create-virtualenv step. 19:25:43 INFO - ##### 19:25:43 INFO - Running pre-action listener: _resource_record_pre_action 19:25:43 INFO - Running main action method: create_virtualenv 19:25:43 INFO - Creating virtualenv /builds/slave/test/build/venv 19:25:43 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 19:25:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:25:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:25:43 INFO - Using real prefix '/tools/python27' 19:25:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:25:43 INFO - Installing distribute.............................................................................................................................................................................................done. 19:25:46 INFO - Installing pip.................done. 19:25:46 INFO - Return code: 0 19:25:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107d17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf18c52970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c7bd30>, '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 0x1079e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c73b20>, '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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:25:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pUKqPSw1pK/Render', 19:25:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:46 INFO - 'HOME': '/Users/cltbld', 19:25:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:46 INFO - 'LOGNAME': 'cltbld', 19:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:46 INFO - 'MOZ_NO_REMOTE': '1', 19:25:46 INFO - 'NO_EM_RESTART': '1', 19:25:46 INFO - 'PAGER': '/bin/cat', 19:25:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:46 INFO - 'PWD': '/builds/slave/test', 19:25:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:46 INFO - 'SHELL': '/bin/bash', 19:25:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qQcSbzAvH/Listeners', 19:25:46 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:25:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:46 INFO - 'USER': 'cltbld', 19:25:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:46 INFO - 'XPC_FLAGS': '0x0', 19:25:46 INFO - 'XPC_SERVICE_NAME': '0', 19:25:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:47 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 19:25:47 INFO - Cleaning up... 19:25:47 INFO - Return code: 0 19:25:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:47 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 0x107d17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf18c52970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c7bd30>, '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 0x1079e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c73b20>, '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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:25:47 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 19:25:47 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 19:25:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pUKqPSw1pK/Render', 19:25:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:47 INFO - 'HOME': '/Users/cltbld', 19:25:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:47 INFO - 'LOGNAME': 'cltbld', 19:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:47 INFO - 'MOZ_NO_REMOTE': '1', 19:25:47 INFO - 'NO_EM_RESTART': '1', 19:25:47 INFO - 'PAGER': '/bin/cat', 19:25:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:47 INFO - 'PWD': '/builds/slave/test', 19:25:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:47 INFO - 'SHELL': '/bin/bash', 19:25:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qQcSbzAvH/Listeners', 19:25:47 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:25:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:47 INFO - 'USER': 'cltbld', 19:25:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:47 INFO - 'XPC_FLAGS': '0x0', 19:25:47 INFO - 'XPC_SERVICE_NAME': '0', 19:25:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:47 INFO - Downloading/unpacking psutil>=3.1.1 19:25:47 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 19:25:47 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 19:25:47 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 19:25:47 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 19:25:47 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 19:25:47 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 19:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:25:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:25:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:25:50 INFO - Installing collected packages: psutil 19:25:50 INFO - Running setup.py install for psutil 19:25:50 INFO - building 'psutil._psutil_osx' extension 19:25:50 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 19:25:51 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 19:25:51 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 19:25:51 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 19:25:51 INFO - building 'psutil._psutil_posix' extension 19:25:51 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 19:25:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:25:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:25:51 INFO - ^ 19:25:51 INFO - 1 warning generated. 19:25:51 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 19:25:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:25:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:25:51 INFO - Successfully installed psutil 19:25:51 INFO - Cleaning up... 19:25:51 INFO - Return code: 0 19:25:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:25:51 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')]} 19:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:51 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')]} 19:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:51 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 0x107d17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf18c52970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c7bd30>, '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 0x1079e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c73b20>, '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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:25:51 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 19:25:51 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 19:25:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pUKqPSw1pK/Render', 19:25:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:51 INFO - 'HOME': '/Users/cltbld', 19:25:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:51 INFO - 'LOGNAME': 'cltbld', 19:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:51 INFO - 'MOZ_NO_REMOTE': '1', 19:25:51 INFO - 'NO_EM_RESTART': '1', 19:25:51 INFO - 'PAGER': '/bin/cat', 19:25:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:51 INFO - 'PWD': '/builds/slave/test', 19:25:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:51 INFO - 'SHELL': '/bin/bash', 19:25:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qQcSbzAvH/Listeners', 19:25:51 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:25:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:51 INFO - 'USER': 'cltbld', 19:25:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:51 INFO - 'XPC_FLAGS': '0x0', 19:25:51 INFO - 'XPC_SERVICE_NAME': '0', 19:25:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25: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 19:25:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:25:54 INFO - Installing collected packages: mozsystemmonitor 19:25:54 INFO - Running setup.py install for mozsystemmonitor 19:25:54 INFO - Successfully installed mozsystemmonitor 19:25:54 INFO - Cleaning up... 19:25:54 INFO - Return code: 0 19:25:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:25:54 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')]} 19:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:54 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')]} 19:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:54 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 0x107d17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf18c52970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c7bd30>, '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 0x1079e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c73b20>, '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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:25:54 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 19:25:54 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 19:25:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pUKqPSw1pK/Render', 19:25:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:54 INFO - 'HOME': '/Users/cltbld', 19:25:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:54 INFO - 'LOGNAME': 'cltbld', 19:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:54 INFO - 'MOZ_NO_REMOTE': '1', 19:25:54 INFO - 'NO_EM_RESTART': '1', 19:25:54 INFO - 'PAGER': '/bin/cat', 19:25:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:54 INFO - 'PWD': '/builds/slave/test', 19:25:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:54 INFO - 'SHELL': '/bin/bash', 19:25:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qQcSbzAvH/Listeners', 19:25:54 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:25:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:54 INFO - 'USER': 'cltbld', 19:25:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:54 INFO - 'XPC_FLAGS': '0x0', 19:25:54 INFO - 'XPC_SERVICE_NAME': '0', 19:25:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:55 INFO - Downloading/unpacking jsonschema==2.5.1 19:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:25:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:25:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:25:57 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 19:25:57 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 19:25:57 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 19:25:57 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 19:25:57 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 19:25:57 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 19:25:57 INFO - Downloading functools32-3.2.3-2.tar.gz 19:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:25:57 INFO - warning: no files found matching '*.txt' 19:25:57 INFO - no previously-included directories found matching 'build' 19:25:57 INFO - no previously-included directories found matching 'dist' 19:25:57 INFO - no previously-included directories found matching '.git*' 19:25:57 INFO - Installing collected packages: jsonschema, functools32 19:25:58 INFO - Running setup.py install for functools32 19:25:58 INFO - warning: no files found matching '*.txt' 19:25:58 INFO - no previously-included directories found matching 'build' 19:25:58 INFO - no previously-included directories found matching 'dist' 19:25:58 INFO - no previously-included directories found matching '.git*' 19:25:58 INFO - Successfully installed jsonschema functools32 19:25:58 INFO - Cleaning up... 19:25:58 INFO - Return code: 0 19:25:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:25:58 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 0x107d17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf18c52970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c7bd30>, '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 0x1079e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c73b20>, '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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:25:58 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 19:25:58 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 19:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pUKqPSw1pK/Render', 19:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:25:58 INFO - 'HOME': '/Users/cltbld', 19:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:25:58 INFO - 'LOGNAME': 'cltbld', 19:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:58 INFO - 'MOZ_NO_REMOTE': '1', 19:25:58 INFO - 'NO_EM_RESTART': '1', 19:25:58 INFO - 'PAGER': '/bin/cat', 19:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:58 INFO - 'PWD': '/builds/slave/test', 19:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:25:58 INFO - 'SHELL': '/bin/bash', 19:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qQcSbzAvH/Listeners', 19:25:58 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:25:58 INFO - 'USER': 'cltbld', 19:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:58 INFO - 'XPC_FLAGS': '0x0', 19:25:58 INFO - 'XPC_SERVICE_NAME': '0', 19:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:58 INFO - Downloading/unpacking blobuploader==1.2.4 19:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:00 INFO - Downloading blobuploader-1.2.4.tar.gz 19:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:26:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:26:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:02 INFO - Downloading docopt-0.6.1.tar.gz 19:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:26:02 INFO - Installing collected packages: blobuploader, requests, docopt 19:26:02 INFO - Running setup.py install for blobuploader 19:26:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:26:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:26:02 INFO - Running setup.py install for requests 19:26:02 INFO - Running setup.py install for docopt 19:26:02 INFO - Successfully installed blobuploader requests docopt 19:26:02 INFO - Cleaning up... 19:26:03 INFO - Return code: 0 19:26:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26:03 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')]} 19:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:03 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')]} 19:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:03 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 0x107d17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf18c52970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c7bd30>, '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 0x1079e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c73b20>, '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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:26:03 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 19:26:03 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 19:26:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pUKqPSw1pK/Render', 19:26:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:03 INFO - 'HOME': '/Users/cltbld', 19:26:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:03 INFO - 'LOGNAME': 'cltbld', 19:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:03 INFO - 'MOZ_NO_REMOTE': '1', 19:26:03 INFO - 'NO_EM_RESTART': '1', 19:26:03 INFO - 'PAGER': '/bin/cat', 19:26:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:03 INFO - 'PWD': '/builds/slave/test', 19:26:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:03 INFO - 'SHELL': '/bin/bash', 19:26:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qQcSbzAvH/Listeners', 19:26:03 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:26:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:03 INFO - 'USER': 'cltbld', 19:26:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:03 INFO - 'XPC_FLAGS': '0x0', 19:26:03 INFO - 'XPC_SERVICE_NAME': '0', 19:26:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:26:03 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-OPUvQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:26:03 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-FYb7Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:26:03 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-b6_t36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:26:03 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Lo4dJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:26:03 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Axbx3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:26:03 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ZFpb0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:26:03 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Z9WDiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:26:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Ky2QFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:26:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-aaOU_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:26:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-4J8zsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:26:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Y9p50e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:26:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Sq0917-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:26:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-VuZnSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:26:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-vgdMyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-vSThNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:26:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-dL2wuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:26:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-G54bIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:26:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:26:05 INFO - Running setup.py install for manifestparser 19:26:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:26:05 INFO - Running setup.py install for mozcrash 19:26:05 INFO - Running setup.py install for mozdebug 19:26:05 INFO - Running setup.py install for mozdevice 19:26:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:26:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:26:05 INFO - Running setup.py install for mozfile 19:26:05 INFO - Running setup.py install for mozhttpd 19:26:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:26:05 INFO - Running setup.py install for mozinfo 19:26:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:26:06 INFO - Running setup.py install for mozInstall 19:26:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:26:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:26:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:26:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:26:06 INFO - Running setup.py install for mozleak 19:26:06 INFO - Running setup.py install for mozlog 19:26:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:26:06 INFO - Running setup.py install for moznetwork 19:26:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:26:06 INFO - Running setup.py install for mozprocess 19:26:06 INFO - Running setup.py install for mozprofile 19:26:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:26:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:26:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:26:07 INFO - Running setup.py install for mozrunner 19:26:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:26:07 INFO - Running setup.py install for mozscreenshot 19:26:07 INFO - Running setup.py install for moztest 19:26:07 INFO - Running setup.py install for mozversion 19:26:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:26:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:26:07 INFO - Cleaning up... 19:26:07 INFO - Return code: 0 19:26:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26:07 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')]} 19:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:07 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')]} 19:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:07 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 0x107d17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf18c52970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c7bd30>, '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 0x1079e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c73b20>, '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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:26:07 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 19:26:07 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 19:26:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pUKqPSw1pK/Render', 19:26:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:07 INFO - 'HOME': '/Users/cltbld', 19:26:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:07 INFO - 'LOGNAME': 'cltbld', 19:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:07 INFO - 'MOZ_NO_REMOTE': '1', 19:26:07 INFO - 'NO_EM_RESTART': '1', 19:26:07 INFO - 'PAGER': '/bin/cat', 19:26:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:07 INFO - 'PWD': '/builds/slave/test', 19:26:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:07 INFO - 'SHELL': '/bin/bash', 19:26:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qQcSbzAvH/Listeners', 19:26:07 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:26:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:07 INFO - 'USER': 'cltbld', 19:26:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:07 INFO - 'XPC_FLAGS': '0x0', 19:26:07 INFO - 'XPC_SERVICE_NAME': '0', 19:26:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:26:07 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-wyGmoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:26:08 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)) 19:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:26:08 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-i2l71J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:26:08 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)) 19:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:26:08 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-UHXbBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:26:08 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)) 19:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:26:08 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-cOv5aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:26:08 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)) 19:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:26:08 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ekMqW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:26:08 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)) 19:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:26:08 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-74uXf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:26:08 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)) 19:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:26:08 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-jeNbtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:26:08 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)) 19:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:26:08 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-9nRmh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:26:08 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)) 19:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:26:08 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-xEbbQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:26:08 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)) 19:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:26:08 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-R0QQGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:26:09 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)) 19:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:26:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-2p9hB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:26:09 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)) 19:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:26:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-7F9kVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:26:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-OroHI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:26:09 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)) 19:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:26:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Ub1zBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-1BG_zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:09 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)) 19:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:26:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-DoGrmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:26:09 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)) 19:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:26:09 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-JXT4yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:26:09 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)) 19:26:09 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)) 19:26:09 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)) 19:26:09 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)) 19:26:09 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)) 19:26:09 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)) 19:26:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:12 INFO - Downloading blessings-1.6.tar.gz 19:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:26:12 INFO - Installing collected packages: blessings 19:26:12 INFO - Running setup.py install for blessings 19:26:12 INFO - Successfully installed blessings 19:26:12 INFO - Cleaning up... 19:26:13 INFO - Return code: 0 19:26:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:26:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:26:13 INFO - Reading from file tmpfile_stdout 19:26:13 INFO - Current package versions: 19:26:13 INFO - blessings == 1.6 19:26:13 INFO - blobuploader == 1.2.4 19:26:13 INFO - docopt == 0.6.1 19:26:13 INFO - functools32 == 3.2.3-2 19:26:13 INFO - jsonschema == 2.5.1 19:26:13 INFO - manifestparser == 1.1 19:26:13 INFO - mozInstall == 1.12 19:26:13 INFO - mozcrash == 0.17 19:26:13 INFO - mozdebug == 0.1 19:26:13 INFO - mozdevice == 0.48 19:26:13 INFO - mozfile == 1.2 19:26:13 INFO - mozhttpd == 0.7 19:26:13 INFO - mozinfo == 0.9 19:26:13 INFO - mozleak == 0.1 19:26:13 INFO - mozlog == 3.2 19:26:13 INFO - moznetwork == 0.27 19:26:13 INFO - mozprocess == 0.22 19:26:13 INFO - mozprofile == 0.28 19:26:13 INFO - mozrunner == 6.11 19:26:13 INFO - mozscreenshot == 0.1 19:26:13 INFO - mozsystemmonitor == 0.3 19:26:13 INFO - moztest == 0.7 19:26:13 INFO - mozversion == 1.4 19:26:13 INFO - psutil == 3.1.1 19:26:13 INFO - requests == 1.2.3 19:26:13 INFO - wsgiref == 0.1.2 19:26:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:13 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 0x107d17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf18c52970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c7bd30>, '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 0x1079e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c73b20>, '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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:26:13 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 19:26:13 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 19:26:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pUKqPSw1pK/Render', 19:26:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:13 INFO - 'HOME': '/Users/cltbld', 19:26:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:13 INFO - 'LOGNAME': 'cltbld', 19:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:13 INFO - 'MOZ_NO_REMOTE': '1', 19:26:13 INFO - 'NO_EM_RESTART': '1', 19:26:13 INFO - 'PAGER': '/bin/cat', 19:26:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:13 INFO - 'PWD': '/builds/slave/test', 19:26:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:13 INFO - 'SHELL': '/bin/bash', 19:26:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qQcSbzAvH/Listeners', 19:26:13 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:26:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:13 INFO - 'USER': 'cltbld', 19:26:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:13 INFO - 'XPC_FLAGS': '0x0', 19:26:13 INFO - 'XPC_SERVICE_NAME': '0', 19:26:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:13 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)) 19:26:13 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)) 19:26:13 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)) 19:26:13 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)) 19:26:13 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)) 19:26:13 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)) 19:26:13 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)) 19:26:13 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)) 19:26:13 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)) 19:26:13 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)) 19:26:13 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)) 19:26:13 INFO - Cleaning up... 19:26:13 INFO - Return code: 0 19:26:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107d17a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107dac618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf18c52970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c7bd30>, '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 0x1079e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c73b20>, '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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 19:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:26:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pUKqPSw1pK/Render', 19:26:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:13 INFO - 'HOME': '/Users/cltbld', 19:26:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:13 INFO - 'LOGNAME': 'cltbld', 19:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:13 INFO - 'MOZ_NO_REMOTE': '1', 19:26:13 INFO - 'NO_EM_RESTART': '1', 19:26:13 INFO - 'PAGER': '/bin/cat', 19:26:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:13 INFO - 'PWD': '/builds/slave/test', 19:26:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:13 INFO - 'SHELL': '/bin/bash', 19:26:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qQcSbzAvH/Listeners', 19:26:13 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:26:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:13 INFO - 'USER': 'cltbld', 19:26:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:13 INFO - 'XPC_FLAGS': '0x0', 19:26:13 INFO - 'XPC_SERVICE_NAME': '0', 19:26:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:26:13 INFO - Cleaning up... 19:26:13 INFO - Return code: 0 19:26:13 INFO - Running post-action listener: _resource_record_post_action 19:26:13 INFO - Running post-action listener: _start_resource_monitoring 19:26:13 INFO - Starting resource monitoring. 19:26:13 INFO - ##### 19:26:13 INFO - ##### Finished create-virtualenv step (success) 19:26:13 INFO - ##### 19:26:13 INFO - ##### 19:26:13 INFO - ##### Running install step. 19:26:13 INFO - ##### 19:26:13 INFO - Running pre-action listener: _resource_record_pre_action 19:26:13 INFO - Running main action method: install 19:26:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:26:14 INFO - Reading from file tmpfile_stdout 19:26:14 INFO - Detecting whether we're running mozinstall >=1.0... 19:26:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:26:14 INFO - Reading from file tmpfile_stdout 19:26:14 INFO - Output received: 19:26:14 INFO - Usage: mozinstall [options] installer 19:26:14 INFO - Options: 19:26:14 INFO - -h, --help show this help message and exit 19:26:14 INFO - -d DEST, --destination=DEST 19:26:14 INFO - Directory to install application into. [default: 19:26:14 INFO - "/builds/slave/test"] 19:26:14 INFO - --app=APP Application being installed. [default: firefox] 19:26:14 INFO - mkdir: /builds/slave/test/build/application 19:26:14 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'] 19:26:14 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 19:26:49 INFO - Reading from file tmpfile_stdout 19:26:49 INFO - Output received: 19:26:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:26:49 INFO - Running post-action listener: _resource_record_post_action 19:26:49 INFO - ##### 19:26:49 INFO - ##### Finished install step (success) 19:26:49 INFO - ##### 19:26:49 INFO - ##### 19:26:49 INFO - ##### Running run-tests step. 19:26:49 INFO - ##### 19:26:49 INFO - Running pre-action listener: _resource_record_pre_action 19:26:49 INFO - Running main action method: run_tests 19:26:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:26:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:26:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:26:49 INFO - 2016-06-28 19:26:49.308 screenresolution[1646:9373] starting screenresolution argv=screenresolution get 19:26:49 INFO - 2016-06-28 19:26:49.310 screenresolution[1646:9373] Display 0: 1600x1200x32@60 19:26:49 INFO - 2016-06-28 19:26:49.316 screenresolution[1647:9375] starting screenresolution argv=screenresolution list 19:26:49 INFO - Available Modes on Display 0 19:26:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:26:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:26:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:26:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:26:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:26:49 INFO - Intel Iris: 19:26:49 INFO - Chipset Model: Intel Iris 19:26:49 INFO - Type: GPU 19:26:49 INFO - Bus: Built-In 19:26:49 INFO - VRAM (Dynamic, Max): 1536 MB 19:26:49 INFO - Vendor: Intel (0x8086) 19:26:49 INFO - Device ID: 0x0a2e 19:26:49 INFO - Revision ID: 0x0009 19:26:49 INFO - Displays: 19:26:49 INFO - Display: 19:26:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:26:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:26:49 INFO - Display Serial Number: 1600x1200 60 19:26:49 INFO - Main Display: Yes 19:26:49 INFO - Mirror: Off 19:26:49 INFO - Online: Yes 19:26:49 INFO - Rotation: Supported 19:26:49 INFO - Return code: 0 19:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:26:49 INFO - Python 2.7.3 19:26:49 INFO - Return code: 0 19:26:49 INFO - grabbing minidump binary from tooltool 19:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:49 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 0x107c7bd30>, '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 0x1079e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c73b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:26:49 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 19:26:49 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 19:26:49 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 19:26:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:26:49 INFO - Return code: 0 19:26:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:26:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:26:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:26:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:26:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:26:49 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/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 19:26:49 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/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --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 19:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pUKqPSw1pK/Render', 19:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:26:49 INFO - 'HOME': '/Users/cltbld', 19:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:26:49 INFO - 'LOGNAME': 'cltbld', 19:26:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:26:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:49 INFO - 'MOZ_NO_REMOTE': '1', 19:26:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:26:49 INFO - 'NO_EM_RESTART': '1', 19:26:49 INFO - 'PAGER': '/bin/cat', 19:26:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:49 INFO - 'PWD': '/builds/slave/test', 19:26:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:26:49 INFO - 'SHELL': '/bin/bash', 19:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0qQcSbzAvH/Listeners', 19:26:49 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:26:49 INFO - 'USER': 'cltbld', 19:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:49 INFO - 'XPC_FLAGS': '0x0', 19:26:49 INFO - 'XPC_SERVICE_NAME': '0', 19:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:26:49 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/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 19:26:49 INFO - mozversion application_buildid: 20160628171728 19:26:49 INFO - mozversion application_changeset: a1eab626db95522e838cdb9120e22d129fd08c01 19:26:49 INFO - mozversion application_display_name: Nightly 19:26:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:26:49 INFO - mozversion application_name: Firefox 19:26:49 INFO - mozversion application_remotingname: firefox 19:26:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:26:49 INFO - mozversion application_vendor: Mozilla 19:26:49 INFO - mozversion application_version: 50.0a1 19:26:49 INFO - mozversion platform_buildid: 20160628171728 19:26:49 INFO - mozversion platform_changeset: a1eab626db95522e838cdb9120e22d129fd08c01 19:26:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:26:49 INFO - mozversion platform_version: 50.0a1 19:26:49 INFO - using testdate: 1467167209 19:26:49 INFO - actual date: 1467167209 19:26:49 INFO - starting webserver on 'localhost:49266' 19:26:49 INFO - SUITE-START | Running 2 tests 19:26:49 INFO - TEST-START | dromaeo_css 19:26:49 INFO - operating with platform_type : mac_ 19:26:49 INFO - Initialising browser for dromaeo_css test... 19:26:49 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpXp77lk/profile http://localhost:49266/getInfo.html) 19:26:52 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 19:26:52 INFO - PROCESS | 1657 | colorDepth:24 19:26:52 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 19:26:52 INFO - PROCESS | 1657 | __metrics 19:26:52 INFO - PROCESS | 1657 | 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" 19:26:52 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:26:53 INFO - TEST-INFO | 1657: exit 0 19:26:53 INFO - Browser initialized. 19:26:53 INFO - Running cycle 1/1 for dromaeo_css test... 19:26:53 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpXp77lk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:04 INFO - PROCESS | 1660 | RSS: Main: 243466240 19:27:04 INFO - PROCESS | 1660 | 19:27:56 INFO - PROCESS | 1660 | 1467167276112 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] 19:30:07 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 19:30:08 INFO - PROCESS | 1660 | RSS: Main: 362180608 19:30:08 INFO - PROCESS | 1660 | 19:33:12 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 19:33:12 INFO - PROCESS | 1660 | RSS: Main: 383934464 19:33:12 INFO - PROCESS | 1660 | 19:36:15 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 19:36:15 INFO - PROCESS | 1660 | RSS: Main: 375824384 19:36:15 INFO - PROCESS | 1660 | 19:39:18 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 19:39:19 INFO - PROCESS | 1660 | RSS: Main: 374566912 19:39:19 INFO - PROCESS | 1660 | 19:42:22 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 19:42:23 INFO - PROCESS | 1660 | RSS: Main: 351174656 19:42:23 INFO - PROCESS | 1660 | 19:45:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 19:45:26 INFO - PROCESS | 1660 | RSS: Main: 389476352 19:45:26 INFO - PROCESS | 1660 | 19:45:26 INFO - PROCESS | 1660 | __start_tp_report 19:45:26 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 19:45:26 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 19:45:26 INFO - PROCESS | 1660 | |i|pagename|runs| 19:45:26 INFO - PROCESS | 1660 | |0;dojo.html;3355.1276668066303;3365.2596428785673;3385.9503553898294;3389.8305084745757;3423.9315213695727;5604;5662.546996240301;5725.255716756821;5732.684702341369;5753.194552762611;5024.296598476216;5367.684917195283;5814.970925145369;5846.561507886904;5972.9402705972925;5214.243934629477;5230.816921407752;5286.969041036999;5301.443348448415;5402.108652072423;5377.542908852753;5414.83755487336;5419.403865574784;5429.049916264657;5448.019356515825;5204.947950520503;5289.471052894718;5297.390800058004;5317.308749862532;5337.546308563777;5299.993001329735;5319.122344813101;5333.439988801198;5335.466453354672;5352.437994010612;5227.764750586232;5268.8155914543195;5272.630915835893;5281.996420680059;5321.5742740581045;5320.14877619579;5430.83707488776;5777.277840269966;5801.796937107223;5805.042168042268;6180.412860778219;6223.937760622381;6236.407541283571;6271;6273.247210334744;6139.1712118863825;6140.565599444479;6188.752449901998;6225.688715564249;6231.59494632852;5968.4031596840405;5971.104334349882;5998.1602575639445;6004;6027.21646185993;6295.811125666238;6308.495320374451;6310.337414571496;6318.684065796691;6337.493000559944;6104.664243466563;6139.127566092385;6169.81490555284;6189.659568723673;6215.471684906834;6191.19514463117;6212.502999760009;6214.751409943642;6219.502439804895;6230.345813689588;6210.534209934273;6230.6573138476915;6246.718897649616;6254.8123556293385;6257.405546473078;5211.765470553834;6116.089207487093;6150.50795936333;6243.875122497525;6260.937390626126;4946.950530494649;4953.2322490013385;4966.230234313615;4974.303597496353;5001.674891132065;4440.666949978765;4454.732716036983;4460.7323560586465;4461.821527138943;4498.707584007029;5721.5708821838525;5907.2911250650195;5945.910811337833;5980.611260268069;5983.132445795335;6132.753252973555;6144.893919094606;6182.567220294626;6193.969030154821;6217.4715149212825;5605.383407825136;5885.705714714247;5896.64620122794;5923.318818335861;5929.37741537141;5366.570674346043;5426.348838139448;5479.561635069185;5493.670379777226;5495.2856128703015;6214.906776398358;6291.182146320949;6297.2128483939505;6303.810885673437;6323.146375239284;6133.701927635063;6190;6197.101420294122;6223.875522489616;6228.875422491616;6336.17629708135;6350.7142178603;6383.234011918599;6384.776532821329;6390.7443702251385;5201.869953251199;6120.355709577036;6197.907031394442;6204.937950620436;6265.248170219603;6020.638761674313;6135.7839197735275;6174.44430001302;6202.658853762906;6225.906611400742;6189.288231853395;6213.1922850029205;6235.75056997715;6243.250809902841;6267.122602835698;6096.556923351527;6108.5723999319625;6234.719437625408;6239.656818875005;6259.436650701458;5594.216809646734;6121.4615288689365;6142.375998160927;6143.665407145256;6153.784617538365;6211.161493198541;6211.3478084802255;6225.937740622536;6249.562530622813;6256.5620406572925;5963.582549221513;6007.189029481139;6051.848703782441;6095.664738439251;6107.69461526913 19:45:26 INFO - PROCESS | 1660 | |1;ext.html;463.0692308459994;483.45128279402866;490.13735824948094;494.809981993306;515.6493584362632;30834.229144271405;32501;32515;38493;42109.78945105278;43985.56014439854;44417.77791111048;44418.7779061105;44422.33366499505;44429.33355999662;9596.616135354578;9803.901960980405;9811.65659201928;9816.361936474143;9827.410355378664;8899.555022248895;9036.27709783219;9050.547472626375;9671.419714817099;12062.215955962878;12101.878981210208;12357.752844943096;12375.071869609816;12375.938120309385;12388;12253.203541769757;12332.75334493314;12336.198147120409;12346.938265308661;12347.08620163876;8909.509976951265;9050.411723238034;9072.8639070414;9223.584938677775;12151.878481215163;41098.38352424716;41254;41317.380239296435;43520.782396088136;43552.34671479931;3362.714169295613;3366;3370.4438767603315;3408.4887266909914;3537.6108628050893;32965;33015.6698433015;33190.834045829615;33347;34220.657793422;3047.3604408019273;3068.539719042139;3094.5512900629283;3156.400283946066;3212.8393580321126;508038;508964;509780;510284;510701;53526.19710704342;61885.69057154685;62651.686741566;63616.68191659012;63664.68167659132;66396.6680166596;66562.33437665658;66729.33270667329;66810.66594666995;66861;16440.260188291555;16611.584710382336;16621.085840278658;16621.252043658063;16628.83371166273;10552.41961692099;12864.614061578168;12866.678333041562;12871;13043;14561.41754329815;15275.236238188269;16666.000039997638;16982.745258821127;17042.914785425994;7432.516886402366;7435.7025718970635;7466.775996720107;7467.5730387624235;7521.435892307989;791.6358475101517;974.7027156717269;1001.7896241789306;1098.4343063322394;1103.4813637590319;30805.22986925345;30827.229319267197;31068.067957960844;31292.374152516823;31557.52663710046;1115.4757264085868;1127.9830802537967;1170.8946194842506;1208.2871106047473;1273.7134144817528;16042.598935026717;16094.75857862133;16119.919400402923;16330.75503867443;16502.587435314214;653988;659013;659026;659436;660392;62009;62021;62094.379056209764;62235.688821556505;62566.0615090774;1289.0783090090442;1425.5580769961139;1437.4178457724638;1454.9636259093395;1467.3836988464657;30236.84881575666;31818;32136.19659508531;32286.677133228368;32676.183095422806;51137.744311278206;51611;52203;52316;52335.73832130815;539152;539514;540379;540698;540948;35053.29893402169;41432.54986075473;42076;43395.56604433915;43506.912327192076;46602.53397465982;47040.52959470498;47248.29127563158;47997.5200248007;48182;37390.81304593568;38621.034474138374;38824.805875970436;40033.599664002984;40050;37324.81337593294;37652;38175.80912095422;38720.419193711554;39066;37160.07099822418;37413;37481;37901.24197516089;38331.23337533289;32608.510872337407;34086.48870266997;34157.829210853786;34203.31593368168;34431.483527746605;21429.423696456244;21937.780622193575;23076.307710768702;25625.359366016;25657.486850263263 19:45:26 INFO - PROCESS | 1660 | |2;jquery.html;326.4157158685952;372.33723971331034;381.1728549048564;388.04540829559284;399.97000224983134;20145;20527.281545145925;21818.127274909024;21820.454488637773;21891;11933.701657458569;12279.017678585691;12283.385830708474;12292.877071229284;17578.472645820613;5376.704281264529;5526.392096869341;5562.972185139069;5583.8604034899045;5588.133839254901;3934.154156856275;4211.284081706117;4782.426108866924;6960.408365288957;6977.05809715687;6927.584344939294;6959.930400696004;6961;6961.23426423093;6962.965185174067;6121.724522396503;6147.815565533041;6153.107799369089;6153.753849846001;6154.938450615481;3822.522184726909;3915.941260881089;4052;4053.8175782089875;5998.25021872266;13083.41124649393;13099.803502947463;13550.322483875865;13653.453861845514;13664.726705465935;2376.702912135983;2392.150786470795;2421.1889017179265;2898.130560831742;2994.9101526954228;9576.952115239448;10510.211734119972;10552;11553.480093395818;16261.268242928978;1871.576611759783;1978.6141702368045;1983.9206431742714;1988.1848442138798;1995.750531183602;108899;115602.42198789037;116305.41847290794;116507.99999999916;119702;11586.536538538365;11711.824322635168;11815.468303926173;11838.112141589416;11885.702857428634;12014.459349329301;12497.75004499905;14736.631584210267;14905.254737263094;14911.254437278092;8662.6101825418;8677.52273624944;8718.086911392005;8786.780330491789;8851.424657397249;8699.913000870038;8729.214370706666;8735.781605459915;8742.344324175712;8886.555672216364;4596.563326483979;4606.97696511522;4611.354410382549;4612.561806628365;4677.059020506452;1760.313477743681;1950.629380417716;1955.0869204884903;1959.1379792891366;1963.6661767499559;860.3031544449017;862.1809281182901;890.9109089091039;925.1765928323797;1001.5943542865151;16107.355705771872;21988.670169947145;22005.00977456018;22027.229046983277;22034.33896983093;924.4453328003278;929.8512238041881;960.2701946520694;991.1426615977272;1051.9690703110994;9900.40597564134;10034.799304013879;11260.38067906273;11355.886441135483;11464.25482343645;431326;457055;487964;489269;550692;81625.18374816175;82644.34711305861;125385;139284;146615.2669236647;907.8002839375326;970.3450171134597;980.705468781202;1015.8527013582989;1020.7090979071078;15592.844071559139;19291;19496.512587184865;19576.8042319575;20370.898145509178;56480.65751452285;58062.12906806486;58576;59199.112013318976;62385;65108;89440.55279723559;89823;90186.54906725425;90228.5488572553;11788.174827761974;11883.227590206609;12075.456604452645;12137.514499419924;12197.634070977885;12879.549215777402;12988.935055324662;13184.406701698255;13216;13295.268760217894;11378.203525753117;11504.769904602028;11542.307461552333;11714.648560543197;11716.06271498295;11330;11349.262297950607;11512.712182195512;11531.654050378502;11813.586524471602;11693.76612467763;11818.172727908965;11969.982551483221;11984.981276591587;11986.160968732454;11896.345700986529;11987;12087.456064476944;12102;12139;11546.13403994687;11593.594224202112;11670.591529296435;11707.824382634097;11863.466144023367 19:45:26 INFO - PROCESS | 1660 | |3;mootools.html;1337.7993301004853;1476.0553245922608;1534.7928029715988;1732.281103342113;1971.9014049297532;7966.322862556683;8683.782905427368;8902.332325075613;8923.92912850458;9006.324525660586;8684.91315086849;8783;8868.822623547525;8894.555272236395;8901.332400070005;2046.3963130876427;2127.4468638154035;2311.8150547956166;2347.6713260143592;2350.8824558771994;2317.177402022283;2382.28531440568;2395.3891757601873;2397.9760202398015;2398.0527691561824;2158.7085743424595;2183.148572056899;2340.929772106831;2353.305774796431;2370.762923707624;1797.8921264724158;1982.8909409982446;2071.440711008019;2337.9479234344526;2354.3290162303747;2111.778263282364;2282.8287878409187;2360.6577046328184;2374.5963186258377;2383.2373640435067;8921.509316987564;8984.371094023421;9006.86489702655;9011.909880901238;9038.056817784141;5142.4600416956055;5302.257683924254;5302.973485132588;5306.09796334624;5307.097793375096;3267.1178781729036;3341.916452088693;3413.3173365326784;3414.709749671281;3469.3234819210265;934.2666007184328;1024.0578667625728;1036.7615448446825;1052.1845569683555;1064.9776214833769;11876.584319548774;11907.702307442296;11920.46357913896;11926.344051077187;11957.282563046245;4293;4552.817887284472;4577.22187228172;4725.054989002213;4727.692699974491;10092.343997640277;10105.595776169019;10111.494425278706;10138.847917281246;10144.340617859816;5329.014132385521;5330;5332.173513105475;5333.679979201261;5340.706261155674;4166.958330416657;4274.401583778274;4387.100644367961;4844.273358996108;4874.731889746027;4013.2174226026227;4036.8183431745642;4094.1811637672586;4135.669146468275;4181.686373521937;1282.076904628666;1297.2540789046336;1299.2200685061525;1308.8822006019504;1310.541310541322;851.1786126388065;874.060385086035;912.9132732390412;918.2516249256835;920.5868991098631;5985.610935289193;6060.606060606046;6071.210742603434;6100.542459315569;6305.5901366411035;928.8142371525587;952.590386133969;1041.8645576075062;1063.542676649033;1098.9780204395868;3796.52543432071;3898.5516665583255;3920.9607903921165;3950.111224974358;3962.128331767007;10447.529861156267;10873.07578855806;11027.283226590245;11027.779444411068;11034.668959931216;9461.90538094624;10043;10674.412907290174;10828.78342433147;11002;7997.800054998672;8233.34133269337;8283.710070147516;8315.708950186714;8320.875186872201;5854.736536855937;5919.467247947706;6095.634261944298;6129.264488261437;6209.782657606962;9542.093501117382;10048;10055.748606284902;10064.899351006396;10079.34484258521;9376.67181648639;9512.524373781145;10213.285070045322;10241.385516869012;10271.794564108526;7017.894431844328;7585.393168546393;7855.33229675484;8229.135940726377;8449.788755281168;7966.800829979297;8024.879626805719;8027.83944321122;8592.269657079218;8610.397272190887;7487.176410594939;7607.961960190385;7622.3521000713345;7630.656620451982;7914.0503139623615;6441.742330306923;7460.253974602496;7530.058742657168;7535.095788505414;7553.357964572853;7099.36105750485;7181.928180718126;7186.10173728284;7197.964010180125;7206.387457065998;4262.7016108872085;4866.562009419169;4928.162212423825;4939.506049395031;5014.34813474246;5026.74866256693;5040.697558146523;5063.797448102035;5082.822101226439;5183.274341592105 19:45:26 INFO - PROCESS | 1660 | |4;prototype.html;300.47417020214624;308.4555759085215;311.66029028359094;314.4716875648909;320.628071437133;5168.2764412982215;5178.896422071556;5358.973205133973;5413.427138088862;5426.511613954744;4633.957359594089;5176.948230517693;5387.4612538746105;5393.919091213635;5415.891682166364;3793.753406028606;3973.6225058619384;3983.3228351180223;3989.640932316091;4027.7784721840285;3196.5205219217073;3651.3245049665766;3887.105965627907;4019.638232559069;4093.649095798379;3985.123272879962;4020.0954785173394;4040.272750904836;4054.8175332109977;4054.8443693547347;3452.654734526552;3546.2730140321173;3949.9315704824076;4054.2904991626497;4085.754854708712;2956.8669409876607;3331.93336133276;3359.4960755886814;3437.129996452965;3515.701165400944;4602.171609110359;4727.905441891177;4794.184988551954;5088.542031217171;5116.104681680728;3766.8304926278383;4572.3827283317;4575.153596584642;4586.977065114686;4595.322707211843;4534.433195850519;5278.683279003272;5503.477169668875;5551.833444996657;5562.749676264537;3880.8835734927998;3892.552356479013;3899.0642245861072;3899.610038996106;3918.2359439908946;4919.31129641854;5542.528885044776;5761.164631128505;5915.733791979371;5930.733117009745;3509.7367697422796;3794.9810250948567;3829.751066180689;3934.252492026506;3936.527616685959;3635.4001589737395;3985.8206380712936;3988.3618621020496;3994.5406278277787;4011.5787842276723;4446.933296000562;4452.9554704453185;4573.885652858705;4632.814687412466;4635.235186194308;4738.739369334719;5573.247611572467;5579.860503487445;5616.12487383704;5731.742071606787;1331.5672406467936;1357.2535105692027;1360.768669326217;1367.5145323410047;1368.6715188354724;806.6450761664966;845.7970087179156;851.4210336970796;856.195176534056;856.9031639501449;4223.809928553223;4361.542038086019;4361.6074553290355;4361.629261512743;4421.159979603865;3910.7262491625315;4473.676325173099;4735.857924262277;4757.881052973703;4794.856154315376;3770.792606406619;4125.792700905002;4332.501762297313;4382.276924307517;4397.934030989538;2065.917363305451;2321.3848330192513;2455.84037037592;2541.5552278351215;2543.9618405723927;4311.374850646702;4457.64338852891;4605.723656580616;4623.520473448464;4993.825216117419;4672.088942656217;4839.612830973514;4898.110115032148;4927.630427717864;4943.912339285352;4132.524759652619;4331.350297455281;4728.4562275338085;4884.731339776346;5047.419546752097;4127.4634297542325;4517.367568540341;4566.840160594364;4658.530978581357;4709.974710874357;4200.529814564878;4311.762853043113;4492.932606010978;4640.605548528413;4766.880827979328;5269.0252303324005;5393;5716.828495145152;5720.313562372542;5898.203742494708;3362.008207578819;3909.9218015638958;3957.248122856648;3959.980200098981;3974.8211330490776;5186.533212010786;5201.427842937198;5240.292560504283;5753.654780713171;5836.941630583639;4900.26496025599;5077.146841402935;5462.744085338115;5506.256655351476;5522.917156242579;5159.690418574897;5330.413654497925;5620.67914040192;5626;5681.4034526374135;5491.203775452617;5501.972490137524;5522.944770552243;5551.666899986014;5555.416681248411;4616.667748750199;5283.471652834686;5397.8110766123;5641.5204707600315;5695.629784064023;4594.379758732662;4830.806767729392;4958.801647934042;5373.301470808926;5528.806491772769 19:45:26 INFO - PROCESS | 1660 | |5;yui.html;688.4182865478671;733.3106879533238;788.459904965099;788.8343447875945;841.9915800841992;15192.392304307828;15814.525564233092;15816.841831581682;15831.445899393524;15833.683326333467;14058.367373468192;14390.064645798016;14671.339789709462;14743.92628036861;14772.778408323884;707.5294928872294;729.5768454296522;741.4290995933128;894.1460904835882;911.3165126155384;887.5650931043774;917.4724533393293;920.6915683246087;920.7974245665943;922.7693076730817;962.9422234665907;970.1171933540479;970.1850445625709;970.3450171134491;970.9563069661847;748.4050180106829;935.088288918306;965.0494263150791;965.3290962780906;967.0957654592943;711.8789805733038;713.6859781696037;713.9750108746169;715.8103102677794;716.3910675925474;12890.677733056655;12940.288284144368;12947.223166610034;12965.675858103623;12986.740265194738;13733;13891.097078689954;13935.512257070954;13954.372053257628;14249.572512824632;12779.61661150167;12849.743005139939;13132.474701012043;13271.601851944457;13330.13354131988;4564.132814765184;4619.030003699228;4760.428748550162;4798;4809.302651115569;104661.47669261681;105430.4185437219;109637;110123.34814977781;111473;9043.32175086858;11124.55501779936;11282.435878206057;11371;11376.715582110348;18553.628927421647;21963.341099767033;21967.23114690978;21989.780102199093;22020.559588808133;8053.718119865776;8113.432059755761;8201.343892488587;8212.958935205286;8261.628226729812;4389.956100439019;4413.933790993137;4428.402165707653;4482.350059241392;4554.590086892129;3495.807730574843;3599.6040435552068;3644.526211592476;3647.9817600911824;3661.469086982426;655.3413819111762;663.5786275714955;666.3336663336663;696.4498046543174;716.0655344775118;566.5355057177243;619.8078595635368;634.80321100459;673.6901025528214;685.7976896815452;8583.957080214685;9798.853017204749;9949.751256218653;9974.551145198484;10016.64941727036;651.8891788395985;655.5476721062547;667.2426795587044;670.53062856001;681.7341236917606;4627.213373726475;4741.407324084489;4811.927821082687;4839.540243676845;4846.660733748674;150508;154262;154680;157204.21397893166;172273;127104.7289527093;129622.35188824184;130385.69614303925;132469;133273;108009;108664.37003444954;113045;115203.847961521;115629;9799.510024498604;10086.445245511568;10119.949400252952;10127.949360253151;10197.235207359627;62281.688591556755;64271;64339.67830161007;65709.67145164244;65759.67120164368;62199.6890015547;62358.688206560495;84369.5781521113;95979;97817;13320.600381988555;13393.330333483482;13408.195508269535;13501;13506.662333441742;15006.02460840042;15039.473618423302;15176.696466070396;15189.848101518843;15813;10253.764110852228;12505.624831255076;13051.804222936473;13783.931080344533;14379.496717614833;13965.371558280105;14043.1574105554;14057.929710351384;14078.507252246121;14078.929605351908;13678.589642310746;13772.586822395344;13799.86200138026;14133.15201087938;14238.552180182054;11180.944095279472;11393.259438136494;11513.712157196138;11652.53389864396;11857.703557410789;11057.668419012905;11507;11508.53965841357;11655.125865560287;11701.76596468083 19:45:26 INFO - PROCESS | 1660 | __end_tp_report 19:45:26 INFO - PROCESS | 1660 | __start_cc_report 19:45:26 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1249 19:45:26 INFO - PROCESS | 1660 | __end_cc_report 19:45:26 INFO - PROCESS | 1660 | __startTimestamp1467168326392__endTimestamp 19:45:26 INFO - PROCESS | 1660 | 19:45:26 INFO - PROCESS | 1660 | ------- Summary: start ------- 19:45:26 INFO - PROCESS | 1660 | Number of tests: 6 19:45:26 INFO - PROCESS | 1660 | 19:45:26 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5781.57 Median:6095.66 stddev:632.32 (10.4%) stddev-sans-first:604.93 19:45:26 INFO - PROCESS | 1660 | Values: 3355.1 3365.3 3386.0 3389.8 3423.9 5604.0 5662.5 5725.3 5732.7 5753.2 5024.3 5367.7 5815.0 5846.6 5972.9 5214.2 5230.8 5287.0 5301.4 5402.1 5377.5 5414.8 5419.4 5429.0 5448.0 5204.9 5289.5 5297.4 5317.3 5337.5 5300.0 5319.1 5333.4 5335.5 5352.4 5227.8 5268.8 5272.6 5282.0 5321.6 5320.1 5430.8 5777.3 5801.8 5805.0 6180.4 6223.9 6236.4 6271.0 6273.2 6139.2 6140.6 6188.8 6225.7 6231.6 5968.4 5971.1 5998.2 6004.0 6027.2 6295.8 6308.5 6310.3 6318.7 6337.5 6104.7 6139.1 6169.8 6189.7 6215.5 6191.2 6212.5 6214.8 6219.5 6230.3 6210.5 6230.7 6246.7 6254.8 6257.4 5211.8 6116.1 6150.5 6243.9 6260.9 4947.0 4953.2 4966.2 4974.3 5001.7 4440.7 4454.7 4460.7 4461.8 4498.7 5721.6 5907.3 5945.9 5980.6 5983.1 6132.8 6144.9 6182.6 6194.0 6217.5 5605.4 5885.7 5896.6 5923.3 5929.4 5366.6 5426.3 5479.6 5493.7 5495.3 6214.9 6291.2 6297.2 6303.8 6323.1 6133.7 6190.0 6197.1 6223.9 6228.9 6336.2 6350.7 6383.2 6384.8 6390.7 5201.9 6120.4 6197.9 6204.9 6265.2 6020.6 6135.8 6174.4 6202.7 6225.9 6189.3 6213.2 6235.8 6243.3 6267.1 6096.6 6108.6 6234.7 6239.7 6259.4 5594.2 6121.5 6142.4 6143.7 6153.8 6211.2 6211.3 6225.9 6249.6 6256.6 5963.6 6007.2 6051.8 6095.7 6107.7 19:45:26 INFO - PROCESS | 1660 | 19:45:26 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:71166.84 Median:38038.53 stddev:152909.83 (402.0%) stddev-sans-first:153246.64 19:45:26 INFO - PROCESS | 1660 | Values: 463.1 483.5 490.1 494.8 515.6 30834.2 32501.0 32515.0 38493.0 42109.8 43985.6 44417.8 44418.8 44422.3 44429.3 9596.6 9803.9 9811.7 9816.4 9827.4 8899.6 9036.3 9050.5 9671.4 12062.2 12101.9 12357.8 12375.1 12375.9 12388.0 12253.2 12332.8 12336.2 12346.9 12347.1 8909.5 9050.4 9072.9 9223.6 12151.9 41098.4 41254.0 41317.4 43520.8 43552.3 3362.7 3366.0 3370.4 3408.5 3537.6 32965.0 33015.7 33190.8 33347.0 34220.7 3047.4 3068.5 3094.6 3156.4 3212.8 508038.0 508964.0 509780.0 510284.0 510701.0 53526.2 61885.7 62651.7 63616.7 63664.7 66396.7 66562.3 66729.3 66810.7 66861.0 16440.3 16611.6 16621.1 16621.3 16628.8 10552.4 12864.6 12866.7 12871.0 13043.0 14561.4 15275.2 16666.0 16982.7 17042.9 7432.5 7435.7 7466.8 7467.6 7521.4 791.6 974.7 1001.8 1098.4 1103.5 30805.2 30827.2 31068.1 31292.4 31557.5 1115.5 1128.0 1170.9 1208.3 1273.7 16042.6 16094.8 16119.9 16330.8 16502.6 653988.0 659013.0 659026.0 659436.0 660392.0 62009.0 62021.0 62094.4 62235.7 62566.1 1289.1 1425.6 1437.4 1455.0 1467.4 30236.8 31818.0 32136.2 32286.7 32676.2 51137.7 51611.0 52203.0 52316.0 52335.7 539152.0 539514.0 540379.0 540698.0 540948.0 35053.3 41432.5 42076.0 43395.6 43506.9 46602.5 47040.5 47248.3 47997.5 48182.0 37390.8 38621.0 38824.8 40033.6 40050.0 37324.8 37652.0 38175.8 38720.4 39066.0 37160.1 37413.0 37481.0 37901.2 38331.2 32608.5 34086.5 34157.8 34203.3 34431.5 21429.4 21937.8 23076.3 25625.4 25657.5 19:45:26 INFO - PROCESS | 1660 | 19:45:26 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:31594.62 Median:20257.95 stddev:82033.43 (404.9%) stddev-sans-first:82229.96 19:45:26 INFO - PROCESS | 1660 | Values: 326.4 372.3 381.2 388.0 400.0 20145.0 20527.3 21818.1 21820.5 21891.0 11933.7 12279.0 12283.4 12292.9 17578.5 5376.7 5526.4 5563.0 5583.9 5588.1 3934.2 4211.3 4782.4 6960.4 6977.1 6927.6 6959.9 6961.0 6961.2 6963.0 6121.7 6147.8 6153.1 6153.8 6154.9 3822.5 3915.9 4052.0 4053.8 5998.3 13083.4 13099.8 13550.3 13653.5 13664.7 2376.7 2392.2 2421.2 2898.1 2994.9 9577.0 10510.2 10552.0 11553.5 16261.3 1871.6 1978.6 1983.9 1988.2 1995.8 108899.0 115602.4 116305.4 116508.0 119702.0 11586.5 11711.8 11815.5 11838.1 11885.7 12014.5 12497.8 14736.6 14905.3 14911.3 8662.6 8677.5 8718.1 8786.8 8851.4 8699.9 8729.2 8735.8 8742.3 8886.6 4596.6 4607.0 4611.4 4612.6 4677.1 1760.3 1950.6 1955.1 1959.1 1963.7 860.3 862.2 890.9 925.2 1001.6 16107.4 21988.7 22005.0 22027.2 22034.3 924.4 929.9 960.3 991.1 1052.0 9900.4 10034.8 11260.4 11355.9 11464.3 431326.0 457055.0 487964.0 489269.0 550692.0 81625.2 82644.3 125385.0 139284.0 146615.3 907.8 970.3 980.7 1015.9 1020.7 15592.8 19291.0 19496.5 19576.8 20370.9 56480.7 58062.1 58576.0 59199.1 62385.0 65108.0 89440.6 89823.0 90186.5 90228.5 11788.2 11883.2 12075.5 12137.5 12197.6 12879.5 12988.9 13184.4 13216.0 13295.3 11378.2 11504.8 11542.3 11714.6 11716.1 11330.0 11349.3 11512.7 11531.7 11813.6 11693.8 11818.2 11970.0 11985.0 11986.2 11896.3 11987.0 12087.5 12102.0 12139.0 11546.1 11593.6 11670.6 11707.8 11863.5 19:45:26 INFO - PROCESS | 1660 | 19:45:26 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5733.35 Median:4726.37 stddev:3249.73 (68.8%) stddev-sans-first:3242.06 19:45:26 INFO - PROCESS | 1660 | Values: 1337.8 1476.1 1534.8 1732.3 1971.9 7966.3 8683.8 8902.3 8923.9 9006.3 8684.9 8783.0 8868.8 8894.6 8901.3 2046.4 2127.4 2311.8 2347.7 2350.9 2317.2 2382.3 2395.4 2398.0 2398.1 2158.7 2183.1 2340.9 2353.3 2370.8 1797.9 1982.9 2071.4 2337.9 2354.3 2111.8 2282.8 2360.7 2374.6 2383.2 8921.5 8984.4 9006.9 9011.9 9038.1 5142.5 5302.3 5303.0 5306.1 5307.1 3267.1 3341.9 3413.3 3414.7 3469.3 934.3 1024.1 1036.8 1052.2 1065.0 11876.6 11907.7 11920.5 11926.3 11957.3 4293.0 4552.8 4577.2 4725.1 4727.7 10092.3 10105.6 10111.5 10138.8 10144.3 5329.0 5330.0 5332.2 5333.7 5340.7 4167.0 4274.4 4387.1 4844.3 4874.7 4013.2 4036.8 4094.2 4135.7 4181.7 1282.1 1297.3 1299.2 1308.9 1310.5 851.2 874.1 912.9 918.3 920.6 5985.6 6060.6 6071.2 6100.5 6305.6 928.8 952.6 1041.9 1063.5 1099.0 3796.5 3898.6 3921.0 3950.1 3962.1 10447.5 10873.1 11027.3 11027.8 11034.7 9461.9 10043.0 10674.4 10828.8 11002.0 7997.8 8233.3 8283.7 8315.7 8320.9 5854.7 5919.5 6095.6 6129.3 6209.8 9542.1 10048.0 10055.7 10064.9 10079.3 9376.7 9512.5 10213.3 10241.4 10271.8 7017.9 7585.4 7855.3 8229.1 8449.8 7966.8 8024.9 8027.8 8592.3 8610.4 7487.2 7608.0 7622.4 7630.7 7914.1 6441.7 7460.3 7530.1 7535.1 7553.4 7099.4 7181.9 7186.1 7198.0 7206.4 4262.7 4866.6 4928.2 4939.5 5014.3 5026.7 5040.7 5063.8 5082.8 5183.3 19:45:26 INFO - PROCESS | 1660 | 19:45:26 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4272.98 Median:4594.85 stddev:1294.39 (28.2%) stddev-sans-first:1263.21 19:45:26 INFO - PROCESS | 1660 | Values: 300.5 308.5 311.7 314.5 320.6 5168.3 5178.9 5359.0 5413.4 5426.5 4634.0 5176.9 5387.5 5393.9 5415.9 3793.8 3973.6 3983.3 3989.6 4027.8 3196.5 3651.3 3887.1 4019.6 4093.6 3985.1 4020.1 4040.3 4054.8 4054.8 3452.7 3546.3 3949.9 4054.3 4085.8 2956.9 3331.9 3359.5 3437.1 3515.7 4602.2 4727.9 4794.2 5088.5 5116.1 3766.8 4572.4 4575.2 4587.0 4595.3 4534.4 5278.7 5503.5 5551.8 5562.7 3880.9 3892.6 3899.1 3899.6 3918.2 4919.3 5542.5 5761.2 5915.7 5930.7 3509.7 3795.0 3829.8 3934.3 3936.5 3635.4 3985.8 3988.4 3994.5 4011.6 4446.9 4453.0 4573.9 4632.8 4635.2 4738.7 5573.2 5579.9 5616.1 5731.7 1331.6 1357.3 1360.8 1367.5 1368.7 806.6 845.8 851.4 856.2 856.9 4223.8 4361.5 4361.6 4361.6 4421.2 3910.7 4473.7 4735.9 4757.9 4794.9 3770.8 4125.8 4332.5 4382.3 4397.9 2065.9 2321.4 2455.8 2541.6 2544.0 4311.4 4457.6 4605.7 4623.5 4993.8 4672.1 4839.6 4898.1 4927.6 4943.9 4132.5 4331.4 4728.5 4884.7 5047.4 4127.5 4517.4 4566.8 4658.5 4710.0 4200.5 4311.8 4492.9 4640.6 4766.9 5269.0 5393.0 5716.8 5720.3 5898.2 3362.0 3909.9 3957.2 3960.0 3974.8 5186.5 5201.4 5240.3 5753.7 5836.9 4900.3 5077.1 5462.7 5506.3 5522.9 5159.7 5330.4 5620.7 5626.0 5681.4 5491.2 5502.0 5522.9 5551.7 5555.4 4616.7 5283.5 5397.8 5641.5 5695.6 4594.4 4830.8 4958.8 5373.3 5528.8 19:45:26 INFO - PROCESS | 1660 | 19:45:26 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:25028.64 Median:21965.29 stddev:40180.04 (182.9%) stddev-sans-first:40251.20 19:45:26 INFO - PROCESS | 1660 | Values: 688.4 733.3 788.5 788.8 842.0 15192.4 15814.5 15816.8 15831.4 15833.7 14058.4 14390.1 14671.3 14743.9 14772.8 707.5 729.6 741.4 894.1 911.3 887.6 917.5 920.7 920.8 922.8 962.9 970.1 970.2 970.3 971.0 748.4 935.1 965.0 965.3 967.1 711.9 713.7 714.0 715.8 716.4 12890.7 12940.3 12947.2 12965.7 12986.7 13733.0 13891.1 13935.5 13954.4 14249.6 12779.6 12849.7 13132.5 13271.6 13330.1 4564.1 4619.0 4760.4 4798.0 4809.3 104661.5 105430.4 109637.0 110123.3 111473.0 9043.3 11124.6 11282.4 11371.0 11376.7 18553.6 21963.3 21967.2 21989.8 22020.6 8053.7 8113.4 8201.3 8213.0 8261.6 4390.0 4413.9 4428.4 4482.4 4554.6 3495.8 3599.6 3644.5 3648.0 3661.5 655.3 663.6 666.3 696.4 716.1 566.5 619.8 634.8 673.7 685.8 8584.0 9798.9 9949.8 9974.6 10016.6 651.9 655.5 667.2 670.5 681.7 4627.2 4741.4 4811.9 4839.5 4846.7 150508.0 154262.0 154680.0 157204.2 172273.0 127104.7 129622.4 130385.7 132469.0 133273.0 108009.0 108664.4 113045.0 115203.8 115629.0 9799.5 10086.4 10119.9 10127.9 10197.2 62281.7 64271.0 64339.7 65709.7 65759.7 62199.7 62358.7 84369.6 95979.0 97817.0 13320.6 13393.3 13408.2 13501.0 13506.7 15006.0 15039.5 15176.7 15189.8 15813.0 10253.8 12505.6 13051.8 13783.9 14379.5 13965.4 14043.2 14057.9 14078.5 14078.9 13678.6 13772.6 13799.9 14133.2 14238.6 11180.9 11393.3 11513.7 11652.5 11857.7 11057.7 11507.0 11508.5 11655.1 11701.8 19:45:26 INFO - PROCESS | 1660 | -------- Summary: end -------- 19:45:26 INFO - PROCESS | 1660 | 19:45:27 INFO - TEST-INFO | 1660: exit 0 19:45:27 INFO - TEST-OK | dromaeo_css | took 1117130ms 19:45:27 INFO - TEST-START | kraken 19:45:27 INFO - operating with platform_type : mac_ 19:45:27 INFO - Initialising browser for kraken test... 19:45:27 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpC70p5h/profile http://localhost:49266/getInfo.html) 19:45:29 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 19:45:29 INFO - PROCESS | 1667 | colorDepth:24 19:45:29 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 19:45:29 INFO - PROCESS | 1667 | __metrics 19:45:29 INFO - PROCESS | 1667 | 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" 19:45:29 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:45:30 INFO - TEST-INFO | 1667: exit 0 19:45:30 INFO - Browser initialized. 19:45:30 INFO - Running cycle 1/1 for kraken test... 19:45:30 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpC70p5h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:45:41 INFO - PROCESS | 1668 | RSS: Main: 243494912 19:45:41 INFO - PROCESS | 1668 | 19:45:44 INFO - PROCESS | 1668 | 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) 19:45:45 INFO - PROCESS | 1668 | RSS: Main: 294187008 19:45:45 INFO - PROCESS | 1668 | 19:45:48 INFO - PROCESS | 1668 | 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) 19:45:48 INFO - PROCESS | 1668 | RSS: Main: 303992832 19:45:48 INFO - PROCESS | 1668 | 19:45:52 INFO - PROCESS | 1668 | 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) 19:45:53 INFO - PROCESS | 1668 | RSS: Main: 387723264 19:45:53 INFO - PROCESS | 1668 | 19:45:54 INFO - PROCESS | 1668 | 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) 19:45:55 INFO - PROCESS | 1668 | RSS: Main: 289771520 19:45:55 INFO - PROCESS | 1668 | 19:45:57 INFO - PROCESS | 1668 | 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) 19:45:58 INFO - PROCESS | 1668 | RSS: Main: 293908480 19:45:58 INFO - PROCESS | 1668 | 19:46:01 INFO - PROCESS | 1668 | 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) 19:46:01 INFO - PROCESS | 1668 | RSS: Main: 330145792 19:46:01 INFO - PROCESS | 1668 | 19:46:04 INFO - PROCESS | 1668 | 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) 19:46:05 INFO - PROCESS | 1668 | RSS: Main: 332607488 19:46:05 INFO - PROCESS | 1668 | 19:46:08 INFO - PROCESS | 1668 | 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) 19:46:08 INFO - PROCESS | 1668 | RSS: Main: 332607488 19:46:08 INFO - PROCESS | 1668 | 19:46:10 INFO - PROCESS | 1668 | 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) 19:46:11 INFO - PROCESS | 1668 | RSS: Main: 313765888 19:46:11 INFO - PROCESS | 1668 | 19:46:13 INFO - PROCESS | 1668 | 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) 19:46:13 INFO - PROCESS | 1668 | RSS: Main: 320684032 19:46:13 INFO - PROCESS | 1668 | 19:46:15 INFO - PROCESS | 1668 | 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) 19:46:16 INFO - PROCESS | 1668 | RSS: Main: 322453504 19:46:16 INFO - PROCESS | 1668 | 19:46:19 INFO - PROCESS | 1668 | 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) 19:46:20 INFO - PROCESS | 1668 | RSS: Main: 337612800 19:46:20 INFO - PROCESS | 1668 | 19:46:23 INFO - PROCESS | 1668 | 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) 19:46:23 INFO - PROCESS | 1668 | RSS: Main: 334036992 19:46:23 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | 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) 19:46:25 INFO - PROCESS | 1668 | RSS: Main: 377659392 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | __start_tp_report 19:46:25 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 19:46:25 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 19:46:25 INFO - PROCESS | 1668 | |i|pagename|runs| 19:46:25 INFO - PROCESS | 1668 | |0;ai-astar;101;113;113;113;113;113;113;113;111;113 19:46:25 INFO - PROCESS | 1668 | |1;audio-beat-detection;157;120;119;170;119;119;140;127;208;143 19:46:25 INFO - PROCESS | 1668 | |2;audio-dft;183;185;185;182;184;183;182;186;182;183 19:46:25 INFO - PROCESS | 1668 | |3;audio-fft;78;74;58;86;57;58;60;66;83;57 19:46:25 INFO - PROCESS | 1668 | |4;audio-oscillator;84;93;94;73;71;70;99;95;98;105 19:46:25 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;90;87;90;87;90;86;90;88;114;79 19:46:25 INFO - PROCESS | 1668 | |6;imaging-darkroom;95;95;95;95;94;94;95;94;95;94 19:46:25 INFO - PROCESS | 1668 | |7;imaging-desaturate;86;89;86;103;133;130;84;85;84;88 19:46:25 INFO - PROCESS | 1668 | |8;json-parse-financial;55;56;56;55;54;55;54;54;54;55 19:46:25 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;66;66;77;81;73;74;70;72;68;73 19:46:25 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;84;85;86;91;89;98;101;82;103;85 19:46:25 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;139;147;124;136;137;144;138;139;134;136 19:46:25 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;216;218;164;168;166;166;167;230;174;165 19:46:25 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;66;66;64;66;67;68;63;78;67;65 19:46:25 INFO - PROCESS | 1668 | __end_tp_report 19:46:25 INFO - PROCESS | 1668 | __start_cc_report 19:46:25 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,2092 19:46:25 INFO - PROCESS | 1668 | __end_cc_report 19:46:25 INFO - PROCESS | 1668 | __startTimestamp1467168385839__endTimestamp 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | ------- Summary: start ------- 19:46:25 INFO - PROCESS | 1668 | Number of tests: 14 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.78 (3.3%) stddev-sans-first:0.67 19:46:25 INFO - PROCESS | 1668 | Values: 101.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 111.0 113.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:141.50 stddev:29.18 (20.6%) stddev-sans-first:30.46 19:46:25 INFO - PROCESS | 1668 | Values: 157.0 120.0 119.0 170.0 119.0 119.0 140.0 127.0 208.0 143.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.50 stddev:1.43 (0.8%) stddev-sans-first:1.51 19:46:25 INFO - PROCESS | 1668 | Values: 183.0 185.0 185.0 182.0 184.0 183.0 182.0 186.0 182.0 183.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:67.70 Median:70.00 stddev:11.52 (16.5%) stddev-sans-first:11.60 19:46:25 INFO - PROCESS | 1668 | Values: 78.0 74.0 58.0 86.0 57.0 58.0 60.0 66.0 83.0 57.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:93.50 stddev:12.80 (13.7%) stddev-sans-first:13.48 19:46:25 INFO - PROCESS | 1668 | Values: 84.0 93.0 94.0 73.0 71.0 70.0 99.0 95.0 98.0 105.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:89.00 stddev:9.04 (10.2%) stddev-sans-first:9.58 19:46:25 INFO - PROCESS | 1668 | Values: 90.0 87.0 90.0 87.0 90.0 86.0 90.0 88.0 114.0 79.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:46:25 INFO - PROCESS | 1668 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:85.50 stddev:19.12 (22.4%) stddev-sans-first:19.87 19:46:25 INFO - PROCESS | 1668 | Values: 86.0 89.0 86.0 103.0 133.0 130.0 84.0 85.0 84.0 88.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 19:46:25 INFO - PROCESS | 1668 | Values: 55.0 56.0 56.0 55.0 54.0 55.0 54.0 54.0 54.0 55.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:73.00 stddev:4.76 (6.5%) stddev-sans-first:4.53 19:46:25 INFO - PROCESS | 1668 | Values: 66.0 66.0 77.0 81.0 73.0 74.0 70.0 72.0 68.0 73.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:85.50 stddev:7.60 (8.9%) stddev-sans-first:7.70 19:46:25 INFO - PROCESS | 1668 | Values: 84.0 85.0 86.0 91.0 89.0 98.0 101.0 82.0 103.0 85.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:138.50 stddev:6.11 (4.4%) stddev-sans-first:6.46 19:46:25 INFO - PROCESS | 1668 | Values: 139.0 147.0 124.0 136.0 137.0 144.0 138.0 139.0 134.0 136.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.40 Median:171.00 stddev:26.55 (15.5%) stddev-sans-first:25.41 19:46:25 INFO - PROCESS | 1668 | Values: 216.0 218.0 164.0 168.0 166.0 166.0 167.0 230.0 174.0 165.0 19:46:25 INFO - PROCESS | 1668 | 19:46:25 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.50 stddev:4.14 (6.2%) stddev-sans-first:4.37 19:46:25 INFO - PROCESS | 1668 | Values: 66.0 66.0 64.0 66.0 67.0 68.0 63.0 78.0 67.0 65.0 19:46:25 INFO - PROCESS | 1668 | -------- Summary: end -------- 19:46:25 INFO - PROCESS | 1668 | 19:46:26 INFO - TEST-INFO | 1668: exit 0 19:46:26 INFO - TEST-OK | kraken | took 59609ms 19:46:26 INFO - SUITE-END | took 1176s 19:46:27 INFO - Completed test suite (00:19:37) 19:46:27 INFO - javascript benchmark 19:46:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3355.1276668066303, 3365.2596428785673, 3385.9503553898294, 3389.8305084745757, 3423.9315213695727, 5604.0, 5662.546996240301, 5725.255716756821, 5732.684702341369, 5753.194552762611, 5024.296598476216, 5367.684917195283, 5814.970925145369, 5846.561507886904, 5972.9402705972925, 5214.243934629477, 5230.816921407752, 5286.969041036999, 5301.443348448415, 5402.108652072423, 5377.542908852753, 5414.83755487336, 5419.403865574784, 5429.049916264657, 5448.019356515825, 5204.947950520503, 5289.471052894718, 5297.390800058004, 5317.308749862532, 5337.546308563777, 5299.993001329735, 5319.122344813101, 5333.439988801198, 5335.466453354672, 5352.437994010612, 5227.764750586232, 5268.8155914543195, 5272.630915835893, 5281.996420680059, 5321.5742740581045, 5320.14877619579, 5430.83707488776, 5777.277840269966, 5801.796937107223, 5805.042168042268, 6180.412860778219, 6223.937760622381, 6236.407541283571, 6271.0, 6273.247210334744, 6139.1712118863825, 6140.565599444479, 6188.752449901998, 6225.688715564249, 6231.59494632852, 5968.4031596840405, 5971.104334349882, 5998.1602575639445, 6004.0, 6027.21646185993, 6295.811125666238, 6308.495320374451, 6310.337414571496, 6318.684065796691, 6337.493000559944, 6104.664243466563, 6139.127566092385, 6169.81490555284, 6189.659568723673, 6215.471684906834, 6191.19514463117, 6212.502999760009, 6214.751409943642, 6219.502439804895, 6230.345813689588, 6210.534209934273, 6230.6573138476915, 6246.718897649616, 6254.8123556293385, 6257.405546473078, 5211.765470553834, 6116.089207487093, 6150.50795936333, 6243.875122497525, 6260.937390626126, 4946.950530494649, 4953.2322490013385, 4966.230234313615, 4974.303597496353, 5001.674891132065, 4440.666949978765, 4454.732716036983, 4460.7323560586465, 4461.821527138943, 4498.707584007029, 5721.5708821838525, 5907.2911250650195, 5945.910811337833, 5980.611260268069, 5983.132445795335, 6132.753252973555, 6144.893919094606, 6182.567220294626, 6193.969030154821, 6217.4715149212825, 5605.383407825136, 5885.705714714247, 5896.64620122794, 5923.318818335861, 5929.37741537141, 5366.570674346043, 5426.348838139448, 5479.561635069185, 5493.670379777226, 5495.2856128703015, 6214.906776398358, 6291.182146320949, 6297.2128483939505, 6303.810885673437, 6323.146375239284, 6133.701927635063, 6190.0, 6197.101420294122, 6223.875522489616, 6228.875422491616, 6336.17629708135, 6350.7142178603, 6383.234011918599, 6384.776532821329, 6390.7443702251385, 5201.869953251199, 6120.355709577036, 6197.907031394442, 6204.937950620436, 6265.248170219603, 6020.638761674313, 6135.7839197735275, 6174.44430001302, 6202.658853762906, 6225.906611400742, 6189.288231853395, 6213.1922850029205, 6235.75056997715, 6243.250809902841, 6267.122602835698, 6096.556923351527, 6108.5723999319625, 6234.719437625408, 6239.656818875005, 6259.436650701458, 5594.216809646734, 6121.4615288689365, 6142.375998160927, 6143.665407145256, 6153.784617538365, 6211.161493198541, 6211.3478084802255, 6225.937740622536, 6249.562530622813, 6256.5620406572925, 5963.582549221513, 6007.189029481139, 6051.848703782441, 6095.664738439251, 6107.69461526913], "value": 5741.98093796402, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.0692308459994, 483.45128279402866, 490.13735824948094, 494.809981993306, 515.6493584362632, 30834.229144271405, 32501.0, 32515.0, 38493.0, 42109.78945105278, 43985.56014439854, 44417.77791111048, 44418.7779061105, 44422.33366499505, 44429.33355999662, 9596.616135354578, 9803.901960980405, 9811.65659201928, 9816.361936474143, 9827.410355378664, 8899.555022248895, 9036.27709783219, 9050.547472626375, 9671.419714817099, 12062.215955962878, 12101.878981210208, 12357.752844943096, 12375.071869609816, 12375.938120309385, 12388.0, 12253.203541769757, 12332.75334493314, 12336.198147120409, 12346.938265308661, 12347.08620163876, 8909.509976951265, 9050.411723238034, 9072.8639070414, 9223.584938677775, 12151.878481215163, 41098.38352424716, 41254.0, 41317.380239296435, 43520.782396088136, 43552.34671479931, 3362.714169295613, 3366.0, 3370.4438767603315, 3408.4887266909914, 3537.6108628050893, 32965.0, 33015.6698433015, 33190.834045829615, 33347.0, 34220.657793422, 3047.3604408019273, 3068.539719042139, 3094.5512900629283, 3156.400283946066, 3212.8393580321126, 508038.0, 508964.0, 509780.0, 510284.0, 510701.0, 53526.19710704342, 61885.69057154685, 62651.686741566, 63616.68191659012, 63664.68167659132, 66396.6680166596, 66562.33437665658, 66729.33270667329, 66810.66594666995, 66861.0, 16440.260188291555, 16611.584710382336, 16621.085840278658, 16621.252043658063, 16628.83371166273, 10552.41961692099, 12864.614061578168, 12866.678333041562, 12871.0, 13043.0, 14561.41754329815, 15275.236238188269, 16666.000039997638, 16982.745258821127, 17042.914785425994, 7432.516886402366, 7435.7025718970635, 7466.775996720107, 7467.5730387624235, 7521.435892307989, 791.6358475101517, 974.7027156717269, 1001.7896241789306, 1098.4343063322394, 1103.4813637590319, 30805.22986925345, 30827.229319267197, 31068.067957960844, 31292.374152516823, 31557.52663710046, 1115.4757264085868, 1127.9830802537967, 1170.8946194842506, 1208.2871106047473, 1273.7134144817528, 16042.598935026717, 16094.75857862133, 16119.919400402923, 16330.75503867443, 16502.587435314214, 653988.0, 659013.0, 659026.0, 659436.0, 660392.0, 62009.0, 62021.0, 62094.379056209764, 62235.688821556505, 62566.0615090774, 1289.0783090090442, 1425.5580769961139, 1437.4178457724638, 1454.9636259093395, 1467.3836988464657, 30236.84881575666, 31818.0, 32136.19659508531, 32286.677133228368, 32676.183095422806, 51137.744311278206, 51611.0, 52203.0, 52316.0, 52335.73832130815, 539152.0, 539514.0, 540379.0, 540698.0, 540948.0, 35053.29893402169, 41432.54986075473, 42076.0, 43395.56604433915, 43506.912327192076, 46602.53397465982, 47040.52959470498, 47248.29127563158, 47997.5200248007, 48182.0, 37390.81304593568, 38621.034474138374, 38824.805875970436, 40033.599664002984, 40050.0, 37324.81337593294, 37652.0, 38175.80912095422, 38720.419193711554, 39066.0, 37160.07099822418, 37413.0, 37481.0, 37901.24197516089, 38331.23337533289, 32608.510872337407, 34086.48870266997, 34157.829210853786, 34203.31593368168, 34431.483527746605, 21429.423696456244, 21937.780622193575, 23076.307710768702, 25625.359366016, 25657.486850263263], "value": 20658.477785272986, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.4157158685952, 372.33723971331034, 381.1728549048564, 388.04540829559284, 399.97000224983134, 20145.0, 20527.281545145925, 21818.127274909024, 21820.454488637773, 21891.0, 11933.701657458569, 12279.017678585691, 12283.385830708474, 12292.877071229284, 17578.472645820613, 5376.704281264529, 5526.392096869341, 5562.972185139069, 5583.8604034899045, 5588.133839254901, 3934.154156856275, 4211.284081706117, 4782.426108866924, 6960.408365288957, 6977.05809715687, 6927.584344939294, 6959.930400696004, 6961.0, 6961.23426423093, 6962.965185174067, 6121.724522396503, 6147.815565533041, 6153.107799369089, 6153.753849846001, 6154.938450615481, 3822.522184726909, 3915.941260881089, 4052.0, 4053.8175782089875, 5998.25021872266, 13083.41124649393, 13099.803502947463, 13550.322483875865, 13653.453861845514, 13664.726705465935, 2376.702912135983, 2392.150786470795, 2421.1889017179265, 2898.130560831742, 2994.9101526954228, 9576.952115239448, 10510.211734119972, 10552.0, 11553.480093395818, 16261.268242928978, 1871.576611759783, 1978.6141702368045, 1983.9206431742714, 1988.1848442138798, 1995.750531183602, 108899.0, 115602.42198789037, 116305.41847290794, 116507.99999999916, 119702.0, 11586.536538538365, 11711.824322635168, 11815.468303926173, 11838.112141589416, 11885.702857428634, 12014.459349329301, 12497.75004499905, 14736.631584210267, 14905.254737263094, 14911.254437278092, 8662.6101825418, 8677.52273624944, 8718.086911392005, 8786.780330491789, 8851.424657397249, 8699.913000870038, 8729.214370706666, 8735.781605459915, 8742.344324175712, 8886.555672216364, 4596.563326483979, 4606.97696511522, 4611.354410382549, 4612.561806628365, 4677.059020506452, 1760.313477743681, 1950.629380417716, 1955.0869204884903, 1959.1379792891366, 1963.6661767499559, 860.3031544449017, 862.1809281182901, 890.9109089091039, 925.1765928323797, 1001.5943542865151, 16107.355705771872, 21988.670169947145, 22005.00977456018, 22027.229046983277, 22034.33896983093, 924.4453328003278, 929.8512238041881, 960.2701946520694, 991.1426615977272, 1051.9690703110994, 9900.40597564134, 10034.799304013879, 11260.38067906273, 11355.886441135483, 11464.25482343645, 431326.0, 457055.0, 487964.0, 489269.0, 550692.0, 81625.18374816175, 82644.34711305861, 125385.0, 139284.0, 146615.2669236647, 907.8002839375326, 970.3450171134597, 980.705468781202, 1015.8527013582989, 1020.7090979071078, 15592.844071559139, 19291.0, 19496.512587184865, 19576.8042319575, 20370.898145509178, 56480.65751452285, 58062.12906806486, 58576.0, 59199.112013318976, 62385.0, 65108.0, 89440.55279723559, 89823.0, 90186.54906725425, 90228.5488572553, 11788.174827761974, 11883.227590206609, 12075.456604452645, 12137.514499419924, 12197.634070977885, 12879.549215777402, 12988.935055324662, 13184.406701698255, 13216.0, 13295.268760217894, 11378.203525753117, 11504.769904602028, 11542.307461552333, 11714.648560543197, 11716.06271498295, 11330.0, 11349.262297950607, 11512.712182195512, 11531.654050378502, 11813.586524471602, 11693.76612467763, 11818.172727908965, 11969.982551483221, 11984.981276591587, 11986.160968732454, 11896.345700986529, 11987.0, 12087.456064476944, 12102.0, 12139.0, 11546.13403994687, 11593.594224202112, 11670.591529296435, 11707.824382634097, 11863.466144023367], "value": 9583.077305303408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.7993301004853, 1476.0553245922608, 1534.7928029715988, 1732.281103342113, 1971.9014049297532, 7966.322862556683, 8683.782905427368, 8902.332325075613, 8923.92912850458, 9006.324525660586, 8684.91315086849, 8783.0, 8868.822623547525, 8894.555272236395, 8901.332400070005, 2046.3963130876427, 2127.4468638154035, 2311.8150547956166, 2347.6713260143592, 2350.8824558771994, 2317.177402022283, 2382.28531440568, 2395.3891757601873, 2397.9760202398015, 2398.0527691561824, 2158.7085743424595, 2183.148572056899, 2340.929772106831, 2353.305774796431, 2370.762923707624, 1797.8921264724158, 1982.8909409982446, 2071.440711008019, 2337.9479234344526, 2354.3290162303747, 2111.778263282364, 2282.8287878409187, 2360.6577046328184, 2374.5963186258377, 2383.2373640435067, 8921.509316987564, 8984.371094023421, 9006.86489702655, 9011.909880901238, 9038.056817784141, 5142.4600416956055, 5302.257683924254, 5302.973485132588, 5306.09796334624, 5307.097793375096, 3267.1178781729036, 3341.916452088693, 3413.3173365326784, 3414.709749671281, 3469.3234819210265, 934.2666007184328, 1024.0578667625728, 1036.7615448446825, 1052.1845569683555, 1064.9776214833769, 11876.584319548774, 11907.702307442296, 11920.46357913896, 11926.344051077187, 11957.282563046245, 4293.0, 4552.817887284472, 4577.22187228172, 4725.054989002213, 4727.692699974491, 10092.343997640277, 10105.595776169019, 10111.494425278706, 10138.847917281246, 10144.340617859816, 5329.014132385521, 5330.0, 5332.173513105475, 5333.679979201261, 5340.706261155674, 4166.958330416657, 4274.401583778274, 4387.100644367961, 4844.273358996108, 4874.731889746027, 4013.2174226026227, 4036.8183431745642, 4094.1811637672586, 4135.669146468275, 4181.686373521937, 1282.076904628666, 1297.2540789046336, 1299.2200685061525, 1308.8822006019504, 1310.541310541322, 851.1786126388065, 874.060385086035, 912.9132732390412, 918.2516249256835, 920.5868991098631, 5985.610935289193, 6060.606060606046, 6071.210742603434, 6100.542459315569, 6305.5901366411035, 928.8142371525587, 952.590386133969, 1041.8645576075062, 1063.542676649033, 1098.9780204395868, 3796.52543432071, 3898.5516665583255, 3920.9607903921165, 3950.111224974358, 3962.128331767007, 10447.529861156267, 10873.07578855806, 11027.283226590245, 11027.779444411068, 11034.668959931216, 9461.90538094624, 10043.0, 10674.412907290174, 10828.78342433147, 11002.0, 7997.800054998672, 8233.34133269337, 8283.710070147516, 8315.708950186714, 8320.875186872201, 5854.736536855937, 5919.467247947706, 6095.634261944298, 6129.264488261437, 6209.782657606962, 9542.093501117382, 10048.0, 10055.748606284902, 10064.899351006396, 10079.34484258521, 9376.67181648639, 9512.524373781145, 10213.285070045322, 10241.385516869012, 10271.794564108526, 7017.894431844328, 7585.393168546393, 7855.33229675484, 8229.135940726377, 8449.788755281168, 7966.800829979297, 8024.879626805719, 8027.83944321122, 8592.269657079218, 8610.397272190887, 7487.176410594939, 7607.961960190385, 7622.3521000713345, 7630.656620451982, 7914.0503139623615, 6441.742330306923, 7460.253974602496, 7530.058742657168, 7535.095788505414, 7553.357964572853, 7099.36105750485, 7181.928180718126, 7186.10173728284, 7197.964010180125, 7206.387457065998, 4262.7016108872085, 4866.562009419169, 4928.162212423825, 4939.506049395031, 5014.34813474246, 5026.74866256693, 5040.697558146523, 5063.797448102035, 5082.822101226439, 5183.274341592105], "value": 4585.259258926791, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.47417020214624, 308.4555759085215, 311.66029028359094, 314.4716875648909, 320.628071437133, 5168.2764412982215, 5178.896422071556, 5358.973205133973, 5413.427138088862, 5426.511613954744, 4633.957359594089, 5176.948230517693, 5387.4612538746105, 5393.919091213635, 5415.891682166364, 3793.753406028606, 3973.6225058619384, 3983.3228351180223, 3989.640932316091, 4027.7784721840285, 3196.5205219217073, 3651.3245049665766, 3887.105965627907, 4019.638232559069, 4093.649095798379, 3985.123272879962, 4020.0954785173394, 4040.272750904836, 4054.8175332109977, 4054.8443693547347, 3452.654734526552, 3546.2730140321173, 3949.9315704824076, 4054.2904991626497, 4085.754854708712, 2956.8669409876607, 3331.93336133276, 3359.4960755886814, 3437.129996452965, 3515.701165400944, 4602.171609110359, 4727.905441891177, 4794.184988551954, 5088.542031217171, 5116.104681680728, 3766.8304926278383, 4572.3827283317, 4575.153596584642, 4586.977065114686, 4595.322707211843, 4534.433195850519, 5278.683279003272, 5503.477169668875, 5551.833444996657, 5562.749676264537, 3880.8835734927998, 3892.552356479013, 3899.0642245861072, 3899.610038996106, 3918.2359439908946, 4919.31129641854, 5542.528885044776, 5761.164631128505, 5915.733791979371, 5930.733117009745, 3509.7367697422796, 3794.9810250948567, 3829.751066180689, 3934.252492026506, 3936.527616685959, 3635.4001589737395, 3985.8206380712936, 3988.3618621020496, 3994.5406278277787, 4011.5787842276723, 4446.933296000562, 4452.9554704453185, 4573.885652858705, 4632.814687412466, 4635.235186194308, 4738.739369334719, 5573.247611572467, 5579.860503487445, 5616.12487383704, 5731.742071606787, 1331.5672406467936, 1357.2535105692027, 1360.768669326217, 1367.5145323410047, 1368.6715188354724, 806.6450761664966, 845.7970087179156, 851.4210336970796, 856.195176534056, 856.9031639501449, 4223.809928553223, 4361.542038086019, 4361.6074553290355, 4361.629261512743, 4421.159979603865, 3910.7262491625315, 4473.676325173099, 4735.857924262277, 4757.881052973703, 4794.856154315376, 3770.792606406619, 4125.792700905002, 4332.501762297313, 4382.276924307517, 4397.934030989538, 2065.917363305451, 2321.3848330192513, 2455.84037037592, 2541.5552278351215, 2543.9618405723927, 4311.374850646702, 4457.64338852891, 4605.723656580616, 4623.520473448464, 4993.825216117419, 4672.088942656217, 4839.612830973514, 4898.110115032148, 4927.630427717864, 4943.912339285352, 4132.524759652619, 4331.350297455281, 4728.4562275338085, 4884.731339776346, 5047.419546752097, 4127.4634297542325, 4517.367568540341, 4566.840160594364, 4658.530978581357, 4709.974710874357, 4200.529814564878, 4311.762853043113, 4492.932606010978, 4640.605548528413, 4766.880827979328, 5269.0252303324005, 5393.0, 5716.828495145152, 5720.313562372542, 5898.203742494708, 3362.008207578819, 3909.9218015638958, 3957.248122856648, 3959.980200098981, 3974.8211330490776, 5186.533212010786, 5201.427842937198, 5240.292560504283, 5753.654780713171, 5836.941630583639, 4900.26496025599, 5077.146841402935, 5462.744085338115, 5506.256655351476, 5522.917156242579, 5159.690418574897, 5330.413654497925, 5620.67914040192, 5626.0, 5681.4034526374135, 5491.203775452617, 5501.972490137524, 5522.944770552243, 5551.666899986014, 5555.416681248411, 4616.667748750199, 5283.471652834686, 5397.8110766123, 5641.5204707600315, 5695.629784064023, 4594.379758732662, 4830.806767729392, 4958.801647934042, 5373.301470808926, 5528.806491772769], "value": 3870.1929413981625, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.4182865478671, 733.3106879533238, 788.459904965099, 788.8343447875945, 841.9915800841992, 15192.392304307828, 15814.525564233092, 15816.841831581682, 15831.445899393524, 15833.683326333467, 14058.367373468192, 14390.064645798016, 14671.339789709462, 14743.92628036861, 14772.778408323884, 707.5294928872294, 729.5768454296522, 741.4290995933128, 894.1460904835882, 911.3165126155384, 887.5650931043774, 917.4724533393293, 920.6915683246087, 920.7974245665943, 922.7693076730817, 962.9422234665907, 970.1171933540479, 970.1850445625709, 970.3450171134491, 970.9563069661847, 748.4050180106829, 935.088288918306, 965.0494263150791, 965.3290962780906, 967.0957654592943, 711.8789805733038, 713.6859781696037, 713.9750108746169, 715.8103102677794, 716.3910675925474, 12890.677733056655, 12940.288284144368, 12947.223166610034, 12965.675858103623, 12986.740265194738, 13733.0, 13891.097078689954, 13935.512257070954, 13954.372053257628, 14249.572512824632, 12779.61661150167, 12849.743005139939, 13132.474701012043, 13271.601851944457, 13330.13354131988, 4564.132814765184, 4619.030003699228, 4760.428748550162, 4798.0, 4809.302651115569, 104661.47669261681, 105430.4185437219, 109637.0, 110123.34814977781, 111473.0, 9043.32175086858, 11124.55501779936, 11282.435878206057, 11371.0, 11376.715582110348, 18553.628927421647, 21963.341099767033, 21967.23114690978, 21989.780102199093, 22020.559588808133, 8053.718119865776, 8113.432059755761, 8201.343892488587, 8212.958935205286, 8261.628226729812, 4389.956100439019, 4413.933790993137, 4428.402165707653, 4482.350059241392, 4554.590086892129, 3495.807730574843, 3599.6040435552068, 3644.526211592476, 3647.9817600911824, 3661.469086982426, 655.3413819111762, 663.5786275714955, 666.3336663336663, 696.4498046543174, 716.0655344775118, 566.5355057177243, 619.8078595635368, 634.80321100459, 673.6901025528214, 685.7976896815452, 8583.957080214685, 9798.853017204749, 9949.751256218653, 9974.551145198484, 10016.64941727036, 651.8891788395985, 655.5476721062547, 667.2426795587044, 670.53062856001, 681.7341236917606, 4627.213373726475, 4741.407324084489, 4811.927821082687, 4839.540243676845, 4846.660733748674, 150508.0, 154262.0, 154680.0, 157204.21397893166, 172273.0, 127104.7289527093, 129622.35188824184, 130385.69614303925, 132469.0, 133273.0, 108009.0, 108664.37003444954, 113045.0, 115203.847961521, 115629.0, 9799.510024498604, 10086.445245511568, 10119.949400252952, 10127.949360253151, 10197.235207359627, 62281.688591556755, 64271.0, 64339.67830161007, 65709.67145164244, 65759.67120164368, 62199.6890015547, 62358.688206560495, 84369.5781521113, 95979.0, 97817.0, 13320.600381988555, 13393.330333483482, 13408.195508269535, 13501.0, 13506.662333441742, 15006.02460840042, 15039.473618423302, 15176.696466070396, 15189.848101518843, 15813.0, 10253.764110852228, 12505.624831255076, 13051.804222936473, 13783.931080344533, 14379.496717614833, 13965.371558280105, 14043.1574105554, 14057.929710351384, 14078.507252246121, 14078.929605351908, 13678.589642310746, 13772.586822395344, 13799.86200138026, 14133.15201087938, 14238.552180182054, 11180.944095279472, 11393.259438136494, 11513.712157196138, 11652.53389864396, 11857.703557410789, 11057.668419012905, 11507.0, 11508.53965841357, 11655.125865560287, 11701.76596468083], "value": 7999.468866521962, "unit": "score"}], "name": "dromaeo_css", "value": 7378.681980695302, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 111.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 120.0, 119.0, 170.0, 119.0, 119.0, 140.0, 127.0, 208.0, 143.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 185.0, 182.0, 184.0, 183.0, 182.0, 186.0, 182.0, 183.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 58.0, 86.0, 57.0, 58.0, 60.0, 66.0, 83.0, 57.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 93.0, 94.0, 73.0, 71.0, 70.0, 99.0, 95.0, 98.0, 105.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 90.0, 86.0, 90.0, 88.0, 114.0, 79.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 86.0, 103.0, 133.0, 130.0, 84.0, 85.0, 84.0, 88.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 77.0, 81.0, 73.0, 74.0, 70.0, 72.0, 68.0, 73.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 91.0, 89.0, 98.0, 101.0, 82.0, 103.0, 85.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 147.0, 124.0, 136.0, 137.0, 144.0, 138.0, 139.0, 134.0, 136.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 218.0, 164.0, 168.0, 166.0, 166.0, 167.0, 230.0, 174.0, 165.0], "value": 183.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 64.0, 66.0, 67.0, 68.0, 63.0, 78.0, 67.0, 65.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1479.7, "alertThreshold": 2.0}]} 19:46:27 INFO - Return code: 0 19:46:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:46:27 INFO - # TBPL SUCCESS # 19:46:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:46:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:46:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:46:27 INFO - 2016-06-28 19:46:27.177 screenresolution[1672:11535] starting screenresolution argv=screenresolution get 19:46:27 INFO - 2016-06-28 19:46:27.180 screenresolution[1672:11535] Display 0: 1600x1200x32@60 19:46:27 INFO - 2016-06-28 19:46:27.186 screenresolution[1673:11538] starting screenresolution argv=screenresolution list 19:46:27 INFO - Available Modes on Display 0 19:46:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:46:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:46:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:46:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:46:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:46:27 INFO - Intel Iris: 19:46:27 INFO - Chipset Model: Intel Iris 19:46:27 INFO - Type: GPU 19:46:27 INFO - Bus: Built-In 19:46:27 INFO - VRAM (Dynamic, Max): 1536 MB 19:46:27 INFO - Vendor: Intel (0x8086) 19:46:27 INFO - Device ID: 0x0a2e 19:46:27 INFO - Revision ID: 0x0009 19:46:27 INFO - Displays: 19:46:27 INFO - Display: 19:46:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:46:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:46:27 INFO - Display Serial Number: 1600x1200 60 19:46:27 INFO - Main Display: Yes 19:46:27 INFO - Mirror: Off 19:46:27 INFO - Online: Yes 19:46:27 INFO - Rotation: Supported 19:46:27 INFO - Return code: 0 19:46:27 INFO - Running post-action listener: _resource_record_post_action 19:46:27 INFO - ##### 19:46:27 INFO - ##### Finished run-tests step (success) 19:46:27 INFO - ##### 19:46:27 INFO - Running post-run listener: _resource_record_post_run 19:46:27 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 31575552; Write bytes: 707003392; Read time: 193; Write time: 1922 19:46:27 INFO - TinderboxPrint: CPU usage
53.9% 19:46:27 INFO - TinderboxPrint: I/O read bytes / time
31,575,552 / 193 19:46:27 INFO - TinderboxPrint: I/O write bytes / time
707,003,392 / 1,922 19:46:27 INFO - TinderboxPrint: CPU idle
2,237.4 (46.1%) 19:46:27 INFO - TinderboxPrint: CPU system
963.4 (19.8%) 19:46:27 INFO - TinderboxPrint: CPU user
1,652.9 (34.1%) 19:46:27 INFO - TinderboxPrint: Swap in / out
433,905,664 / 0 19:46:27 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 400488960; Write bytes: 395907584; Read time: 30185; Write time: 792 19:46:27 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 29511168; Write bytes: 295191040; Read time: 175; Write time: 1087 19:46:27 INFO - Running post-run listener: _upload_blobber_files 19:46:27 INFO - Blob upload gear active. 19:46:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:46:27 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 19:46:27 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'] 19:46:27 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 19:46:28 INFO - (blobuploader) - INFO - Open directory for files ... 19:46:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:46:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:29 INFO - (blobuploader) - INFO - Done attempting. 19:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:29 INFO - (blobuploader) - INFO - Done attempting. 19:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:46:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:32 INFO - (blobuploader) - INFO - Done attempting. 19:46:32 INFO - (blobuploader) - INFO - Iteration through files over. 19:46:32 INFO - Return code: 0 19:46:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:46:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:46:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/52d266819d88c9f64c2bc9b98dcb00dd87bfe05f570b67b2f6e869571024315e521eed4cce99e9e6c8023031d05dc368c11bcd8fcd304b8e6db1af3d49878aaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d863cd57238c4da58e4e25ed269604ce4e7cea61152518721e01c2ee6c3f890c751309815c4d7006ff2d3737d3e69718e18ef4a90e15d6967ce29bbf5fc0cf1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8acaaaf678be489b5118fcce9ada4e800ff5aeb2af59322cced2c0b3b00a8729750abc150eed59ad0b52e72713122a6f44064c2ef8ddd7dd37610cbc2edaacd2"} 19:46:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:46:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:46:32 INFO - Contents: 19:46:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/52d266819d88c9f64c2bc9b98dcb00dd87bfe05f570b67b2f6e869571024315e521eed4cce99e9e6c8023031d05dc368c11bcd8fcd304b8e6db1af3d49878aaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d863cd57238c4da58e4e25ed269604ce4e7cea61152518721e01c2ee6c3f890c751309815c4d7006ff2d3737d3e69718e18ef4a90e15d6967ce29bbf5fc0cf1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8acaaaf678be489b5118fcce9ada4e800ff5aeb2af59322cced2c0b3b00a8729750abc150eed59ad0b52e72713122a6f44064c2ef8ddd7dd37610cbc2edaacd2"} 19:46:32 INFO - Running post-run listener: copy_logs_to_upload_dir 19:46:32 INFO - Copying logs to upload dir... 19:46:32 INFO - mkdir: /builds/slave/test/build/upload/logs 19:46:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.725663 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-06-28 19:46:32.719160) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 19:46:32.723151) ========= 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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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/52d266819d88c9f64c2bc9b98dcb00dd87bfe05f570b67b2f6e869571024315e521eed4cce99e9e6c8023031d05dc368c11bcd8fcd304b8e6db1af3d49878aaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d863cd57238c4da58e4e25ed269604ce4e7cea61152518721e01c2ee6c3f890c751309815c4d7006ff2d3737d3e69718e18ef4a90e15d6967ce29bbf5fc0cf1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8acaaaf678be489b5118fcce9ada4e800ff5aeb2af59322cced2c0b3b00a8729750abc150eed59ad0b52e72713122a6f44064c2ef8ddd7dd37610cbc2edaacd2"} build_url:https://queue.taskcluster.net/v1/task/SjtId96RQsa4QTTO77mwTQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010527 build_url: 'https://queue.taskcluster.net/v1/task/SjtId96RQsa4QTTO77mwTQ/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/52d266819d88c9f64c2bc9b98dcb00dd87bfe05f570b67b2f6e869571024315e521eed4cce99e9e6c8023031d05dc368c11bcd8fcd304b8e6db1af3d49878aaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d863cd57238c4da58e4e25ed269604ce4e7cea61152518721e01c2ee6c3f890c751309815c4d7006ff2d3737d3e69718e18ef4a90e15d6967ce29bbf5fc0cf1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8acaaaf678be489b5118fcce9ada4e800ff5aeb2af59322cced2c0b3b00a8729750abc150eed59ad0b52e72713122a6f44064c2ef8ddd7dd37610cbc2edaacd2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 19:46:32.758841) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 19:46:32.759184) ========= 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.pUKqPSw1pK/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.0qQcSbzAvH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005024 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 19:46:32.811251) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 19:46:32.812020) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 19:46:32.812783) ========= ========= Total master_lag: 0.61 =========