builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0138 starttime: 1468884198.52 results: success (0) buildid: 20160718150719 builduid: 11b379f30ae14092b947a1ba76dd44c3 revision: 9edae2531988223eb282ec0995eb736fd0fb8762 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:18.524440) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:18.524887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:18.525169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:18.547345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:18.547602) ========= 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.luiF8eTzYF/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.exPsMsYmfK/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-18 16:23:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.43M=0.001s 2016-07-18 16:23:18 (8.43 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:18.654303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:18.654609) ========= 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.luiF8eTzYF/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.exPsMsYmfK/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.020824 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:18.702403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 16:23:18.702704) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 9edae2531988223eb282ec0995eb736fd0fb8762 --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 9edae2531988223eb282ec0995eb736fd0fb8762 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.luiF8eTzYF/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.exPsMsYmfK/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-18 16:23:18,775 truncating revision to first 12 chars 2016-07-18 16:23:18,775 Setting DEBUG logging. 2016-07-18 16:23:18,775 attempt 1/10 2016-07-18 16:23:18,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/9edae2531988?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 16:23:19,714 unpacking tar archive at: autoland-9edae2531988/testing/mozharness/ program finished with exit code 0 elapsedTime=1.191749 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 16:23:19.917132) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:19.917647) ========= script_repo_revision: 9edae2531988223eb282ec0995eb736fd0fb8762 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:19.918273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:19.918721) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 16:23:19.938125) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-18 16:23:19.938589) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.luiF8eTzYF/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.exPsMsYmfK/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 16:23:20 INFO - MultiFileLogger online at 20160718 16:23:20 in /builds/slave/test 16:23:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 16:23:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:23:20 INFO - {'append_to_log': False, 16:23:20 INFO - 'base_work_dir': '/builds/slave/test', 16:23:20 INFO - 'blob_upload_branch': 'Autoland', 16:23:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:23:20 INFO - 'branch': 'Autoland', 16:23:20 INFO - 'buildbot_json_path': 'buildprops.json', 16:23:20 INFO - 'config_files': ('talos/mac_config.py',), 16:23:20 INFO - 'default_actions': ('clobber', 16:23:20 INFO - 'read-buildbot-config', 16:23:20 INFO - 'download-and-extract', 16:23:20 INFO - 'populate-webroot', 16:23:20 INFO - 'create-virtualenv', 16:23:20 INFO - 'install', 16:23:20 INFO - 'run-tests'), 16:23:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:23:20 INFO - 'download_minidump_stackwalk': True, 16:23:20 INFO - 'download_symbols': 'ondemand', 16:23:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:23:20 INFO - 'tooltool.py': '/tools/tooltool.py', 16:23:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:23:20 INFO - '/tools/misc-python/virtualenv.py')}, 16:23:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:23:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:23:20 INFO - 'installer_path': 'installer.exe', 16:23:20 INFO - 'log_level': 'info', 16:23:20 INFO - 'log_name': 'talos', 16:23:20 INFO - 'log_to_console': True, 16:23:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:23:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:23:20 INFO - 'opt_config_files': (), 16:23:20 INFO - 'pip_index': False, 16:23:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:23:20 INFO - 'cmd': ('bash', 16:23:20 INFO - '-c', 16:23:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:23:20 INFO - 'enabled': True, 16:23:20 INFO - 'halt_on_failure': False, 16:23:20 INFO - 'name': 'check_screen_resolution'},), 16:23:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:23:20 INFO - 'cmd': ('bash', 16:23:20 INFO - '-c', 16:23:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:23:20 INFO - 'enabled': True, 16:23:20 INFO - 'halt_on_failure': False, 16:23:20 INFO - 'name': 'check_screen_resolution'},), 16:23:20 INFO - 'run_cmd_checks_enabled': True, 16:23:20 INFO - 'sps_profile': False, 16:23:20 INFO - 'sps_profile_interval': 0, 16:23:20 INFO - 'suite': 'dromaeojs-e10s', 16:23:20 INFO - 'system_bits': '32', 16:23:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:23:20 INFO - 'title': 't-yosemite-r7-0138', 16:23:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:23:20 INFO - 'use_talos_json': True, 16:23:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:23:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:23:20 INFO - 'work_dir': 'build'} 16:23:20 INFO - ##### 16:23:20 INFO - ##### Running clobber step. 16:23:20 INFO - ##### 16:23:20 INFO - Running pre-action listener: _resource_record_pre_action 16:23:20 INFO - Running main action method: clobber 16:23:20 INFO - rmtree: /builds/slave/test/build 16:23:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:23:21 INFO - Running post-action listener: _resource_record_post_action 16:23:21 INFO - ##### 16:23:21 INFO - ##### Finished clobber step (success) 16:23:21 INFO - ##### 16:23:21 INFO - ##### 16:23:21 INFO - ##### Running read-buildbot-config step. 16:23:21 INFO - ##### 16:23:21 INFO - Running pre-action listener: _resource_record_pre_action 16:23:21 INFO - Running main action method: read_buildbot_config 16:23:21 INFO - Using buildbot properties: 16:23:21 INFO - { 16:23:21 INFO - "project": "", 16:23:21 INFO - "product": "firefox", 16:23:21 INFO - "script_repo_revision": "production", 16:23:21 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 16:23:21 INFO - "repository": "", 16:23:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 16:23:21 INFO - "buildid": "20160718150719", 16:23:21 INFO - "pgo_build": "False", 16:23:21 INFO - "basedir": "/builds/slave/test", 16:23:21 INFO - "buildnumber": 54, 16:23:21 INFO - "slavename": "t-yosemite-r7-0138", 16:23:21 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:23:21 INFO - "platform": "yosemite_r7", 16:23:21 INFO - "scheduler": "tests-autoland-macosx64-talos", 16:23:21 INFO - "branch": "autoland", 16:23:21 INFO - "repo_path": "integration/autoland", 16:23:21 INFO - "revision": "9edae2531988223eb282ec0995eb736fd0fb8762", 16:23:21 INFO - "stage_platform": "macosx64", 16:23:21 INFO - "builduid": "11b379f30ae14092b947a1ba76dd44c3", 16:23:21 INFO - "slavebuilddir": "test" 16:23:21 INFO - } 16:23:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 16:23:21 INFO - Running post-action listener: _resource_record_post_action 16:23:21 INFO - ##### 16:23:21 INFO - ##### Finished read-buildbot-config step (success) 16:23:21 INFO - ##### 16:23:21 INFO - ##### 16:23:21 INFO - ##### Running download-and-extract step. 16:23:21 INFO - ##### 16:23:21 INFO - Running pre-action listener: _resource_record_pre_action 16:23:21 INFO - Running main action method: download_and_extract 16:23:21 INFO - mkdir: /builds/slave/test/build/tests 16:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:21 INFO - https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:23:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:23:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:23:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/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 16:23:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/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 16:23:22 INFO - Downloaded 1199 bytes. 16:23:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 16:23:22 INFO - Using the following test package requirements: 16:23:22 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:23:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:23:22 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 16:23:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:23:22 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 16:23:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:23:22 INFO - u'jsshell-mac.zip'], 16:23:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:23:22 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 16:23:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:23:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:23:22 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 16:23:22 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:23:22 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 16:23:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:23:22 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 16:23:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:23:22 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 16:23:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:22 INFO - https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:23:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:23:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:23:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/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 16:23:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/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 16:23:24 INFO - Downloaded 18835696 bytes. 16:23:24 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'] 16:23:24 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 16:23:27 INFO - Return code: 0 16:23:27 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 16:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:27 INFO - https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:23:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:23:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:23:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/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 16:23:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/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 16:23:28 INFO - Downloaded 18835696 bytes. 16:23:28 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'] 16:23:28 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 16:23:32 INFO - Return code: 0 16:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:32 INFO - https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:23:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:23:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:23:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/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 16:23:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/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 16:23:33 INFO - Downloaded 14403317 bytes. 16:23:33 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'] 16:23:33 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 16:23:33 INFO - Return code: 0 16:23:33 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')]} 16:23:33 INFO - https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:23:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:23:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:23:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 16:23:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IJTw0CZwQLCJoWq87LtWTg/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 16:23:36 INFO - Downloaded 112925772 bytes. 16:23:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:23:36 INFO - mkdir: /builds/slave/test/properties 16:23:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:23:36 INFO - Writing to file /builds/slave/test/properties/build_url 16:23:36 INFO - Contents: 16:23:36 INFO - build_url:https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:23:37 INFO - Running post-action listener: _resource_record_post_action 16:23:37 INFO - Running post-action listener: set_extra_try_arguments 16:23:37 INFO - ##### 16:23:37 INFO - ##### Finished download-and-extract step (success) 16:23:37 INFO - ##### 16:23:37 INFO - ##### 16:23:37 INFO - ##### Running populate-webroot step. 16:23:37 INFO - ##### 16:23:37 INFO - Running pre-action listener: _resource_record_pre_action 16:23:37 INFO - Running main action method: populate_webroot 16:23:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:23:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:23:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:23:37 INFO - '--tppagecycles', 16:23:37 INFO - '7'], 16:23:37 INFO - 'tests': ['tsvgm']}}, 16:23:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:23:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:23:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:23:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:23:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:23:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:23:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:37 INFO - 'talos_options': ['--disable-e10s'], 16:23:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:37 INFO - 'talos_options': ['--disable-e10s'], 16:23:37 INFO - 'tests': ['damp', 'tps']}, 16:23:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:37 INFO - 'tests': ['damp', 'tps']}, 16:23:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:23:37 INFO - 'tests': ['dromaeo_dom']}, 16:23:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:23:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:23:37 INFO - 'tests': ['basic_compositor_video']}, 16:23:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:23:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:23:37 INFO - 'tests': ['a11yr', 16:23:37 INFO - 'ts_paint', 16:23:37 INFO - 'tpaint', 16:23:37 INFO - 'sessionrestore', 16:23:37 INFO - 'sessionrestore_no_auto_restore', 16:23:37 INFO - 'tabpaint']}, 16:23:37 INFO - 'other-e10s': {'tests': ['a11yr', 16:23:37 INFO - 'ts_paint', 16:23:37 INFO - 'tpaint', 16:23:37 INFO - 'sessionrestore', 16:23:37 INFO - 'sessionrestore_no_auto_restore', 16:23:37 INFO - 'tabpaint']}, 16:23:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:23:37 INFO - 'ts_paint', 16:23:37 INFO - 'tpaint', 16:23:37 INFO - 'sessionrestore', 16:23:37 INFO - 'sessionrestore_no_auto_restore', 16:23:37 INFO - 'tabpaint']}, 16:23:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:23:37 INFO - 'ts_paint', 16:23:37 INFO - 'tpaint', 16:23:37 INFO - 'sessionrestore', 16:23:37 INFO - 'sessionrestore_no_auto_restore', 16:23:37 INFO - 'tabpaint']}, 16:23:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:23:37 INFO - 'tests': ['a11yr', 16:23:37 INFO - 'ts_paint', 16:23:37 INFO - 'tpaint', 16:23:37 INFO - 'sessionrestore', 16:23:37 INFO - 'sessionrestore_no_auto_restore', 16:23:37 INFO - 'tabpaint']}, 16:23:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:23:37 INFO - 'tests': ['a11yr', 16:23:37 INFO - 'ts_paint', 16:23:37 INFO - 'tpaint', 16:23:37 INFO - 'sessionrestore', 16:23:37 INFO - 'sessionrestore_no_auto_restore', 16:23:37 INFO - 'tabpaint']}, 16:23:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:23:37 INFO - 'tests': ['tsvgx', 16:23:37 INFO - 'tsvgr_opacity', 16:23:37 INFO - 'tart', 16:23:37 INFO - 'tscrollx', 16:23:37 INFO - 'cart']}, 16:23:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:23:37 INFO - 'tsvgr_opacity', 16:23:37 INFO - 'tart', 16:23:37 INFO - 'tscrollx', 16:23:37 INFO - 'cart']}, 16:23:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:37 INFO - 'talos_options': ['--disable-e10s'], 16:23:37 INFO - 'tests': ['tp5o']}, 16:23:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:37 INFO - 'tests': ['tp5o']}, 16:23:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:37 INFO - 'talos_options': ['--disable-e10s', 16:23:37 INFO - '--xperf_path', 16:23:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:37 INFO - 'tests': ['tp5n']}, 16:23:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:23:37 INFO - 'talos_options': ['--xperf_path', 16:23:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:37 INFO - 'tests': ['tp5n']}}, 16:23:37 INFO - 'talos.zip': {'path': '', 16:23:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:23:37 INFO - Running post-action listener: _resource_record_post_action 16:23:37 INFO - ##### 16:23:37 INFO - ##### Finished populate-webroot step (success) 16:23:37 INFO - ##### 16:23:37 INFO - ##### 16:23:37 INFO - ##### Running create-virtualenv step. 16:23:37 INFO - ##### 16:23:37 INFO - Running pre-action listener: _resource_record_pre_action 16:23:37 INFO - Running main action method: create_virtualenv 16:23:37 INFO - Creating virtualenv /builds/slave/test/build/venv 16:23:37 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 16:23:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:23:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:23:37 INFO - Using real prefix '/tools/python27' 16:23:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:23:38 INFO - Installing distribute.............................................................................................................................................................................................done. 16:23:41 INFO - Installing pip.................done. 16:23:41 INFO - Return code: 0 16:23:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:23:41 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')]} 16:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:41 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')]} 16:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:41 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 0x102bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c87618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe41b466510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b56d30>, '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 0x1028bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b4eb20>, '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.luiF8eTzYF/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.exPsMsYmfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 16:23:41 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 16:23:41 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 16:23:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luiF8eTzYF/Render', 16:23:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:23:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:23:41 INFO - 'HOME': '/Users/cltbld', 16:23:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:23:41 INFO - 'LOGNAME': 'cltbld', 16:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:41 INFO - 'MOZ_NO_REMOTE': '1', 16:23:41 INFO - 'NO_EM_RESTART': '1', 16:23:41 INFO - 'PAGER': '/bin/cat', 16:23:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:41 INFO - 'PWD': '/builds/slave/test', 16:23:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:23:41 INFO - 'SHELL': '/bin/bash', 16:23:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.exPsMsYmfK/Listeners', 16:23:41 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 16:23:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:23:41 INFO - 'USER': 'cltbld', 16:23:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:23:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:41 INFO - 'XPC_FLAGS': '0x0', 16:23:41 INFO - 'XPC_SERVICE_NAME': '0', 16:23:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:41 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 16:23:41 INFO - Cleaning up... 16:23:41 INFO - Return code: 0 16:23:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:23:41 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')]} 16:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:41 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')]} 16:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:41 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 0x102bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c87618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe41b466510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b56d30>, '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 0x1028bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b4eb20>, '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.luiF8eTzYF/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.exPsMsYmfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 16:23:41 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 16:23:41 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 16:23:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luiF8eTzYF/Render', 16:23:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:23:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:23:41 INFO - 'HOME': '/Users/cltbld', 16:23:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:23:41 INFO - 'LOGNAME': 'cltbld', 16:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:41 INFO - 'MOZ_NO_REMOTE': '1', 16:23:41 INFO - 'NO_EM_RESTART': '1', 16:23:41 INFO - 'PAGER': '/bin/cat', 16:23:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:41 INFO - 'PWD': '/builds/slave/test', 16:23:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:23:41 INFO - 'SHELL': '/bin/bash', 16:23:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.exPsMsYmfK/Listeners', 16:23:41 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 16:23:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:23:41 INFO - 'USER': 'cltbld', 16:23:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:23:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:41 INFO - 'XPC_FLAGS': '0x0', 16:23:41 INFO - 'XPC_SERVICE_NAME': '0', 16:23:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:41 INFO - Downloading/unpacking psutil>=3.1.1 16:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:23:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:44 INFO - Installing collected packages: psutil 16:23:44 INFO - Running setup.py install for psutil 16:23:44 INFO - building 'psutil._psutil_osx' extension 16:23:44 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 16:23:45 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 16:23:45 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 16:23:45 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 16:23:45 INFO - building 'psutil._psutil_posix' extension 16:23:45 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 16:23:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:23:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:23:45 INFO - ^ 16:23:45 INFO - 1 warning generated. 16:23:45 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 16:23:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:45 INFO - Successfully installed psutil 16:23:45 INFO - Cleaning up... 16:23:45 INFO - Return code: 0 16:23:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c87618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe41b466510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b56d30>, '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 0x1028bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b4eb20>, '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.luiF8eTzYF/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.exPsMsYmfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 16:23:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:23:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luiF8eTzYF/Render', 16:23:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:23:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:23:45 INFO - 'HOME': '/Users/cltbld', 16:23:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:23:45 INFO - 'LOGNAME': 'cltbld', 16:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:45 INFO - 'MOZ_NO_REMOTE': '1', 16:23:45 INFO - 'NO_EM_RESTART': '1', 16:23:45 INFO - 'PAGER': '/bin/cat', 16:23:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:45 INFO - 'PWD': '/builds/slave/test', 16:23:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:23:45 INFO - 'SHELL': '/bin/bash', 16:23:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.exPsMsYmfK/Listeners', 16:23:45 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 16:23:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:23:45 INFO - 'USER': 'cltbld', 16:23:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:23:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:45 INFO - 'XPC_FLAGS': '0x0', 16:23:45 INFO - 'XPC_SERVICE_NAME': '0', 16:23:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:23:48 INFO - Installing collected packages: mozsystemmonitor 16:23:48 INFO - Running setup.py install for mozsystemmonitor 16:23:48 INFO - Successfully installed mozsystemmonitor 16:23:48 INFO - Cleaning up... 16:23:48 INFO - Return code: 0 16:23:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:23:48 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')]} 16:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:48 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')]} 16:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:48 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 0x102bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c87618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe41b466510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b56d30>, '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 0x1028bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b4eb20>, '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.luiF8eTzYF/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.exPsMsYmfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 16:23:48 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 16:23:48 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 16:23:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luiF8eTzYF/Render', 16:23:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:23:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:23:48 INFO - 'HOME': '/Users/cltbld', 16:23:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:23:48 INFO - 'LOGNAME': 'cltbld', 16:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:48 INFO - 'MOZ_NO_REMOTE': '1', 16:23:48 INFO - 'NO_EM_RESTART': '1', 16:23:48 INFO - 'PAGER': '/bin/cat', 16:23:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:48 INFO - 'PWD': '/builds/slave/test', 16:23:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:23:48 INFO - 'SHELL': '/bin/bash', 16:23:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.exPsMsYmfK/Listeners', 16:23:48 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 16:23:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:23:48 INFO - 'USER': 'cltbld', 16:23:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:23:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:48 INFO - 'XPC_FLAGS': '0x0', 16:23:48 INFO - 'XPC_SERVICE_NAME': '0', 16:23:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:49 INFO - Downloading/unpacking jsonschema==2.5.1 16:23:49 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 16:23:49 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 16:23:49 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 16:23:49 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 16:23:49 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 16:23:49 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 16:23:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:23:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:23:51 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 16:23:51 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 16:23:51 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 16:23:51 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 16:23:51 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 16:23:51 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 16:23:51 INFO - Downloading functools32-3.2.3-2.tar.gz 16:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:23:51 INFO - warning: no files found matching '*.txt' 16:23:51 INFO - no previously-included directories found matching 'build' 16:23:51 INFO - no previously-included directories found matching 'dist' 16:23:51 INFO - no previously-included directories found matching '.git*' 16:23:51 INFO - Installing collected packages: jsonschema, functools32 16:23:52 INFO - Running setup.py install for functools32 16:23:52 INFO - warning: no files found matching '*.txt' 16:23:52 INFO - no previously-included directories found matching 'build' 16:23:52 INFO - no previously-included directories found matching 'dist' 16:23:52 INFO - no previously-included directories found matching '.git*' 16:23:52 INFO - Successfully installed jsonschema functools32 16:23:52 INFO - Cleaning up... 16:23:52 INFO - Return code: 0 16:23:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:23:52 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')]} 16:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:52 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')]} 16:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:52 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 0x102bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c87618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe41b466510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b56d30>, '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 0x1028bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b4eb20>, '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.luiF8eTzYF/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.exPsMsYmfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 16:23:52 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 16:23:52 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 16:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luiF8eTzYF/Render', 16:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:23:52 INFO - 'HOME': '/Users/cltbld', 16:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:23:52 INFO - 'LOGNAME': 'cltbld', 16:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:52 INFO - 'MOZ_NO_REMOTE': '1', 16:23:52 INFO - 'NO_EM_RESTART': '1', 16:23:52 INFO - 'PAGER': '/bin/cat', 16:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:52 INFO - 'PWD': '/builds/slave/test', 16:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:23:52 INFO - 'SHELL': '/bin/bash', 16:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.exPsMsYmfK/Listeners', 16:23:52 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 16:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:23:52 INFO - 'USER': 'cltbld', 16:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:52 INFO - 'XPC_FLAGS': '0x0', 16:23:52 INFO - 'XPC_SERVICE_NAME': '0', 16:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:52 INFO - Downloading/unpacking blobuploader==1.2.4 16:23: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 16:23: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 16:23: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 16:23: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 16:23: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 16:23: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 16:23:54 INFO - Downloading blobuploader-1.2.4.tar.gz 16:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:23:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:23: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 16:23: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 16:23: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 16:23: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 16:23: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 16:23: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 16:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:23:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:23: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 16:23: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 16:23: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 16:23: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 16:23: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 16:23: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 16:23:56 INFO - Downloading docopt-0.6.1.tar.gz 16:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:23:56 INFO - Installing collected packages: blobuploader, requests, docopt 16:23:56 INFO - Running setup.py install for blobuploader 16:23:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:23:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:23:56 INFO - Running setup.py install for requests 16:23:56 INFO - Running setup.py install for docopt 16:23:56 INFO - Successfully installed blobuploader requests docopt 16:23:56 INFO - Cleaning up... 16:23:57 INFO - Return code: 0 16:23:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:23:57 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 0x102bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c87618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe41b466510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b56d30>, '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 0x1028bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b4eb20>, '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.luiF8eTzYF/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.exPsMsYmfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 16:23:57 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 16:23:57 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 16:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luiF8eTzYF/Render', 16:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:23:57 INFO - 'HOME': '/Users/cltbld', 16:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:23:57 INFO - 'LOGNAME': 'cltbld', 16:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:57 INFO - 'MOZ_NO_REMOTE': '1', 16:23:57 INFO - 'NO_EM_RESTART': '1', 16:23:57 INFO - 'PAGER': '/bin/cat', 16:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:57 INFO - 'PWD': '/builds/slave/test', 16:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:23:57 INFO - 'SHELL': '/bin/bash', 16:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.exPsMsYmfK/Listeners', 16:23:57 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 16:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:23:57 INFO - 'USER': 'cltbld', 16:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:57 INFO - 'XPC_FLAGS': '0x0', 16:23:57 INFO - 'XPC_SERVICE_NAME': '0', 16:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:57 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-dfjZiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:57 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-ICPzON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:57 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-_yPHxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:57 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-1sPU2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:57 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-1Lab6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:57 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-F5BRWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:57 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-i1eq0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:58 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-yzzizq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:58 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-3Dc0Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:58 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-GREEZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:58 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-g034hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:58 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-p0i6ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:58 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-6CMwh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:58 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-vymk1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:58 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-pC7iys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:58 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-aruSPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:59 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-V6tV7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:23:59 INFO - Running setup.py install for manifestparser 16:23:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:23:59 INFO - Running setup.py install for mozcrash 16:23:59 INFO - Running setup.py install for mozdebug 16:23:59 INFO - Running setup.py install for mozdevice 16:23:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:23:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:23:59 INFO - Running setup.py install for mozfile 16:23:59 INFO - Running setup.py install for mozhttpd 16:23:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Running setup.py install for mozinfo 16:24:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Running setup.py install for mozInstall 16:24:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Running setup.py install for mozleak 16:24:00 INFO - Running setup.py install for mozlog 16:24:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Running setup.py install for moznetwork 16:24:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:24:00 INFO - Running setup.py install for mozprocess 16:24:00 INFO - Running setup.py install for mozprofile 16:24:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:24:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:24:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:24:01 INFO - Running setup.py install for mozrunner 16:24:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:24:01 INFO - Running setup.py install for mozscreenshot 16:24:01 INFO - Running setup.py install for moztest 16:24:01 INFO - Running setup.py install for mozversion 16:24:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:24:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:24:01 INFO - Cleaning up... 16:24:01 INFO - Return code: 0 16:24:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:01 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 0x102bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c87618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe41b466510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b56d30>, '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 0x1028bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b4eb20>, '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.luiF8eTzYF/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.exPsMsYmfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 16:24:01 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 16:24:01 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 16:24:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luiF8eTzYF/Render', 16:24:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:01 INFO - 'HOME': '/Users/cltbld', 16:24:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:01 INFO - 'LOGNAME': 'cltbld', 16:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:01 INFO - 'MOZ_NO_REMOTE': '1', 16:24:01 INFO - 'NO_EM_RESTART': '1', 16:24:01 INFO - 'PAGER': '/bin/cat', 16:24:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:01 INFO - 'PWD': '/builds/slave/test', 16:24:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:01 INFO - 'SHELL': '/bin/bash', 16:24:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.exPsMsYmfK/Listeners', 16:24:01 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 16:24:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:01 INFO - 'USER': 'cltbld', 16:24:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:01 INFO - 'XPC_FLAGS': '0x0', 16:24:01 INFO - 'XPC_SERVICE_NAME': '0', 16:24:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:01 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-fcHM8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:02 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-lRCeaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:02 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-ZNxcAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:02 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-Ej5qOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:02 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-aIkMFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:02 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-7yLOds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:02 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-CTkCu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:02 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-tupFfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:02 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-K9WOd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:02 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)) 16:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:02 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-Zpp6Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:03 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)) 16:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:03 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-8u3C8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:03 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)) 16:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:03 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-G3sjZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:03 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-8qXaz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:03 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)) 16:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:03 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-uWtW3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:03 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-YT5mt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:03 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)) 16:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:03 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-dj1hfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:03 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)) 16:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:03 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-N6OXUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:03 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)) 16:24:03 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)) 16:24:03 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)) 16:24:03 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)) 16:24:03 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)) 16:24:03 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)) 16:24:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:24:03 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 16:24:03 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 16:24:03 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 16:24:03 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 16:24:03 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 16:24:03 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 16:24:06 INFO - Downloading blessings-1.6.tar.gz 16:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:24:06 INFO - Installing collected packages: blessings 16:24:06 INFO - Running setup.py install for blessings 16:24:06 INFO - Successfully installed blessings 16:24:06 INFO - Cleaning up... 16:24:06 INFO - Return code: 0 16:24:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:06 INFO - Reading from file tmpfile_stdout 16:24:06 INFO - Current package versions: 16:24:06 INFO - blessings == 1.6 16:24:06 INFO - blobuploader == 1.2.4 16:24:06 INFO - docopt == 0.6.1 16:24:06 INFO - functools32 == 3.2.3-2 16:24:06 INFO - jsonschema == 2.5.1 16:24:06 INFO - manifestparser == 1.1 16:24:06 INFO - mozInstall == 1.12 16:24:06 INFO - mozcrash == 0.17 16:24:06 INFO - mozdebug == 0.1 16:24:06 INFO - mozdevice == 0.48 16:24:06 INFO - mozfile == 1.2 16:24:06 INFO - mozhttpd == 0.7 16:24:06 INFO - mozinfo == 0.9 16:24:06 INFO - mozleak == 0.1 16:24:06 INFO - mozlog == 3.2 16:24:06 INFO - moznetwork == 0.27 16:24:06 INFO - mozprocess == 0.23 16:24:06 INFO - mozprofile == 0.28 16:24:06 INFO - mozrunner == 6.12 16:24:06 INFO - mozscreenshot == 0.1 16:24:06 INFO - mozsystemmonitor == 0.3 16:24:06 INFO - moztest == 0.7 16:24:06 INFO - mozversion == 1.4 16:24:06 INFO - psutil == 3.1.1 16:24:06 INFO - requests == 1.2.3 16:24:06 INFO - wsgiref == 0.1.2 16:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:06 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')]} 16:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:06 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')]} 16:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:06 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 0x102bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c87618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe41b466510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b56d30>, '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 0x1028bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b4eb20>, '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.luiF8eTzYF/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.exPsMsYmfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 16:24:06 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 16:24:06 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 16:24:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luiF8eTzYF/Render', 16:24:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:06 INFO - 'HOME': '/Users/cltbld', 16:24:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:06 INFO - 'LOGNAME': 'cltbld', 16:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:06 INFO - 'MOZ_NO_REMOTE': '1', 16:24:06 INFO - 'NO_EM_RESTART': '1', 16:24:06 INFO - 'PAGER': '/bin/cat', 16:24:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:06 INFO - 'PWD': '/builds/slave/test', 16:24:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:06 INFO - 'SHELL': '/bin/bash', 16:24:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.exPsMsYmfK/Listeners', 16:24:06 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 16:24:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:06 INFO - 'USER': 'cltbld', 16:24:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:06 INFO - 'XPC_FLAGS': '0x0', 16:24:06 INFO - 'XPC_SERVICE_NAME': '0', 16:24:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:07 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)) 16:24:07 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)) 16:24:07 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)) 16:24:07 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)) 16:24:07 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)) 16:24:07 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)) 16:24:07 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)) 16:24:07 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)) 16:24:07 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)) 16:24:07 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)) 16:24:07 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)) 16:24:07 INFO - Cleaning up... 16:24:07 INFO - Return code: 0 16:24:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:24: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')]} 16:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24: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')]} 16:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:07 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 0x102bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c87618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe41b466510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b56d30>, '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 0x1028bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b4eb20>, '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.luiF8eTzYF/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.exPsMsYmfK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 16:24:07 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 16:24:07 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 16:24:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luiF8eTzYF/Render', 16:24:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:07 INFO - 'HOME': '/Users/cltbld', 16:24:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:07 INFO - 'LOGNAME': 'cltbld', 16:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:07 INFO - 'MOZ_NO_REMOTE': '1', 16:24:07 INFO - 'NO_EM_RESTART': '1', 16:24:07 INFO - 'PAGER': '/bin/cat', 16:24:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:07 INFO - 'PWD': '/builds/slave/test', 16:24:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:07 INFO - 'SHELL': '/bin/bash', 16:24:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.exPsMsYmfK/Listeners', 16:24:07 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 16:24:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:07 INFO - 'USER': 'cltbld', 16:24:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:07 INFO - 'XPC_FLAGS': '0x0', 16:24:07 INFO - 'XPC_SERVICE_NAME': '0', 16:24:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:24:07 INFO - Cleaning up... 16:24:07 INFO - Return code: 0 16:24:07 INFO - Running post-action listener: _resource_record_post_action 16:24:07 INFO - Running post-action listener: _start_resource_monitoring 16:24:07 INFO - Starting resource monitoring. 16:24:07 INFO - ##### 16:24:07 INFO - ##### Finished create-virtualenv step (success) 16:24:07 INFO - ##### 16:24:07 INFO - ##### 16:24:07 INFO - ##### Running install step. 16:24:07 INFO - ##### 16:24:07 INFO - Running pre-action listener: _resource_record_pre_action 16:24:07 INFO - Running main action method: install 16:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:07 INFO - Reading from file tmpfile_stdout 16:24:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:24:07 INFO - Reading from file tmpfile_stdout 16:24:07 INFO - Output received: 16:24:07 INFO - Usage: mozinstall [options] installer 16:24:07 INFO - Options: 16:24:07 INFO - -h, --help show this help message and exit 16:24:07 INFO - -d DEST, --destination=DEST 16:24:07 INFO - Directory to install application into. [default: 16:24:07 INFO - "/builds/slave/test"] 16:24:07 INFO - --app=APP Application being installed. [default: firefox] 16:24:07 INFO - mkdir: /builds/slave/test/build/application 16:24:07 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'] 16:24:07 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 16:24:42 INFO - Reading from file tmpfile_stdout 16:24:42 INFO - Output received: 16:24:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:24:42 INFO - Running post-action listener: _resource_record_post_action 16:24:42 INFO - ##### 16:24:42 INFO - ##### Finished install step (success) 16:24:42 INFO - ##### 16:24:42 INFO - ##### 16:24:42 INFO - ##### Running run-tests step. 16:24:42 INFO - ##### 16:24:42 INFO - Running pre-action listener: _resource_record_pre_action 16:24:42 INFO - Running main action method: run_tests 16:24:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:24:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:24:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:24:42 INFO - 2016-07-18 16:24:42.483 screenresolution[1943:17085] starting screenresolution argv=screenresolution get 16:24:42 INFO - 2016-07-18 16:24:42.485 screenresolution[1943:17085] Display 0: 1600x1200x32@60 16:24:42 INFO - 2016-07-18 16:24:42.491 screenresolution[1944:17087] starting screenresolution argv=screenresolution list 16:24:42 INFO - Available Modes on Display 0 16:24:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:24:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:24:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:24:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:24:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:24:42 INFO - Intel Iris: 16:24:42 INFO - Chipset Model: Intel Iris 16:24:42 INFO - Type: GPU 16:24:42 INFO - Bus: Built-In 16:24:42 INFO - VRAM (Dynamic, Max): 1536 MB 16:24:42 INFO - Vendor: Intel (0x8086) 16:24:42 INFO - Device ID: 0x0a2e 16:24:42 INFO - Revision ID: 0x0009 16:24:42 INFO - Displays: 16:24:42 INFO - Display: 16:24:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:24:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:24:42 INFO - Display Serial Number: 1600x1200 60 16:24:42 INFO - Main Display: Yes 16:24:42 INFO - Mirror: Off 16:24:42 INFO - Online: Yes 16:24:42 INFO - Rotation: Supported 16:24:42 INFO - Return code: 0 16:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:24:42 INFO - Python 2.7.3 16:24:42 INFO - Return code: 0 16:24:42 INFO - grabbing minidump binary from tooltool 16:24:42 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')]} 16:24:42 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 0x102b56d30>, '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 0x1028bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b4eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:24:42 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 16:24:42 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 16:24:42 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 16:24:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:24:42 INFO - Return code: 0 16:24:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:24:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:24:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:24:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:24:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0138 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:24:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luiF8eTzYF/Render', 16:24:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:24:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:24:42 INFO - 'HOME': '/Users/cltbld', 16:24:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:24:42 INFO - 'LOGNAME': 'cltbld', 16:24:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:24:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:42 INFO - 'MOZ_NO_REMOTE': '1', 16:24:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:24:42 INFO - 'NO_EM_RESTART': '1', 16:24:42 INFO - 'PAGER': '/bin/cat', 16:24:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:42 INFO - 'PWD': '/builds/slave/test', 16:24:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:24:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:24:42 INFO - 'SHELL': '/bin/bash', 16:24:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.exPsMsYmfK/Listeners', 16:24:42 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 16:24:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:24:42 INFO - 'USER': 'cltbld', 16:24:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:24:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:42 INFO - 'XPC_FLAGS': '0x0', 16:24:42 INFO - 'XPC_SERVICE_NAME': '0', 16:24:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:24:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:24:43 INFO - mozversion application_buildid: 20160718150719 16:24:43 INFO - mozversion application_changeset: 9edae2531988223eb282ec0995eb736fd0fb8762 16:24:43 INFO - mozversion application_display_name: Nightly 16:24:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:24:43 INFO - mozversion application_name: Firefox 16:24:43 INFO - mozversion application_remotingname: firefox 16:24:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:24:43 INFO - mozversion application_vendor: Mozilla 16:24:43 INFO - mozversion application_version: 50.0a1 16:24:43 INFO - mozversion platform_buildid: 20160718150719 16:24:43 INFO - mozversion platform_changeset: 9edae2531988223eb282ec0995eb736fd0fb8762 16:24:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:24:43 INFO - mozversion platform_version: 50.0a1 16:24:43 INFO - using testdate: 1468884283 16:24:43 INFO - actual date: 1468884283 16:24:43 INFO - starting webserver on 'localhost:53258' 16:24:43 INFO - SUITE-START | Running 2 tests 16:24:43 INFO - TEST-START | dromaeo_css 16:24:43 INFO - operating with platform_type : mac_ 16:24:43 INFO - Initialising browser for dromaeo_css test... 16:24:43 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpLA3pHI/profile http://localhost:53258/getInfo.html) 16:24:46 INFO - PROCESS | 1954 | __metrics Screen width/height:1600/1200 16:24:46 INFO - PROCESS | 1954 | colorDepth:24 16:24:46 INFO - PROCESS | 1954 | Browser inner width/height: 1024/689 16:24:46 INFO - PROCESS | 1954 | __metrics 16:24:46 ERROR - PROCESS | 1954 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:24:47 INFO - TEST-INFO | 1954: exit 0 16:24:47 INFO - Browser initialized. 16:24:47 INFO - Running cycle 1/1 for dromaeo_css test... 16:24:47 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpLA3pHI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:59 INFO - PROCESS | 1957 | RSS: Main: 254324736 16:24:59 INFO - PROCESS | 1957 | 16:25:48 INFO - PROCESS | 1957 | 1468884348820 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] 16:27:59 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53258/tests/dromaeo/cssquery-ext.html) 16:28:00 INFO - PROCESS | 1957 | RSS: Main: 268521472 16:28:00 INFO - PROCESS | 1957 | 16:31:02 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-ext.html (next: http://localhost:53258/tests/dromaeo/cssquery-jquery.html) 16:31:03 INFO - PROCESS | 1957 | RSS: Main: 276922368 16:31:03 INFO - PROCESS | 1957 | 16:34:05 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53258/tests/dromaeo/cssquery-mootools.html) 16:34:05 INFO - PROCESS | 1957 | RSS: Main: 281526272 16:34:05 INFO - PROCESS | 1957 | 16:37:07 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53258/tests/dromaeo/cssquery-prototype.html) 16:37:08 INFO - PROCESS | 1957 | RSS: Main: 280510464 16:37:08 INFO - PROCESS | 1957 | 16:40:11 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53258/tests/dromaeo/cssquery-yui.html) 16:40:11 INFO - PROCESS | 1957 | RSS: Main: 284200960 16:40:11 INFO - PROCESS | 1957 | 16:43:14 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:53258/tests/dromaeo/cssquery-yui.html (next: http://localhost:53258/tests/dromaeo/cssquery-dojo.html) 16:43:14 INFO - PROCESS | 1957 | RSS: Main: 284516352 16:43:14 INFO - PROCESS | 1957 | 16:43:14 INFO - PROCESS | 1957 | __start_tp_report 16:43:14 INFO - PROCESS | 1957 | _x_x_mozilla_page_load 16:43:14 INFO - PROCESS | 1957 | _x_x_mozilla_page_load_details 16:43:14 INFO - PROCESS | 1957 | |i|pagename|runs| 16:43:14 INFO - PROCESS | 1957 | |0;dojo.html;2825.279553713803;3285.7699961002722;3396.2188696599796;3428.3828910796046;3443.22527431328;5823.825285241444;5912.556558258127;5914.172015917769;5968.074948382997;5971.074483455066;5711.885762284752;5804.622699524539;5964.552658550604;5967.433093856077;6045.7883974060915;4919.606431485473;5326.174442961337;5365.275687782138;5508.889822203553;5520;43.4232658443081;5363.758630861621;5447.073997420428;5482.2873026506495;5516.586256030793;4480.798364073608;5395.78416863325;5398.568114550866;5423.132298832168;5426.186072089179;5341.599380046512;5426.593005524602;5461.563074953994;5465.9726701366635;5468.535174510172;5300.522952934216;5314.734263286859;5371.650842695212;5375.596830237748;5393.433689462589;5003.374578177728;5041.873953151201;5944.197533332988;5945.910811337833;5984.251968503937;6198.6280823150755;6263.78076767311;6321.6523091229965;6322.810315690536;6336.493080553545;6256.15541901842;6350.745970161188;6363.9045414318825;6373.776917807901;6374.553781235315;6029.336772954972;6034.668093254869;6049.637021778707;6056.939430605726;6062.818115456544;6264.5301602380005;6372.458341041063;6389.8722025560155;6396.488280937514;6427.903581446189;6232.065190221503;6330.905036424458;6340.207474065742;6340.904886426707;6366.936330636727;6406.647634380154;6417.7753778617525;6426.4216220540375;6440.903386449207;6441.677916104176;6181;6268.247810262797;6299.244090709144;6302.401271879165;6352.237731472253;6227.813165605039;6275.843103922347;6303.3066362700065;6320.146780184617;6323.399277068671;5087.745612719349;5146.433892271847;5158.793648254028;5166.5866730661455;5198.662086964335;4523.728576285368;4607.631389488833;4656.185167595657;4662.906741865144;4712.410948631421;5956.463918247378;5991.580589358703;6012.098185272244;6073.30157031947;6094.177286066324;6287.088372186007;6367.0449432584555;6371.649559274284;6372.872542549123;6382.266039405527;6069.635821850615;6076.875777981088;6077.17958075663;6080.361562035922;6093.177421048191;5527.55779537636;5576.888462230732;5635.774569017275;5642.71786410686;5686.2039314496005;5427.1316589345515;5517.200005999188;5523.972380138073;6394.3925327094785;6450.451711604566;6372.713227904663;6373.8725225496155;6381.425671689571;6402.487800976004;6416.390442907917;5418.512333889968;6359.96820015897;6388.2972872984865;6401.487880969418;6497.74009039652;5594.021046316797;6318.810435686937;6331.90502142459;6335.556511044183;6342.207224096988;5613.214150018919;5946.572822522477;6343.397377249154;6390.520710946605;6393.8721225576155;5184.922226166535;6104.701693046632;6145.385461453819;6299.811005669837;6309.842253943504;6291.685415729104;6320.178376810985;6346.682665866781;6355.396237357444;6381.904271436025;6079.179310792986;6230.657313847782;6256.155419018374;6284.214473190851;6290.748370065146;6110.801781737137;6208.627482351073;6228.626282423069;6254.6247225166635;6272.18461599989;5240.397354304151;6152.107944347955;6160.229971253593;6183.072539119168;6206.224221972254 16:43:14 INFO - PROCESS | 1957 | |1;ext.html;481.63395819177424;493.3684883349313;520.6797819341107;541.9512243898048;564;37852.86441406759;40258.59741402585;40338.7983060085;40365.1926961461;40472.59527404725;41844.58155418445;42340;42348.15303693932;42354.364684529755;42375.788121059355;9582.616695332195;9619;9708.951455242714;9720.61117555297;9768.804623907517;9746.90253097467;9793.559289831976;9842.163416109603;9875.061869122457;9894.455804930725;9798.657047003357;9860.901390986106;9911.801763964717;9926.602935882556;9936.552855121501;9789.951050244774;9850.70447886561;9863.358881672704;9901.356411833243;9902.504874756234;9612.567434465465;9727.805443891153;9816.754581135458;9824.263180261438;9846.704598862045;39543.8022809887;40119.598804011875;40412;40437.98905027368;40524.39213411801;3470.9826450867836;3614.9277014459562;3824.6749026332795;3942.64516193544;4271.743695378256;31816.886408975806;32032.519512207335;32367.35265294681;32629.67370326314;33204.335913281844;3238.724708399789;3323.2356557991557;3373.4602463605706;3400.285939952613;3426.229098452853;375283.1235843803;378024;378605;378638.10680946696;378981;32119.839400802848;33299.00102996914;58727.41272587219;58828;59251.407485925454;33456.99629011133;34193;34216.82891585526;34329.82835085859;34408;12928;14742.041767285093;14983.250837458083;15017.549473515812;15282.694346113016;12855.16441431304;12884.48462061507;12990.480380784662;13016.47934082645;13017;7655.578943158069;7670.0795904491815;7674.117476490163;7726.7681969541;7730.381569474429;3097.504399296102;3131.85906634202;3141.732952699046;3141.79578327408;3168.3821654777557;786.7962018112297;961.9610820314044;962.7159987803615;974.1865542272141;1040.921930855189;26999.325016874343;30450.238744031132;30566;30729.231769205948;31591.684083159333;909.8544232922701;1094.414488248783;1144.7996600594863;1179.1627944159743;1181.4919584578713;12783.360831958551;14702.55892323232;15892;16072.598185045468;16476.588085297964;640615;753584;780087;783676.8977706281;968314.3168568366;53750;60335.396646033856;60940.69529652412;61068;61246.693766531775;1395.8673925977016;1411.4636438153436;1422.0472283570032;1427.2150317325636;1430.470725831449;30707.157570544947;30830.229244269074;31086.22284442907;31590.36819263556;31686.68313316837;51051;51199;51329.23006154836;51405;51660.74169629278;612624;614920;618477;618869;620835;22695.205667801547;26495.60256596114;26774.866125670025;27106.051288204817;27197.184084477496;49572.75213623909;49578.75210623924;50111;50243.74878125732;50341.49658503368;40869.38695919504;41265.79367103145;41269.20893545414;41442.96392590209;42057.94855128646;40574.188516230104;40675.98310042272;40870;40994.385084224356;41643.7917810409;38752;39174.412383813695;39304;39892.40161397639;41952;33353.16617084592;35770.28459430745;36325.72859949889;36386.8180659095;36607.63392366149;25683.87158064198;26076;26149.869250653624;26238.73761262363;26450.002496131303 16:43:14 INFO - PROCESS | 1957 | |2;jquery.html;379.544546544147;384.47327161788354;387.0440013167476;400.8276441130316;407.4051884248996;19720.70418943717;21849.235276765317;21985.890070549664;22583.77416225837;22684.86575671218;21470;21584.66804927414;21693.45766355842;21809.563808723815;21981.67027494589;5023.899522009567;5361.839144825662;5376.11294136467;5407.188921661743;5434.7826086956475;3902.746321489094;4437.35658329542;5876.970615146918;6165.969170154165;6182.289036760762;5324.973375133139;6009.369016253274;6135.601185922923;6206.565540412151;6242.438180563771;4981.277714731362;6070.544709146788;6091.878162436771;6119.632822030648;6189.257289125311;5838.386969368197;5908.67502287374;5995.370486098984;6013.458788708994;6014.188084608566;13571.660708482268;23492;23556.411089722722;24853.627195592082;26244.73755262461;1962.528993041674;2258.2570632709812;2483.962740558875;2980.7615390768688;3049.817010979348;9892.208623310118;10074.445905475195;10133.746656333577;10274.640387586473;10378.584856605727;1374.5120482228865;1826.0960824392012;1890.8392786613153;1894.6400183965002;1903.9048047597564;100695;125949;132755.67244327627;133297;134067;11698.70753231159;11748.53555648848;11815.172937894436;11891.88108118925;11908.285502869856;12063.396830158457;14839.629009274639;14841.40634374613;14889.70220595582;14945.327460264314;7343.596102214429;8776.473411595325;8827.470351778913;8850.73447796567;8882.289416846637;7180.425565954711;7214.386777123898;8897.332700047522;9018.458892466473;9050.411723237969;3766.2844059628583;4599.126166028444;4671.976640116778;4709.740964246931;4719.433667959866;1494.8414978391834;1560.180905024871;1693.2634304077765;1729.5416714570397;1920.4142736465233;372.3316646619325;891.4873947480095;921.7004473546124;941.6327632223438;1050.4485145298627;11674.474648640831;12276.754464910651;12289.385530723606;12313.322767247888;12350.44423000967;422.2357532865523;432.23925890432434;439.0494579235982;443.2000239567547;446.635991666797;6225.128482012522;6257.812265632038;6284.654344011124;6348.333424990402;6361.491080713625;627278;639428;641712;643121;643390;130856.3457182727;133605;133632;135539.32230338786;135884;435.5970727077441;438.7762241256918;445.03649598618625;445.9955400445954;447.0098731310164;11439;11530.538778449103;11572.074234061087;11603.897629725163;11720.238184517979;39079.60920390873;44774.3283850736;53957;54109.64725881885;57649.71175144265;78578;81481.59259203666;82370.352592949;82590.58704706439;83435;7209.747658831916;7609.2010338913615;7643.235676432312;7902.328302094386;8269.2971097455;12758.61724148277;13714.0400171987;13723.451061957809;13810.10234334765;13969.790453143009;11691.532338706356;11764.529418823151;11766.411679416165;11881.762364752829;11988.820167697666;11502.252353596989;11631;11689.88310116922;11708.590199342982;11823.11326650522;11846.763064738485;11849;11927.284362938251;12023.038156947248;12099.153059285765;7583;7642.579658118634;7651.120121186135;7665.578393188428;7800.4149688774705;10173.84739228927;10747.140228781835;10955.287906286067;11818.172727908965;11903.46434410471 16:43:14 INFO - PROCESS | 1957 | |3;mootools.html;1485.7325681377351;1555.696639155365;1796.6855800234955;1914.1673372083144;1934.3616606519831;7892.763217103482;8467.91532084679;8509.659613615455;8890.244329232015;8926.59830307637;7978.880316795253;8237.6293066812;8534.1039190885;8722.563871806417;8732.738017859458;2338.368640467073;2359.740428552858;2365.8107351411845;2366.171839856054;2368.0764501844296;2301.551197516485;2358.6344116661944;2375.299286710416;2395.2215529952746;2398.8440751351104;2320.709911261092;2354.799842013431;2364.2316247219637;2373.252425485975;2374.9525009499885;2342.500799488329;2365.2667673021333;2370.182287110944;2378.5242951409787;2379.631157170633;2308.111377119821;2363.7636236376397;2364.4443555764383;2374.228375777879;2375.3349062262596;8759.124087591254;8840.38117331787;8844.646214151491;8845.955770221171;8869.290456763509;5265.394479634852;5318.149096144598;5404.108322126884;5421.132618780976;5426.9185962210595;3194.68053194681;3520.4895290183035;3634.2368102698465;3649.908752281188;3697.3529632314508;1091.9890801091967;1098.6264670012154;1099.164634877491;1105.5190991918462;1115.893990070942;11484.310941343463;11514.712132196762;11634.59278925242;11690.298582085103;11723.824142637868;3851.5955824638568;4575.24508456101;4781.450133234653;4782.234842425195;4828.985912958248;9983.900160998297;9991.600335986624;9996.400215987063;10017.098461138532;10023.548940297704;5261.263423120766;5376.8118115865755;5379.892402151935;5390.029794637003;5416.729163541807;4399.274119770266;4779.95220047802;4838.661293709407;4892.633052521004;4968.130577149057;3354;3452.6374730653424;4014.4781178446615;4043.5754245804355;4125.64931980779;1284.5568278943936;1288.9097763156676;1292.08262133886;1301.6095171448528;1317.3413293353324;931.855562387831;936.3585943628636;940.1350757303297;944.3153713557616;995.2635050062902;5762.135679648086;5873.20711703923;5896.616719913192;5986.341502434729;6056.788012419544;382.23743631455426;402.21768659956103;410.80692074724834;410.86441474313403;414.09313603208875;3984.242993831163;3994.6804255659476;4065.715399921977;4067.877963661095;4083.4283200351974;9866.506674666238;10565.788684226272;10681.077406066826;10689.893101069045;10692.518836652369;10242.743931401625;10474.790504190027;10634.574617015232;10641.467926603793;10684.358938463716;8168.387370947203;8249.670013199524;8254.257116859511;8261.091279959199;8271.048829384577;5792.594518383673;5814.854628634318;5848.093545500455;5853.209816674695;5913.881722365442;9727;9856.950715246665;9863.852042219229;9879.555420006262;9966.850497242402;7867.9606601966625;9956.950215248877;10080.495975201064;10158.796824063329;10168.898311016796;6771.52599318043;7366.079240094989;7555.09338879338;7557.2820582044615;7652.349550288288;8358.08061113265;8408.327333813402;8446.535440550828;8516.531590762568;8518.61666225009;7394.741184058532;7539.0576177977755;7582.203868593939;7626.618669066635;7667.654955527126;7420.591867447342;7495.43784216175;7504.249575042671;7600.961995189989;7601.923980760122;7026.683799229149;7079.079719636415;7113;7131.893021604784;7163.7492687755675;4938.16051271292;5069.214271787879;5134.8973020540125;5136.152534831711;5137.563307118937;5075.137226671401;5084.6440749147205;5098.566621837185;5149.0474262261605;5151.819686311111 16:43:14 INFO - PROCESS | 1957 | |4;prototype.html;298.2246159984041;303.1844338728819;304.3259180914275;307.7922402378394;311.1210829406923;4315.892102697434;5148.91872706732;5424.8101316453885;5580.776768929243;5665.490105890474;4539.931901021488;5497.697626630534;5523.613347065707;5587.832365029056;5612.747426365823;3917.9412308815463;4092.4679791627045;4174.994004316887;4177.206330797138;4193.056562273495;3635.073056370622;4086.346184610448;4181.665466762652;4183.3515805050265;4205;3456;3525.6826885580294;3624.5650521937273;4151.08676091261;4196.601322874338;3861.613838616144;4095;4123.783483872265;4170.35359519275;4198.85304014358;3539.7699149555456;3543.291341731664;3564.41187204111;3566.375884220277;3581.3195492856275;4455.487618923833;4467.396901418299;5399.2980912481125;5416.512513873731;5483.341998960151;4585.518520555361;4753.786079626425;4782.756483314363;4783.28250762385;4811.687240329403;5778.162166485836;5799.652020878761;5812.070068789016;5856.443637854397;5861.618994765369;3299.9010029699148;3460.7058400036026;3695.1685870678884;3911.7066220033325;3947.7892380267144;4522.213725578411;5280.603954703451;6085.4523092921845;6148.292946311187;6157.661328626924;3251.7561182911377;3570.535830342039;3954.0510277533185;3965.2862484752445;3984.541777695602;3379.983100084533;4041.333180025322;4047.5547689754103;4058.585141840659;4086.7956602169775;4318.827246910151;4618.330342100377;4699.459562150328;4762.190427627312;4777.378940737682;5583.609147359646;5864.648121112747;5864.9413505864395;5903.26209223847;5910.408959104141;1352.2292293392672;1377.7037936843426;1380.709037050341;1388.465440805277;1391.311300906058;805.943583949118;844.0673056272852;845.2519520224522;849.9745007649781;882.5190271302156;4715;4923.359963204832;5098.827269727984;5222.451642577551;5385.676859388449;5080.898382032338;5696.3449203341315;5869.207656966255;5890.676012819336;5924.289085309704;4275.508316543575;4919.508049195052;5070.453511678899;5353.357597088297;5590.524805391506;2684.4765270772014;2794.6506686664165;3233.900473838859;3248.6101667800017;3252.121927079675;5777.566682498829;6245.281792593819;6274.23545872482;6313.021481670256;6318.336574659686;5792.333881603669;5891.675957822275;6294.583718663264;6309.652969086745;6328.651924144124;4799.328094066834;5262.60530460217;6348.650824204713;6357.965451055617;6358.586691865014;5142.51146141116;5967.552433567413;6103.694815259308;6108.72510737009;6144.41628045335;5128.897152167593;5342.11855043929;6071.2714474263375;6105.297890742621;6111.786087486917;5073.670211436245;5969.313528944053;6085.72199838039;6303.716332765129;6333.524985626004;3548.0242933192544;3875.6435247663094;3973.741706789165;4022.2960981827478;4055.3916912463364;5051.772670229775;6149.292831324455;6166.506679465721;6192.566520343533;6201.937980620317;4994.4006719192475;5522.447755224445;5969.567498688185;5976.701164941648;5981.1327357532045;5646.943530564806;5876.706164691663;5926.318473375444;5938.495227905676;5996.8800623988145;5220.347456567929;5509.421510741475;5546.029444847216;5855.531557475477;5869.207656966255;5772.336181339199;5942.64344139353;5951.404859514188;6001.3698561652145;6004.699765011645;5050.722210278323;5534.92069046532;5731.484166424875;5880.588358814842;5887.735051922588 16:43:14 INFO - PROCESS | 1957 | |5;yui.html;743.6802175064722;787.7479206653869;789.0767801672043;824.5877061469262;855.5508358111992;14213.005089643702;15269.770953435693;15935.203239838005;15967;16036.67926641468;13066;14442.422303107864;14443.5666929992;14466.710665786677;14479.203643799587;684.7329541478803;754.2419868032647;861.4788053227801;870.4994628088858;893.1068931068932;876.7501262140291;895.7447127568644;902.5938327752505;906.0939060939061;907.4101833808045;947.4220725357526;955.7849483866144;960.0735290444719;960.6397600899662;960.8366577681776;855.5850412549909;916.5554705967601;956.9473678947655;958.9280803939697;962.5187406296886;696.3906581740977;696.7979286007103;707.1302298173224;707.3775077931439;709.2340272505681;15249.237538123049;15489.922550387177;15512.689746205013;15652.060876347456;15658.138802365866;14888.181150036744;15088.17015064171;15100.773488397683;15132.924335378253;15157.545273641808;10240.590376384936;12090.274583524928;12369.340591772812;12623.116381853273;12729.236245825281;3848.1918797052654;3860.1507668313207;3877.9030524236837;3999.960000399988;4031.496062992126;115030;115537.4223128879;115564;121820;130698.3465082678;10696.197785166143;10859.239853210358;11093.889061109447;11350.48922798476;11480.96671299587;21814.345569632937;22161.556768864855;22188;22221.000054997563;22267.665985010237;7787.058338343484;7792.649330780128;8060.959695201486;8082.83834323322;8487.363447741443;4511.548845115528;4585.633149348044;4595.655325850575;4681.204195286809;4702.988857395676;3502.649735026528;3638.7270954677974;3640.3811352069683;3649.379605467077;3649.5255616770182;682.7883356159606;688.2635579929528;688.6659969914588;689.8240948558085;708.9042979197845;574.7097715653568;619.8574327904607;625.9811908499832;647.3914520350855;721.72935149319;9216.723498295061;9749.122578967927;9789.51052447389;9858.852117218248;10036.297459177933;575.5884542552012;630.7540059376847;649.1658219188321;696.9094017777657;711.5410560188649;4511.368408422823;4624.213883639789;4779.4264688236935;4792.329073929653;4858.95141048585;146851;149161;153517;153567.2321638407;157211.4278857197;140304;140534.29732851475;142147;142538;145831;117188;119916;119964.40017799856;120230;122353.7764622378;8256.339492840678;8856.202941735275;9173.744248944686;9245.953770231376;9285.86071208946;45495.77252113718;59974.10038849334;66309.66845165743;66805.33194667991;67408.32591674216;91048.08951910396;94796;94934.52532737292;95369.52315238657;97802.5109874446;11946.283223006647;11964.401779910795;12015.219010764273;12052.698682533006;12186.2078964867;13322.69565434184;13669.316534173451;13704.657383565092;13726.65683357924;14224.71550568962;12262.816057759319;12490.87509124897;12526.143628884302;12604.991600672107;12833.807492887427;12560.497580096693;12825.422855971317;12827.743445131231;12909.806352904527;12945.223286602833;10978.176636752436;12217.328046957502;12490.562830300896;12688.6827829305;12797.680057998625;10660.946695266784;10901.83647245276;10949.945250273699;11002.834957475485;11011.834822477509;10139.442330671884;10669.8933010672;10777.62278320255;10849.891501084889;10875.782484350428 16:43:14 INFO - PROCESS | 1957 | __end_tp_report 16:43:14 INFO - PROCESS | 1957 | __start_cc_report 16:43:14 INFO - PROCESS | 1957 | _x_x_mozilla_cycle_collect,447 16:43:14 INFO - PROCESS | 1957 | __end_cc_report 16:43:14 INFO - PROCESS | 1957 | __startTimestamp1468885394598__endTimestamp 16:43:14 INFO - PROCESS | 1957 | 16:43:14 INFO - PROCESS | 1957 | ------- Summary: start ------- 16:43:14 INFO - PROCESS | 1957 | Number of tests: 6 16:43:14 INFO - PROCESS | 1957 | 16:43:14 INFO - PROCESS | 1957 | [#0] dojo.html Cycles:165 Average:5823.61 Median:6080.36 stddev:804.77 (13.2%) stddev-sans-first:772.10 16:43:14 INFO - PROCESS | 1957 | Values: 2825.3 3285.8 3396.2 3428.4 3443.2 5823.8 5912.6 5914.2 5968.1 5971.1 5711.9 5804.6 5964.6 5967.4 6045.8 4919.6 5326.2 5365.3 5508.9 5520.0 43.4 5363.8 5447.1 5482.3 5516.6 4480.8 5395.8 5398.6 5423.1 5426.2 5341.6 5426.6 5461.6 5466.0 5468.5 5300.5 5314.7 5371.7 5375.6 5393.4 5003.4 5041.9 5944.2 5945.9 5984.3 6198.6 6263.8 6321.7 6322.8 6336.5 6256.2 6350.7 6363.9 6373.8 6374.6 6029.3 6034.7 6049.6 6056.9 6062.8 6264.5 6372.5 6389.9 6396.5 6427.9 6232.1 6330.9 6340.2 6340.9 6366.9 6406.6 6417.8 6426.4 6440.9 6441.7 6181.0 6268.2 6299.2 6302.4 6352.2 6227.8 6275.8 6303.3 6320.1 6323.4 5087.7 5146.4 5158.8 5166.6 5198.7 4523.7 4607.6 4656.2 4662.9 4712.4 5956.5 5991.6 6012.1 6073.3 6094.2 6287.1 6367.0 6371.6 6372.9 6382.3 6069.6 6076.9 6077.2 6080.4 6093.2 5527.6 5576.9 5635.8 5642.7 5686.2 5427.1 5517.2 5524.0 6394.4 6450.5 6372.7 6373.9 6381.4 6402.5 6416.4 5418.5 6360.0 6388.3 6401.5 6497.7 5594.0 6318.8 6331.9 6335.6 6342.2 5613.2 5946.6 6343.4 6390.5 6393.9 5184.9 6104.7 6145.4 6299.8 6309.8 6291.7 6320.2 6346.7 6355.4 6381.9 6079.2 6230.7 6256.2 6284.2 6290.7 6110.8 6208.6 6228.6 6254.6 6272.2 5240.4 6152.1 6160.2 6183.1 6206.2 16:43:14 INFO - PROCESS | 1957 | 16:43:14 INFO - PROCESS | 1957 | [#1] ext.html Cycles:180 Average:71204.67 Median:40388.60 stddev:166961.86 (413.4%) stddev-sans-first:167345.80 16:43:14 INFO - PROCESS | 1957 | Values: 481.6 493.4 520.7 542.0 564.0 37852.9 40258.6 40338.8 40365.2 40472.6 41844.6 42340.0 42348.2 42354.4 42375.8 9582.6 9619.0 9709.0 9720.6 9768.8 9746.9 9793.6 9842.2 9875.1 9894.5 9798.7 9860.9 9911.8 9926.6 9936.6 9790.0 9850.7 9863.4 9901.4 9902.5 9612.6 9727.8 9816.8 9824.3 9846.7 39543.8 40119.6 40412.0 40438.0 40524.4 3471.0 3614.9 3824.7 3942.6 4271.7 31816.9 32032.5 32367.4 32629.7 33204.3 3238.7 3323.2 3373.5 3400.3 3426.2 375283.1 378024.0 378605.0 378638.1 378981.0 32119.8 33299.0 58727.4 58828.0 59251.4 33457.0 34193.0 34216.8 34329.8 34408.0 12928.0 14742.0 14983.3 15017.5 15282.7 12855.2 12884.5 12990.5 13016.5 13017.0 7655.6 7670.1 7674.1 7726.8 7730.4 3097.5 3131.9 3141.7 3141.8 3168.4 786.8 962.0 962.7 974.2 1040.9 26999.3 30450.2 30566.0 30729.2 31591.7 909.9 1094.4 1144.8 1179.2 1181.5 12783.4 14702.6 15892.0 16072.6 16476.6 640615.0 753584.0 780087.0 783676.9 968314.3 53750.0 60335.4 60940.7 61068.0 61246.7 1395.9 1411.5 1422.0 1427.2 1430.5 30707.2 30830.2 31086.2 31590.4 31686.7 51051.0 51199.0 51329.2 51405.0 51660.7 612624.0 614920.0 618477.0 618869.0 620835.0 22695.2 26495.6 26774.9 27106.1 27197.2 49572.8 49578.8 50111.0 50243.7 50341.5 40869.4 41265.8 41269.2 41443.0 42057.9 40574.2 40676.0 40870.0 40994.4 41643.8 38752.0 39174.4 39304.0 39892.4 41952.0 33353.2 35770.3 36325.7 36386.8 36607.6 25683.9 26076.0 26149.9 26238.7 26450.0 16:43:14 INFO - PROCESS | 1957 | 16:43:14 INFO - PROCESS | 1957 | [#2] jquery.html Cycles:180 Average:35983.77 Median:2069.31 stddev:106777.42 (5160.1%) stddev-sans-first:107043.49 16:43:14 INFO - PROCESS | 1957 | Values: 379.5 384.5 387.0 400.8 407.4 19720.7 21849.2 21985.9 22583.8 22684.9 21470.0 21584.7 21693.5 21809.6 21981.7 5023.9 5361.8 5376.1 5407.2 5434.8 3902.7 4437.4 5877.0 6166.0 6182.3 5325.0 6009.4 6135.6 6206.6 6242.4 4981.3 6070.5 6091.9 6119.6 6189.3 5838.4 5908.7 5995.4 6013.5 6014.2 13571.7 23492.0 23556.4 24853.6 26244.7 1962.5 2258.3 2484.0 2980.8 3049.8 9892.2 10074.4 10133.7 10274.6 10378.6 1374.5 1826.1 1890.8 1894.6 1903.9 100695.0 125949.0 132755.7 133297.0 134067.0 11698.7 11748.5 11815.2 11891.9 11908.3 12063.4 14839.6 14841.4 14889.7 14945.3 7343.6 8776.5 8827.5 8850.7 8882.3 7180.4 7214.4 8897.3 9018.5 9050.4 3766.3 4599.1 4672.0 4709.7 4719.4 1494.8 1560.2 1693.3 1729.5 1920.4 372.3 891.5 921.7 941.6 1050.4 11674.5 12276.8 12289.4 12313.3 12350.4 422.2 432.2 439.0 443.2 446.6 6225.1 6257.8 6284.7 6348.3 6361.5 627278.0 639428.0 641712.0 643121.0 643390.0 130856.3 133605.0 133632.0 135539.3 135884.0 435.6 438.8 445.0 446.0 447.0 11439.0 11530.5 11572.1 11603.9 11720.2 39079.6 44774.3 53957.0 54109.6 57649.7 78578.0 81481.6 82370.4 82590.6 83435.0 7209.7 7609.2 7643.2 7902.3 8269.3 12758.6 13714.0 13723.5 13810.1 13969.8 11691.5 11764.5 11766.4 11881.8 11988.8 11502.3 11631.0 11689.9 11708.6 11823.1 11846.8 11849.0 11927.3 12023.0 12099.2 7583.0 7642.6 7651.1 7665.6 7800.4 10173.8 10747.1 10955.3 11818.2 11903.5 16:43:14 INFO - PROCESS | 1957 | 16:43:14 INFO - PROCESS | 1957 | [#3] mootools.html Cycles:180 Average:5692.33 Median:5072.18 stddev:3180.52 (62.7%) stddev-sans-first:3173.73 16:43:14 INFO - PROCESS | 1957 | Values: 1485.7 1555.7 1796.7 1914.2 1934.4 7892.8 8467.9 8509.7 8890.2 8926.6 7978.9 8237.6 8534.1 8722.6 8732.7 2338.4 2359.7 2365.8 2366.2 2368.1 2301.6 2358.6 2375.3 2395.2 2398.8 2320.7 2354.8 2364.2 2373.3 2375.0 2342.5 2365.3 2370.2 2378.5 2379.6 2308.1 2363.8 2364.4 2374.2 2375.3 8759.1 8840.4 8844.6 8846.0 8869.3 5265.4 5318.1 5404.1 5421.1 5426.9 3194.7 3520.5 3634.2 3649.9 3697.4 1092.0 1098.6 1099.2 1105.5 1115.9 11484.3 11514.7 11634.6 11690.3 11723.8 3851.6 4575.2 4781.5 4782.2 4829.0 9983.9 9991.6 9996.4 10017.1 10023.5 5261.3 5376.8 5379.9 5390.0 5416.7 4399.3 4780.0 4838.7 4892.6 4968.1 3354.0 3452.6 4014.5 4043.6 4125.6 1284.6 1288.9 1292.1 1301.6 1317.3 931.9 936.4 940.1 944.3 995.3 5762.1 5873.2 5896.6 5986.3 6056.8 382.2 402.2 410.8 410.9 414.1 3984.2 3994.7 4065.7 4067.9 4083.4 9866.5 10565.8 10681.1 10689.9 10692.5 10242.7 10474.8 10634.6 10641.5 10684.4 8168.4 8249.7 8254.3 8261.1 8271.0 5792.6 5814.9 5848.1 5853.2 5913.9 9727.0 9857.0 9863.9 9879.6 9966.9 7868.0 9957.0 10080.5 10158.8 10168.9 6771.5 7366.1 7555.1 7557.3 7652.3 8358.1 8408.3 8446.5 8516.5 8518.6 7394.7 7539.1 7582.2 7626.6 7667.7 7420.6 7495.4 7504.2 7601.0 7601.9 7026.7 7079.1 7113.0 7131.9 7163.7 4938.2 5069.2 5134.9 5136.2 5137.6 5075.1 5084.6 5098.6 5149.0 5151.8 16:43:14 INFO - PROCESS | 1957 | 16:43:14 INFO - PROCESS | 1957 | [#4] prototype.html Cycles:180 Average:4691.70 Median:5221.40 stddev:1496.64 (28.7%) stddev-sans-first:1464.06 16:43:14 INFO - PROCESS | 1957 | Values: 298.2 303.2 304.3 307.8 311.1 4315.9 5148.9 5424.8 5580.8 5665.5 4539.9 5497.7 5523.6 5587.8 5612.7 3917.9 4092.5 4175.0 4177.2 4193.1 3635.1 4086.3 4181.7 4183.4 4205.0 3456.0 3525.7 3624.6 4151.1 4196.6 3861.6 4095.0 4123.8 4170.4 4198.9 3539.8 3543.3 3564.4 3566.4 3581.3 4455.5 4467.4 5399.3 5416.5 5483.3 4585.5 4753.8 4782.8 4783.3 4811.7 5778.2 5799.7 5812.1 5856.4 5861.6 3299.9 3460.7 3695.2 3911.7 3947.8 4522.2 5280.6 6085.5 6148.3 6157.7 3251.8 3570.5 3954.1 3965.3 3984.5 3380.0 4041.3 4047.6 4058.6 4086.8 4318.8 4618.3 4699.5 4762.2 4777.4 5583.6 5864.6 5864.9 5903.3 5910.4 1352.2 1377.7 1380.7 1388.5 1391.3 805.9 844.1 845.3 850.0 882.5 4715.0 4923.4 5098.8 5222.5 5385.7 5080.9 5696.3 5869.2 5890.7 5924.3 4275.5 4919.5 5070.5 5353.4 5590.5 2684.5 2794.7 3233.9 3248.6 3252.1 5777.6 6245.3 6274.2 6313.0 6318.3 5792.3 5891.7 6294.6 6309.7 6328.7 4799.3 5262.6 6348.7 6358.0 6358.6 5142.5 5967.6 6103.7 6108.7 6144.4 5128.9 5342.1 6071.3 6105.3 6111.8 5073.7 5969.3 6085.7 6303.7 6333.5 3548.0 3875.6 3973.7 4022.3 4055.4 5051.8 6149.3 6166.5 6192.6 6201.9 4994.4 5522.4 5969.6 5976.7 5981.1 5646.9 5876.7 5926.3 5938.5 5996.9 5220.3 5509.4 5546.0 5855.5 5869.2 5772.3 5942.6 5951.4 6001.4 6004.7 5050.7 5534.9 5731.5 5880.6 5887.7 16:43:14 INFO - PROCESS | 1957 | 16:43:14 INFO - PROCESS | 1957 | [#5] yui.html Cycles:180 Average:25863.30 Median:12885.16 stddev:42243.25 (327.8%) stddev-sans-first:42319.65 16:43:14 INFO - PROCESS | 1957 | Values: 743.7 787.7 789.1 824.6 855.6 14213.0 15269.8 15935.2 15967.0 16036.7 13066.0 14442.4 14443.6 14466.7 14479.2 684.7 754.2 861.5 870.5 893.1 876.8 895.7 902.6 906.1 907.4 947.4 955.8 960.1 960.6 960.8 855.6 916.6 956.9 958.9 962.5 696.4 696.8 707.1 707.4 709.2 15249.2 15489.9 15512.7 15652.1 15658.1 14888.2 15088.2 15100.8 15132.9 15157.5 10240.6 12090.3 12369.3 12623.1 12729.2 3848.2 3860.2 3877.9 4000.0 4031.5 115030.0 115537.4 115564.0 121820.0 130698.3 10696.2 10859.2 11093.9 11350.5 11481.0 21814.3 22161.6 22188.0 22221.0 22267.7 7787.1 7792.6 8061.0 8082.8 8487.4 4511.5 4585.6 4595.7 4681.2 4703.0 3502.6 3638.7 3640.4 3649.4 3649.5 682.8 688.3 688.7 689.8 708.9 574.7 619.9 626.0 647.4 721.7 9216.7 9749.1 9789.5 9858.9 10036.3 575.6 630.8 649.2 696.9 711.5 4511.4 4624.2 4779.4 4792.3 4859.0 146851.0 149161.0 153517.0 153567.2 157211.4 140304.0 140534.3 142147.0 142538.0 145831.0 117188.0 119916.0 119964.4 120230.0 122353.8 8256.3 8856.2 9173.7 9246.0 9285.9 45495.8 59974.1 66309.7 66805.3 67408.3 91048.1 94796.0 94934.5 95369.5 97802.5 11946.3 11964.4 12015.2 12052.7 12186.2 13322.7 13669.3 13704.7 13726.7 14224.7 12262.8 12490.9 12526.1 12605.0 12833.8 12560.5 12825.4 12827.7 12909.8 12945.2 10978.2 12217.3 12490.6 12688.7 12797.7 10660.9 10901.8 10949.9 11002.8 11011.8 10139.4 10669.9 10777.6 10849.9 10875.8 16:43:14 INFO - PROCESS | 1957 | -------- Summary: end -------- 16:43:14 INFO - PROCESS | 1957 | 16:43:15 INFO - TEST-INFO | 1957: exit 0 16:43:15 INFO - TEST-OK | dromaeo_css | took 1112164ms 16:43:15 INFO - TEST-START | kraken 16:43:15 INFO - operating with platform_type : mac_ 16:43:15 INFO - Initialising browser for kraken test... 16:43:15 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmp5U7mbQ/profile http://localhost:53258/getInfo.html) 16:43:18 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 16:43:18 INFO - PROCESS | 1964 | colorDepth:24 16:43:18 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 16:43:18 INFO - PROCESS | 1964 | __metrics 16:43:18 ERROR - PROCESS | 1964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:43:19 INFO - TEST-INFO | 1964: exit 0 16:43:19 INFO - Browser initialized. 16:43:19 INFO - Running cycle 1/1 for kraken test... 16:43:19 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmp5U7mbQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:31 INFO - PROCESS | 1966 | RSS: Main: 254418944 16:43:31 INFO - PROCESS | 1966 | 16:43:34 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53258/tests/kraken/driver.html?testName=audio-beat-detection) 16:43:35 INFO - PROCESS | 1966 | RSS: Main: 267403264 16:43:35 INFO - PROCESS | 1966 | 16:43:37 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53258/tests/kraken/driver.html?testName=audio-dft) 16:43:38 INFO - PROCESS | 1966 | RSS: Main: 271433728 16:43:38 INFO - PROCESS | 1966 | 16:43:41 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53258/tests/kraken/driver.html?testName=audio-fft) 16:43:42 INFO - PROCESS | 1966 | RSS: Main: 271896576 16:43:42 INFO - PROCESS | 1966 | 16:43:44 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53258/tests/kraken/driver.html?testName=audio-oscillator) 16:43:44 INFO - PROCESS | 1966 | RSS: Main: 272830464 16:43:44 INFO - PROCESS | 1966 | 16:43:46 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53258/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:43:47 INFO - PROCESS | 1966 | RSS: Main: 273514496 16:43:47 INFO - PROCESS | 1966 | 16:43:50 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53258/tests/kraken/driver.html?testName=imaging-darkroom) 16:43:51 INFO - PROCESS | 1966 | RSS: Main: 273797120 16:43:51 INFO - PROCESS | 1966 | 16:43:54 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53258/tests/kraken/driver.html?testName=imaging-desaturate) 16:43:55 INFO - PROCESS | 1966 | RSS: Main: 274272256 16:43:55 INFO - PROCESS | 1966 | 16:43:58 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53258/tests/kraken/driver.html?testName=json-parse-financial) 16:43:58 INFO - PROCESS | 1966 | RSS: Main: 274321408 16:43:58 INFO - PROCESS | 1966 | 16:44:00 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53258/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:44:00 INFO - PROCESS | 1966 | RSS: Main: 273989632 16:44:00 INFO - PROCESS | 1966 | 16:44:02 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:44:03 INFO - PROCESS | 1966 | RSS: Main: 274022400 16:44:03 INFO - PROCESS | 1966 | 16:44:05 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:44:06 INFO - PROCESS | 1966 | RSS: Main: 273928192 16:44:06 INFO - PROCESS | 1966 | 16:44:09 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:44:10 INFO - PROCESS | 1966 | RSS: Main: 274321408 16:44:10 INFO - PROCESS | 1966 | 16:44:13 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:44:13 INFO - PROCESS | 1966 | RSS: Main: 274055168 16:44:13 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:53258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53258/tests/kraken/driver.html?testName=ai-astar) 16:44:15 INFO - PROCESS | 1966 | RSS: Main: 274870272 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | __start_tp_report 16:44:15 INFO - PROCESS | 1966 | _x_x_mozilla_page_load 16:44:15 INFO - PROCESS | 1966 | _x_x_mozilla_page_load_details 16:44:15 INFO - PROCESS | 1966 | |i|pagename|runs| 16:44:15 INFO - PROCESS | 1966 | |0;ai-astar;105;119;107;116;117;116;115;117;116;118 16:44:15 INFO - PROCESS | 1966 | |1;audio-beat-detection;145;109;132;158;111;125;165;142;165;91 16:44:15 INFO - PROCESS | 1966 | |2;audio-dft;202;213;223;203;200;197;196;198;202;197 16:44:15 INFO - PROCESS | 1966 | |3;audio-fft;71;84;77;146;57;59;62;65;137;67 16:44:15 INFO - PROCESS | 1966 | |4;audio-oscillator;70;73;123;73;74;81;118;70;72;116 16:44:15 INFO - PROCESS | 1966 | |5;imaging-gaussian-blur;101;132;136;91;92;90;93;91;92;89 16:44:15 INFO - PROCESS | 1966 | |6;imaging-darkroom;116;151;106;158;146;104;150;115;132;152 16:44:15 INFO - PROCESS | 1966 | |7;imaging-desaturate;125;93;104;93;92;102;137;90;98;93 16:44:15 INFO - PROCESS | 1966 | |8;json-parse-financial;54;57;54;52;55;85;51;55;82;85 16:44:15 INFO - PROCESS | 1966 | |9;json-stringify-tinderbox;69;72;69;79;76;87;79;73;69;62 16:44:15 INFO - PROCESS | 1966 | |10;stanford-crypto-aes;99;73;84;73;104;103;105;87;91;93 16:44:15 INFO - PROCESS | 1966 | |11;stanford-crypto-ccm;136;135;135;150;184;152;154;146;202;149 16:44:15 INFO - PROCESS | 1966 | |12;stanford-crypto-pbkdf2;169;171;175;172;215;170;182;199;181;168 16:44:15 INFO - PROCESS | 1966 | |13;stanford-crypto-sha256-iterative;66;70;68;67;65;68;69;78;89;87 16:44:15 INFO - PROCESS | 1966 | __end_tp_report 16:44:15 INFO - PROCESS | 1966 | __start_cc_report 16:44:15 INFO - PROCESS | 1966 | _x_x_mozilla_cycle_collect,1113 16:44:15 INFO - PROCESS | 1966 | __end_cc_report 16:44:15 INFO - PROCESS | 1966 | __startTimestamp1468885455662__endTimestamp 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | ------- Summary: start ------- 16:44:15 INFO - PROCESS | 1966 | Number of tests: 14 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#0] ai-astar Cycles:10 Average:114.60 Median:116.50 stddev:4.70 (4.0%) stddev-sans-first:3.46 16:44:15 INFO - PROCESS | 1966 | Values: 105.0 119.0 107.0 116.0 117.0 116.0 115.0 117.0 116.0 118.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:151.50 stddev:25.32 (16.7%) stddev-sans-first:26.56 16:44:15 INFO - PROCESS | 1966 | Values: 145.0 109.0 132.0 158.0 111.0 125.0 165.0 142.0 165.0 91.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#2] audio-dft Cycles:10 Average:203.10 Median:202.00 stddev:8.54 (4.2%) stddev-sans-first:9.05 16:44:15 INFO - PROCESS | 1966 | Values: 202.0 213.0 223.0 203.0 200.0 197.0 196.0 198.0 202.0 197.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#3] audio-fft Cycles:10 Average:82.50 Median:66.00 stddev:32.21 (48.8%) stddev-sans-first:33.89 16:44:15 INFO - PROCESS | 1966 | Values: 71.0 84.0 77.0 146.0 57.0 59.0 62.0 65.0 137.0 67.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#4] audio-oscillator Cycles:10 Average:87.00 Median:72.50 stddev:22.36 (30.8%) stddev-sans-first:22.85 16:44:15 INFO - PROCESS | 1966 | Values: 70.0 73.0 123.0 73.0 74.0 81.0 118.0 70.0 72.0 116.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#5] imaging-gaussian-blur Cycles:10 Average:100.70 Median:91.00 stddev:17.88 (19.6%) stddev-sans-first:18.96 16:44:15 INFO - PROCESS | 1966 | Values: 101.0 132.0 136.0 91.0 92.0 90.0 93.0 91.0 92.0 89.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#6] imaging-darkroom Cycles:10 Average:133.00 Median:148.00 stddev:20.95 (14.2%) stddev-sans-first:21.30 16:44:15 INFO - PROCESS | 1966 | Values: 116.0 151.0 106.0 158.0 146.0 104.0 150.0 115.0 132.0 152.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#7] imaging-desaturate Cycles:10 Average:102.70 Median:92.50 stddev:15.83 (17.1%) stddev-sans-first:14.59 16:44:15 INFO - PROCESS | 1966 | Values: 125.0 93.0 104.0 93.0 92.0 102.0 137.0 90.0 98.0 93.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:56.00 stddev:14.61 (26.1%) stddev-sans-first:15.12 16:44:15 INFO - PROCESS | 1966 | Values: 54.0 57.0 54.0 52.0 55.0 85.0 51.0 55.0 82.0 85.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#9] json-stringify-tinderbox Cycles:10 Average:73.50 Median:74.50 stddev:7.03 (9.4%) stddev-sans-first:7.26 16:44:15 INFO - PROCESS | 1966 | Values: 69.0 72.0 69.0 79.0 76.0 87.0 79.0 73.0 69.0 62.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:85.50 stddev:11.97 (14.0%) stddev-sans-first:12.36 16:44:15 INFO - PROCESS | 1966 | Values: 99.0 73.0 84.0 73.0 104.0 103.0 105.0 87.0 91.0 93.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#11] stanford-crypto-ccm Cycles:10 Average:154.30 Median:151.00 stddev:22.01 (14.6%) stddev-sans-first:22.32 16:44:15 INFO - PROCESS | 1966 | Values: 136.0 135.0 135.0 150.0 184.0 152.0 154.0 146.0 202.0 149.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:178.00 stddev:15.37 (8.6%) stddev-sans-first:15.76 16:44:15 INFO - PROCESS | 1966 | Values: 169.0 171.0 175.0 172.0 215.0 170.0 182.0 199.0 181.0 168.0 16:44:15 INFO - PROCESS | 1966 | 16:44:15 INFO - PROCESS | 1966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:69.50 stddev:8.82 (12.7%) stddev-sans-first:9.02 16:44:15 INFO - PROCESS | 1966 | Values: 66.0 70.0 68.0 67.0 65.0 68.0 69.0 78.0 89.0 87.0 16:44:15 INFO - PROCESS | 1966 | -------- Summary: end -------- 16:44:15 INFO - PROCESS | 1966 | 16:44:16 INFO - TEST-INFO | 1966: exit 0 16:44:16 INFO - TEST-OK | kraken | took 61277ms 16:44:16 INFO - SUITE-END | took 1173s 16:44:16 INFO - Completed test suite (00:19:33) 16:44:16 INFO - javascript benchmark 16:44:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7245.308108885427, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2825.279553713803, 3285.7699961002722, 3396.2188696599796, 3428.3828910796046, 3443.22527431328, 5823.825285241444, 5912.556558258127, 5914.172015917769, 5968.074948382997, 5971.074483455066, 5711.885762284752, 5804.622699524539, 5964.552658550604, 5967.433093856077, 6045.7883974060915, 4919.606431485473, 5326.174442961337, 5365.275687782138, 5508.889822203553, 5520.0, 43.4232658443081, 5363.758630861621, 5447.073997420428, 5482.2873026506495, 5516.586256030793, 4480.798364073608, 5395.78416863325, 5398.568114550866, 5423.132298832168, 5426.186072089179, 5341.599380046512, 5426.593005524602, 5461.563074953994, 5465.9726701366635, 5468.535174510172, 5300.522952934216, 5314.734263286859, 5371.650842695212, 5375.596830237748, 5393.433689462589, 5003.374578177728, 5041.873953151201, 5944.197533332988, 5945.910811337833, 5984.251968503937, 6198.6280823150755, 6263.78076767311, 6321.6523091229965, 6322.810315690536, 6336.493080553545, 6256.15541901842, 6350.745970161188, 6363.9045414318825, 6373.776917807901, 6374.553781235315, 6029.336772954972, 6034.668093254869, 6049.637021778707, 6056.939430605726, 6062.818115456544, 6264.5301602380005, 6372.458341041063, 6389.8722025560155, 6396.488280937514, 6427.903581446189, 6232.065190221503, 6330.905036424458, 6340.207474065742, 6340.904886426707, 6366.936330636727, 6406.647634380154, 6417.7753778617525, 6426.4216220540375, 6440.903386449207, 6441.677916104176, 6181.0, 6268.247810262797, 6299.244090709144, 6302.401271879165, 6352.237731472253, 6227.813165605039, 6275.843103922347, 6303.3066362700065, 6320.146780184617, 6323.399277068671, 5087.745612719349, 5146.433892271847, 5158.793648254028, 5166.5866730661455, 5198.662086964335, 4523.728576285368, 4607.631389488833, 4656.185167595657, 4662.906741865144, 4712.410948631421, 5956.463918247378, 5991.580589358703, 6012.098185272244, 6073.30157031947, 6094.177286066324, 6287.088372186007, 6367.0449432584555, 6371.649559274284, 6372.872542549123, 6382.266039405527, 6069.635821850615, 6076.875777981088, 6077.17958075663, 6080.361562035922, 6093.177421048191, 5527.55779537636, 5576.888462230732, 5635.774569017275, 5642.71786410686, 5686.2039314496005, 5427.1316589345515, 5517.200005999188, 5523.972380138073, 6394.3925327094785, 6450.451711604566, 6372.713227904663, 6373.8725225496155, 6381.425671689571, 6402.487800976004, 6416.390442907917, 5418.512333889968, 6359.96820015897, 6388.2972872984865, 6401.487880969418, 6497.74009039652, 5594.021046316797, 6318.810435686937, 6331.90502142459, 6335.556511044183, 6342.207224096988, 5613.214150018919, 5946.572822522477, 6343.397377249154, 6390.520710946605, 6393.8721225576155, 5184.922226166535, 6104.701693046632, 6145.385461453819, 6299.811005669837, 6309.842253943504, 6291.685415729104, 6320.178376810985, 6346.682665866781, 6355.396237357444, 6381.904271436025, 6079.179310792986, 6230.657313847782, 6256.155419018374, 6284.214473190851, 6290.748370065146, 6110.801781737137, 6208.627482351073, 6228.626282423069, 6254.6247225166635, 6272.18461599989, 5240.397354304151, 6152.107944347955, 6160.229971253593, 6183.072539119168, 6206.224221972254], "value": 5775.38408470704, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.63395819177424, 493.3684883349313, 520.6797819341107, 541.9512243898048, 564.0, 37852.86441406759, 40258.59741402585, 40338.7983060085, 40365.1926961461, 40472.59527404725, 41844.58155418445, 42340.0, 42348.15303693932, 42354.364684529755, 42375.788121059355, 9582.616695332195, 9619.0, 9708.951455242714, 9720.61117555297, 9768.804623907517, 9746.90253097467, 9793.559289831976, 9842.163416109603, 9875.061869122457, 9894.455804930725, 9798.657047003357, 9860.901390986106, 9911.801763964717, 9926.602935882556, 9936.552855121501, 9789.951050244774, 9850.70447886561, 9863.358881672704, 9901.356411833243, 9902.504874756234, 9612.567434465465, 9727.805443891153, 9816.754581135458, 9824.263180261438, 9846.704598862045, 39543.8022809887, 40119.598804011875, 40412.0, 40437.98905027368, 40524.39213411801, 3470.9826450867836, 3614.9277014459562, 3824.6749026332795, 3942.64516193544, 4271.743695378256, 31816.886408975806, 32032.519512207335, 32367.35265294681, 32629.67370326314, 33204.335913281844, 3238.724708399789, 3323.2356557991557, 3373.4602463605706, 3400.285939952613, 3426.229098452853, 375283.1235843803, 378024.0, 378605.0, 378638.10680946696, 378981.0, 32119.839400802848, 33299.00102996914, 58727.41272587219, 58828.0, 59251.407485925454, 33456.99629011133, 34193.0, 34216.82891585526, 34329.82835085859, 34408.0, 12928.0, 14742.041767285093, 14983.250837458083, 15017.549473515812, 15282.694346113016, 12855.16441431304, 12884.48462061507, 12990.480380784662, 13016.47934082645, 13017.0, 7655.578943158069, 7670.0795904491815, 7674.117476490163, 7726.7681969541, 7730.381569474429, 3097.504399296102, 3131.85906634202, 3141.732952699046, 3141.79578327408, 3168.3821654777557, 786.7962018112297, 961.9610820314044, 962.7159987803615, 974.1865542272141, 1040.921930855189, 26999.325016874343, 30450.238744031132, 30566.0, 30729.231769205948, 31591.684083159333, 909.8544232922701, 1094.414488248783, 1144.7996600594863, 1179.1627944159743, 1181.4919584578713, 12783.360831958551, 14702.55892323232, 15892.0, 16072.598185045468, 16476.588085297964, 640615.0, 753584.0, 780087.0, 783676.8977706281, 968314.3168568366, 53750.0, 60335.396646033856, 60940.69529652412, 61068.0, 61246.693766531775, 1395.8673925977016, 1411.4636438153436, 1422.0472283570032, 1427.2150317325636, 1430.470725831449, 30707.157570544947, 30830.229244269074, 31086.22284442907, 31590.36819263556, 31686.68313316837, 51051.0, 51199.0, 51329.23006154836, 51405.0, 51660.74169629278, 612624.0, 614920.0, 618477.0, 618869.0, 620835.0, 22695.205667801547, 26495.60256596114, 26774.866125670025, 27106.051288204817, 27197.184084477496, 49572.75213623909, 49578.75210623924, 50111.0, 50243.74878125732, 50341.49658503368, 40869.38695919504, 41265.79367103145, 41269.20893545414, 41442.96392590209, 42057.94855128646, 40574.188516230104, 40675.98310042272, 40870.0, 40994.385084224356, 41643.7917810409, 38752.0, 39174.412383813695, 39304.0, 39892.40161397639, 41952.0, 33353.16617084592, 35770.28459430745, 36325.72859949889, 36386.8180659095, 36607.63392366149, 25683.87158064198, 26076.0, 26149.869250653624, 26238.73761262363, 26450.002496131303], "value": 18939.502520428123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.544546544147, 384.47327161788354, 387.0440013167476, 400.8276441130316, 407.4051884248996, 19720.70418943717, 21849.235276765317, 21985.890070549664, 22583.77416225837, 22684.86575671218, 21470.0, 21584.66804927414, 21693.45766355842, 21809.563808723815, 21981.67027494589, 5023.899522009567, 5361.839144825662, 5376.11294136467, 5407.188921661743, 5434.7826086956475, 3902.746321489094, 4437.35658329542, 5876.970615146918, 6165.969170154165, 6182.289036760762, 5324.973375133139, 6009.369016253274, 6135.601185922923, 6206.565540412151, 6242.438180563771, 4981.277714731362, 6070.544709146788, 6091.878162436771, 6119.632822030648, 6189.257289125311, 5838.386969368197, 5908.67502287374, 5995.370486098984, 6013.458788708994, 6014.188084608566, 13571.660708482268, 23492.0, 23556.411089722722, 24853.627195592082, 26244.73755262461, 1962.528993041674, 2258.2570632709812, 2483.962740558875, 2980.7615390768688, 3049.817010979348, 9892.208623310118, 10074.445905475195, 10133.746656333577, 10274.640387586473, 10378.584856605727, 1374.5120482228865, 1826.0960824392012, 1890.8392786613153, 1894.6400183965002, 1903.9048047597564, 100695.0, 125949.0, 132755.67244327627, 133297.0, 134067.0, 11698.70753231159, 11748.53555648848, 11815.172937894436, 11891.88108118925, 11908.285502869856, 12063.396830158457, 14839.629009274639, 14841.40634374613, 14889.70220595582, 14945.327460264314, 7343.596102214429, 8776.473411595325, 8827.470351778913, 8850.73447796567, 8882.289416846637, 7180.425565954711, 7214.386777123898, 8897.332700047522, 9018.458892466473, 9050.411723237969, 3766.2844059628583, 4599.126166028444, 4671.976640116778, 4709.740964246931, 4719.433667959866, 1494.8414978391834, 1560.180905024871, 1693.2634304077765, 1729.5416714570397, 1920.4142736465233, 372.3316646619325, 891.4873947480095, 921.7004473546124, 941.6327632223438, 1050.4485145298627, 11674.474648640831, 12276.754464910651, 12289.385530723606, 12313.322767247888, 12350.44423000967, 422.2357532865523, 432.23925890432434, 439.0494579235982, 443.2000239567547, 446.635991666797, 6225.128482012522, 6257.812265632038, 6284.654344011124, 6348.333424990402, 6361.491080713625, 627278.0, 639428.0, 641712.0, 643121.0, 643390.0, 130856.3457182727, 133605.0, 133632.0, 135539.32230338786, 135884.0, 435.5970727077441, 438.7762241256918, 445.03649598618625, 445.9955400445954, 447.0098731310164, 11439.0, 11530.538778449103, 11572.074234061087, 11603.897629725163, 11720.238184517979, 39079.60920390873, 44774.3283850736, 53957.0, 54109.64725881885, 57649.71175144265, 78578.0, 81481.59259203666, 82370.352592949, 82590.58704706439, 83435.0, 7209.747658831916, 7609.2010338913615, 7643.235676432312, 7902.328302094386, 8269.2971097455, 12758.61724148277, 13714.0400171987, 13723.451061957809, 13810.10234334765, 13969.790453143009, 11691.532338706356, 11764.529418823151, 11766.411679416165, 11881.762364752829, 11988.820167697666, 11502.252353596989, 11631.0, 11689.88310116922, 11708.590199342982, 11823.11326650522, 11846.763064738485, 11849.0, 11927.284362938251, 12023.038156947248, 12099.153059285765, 7583.0, 7642.579658118634, 7651.120121186135, 7665.578393188428, 7800.4149688774705, 10173.84739228927, 10747.140228781835, 10955.287906286067, 11818.172727908965, 11903.46434410471], "value": 8786.340975159952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.7325681377351, 1555.696639155365, 1796.6855800234955, 1914.1673372083144, 1934.3616606519831, 7892.763217103482, 8467.91532084679, 8509.659613615455, 8890.244329232015, 8926.59830307637, 7978.880316795253, 8237.6293066812, 8534.1039190885, 8722.563871806417, 8732.738017859458, 2338.368640467073, 2359.740428552858, 2365.8107351411845, 2366.171839856054, 2368.0764501844296, 2301.551197516485, 2358.6344116661944, 2375.299286710416, 2395.2215529952746, 2398.8440751351104, 2320.709911261092, 2354.799842013431, 2364.2316247219637, 2373.252425485975, 2374.9525009499885, 2342.500799488329, 2365.2667673021333, 2370.182287110944, 2378.5242951409787, 2379.631157170633, 2308.111377119821, 2363.7636236376397, 2364.4443555764383, 2374.228375777879, 2375.3349062262596, 8759.124087591254, 8840.38117331787, 8844.646214151491, 8845.955770221171, 8869.290456763509, 5265.394479634852, 5318.149096144598, 5404.108322126884, 5421.132618780976, 5426.9185962210595, 3194.68053194681, 3520.4895290183035, 3634.2368102698465, 3649.908752281188, 3697.3529632314508, 1091.9890801091967, 1098.6264670012154, 1099.164634877491, 1105.5190991918462, 1115.893990070942, 11484.310941343463, 11514.712132196762, 11634.59278925242, 11690.298582085103, 11723.824142637868, 3851.5955824638568, 4575.24508456101, 4781.450133234653, 4782.234842425195, 4828.985912958248, 9983.900160998297, 9991.600335986624, 9996.400215987063, 10017.098461138532, 10023.548940297704, 5261.263423120766, 5376.8118115865755, 5379.892402151935, 5390.029794637003, 5416.729163541807, 4399.274119770266, 4779.95220047802, 4838.661293709407, 4892.633052521004, 4968.130577149057, 3354.0, 3452.6374730653424, 4014.4781178446615, 4043.5754245804355, 4125.64931980779, 1284.5568278943936, 1288.9097763156676, 1292.08262133886, 1301.6095171448528, 1317.3413293353324, 931.855562387831, 936.3585943628636, 940.1350757303297, 944.3153713557616, 995.2635050062902, 5762.135679648086, 5873.20711703923, 5896.616719913192, 5986.341502434729, 6056.788012419544, 382.23743631455426, 402.21768659956103, 410.80692074724834, 410.86441474313403, 414.09313603208875, 3984.242993831163, 3994.6804255659476, 4065.715399921977, 4067.877963661095, 4083.4283200351974, 9866.506674666238, 10565.788684226272, 10681.077406066826, 10689.893101069045, 10692.518836652369, 10242.743931401625, 10474.790504190027, 10634.574617015232, 10641.467926603793, 10684.358938463716, 8168.387370947203, 8249.670013199524, 8254.257116859511, 8261.091279959199, 8271.048829384577, 5792.594518383673, 5814.854628634318, 5848.093545500455, 5853.209816674695, 5913.881722365442, 9727.0, 9856.950715246665, 9863.852042219229, 9879.555420006262, 9966.850497242402, 7867.9606601966625, 9956.950215248877, 10080.495975201064, 10158.796824063329, 10168.898311016796, 6771.52599318043, 7366.079240094989, 7555.09338879338, 7557.2820582044615, 7652.349550288288, 8358.08061113265, 8408.327333813402, 8446.535440550828, 8516.531590762568, 8518.61666225009, 7394.741184058532, 7539.0576177977755, 7582.203868593939, 7626.618669066635, 7667.654955527126, 7420.591867447342, 7495.43784216175, 7504.249575042671, 7600.961995189989, 7601.923980760122, 7026.683799229149, 7079.079719636415, 7113.0, 7131.893021604784, 7163.7492687755675, 4938.16051271292, 5069.214271787879, 5134.8973020540125, 5136.152534831711, 5137.563307118937, 5075.137226671401, 5084.6440749147205, 5098.566621837185, 5149.0474262261605, 5151.819686311111], "value": 4507.227856048053, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.2246159984041, 303.1844338728819, 304.3259180914275, 307.7922402378394, 311.1210829406923, 4315.892102697434, 5148.91872706732, 5424.8101316453885, 5580.776768929243, 5665.490105890474, 4539.931901021488, 5497.697626630534, 5523.613347065707, 5587.832365029056, 5612.747426365823, 3917.9412308815463, 4092.4679791627045, 4174.994004316887, 4177.206330797138, 4193.056562273495, 3635.073056370622, 4086.346184610448, 4181.665466762652, 4183.3515805050265, 4205.0, 3456.0, 3525.6826885580294, 3624.5650521937273, 4151.08676091261, 4196.601322874338, 3861.613838616144, 4095.0, 4123.783483872265, 4170.35359519275, 4198.85304014358, 3539.7699149555456, 3543.291341731664, 3564.41187204111, 3566.375884220277, 3581.3195492856275, 4455.487618923833, 4467.396901418299, 5399.2980912481125, 5416.512513873731, 5483.341998960151, 4585.518520555361, 4753.786079626425, 4782.756483314363, 4783.28250762385, 4811.687240329403, 5778.162166485836, 5799.652020878761, 5812.070068789016, 5856.443637854397, 5861.618994765369, 3299.9010029699148, 3460.7058400036026, 3695.1685870678884, 3911.7066220033325, 3947.7892380267144, 4522.213725578411, 5280.603954703451, 6085.4523092921845, 6148.292946311187, 6157.661328626924, 3251.7561182911377, 3570.535830342039, 3954.0510277533185, 3965.2862484752445, 3984.541777695602, 3379.983100084533, 4041.333180025322, 4047.5547689754103, 4058.585141840659, 4086.7956602169775, 4318.827246910151, 4618.330342100377, 4699.459562150328, 4762.190427627312, 4777.378940737682, 5583.609147359646, 5864.648121112747, 5864.9413505864395, 5903.26209223847, 5910.408959104141, 1352.2292293392672, 1377.7037936843426, 1380.709037050341, 1388.465440805277, 1391.311300906058, 805.943583949118, 844.0673056272852, 845.2519520224522, 849.9745007649781, 882.5190271302156, 4715.0, 4923.359963204832, 5098.827269727984, 5222.451642577551, 5385.676859388449, 5080.898382032338, 5696.3449203341315, 5869.207656966255, 5890.676012819336, 5924.289085309704, 4275.508316543575, 4919.508049195052, 5070.453511678899, 5353.357597088297, 5590.524805391506, 2684.4765270772014, 2794.6506686664165, 3233.900473838859, 3248.6101667800017, 3252.121927079675, 5777.566682498829, 6245.281792593819, 6274.23545872482, 6313.021481670256, 6318.336574659686, 5792.333881603669, 5891.675957822275, 6294.583718663264, 6309.652969086745, 6328.651924144124, 4799.328094066834, 5262.60530460217, 6348.650824204713, 6357.965451055617, 6358.586691865014, 5142.51146141116, 5967.552433567413, 6103.694815259308, 6108.72510737009, 6144.41628045335, 5128.897152167593, 5342.11855043929, 6071.2714474263375, 6105.297890742621, 6111.786087486917, 5073.670211436245, 5969.313528944053, 6085.72199838039, 6303.716332765129, 6333.524985626004, 3548.0242933192544, 3875.6435247663094, 3973.741706789165, 4022.2960981827478, 4055.3916912463364, 5051.772670229775, 6149.292831324455, 6166.506679465721, 6192.566520343533, 6201.937980620317, 4994.4006719192475, 5522.447755224445, 5969.567498688185, 5976.701164941648, 5981.1327357532045, 5646.943530564806, 5876.706164691663, 5926.318473375444, 5938.495227905676, 5996.8800623988145, 5220.347456567929, 5509.421510741475, 5546.029444847216, 5855.531557475477, 5869.207656966255, 5772.336181339199, 5942.64344139353, 5951.404859514188, 6001.3698561652145, 6004.699765011645, 5050.722210278323, 5534.92069046532, 5731.484166424875, 5880.588358814842, 5887.735051922588], "value": 4210.398187306654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.6802175064722, 787.7479206653869, 789.0767801672043, 824.5877061469262, 855.5508358111992, 14213.005089643702, 15269.770953435693, 15935.203239838005, 15967.0, 16036.67926641468, 13066.0, 14442.422303107864, 14443.5666929992, 14466.710665786677, 14479.203643799587, 684.7329541478803, 754.2419868032647, 861.4788053227801, 870.4994628088858, 893.1068931068932, 876.7501262140291, 895.7447127568644, 902.5938327752505, 906.0939060939061, 907.4101833808045, 947.4220725357526, 955.7849483866144, 960.0735290444719, 960.6397600899662, 960.8366577681776, 855.5850412549909, 916.5554705967601, 956.9473678947655, 958.9280803939697, 962.5187406296886, 696.3906581740977, 696.7979286007103, 707.1302298173224, 707.3775077931439, 709.2340272505681, 15249.237538123049, 15489.922550387177, 15512.689746205013, 15652.060876347456, 15658.138802365866, 14888.181150036744, 15088.17015064171, 15100.773488397683, 15132.924335378253, 15157.545273641808, 10240.590376384936, 12090.274583524928, 12369.340591772812, 12623.116381853273, 12729.236245825281, 3848.1918797052654, 3860.1507668313207, 3877.9030524236837, 3999.960000399988, 4031.496062992126, 115030.0, 115537.4223128879, 115564.0, 121820.0, 130698.3465082678, 10696.197785166143, 10859.239853210358, 11093.889061109447, 11350.48922798476, 11480.96671299587, 21814.345569632937, 22161.556768864855, 22188.0, 22221.000054997563, 22267.665985010237, 7787.058338343484, 7792.649330780128, 8060.959695201486, 8082.83834323322, 8487.363447741443, 4511.548845115528, 4585.633149348044, 4595.655325850575, 4681.204195286809, 4702.988857395676, 3502.649735026528, 3638.7270954677974, 3640.3811352069683, 3649.379605467077, 3649.5255616770182, 682.7883356159606, 688.2635579929528, 688.6659969914588, 689.8240948558085, 708.9042979197845, 574.7097715653568, 619.8574327904607, 625.9811908499832, 647.3914520350855, 721.72935149319, 9216.723498295061, 9749.122578967927, 9789.51052447389, 9858.852117218248, 10036.297459177933, 575.5884542552012, 630.7540059376847, 649.1658219188321, 696.9094017777657, 711.5410560188649, 4511.368408422823, 4624.213883639789, 4779.4264688236935, 4792.329073929653, 4858.95141048585, 146851.0, 149161.0, 153517.0, 153567.2321638407, 157211.4278857197, 140304.0, 140534.29732851475, 142147.0, 142538.0, 145831.0, 117188.0, 119916.0, 119964.40017799856, 120230.0, 122353.7764622378, 8256.339492840678, 8856.202941735275, 9173.744248944686, 9245.953770231376, 9285.86071208946, 45495.77252113718, 59974.10038849334, 66309.66845165743, 66805.33194667991, 67408.32591674216, 91048.08951910396, 94796.0, 94934.52532737292, 95369.52315238657, 97802.5109874446, 11946.283223006647, 11964.401779910795, 12015.219010764273, 12052.698682533006, 12186.2078964867, 13322.69565434184, 13669.316534173451, 13704.657383565092, 13726.65683357924, 14224.71550568962, 12262.816057759319, 12490.87509124897, 12526.143628884302, 12604.991600672107, 12833.807492887427, 12560.497580096693, 12825.422855971317, 12827.743445131231, 12909.806352904527, 12945.223286602833, 10978.176636752436, 12217.328046957502, 12490.562830300896, 12688.6827829305, 12797.680057998625, 10660.946695266784, 10901.83647245276, 10949.945250273699, 11002.834957475485, 11011.834822477509, 10139.442330671884, 10669.8933010672, 10777.62278320255, 10849.891501084889, 10875.782484350428], "value": 7930.650579019841, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 107.0, 116.0, 117.0, 116.0, 115.0, 117.0, 116.0, 118.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 132.0, 158.0, 111.0, 125.0, 165.0, 142.0, 165.0, 91.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 213.0, 223.0, 203.0, 200.0, 197.0, 196.0, 198.0, 202.0, 197.0], "value": 203.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 84.0, 77.0, 146.0, 57.0, 59.0, 62.0, 65.0, 137.0, 67.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 123.0, 73.0, 74.0, 81.0, 118.0, 70.0, 72.0, 116.0], "value": 87.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 132.0, 136.0, 91.0, 92.0, 90.0, 93.0, 91.0, 92.0, 89.0], "value": 100.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 151.0, 106.0, 158.0, 146.0, 104.0, 150.0, 115.0, 132.0, 152.0], "value": 133.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 93.0, 104.0, 93.0, 92.0, 102.0, 137.0, 90.0, 98.0, 93.0], "value": 102.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 54.0, 52.0, 55.0, 85.0, 51.0, 55.0, 82.0, 85.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 69.0, 79.0, 76.0, 87.0, 79.0, 73.0, 69.0, 62.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 73.0, 84.0, 73.0, 104.0, 103.0, 105.0, 87.0, 91.0, 93.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 135.0, 150.0, 184.0, 152.0, 154.0, 146.0, 202.0, 149.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 175.0, 172.0, 215.0, 170.0, 182.0, 199.0, 181.0, 168.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 68.0, 67.0, 65.0, 68.0, 69.0, 78.0, 89.0, 87.0], "value": 72.7, "unit": "score"}]}]} 16:44:16 INFO - Return code: 0 16:44:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:44:16 ERROR - # TBPL SUCCESS # 16:44:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:44:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:44:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:44:16 INFO - 2016-07-18 16:44:16.956 screenresolution[1973:19665] starting screenresolution argv=screenresolution get 16:44:16 INFO - 2016-07-18 16:44:16.958 screenresolution[1973:19665] Display 0: 1600x1200x32@60 16:44:16 INFO - 2016-07-18 16:44:16.964 screenresolution[1974:19667] starting screenresolution argv=screenresolution list 16:44:16 INFO - Available Modes on Display 0 16:44:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:44:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:44:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:44:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:44:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:44:17 INFO - Intel Iris: 16:44:17 INFO - Chipset Model: Intel Iris 16:44:17 INFO - Type: GPU 16:44:17 INFO - Bus: Built-In 16:44:17 INFO - VRAM (Dynamic, Max): 1536 MB 16:44:17 INFO - Vendor: Intel (0x8086) 16:44:17 INFO - Device ID: 0x0a2e 16:44:17 INFO - Revision ID: 0x0009 16:44:17 INFO - Displays: 16:44:17 INFO - Display: 16:44:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:44:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:44:17 INFO - Display Serial Number: 1600x1200 60 16:44:17 INFO - Main Display: Yes 16:44:17 INFO - Mirror: Off 16:44:17 INFO - Online: Yes 16:44:17 INFO - Rotation: Supported 16:44:17 INFO - Return code: 0 16:44:17 INFO - Running post-action listener: _resource_record_post_action 16:44:17 INFO - ##### 16:44:17 INFO - ##### Finished run-tests step (success) 16:44:17 INFO - ##### 16:44:17 INFO - Running post-run listener: _resource_record_post_run 16:44:17 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 798720; Write bytes: 705059328; Read time: 12; Write time: 1853 16:44:17 INFO - TinderboxPrint: CPU usage
54.2% 16:44:17 INFO - TinderboxPrint: I/O read bytes / time
798,720 / 12 16:44:17 INFO - TinderboxPrint: I/O write bytes / time
705,059,328 / 1,853 16:44:17 INFO - TinderboxPrint: CPU idle
2,214.6 (45.8%) 16:44:17 INFO - TinderboxPrint: CPU system
980.9 (20.3%) 16:44:17 INFO - TinderboxPrint: CPU user
1,642.2 (33.9%) 16:44:17 INFO - TinderboxPrint: Swap in / out
408,772,608 / 0 16:44:17 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 408547840; Write bytes: 409802752; Read time: 30584; Write time: 733 16:44:17 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 757760; Write bytes: 293736960; Read time: 12; Write time: 1113 16:44:17 INFO - Running post-run listener: _upload_blobber_files 16:44:17 INFO - Blob upload gear active. 16:44:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:44:17 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 16:44:17 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'] 16:44:17 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 16:44:18 INFO - (blobuploader) - INFO - Open directory for files ... 16:44:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:44:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:44:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:18 INFO - (blobuploader) - INFO - Done attempting. 16:44:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:44:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:44:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:19 INFO - (blobuploader) - INFO - Done attempting. 16:44:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:44:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:44:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:22 INFO - (blobuploader) - INFO - Done attempting. 16:44:22 INFO - (blobuploader) - INFO - Iteration through files over. 16:44:22 INFO - Return code: 0 16:44:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:44:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:44:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d57b941a512c129d4d6ab785aa07b14194d77e761a8553a72bf8fa19f91fd206839ae3167a354f49b7725b4dd08c8cc01e2903bc90ab47a270aa2c8a6bf88cf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/791943d3159c44116e15287e67005f51ff8f3a3a856e9d73c7774383f5d6d590cc6cf7a2e8a528efea912212d64816c559c8b4171e5e72f4fbd7df4b3a53c14b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2e714940b531464c9806a2cdc22830df54427f997f5d11f54cf1016e826c43f6804fd8ceed6edd68b155747532ee14cc98c9ef8bf8a136b6057136207f3b5010"} 16:44:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:44:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:44:22 INFO - Contents: 16:44:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d57b941a512c129d4d6ab785aa07b14194d77e761a8553a72bf8fa19f91fd206839ae3167a354f49b7725b4dd08c8cc01e2903bc90ab47a270aa2c8a6bf88cf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/791943d3159c44116e15287e67005f51ff8f3a3a856e9d73c7774383f5d6d590cc6cf7a2e8a528efea912212d64816c559c8b4171e5e72f4fbd7df4b3a53c14b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2e714940b531464c9806a2cdc22830df54427f997f5d11f54cf1016e826c43f6804fd8ceed6edd68b155747532ee14cc98c9ef8bf8a136b6057136207f3b5010"} 16:44:22 INFO - Running post-run listener: copy_logs_to_upload_dir 16:44:22 INFO - Copying logs to upload dir... 16:44:22 INFO - mkdir: /builds/slave/test/build/upload/logs 16:44:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.453567 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-18 16:44:22.429877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 16:44:22.433058) ========= 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.luiF8eTzYF/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.exPsMsYmfK/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d57b941a512c129d4d6ab785aa07b14194d77e761a8553a72bf8fa19f91fd206839ae3167a354f49b7725b4dd08c8cc01e2903bc90ab47a270aa2c8a6bf88cf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/791943d3159c44116e15287e67005f51ff8f3a3a856e9d73c7774383f5d6d590cc6cf7a2e8a528efea912212d64816c559c8b4171e5e72f4fbd7df4b3a53c14b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2e714940b531464c9806a2cdc22830df54427f997f5d11f54cf1016e826c43f6804fd8ceed6edd68b155747532ee14cc98c9ef8bf8a136b6057136207f3b5010"} build_url:https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/IJTw0CZwQLCJoWq87LtWTg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d57b941a512c129d4d6ab785aa07b14194d77e761a8553a72bf8fa19f91fd206839ae3167a354f49b7725b4dd08c8cc01e2903bc90ab47a270aa2c8a6bf88cf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/791943d3159c44116e15287e67005f51ff8f3a3a856e9d73c7774383f5d6d590cc6cf7a2e8a528efea912212d64816c559c8b4171e5e72f4fbd7df4b3a53c14b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2e714940b531464c9806a2cdc22830df54427f997f5d11f54cf1016e826c43f6804fd8ceed6edd68b155747532ee14cc98c9ef8bf8a136b6057136207f3b5010"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 16:44:22.465482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 16:44:22.465766) ========= 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.luiF8eTzYF/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.exPsMsYmfK/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.004486 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 16:44:22.513402) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 16:44:22.513671) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 16:44:22.513947) ========= ========= Total master_lag: 0.17 =========