builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0010 starttime: 1460657992.69 results: success (0) buildid: 20160414090846 builduid: a6bf07eb8d504961b5b1edca2b493c82 revision: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 11:19:52.690971) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 11:19:52.691356) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 14 secs) (at 2016-04-14 11:19:52.691623) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 14 secs) (at 2016-04-14 11:20:07.455964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-14 11:20:07.456323) ========= 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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-04-14 11:20:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 36.0M=0s 2016-04-14 11:20:08 (36.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.365910 ========= master_lag: 2.00 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-14 11:20:09.820719) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-14 11:20:09.821015) ========= 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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.020622 ========= master_lag: 5.47 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-14 11:20:15.313149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 11:20:15.313547) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1bce3f1720e66a9cdc1a1699d3fd24a598641969 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1bce3f1720e66a9cdc1a1699d3fd24a598641969 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2JyMRI2OuV/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.i5QOkgFNXG/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-04-14 11:20:15,445 truncating revision to first 12 chars 2016-04-14 11:20:15,445 Setting DEBUG logging. 2016-04-14 11:20:15,445 attempt 1/10 2016-04-14 11:20:15,445 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1bce3f1720e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 11:20:16,708 unpacking tar archive at: fx-team-1bce3f1720e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.517927 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 11:20:16.972102) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 11:20:16.975417) ========= script_repo_revision: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 11:20:16.975789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 11:20:16.976045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 11:20:16.995812) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-14 11:20:16.996074) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2JyMRI2OuV/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.i5QOkgFNXG/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 11:20:17 INFO - MultiFileLogger online at 20160414 11:20:17 in /builds/slave/test 11:20:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:20:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:17 INFO - {'append_to_log': False, 11:20:17 INFO - 'base_work_dir': '/builds/slave/test', 11:20:17 INFO - 'blob_upload_branch': 'Fx-Team', 11:20:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:17 INFO - 'branch': 'Fx-Team', 11:20:17 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:17 INFO - 'config_files': ('talos/mac_config.py',), 11:20:17 INFO - 'default_actions': ('clobber', 11:20:17 INFO - 'read-buildbot-config', 11:20:17 INFO - 'download-and-extract', 11:20:17 INFO - 'populate-webroot', 11:20:17 INFO - 'create-virtualenv', 11:20:17 INFO - 'install', 11:20:17 INFO - 'run-tests'), 11:20:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:17 INFO - 'download_minidump_stackwalk': True, 11:20:17 INFO - 'download_symbols': 'ondemand', 11:20:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:17 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:17 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:17 INFO - 'installer_path': 'installer.exe', 11:20:17 INFO - 'log_level': 'info', 11:20:17 INFO - 'log_name': 'talos', 11:20:17 INFO - 'log_to_console': True, 11:20:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:20:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:20:17 INFO - 'opt_config_files': (), 11:20:17 INFO - 'pip_index': False, 11:20:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:20:17 INFO - 'cmd': ('bash', 11:20:17 INFO - '-c', 11:20:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:20:17 INFO - 'enabled': True, 11:20:17 INFO - 'halt_on_failure': False, 11:20:17 INFO - 'name': 'check_screen_resolution'},), 11:20:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:20:17 INFO - 'cmd': ('bash', 11:20:17 INFO - '-c', 11:20:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:20:17 INFO - 'enabled': True, 11:20:17 INFO - 'halt_on_failure': False, 11:20:17 INFO - 'name': 'check_screen_resolution'},), 11:20:17 INFO - 'run_cmd_checks_enabled': True, 11:20:17 INFO - 'sps_profile': False, 11:20:17 INFO - 'sps_profile_interval': 0, 11:20:17 INFO - 'suite': 'dromaeojs-e10s', 11:20:17 INFO - 'system_bits': '32', 11:20:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:17 INFO - 'title': 't-yosemite-r7-0010', 11:20:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:17 INFO - 'use_talos_json': True, 11:20:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:17 INFO - 'work_dir': 'build'} 11:20:17 INFO - ##### 11:20:17 INFO - ##### Running clobber step. 11:20:17 INFO - ##### 11:20:17 INFO - Running pre-action listener: _resource_record_pre_action 11:20:17 INFO - Running main action method: clobber 11:20:17 INFO - rmtree: /builds/slave/test/build 11:20:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:17 INFO - Running post-action listener: _resource_record_post_action 11:20:17 INFO - ##### 11:20:17 INFO - ##### Running read-buildbot-config step. 11:20:17 INFO - ##### 11:20:17 INFO - Running pre-action listener: _resource_record_pre_action 11:20:17 INFO - Running main action method: read_buildbot_config 11:20:17 INFO - Using buildbot properties: 11:20:17 INFO - { 11:20:17 INFO - "project": "", 11:20:17 INFO - "product": "firefox", 11:20:17 INFO - "script_repo_revision": "production", 11:20:17 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:20:17 INFO - "repository": "", 11:20:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:20:17 INFO - "buildid": "20160414090846", 11:20:17 INFO - "pgo_build": "False", 11:20:17 INFO - "basedir": "/builds/slave/test", 11:20:17 INFO - "buildnumber": 688, 11:20:17 INFO - "slavename": "t-yosemite-r7-0010", 11:20:17 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:20:17 INFO - "platform": "yosemite_r7", 11:20:17 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:20:17 INFO - "branch": "fx-team", 11:20:17 INFO - "repo_path": "integration/fx-team", 11:20:17 INFO - "revision": "1bce3f1720e66a9cdc1a1699d3fd24a598641969", 11:20:17 INFO - "stage_platform": "macosx64", 11:20:17 INFO - "builduid": "a6bf07eb8d504961b5b1edca2b493c82", 11:20:17 INFO - "slavebuilddir": "test" 11:20:17 INFO - } 11:20:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 11:20:17 INFO - Running post-action listener: _resource_record_post_action 11:20:17 INFO - ##### 11:20:17 INFO - ##### Running download-and-extract step. 11:20:17 INFO - ##### 11:20:17 INFO - Running pre-action listener: _resource_record_pre_action 11:20:17 INFO - Running main action method: download_and_extract 11:20:17 INFO - mkdir: /builds/slave/test/build/tests 11:20:17 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')]} 11:20:17 INFO - https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:20:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:20:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:20:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 11:20:18 INFO - Downloaded 1199 bytes. 11:20:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:20:18 INFO - Using the following test package requirements: 11:20:18 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:20:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:20:18 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 11:20:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:20:18 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 11:20:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:20:18 INFO - u'jsshell-mac.zip'], 11:20:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:20:18 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 11:20:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:20:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:20:18 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 11:20:18 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:20:18 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 11:20:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:20:18 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 11:20:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:20:18 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 11:20:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:20:18 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')]} 11:20:18 INFO - https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:20:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:20:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:20:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:20:19 INFO - Downloaded 18031180 bytes. 11:20:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:20:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:20:22 INFO - Return code: 0 11:20:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:20: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')]} 11:20:22 INFO - https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:20:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:20:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:20:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:20:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:20:23 INFO - Downloaded 18031180 bytes. 11:20:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:20:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:20:26 INFO - Return code: 0 11:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:26 INFO - https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:20:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:20:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:20:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:20:27 INFO - Downloaded 10841076 bytes. 11:20:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:20:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:20:28 INFO - Return code: 0 11:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:28 INFO - https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:20:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:20:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:20:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 11:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 11:20:31 INFO - Downloaded 109836388 bytes. 11:20:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:20:31 INFO - mkdir: /builds/slave/test/properties 11:20:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:31 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:31 INFO - Contents: 11:20:31 INFO - build_url:https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:20:32 INFO - Running post-action listener: _resource_record_post_action 11:20:32 INFO - Running post-action listener: set_extra_try_arguments 11:20:32 INFO - ##### 11:20:32 INFO - ##### Running populate-webroot step. 11:20:32 INFO - ##### 11:20:32 INFO - Running pre-action listener: _resource_record_pre_action 11:20:32 INFO - Running main action method: populate_webroot 11:20:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:20:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:20:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:20:32 INFO - '--tppagecycles', 11:20:32 INFO - '7'], 11:20:32 INFO - 'tests': ['tsvgm']}}, 11:20:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:20:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:20:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:32 INFO - 'talos_options': ['--disable-e10s'], 11:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:32 INFO - 'talos_options': ['--disable-e10s'], 11:20:32 INFO - 'tests': ['damp', 'tps']}, 11:20:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:32 INFO - 'tests': ['damp', 'tps']}, 11:20:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:20:32 INFO - 'tests': ['dromaeo_dom']}, 11:20:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:20:32 INFO - 'tests': ['a11yr', 11:20:32 INFO - 'ts_paint', 11:20:32 INFO - 'tpaint', 11:20:32 INFO - 'sessionrestore', 11:20:32 INFO - 'sessionrestore_no_auto_restore', 11:20:32 INFO - 'tabpaint']}, 11:20:32 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:32 INFO - 'ts_paint', 11:20:32 INFO - 'tpaint', 11:20:32 INFO - 'sessionrestore', 11:20:32 INFO - 'sessionrestore_no_auto_restore', 11:20:32 INFO - 'tabpaint']}, 11:20:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:20:32 INFO - 'ts_paint', 11:20:32 INFO - 'tpaint', 11:20:32 INFO - 'sessionrestore', 11:20:32 INFO - 'sessionrestore_no_auto_restore', 11:20:32 INFO - 'tabpaint']}, 11:20:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:20:32 INFO - 'ts_paint', 11:20:32 INFO - 'tpaint', 11:20:32 INFO - 'sessionrestore', 11:20:32 INFO - 'sessionrestore_no_auto_restore', 11:20:32 INFO - 'tabpaint']}, 11:20:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:20:32 INFO - 'tests': ['a11yr', 11:20:32 INFO - 'ts_paint', 11:20:32 INFO - 'tpaint', 11:20:32 INFO - 'sessionrestore', 11:20:32 INFO - 'sessionrestore_no_auto_restore', 11:20:32 INFO - 'tabpaint']}, 11:20:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:20:32 INFO - 'tests': ['a11yr', 11:20:32 INFO - 'ts_paint', 11:20:32 INFO - 'tpaint', 11:20:32 INFO - 'sessionrestore', 11:20:32 INFO - 'sessionrestore_no_auto_restore', 11:20:32 INFO - 'tabpaint']}, 11:20:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:20:32 INFO - 'tests': ['tsvgx', 11:20:32 INFO - 'tsvgr_opacity', 11:20:32 INFO - 'tart', 11:20:32 INFO - 'tscrollx', 11:20:32 INFO - 'cart']}, 11:20:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:32 INFO - 'tsvgr_opacity', 11:20:32 INFO - 'tart', 11:20:32 INFO - 'tscrollx', 11:20:32 INFO - 'cart']}, 11:20:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:32 INFO - 'talos_options': ['--disable-e10s'], 11:20:32 INFO - 'tests': ['tp5o']}, 11:20:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:32 INFO - 'tests': ['tp5o']}, 11:20:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:32 INFO - 'talos_options': ['--disable-e10s', 11:20:32 INFO - '--xperf_path', 11:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:32 INFO - 'tests': ['tp5n']}, 11:20:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:32 INFO - 'talos_options': ['--xperf_path', 11:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:32 INFO - 'tests': ['tp5n']}}, 11:20:32 INFO - 'talos.zip': {'path': '', 11:20:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:20:32 INFO - Running post-action listener: _resource_record_post_action 11:20:32 INFO - ##### 11:20:32 INFO - ##### Running create-virtualenv step. 11:20:32 INFO - ##### 11:20:32 INFO - Running pre-action listener: _resource_record_pre_action 11:20:32 INFO - Running main action method: create_virtualenv 11:20:32 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:32 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 11:20:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:32 INFO - Using real prefix '/tools/python27' 11:20:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:36 INFO - Installing pip.................done. 11:20:36 INFO - Return code: 0 11:20:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:36 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 0x10bd94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bda4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe161c736f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc33e00>, '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 0x10ba9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc2eb20>, '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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 11:20:36 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 11:20:36 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 11:20:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JyMRI2OuV/Render', 11:20:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:20:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:20:36 INFO - 'HOME': '/Users/cltbld', 11:20:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:20:36 INFO - 'LOGNAME': 'cltbld', 11:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:36 INFO - 'MOZ_NO_REMOTE': '1', 11:20:36 INFO - 'NO_EM_RESTART': '1', 11:20:36 INFO - 'PAGER': '/bin/cat', 11:20:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:36 INFO - 'PWD': '/builds/slave/test', 11:20:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:20:36 INFO - 'SHELL': '/bin/bash', 11:20:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5QOkgFNXG/Listeners', 11:20:36 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 11:20:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:20:36 INFO - 'USER': 'cltbld', 11:20:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:20:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:36 INFO - 'XPC_FLAGS': '0x0', 11:20:36 INFO - 'XPC_SERVICE_NAME': '0', 11:20:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:36 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 11:20:36 INFO - Cleaning up... 11:20:36 INFO - Return code: 0 11:20:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:36 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bda4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe161c736f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc33e00>, '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 0x10ba9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc2eb20>, '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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 11:20:36 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>=0.7.1'] in /builds/slave/test/build 11:20:36 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>=0.7.1 11:20:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JyMRI2OuV/Render', 11:20:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:20:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:20:36 INFO - 'HOME': '/Users/cltbld', 11:20:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:20:36 INFO - 'LOGNAME': 'cltbld', 11:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:36 INFO - 'MOZ_NO_REMOTE': '1', 11:20:36 INFO - 'NO_EM_RESTART': '1', 11:20:36 INFO - 'PAGER': '/bin/cat', 11:20:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:36 INFO - 'PWD': '/builds/slave/test', 11:20:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:20:36 INFO - 'SHELL': '/bin/bash', 11:20:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5QOkgFNXG/Listeners', 11:20:36 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 11:20:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:20:36 INFO - 'USER': 'cltbld', 11:20:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:20:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:36 INFO - 'XPC_FLAGS': '0x0', 11:20:36 INFO - 'XPC_SERVICE_NAME': '0', 11:20:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:36 INFO - Downloading/unpacking psutil>=0.7.1 11:20:36 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 11:20:36 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 11:20:36 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 11:20:36 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 11:20:36 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 11:20:36 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 11:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:39 INFO - Installing collected packages: psutil 11:20:39 INFO - Running setup.py install for psutil 11:20:39 INFO - building 'psutil._psutil_osx' extension 11:20:39 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 11:20:40 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 11:20:40 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 11:20:40 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 11:20:40 INFO - building 'psutil._psutil_posix' extension 11:20:40 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 11:20:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:20:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:20:40 INFO - ^ 11:20:40 INFO - 1 warning generated. 11:20:40 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 11:20:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:40 INFO - Successfully installed psutil 11:20:40 INFO - Cleaning up... 11:20:40 INFO - Return code: 0 11:20:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20: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')]} 11:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bda4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe161c736f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc33e00>, '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 0x10ba9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc2eb20>, '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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 11:20: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:20: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 mozsystemmonitor==0.0.0 11:20:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JyMRI2OuV/Render', 11:20:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:20:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:20:41 INFO - 'HOME': '/Users/cltbld', 11:20:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:20:41 INFO - 'LOGNAME': 'cltbld', 11:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:41 INFO - 'MOZ_NO_REMOTE': '1', 11:20:41 INFO - 'NO_EM_RESTART': '1', 11:20:41 INFO - 'PAGER': '/bin/cat', 11:20:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:41 INFO - 'PWD': '/builds/slave/test', 11:20:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:20:41 INFO - 'SHELL': '/bin/bash', 11:20:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5QOkgFNXG/Listeners', 11:20:41 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 11:20:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:20:41 INFO - 'USER': 'cltbld', 11:20:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:20:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:41 INFO - 'XPC_FLAGS': '0x0', 11:20:41 INFO - 'XPC_SERVICE_NAME': '0', 11:20:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:20:43 INFO - Installing collected packages: mozsystemmonitor 11:20:43 INFO - Running setup.py install for mozsystemmonitor 11:20:43 INFO - Successfully installed mozsystemmonitor 11:20:43 INFO - Cleaning up... 11:20:43 INFO - Return code: 0 11:20:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:43 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 0x10bd94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bda4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe161c736f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc33e00>, '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 0x10ba9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc2eb20>, '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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 11:20:43 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 11:20:43 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 11:20:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JyMRI2OuV/Render', 11:20:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:20:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:20:43 INFO - 'HOME': '/Users/cltbld', 11:20:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:20:43 INFO - 'LOGNAME': 'cltbld', 11:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:43 INFO - 'MOZ_NO_REMOTE': '1', 11:20:43 INFO - 'NO_EM_RESTART': '1', 11:20:43 INFO - 'PAGER': '/bin/cat', 11:20:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:43 INFO - 'PWD': '/builds/slave/test', 11:20:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:20:43 INFO - 'SHELL': '/bin/bash', 11:20:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5QOkgFNXG/Listeners', 11:20:43 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 11:20:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:20:43 INFO - 'USER': 'cltbld', 11:20:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:20:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:43 INFO - 'XPC_FLAGS': '0x0', 11:20:43 INFO - 'XPC_SERVICE_NAME': '0', 11:20:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:44 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:46 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:47 INFO - Downloading docopt-0.6.1.tar.gz 11:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:47 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:47 INFO - Running setup.py install for blobuploader 11:20:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:48 INFO - Running setup.py install for requests 11:20:48 INFO - Running setup.py install for docopt 11:20:48 INFO - Successfully installed blobuploader requests docopt 11:20:48 INFO - Cleaning up... 11:20:48 INFO - Return code: 0 11:20:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20: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')]} 11:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:48 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 0x10bd94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bda4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe161c736f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc33e00>, '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 0x10ba9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc2eb20>, '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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 11:20:48 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 11:20:48 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 11:20:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JyMRI2OuV/Render', 11:20:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:20:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:20:48 INFO - 'HOME': '/Users/cltbld', 11:20:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:20:48 INFO - 'LOGNAME': 'cltbld', 11:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:48 INFO - 'MOZ_NO_REMOTE': '1', 11:20:48 INFO - 'NO_EM_RESTART': '1', 11:20:48 INFO - 'PAGER': '/bin/cat', 11:20:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:48 INFO - 'PWD': '/builds/slave/test', 11:20:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:20:48 INFO - 'SHELL': '/bin/bash', 11:20:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5QOkgFNXG/Listeners', 11:20:48 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 11:20:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:20:48 INFO - 'USER': 'cltbld', 11:20:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:20:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:48 INFO - 'XPC_FLAGS': '0x0', 11:20:48 INFO - 'XPC_SERVICE_NAME': '0', 11:20:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:49 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-4YOqBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:49 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-k3fD44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:49 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-uCoLKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:49 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-kNRs3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:49 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-FIyzr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:49 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-pDrkbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:49 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-jokYtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:49 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-E19aZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:49 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-D76T0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:49 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-EOpmJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:50 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-gU_izz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:50 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-RECCUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:50 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-V6T37a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:50 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-e1Du54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:50 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-E528KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:50 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-XdUrjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:50 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-hSF6Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:20:50 INFO - Running setup.py install for manifestparser 11:20:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:20:50 INFO - Running setup.py install for mozcrash 11:20:51 INFO - Running setup.py install for mozdebug 11:20:51 INFO - Running setup.py install for mozdevice 11:20:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:20:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:20:51 INFO - Running setup.py install for mozfile 11:20:51 INFO - Running setup.py install for mozhttpd 11:20:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:20:51 INFO - Running setup.py install for mozinfo 11:20:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:20:51 INFO - Running setup.py install for mozInstall 11:20:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:20:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:20:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:20:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:20:51 INFO - Running setup.py install for mozleak 11:20:52 INFO - Running setup.py install for mozlog 11:20:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:20:52 INFO - Running setup.py install for moznetwork 11:20:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:20:52 INFO - Running setup.py install for mozprocess 11:20:52 INFO - Running setup.py install for mozprofile 11:20:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:20:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:20:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:20:52 INFO - Running setup.py install for mozrunner 11:20:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:20:52 INFO - Running setup.py install for mozscreenshot 11:20:53 INFO - Running setup.py install for moztest 11:20:53 INFO - Running setup.py install for mozversion 11:20:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:20:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:20:53 INFO - Cleaning up... 11:20:53 INFO - Return code: 0 11:20:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:53 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 0x10bd94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bda4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe161c736f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc33e00>, '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 0x10ba9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc2eb20>, '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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 11:20:53 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 11:20:53 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 11:20:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JyMRI2OuV/Render', 11:20:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:20:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:20:53 INFO - 'HOME': '/Users/cltbld', 11:20:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:20:53 INFO - 'LOGNAME': 'cltbld', 11:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:53 INFO - 'MOZ_NO_REMOTE': '1', 11:20:53 INFO - 'NO_EM_RESTART': '1', 11:20:53 INFO - 'PAGER': '/bin/cat', 11:20:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:53 INFO - 'PWD': '/builds/slave/test', 11:20:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:20:53 INFO - 'SHELL': '/bin/bash', 11:20:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5QOkgFNXG/Listeners', 11:20:53 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 11:20:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:20:53 INFO - 'USER': 'cltbld', 11:20:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:20:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:53 INFO - 'XPC_FLAGS': '0x0', 11:20:53 INFO - 'XPC_SERVICE_NAME': '0', 11:20:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:53 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-UO5Fhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:53 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)) 11:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:53 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-hE6UhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:53 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)) 11:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:53 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-tQ206g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:53 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)) 11:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:53 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ZbJp_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:54 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)) 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:54 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-9KRU6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:54 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)) 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:54 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-VlvI_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:54 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)) 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:54 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-uKLPyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:54 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)) 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:54 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-X3fg0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:54 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)) 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:54 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Jd0XLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:54 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)) 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:54 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-2x5GEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:54 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-dSYudy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:54 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)) 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:54 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Z1h08T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:54 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-EEU31A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:55 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)) 11:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:55 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-F1MR55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:55 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-s5TVdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:55 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)) 11:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:55 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-WVz8uW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:55 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)) 11:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:55 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-xPJRhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:55 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)) 11:20:55 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)) 11:20:55 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)) 11:20:55 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)) 11:20:55 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)) 11:20:55 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)) 11:20:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20:57 INFO - Downloading blessings-1.6.tar.gz 11:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:20:57 INFO - Installing collected packages: blessings 11:20:57 INFO - Running setup.py install for blessings 11:20:58 INFO - Successfully installed blessings 11:20:58 INFO - Cleaning up... 11:20:58 INFO - Return code: 0 11:20:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:58 INFO - Reading from file tmpfile_stdout 11:20:58 INFO - Current package versions: 11:20:58 INFO - blessings == 1.6 11:20:58 INFO - blobuploader == 1.2.4 11:20:58 INFO - docopt == 0.6.1 11:20:58 INFO - manifestparser == 1.1 11:20:58 INFO - mozInstall == 1.12 11:20:58 INFO - mozcrash == 0.17 11:20:58 INFO - mozdebug == 0.1 11:20:58 INFO - mozdevice == 0.48 11:20:58 INFO - mozfile == 1.2 11:20:58 INFO - mozhttpd == 0.7 11:20:58 INFO - mozinfo == 0.9 11:20:58 INFO - mozleak == 0.1 11:20:58 INFO - mozlog == 3.1 11:20:58 INFO - moznetwork == 0.27 11:20:58 INFO - mozprocess == 0.22 11:20:58 INFO - mozprofile == 0.28 11:20:58 INFO - mozrunner == 6.11 11:20:58 INFO - mozscreenshot == 0.1 11:20:58 INFO - mozsystemmonitor == 0.0 11:20:58 INFO - moztest == 0.7 11:20:58 INFO - mozversion == 1.4 11:20:58 INFO - psutil == 3.1.1 11:20:58 INFO - requests == 1.2.3 11:20:58 INFO - wsgiref == 0.1.2 11:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:58 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 0x10bd94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bda4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe161c736f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc33e00>, '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 0x10ba9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc2eb20>, '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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 11:20:58 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 11:20:58 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 11:20:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JyMRI2OuV/Render', 11:20:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:20:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:20:58 INFO - 'HOME': '/Users/cltbld', 11:20:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:20:58 INFO - 'LOGNAME': 'cltbld', 11:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:58 INFO - 'MOZ_NO_REMOTE': '1', 11:20:58 INFO - 'NO_EM_RESTART': '1', 11:20:58 INFO - 'PAGER': '/bin/cat', 11:20:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:58 INFO - 'PWD': '/builds/slave/test', 11:20:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:20:58 INFO - 'SHELL': '/bin/bash', 11:20:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5QOkgFNXG/Listeners', 11:20:58 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 11:20:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:20:58 INFO - 'USER': 'cltbld', 11:20:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:20:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:58 INFO - 'XPC_FLAGS': '0x0', 11:20:58 INFO - 'XPC_SERVICE_NAME': '0', 11:20:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:58 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)) 11:20:58 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)) 11:20:58 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)) 11:20:58 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)) 11:20:58 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)) 11:20:58 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)) 11:20:58 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)) 11:20:58 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)) 11:20:58 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)) 11:20:58 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)) 11:20:58 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)) 11:20:58 INFO - Cleaning up... 11:20:58 INFO - Return code: 0 11:20:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bda4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe161c736f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc33e00>, '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 0x10ba9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc2eb20>, '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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 11:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:20:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JyMRI2OuV/Render', 11:20:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:20:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:20:58 INFO - 'HOME': '/Users/cltbld', 11:20:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:20:58 INFO - 'LOGNAME': 'cltbld', 11:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:58 INFO - 'MOZ_NO_REMOTE': '1', 11:20:58 INFO - 'NO_EM_RESTART': '1', 11:20:58 INFO - 'PAGER': '/bin/cat', 11:20:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:58 INFO - 'PWD': '/builds/slave/test', 11:20:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:20:58 INFO - 'SHELL': '/bin/bash', 11:20:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5QOkgFNXG/Listeners', 11:20:58 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 11:20:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:20:58 INFO - 'USER': 'cltbld', 11:20:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:20:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:58 INFO - 'XPC_FLAGS': '0x0', 11:20:58 INFO - 'XPC_SERVICE_NAME': '0', 11:20:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:59 INFO - Downloading/unpacking jsonschema 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:01 INFO - Downloading/unpacking functools32 (from jsonschema) 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:01 INFO - warning: no files found matching '*.txt' 11:21:01 INFO - no previously-included directories found matching 'build' 11:21:01 INFO - no previously-included directories found matching 'dist' 11:21:01 INFO - no previously-included directories found matching '.git*' 11:21:01 INFO - Installing collected packages: jsonschema, functools32 11:21:02 INFO - Running setup.py install for functools32 11:21:02 INFO - warning: no files found matching '*.txt' 11:21:02 INFO - no previously-included directories found matching 'build' 11:21:02 INFO - no previously-included directories found matching 'dist' 11:21:02 INFO - no previously-included directories found matching '.git*' 11:21:02 INFO - Successfully installed jsonschema functools32 11:21:02 INFO - Cleaning up... 11:21:02 INFO - Return code: 0 11:21:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:21:02 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')]} 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:02 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')]} 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:02 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bda4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe161c736f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc33e00>, '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 0x10ba9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc2eb20>, '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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 11:21:02 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', 'flake8'] in /builds/slave/test/build 11:21:02 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 flake8 11:21:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JyMRI2OuV/Render', 11:21:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:02 INFO - 'HOME': '/Users/cltbld', 11:21:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:02 INFO - 'LOGNAME': 'cltbld', 11:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:02 INFO - 'MOZ_NO_REMOTE': '1', 11:21:02 INFO - 'NO_EM_RESTART': '1', 11:21:02 INFO - 'PAGER': '/bin/cat', 11:21:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:02 INFO - 'PWD': '/builds/slave/test', 11:21:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:02 INFO - 'SHELL': '/bin/bash', 11:21:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5QOkgFNXG/Listeners', 11:21:02 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 11:21:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:02 INFO - 'USER': 'cltbld', 11:21:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:02 INFO - 'XPC_FLAGS': '0x0', 11:21:02 INFO - 'XPC_SERVICE_NAME': '0', 11:21:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:02 INFO - Downloading/unpacking flake8 11:21:02 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 11:21:02 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 11:21:02 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 11:21:02 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 11:21:02 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 11:21:02 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 11:21:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:21:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:21:04 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 11:21:04 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 11:21:04 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 11:21:04 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 11:21:04 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 11:21:05 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 11:21:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:21:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:21:05 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 11:21:05 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 11:21:05 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 11:21:05 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 11:21:05 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 11:21:05 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 11:21:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:21:05 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 11:21:05 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 11:21:05 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 11:21:05 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 11:21:05 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 11:21:05 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 11:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:21:06 INFO - no previously-included directories found matching 'docs/_build' 11:21:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:21:06 INFO - Running setup.py install for pep8 11:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:21:06 INFO - no previously-included directories found matching 'docs/_build' 11:21:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:21:06 INFO - Cleaning up... 11:21:06 INFO - Return code: 0 11:21:06 INFO - Running post-action listener: _resource_record_post_action 11:21:06 INFO - Running post-action listener: _start_resource_monitoring 11:21:06 INFO - Starting resource monitoring. 11:21:06 INFO - ##### 11:21:06 INFO - ##### Running install step. 11:21:06 INFO - ##### 11:21:06 INFO - Running pre-action listener: _resource_record_pre_action 11:21:06 INFO - Running main action method: install 11:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:06 INFO - Reading from file tmpfile_stdout 11:21:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:07 INFO - Reading from file tmpfile_stdout 11:21:07 INFO - Output received: 11:21:07 INFO - Usage: mozinstall [options] installer 11:21:07 INFO - Options: 11:21:07 INFO - -h, --help show this help message and exit 11:21:07 INFO - -d DEST, --destination=DEST 11:21:07 INFO - Directory to install application into. [default: 11:21:07 INFO - "/builds/slave/test"] 11:21:07 INFO - --app=APP Application being installed. [default: firefox] 11:21:07 INFO - mkdir: /builds/slave/test/build/application 11:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:21:40 INFO - Reading from file tmpfile_stdout 11:21:40 INFO - Output received: 11:21:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:21:40 INFO - Running post-action listener: _resource_record_post_action 11:21:40 INFO - ##### 11:21:40 INFO - ##### Running run-tests step. 11:21:40 INFO - ##### 11:21:40 INFO - Running pre-action listener: _resource_record_pre_action 11:21:40 INFO - Running main action method: run_tests 11:21:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:21:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:21:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:21:40 INFO - 2016-04-14 11:21:40.671 screenresolution[2357:31970] starting screenresolution argv=screenresolution get 11:21:40 INFO - 2016-04-14 11:21:40.674 screenresolution[2357:31970] Display 0: 1600x1200x32@60 11:21:40 INFO - 2016-04-14 11:21:40.680 screenresolution[2358:31973] starting screenresolution argv=screenresolution list 11:21:40 INFO - Available Modes on Display 0 11:21:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:21:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:21:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:21:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:21:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:21:40 INFO - Intel Iris: 11:21:40 INFO - Chipset Model: Intel Iris 11:21:40 INFO - Type: GPU 11:21:40 INFO - Bus: Built-In 11:21:40 INFO - VRAM (Dynamic, Max): 1536 MB 11:21:40 INFO - Vendor: Intel (0x8086) 11:21:40 INFO - Device ID: 0x0a2e 11:21:40 INFO - Revision ID: 0x0009 11:21:40 INFO - Displays: 11:21:40 INFO - Display: 11:21:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:21:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:21:40 INFO - Display Serial Number: 1600x1200 60 11:21:40 INFO - Main Display: Yes 11:21:40 INFO - Mirror: Off 11:21:40 INFO - Online: Yes 11:21:40 INFO - Rotation: Supported 11:21:40 INFO - Return code: 0 11:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:40 INFO - Python 2.7.3 11:21:40 INFO - Return code: 0 11:21:40 INFO - grabbing minidump binary from tooltool 11:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:40 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc33e00>, '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 0x10ba9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc2eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:40 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 11:21:40 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 11:21:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:40 INFO - Return code: 0 11:21:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:21:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:21:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:21:42 INFO - Return code: 0 11:21:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 11:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0010 --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 11:21:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JyMRI2OuV/Render', 11:21:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:21:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:21:42 INFO - 'HOME': '/Users/cltbld', 11:21:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:21:42 INFO - 'LOGNAME': 'cltbld', 11:21:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:42 INFO - 'MOZ_NO_REMOTE': '1', 11:21:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:42 INFO - 'NO_EM_RESTART': '1', 11:21:42 INFO - 'PAGER': '/bin/cat', 11:21:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:42 INFO - 'PWD': '/builds/slave/test', 11:21:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:21:42 INFO - 'SHELL': '/bin/bash', 11:21:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5QOkgFNXG/Listeners', 11:21:42 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 11:21:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:21:42 INFO - 'USER': 'cltbld', 11:21:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:21:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:42 INFO - 'XPC_FLAGS': '0x0', 11:21:42 INFO - 'XPC_SERVICE_NAME': '0', 11:21:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:21:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 11:21:42 INFO - mozversion application_buildid: 20160414090846 11:21:42 INFO - mozversion application_changeset: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 11:21:42 INFO - mozversion application_display_name: Nightly 11:21:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:42 INFO - mozversion application_name: Firefox 11:21:42 INFO - mozversion application_remotingname: firefox 11:21:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:21:42 INFO - mozversion application_vendor: Mozilla 11:21:42 INFO - mozversion application_version: 48.0a1 11:21:42 INFO - mozversion platform_buildid: 20160414090846 11:21:42 INFO - mozversion platform_changeset: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 11:21:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:21:42 INFO - mozversion platform_version: 48.0a1 11:21:42 INFO - using testdate: 1460658102 11:21:42 INFO - actual date: 1460658102 11:21:42 INFO - starting webserver on 'localhost:52757' 11:21:42 INFO - SUITE-START | Running 2 tests 11:21:42 INFO - TEST-START | dromaeo_css 11:21:42 INFO - operating with platform_type : mac_ 11:21:42 INFO - Initialising browser for dromaeo_css test... 11:21:42 INFO - TEST-INFO | started process 2376 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpFoqvUO/profile http://localhost:52757/getInfo.html) 11:21:44 INFO - PROCESS | 2376 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 11:21:45 INFO - PROCESS | 2376 | __metrics Screen width/height:1600/1200 11:21:45 INFO - PROCESS | 2376 | colorDepth:24 11:21:45 INFO - PROCESS | 2376 | Browser inner width/height: 1024/689 11:21:45 INFO - PROCESS | 2376 | __metrics 11:21:45 ERROR - PROCESS | 2376 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:21:45 INFO - TEST-INFO | 2376: exit 0 11:21:45 INFO - Browser initialized. 11:21:45 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:45 INFO - TEST-INFO | started process 2379 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpFoqvUO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:57 INFO - PROCESS | 2379 | RSS: Main: 247848960 11:21:57 INFO - PROCESS | 2379 | 11:22:47 INFO - PROCESS | 2379 | 1460658167396 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] 11:24:58 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:52757/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52757/tests/dromaeo/cssquery-ext.html) 11:24:59 INFO - PROCESS | 2379 | RSS: Main: 260075520 11:24:59 INFO - PROCESS | 2379 | 11:28:02 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:52757/tests/dromaeo/cssquery-ext.html (next: http://localhost:52757/tests/dromaeo/cssquery-jquery.html) 11:28:02 INFO - PROCESS | 2379 | RSS: Main: 271908864 11:28:02 INFO - PROCESS | 2379 | 11:31:04 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:52757/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52757/tests/dromaeo/cssquery-mootools.html) 11:31:05 INFO - PROCESS | 2379 | RSS: Main: 273453056 11:31:05 INFO - PROCESS | 2379 | 11:34:06 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:52757/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52757/tests/dromaeo/cssquery-prototype.html) 11:34:07 INFO - PROCESS | 2379 | RSS: Main: 275128320 11:34:07 INFO - PROCESS | 2379 | 11:37:10 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:52757/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52757/tests/dromaeo/cssquery-yui.html) 11:37:10 INFO - PROCESS | 2379 | RSS: Main: 278159360 11:37:10 INFO - PROCESS | 2379 | 11:40:13 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:52757/tests/dromaeo/cssquery-yui.html (next: http://localhost:52757/tests/dromaeo/cssquery-dojo.html) 11:40:13 INFO - PROCESS | 2379 | RSS: Main: 279449600 11:40:13 INFO - PROCESS | 2379 | 11:40:13 INFO - PROCESS | 2379 | __start_tp_report 11:40:13 INFO - PROCESS | 2379 | _x_x_mozilla_page_load 11:40:13 INFO - PROCESS | 2379 | _x_x_mozilla_page_load_details 11:40:13 INFO - PROCESS | 2379 | |i|pagename|runs| 11:40:13 INFO - PROCESS | 2379 | |0;dojo.html;3435.8453869575874;3437.3297207044625;3460.619331873495;3477.1307173206696;3528.9294214115703;5710.71446427678;5725.6278341907855;5754.65472071676;5769.509591684707;5828.358880523145;4699.107169637767;5603.663780173182;5705.48650621444;5705.971470142654;5813.186153938452;5114.948850511503;5170.586353091753;5230.947690523084;5253.527182553588;5315.0698627740185;5288.68267903927;5295.523402893738;5299.54953828925;5305.1776974569;5320.414754377015;5183.067047931371;5185.403678576974;5208.401033881114;5240.109181439165;5249.107651699202;5168.793248270064;5233.659812112201;5252.842414727565;5266;5282.3925248596515;5200.3759548854005;5220.947790522084;5221.530062294374;5250;5264.815731449419;5498.147787093007;5534.114541673353;5559.471850174227;5574.60977731559;5632.662040277555;5299.364076310829;6018.6990650467305;6225.968870155665;6252.968735156295;6253;6131.774283661862;6322.114903913456;6324.146240257553;6329.1772069631115;6331.113644089831;5734.913976290359;5833.620814647034;5840.561957853178;5850.444207800252;5853.76584936602;6281.309056003836;6311.495080393557;6346.27017892939;6358.364163583605;6361.681915904186;6062.605930614496;6131.601445906091;6207.534434917399;6227.532935029891;6247.0629405589525;6144.832481828438;6180.567360284737;6237.126802247689;6309.936900630935;6340.619562826245;6188.195534580475;6220.906686399708;6265.561410701207;6294.842628934313;6308.3060863305;6142.539309551801;6223.190985171989;6243.96878015607;6321.683915804191;6332.6200427973545;4821.5178482151505;4903.387076615423;4953.578945789576;4970.726610036482;5010.3737032870895;3841.500604921398;4425.468943726773;4435.35687325336;4440.62254708347;4476.082403107355;5416;5634.605577609528;5679.488846003796;5735.598508104393;5785.652860828363;6257.749690012349;6300.180976473029;6318.873622527523;6320.209973753281;6326.557141000086;5771.451712087345;5786.7495852415495;5859;5871.031279838864;5897.174395584621;5321.547668448148;5377.5429088527135;5402.486763757437;5421.4578542146255;5435.646682965595;6411.775587854403;6444.130042444398;6452.645104519296;6468.417842394207;6481.902771458337;6243.250809902659;6271.686415679106;6272.121902933502;6280.371962803683;6316.778912738032;6189.412005859436;6337.809865704036;6361.840953976188;6414.069959855888;6448.935510644834;6160.599561028519;6211.378862113753;6221.3156552778255;6231.813045608639;6234.314225435289;6085.726142323695;6258.906116408167;6263.123162757127;6265.718042687999;6267.811965640855;4932.950670493393;5992.490638295793;6078.696065196634;6131.509479241739;6147.5245940972945;4724.456687480983;5857.916285487028;6079.878402432015;6093.2078829751845;6114.449699527064;5812.360640329476;5867.882642347215;5894.086416605433;5964.761409543569;5968.850778730392;6108.053251745987;6116.35778243278;6192.164057852132;6203.348648392034;6218.81343559694;4925.556699897026;5985.910211346746;5986.022033402198;6016.42843929826;6019.006863867413 11:40:13 INFO - PROCESS | 2379 | |1;ext.html;502.8868504586466;510.4385176306064;569.9601027928045;574.7959474386595;627.8461776864668;36318.818405907965;37187.62812371876;37226;37244.696435624755;37295;29269.707302926963;30508.084757457258;38508;38598.22803543927;38677.41983870237;9149.862752058707;9231.6307347706;9246.907530924673;9396.248300135972;9412.764680882998;9273.721788346327;9486.288528360401;9486.66796662117;9492.335536512446;9540.045995400475;9419.670311539097;9457.38526995743;9536;9540.33217674763;9540.80918381632;9429.669961551346;9451.810963780754;9509.57206925683;9536.856947145763;9548.809023819555;8167.387445941518;9333.533323333873;9421.62313507459;9491.905080949171;9497.667581634678;30999.690003099906;36525.81737091324;36721.63278367209;37228.44157337642;37464.06339841498;3141.183292344007;3190.218396492851;3223.09753269085;3463.6709512596262;3482.3905816482015;28080.876764929377;28127.296817579725;28342;28582;28674.856625716737;2230.810381117607;2711.701712811589;2718.8912443502236;2724.3851798996175;2828.1091456191234;348438;349430;350515;458279;460925.695371521;34538.654613453546;59322.40677593255;59712.402875970685;59770.40229597735;59847.803043938875;34472.96581102571;34569.82715086408;34699;34829.47755783665;34834.129146771535;14620.415183392544;14812.259387030605;14858.702825943637;14870.628234294229;14903.105813651217;10081.848772268422;12046.072628379417;12223.205491643193;12416.503339866485;12459.12786104964;8048.752443371287;8053.6375863086305;8109.635066422025;8131.308838748654;8151.918480815235;3314.4531152360073;3331.283773988604;3364.52896594477;3369.4777309517062;3382.2051817823285;982.8132654795565;1000.2548101664162;1075.6439907488686;1116.609186784619;1153.4521102476256;28930.421391572472;29242.561361579592;29384;29572.40855182884;29690.55464168039;1103.663382668294;1126.1272513801869;1131.5134492168281;1191.2257032928492;1232.0820988363726;15065.774013389808;15106.471273505374;15205.467808626645;15265.542033739006;15381.615459613598;304927;305384;310472;311291;645343;56221.71889140528;58463.5384115392;58722.82554348889;58818.70590647105;58888.11667824986;1418.7659036259108;1430.3348942741468;1454.3528129982267;1456.4611093895326;1464.0995787590555;28910.566341505313;29073.12780616585;29124.854375727984;29526.261843454085;30335;50898.74550627223;51132.74433627808;51365;51567;51619;570171;571039;573016;575380;575764;26069;26507.602385964612;39865;41076.79461602673;42046.36930445985;41114.972125697095;41691;41853.44315526888;42026.57973420349;42538.57461425346;27236.455270894076;28408.090155981296;34578.61685532651;36410.27179456449;37173.6282637181;31256.843715781277;31431.842840785648;35222.82388588143;35738.463923040654;36523.634763653085;31616.525752113277;33814;36172.81913590415;37071.81464092662;38272.42591361188;30417;31219.84390078126;31277.06168814939;31289.904853330023;31420.528692070093;23312.184073557342;24356.75643243616;24410.51178976446;24427.75572244326;25264.89802421916 11:40:13 INFO - PROCESS | 2379 | |2;jquery.html;348.6757315696401;391.90267251695246;392.3643697210518;399.39491670119776;407.7634971716401;18757.906210468947;20352.69470957933;20753.896230518865;20792.37622871316;20804.271850485235;19451.31920382787;19638.116284767184;19747.308844190455;20716.378508644764;21079.6838047429;5587.552995760329;5706.514946229565;5881.705914704247;5890.528757699395;5939.406059394069;5661.377248502661;5707.571932105088;5723.341815691187;5745.6265342752795;5768.250127483421;5465.9180112298345;5698.629589076697;5833.533317334603;5844.357120716718;5848.093545500433;5713.3429655589725;5742.483176514133;5761.9135712964335;5770.394108618598;5838.153467747175;5035.093683137034;5110.718910459923;5112.386513618352;5133.358330208724;5134.897302053975;25027.374315642253;25279.11523096683;25340.23979280606;25360.87319563409;25586;1926.566522532433;2161.958829730894;2261.8642881427168;2414.7343792182846;2416.3808955817235;14544.418223271057;14576.416943322254;14910.925445372812;15064.924675376662;15114;1702.0383483331877;1704.3779020657494;1743.2939659437948;1750.9824901751074;1803.8376546110783;102835.48582257115;106347.40478892822;106404.46797766039;107159.46420267927;107578;10574.312669676447;10659.680209593724;10740.409277489813;10965.56137754481;11062.778744425228;11573.537058517733;13795.310234488436;13905.304734763222;13988.58034258974;14014.649633759034;8426.620802063922;8440.915590844135;8572.399932004824;8584.957075214585;8670.176333248332;8279.54462504568;8468.872966905501;8480;8545.700900468453;8604.698835540727;5573.442655734475;6544.640044797487;6664.133662623828;6682.599044057372;6682.732690692415;1836.8622353323553;1869.793982881034;1893.4508992392052;1900.667383207933;1940.379078694804;938.1650331205233;950.9429434233969;979.3242662562809;1007.6070332570304;1052.6157952347337;20147.597048058957;20206.494837629176;20346;20565.38303850887;20608.072636731384;1009.152312057875;1024.1908891975404;1075.9246852720235;1095.8191898336845;1143.731223162556;10700.678979630624;11024.834627480594;11093.278936869077;11105.056070233959;11176.776464470666;609128;611626;622061;624540;633142;79369;102544;107949;111330;112304.43847780708;991.8859331177007;1026.743314171457;1029.1818004686443;1038.314712289885;1045.6758404894506;18369.81630183681;18559.25762969466;18694;18709.8774073556;18822.341218057303;43120.78439607782;44687.77656111699;45362.546374535836;45385.999999998676;45796.08407831758;53761;63940;65035.67482162559;65642.67178664076;65883.67058164679;7413.555186688816;7531.924680753342;7580.583067931096;7673.501222420525;7763.378929685725;9326.95336523313;12073.11903039969;12123.393830308272;12212.57255996036;12227.69430764238;9576.377535460173;10225.590976360862;10476.94761526218;10528;10585.417802020962;10224.846627300447;10352.741181470523;10406.947965260126;10411.11505522039;10600.04599586041;10571.735706607089;10610.204234682584;10945.069669077899;10996.615118470816;11015.228933974546;7549.6225188739245;7584.696612135453;7758;7822.647980840762;7890.763277101696;10399.94800025995;10503.632372866912;10623.946880265548;10728.302660327054;10757.569697212024 11:40:13 INFO - PROCESS | 2379 | |3;mootools.html;1612.048891154219;1625.53672203422;1873.9906300468497;1944.77323464633;1951.0829909942322;7313.524620899644;8082.91917080829;8405.201505856941;8641.956790216056;9020.864687029693;8653.56732163391;8705.608247628856;8732.738017859458;8822.338324625647;8832.955835220815;2409.7469765674614;2429.2469334506313;2433.5862903306393;2441.2554170977846;2448.5470188015274;2422.0553983946274;2425.126954296452;2453.141400509825;2465.580851255291;2470.407102295445;2418.5404773093055;2446.4617784087563;2447.363685441789;2449.6692946452267;2472.418981539337;2434.026389444228;2443.4013666651695;2443.4135807406274;2444.59664155415;2465.6794616699895;2432.2824766693866;2434.866082365469;2443.8655873926928;2446.1805295226122;2455.287966489716;8843.469391836446;8944.8658270126;8978;8990.05604411534;8993.460392376479;4668.486466488684;5327.547158491533;5485.314335708036;5489.807856724996;5551.666899985973;3500.474928760681;3557.146284891633;3585.6593623605977;3619.8733044343585;3627.3470775260444;1014.8021135878433;1018.2464975917842;1040.8022475729588;1052.431686889079;1075.940198904079;10266.076053155177;11188.552457901675;11551.480183391683;11624.535018599247;11725.472353744102;4727.101850648366;4834.492378300298;4864.124457597666;4928.260760885896;4949.232868905326;9959.103680668775;10040.046195611405;10044.949775251076;10066.094051535398;10080.941501142275;5366.436524164985;5391.191321301836;5457.781688732485;5462.562994960394;5478.150886612581;4349.391085248068;4773.11697335994;4887.73117478535;4956.033573453215;4956.281339205795;3956.8615098471414;4022.3765316375425;4065.0243941453837;4090.4886889138857;4160.209560183555;1327.4424741608548;1349.8380194376737;1369.9726005479833;1370.9177449353072;1384.0865029080758;914.3279689428265;914.6067191107887;931.855562387831;946.2713710443059;972.9367591106555;5981.581289309794;6023.518118550505;6078.240219972504;6092.1775560299675;6133.907991380132;439.28835286835533;440.44943820224717;442.0187184450515;443.87349605362317;444.426689570457;3974.8012599370495;3975.8807235782974;3989.840406383712;4021.557628660845;4066.3290557057753;10630.787384252271;11006.339619622848;11010;11024.669259922215;11107.44462776874;10453.163746900229;10915.399653019002;10942.17933654979;10973.83539246912;11015.614453494249;7004.754833580801;8104.351651867836;8297.626606802709;8302.211289927447;8323.625436855235;5910;5960.1357803117435;6002.429769171922;6136.7852125175405;6222.439980401786;8213.876791848008;9447.574859131219;10102.595896164365;10155.695329140137;10275.640352587623;10047.145992590711;10120.342177758423;10123.848142278019;10127.341722787995;10171.64399246023;6857.862842743018;6949.930500694928;7333.596652184181;7455.291747283999;7620.085589729268;8045.356371490384;8128.105908349959;8130.983627046619;8134.349252059703;8174.468659537111;7133.357997780225;7134.32223938725;7252.927470725225;7387.593682347308;7389.889151662837;7064.576125432491;7218.711251549879;7255.310745479383;7287.2348403419;7536.547807131589;6188.504919606331;6873.48448866327;7001.299870012958;7072.893906591508;7081.858362832818;4838.395200599925;4904.141775189256;4920.901581968412;4980.576650984707;5061.8734531637;4221.91556168881;4745.193317136026;4768.165571025126;4936.691776679111;4967.285219273413 11:40:13 INFO - PROCESS | 2379 | |4;prototype.html;296.8753123688052;319.96160460744704;329.1770573566085;330.96028476582813;332.58260882592344;6066.241719785027;6098.085287206921;6248.781292654758;6273.968630156848;6301.683346907366;4748.928766068511;5721.166818231784;6120.908186377197;6212.720427580758;6226.283977342607;4021.557628660845;4033.2135233629456;4622.699524530912;4644.814207431698;4658.604018658401;4447.733136011833;4643.330085201006;4652.906566956763;4663.300504924255;4664.97667511662;4540.79566419512;4575.885602859922;4597.770111494428;4611.654125940551;4623.214053610895;4614.238650622643;4654.348391225231;4658;4663.440387153546;4676.766161691936;3787.715921305913;3956.5647778744315;3960.841566337343;3992.48097747291;3998.020484981198;5931.406859314034;5946.413310210072;5971.253593300838;5981.325228935905;5999.640021598718;4731.787069581877;4794.688345257582;5383.084875571162;5433.891322173535;5441.646292990943;5016.065601623055;5624.775008999635;6285.025820997753;6439.517036222255;6607.240167380764;4236.597523235288;4245.0236445617375;4267.594578515036;4271.765052922088;4312.956870431318;5745.3105627324985;6454.548181627288;6568.63872487013;6596.109525214083;6698.93301066988;3333.9664703941858;3995.2409042281874;4275.166342563232;4284.186004659105;4319.740815551077;3692.630736926286;4212.262854000599;4376.343548467756;4382.824687012548;4392;4547.272436410159;4945.480724523945;5152.639315247897;5163.380394352702;5169.302144210558;5494.36814766299;6403.135576697086;6486.837829054217;6518.543701940914;6547.214334279917;1519.55173223897;1532.7547592385165;1534.2022148482727;1536;1537.1392020468572;980.9215262778961;990.4255531791688;1000.7898341348252;1005.2912696548915;1017.9134773544183;5202.869928251824;5939.13882487037;6153.230846144232;6206.844828879224;6229.719662615194;6845.8973115403305;6852.828679283058;6880.2431732509385;6911.680199875078;6931.202911665122;4990.6506544541535;5112.9744351278005;6182.567220294536;6189.876202476015;6193.597416167935;3594.5866225384416;3641.890743277706;3653.0867283179205;3659.1949771050326;3671.7796932184156;6105.34915463626;6716.059751634775;6756.9188929771;7180.461465390013;7214.494985350975;6721.495887808336;7063.540869843444;7069.116360454943;7079.504434689626;7101.538400003983;5854.818485640154;6838.7264509419065;6949.409300209539;7094.92905070953;7181.928180718126;5748.45389687979;5838.883222335615;6820.35206655367;6851.972204169415;6942.548734332252;6019.458248757458;6209.875802484015;6754.290799465985;6844.8288792778585;6868.62222577763;7121.287871213044;7155.356017958408;7169.4981351304905;7189.496735228484;7235.674394652148;4420.359047937966;4428.4243048403505;4436.378906952965;4448.7108337957925;4450.777461126995;5830.883382332415;6557.2131344239;6589.538732288694;6838.760643377458;6931.851126150707;5926.7925622603;6131.785387511594;6732.528722989344;6740.528163028737;6771.458283337222;5946.405359464019;6378.52161087911;6446.516511261768;6738.9554619034125;6770.796876093725;5881.941180588139;5938.851528711817;6322.557420980487;6490.896547586827;6625.370589793962;5582.804601838916;5885.676287804041;6297.55917085818;6715.597064176165;6775.356341147583;5702.002149623716;5703.859228154469;6142.262928448615;6441.3880681335195;6570.310117437792 11:40:13 INFO - PROCESS | 2379 | |5;yui.html;668.6990854115652;689.8344397344639;731.2431633259577;736.4071922102709;753.3220101908282;12315.38423078847;14091.647708807284;15131.621709457282;15275.618109547238;15321.233938303096;10249.84625230622;11717;14024.439022439115;14343.354549045293;14374.353154108065;718.7735863203101;894.575076838503;903.8508646073407;916.7112359606735;917.6742256498947;869.2698133567802;870.899846517649;874.8337815815007;902.057350069176;920.1810388754014;923.487464457226;931.3480563605469;958.2286259561085;960.9951950240239;970.0832713086137;916.9816603667889;934.6775362499926;946.46997681298;954.1031430455349;966.4153187321674;690.2476300832117;691.7509696509253;697.2643860726931;715.7709532949458;718.6299055986171;15309.234538273153;15349.079055256609;15364.462243821412;15436.38254469831;15526.922365388215;12930.676733081655;12958;13048.673783155402;13073.803892941614;13293;10314.79370412595;10334.586616535329;10373.170146388271;10489.423081730502;10711.036006759428;3163.1459505933267;3474.322507111114;3532.452469867175;3576.6423357664285;3638.5451818522683;89550;90054;90250.5487472565;90644.54677726635;91927.08072919252;9088.363814532919;9218.308626853013;9394.671186508576;9434.716958491119;9999.35004224723;21292.25477108294;21867;21940.89029554842;21957.67063494049;21983;7590.7722768317035;7654.349380302737;7684.231576842383;7732.806679833049;7754.651040703069;3988.541317748438;4040.070783719761;4067.898302542401;4075.1645912587846;4084.448599439097;3540.4335306351377;3678.3930651442747;3681.7790932544135;3687.723420743455;3811.8856434307013;681.1417613806541;683.0300972618893;686.7012849410522;689.3898899474002;698.1029377250209;567.2002476508104;588.5850475414823;590.9497692696083;598.7305712429425;623.8939380305359;7807.882881756778;8090.797730056795;8148.837023259502;8204.671813127527;8392.580370981426;481.41267653462717;494.9704614402035;563.5632384901652;589.104561067184;603.6287683074966;3125.7809454312837;3850.0374906273432;3886.300465916162;3957.3272543667645;4077.510698716114;73821;95301;97320;98872;99120;78636.60681696555;80719.19280807117;83598.5820070908;83845;84127.5793621028;73034;73422.63288683629;73519;73548;74192.25807741853;7530.134034585873;7578;7709.790988903435;7777.650005749641;7810.984572005603;43796;44306;44476.77761611301;44538.10923781442;45186.09627807491;47967.04065918732;62080.75838483295;62369;62859.05711414424;63426.68286658537;9404.01257867914;9538.380005299634;9721.56252968604;9975.301728878909;10748.946255268986;11800.52797888075;12350.258984460961;12465.813012804634;12577.811332830199;13068.934655326662;10243.282970192015;11266.549338026387;11560.30638161713;11681.532738690697;12070.939645301718;11363.829542556703;11529.135314851252;11537.653870383901;11962.76074478523;12092.093093018235;8475;8781.648734050566;8976.55117244122;10544.57821687124;10625.734356641145;9402.34183607141;9467.195288400288;9613;9904.25718071162;10349.86151523347;7992.480488768444;8361.390862392014;9798.216142708709;9798.51007449639;9868.210543156674 11:40:13 INFO - PROCESS | 2379 | __end_tp_report 11:40:13 INFO - PROCESS | 2379 | __start_cc_report 11:40:13 INFO - PROCESS | 2379 | _x_x_mozilla_cycle_collect,392 11:40:13 INFO - PROCESS | 2379 | __end_cc_report 11:40:13 INFO - PROCESS | 2379 | __startTimestamp1460659213749__endTimestamp 11:40:13 INFO - PROCESS | 2379 | 11:40:13 INFO - PROCESS | 2379 | ------- Summary: start ------- 11:40:13 INFO - PROCESS | 2379 | Number of tests: 6 11:40:13 INFO - PROCESS | 2379 | 11:40:13 INFO - PROCESS | 2379 | [#0] dojo.html Cycles:165 Average:5736.94 Median:5897.17 stddev:660.32 (11.2%) stddev-sans-first:637.19 11:40:13 INFO - PROCESS | 2379 | Values: 3435.8 3437.3 3460.6 3477.1 3528.9 5710.7 5725.6 5754.7 5769.5 5828.4 4699.1 5603.7 5705.5 5706.0 5813.2 5114.9 5170.6 5230.9 5253.5 5315.1 5288.7 5295.5 5299.5 5305.2 5320.4 5183.1 5185.4 5208.4 5240.1 5249.1 5168.8 5233.7 5252.8 5266.0 5282.4 5200.4 5220.9 5221.5 5250.0 5264.8 5498.1 5534.1 5559.5 5574.6 5632.7 5299.4 6018.7 6226.0 6253.0 6253.0 6131.8 6322.1 6324.1 6329.2 6331.1 5734.9 5833.6 5840.6 5850.4 5853.8 6281.3 6311.5 6346.3 6358.4 6361.7 6062.6 6131.6 6207.5 6227.5 6247.1 6144.8 6180.6 6237.1 6309.9 6340.6 6188.2 6220.9 6265.6 6294.8 6308.3 6142.5 6223.2 6244.0 6321.7 6332.6 4821.5 4903.4 4953.6 4970.7 5010.4 3841.5 4425.5 4435.4 4440.6 4476.1 5416.0 5634.6 5679.5 5735.6 5785.7 6257.7 6300.2 6318.9 6320.2 6326.6 5771.5 5786.7 5859.0 5871.0 5897.2 5321.5 5377.5 5402.5 5421.5 5435.6 6411.8 6444.1 6452.6 6468.4 6481.9 6243.3 6271.7 6272.1 6280.4 6316.8 6189.4 6337.8 6361.8 6414.1 6448.9 6160.6 6211.4 6221.3 6231.8 6234.3 6085.7 6258.9 6263.1 6265.7 6267.8 4933.0 5992.5 6078.7 6131.5 6147.5 4724.5 5857.9 6079.9 6093.2 6114.4 5812.4 5867.9 5894.1 5964.8 5968.9 6108.1 6116.4 6192.2 6203.3 6218.8 4925.6 5985.9 5986.0 6016.4 6019.0 11:40:13 INFO - PROCESS | 2379 | 11:40:13 INFO - PROCESS | 2379 | [#1] ext.html Cycles:180 Average:57806.47 Median:191636.06 stddev:124070.77 (64.7%) stddev-sans-first:124344.22 11:40:13 INFO - PROCESS | 2379 | Values: 502.9 510.4 570.0 574.8 627.8 36318.8 37187.6 37226.0 37244.7 37295.0 29269.7 30508.1 38508.0 38598.2 38677.4 9149.9 9231.6 9246.9 9396.2 9412.8 9273.7 9486.3 9486.7 9492.3 9540.0 9419.7 9457.4 9536.0 9540.3 9540.8 9429.7 9451.8 9509.6 9536.9 9548.8 8167.4 9333.5 9421.6 9491.9 9497.7 30999.7 36525.8 36721.6 37228.4 37464.1 3141.2 3190.2 3223.1 3463.7 3482.4 28080.9 28127.3 28342.0 28582.0 28674.9 2230.8 2711.7 2718.9 2724.4 2828.1 348438.0 349430.0 350515.0 458279.0 460925.7 34538.7 59322.4 59712.4 59770.4 59847.8 34473.0 34569.8 34699.0 34829.5 34834.1 14620.4 14812.3 14858.7 14870.6 14903.1 10081.8 12046.1 12223.2 12416.5 12459.1 8048.8 8053.6 8109.6 8131.3 8151.9 3314.5 3331.3 3364.5 3369.5 3382.2 982.8 1000.3 1075.6 1116.6 1153.5 28930.4 29242.6 29384.0 29572.4 29690.6 1103.7 1126.1 1131.5 1191.2 1232.1 15065.8 15106.5 15205.5 15265.5 15381.6 304927.0 305384.0 310472.0 311291.0 645343.0 56221.7 58463.5 58722.8 58818.7 58888.1 1418.8 1430.3 1454.4 1456.5 1464.1 28910.6 29073.1 29124.9 29526.3 30335.0 50898.7 51132.7 51365.0 51567.0 51619.0 570171.0 571039.0 573016.0 575380.0 575764.0 26069.0 26507.6 39865.0 41076.8 42046.4 41115.0 41691.0 41853.4 42026.6 42538.6 27236.5 28408.1 34578.6 36410.3 37173.6 31256.8 31431.8 35222.8 35738.5 36523.6 31616.5 33814.0 36172.8 37071.8 38272.4 30417.0 31219.8 31277.1 31289.9 31420.5 23312.2 24356.8 24410.5 24427.8 25264.9 11:40:13 INFO - PROCESS | 2379 | 11:40:13 INFO - PROCESS | 2379 | [#2] jquery.html Cycles:180 Average:33927.05 Median:20773.14 stddev:102348.73 (492.7%) stddev-sans-first:102604.79 11:40:13 INFO - PROCESS | 2379 | Values: 348.7 391.9 392.4 399.4 407.8 18757.9 20352.7 20753.9 20792.4 20804.3 19451.3 19638.1 19747.3 20716.4 21079.7 5587.6 5706.5 5881.7 5890.5 5939.4 5661.4 5707.6 5723.3 5745.6 5768.3 5465.9 5698.6 5833.5 5844.4 5848.1 5713.3 5742.5 5761.9 5770.4 5838.2 5035.1 5110.7 5112.4 5133.4 5134.9 25027.4 25279.1 25340.2 25360.9 25586.0 1926.6 2162.0 2261.9 2414.7 2416.4 14544.4 14576.4 14910.9 15064.9 15114.0 1702.0 1704.4 1743.3 1751.0 1803.8 102835.5 106347.4 106404.5 107159.5 107578.0 10574.3 10659.7 10740.4 10965.6 11062.8 11573.5 13795.3 13905.3 13988.6 14014.6 8426.6 8440.9 8572.4 8585.0 8670.2 8279.5 8468.9 8480.0 8545.7 8604.7 5573.4 6544.6 6664.1 6682.6 6682.7 1836.9 1869.8 1893.5 1900.7 1940.4 938.2 950.9 979.3 1007.6 1052.6 20147.6 20206.5 20346.0 20565.4 20608.1 1009.2 1024.2 1075.9 1095.8 1143.7 10700.7 11024.8 11093.3 11105.1 11176.8 609128.0 611626.0 622061.0 624540.0 633142.0 79369.0 102544.0 107949.0 111330.0 112304.4 991.9 1026.7 1029.2 1038.3 1045.7 18369.8 18559.3 18694.0 18709.9 18822.3 43120.8 44687.8 45362.5 45386.0 45796.1 53761.0 63940.0 65035.7 65642.7 65883.7 7413.6 7531.9 7580.6 7673.5 7763.4 9327.0 12073.1 12123.4 12212.6 12227.7 9576.4 10225.6 10476.9 10528.0 10585.4 10224.8 10352.7 10406.9 10411.1 10600.0 10571.7 10610.2 10945.1 10996.6 11015.2 7549.6 7584.7 7758.0 7822.6 7890.8 10399.9 10503.6 10623.9 10728.3 10757.6 11:40:13 INFO - PROCESS | 2379 | 11:40:13 INFO - PROCESS | 2379 | [#3] mootools.html Cycles:180 Average:5700.55 Median:4736.15 stddev:3172.52 (67.0%) stddev-sans-first:3166.54 11:40:13 INFO - PROCESS | 2379 | Values: 1612.0 1625.5 1874.0 1944.8 1951.1 7313.5 8082.9 8405.2 8642.0 9020.9 8653.6 8705.6 8732.7 8822.3 8833.0 2409.7 2429.2 2433.6 2441.3 2448.5 2422.1 2425.1 2453.1 2465.6 2470.4 2418.5 2446.5 2447.4 2449.7 2472.4 2434.0 2443.4 2443.4 2444.6 2465.7 2432.3 2434.9 2443.9 2446.2 2455.3 8843.5 8944.9 8978.0 8990.1 8993.5 4668.5 5327.5 5485.3 5489.8 5551.7 3500.5 3557.1 3585.7 3619.9 3627.3 1014.8 1018.2 1040.8 1052.4 1075.9 10266.1 11188.6 11551.5 11624.5 11725.5 4727.1 4834.5 4864.1 4928.3 4949.2 9959.1 10040.0 10044.9 10066.1 10080.9 5366.4 5391.2 5457.8 5462.6 5478.2 4349.4 4773.1 4887.7 4956.0 4956.3 3956.9 4022.4 4065.0 4090.5 4160.2 1327.4 1349.8 1370.0 1370.9 1384.1 914.3 914.6 931.9 946.3 972.9 5981.6 6023.5 6078.2 6092.2 6133.9 439.3 440.4 442.0 443.9 444.4 3974.8 3975.9 3989.8 4021.6 4066.3 10630.8 11006.3 11010.0 11024.7 11107.4 10453.2 10915.4 10942.2 10973.8 11015.6 7004.8 8104.4 8297.6 8302.2 8323.6 5910.0 5960.1 6002.4 6136.8 6222.4 8213.9 9447.6 10102.6 10155.7 10275.6 10047.1 10120.3 10123.8 10127.3 10171.6 6857.9 6949.9 7333.6 7455.3 7620.1 8045.4 8128.1 8131.0 8134.3 8174.5 7133.4 7134.3 7252.9 7387.6 7389.9 7064.6 7218.7 7255.3 7287.2 7536.5 6188.5 6873.5 7001.3 7072.9 7081.9 4838.4 4904.1 4920.9 4980.6 5061.9 4221.9 4745.2 4768.2 4936.7 4967.3 11:40:13 INFO - PROCESS | 2379 | 11:40:13 INFO - PROCESS | 2379 | [#4] prototype.html Cycles:180 Average:5273.68 Median:5906.23 stddev:1672.99 (28.3%) stddev-sans-first:1635.45 11:40:13 INFO - PROCESS | 2379 | Values: 296.9 320.0 329.2 331.0 332.6 6066.2 6098.1 6248.8 6274.0 6301.7 4748.9 5721.2 6120.9 6212.7 6226.3 4021.6 4033.2 4622.7 4644.8 4658.6 4447.7 4643.3 4652.9 4663.3 4665.0 4540.8 4575.9 4597.8 4611.7 4623.2 4614.2 4654.3 4658.0 4663.4 4676.8 3787.7 3956.6 3960.8 3992.5 3998.0 5931.4 5946.4 5971.3 5981.3 5999.6 4731.8 4794.7 5383.1 5433.9 5441.6 5016.1 5624.8 6285.0 6439.5 6607.2 4236.6 4245.0 4267.6 4271.8 4313.0 5745.3 6454.5 6568.6 6596.1 6698.9 3334.0 3995.2 4275.2 4284.2 4319.7 3692.6 4212.3 4376.3 4382.8 4392.0 4547.3 4945.5 5152.6 5163.4 5169.3 5494.4 6403.1 6486.8 6518.5 6547.2 1519.6 1532.8 1534.2 1536.0 1537.1 980.9 990.4 1000.8 1005.3 1017.9 5202.9 5939.1 6153.2 6206.8 6229.7 6845.9 6852.8 6880.2 6911.7 6931.2 4990.7 5113.0 6182.6 6189.9 6193.6 3594.6 3641.9 3653.1 3659.2 3671.8 6105.3 6716.1 6756.9 7180.5 7214.5 6721.5 7063.5 7069.1 7079.5 7101.5 5854.8 6838.7 6949.4 7094.9 7181.9 5748.5 5838.9 6820.4 6852.0 6942.5 6019.5 6209.9 6754.3 6844.8 6868.6 7121.3 7155.4 7169.5 7189.5 7235.7 4420.4 4428.4 4436.4 4448.7 4450.8 5830.9 6557.2 6589.5 6838.8 6931.9 5926.8 6131.8 6732.5 6740.5 6771.5 5946.4 6378.5 6446.5 6739.0 6770.8 5881.9 5938.9 6322.6 6490.9 6625.4 5582.8 5885.7 6297.6 6715.6 6775.4 5702.0 5703.9 6142.3 6441.4 6570.3 11:40:13 INFO - PROCESS | 2379 | 11:40:13 INFO - PROCESS | 2379 | [#5] yui.html Cycles:180 Average:18332.52 Median:682.09 stddev:26455.29 (3878.6%) stddev-sans-first:26496.26 11:40:13 INFO - PROCESS | 2379 | Values: 668.7 689.8 731.2 736.4 753.3 12315.4 14091.6 15131.6 15275.6 15321.2 10249.8 11717.0 14024.4 14343.4 14374.4 718.8 894.6 903.9 916.7 917.7 869.3 870.9 874.8 902.1 920.2 923.5 931.3 958.2 961.0 970.1 917.0 934.7 946.5 954.1 966.4 690.2 691.8 697.3 715.8 718.6 15309.2 15349.1 15364.5 15436.4 15526.9 12930.7 12958.0 13048.7 13073.8 13293.0 10314.8 10334.6 10373.2 10489.4 10711.0 3163.1 3474.3 3532.5 3576.6 3638.5 89550.0 90054.0 90250.5 90644.5 91927.1 9088.4 9218.3 9394.7 9434.7 9999.4 21292.3 21867.0 21940.9 21957.7 21983.0 7590.8 7654.3 7684.2 7732.8 7754.7 3988.5 4040.1 4067.9 4075.2 4084.4 3540.4 3678.4 3681.8 3687.7 3811.9 681.1 683.0 686.7 689.4 698.1 567.2 588.6 590.9 598.7 623.9 7807.9 8090.8 8148.8 8204.7 8392.6 481.4 495.0 563.6 589.1 603.6 3125.8 3850.0 3886.3 3957.3 4077.5 73821.0 95301.0 97320.0 98872.0 99120.0 78636.6 80719.2 83598.6 83845.0 84127.6 73034.0 73422.6 73519.0 73548.0 74192.3 7530.1 7578.0 7709.8 7777.7 7811.0 43796.0 44306.0 44476.8 44538.1 45186.1 47967.0 62080.8 62369.0 62859.1 63426.7 9404.0 9538.4 9721.6 9975.3 10748.9 11800.5 12350.3 12465.8 12577.8 13068.9 10243.3 11266.5 11560.3 11681.5 12070.9 11363.8 11529.1 11537.7 11962.8 12092.1 8475.0 8781.6 8976.6 10544.6 10625.7 9402.3 9467.2 9613.0 9904.3 10349.9 7992.5 8361.4 9798.2 9798.5 9868.2 11:40:13 INFO - PROCESS | 2379 | -------- Summary: end -------- 11:40:13 INFO - PROCESS | 2379 | 11:40:14 INFO - TEST-INFO | 2379: exit 0 11:40:14 INFO - TEST-OK | dromaeo_css | took 1111881ms 11:40:14 INFO - TEST-START | kraken 11:40:14 INFO - operating with platform_type : mac_ 11:40:14 INFO - Initialising browser for kraken test... 11:40:14 INFO - TEST-INFO | started process 2385 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpSOeHvB/profile http://localhost:52757/getInfo.html) 11:40:16 INFO - PROCESS | 2385 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 11:40:17 INFO - PROCESS | 2385 | __metrics Screen width/height:1600/1200 11:40:17 INFO - PROCESS | 2385 | colorDepth:24 11:40:17 INFO - PROCESS | 2385 | Browser inner width/height: 1024/689 11:40:17 INFO - PROCESS | 2385 | __metrics 11:40:17 ERROR - PROCESS | 2385 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:40:17 INFO - TEST-INFO | 2385: exit 0 11:40:17 INFO - Browser initialized. 11:40:17 INFO - Running cycle 1/1 for kraken test... 11:40:17 INFO - TEST-INFO | started process 2388 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpSOeHvB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:29 INFO - PROCESS | 2388 | RSS: Main: 247685120 11:40:29 INFO - PROCESS | 2388 | 11:40:32 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52757/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:33 INFO - PROCESS | 2388 | RSS: Main: 260055040 11:40:33 INFO - PROCESS | 2388 | 11:40:36 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52757/tests/kraken/driver.html?testName=audio-dft) 11:40:36 INFO - PROCESS | 2388 | RSS: Main: 268976128 11:40:36 INFO - PROCESS | 2388 | 11:40:40 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52757/tests/kraken/driver.html?testName=audio-fft) 11:40:40 INFO - PROCESS | 2388 | RSS: Main: 272150528 11:40:40 INFO - PROCESS | 2388 | 11:40:42 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52757/tests/kraken/driver.html?testName=audio-oscillator) 11:40:43 INFO - PROCESS | 2388 | RSS: Main: 273039360 11:40:43 INFO - PROCESS | 2388 | 11:40:45 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52757/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:46 INFO - PROCESS | 2388 | RSS: Main: 273481728 11:40:46 INFO - PROCESS | 2388 | 11:40:48 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52757/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:49 INFO - PROCESS | 2388 | RSS: Main: 273887232 11:40:49 INFO - PROCESS | 2388 | 11:40:52 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52757/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:52 INFO - PROCESS | 2388 | RSS: Main: 275001344 11:40:52 INFO - PROCESS | 2388 | 11:40:55 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52757/tests/kraken/driver.html?testName=json-parse-financial) 11:40:56 INFO - PROCESS | 2388 | RSS: Main: 275075072 11:40:56 INFO - PROCESS | 2388 | 11:40:57 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52757/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:58 INFO - PROCESS | 2388 | RSS: Main: 274931712 11:40:58 INFO - PROCESS | 2388 | 11:41:00 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52757/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:41:01 INFO - PROCESS | 2388 | RSS: Main: 275034112 11:41:01 INFO - PROCESS | 2388 | 11:41:03 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52757/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:41:04 INFO - PROCESS | 2388 | RSS: Main: 275243008 11:41:04 INFO - PROCESS | 2388 | 11:41:07 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:41:07 INFO - PROCESS | 2388 | RSS: Main: 275484672 11:41:07 INFO - PROCESS | 2388 | 11:41:10 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:11 INFO - PROCESS | 2388 | RSS: Main: 275365888 11:41:11 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | Cycle 1(1): loaded http://localhost:52757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52757/tests/kraken/driver.html?testName=ai-astar) 11:41:13 INFO - PROCESS | 2388 | RSS: Main: 277323776 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | __start_tp_report 11:41:13 INFO - PROCESS | 2388 | _x_x_mozilla_page_load 11:41:13 INFO - PROCESS | 2388 | _x_x_mozilla_page_load_details 11:41:13 INFO - PROCESS | 2388 | |i|pagename|runs| 11:41:13 INFO - PROCESS | 2388 | |0;ai-astar;117;110;123;118;117;129;116;117;118;119 11:41:13 INFO - PROCESS | 2388 | |1;audio-beat-detection;174;155;190;165;118;142;145;122;169;123 11:41:13 INFO - PROCESS | 2388 | |2;audio-dft;195;201;204;208;248;285;246;203;202;198 11:41:13 INFO - PROCESS | 2388 | |3;audio-fft;65;81;74;138;58;55;58;63;131;58 11:41:13 INFO - PROCESS | 2388 | |4;audio-oscillator;79;82;134;78;83;82;119;83;79;118 11:41:13 INFO - PROCESS | 2388 | |5;imaging-gaussian-blur;89;84;89;87;90;86;90;86;89;87 11:41:13 INFO - PROCESS | 2388 | |6;imaging-darkroom;96;97;96;94;97;96;96;95;95;95 11:41:13 INFO - PROCESS | 2388 | |7;imaging-desaturate;91;91;93;91;96;92;90;111;143;114 11:41:13 INFO - PROCESS | 2388 | |8;json-parse-financial;60;62;61;61;62;61;62;80;69;79 11:41:13 INFO - PROCESS | 2388 | |9;json-stringify-tinderbox;68;67;69;69;71;73;74;68;68;71 11:41:13 INFO - PROCESS | 2388 | |10;stanford-crypto-aes;89;88;90;89;89;89;90;83;102;113 11:41:13 INFO - PROCESS | 2388 | |11;stanford-crypto-ccm;180;136;181;163;154;157;164;163;226;173 11:41:13 INFO - PROCESS | 2388 | |12;stanford-crypto-pbkdf2;173;176;169;166;176;176;172;178;174;173 11:41:13 INFO - PROCESS | 2388 | |13;stanford-crypto-sha256-iterative;70;76;88;97;104;95;75;70;69;73 11:41:13 INFO - PROCESS | 2388 | __end_tp_report 11:41:13 INFO - PROCESS | 2388 | __start_cc_report 11:41:13 INFO - PROCESS | 2388 | _x_x_mozilla_cycle_collect,992 11:41:13 INFO - PROCESS | 2388 | __end_cc_report 11:41:13 INFO - PROCESS | 2388 | __startTimestamp1460659273346__endTimestamp 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | ------- Summary: start ------- 11:41:13 INFO - PROCESS | 2388 | Number of tests: 14 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#0] ai-astar Cycles:10 Average:118.40 Median:118.00 stddev:4.90 (4.2%) stddev-sans-first:5.17 11:41:13 INFO - PROCESS | 2388 | Values: 117.0 110.0 123.0 118.0 117.0 129.0 116.0 117.0 118.0 119.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:160.00 stddev:24.52 (15.3%) stddev-sans-first:24.46 11:41:13 INFO - PROCESS | 2388 | Values: 174.0 155.0 190.0 165.0 118.0 142.0 145.0 122.0 169.0 123.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#2] audio-dft Cycles:10 Average:219.00 Median:206.00 stddev:30.11 (14.6%) stddev-sans-first:30.66 11:41:13 INFO - PROCESS | 2388 | Values: 195.0 201.0 204.0 208.0 248.0 285.0 246.0 203.0 202.0 198.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#3] audio-fft Cycles:10 Average:78.10 Median:60.50 stddev:30.83 (51.0%) stddev-sans-first:32.34 11:41:13 INFO - PROCESS | 2388 | Values: 65.0 81.0 74.0 138.0 58.0 55.0 58.0 63.0 131.0 58.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:80.50 stddev:21.18 (26.3%) stddev-sans-first:21.78 11:41:13 INFO - PROCESS | 2388 | Values: 79.0 82.0 134.0 78.0 83.0 82.0 119.0 83.0 79.0 118.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:89.00 stddev:2.00 (2.3%) stddev-sans-first:2.07 11:41:13 INFO - PROCESS | 2388 | Values: 89.0 84.0 89.0 87.0 90.0 86.0 90.0 86.0 89.0 87.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 11:41:13 INFO - PROCESS | 2388 | Values: 96.0 97.0 96.0 94.0 97.0 96.0 96.0 95.0 95.0 95.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#7] imaging-desaturate Cycles:10 Average:101.20 Median:91.00 stddev:17.07 (18.8%) stddev-sans-first:17.71 11:41:13 INFO - PROCESS | 2388 | Values: 91.0 91.0 93.0 91.0 96.0 92.0 90.0 111.0 143.0 114.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:62.00 stddev:7.69 (12.4%) stddev-sans-first:7.87 11:41:13 INFO - PROCESS | 2388 | Values: 60.0 62.0 61.0 61.0 62.0 61.0 62.0 80.0 69.0 79.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:2.35 (3.4%) stddev-sans-first:2.40 11:41:13 INFO - PROCESS | 2388 | Values: 68.0 67.0 69.0 69.0 71.0 73.0 74.0 68.0 68.0 71.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:89.00 stddev:8.70 (9.8%) stddev-sans-first:9.15 11:41:13 INFO - PROCESS | 2388 | Values: 89.0 88.0 90.0 89.0 89.0 89.0 90.0 83.0 102.0 113.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#11] stanford-crypto-ccm Cycles:10 Average:169.70 Median:168.50 stddev:23.76 (14.1%) stddev-sans-first:24.91 11:41:13 INFO - PROCESS | 2388 | Values: 180.0 136.0 181.0 163.0 154.0 157.0 164.0 163.0 226.0 173.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:175.00 stddev:3.62 (2.1%) stddev-sans-first:3.84 11:41:13 INFO - PROCESS | 2388 | Values: 173.0 176.0 169.0 166.0 176.0 176.0 172.0 178.0 174.0 173.0 11:41:13 INFO - PROCESS | 2388 | 11:41:13 INFO - PROCESS | 2388 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.70 Median:75.50 stddev:13.06 (17.3%) stddev-sans-first:13.15 11:41:13 INFO - PROCESS | 2388 | Values: 70.0 76.0 88.0 97.0 104.0 95.0 75.0 70.0 69.0 73.0 11:41:13 INFO - PROCESS | 2388 | -------- Summary: end -------- 11:41:13 INFO - PROCESS | 2388 | 11:41:14 INFO - TEST-INFO | 2388: exit 0 11:41:14 INFO - TEST-OK | kraken | took 59889ms 11:41:14 INFO - SUITE-END | took 1171s 11:41:14 INFO - Completed test suite (00:19:32) 11:41:14 INFO - javascript benchmark 11:41:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3435.8453869575874, 3437.3297207044625, 3460.619331873495, 3477.1307173206696, 3528.9294214115703, 5710.71446427678, 5725.6278341907855, 5754.65472071676, 5769.509591684707, 5828.358880523145, 4699.107169637767, 5603.663780173182, 5705.48650621444, 5705.971470142654, 5813.186153938452, 5114.948850511503, 5170.586353091753, 5230.947690523084, 5253.527182553588, 5315.0698627740185, 5288.68267903927, 5295.523402893738, 5299.54953828925, 5305.1776974569, 5320.414754377015, 5183.067047931371, 5185.403678576974, 5208.401033881114, 5240.109181439165, 5249.107651699202, 5168.793248270064, 5233.659812112201, 5252.842414727565, 5266.0, 5282.3925248596515, 5200.3759548854005, 5220.947790522084, 5221.530062294374, 5250.0, 5264.815731449419, 5498.147787093007, 5534.114541673353, 5559.471850174227, 5574.60977731559, 5632.662040277555, 5299.364076310829, 6018.6990650467305, 6225.968870155665, 6252.968735156295, 6253.0, 6131.774283661862, 6322.114903913456, 6324.146240257553, 6329.1772069631115, 6331.113644089831, 5734.913976290359, 5833.620814647034, 5840.561957853178, 5850.444207800252, 5853.76584936602, 6281.309056003836, 6311.495080393557, 6346.27017892939, 6358.364163583605, 6361.681915904186, 6062.605930614496, 6131.601445906091, 6207.534434917399, 6227.532935029891, 6247.0629405589525, 6144.832481828438, 6180.567360284737, 6237.126802247689, 6309.936900630935, 6340.619562826245, 6188.195534580475, 6220.906686399708, 6265.561410701207, 6294.842628934313, 6308.3060863305, 6142.539309551801, 6223.190985171989, 6243.96878015607, 6321.683915804191, 6332.6200427973545, 4821.5178482151505, 4903.387076615423, 4953.578945789576, 4970.726610036482, 5010.3737032870895, 3841.500604921398, 4425.468943726773, 4435.35687325336, 4440.62254708347, 4476.082403107355, 5416.0, 5634.605577609528, 5679.488846003796, 5735.598508104393, 5785.652860828363, 6257.749690012349, 6300.180976473029, 6318.873622527523, 6320.209973753281, 6326.557141000086, 5771.451712087345, 5786.7495852415495, 5859.0, 5871.031279838864, 5897.174395584621, 5321.547668448148, 5377.5429088527135, 5402.486763757437, 5421.4578542146255, 5435.646682965595, 6411.775587854403, 6444.130042444398, 6452.645104519296, 6468.417842394207, 6481.902771458337, 6243.250809902659, 6271.686415679106, 6272.121902933502, 6280.371962803683, 6316.778912738032, 6189.412005859436, 6337.809865704036, 6361.840953976188, 6414.069959855888, 6448.935510644834, 6160.599561028519, 6211.378862113753, 6221.3156552778255, 6231.813045608639, 6234.314225435289, 6085.726142323695, 6258.906116408167, 6263.123162757127, 6265.718042687999, 6267.811965640855, 4932.950670493393, 5992.490638295793, 6078.696065196634, 6131.509479241739, 6147.5245940972945, 4724.456687480983, 5857.916285487028, 6079.878402432015, 6093.2078829751845, 6114.449699527064, 5812.360640329476, 5867.882642347215, 5894.086416605433, 5964.761409543569, 5968.850778730392, 6108.053251745987, 6116.35778243278, 6192.164057852132, 6203.348648392034, 6218.81343559694, 4925.556699897026, 5985.910211346746, 5986.022033402198, 6016.42843929826, 6019.006863867413], "value": 5696.29709491829, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.8868504586466, 510.4385176306064, 569.9601027928045, 574.7959474386595, 627.8461776864668, 36318.818405907965, 37187.62812371876, 37226.0, 37244.696435624755, 37295.0, 29269.707302926963, 30508.084757457258, 38508.0, 38598.22803543927, 38677.41983870237, 9149.862752058707, 9231.6307347706, 9246.907530924673, 9396.248300135972, 9412.764680882998, 9273.721788346327, 9486.288528360401, 9486.66796662117, 9492.335536512446, 9540.045995400475, 9419.670311539097, 9457.38526995743, 9536.0, 9540.33217674763, 9540.80918381632, 9429.669961551346, 9451.810963780754, 9509.57206925683, 9536.856947145763, 9548.809023819555, 8167.387445941518, 9333.533323333873, 9421.62313507459, 9491.905080949171, 9497.667581634678, 30999.690003099906, 36525.81737091324, 36721.63278367209, 37228.44157337642, 37464.06339841498, 3141.183292344007, 3190.218396492851, 3223.09753269085, 3463.6709512596262, 3482.3905816482015, 28080.876764929377, 28127.296817579725, 28342.0, 28582.0, 28674.856625716737, 2230.810381117607, 2711.701712811589, 2718.8912443502236, 2724.3851798996175, 2828.1091456191234, 348438.0, 349430.0, 350515.0, 458279.0, 460925.695371521, 34538.654613453546, 59322.40677593255, 59712.402875970685, 59770.40229597735, 59847.803043938875, 34472.96581102571, 34569.82715086408, 34699.0, 34829.47755783665, 34834.129146771535, 14620.415183392544, 14812.259387030605, 14858.702825943637, 14870.628234294229, 14903.105813651217, 10081.848772268422, 12046.072628379417, 12223.205491643193, 12416.503339866485, 12459.12786104964, 8048.752443371287, 8053.6375863086305, 8109.635066422025, 8131.308838748654, 8151.918480815235, 3314.4531152360073, 3331.283773988604, 3364.52896594477, 3369.4777309517062, 3382.2051817823285, 982.8132654795565, 1000.2548101664162, 1075.6439907488686, 1116.609186784619, 1153.4521102476256, 28930.421391572472, 29242.561361579592, 29384.0, 29572.40855182884, 29690.55464168039, 1103.663382668294, 1126.1272513801869, 1131.5134492168281, 1191.2257032928492, 1232.0820988363726, 15065.774013389808, 15106.471273505374, 15205.467808626645, 15265.542033739006, 15381.615459613598, 304927.0, 305384.0, 310472.0, 311291.0, 645343.0, 56221.71889140528, 58463.5384115392, 58722.82554348889, 58818.70590647105, 58888.11667824986, 1418.7659036259108, 1430.3348942741468, 1454.3528129982267, 1456.4611093895326, 1464.0995787590555, 28910.566341505313, 29073.12780616585, 29124.854375727984, 29526.261843454085, 30335.0, 50898.74550627223, 51132.74433627808, 51365.0, 51567.0, 51619.0, 570171.0, 571039.0, 573016.0, 575380.0, 575764.0, 26069.0, 26507.602385964612, 39865.0, 41076.79461602673, 42046.36930445985, 41114.972125697095, 41691.0, 41853.44315526888, 42026.57973420349, 42538.57461425346, 27236.455270894076, 28408.090155981296, 34578.61685532651, 36410.27179456449, 37173.6282637181, 31256.843715781277, 31431.842840785648, 35222.82388588143, 35738.463923040654, 36523.634763653085, 31616.525752113277, 33814.0, 36172.81913590415, 37071.81464092662, 38272.42591361188, 30417.0, 31219.84390078126, 31277.06168814939, 31289.904853330023, 31420.528692070093, 23312.184073557342, 24356.75643243616, 24410.51178976446, 24427.75572244326, 25264.89802421916], "value": 17830.130445315397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.6757315696401, 391.90267251695246, 392.3643697210518, 399.39491670119776, 407.7634971716401, 18757.906210468947, 20352.69470957933, 20753.896230518865, 20792.37622871316, 20804.271850485235, 19451.31920382787, 19638.116284767184, 19747.308844190455, 20716.378508644764, 21079.6838047429, 5587.552995760329, 5706.514946229565, 5881.705914704247, 5890.528757699395, 5939.406059394069, 5661.377248502661, 5707.571932105088, 5723.341815691187, 5745.6265342752795, 5768.250127483421, 5465.9180112298345, 5698.629589076697, 5833.533317334603, 5844.357120716718, 5848.093545500433, 5713.3429655589725, 5742.483176514133, 5761.9135712964335, 5770.394108618598, 5838.153467747175, 5035.093683137034, 5110.718910459923, 5112.386513618352, 5133.358330208724, 5134.897302053975, 25027.374315642253, 25279.11523096683, 25340.23979280606, 25360.87319563409, 25586.0, 1926.566522532433, 2161.958829730894, 2261.8642881427168, 2414.7343792182846, 2416.3808955817235, 14544.418223271057, 14576.416943322254, 14910.925445372812, 15064.924675376662, 15114.0, 1702.0383483331877, 1704.3779020657494, 1743.2939659437948, 1750.9824901751074, 1803.8376546110783, 102835.48582257115, 106347.40478892822, 106404.46797766039, 107159.46420267927, 107578.0, 10574.312669676447, 10659.680209593724, 10740.409277489813, 10965.56137754481, 11062.778744425228, 11573.537058517733, 13795.310234488436, 13905.304734763222, 13988.58034258974, 14014.649633759034, 8426.620802063922, 8440.915590844135, 8572.399932004824, 8584.957075214585, 8670.176333248332, 8279.54462504568, 8468.872966905501, 8480.0, 8545.700900468453, 8604.698835540727, 5573.442655734475, 6544.640044797487, 6664.133662623828, 6682.599044057372, 6682.732690692415, 1836.8622353323553, 1869.793982881034, 1893.4508992392052, 1900.667383207933, 1940.379078694804, 938.1650331205233, 950.9429434233969, 979.3242662562809, 1007.6070332570304, 1052.6157952347337, 20147.597048058957, 20206.494837629176, 20346.0, 20565.38303850887, 20608.072636731384, 1009.152312057875, 1024.1908891975404, 1075.9246852720235, 1095.8191898336845, 1143.731223162556, 10700.678979630624, 11024.834627480594, 11093.278936869077, 11105.056070233959, 11176.776464470666, 609128.0, 611626.0, 622061.0, 624540.0, 633142.0, 79369.0, 102544.0, 107949.0, 111330.0, 112304.43847780708, 991.8859331177007, 1026.743314171457, 1029.1818004686443, 1038.314712289885, 1045.6758404894506, 18369.81630183681, 18559.25762969466, 18694.0, 18709.8774073556, 18822.341218057303, 43120.78439607782, 44687.77656111699, 45362.546374535836, 45385.999999998676, 45796.08407831758, 53761.0, 63940.0, 65035.67482162559, 65642.67178664076, 65883.67058164679, 7413.555186688816, 7531.924680753342, 7580.583067931096, 7673.501222420525, 7763.378929685725, 9326.95336523313, 12073.11903039969, 12123.393830308272, 12212.57255996036, 12227.69430764238, 9576.377535460173, 10225.590976360862, 10476.94761526218, 10528.0, 10585.417802020962, 10224.846627300447, 10352.741181470523, 10406.947965260126, 10411.11505522039, 10600.04599586041, 10571.735706607089, 10610.204234682584, 10945.069669077899, 10996.615118470816, 11015.228933974546, 7549.6225188739245, 7584.696612135453, 7758.0, 7822.647980840762, 7890.763277101696, 10399.94800025995, 10503.632372866912, 10623.946880265548, 10728.302660327054, 10757.569697212024], "value": 9428.181212054536, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1612.048891154219, 1625.53672203422, 1873.9906300468497, 1944.77323464633, 1951.0829909942322, 7313.524620899644, 8082.91917080829, 8405.201505856941, 8641.956790216056, 9020.864687029693, 8653.56732163391, 8705.608247628856, 8732.738017859458, 8822.338324625647, 8832.955835220815, 2409.7469765674614, 2429.2469334506313, 2433.5862903306393, 2441.2554170977846, 2448.5470188015274, 2422.0553983946274, 2425.126954296452, 2453.141400509825, 2465.580851255291, 2470.407102295445, 2418.5404773093055, 2446.4617784087563, 2447.363685441789, 2449.6692946452267, 2472.418981539337, 2434.026389444228, 2443.4013666651695, 2443.4135807406274, 2444.59664155415, 2465.6794616699895, 2432.2824766693866, 2434.866082365469, 2443.8655873926928, 2446.1805295226122, 2455.287966489716, 8843.469391836446, 8944.8658270126, 8978.0, 8990.05604411534, 8993.460392376479, 4668.486466488684, 5327.547158491533, 5485.314335708036, 5489.807856724996, 5551.666899985973, 3500.474928760681, 3557.146284891633, 3585.6593623605977, 3619.8733044343585, 3627.3470775260444, 1014.8021135878433, 1018.2464975917842, 1040.8022475729588, 1052.431686889079, 1075.940198904079, 10266.076053155177, 11188.552457901675, 11551.480183391683, 11624.535018599247, 11725.472353744102, 4727.101850648366, 4834.492378300298, 4864.124457597666, 4928.260760885896, 4949.232868905326, 9959.103680668775, 10040.046195611405, 10044.949775251076, 10066.094051535398, 10080.941501142275, 5366.436524164985, 5391.191321301836, 5457.781688732485, 5462.562994960394, 5478.150886612581, 4349.391085248068, 4773.11697335994, 4887.73117478535, 4956.033573453215, 4956.281339205795, 3956.8615098471414, 4022.3765316375425, 4065.0243941453837, 4090.4886889138857, 4160.209560183555, 1327.4424741608548, 1349.8380194376737, 1369.9726005479833, 1370.9177449353072, 1384.0865029080758, 914.3279689428265, 914.6067191107887, 931.855562387831, 946.2713710443059, 972.9367591106555, 5981.581289309794, 6023.518118550505, 6078.240219972504, 6092.1775560299675, 6133.907991380132, 439.28835286835533, 440.44943820224717, 442.0187184450515, 443.87349605362317, 444.426689570457, 3974.8012599370495, 3975.8807235782974, 3989.840406383712, 4021.557628660845, 4066.3290557057753, 10630.787384252271, 11006.339619622848, 11010.0, 11024.669259922215, 11107.44462776874, 10453.163746900229, 10915.399653019002, 10942.17933654979, 10973.83539246912, 11015.614453494249, 7004.754833580801, 8104.351651867836, 8297.626606802709, 8302.211289927447, 8323.625436855235, 5910.0, 5960.1357803117435, 6002.429769171922, 6136.7852125175405, 6222.439980401786, 8213.876791848008, 9447.574859131219, 10102.595896164365, 10155.695329140137, 10275.640352587623, 10047.145992590711, 10120.342177758423, 10123.848142278019, 10127.341722787995, 10171.64399246023, 6857.862842743018, 6949.930500694928, 7333.596652184181, 7455.291747283999, 7620.085589729268, 8045.356371490384, 8128.105908349959, 8130.983627046619, 8134.349252059703, 8174.468659537111, 7133.357997780225, 7134.32223938725, 7252.927470725225, 7387.593682347308, 7389.889151662837, 7064.576125432491, 7218.711251549879, 7255.310745479383, 7287.2348403419, 7536.547807131589, 6188.504919606331, 6873.48448866327, 7001.299870012958, 7072.893906591508, 7081.858362832818, 4838.395200599925, 4904.141775189256, 4920.901581968412, 4980.576650984707, 5061.8734531637, 4221.91556168881, 4745.193317136026, 4768.165571025126, 4936.691776679111, 4967.285219273413], "value": 4538.738393945056, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.8753123688052, 319.96160460744704, 329.1770573566085, 330.96028476582813, 332.58260882592344, 6066.241719785027, 6098.085287206921, 6248.781292654758, 6273.968630156848, 6301.683346907366, 4748.928766068511, 5721.166818231784, 6120.908186377197, 6212.720427580758, 6226.283977342607, 4021.557628660845, 4033.2135233629456, 4622.699524530912, 4644.814207431698, 4658.604018658401, 4447.733136011833, 4643.330085201006, 4652.906566956763, 4663.300504924255, 4664.97667511662, 4540.79566419512, 4575.885602859922, 4597.770111494428, 4611.654125940551, 4623.214053610895, 4614.238650622643, 4654.348391225231, 4658.0, 4663.440387153546, 4676.766161691936, 3787.715921305913, 3956.5647778744315, 3960.841566337343, 3992.48097747291, 3998.020484981198, 5931.406859314034, 5946.413310210072, 5971.253593300838, 5981.325228935905, 5999.640021598718, 4731.787069581877, 4794.688345257582, 5383.084875571162, 5433.891322173535, 5441.646292990943, 5016.065601623055, 5624.775008999635, 6285.025820997753, 6439.517036222255, 6607.240167380764, 4236.597523235288, 4245.0236445617375, 4267.594578515036, 4271.765052922088, 4312.956870431318, 5745.3105627324985, 6454.548181627288, 6568.63872487013, 6596.109525214083, 6698.93301066988, 3333.9664703941858, 3995.2409042281874, 4275.166342563232, 4284.186004659105, 4319.740815551077, 3692.630736926286, 4212.262854000599, 4376.343548467756, 4382.824687012548, 4392.0, 4547.272436410159, 4945.480724523945, 5152.639315247897, 5163.380394352702, 5169.302144210558, 5494.36814766299, 6403.135576697086, 6486.837829054217, 6518.543701940914, 6547.214334279917, 1519.55173223897, 1532.7547592385165, 1534.2022148482727, 1536.0, 1537.1392020468572, 980.9215262778961, 990.4255531791688, 1000.7898341348252, 1005.2912696548915, 1017.9134773544183, 5202.869928251824, 5939.13882487037, 6153.230846144232, 6206.844828879224, 6229.719662615194, 6845.8973115403305, 6852.828679283058, 6880.2431732509385, 6911.680199875078, 6931.202911665122, 4990.6506544541535, 5112.9744351278005, 6182.567220294536, 6189.876202476015, 6193.597416167935, 3594.5866225384416, 3641.890743277706, 3653.0867283179205, 3659.1949771050326, 3671.7796932184156, 6105.34915463626, 6716.059751634775, 6756.9188929771, 7180.461465390013, 7214.494985350975, 6721.495887808336, 7063.540869843444, 7069.116360454943, 7079.504434689626, 7101.538400003983, 5854.818485640154, 6838.7264509419065, 6949.409300209539, 7094.92905070953, 7181.928180718126, 5748.45389687979, 5838.883222335615, 6820.35206655367, 6851.972204169415, 6942.548734332252, 6019.458248757458, 6209.875802484015, 6754.290799465985, 6844.8288792778585, 6868.62222577763, 7121.287871213044, 7155.356017958408, 7169.4981351304905, 7189.496735228484, 7235.674394652148, 4420.359047937966, 4428.4243048403505, 4436.378906952965, 4448.7108337957925, 4450.777461126995, 5830.883382332415, 6557.2131344239, 6589.538732288694, 6838.760643377458, 6931.851126150707, 5926.7925622603, 6131.785387511594, 6732.528722989344, 6740.528163028737, 6771.458283337222, 5946.405359464019, 6378.52161087911, 6446.516511261768, 6738.9554619034125, 6770.796876093725, 5881.941180588139, 5938.851528711817, 6322.557420980487, 6490.896547586827, 6625.370589793962, 5582.804601838916, 5885.676287804041, 6297.55917085818, 6715.597064176165, 6775.356341147583, 5702.002149623716, 5703.859228154469, 6142.262928448615, 6441.3880681335195, 6570.310117437792], "value": 4730.51970513925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.6990854115652, 689.8344397344639, 731.2431633259577, 736.4071922102709, 753.3220101908282, 12315.38423078847, 14091.647708807284, 15131.621709457282, 15275.618109547238, 15321.233938303096, 10249.84625230622, 11717.0, 14024.439022439115, 14343.354549045293, 14374.353154108065, 718.7735863203101, 894.575076838503, 903.8508646073407, 916.7112359606735, 917.6742256498947, 869.2698133567802, 870.899846517649, 874.8337815815007, 902.057350069176, 920.1810388754014, 923.487464457226, 931.3480563605469, 958.2286259561085, 960.9951950240239, 970.0832713086137, 916.9816603667889, 934.6775362499926, 946.46997681298, 954.1031430455349, 966.4153187321674, 690.2476300832117, 691.7509696509253, 697.2643860726931, 715.7709532949458, 718.6299055986171, 15309.234538273153, 15349.079055256609, 15364.462243821412, 15436.38254469831, 15526.922365388215, 12930.676733081655, 12958.0, 13048.673783155402, 13073.803892941614, 13293.0, 10314.79370412595, 10334.586616535329, 10373.170146388271, 10489.423081730502, 10711.036006759428, 3163.1459505933267, 3474.322507111114, 3532.452469867175, 3576.6423357664285, 3638.5451818522683, 89550.0, 90054.0, 90250.5487472565, 90644.54677726635, 91927.08072919252, 9088.363814532919, 9218.308626853013, 9394.671186508576, 9434.716958491119, 9999.35004224723, 21292.25477108294, 21867.0, 21940.89029554842, 21957.67063494049, 21983.0, 7590.7722768317035, 7654.349380302737, 7684.231576842383, 7732.806679833049, 7754.651040703069, 3988.541317748438, 4040.070783719761, 4067.898302542401, 4075.1645912587846, 4084.448599439097, 3540.4335306351377, 3678.3930651442747, 3681.7790932544135, 3687.723420743455, 3811.8856434307013, 681.1417613806541, 683.0300972618893, 686.7012849410522, 689.3898899474002, 698.1029377250209, 567.2002476508104, 588.5850475414823, 590.9497692696083, 598.7305712429425, 623.8939380305359, 7807.882881756778, 8090.797730056795, 8148.837023259502, 8204.671813127527, 8392.580370981426, 481.41267653462717, 494.9704614402035, 563.5632384901652, 589.104561067184, 603.6287683074966, 3125.7809454312837, 3850.0374906273432, 3886.300465916162, 3957.3272543667645, 4077.510698716114, 73821.0, 95301.0, 97320.0, 98872.0, 99120.0, 78636.60681696555, 80719.19280807117, 83598.5820070908, 83845.0, 84127.5793621028, 73034.0, 73422.63288683629, 73519.0, 73548.0, 74192.25807741853, 7530.134034585873, 7578.0, 7709.790988903435, 7777.650005749641, 7810.984572005603, 43796.0, 44306.0, 44476.77761611301, 44538.10923781442, 45186.09627807491, 47967.04065918732, 62080.75838483295, 62369.0, 62859.05711414424, 63426.68286658537, 9404.01257867914, 9538.380005299634, 9721.56252968604, 9975.301728878909, 10748.946255268986, 11800.52797888075, 12350.258984460961, 12465.813012804634, 12577.811332830199, 13068.934655326662, 10243.282970192015, 11266.549338026387, 11560.30638161713, 11681.532738690697, 12070.939645301718, 11363.829542556703, 11529.135314851252, 11537.653870383901, 11962.76074478523, 12092.093093018235, 8475.0, 8781.648734050566, 8976.55117244122, 10544.57821687124, 10625.734356641145, 9402.34183607141, 9467.195288400288, 9613.0, 9904.25718071162, 10349.86151523347, 7992.480488768444, 8361.390862392014, 9798.216142708709, 9798.51007449639, 9868.210543156674], "value": 6832.735451680921, "unit": "score"}], "name": "dromaeo_css", "value": 7210.106253457188, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 110.0, 123.0, 118.0, 117.0, 129.0, 116.0, 117.0, 118.0, 119.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 155.0, 190.0, 165.0, 118.0, 142.0, 145.0, 122.0, 169.0, 123.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 201.0, 204.0, 208.0, 248.0, 285.0, 246.0, 203.0, 202.0, 198.0], "value": 219.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 81.0, 74.0, 138.0, 58.0, 55.0, 58.0, 63.0, 131.0, 58.0], "value": 78.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 134.0, 78.0, 83.0, 82.0, 119.0, 83.0, 79.0, 118.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 89.0, 87.0, 90.0, 86.0, 90.0, 86.0, 89.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 94.0, 97.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 93.0, 91.0, 96.0, 92.0, 90.0, 111.0, 143.0, 114.0], "value": 101.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 80.0, 69.0, 79.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 69.0, 71.0, 73.0, 74.0, 68.0, 68.0, 71.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 90.0, 89.0, 89.0, 89.0, 90.0, 83.0, 102.0, 113.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 136.0, 181.0, 163.0, 154.0, 157.0, 164.0, 163.0, 226.0, 173.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 169.0, 166.0, 176.0, 176.0, 172.0, 178.0, 174.0, 173.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 88.0, 97.0, 104.0, 95.0, 75.0, 70.0, 69.0, 73.0], "value": 81.7, "unit": "score"}], "name": "kraken", "value": 1596.5000000000005, "alertThreshold": 2.0}]} 11:41:14 INFO - Return code: 0 11:41:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:41:14 ERROR - # TBPL SUCCESS # 11:41:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:41:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:41:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:41:14 INFO - 2016-04-14 11:41:14.667 screenresolution[2393:34475] starting screenresolution argv=screenresolution get 11:41:14 INFO - 2016-04-14 11:41:14.670 screenresolution[2393:34475] Display 0: 1600x1200x32@60 11:41:14 INFO - 2016-04-14 11:41:14.676 screenresolution[2394:34478] starting screenresolution argv=screenresolution list 11:41:14 INFO - Available Modes on Display 0 11:41:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:41:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:41:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:41:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:41:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:41:14 INFO - Intel Iris: 11:41:14 INFO - Chipset Model: Intel Iris 11:41:14 INFO - Type: GPU 11:41:14 INFO - Bus: Built-In 11:41:14 INFO - VRAM (Dynamic, Max): 1536 MB 11:41:14 INFO - Vendor: Intel (0x8086) 11:41:14 INFO - Device ID: 0x0a2e 11:41:14 INFO - Revision ID: 0x0009 11:41:14 INFO - Displays: 11:41:14 INFO - Display: 11:41:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:41:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:41:14 INFO - Display Serial Number: 1600x1200 60 11:41:14 INFO - Main Display: Yes 11:41:14 INFO - Mirror: Off 11:41:14 INFO - Online: Yes 11:41:14 INFO - Rotation: Supported 11:41:14 INFO - Return code: 0 11:41:14 INFO - Running post-action listener: _resource_record_post_action 11:41:14 INFO - Running post-run listener: _resource_record_post_run 11:41:15 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 671744; Write bytes: 694815744; Read time: 6; Write time: 2087 11:41:15 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 370850304; Write bytes: 366671872; Read time: 28161; Write time: 703 11:41:15 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 671744; Write bytes: 297837568; Read time: 6; Write time: 1326 11:41:15 INFO - Running post-run listener: _upload_blobber_files 11:41:15 INFO - Blob upload gear active. 11:41:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:15 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 11:41:15 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:41:15 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:41:16 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:41:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:41:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:17 INFO - (blobuploader) - INFO - Done attempting. 11:41:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:41:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:41:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:18 INFO - (blobuploader) - INFO - Done attempting. 11:41:18 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:18 INFO - Return code: 0 11:41:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc633b3c7757943ef8bcb961bad329ac86c4ee572eb21d2e96dceb61b220f9ddf2b684ceb8483c3a55e392985b956e46ef1259607813ec5bdb9e9be02ea6b11d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2281176bf6809c8b17828d271361b4e93e57a5da429a35d9edbb3826770fe1c810fe7e7ec35aec257c198009a1210072ffbefbdf957dc10b48aa6111e9f640ce"} 11:41:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:18 INFO - Contents: 11:41:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc633b3c7757943ef8bcb961bad329ac86c4ee572eb21d2e96dceb61b220f9ddf2b684ceb8483c3a55e392985b956e46ef1259607813ec5bdb9e9be02ea6b11d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2281176bf6809c8b17828d271361b4e93e57a5da429a35d9edbb3826770fe1c810fe7e7ec35aec257c198009a1210072ffbefbdf957dc10b48aa6111e9f640ce"} 11:41:18 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:18 INFO - Copying logs to upload dir... 11:41:18 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.735783 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-14 11:41:18.870870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 11:41:18.874546) ========= 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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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/Fx-Team/sha512/fc633b3c7757943ef8bcb961bad329ac86c4ee572eb21d2e96dceb61b220f9ddf2b684ceb8483c3a55e392985b956e46ef1259607813ec5bdb9e9be02ea6b11d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2281176bf6809c8b17828d271361b4e93e57a5da429a35d9edbb3826770fe1c810fe7e7ec35aec257c198009a1210072ffbefbdf957dc10b48aa6111e9f640ce"} build_url:https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010934 build_url: 'https://queue.taskcluster.net/v1/task/UmpfgIETR_avNFK2YIesLQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc633b3c7757943ef8bcb961bad329ac86c4ee572eb21d2e96dceb61b220f9ddf2b684ceb8483c3a55e392985b956e46ef1259607813ec5bdb9e9be02ea6b11d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2281176bf6809c8b17828d271361b4e93e57a5da429a35d9edbb3826770fe1c810fe7e7ec35aec257c198009a1210072ffbefbdf957dc10b48aa6111e9f640ce"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 11:41:18.991336) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 11:41:18.991631) ========= 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.2JyMRI2OuV/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.i5QOkgFNXG/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005310 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 11:41:19.039350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 11:41:19.039666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 11:41:19.041303) ========= ========= Total master_lag: 7.90 =========