builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0214 starttime: 1467973271.1 results: success (0) buildid: 20160708021326 builduid: 42396063891c4889bb337833f7f3e65f revision: 75b9cc8259df0aca3d93c4b44155a77875341a14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:11.097594) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:11.102795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:11.103101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:11.125847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:11.126222) ========= 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.dkL9IhdftA/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.v01mzz2rwq/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-08 03:21:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-07-08 03:21:11 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171088 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:11.325699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:11.326155) ========= 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.dkL9IhdftA/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.v01mzz2rwq/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.019954 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:11.374749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-08 03:21:11.375062) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 75b9cc8259df0aca3d93c4b44155a77875341a14 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 75b9cc8259df0aca3d93c4b44155a77875341a14 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dkL9IhdftA/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.v01mzz2rwq/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-08 03:21:11,455 truncating revision to first 12 chars 2016-07-08 03:21:11,455 Setting DEBUG logging. 2016-07-08 03:21:11,455 attempt 1/10 2016-07-08 03:21:11,455 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/75b9cc8259df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 03:21:13,597 unpacking tar archive at: mozilla-beta-75b9cc8259df/testing/mozharness/ program finished with exit code 0 elapsedTime=2.419519 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-08 03:21:13.816180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:13.816500) ========= script_repo_revision: 75b9cc8259df0aca3d93c4b44155a77875341a14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:13.816945) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:13.817299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:13.836359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-07-08 03:21:13.836761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dkL9IhdftA/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.v01mzz2rwq/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 03:21:14 INFO - MultiFileLogger online at 20160708 03:21:14 in /builds/slave/test 03:21:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:21:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:21:14 INFO - {'append_to_log': False, 03:21:14 INFO - 'base_work_dir': '/builds/slave/test', 03:21:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:21:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:21:14 INFO - 'branch': 'Mozilla-Beta', 03:21:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:14 INFO - 'config_files': ('talos/mac_config.py',), 03:21:14 INFO - 'default_actions': ('clobber', 03:21:14 INFO - 'read-buildbot-config', 03:21:14 INFO - 'download-and-extract', 03:21:14 INFO - 'populate-webroot', 03:21:14 INFO - 'create-virtualenv', 03:21:14 INFO - 'install', 03:21:14 INFO - 'run-tests'), 03:21:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:14 INFO - 'download_minidump_stackwalk': True, 03:21:14 INFO - 'download_symbols': 'ondemand', 03:21:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:14 INFO - 'installer_path': 'installer.exe', 03:21:14 INFO - 'log_level': 'info', 03:21:14 INFO - 'log_name': 'talos', 03:21:14 INFO - 'log_to_console': True, 03:21:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:21:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:21:14 INFO - 'opt_config_files': (), 03:21:14 INFO - 'pip_index': False, 03:21:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:21:14 INFO - 'cmd': ('bash', 03:21:14 INFO - '-c', 03:21:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:21:14 INFO - 'enabled': True, 03:21:14 INFO - 'halt_on_failure': False, 03:21:14 INFO - 'name': 'check_screen_resolution'},), 03:21:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:21:14 INFO - 'cmd': ('bash', 03:21:14 INFO - '-c', 03:21:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:21:14 INFO - 'enabled': True, 03:21:14 INFO - 'halt_on_failure': False, 03:21:14 INFO - 'name': 'check_screen_resolution'},), 03:21:14 INFO - 'run_cmd_checks_enabled': True, 03:21:14 INFO - 'sps_profile': False, 03:21:14 INFO - 'sps_profile_interval': 0, 03:21:14 INFO - 'suite': 'dromaeojs-e10s', 03:21:14 INFO - 'system_bits': '32', 03:21:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:14 INFO - 'title': 't-yosemite-r7-0214', 03:21:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:14 INFO - 'use_talos_json': True, 03:21:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:21:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:14 INFO - 'work_dir': 'build'} 03:21:14 INFO - ##### 03:21:14 INFO - ##### Running clobber step. 03:21:14 INFO - ##### 03:21:14 INFO - Running pre-action listener: _resource_record_pre_action 03:21:14 INFO - Running main action method: clobber 03:21:14 INFO - rmtree: /builds/slave/test/build 03:21:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:21:15 INFO - Running post-action listener: _resource_record_post_action 03:21:15 INFO - ##### 03:21:15 INFO - ##### Running read-buildbot-config step. 03:21:15 INFO - ##### 03:21:15 INFO - Running pre-action listener: _resource_record_pre_action 03:21:15 INFO - Running main action method: read_buildbot_config 03:21:15 INFO - Using buildbot properties: 03:21:15 INFO - { 03:21:15 INFO - "project": "", 03:21:15 INFO - "product": "firefox", 03:21:15 INFO - "script_repo_revision": "production", 03:21:15 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 03:21:15 INFO - "repository": "", 03:21:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 03:21:15 INFO - "buildid": "20160708021326", 03:21:15 INFO - "pgo_build": "False", 03:21:15 INFO - "basedir": "/builds/slave/test", 03:21:15 INFO - "buildnumber": 57, 03:21:15 INFO - "slavename": "t-yosemite-r7-0214", 03:21:15 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:21:15 INFO - "platform": "yosemite_r7", 03:21:15 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 03:21:15 INFO - "branch": "mozilla-beta", 03:21:15 INFO - "repo_path": "releases/mozilla-beta", 03:21:15 INFO - "revision": "75b9cc8259df0aca3d93c4b44155a77875341a14", 03:21:15 INFO - "stage_platform": "macosx64", 03:21:15 INFO - "builduid": "42396063891c4889bb337833f7f3e65f", 03:21:15 INFO - "slavebuilddir": "test" 03:21:15 INFO - } 03:21:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 03:21:15 INFO - Running post-action listener: _resource_record_post_action 03:21:15 INFO - ##### 03:21:15 INFO - ##### Running download-and-extract step. 03:21:15 INFO - ##### 03:21:15 INFO - Running pre-action listener: _resource_record_pre_action 03:21:15 INFO - Running main action method: download_and_extract 03:21:15 INFO - mkdir: /builds/slave/test/build/tests 03:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:15 INFO - https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:21:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 03:21:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 03:21:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 03:21:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 03:21:25 INFO - Downloaded 1165 bytes. 03:21:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 03:21:25 INFO - Using the following test package requirements: 03:21:25 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 03:21:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:25 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 03:21:25 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:25 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 03:21:25 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 03:21:25 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:25 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 03:21:25 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 03:21:25 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:25 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 03:21:25 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:25 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 03:21:25 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:25 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 03:21:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:25 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 03:21:25 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 03:21:25 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')]} 03:21:25 INFO - https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 03:21:32 INFO - Downloaded 18351477 bytes. 03:21:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:21:35 INFO - Return code: 0 03:21:35 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 03:21:35 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')]} 03:21:35 INFO - https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:21:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 03:21:43 INFO - Downloaded 18351477 bytes. 03:21:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:21:47 INFO - Return code: 0 03:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:47 INFO - https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:21:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 03:21:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 03:21:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 03:21:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 03:21:48 INFO - Downloaded 10840145 bytes. 03:21:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:21:48 INFO - Return code: 0 03:21: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')]} 03:21:48 INFO - https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 03:21:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:21:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:21:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 03:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 03:21:50 INFO - Downloaded 86184205 bytes. 03:21:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:21:50 INFO - mkdir: /builds/slave/test/properties 03:21:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:21:50 INFO - Writing to file /builds/slave/test/properties/build_url 03:21:50 INFO - Contents: 03:21:50 INFO - build_url:https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:21:51 INFO - Running post-action listener: _resource_record_post_action 03:21:51 INFO - Running post-action listener: set_extra_try_arguments 03:21:51 INFO - ##### 03:21:51 INFO - ##### Running populate-webroot step. 03:21:51 INFO - ##### 03:21:51 INFO - Running pre-action listener: _resource_record_pre_action 03:21:51 INFO - Running main action method: populate_webroot 03:21:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:21:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:21:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:21:51 INFO - '--tppagecycles', 03:21:51 INFO - '7'], 03:21:51 INFO - 'tests': ['tsvgm']}}, 03:21:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:21:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:21:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:21:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:21:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:21:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:21:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:51 INFO - 'talos_options': ['--disable-e10s'], 03:21:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:51 INFO - 'talos_options': ['--disable-e10s'], 03:21:51 INFO - 'tests': ['damp', 'tps']}, 03:21:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:51 INFO - 'tests': ['damp', 'tps']}, 03:21:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:21:51 INFO - 'tests': ['dromaeo_dom']}, 03:21:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:21:51 INFO - 'tests': ['a11yr', 03:21:51 INFO - 'ts_paint', 03:21:51 INFO - 'tpaint', 03:21:51 INFO - 'sessionrestore', 03:21:51 INFO - 'sessionrestore_no_auto_restore', 03:21:51 INFO - 'tabpaint']}, 03:21:51 INFO - 'other-e10s': {'tests': ['a11yr', 03:21:51 INFO - 'ts_paint', 03:21:51 INFO - 'tpaint', 03:21:51 INFO - 'sessionrestore', 03:21:51 INFO - 'sessionrestore_no_auto_restore', 03:21:51 INFO - 'tabpaint']}, 03:21:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:21:51 INFO - 'ts_paint', 03:21:51 INFO - 'tpaint', 03:21:51 INFO - 'sessionrestore', 03:21:51 INFO - 'sessionrestore_no_auto_restore', 03:21:51 INFO - 'tabpaint']}, 03:21:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:21:51 INFO - 'ts_paint', 03:21:51 INFO - 'tpaint', 03:21:51 INFO - 'sessionrestore', 03:21:51 INFO - 'sessionrestore_no_auto_restore', 03:21:51 INFO - 'tabpaint']}, 03:21:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:21:51 INFO - 'tests': ['a11yr', 03:21:51 INFO - 'ts_paint', 03:21:51 INFO - 'tpaint', 03:21:51 INFO - 'sessionrestore', 03:21:51 INFO - 'sessionrestore_no_auto_restore', 03:21:51 INFO - 'tabpaint']}, 03:21:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:21:51 INFO - 'tests': ['a11yr', 03:21:51 INFO - 'ts_paint', 03:21:51 INFO - 'tpaint', 03:21:51 INFO - 'sessionrestore', 03:21:51 INFO - 'sessionrestore_no_auto_restore', 03:21:51 INFO - 'tabpaint']}, 03:21:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:21:51 INFO - 'tests': ['tsvgx', 03:21:51 INFO - 'tsvgr_opacity', 03:21:51 INFO - 'tart', 03:21:51 INFO - 'tscrollx', 03:21:51 INFO - 'cart']}, 03:21:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:21:51 INFO - 'tsvgr_opacity', 03:21:51 INFO - 'tart', 03:21:51 INFO - 'tscrollx', 03:21:51 INFO - 'cart']}, 03:21:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:51 INFO - 'talos_options': ['--disable-e10s'], 03:21:51 INFO - 'tests': ['tp5o']}, 03:21:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:51 INFO - 'tests': ['tp5o']}, 03:21:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:51 INFO - 'talos_options': ['--disable-e10s', 03:21:51 INFO - '--xperf_path', 03:21:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:51 INFO - 'tests': ['tp5n']}, 03:21:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:51 INFO - 'talos_options': ['--xperf_path', 03:21:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:51 INFO - 'tests': ['tp5n']}}, 03:21:51 INFO - 'talos.zip': {'path': '', 03:21:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:21:51 INFO - Running post-action listener: _resource_record_post_action 03:21:51 INFO - ##### 03:21:51 INFO - ##### Running create-virtualenv step. 03:21:51 INFO - ##### 03:21:51 INFO - Running pre-action listener: _resource_record_pre_action 03:21:51 INFO - Running main action method: create_virtualenv 03:21:51 INFO - Creating virtualenv /builds/slave/test/build/venv 03:21:51 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 03:21:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:21:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:52 INFO - Using real prefix '/tools/python27' 03:21:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:21:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:55 INFO - Installing pip.................done. 03:21:55 INFO - Return code: 0 03:21:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f15ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f16c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994bcb5070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10effbe00>, '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 0x10ee64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6b20>, '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.dkL9IhdftA/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.v01mzz2rwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 03:21:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:21:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkL9IhdftA/Render', 03:21:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:55 INFO - 'HOME': '/Users/cltbld', 03:21:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:55 INFO - 'LOGNAME': 'cltbld', 03:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:55 INFO - 'MOZ_NO_REMOTE': '1', 03:21:55 INFO - 'NO_EM_RESTART': '1', 03:21:55 INFO - 'PAGER': '/bin/cat', 03:21:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:55 INFO - 'PWD': '/builds/slave/test', 03:21:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:55 INFO - 'SHELL': '/bin/bash', 03:21:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v01mzz2rwq/Listeners', 03:21:55 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 03:21:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:55 INFO - 'USER': 'cltbld', 03:21:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:55 INFO - 'XPC_FLAGS': '0x0', 03:21:55 INFO - 'XPC_SERVICE_NAME': '0', 03:21:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:55 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 03:21:55 INFO - Cleaning up... 03:21:55 INFO - Return code: 0 03:21:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f15ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f16c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994bcb5070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10effbe00>, '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 0x10ee64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6b20>, '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.dkL9IhdftA/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.v01mzz2rwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 03:21:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:21:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkL9IhdftA/Render', 03:21:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:55 INFO - 'HOME': '/Users/cltbld', 03:21:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:55 INFO - 'LOGNAME': 'cltbld', 03:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:55 INFO - 'MOZ_NO_REMOTE': '1', 03:21:55 INFO - 'NO_EM_RESTART': '1', 03:21:55 INFO - 'PAGER': '/bin/cat', 03:21:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:55 INFO - 'PWD': '/builds/slave/test', 03:21:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:55 INFO - 'SHELL': '/bin/bash', 03:21:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v01mzz2rwq/Listeners', 03:21:55 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 03:21:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:55 INFO - 'USER': 'cltbld', 03:21:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:55 INFO - 'XPC_FLAGS': '0x0', 03:21:55 INFO - 'XPC_SERVICE_NAME': '0', 03:21:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:56 INFO - Downloading/unpacking psutil>=0.7.1 03:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:59 INFO - Installing collected packages: psutil 03:21:59 INFO - Running setup.py install for psutil 03:21:59 INFO - building 'psutil._psutil_osx' extension 03:21:59 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 03:22:00 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 03:22:00 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 03:22:00 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 03:22:00 INFO - building 'psutil._psutil_posix' extension 03:22:00 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 03:22:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:22:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:22:00 INFO - ^ 03:22:00 INFO - 1 warning generated. 03:22:00 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 03:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:00 INFO - Successfully installed psutil 03:22:00 INFO - Cleaning up... 03:22:00 INFO - Return code: 0 03:22:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:22:00 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')]} 03:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:00 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')]} 03:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:00 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 0x10f15ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f16c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994bcb5070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10effbe00>, '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 0x10ee64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6b20>, '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.dkL9IhdftA/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.v01mzz2rwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 03:22:00 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 03:22:00 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 03:22:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkL9IhdftA/Render', 03:22:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:00 INFO - 'HOME': '/Users/cltbld', 03:22:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:00 INFO - 'LOGNAME': 'cltbld', 03:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:00 INFO - 'MOZ_NO_REMOTE': '1', 03:22:00 INFO - 'NO_EM_RESTART': '1', 03:22:00 INFO - 'PAGER': '/bin/cat', 03:22:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:00 INFO - 'PWD': '/builds/slave/test', 03:22:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:00 INFO - 'SHELL': '/bin/bash', 03:22:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v01mzz2rwq/Listeners', 03:22:00 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 03:22:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:00 INFO - 'USER': 'cltbld', 03:22:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:00 INFO - 'XPC_FLAGS': '0x0', 03:22:00 INFO - 'XPC_SERVICE_NAME': '0', 03:22:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:22:00 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 03:22:00 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 03:22:00 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 03:22:00 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 03:22:00 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 03:22:00 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 03:22:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:22:03 INFO - Installing collected packages: mozsystemmonitor 03:22:03 INFO - Running setup.py install for mozsystemmonitor 03:22:03 INFO - Successfully installed mozsystemmonitor 03:22:03 INFO - Cleaning up... 03:22:03 INFO - Return code: 0 03:22:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:03 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 0x10f15ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f16c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994bcb5070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10effbe00>, '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 0x10ee64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6b20>, '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.dkL9IhdftA/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.v01mzz2rwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 03:22:03 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 03:22:03 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 03:22:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkL9IhdftA/Render', 03:22:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:03 INFO - 'HOME': '/Users/cltbld', 03:22:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:03 INFO - 'LOGNAME': 'cltbld', 03:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:03 INFO - 'MOZ_NO_REMOTE': '1', 03:22:03 INFO - 'NO_EM_RESTART': '1', 03:22:03 INFO - 'PAGER': '/bin/cat', 03:22:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:03 INFO - 'PWD': '/builds/slave/test', 03:22:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:03 INFO - 'SHELL': '/bin/bash', 03:22:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v01mzz2rwq/Listeners', 03:22:03 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 03:22:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:03 INFO - 'USER': 'cltbld', 03:22:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:03 INFO - 'XPC_FLAGS': '0x0', 03:22:03 INFO - 'XPC_SERVICE_NAME': '0', 03:22:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22:06 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 03:22:06 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 03:22:06 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 03:22:06 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 03:22:06 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 03:22:06 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 03:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:22:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22:07 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 03:22:07 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 03:22:07 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 03:22:07 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 03:22:07 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 03:22:07 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 03:22:07 INFO - Downloading docopt-0.6.1.tar.gz 03:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:07 INFO - Running setup.py install for blobuploader 03:22:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:22:07 INFO - Running setup.py install for requests 03:22:08 INFO - Running setup.py install for docopt 03:22:08 INFO - Successfully installed blobuploader requests docopt 03:22:08 INFO - Cleaning up... 03:22:08 INFO - Return code: 0 03:22:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:08 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')]} 03:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:08 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')]} 03:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:08 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 0x10f15ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f16c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994bcb5070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10effbe00>, '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 0x10ee64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6b20>, '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.dkL9IhdftA/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.v01mzz2rwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 03:22:08 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 03:22:08 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 03:22:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkL9IhdftA/Render', 03:22:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:08 INFO - 'HOME': '/Users/cltbld', 03:22:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:08 INFO - 'LOGNAME': 'cltbld', 03:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:08 INFO - 'MOZ_NO_REMOTE': '1', 03:22:08 INFO - 'NO_EM_RESTART': '1', 03:22:08 INFO - 'PAGER': '/bin/cat', 03:22:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:08 INFO - 'PWD': '/builds/slave/test', 03:22:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:08 INFO - 'SHELL': '/bin/bash', 03:22:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v01mzz2rwq/Listeners', 03:22:08 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 03:22:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:08 INFO - 'USER': 'cltbld', 03:22:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:08 INFO - 'XPC_FLAGS': '0x0', 03:22:08 INFO - 'XPC_SERVICE_NAME': '0', 03:22:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:08 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-c7MMR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:08 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-xsEWfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:08 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-yTeom0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:08 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-KdyKTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:09 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-q_Hb4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:09 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-UhVva0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:09 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-V4_ijG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:09 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-WiDDf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:09 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-_TZn4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:09 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-S8E9kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:09 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-MiRE2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:09 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-_Cp3yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:09 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-RD29FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:10 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-TWNxpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:10 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-xnFxIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:10 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-GXtoZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:10 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-j1COko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:22:10 INFO - Running setup.py install for manifestparser 03:22:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:22:10 INFO - Running setup.py install for mozcrash 03:22:10 INFO - Running setup.py install for mozdebug 03:22:10 INFO - Running setup.py install for mozdevice 03:22:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for mozfile 03:22:11 INFO - Running setup.py install for mozhttpd 03:22:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for mozinfo 03:22:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for mozInstall 03:22:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for mozleak 03:22:11 INFO - Running setup.py install for mozlog 03:22:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:22:11 INFO - Running setup.py install for moznetwork 03:22:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:22:12 INFO - Running setup.py install for mozprocess 03:22:12 INFO - Running setup.py install for mozprofile 03:22:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:22:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:22:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:22:12 INFO - Running setup.py install for mozrunner 03:22:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:22:12 INFO - Running setup.py install for mozscreenshot 03:22:12 INFO - Running setup.py install for moztest 03:22:12 INFO - Running setup.py install for mozversion 03:22:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:22:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:22:12 INFO - Cleaning up... 03:22:13 INFO - Return code: 0 03:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:13 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 0x10f15ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f16c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994bcb5070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10effbe00>, '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 0x10ee64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6b20>, '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.dkL9IhdftA/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.v01mzz2rwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 03:22:13 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 03:22:13 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 03:22:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkL9IhdftA/Render', 03:22:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:13 INFO - 'HOME': '/Users/cltbld', 03:22:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:13 INFO - 'LOGNAME': 'cltbld', 03:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:13 INFO - 'MOZ_NO_REMOTE': '1', 03:22:13 INFO - 'NO_EM_RESTART': '1', 03:22:13 INFO - 'PAGER': '/bin/cat', 03:22:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:13 INFO - 'PWD': '/builds/slave/test', 03:22:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:13 INFO - 'SHELL': '/bin/bash', 03:22:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v01mzz2rwq/Listeners', 03:22:13 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 03:22:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:13 INFO - 'USER': 'cltbld', 03:22:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:13 INFO - 'XPC_FLAGS': '0x0', 03:22:13 INFO - 'XPC_SERVICE_NAME': '0', 03:22:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:13 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-LE8snV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:13 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-74XouN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:13 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-RtRPLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:13 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-uc2SVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:13 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-WIo7C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:13 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-pU9lyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:13 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)) 03:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:13 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-xpwJum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:14 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)) 03:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:14 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-9DM_Av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:14 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)) 03:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:14 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-UsdTOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:14 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)) 03:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:14 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-cFrn2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:14 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)) 03:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:14 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-2I5YkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:14 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)) 03:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:14 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-9W7OA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:14 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)) 03:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:14 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-tBFd0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:14 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)) 03:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:14 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-lw7_d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:14 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)) 03:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:14 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-9HMSLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:14 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)) 03:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:14 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-D1Zs_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:14 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)) 03:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:14 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-sMJ6gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:15 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)) 03:22:15 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)) 03:22:15 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)) 03:22:15 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)) 03:22:15 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)) 03:22:15 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)) 03:22:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:22:15 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 03:22:15 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 03:22:15 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 03:22:15 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 03:22:15 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 03:22:15 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 03:22:17 INFO - Downloading blessings-1.6.tar.gz 03:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:22:18 INFO - Installing collected packages: blessings 03:22:18 INFO - Running setup.py install for blessings 03:22:18 INFO - Successfully installed blessings 03:22:18 INFO - Cleaning up... 03:22:18 INFO - Return code: 0 03:22:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:18 INFO - Reading from file tmpfile_stdout 03:22:18 INFO - Current package versions: 03:22:18 INFO - blessings == 1.6 03:22:18 INFO - blobuploader == 1.2.4 03:22:18 INFO - docopt == 0.6.1 03:22:18 INFO - manifestparser == 1.1 03:22:18 INFO - mozInstall == 1.12 03:22:18 INFO - mozcrash == 0.17 03:22:18 INFO - mozdebug == 0.1 03:22:18 INFO - mozdevice == 0.48 03:22:18 INFO - mozfile == 1.2 03:22:18 INFO - mozhttpd == 0.7 03:22:18 INFO - mozinfo == 0.9 03:22:18 INFO - mozleak == 0.1 03:22:18 INFO - mozlog == 3.1 03:22:18 INFO - moznetwork == 0.27 03:22:18 INFO - mozprocess == 0.22 03:22:18 INFO - mozprofile == 0.28 03:22:18 INFO - mozrunner == 6.11 03:22:18 INFO - mozscreenshot == 0.1 03:22:18 INFO - mozsystemmonitor == 0.0 03:22:18 INFO - moztest == 0.7 03:22:18 INFO - mozversion == 1.4 03:22:18 INFO - psutil == 3.1.1 03:22:18 INFO - requests == 1.2.3 03:22:18 INFO - wsgiref == 0.1.2 03:22:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:19 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')]} 03:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:19 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 0x10f15ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f16c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994bcb5070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10effbe00>, '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 0x10ee64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6b20>, '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.dkL9IhdftA/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.v01mzz2rwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 03:22:19 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 03:22:19 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 03:22:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkL9IhdftA/Render', 03:22:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:19 INFO - 'HOME': '/Users/cltbld', 03:22:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:19 INFO - 'LOGNAME': 'cltbld', 03:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:19 INFO - 'MOZ_NO_REMOTE': '1', 03:22:19 INFO - 'NO_EM_RESTART': '1', 03:22:19 INFO - 'PAGER': '/bin/cat', 03:22:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:19 INFO - 'PWD': '/builds/slave/test', 03:22:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:19 INFO - 'SHELL': '/bin/bash', 03:22:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v01mzz2rwq/Listeners', 03:22:19 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 03:22:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:19 INFO - 'USER': 'cltbld', 03:22:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:19 INFO - 'XPC_FLAGS': '0x0', 03:22:19 INFO - 'XPC_SERVICE_NAME': '0', 03:22:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:19 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)) 03:22:19 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)) 03:22:19 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)) 03:22:19 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)) 03:22:19 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)) 03:22:19 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)) 03:22:19 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)) 03:22:19 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)) 03:22:19 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)) 03:22:19 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)) 03:22:19 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)) 03:22:19 INFO - Cleaning up... 03:22:19 INFO - Return code: 0 03:22:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:22:19 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')]} 03:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:19 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')]} 03:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:19 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 0x10f15ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f16c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994bcb5070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10effbe00>, '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 0x10ee64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6b20>, '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.dkL9IhdftA/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.v01mzz2rwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 03:22:19 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 03:22:19 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 03:22:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkL9IhdftA/Render', 03:22:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:19 INFO - 'HOME': '/Users/cltbld', 03:22:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:19 INFO - 'LOGNAME': 'cltbld', 03:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:19 INFO - 'MOZ_NO_REMOTE': '1', 03:22:19 INFO - 'NO_EM_RESTART': '1', 03:22:19 INFO - 'PAGER': '/bin/cat', 03:22:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:19 INFO - 'PWD': '/builds/slave/test', 03:22:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:19 INFO - 'SHELL': '/bin/bash', 03:22:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v01mzz2rwq/Listeners', 03:22:19 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 03:22:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:19 INFO - 'USER': 'cltbld', 03:22:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:19 INFO - 'XPC_FLAGS': '0x0', 03:22:19 INFO - 'XPC_SERVICE_NAME': '0', 03:22:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:19 INFO - Downloading/unpacking jsonschema 03:22:19 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 03:22:19 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 03:22:19 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 03:22:19 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 03:22:19 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 03:22:19 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 03:22:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:22 INFO - Downloading/unpacking functools32 (from jsonschema) 03:22:22 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 03:22:22 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 03:22:22 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 03:22:22 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 03:22:22 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 03:22:22 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 03:22:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:22 INFO - warning: no files found matching '*.txt' 03:22:22 INFO - no previously-included directories found matching 'build' 03:22:22 INFO - no previously-included directories found matching 'dist' 03:22:22 INFO - no previously-included directories found matching '.git*' 03:22:22 INFO - Installing collected packages: jsonschema, functools32 03:22:22 INFO - Running setup.py install for functools32 03:22:22 INFO - warning: no files found matching '*.txt' 03:22:22 INFO - no previously-included directories found matching 'build' 03:22:22 INFO - no previously-included directories found matching 'dist' 03:22:22 INFO - no previously-included directories found matching '.git*' 03:22:22 INFO - Successfully installed jsonschema functools32 03:22:22 INFO - Cleaning up... 03:22:22 INFO - Return code: 0 03:22:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:22 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 0x10f15ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f16c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994bcb5070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10effbe00>, '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 0x10ee64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6b20>, '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.dkL9IhdftA/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.v01mzz2rwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 03:22:22 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 03:22:22 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 03:22:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkL9IhdftA/Render', 03:22:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:22 INFO - 'HOME': '/Users/cltbld', 03:22:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:22 INFO - 'LOGNAME': 'cltbld', 03:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:22 INFO - 'MOZ_NO_REMOTE': '1', 03:22:22 INFO - 'NO_EM_RESTART': '1', 03:22:22 INFO - 'PAGER': '/bin/cat', 03:22:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:22 INFO - 'PWD': '/builds/slave/test', 03:22:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:22 INFO - 'SHELL': '/bin/bash', 03:22:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v01mzz2rwq/Listeners', 03:22:22 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 03:22:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:22 INFO - 'USER': 'cltbld', 03:22:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:22 INFO - 'XPC_FLAGS': '0x0', 03:22:22 INFO - 'XPC_SERVICE_NAME': '0', 03:22:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:23 INFO - Downloading/unpacking flake8 03:22:23 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 03:22:23 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 03:22:23 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 03:22:23 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 03:22:23 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 03:22:23 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 03:22:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:22:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:22:25 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 03:22:25 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 03:22:25 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 03:22:25 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 03:22:25 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 03:22:25 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 03:22:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:22:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:22:26 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 03:22:26 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 03:22:26 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 03:22:26 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 03:22:26 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 03:22:26 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 03:22:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:22:26 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 03:22:26 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 03:22:26 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 03:22:26 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 03:22:26 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 03:22:26 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 03:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:22:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:27 INFO - no previously-included directories found matching 'docs/_build' 03:22:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:22:27 INFO - Running setup.py install for pep8 03:22:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:27 INFO - no previously-included directories found matching 'docs/_build' 03:22:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:22:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:22:27 INFO - Cleaning up... 03:22:27 INFO - Return code: 0 03:22:27 INFO - Running post-action listener: _resource_record_post_action 03:22:27 INFO - Running post-action listener: _start_resource_monitoring 03:22:27 INFO - Starting resource monitoring. 03:22:27 INFO - ##### 03:22:27 INFO - ##### Running install step. 03:22:27 INFO - ##### 03:22:27 INFO - Running pre-action listener: _resource_record_pre_action 03:22:27 INFO - Running main action method: install 03:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:27 INFO - Reading from file tmpfile_stdout 03:22:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:22:27 INFO - Reading from file tmpfile_stdout 03:22:27 INFO - Output received: 03:22:27 INFO - Usage: mozinstall [options] installer 03:22:27 INFO - Options: 03:22:27 INFO - -h, --help show this help message and exit 03:22:27 INFO - -d DEST, --destination=DEST 03:22:27 INFO - Directory to install application into. [default: 03:22:27 INFO - "/builds/slave/test"] 03:22:27 INFO - --app=APP Application being installed. [default: firefox] 03:22:27 INFO - mkdir: /builds/slave/test/build/application 03:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 03:22:49 INFO - Reading from file tmpfile_stdout 03:22:49 INFO - Output received: 03:22:49 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 03:22:49 INFO - Running post-action listener: _resource_record_post_action 03:22:49 INFO - ##### 03:22:49 INFO - ##### Running run-tests step. 03:22:49 INFO - ##### 03:22:49 INFO - Running pre-action listener: _resource_record_pre_action 03:22:49 INFO - Running main action method: run_tests 03:22:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:22:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:22:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:22:49 INFO - 2016-07-08 03:22:49.766 screenresolution[1949:19185] starting screenresolution argv=screenresolution get 03:22:49 INFO - 2016-07-08 03:22:49.769 screenresolution[1949:19185] Display 0: 1600x1200x32@60 03:22:49 INFO - 2016-07-08 03:22:49.775 screenresolution[1950:19187] starting screenresolution argv=screenresolution list 03:22:49 INFO - Available Modes on Display 0 03:22:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:22:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:22:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:22:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:22:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:22:50 INFO - Intel Iris: 03:22:50 INFO - Chipset Model: Intel Iris 03:22:50 INFO - Type: GPU 03:22:50 INFO - Bus: Built-In 03:22:50 INFO - VRAM (Dynamic, Max): 1536 MB 03:22:50 INFO - Vendor: Intel (0x8086) 03:22:50 INFO - Device ID: 0x0a2e 03:22:50 INFO - Revision ID: 0x0009 03:22:50 INFO - Displays: 03:22:50 INFO - Display: 03:22:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:22:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:22:50 INFO - Display Serial Number: 1600x1200 60 03:22:50 INFO - Main Display: Yes 03:22:50 INFO - Mirror: Off 03:22:50 INFO - Online: Yes 03:22:50 INFO - Rotation: Supported 03:22:50 INFO - Return code: 0 03:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:50 INFO - Python 2.7.3 03:22:50 INFO - Return code: 0 03:22:50 INFO - grabbing minidump binary from tooltool 03:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:50 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 0x10effbe00>, '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 0x10ee64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eff6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:50 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 03:22:50 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 03:22:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:50 INFO - Return code: 0 03:22:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:22:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:22:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:22:51 INFO - Return code: 0 03:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 03:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0214 --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 03:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkL9IhdftA/Render', 03:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:51 INFO - 'HOME': '/Users/cltbld', 03:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:51 INFO - 'LOGNAME': 'cltbld', 03:22:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:51 INFO - 'MOZ_NO_REMOTE': '1', 03:22:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:51 INFO - 'NO_EM_RESTART': '1', 03:22:51 INFO - 'PAGER': '/bin/cat', 03:22:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:51 INFO - 'PWD': '/builds/slave/test', 03:22:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:51 INFO - 'SHELL': '/bin/bash', 03:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v01mzz2rwq/Listeners', 03:22:51 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 03:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:51 INFO - 'USER': 'cltbld', 03:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:51 INFO - 'XPC_FLAGS': '0x0', 03:22:51 INFO - 'XPC_SERVICE_NAME': '0', 03:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 03:22:51 INFO - mozversion application_buildid: 20160708021326 03:22:51 INFO - mozversion application_changeset: 75b9cc8259df0aca3d93c4b44155a77875341a14 03:22:51 INFO - mozversion application_display_name: Firefox 03:22:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:51 INFO - mozversion application_name: Firefox 03:22:51 INFO - mozversion application_remotingname: firefox 03:22:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:22:51 INFO - mozversion application_vendor: Mozilla 03:22:51 INFO - mozversion application_version: 48.0 03:22:51 INFO - mozversion platform_buildid: 20160708021326 03:22:51 INFO - mozversion platform_changeset: 75b9cc8259df0aca3d93c4b44155a77875341a14 03:22:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:22:51 INFO - mozversion platform_version: 48.0 03:22:51 INFO - using testdate: 1467973371 03:22:51 INFO - actual date: 1467973371 03:22:51 INFO - starting webserver on 'localhost:52659' 03:22:51 INFO - SUITE-START | Running 2 tests 03:22:51 INFO - TEST-START | dromaeo_css 03:22:51 INFO - operating with platform_type : mac_ 03:22:51 INFO - Initialising browser for dromaeo_css test... 03:22:51 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpdVJgxa/profile http://localhost:52659/getInfo.html) 03:22:54 INFO - PROCESS | 1968 | __metrics Screen width/height:1600/1200 03:22:54 INFO - PROCESS | 1968 | colorDepth:24 03:22:54 INFO - PROCESS | 1968 | Browser inner width/height: 1024/689 03:22:54 INFO - PROCESS | 1968 | __metrics 03:22:54 ERROR - PROCESS | 1968 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 03:22:54 INFO - TEST-INFO | 1968: exit 0 03:22:54 INFO - Browser initialized. 03:22:54 INFO - Running cycle 1/1 for dromaeo_css test... 03:22:54 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpdVJgxa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:06 INFO - PROCESS | 1972 | RSS: Main: 171073536 03:23:06 INFO - PROCESS | 1972 | 03:23:56 INFO - PROCESS | 1972 | 1467973436323 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] 03:26:06 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:52659/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52659/tests/dromaeo/cssquery-ext.html) 03:26:07 INFO - PROCESS | 1972 | RSS: Main: 182038528 03:26:07 INFO - PROCESS | 1972 | 03:29:09 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:52659/tests/dromaeo/cssquery-ext.html (next: http://localhost:52659/tests/dromaeo/cssquery-jquery.html) 03:29:10 INFO - PROCESS | 1972 | RSS: Main: 192802816 03:29:10 INFO - PROCESS | 1972 | 03:32:11 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:52659/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52659/tests/dromaeo/cssquery-mootools.html) 03:32:12 INFO - PROCESS | 1972 | RSS: Main: 195469312 03:32:12 INFO - PROCESS | 1972 | 03:35:14 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:52659/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52659/tests/dromaeo/cssquery-prototype.html) 03:35:14 INFO - PROCESS | 1972 | RSS: Main: 199254016 03:35:14 INFO - PROCESS | 1972 | 03:38:17 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:52659/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52659/tests/dromaeo/cssquery-yui.html) 03:38:17 INFO - PROCESS | 1972 | RSS: Main: 197849088 03:38:17 INFO - PROCESS | 1972 | 03:41:20 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:52659/tests/dromaeo/cssquery-yui.html (next: http://localhost:52659/tests/dromaeo/cssquery-dojo.html) 03:41:20 INFO - PROCESS | 1972 | RSS: Main: 202776576 03:41:20 INFO - PROCESS | 1972 | 03:41:20 INFO - PROCESS | 1972 | __start_tp_report 03:41:20 INFO - PROCESS | 1972 | _x_x_mozilla_page_load 03:41:20 INFO - PROCESS | 1972 | _x_x_mozilla_page_load_details 03:41:20 INFO - PROCESS | 1972 | |i|pagename|runs| 03:41:20 INFO - PROCESS | 1972 | |0;dojo.html;2909.7817663675223;3641.435577485489;3674.0080178351855;3687.612800655933;3703.4815125882383;5889.823305300848;6016.60892042017;6023.909641355378;6026.306974697911;6031.125486804422;5984.760609575612;6003.0695242237525;6016.368281330452;6044.607100538462;6063.242094738158;5304.230886521452;5341.412444631087;5373.892522149555;5410.702411367373;5531;5327.094393953018;5379.35447746271;5422.48486393792;5507.642003269794;5523;5410.161424979115;5418.674879507223;5424.457554244584;5425.240466334716;5429.158480435539;5352.116900711398;5411.675299482024;5427.674339539641;5445.047116754552;5452.836414907559;5295.894082118336;5407.134858422673;5439.864003399907;5443.237946687427;5456.590755693339;5784.942150578525;5808.941910580882;5857.76568937242;6032.66820324882;6129.387061293835;6266.843328916768;6351;6351.682415879188;6359.904601430936;6363.96818015907;6340.651264180468;6364.554481186319;6374.87250254997;6391.45672617828;6391.8402039948905;4913.968066705996;5929.258842644669;5991.820245392645;6070.726817293233;6090;6444.162258906312;6533.705983230766;6548.476121910236;6551.868962620721;6556.213254409406;6273.247210334698;6292.402221788922;6297.96851015742;6309.33751956038;6314.936850631527;6324.051392291193;6337.429631333202;6388.872222555523;6409.230892292955;6409.359064093554;6227.252729672468;6263.592866463757;6312.084747711648;6317.936820631827;6326.936730632635;6287.151234583364;6293.685315734195;6307.653079080695;6328.886223954466;6336.651484168415;4907.141250281186;5071.112555302807;5095.1847704367865;5110.386753589593;5112.718800465936;4562.543745625411;4591.701539399928;4594.770261486912;4598.747068911175;4603.861884143481;6106.794380079809;6245.96877015612;6271.717772700239;6305.211848518935;6320.178376810985;6305.873882522415;6351.460125889259;6358.523110766711;6383.521235907233;6408.327125651833;6288.654124023131;6293.276273228637;6296.590721603081;6299.748010079546;6351.872962540816;5577.079781836032;5690.573207009408;5713.400092990176;5713.714314284269;5752.108423194411;6674.933250667528;6694.129763130762;6734.595924244659;6737.056812046318;6756.223034351113;5543.9168412474655;5634.464725851038;6309.2744334400295;6346.460550853045;6392.456641185551;6579.111819904251;6632.668366581748;6752.864942701217;6754.560953538201;6757.797266082025;6309.179806625109;6361.2048493938255;6371.840703982252;6377.4579160771855;6391.616503009835;6345.7144428499905;6346.301906790157;6399.8080057598345;6418;6430.292667806444;5255.78976840922;6170.074488826712;6217.906731398942;6278.277998030285;6327.620342779448;6110.51115910735;6266.968665156827;6272.121902933502;6281.497480201664;6297.496200303873;5800.274965629296;6306.243250809932;6306.621602703853;6312.810615681537;6333.556651034568;5021.447640759587;5222.8955420892125;6234.127222188807;6245.313015568375;6321.8735625288155;5269.868253293698;6266.780662676784;6290.465310448663;6319.368063193828;6329.8734025320155 03:41:20 INFO - PROCESS | 1972 | |1;ext.html;516.029863855951;552.6766841397782;565.4147956864645;565.6719102920307;565.6775637886406;31124.53313200301;39207.607923920754;39217.60782392175;39323.60676393235;39414.60585394145;40262.39606405899;40608.593914060926;40767.59232407675;40792.796036019776;40865.795671021675;8868.467891926473;9433.81132377352;9450.621975120986;9710;9751.366161199534;7664.808379790494;9297.4886381249;9565.426074435522;9771.36486128403;9801.852972205386;9740.51297435129;9776.755581110458;9782.755431114243;9822.705318840446;9830.508474576243;9723.513824308791;9764.951175244078;9784.461854597994;9796.118349348557;9808.06823351784;9643.758906027406;9723.222142228675;9771.022897710243;9776.560054797552;9801;39067.804660976515;39285.80357098225;39306.41040384396;39624.60375396238;39716;3180.5865237518974;3748.6438788315068;3814.4906685849087;3903.0632648164237;3921.607839216084;27732.584011239847;27930.441391172266;28030.159095227176;28108.875644974178;28144.85927570349;2770.5844123381453;2777.6805667348312;2837.205582436921;2873.396586716792;2893.8842446302124;484572;489091;490629.546852267;492952;494755;37296.627033729856;59820.700896496106;60367.39632603706;60844;60946;35800.10499737475;35948.46077308842;36143;36163.638363616024;36334.81832590873;15853.207339632972;16080.67838643244;16095.275712592962;16139.757903631455;16148;13266.469341226435;13301.201927884358;13369.331533423485;13622.318884055956;13692.863071369358;8295.585220738938;8330.375221858385;8411.948506436695;8416.326693864476;8504.44721093127;3561.8753343633366;3578.982105089458;3601.5318008659233;3620.475031120473;3629.891103266906;956.4309236004566;1088.6244245735209;1105.9557617695202;1160.802663547199;1180.5454899863614;30543.93096241621;30613.928512501956;30621.69378306233;30867.536986944764;30971.380572388876;1147.4778975566098;1176.864660564029;1206.3968015992004;1249.5130794354689;1252.117257333596;12658.683532911751;15204.619884502976;15416;15455.92272038655;16168.191590420667;508409;510831;514315;515187;521080;58093.70953145207;59816.803663926476;59859.700701496215;59978.700106499185;60028;1562.5546719184977;1563.8905276630526;1571.4657016614635;1579.0446779698118;1585.2549301828121;30084.548731768602;30870.69129308678;31027.844860775553;31608.209794754395;31961;57525.712371437876;57934;58121;58191;58317.4168258312;582031;584122;589306;590479;591155;41122.56071037499;43192.35211471893;43349.78325108354;44924;44977.87555311144;35695.82152089223;39714.41142354273;40568.594314056485;43489.78255108704;44400;30558;34359;34999;36388.454173186896;36470.63529364672;27477.862610687618;35573.1106722334;36292.63707362998;36296;36979.44530832094;32698.019059428254;38040.61959380481;38246.61753382542;39443.605563945144;39666.206675865746;29450.410991779616;31827.36345273035;31953.201169970936;32013.519797203528;32139.517907230944;24526;24658;24815.751842481342;24909.626355605043;25443.87278063598 03:41:20 INFO - PROCESS | 1972 | |2;jquery.html;414.3019012963155;416.67499350506614;420.8884645568925;426.430714995481;426.7951383335998;20204.69692954605;20909.686354704674;20927.267545635907;20951.790482095195;21982.670259946113;20530.794692053074;20901.58196836066;21118.149049878262;21289.57420851582;21733.891330543363;5629.943700563003;6314.71583778731;6318.652474113922;6330.873382532347;6349.650769207692;4226.640735537468;5991.460768530831;6077.544184186182;6242.25092988842;6272.6236425814595;6203.162573052626;6215.0366693162405;6259.374062593727;6278.30938596754;6308.936910630904;6246.781362652308;6391.48868090554;6852.45180385568;6852.588844669311;6862.553933994274;6049.818505444844;6091.51267898567;6104.633721976651;6106.175666285039;6106.694665266719;20150.193992240293;23728.881355593283;24912.377190570198;24940.750592494205;25337.733113344442;2246.3261021693424;2298.482841360697;2304.331743794298;2795.566687163493;2805.8316501010004;9806;9824.803503929952;9919.603215871357;10024.59901603935;10132.797344053077;1772.0342413384735;1775.0858307971405;1797.8651601129836;1908.8472922166193;1910.646530391868;106779;106985.46507267414;107462;115630;119451.4027429866;11912.04703623708;12398.25610463375;12400.00799936003;12450.190737602026;12465.688357790947;15531.922340388452;15635.374585016472;15668.451604193799;15694.979826311253;15697.822663300298;7691.30778229962;9192.95403522978;9328.207102396373;9379.874415070235;9383.436993780395;9238.953805231065;9339.626414943326;9341.90658093424;9403.247740180768;9417.905820941703;4064.349704047338;4802.975985120122;4892.2661600760175;4905.3132561441425;4918.877028074256;1998.3505360757813;2009.2264478175716;2071.2025870039843;2077.802608752166;2134.4450442884963;988.5403287471361;1010.8231059564547;1030.314840630987;1036.2849633752687;1052.095198129608;18497.260109595467;20279.797202027792;21936.780632193793;22023.22918697838;22144.778552214593;978.295627148452;981.6122631560636;1002.0330381182195;1082.0586090101503;1095.9890401096047;9617.374870633526;10924.945375273073;11141.832872506919;11345.773084538263;11355.034822040054;659284;664715;664933.2557179165;679649;685618;111975;136604;142007;144343;144437;1088.1838621034224;1093.573506332531;1106.6679996001167;1110.584005393114;1114.5764609448358;18571;18901;19031.90484047571;19142.947137907548;19463.026848657228;49675.254871176236;53775.73112134414;55257.17114243209;58295.4170458307;59771;79211.60394197992;82888.75666864881;83775;84226.31547368896;84333;11464.598739044093;11832.881671183522;12370.381480926098;12745;12834.55079072228;13302.93348533251;13452.798208027083;13651.726965460834;13879.583612491642;14080.929595351958;5641.830745077655;11121.888781112086;11808.586699465477;11821.290722556674;11985.22096063753;10267;11391.202615816814;11837.82243266369;11911;11934.940325298665;11169.776604467703;11523.250988686044;11541.307521548733;11990.40047997614;12196.451159698012;12766.936165319114;12888.742225155633;12942.67643308887;12951.158174718614;13024.47902083906;10247.590096396061;12081.154319197572;12099.274043557414;12131.272123672608;12297.877021230031 03:41:20 INFO - PROCESS | 1972 | |3;mootools.html;1631.8694504439645;1643.868490520758;1919.2898627507825;2001.279539365828;2050.8256798172156;7710.190430004845;8309.335253179746;8941.463512189273;9334.346595738301;9384.155426011666;9108.271338292938;9145.039770824067;9219.723408297745;9222.584983675733;9255.352125351228;2133.775953524877;2547.350425641459;2547.4905018996183;2555.540002799495;2559;2257;2401.6157414813633;2447.865367404792;2583.509133264674;2586.0431640293023;2152.4511249631323;2259.4464356232747;2539.9840063974375;2572.2026171886682;2586.922392328233;2145.5816115857415;2546.9745302547017;2552.2981180175416;2570.910018149365;2582.1349847801007;2552.5788244939563;2561.2828408045775;2580.4710034443083;2590.818642695012;2601.115620688975;9375.06249375057;9408.294377921684;9409.717708468757;9416.90583094167;9427.104425079675;5720.942790572082;5792.420757924216;5796.82609521715;5835.562332825055;5909.172715819789;3689.2068205335713;3774.698024158061;3800.3159431302356;3814.0846196912817;3822.808859557011;1050.406520316019;1073.693997210799;1074.2641290715885;1090.4711215060688;1090.5910283643634;12646.988240940702;12694.682632934251;12705.745885082246;12716.300603466805;12749.42627581761;4964.478729733398;5018.648694591417;5060.114479965991;5070.518300761421;5137.229415587692;10697.358158510515;10731.443940628722;10771.89228107709;10776.515056822462;10856.457177141112;5682.943170568324;5746.482816546447;5780.132980053026;5780.5953583248765;5785.450382213683;4251.234777740036;5077.669951453144;5184.870378240499;5198.766055527511;5229.712365819916;3626.546681664792;4301.07526881722;4317.956820431818;4328.372386004012;4358.877237749668;1417.9929100354432;1444.2850788859582;1452.6345235478827;1453.5784622459369;1461.8903582231376;966.2415004221652;991.5637119667323;992.2855544008303;1013.6604237580345;1023.8072645368212;6150.692465376803;6172.9074063889075;6195.504359651217;6247.718852651642;6377.139086223393;1013.807376598444;1025.497506221946;1029.1149611334247;1055.551390658967;1071.121680222226;3963.3856752203455;4041.5756345583877;4129.174165166979;4152.148809494047;4213.810378532973;10877;11215.32708037504;11278.379689117013;11352.262102963281;11362.261453005529;11038.227324087236;11252.831207531894;11263.493142808593;11272.267302625303;11398.601048963412;8771.649134034695;8830.823383532294;8954.731358059269;8979.191872731486;9016;5866.149408335853;6025.457708806229;6057.757689692363;6196.008638617799;6213.689315534296;10156.238282129018;10205.795884082128;10218.948905255425;10233.079022887976;10338.689839304832;9666.420014799134;9957.950210248902;10031.996800320201;10043.196544276294;10154.39073655583;7101.218865924848;7805;7936.880946785687;8219.383546234176;8455.492670439793;6925.861482770216;8312;8371.41400101987;8396.454230475;8423.410361274897;6225.221847269091;7413.888791668237;7553.924460755322;7720.884186737316;7733.92266077332;7396.186419493959;7454.291842274975;7475.850482990419;7514.661840217094;7583.582902940391;7197.71209151628;7267.709291628275;7292.708291668486;7329.377002954595;7340.412766978522;5076.822311219237;5102.659104228489;5134.255532947627;5187.754938814582;5194.584433245256;5105.821296254613;5142.408623008402;5217.373915130209;5242.606804489602;5472.50747432733 03:41:20 INFO - PROCESS | 1972 | |4;prototype.html;298.7774108289325;319.594115473349;336.3810588517128;336.5533211336842;344.61059003326227;5639.6334238274485;6713.355227969155;6758.45932325414;6801.149856267966;6893.586384816915;6616.801495955129;6666.50001249907;6686.832829179273;6761.256261811197;6782.118324617805;5023.271625614284;5024.346834911456;5029.949700503003;5036.6726162799305;5039.949600504003;5039.916417970136;5043.697378157304;5044.672096313746;5052.444231134572;5068.34111565496;4981.352424184851;4988.201887697969;4988.401391832967;5005.399352077738;5019.974900125494;4795.952040479586;4949.678270912379;4960.851174464772;4965.851024469253;4978.178600530908;4304.5910638489295;4312.633426158749;4339.002029533225;4348.565143485658;4363.476382834048;6441.645709485976;6471.741130354781;6496.805095847132;6517.804465866032;6529.575577587441;5979.730912108966;5981.282246130492;5997.7001149942325;5998.4601385875485;6006.819795406102;7261.019762332123;7270.818229544251;7288.963555182243;7301.2698730127095;7314.305141011649;4645.187092258841;4823.807047718087;4843.782029808667;4871.050145221683;4875.195592727196;7624.19945905683;7628.923710762877;7685.308322251024;7697.307242348215;7720.227977202291;4165.958340416557;4909.214525675875;4932.654714169974;4946.950530494649;4956.826511072095;5037.11850426174;5041.974790126026;5052.69683818972;5053.646244762905;5070.264811602371;4800.591949684246;5917.881642367214;5929.584929054925;5942.346341902387;5982.312034116046;7022.08712867324;7241.348278654947;7246.601436920914;7295.452841036943;7319.707211711579;1427.6216802547333;1445.6964037552023;1731.073875476614;1733.0641453614908;1752.6144248265362;1050.3120456101267;1120.5237773946203;1120.5405783628673;1148.55780524497;1153.7577108807245;5631.352394474688;6886.724531018703;6951.513394062367;6982.79051628452;7019.473539484559;6084.421979911901;7543.434242431839;7556.282153195438;7557.811054723676;7559;5848.713283077716;6736.191657001191;6904.4821638377325;6967.581945083311;7029.89455158173;3548.574171099433;3985.720999530005;4031.133306339151;4032.1532478179324;4039.8586049488126;7211.8557628848175;8066.354691624656;8071.878921816177;8074.475159114639;8123.228293312126;6812.523123381415;7332.816679583053;7814.921850781533;7833.608319583998;7860.292573668397;8031.598420078973;8066.1933806620045;8068.193180681885;8083.959580202179;8091.635876385577;7382;7586.468947173866;7600.2779735925;7618.961905190438;7628.580428076509;6057.333693293646;6582.243042050034;6912.953543912871;7406.666699998405;7444.441666875115;6945.826354341182;7579;8053.83892322162;8064.516129032277;8068;4961.330220420341;4963.925541116814;4991.80032798684;5004.524570165829;5020.598352131748;7312.670929808065;7547.0943486781935;7566.697332106654;7580.241975802596;7633.503822251536;5994.70026498682;7215.242399547972;7302.087239095114;7307.2367730619835;7331.816704582428;7272.745453909088;7308.926910730825;7319.560826350436;7326.289272969036;7338.412926965937;7129.073220481304;7153.606551639502;7160;7172.784816455514;7188.712451501881;7097.148342198969;7291.708331666674;7350.411967042731;7350.889736654061;7397.704091836266;5642.025291148066;6932.237453879969;7158.785236442915;7190.928090719235;7256.714135047654 03:41:20 INFO - PROCESS | 1972 | |5;yui.html;568.4798409455349;717.2003216413699;767.4512723402765;775.7595145504894;785.8114052627371;12699.682507937294;15121.470748523803;15314.617134571627;15365.69268614627;15505.457308994188;14278;14306.642333941656;14316.42734290627;14326.713465730705;14586.124832510057;791.6279348706099;937.1237892570434;937.2736129499624;950.301528376646;953.7567920180344;884.5577211394303;918.6738707758716;942.0673533202115;956.2159029595699;957.8850537935457;990.5938565188275;994.4530508220486;1035.9741006474824;1036.3263878478974;1047.1151876664244;991.7768502087044;994.4729293474434;1024.2727663359024;1029.3206483720746;1033.6175615022453;740.9555426674417;770.2951799103813;777.8949841771345;789.2896393246067;790.2295262119445;15158.242087895671;15254.694906101928;15270.541883743506;15277.923610381877;15326.770098448533;13074.019448541303;13170.473181072746;13198.340082995812;13296.468141274338;13297.135686180367;10034.347767395097;10165.390076595353;10281.228907831943;10286.691399258034;10427.530761115691;3473.0987004564563;3592.119930616989;3607.8196090195383;3699.722520810923;3757.0982964088694;81534.59232703799;81631.5918420404;81660.59169704173;82651;87489.56255218748;9457.10157535033;9490.525473726286;9851.310408271353;10251.33366331201;10323.328983616191;20705.482362940747;20947.581048379252;20985;20987.475313117295;21418.571628567654;7569.394448444111;7734.690612375442;7792.220777922275;7821.765347039598;7863.410244231705;4214.978925105354;4231.809568569361;4261.722988005832;4312.525622181557;4319.762413067248;3466.1507930557177;3708.2583483303447;3799.772013679188;3801.9429708554394;3803.7147213959065;562.7270773674765;679.9359003160039;706.6996526476227;713.6717110129399;715.6278735057845;474.2743602288504;568.6987040231413;574.029889486766;579.507418694115;593.6616128806625;7902.4863383879865;7949.364050875916;7977.5612341321785;8047.155048719917;8357.289630381485;517.9459799308389;557.6013150597342;576.0638961687258;584.0025028678688;589.2987345059452;3440.569928758905;3771.4908487353855;3856.402257650069;3860.4209368594375;4104.527979282361;96371;97146.05707885802;97701;98279.50860245652;99634.00365996247;80258;81073;82141.58929205316;82179;82369.3526129474;73009.63495182597;74368.88446673196;75787.24212757913;76490.70527884172;77889.22110778933;8583.914160858312;8681.522516261413;8705.651773929225;8842.24840888506;8936.821263574562;34882;44637.776811115735;44961.87595310144;46534.30198546957;50057.749711251214;56632.7168364172;59002.11496827637;64545.70908581896;65292.67353663201;67295;10985.340879547253;11078;11226.831597526207;11418.942905285421;11728.12039097054;11831.585894493652;12053.397330133634;12194.268343899394;12486.875131248571;12699.36503174856;9858.605655773688;11626.302421854716;11678.286480318058;11698.590549330733;11864.070740315075;9544.08197613963;11700.29798212076;11715.966936900406;11835.822462662894;11904.620324671587;11200;11489.680417842595;11839.58561450345;11901.523939042341;11908.225965312227;9677.758056048655;9910;9931.553080111267;9941.204703623838;10210.693679189637;9656.855147172939;9731.12419882214;9774.218062554837;9903.306768526134;9956.800863982824 03:41:20 INFO - PROCESS | 1972 | __end_tp_report 03:41:20 INFO - PROCESS | 1972 | __start_cc_report 03:41:20 INFO - PROCESS | 1972 | _x_x_mozilla_cycle_collect,398 03:41:20 INFO - PROCESS | 1972 | __end_cc_report 03:41:20 INFO - PROCESS | 1972 | __startTimestamp1467974480377__endTimestamp 03:41:20 INFO - PROCESS | 1972 | 03:41:20 INFO - PROCESS | 1972 | ------- Summary: start ------- 03:41:20 INFO - PROCESS | 1972 | Number of tests: 6 03:41:20 INFO - PROCESS | 1972 | 03:41:20 INFO - PROCESS | 1972 | [#0] dojo.html Cycles:165 Average:5931.09 Median:6266.84 stddev:666.63 (10.6%) stddev-sans-first:625.12 03:41:20 INFO - PROCESS | 1972 | Values: 2909.8 3641.4 3674.0 3687.6 3703.5 5889.8 6016.6 6023.9 6026.3 6031.1 5984.8 6003.1 6016.4 6044.6 6063.2 5304.2 5341.4 5373.9 5410.7 5531.0 5327.1 5379.4 5422.5 5507.6 5523.0 5410.2 5418.7 5424.5 5425.2 5429.2 5352.1 5411.7 5427.7 5445.0 5452.8 5295.9 5407.1 5439.9 5443.2 5456.6 5784.9 5808.9 5857.8 6032.7 6129.4 6266.8 6351.0 6351.7 6359.9 6364.0 6340.7 6364.6 6374.9 6391.5 6391.8 4914.0 5929.3 5991.8 6070.7 6090.0 6444.2 6533.7 6548.5 6551.9 6556.2 6273.2 6292.4 6298.0 6309.3 6314.9 6324.1 6337.4 6388.9 6409.2 6409.4 6227.3 6263.6 6312.1 6317.9 6326.9 6287.2 6293.7 6307.7 6328.9 6336.7 4907.1 5071.1 5095.2 5110.4 5112.7 4562.5 4591.7 4594.8 4598.7 4603.9 6106.8 6246.0 6271.7 6305.2 6320.2 6305.9 6351.5 6358.5 6383.5 6408.3 6288.7 6293.3 6296.6 6299.7 6351.9 5577.1 5690.6 5713.4 5713.7 5752.1 6674.9 6694.1 6734.6 6737.1 6756.2 5543.9 5634.5 6309.3 6346.5 6392.5 6579.1 6632.7 6752.9 6754.6 6757.8 6309.2 6361.2 6371.8 6377.5 6391.6 6345.7 6346.3 6399.8 6418.0 6430.3 5255.8 6170.1 6217.9 6278.3 6327.6 6110.5 6267.0 6272.1 6281.5 6297.5 5800.3 6306.2 6306.6 6312.8 6333.6 5021.4 5222.9 6234.1 6245.3 6321.9 5269.9 6266.8 6290.5 6319.4 6329.9 03:41:20 INFO - PROCESS | 1972 | 03:41:20 INFO - PROCESS | 1972 | [#1] ext.html Cycles:180 Average:65877.61 Median:21564.61 stddev:142063.04 (658.8%) stddev-sans-first:142376.80 03:41:20 INFO - PROCESS | 1972 | Values: 516.0 552.7 565.4 565.7 565.7 31124.5 39207.6 39217.6 39323.6 39414.6 40262.4 40608.6 40767.6 40792.8 40865.8 8868.5 9433.8 9450.6 9710.0 9751.4 7664.8 9297.5 9565.4 9771.4 9801.9 9740.5 9776.8 9782.8 9822.7 9830.5 9723.5 9765.0 9784.5 9796.1 9808.1 9643.8 9723.2 9771.0 9776.6 9801.0 39067.8 39285.8 39306.4 39624.6 39716.0 3180.6 3748.6 3814.5 3903.1 3921.6 27732.6 27930.4 28030.2 28108.9 28144.9 2770.6 2777.7 2837.2 2873.4 2893.9 484572.0 489091.0 490629.5 492952.0 494755.0 37296.6 59820.7 60367.4 60844.0 60946.0 35800.1 35948.5 36143.0 36163.6 36334.8 15853.2 16080.7 16095.3 16139.8 16148.0 13266.5 13301.2 13369.3 13622.3 13692.9 8295.6 8330.4 8411.9 8416.3 8504.4 3561.9 3579.0 3601.5 3620.5 3629.9 956.4 1088.6 1106.0 1160.8 1180.5 30543.9 30613.9 30621.7 30867.5 30971.4 1147.5 1176.9 1206.4 1249.5 1252.1 12658.7 15204.6 15416.0 15455.9 16168.2 508409.0 510831.0 514315.0 515187.0 521080.0 58093.7 59816.8 59859.7 59978.7 60028.0 1562.6 1563.9 1571.5 1579.0 1585.3 30084.5 30870.7 31027.8 31608.2 31961.0 57525.7 57934.0 58121.0 58191.0 58317.4 582031.0 584122.0 589306.0 590479.0 591155.0 41122.6 43192.4 43349.8 44924.0 44977.9 35695.8 39714.4 40568.6 43489.8 44400.0 30558.0 34359.0 34999.0 36388.5 36470.6 27477.9 35573.1 36292.6 36296.0 36979.4 32698.0 38040.6 38246.6 39443.6 39666.2 29450.4 31827.4 31953.2 32013.5 32139.5 24526.0 24658.0 24815.8 24909.6 25443.9 03:41:20 INFO - PROCESS | 1972 | 03:41:20 INFO - PROCESS | 1972 | [#2] jquery.html Cycles:180 Average:37753.32 Median:11489.69 stddev:111376.60 (969.4%) stddev-sans-first:111653.75 03:41:20 INFO - PROCESS | 1972 | Values: 414.3 416.7 420.9 426.4 426.8 20204.7 20909.7 20927.3 20951.8 21982.7 20530.8 20901.6 21118.1 21289.6 21733.9 5629.9 6314.7 6318.7 6330.9 6349.7 4226.6 5991.5 6077.5 6242.3 6272.6 6203.2 6215.0 6259.4 6278.3 6308.9 6246.8 6391.5 6852.5 6852.6 6862.6 6049.8 6091.5 6104.6 6106.2 6106.7 20150.2 23728.9 24912.4 24940.8 25337.7 2246.3 2298.5 2304.3 2795.6 2805.8 9806.0 9824.8 9919.6 10024.6 10132.8 1772.0 1775.1 1797.9 1908.8 1910.6 106779.0 106985.5 107462.0 115630.0 119451.4 11912.0 12398.3 12400.0 12450.2 12465.7 15531.9 15635.4 15668.5 15695.0 15697.8 7691.3 9193.0 9328.2 9379.9 9383.4 9239.0 9339.6 9341.9 9403.2 9417.9 4064.3 4803.0 4892.3 4905.3 4918.9 1998.4 2009.2 2071.2 2077.8 2134.4 988.5 1010.8 1030.3 1036.3 1052.1 18497.3 20279.8 21936.8 22023.2 22144.8 978.3 981.6 1002.0 1082.1 1096.0 9617.4 10924.9 11141.8 11345.8 11355.0 659284.0 664715.0 664933.3 679649.0 685618.0 111975.0 136604.0 142007.0 144343.0 144437.0 1088.2 1093.6 1106.7 1110.6 1114.6 18571.0 18901.0 19031.9 19142.9 19463.0 49675.3 53775.7 55257.2 58295.4 59771.0 79211.6 82888.8 83775.0 84226.3 84333.0 11464.6 11832.9 12370.4 12745.0 12834.6 13302.9 13452.8 13651.7 13879.6 14080.9 5641.8 11121.9 11808.6 11821.3 11985.2 10267.0 11391.2 11837.8 11911.0 11934.9 11169.8 11523.3 11541.3 11990.4 12196.5 12766.9 12888.7 12942.7 12951.2 13024.5 10247.6 12081.2 12099.3 12131.3 12297.9 03:41:20 INFO - PROCESS | 1972 | 03:41:20 INFO - PROCESS | 1972 | [#3] mootools.html Cycles:180 Average:5989.57 Median:4661.68 stddev:3335.08 (71.5%) stddev-sans-first:3328.36 03:41:20 INFO - PROCESS | 1972 | Values: 1631.9 1643.9 1919.3 2001.3 2050.8 7710.2 8309.3 8941.5 9334.3 9384.2 9108.3 9145.0 9219.7 9222.6 9255.4 2133.8 2547.4 2547.5 2555.5 2559.0 2257.0 2401.6 2447.9 2583.5 2586.0 2152.5 2259.4 2540.0 2572.2 2586.9 2145.6 2547.0 2552.3 2570.9 2582.1 2552.6 2561.3 2580.5 2590.8 2601.1 9375.1 9408.3 9409.7 9416.9 9427.1 5720.9 5792.4 5796.8 5835.6 5909.2 3689.2 3774.7 3800.3 3814.1 3822.8 1050.4 1073.7 1074.3 1090.5 1090.6 12647.0 12694.7 12705.7 12716.3 12749.4 4964.5 5018.6 5060.1 5070.5 5137.2 10697.4 10731.4 10771.9 10776.5 10856.5 5682.9 5746.5 5780.1 5780.6 5785.5 4251.2 5077.7 5184.9 5198.8 5229.7 3626.5 4301.1 4318.0 4328.4 4358.9 1418.0 1444.3 1452.6 1453.6 1461.9 966.2 991.6 992.3 1013.7 1023.8 6150.7 6172.9 6195.5 6247.7 6377.1 1013.8 1025.5 1029.1 1055.6 1071.1 3963.4 4041.6 4129.2 4152.1 4213.8 10877.0 11215.3 11278.4 11352.3 11362.3 11038.2 11252.8 11263.5 11272.3 11398.6 8771.6 8830.8 8954.7 8979.2 9016.0 5866.1 6025.5 6057.8 6196.0 6213.7 10156.2 10205.8 10218.9 10233.1 10338.7 9666.4 9958.0 10032.0 10043.2 10154.4 7101.2 7805.0 7936.9 8219.4 8455.5 6925.9 8312.0 8371.4 8396.5 8423.4 6225.2 7413.9 7553.9 7720.9 7733.9 7396.2 7454.3 7475.9 7514.7 7583.6 7197.7 7267.7 7292.7 7329.4 7340.4 5076.8 5102.7 5134.3 5187.8 5194.6 5105.8 5142.4 5217.4 5242.6 5472.5 03:41:20 INFO - PROCESS | 1972 | 03:41:20 INFO - PROCESS | 1972 | [#4] prototype.html Cycles:180 Average:5947.93 Median:6700.09 stddev:1897.27 (28.3%) stddev-sans-first:1854.60 03:41:20 INFO - PROCESS | 1972 | Values: 298.8 319.6 336.4 336.6 344.6 5639.6 6713.4 6758.5 6801.1 6893.6 6616.8 6666.5 6686.8 6761.3 6782.1 5023.3 5024.3 5029.9 5036.7 5039.9 5039.9 5043.7 5044.7 5052.4 5068.3 4981.4 4988.2 4988.4 5005.4 5020.0 4796.0 4949.7 4960.9 4965.9 4978.2 4304.6 4312.6 4339.0 4348.6 4363.5 6441.6 6471.7 6496.8 6517.8 6529.6 5979.7 5981.3 5997.7 5998.5 6006.8 7261.0 7270.8 7289.0 7301.3 7314.3 4645.2 4823.8 4843.8 4871.1 4875.2 7624.2 7628.9 7685.3 7697.3 7720.2 4166.0 4909.2 4932.7 4947.0 4956.8 5037.1 5042.0 5052.7 5053.6 5070.3 4800.6 5917.9 5929.6 5942.3 5982.3 7022.1 7241.3 7246.6 7295.5 7319.7 1427.6 1445.7 1731.1 1733.1 1752.6 1050.3 1120.5 1120.5 1148.6 1153.8 5631.4 6886.7 6951.5 6982.8 7019.5 6084.4 7543.4 7556.3 7557.8 7559.0 5848.7 6736.2 6904.5 6967.6 7029.9 3548.6 3985.7 4031.1 4032.2 4039.9 7211.9 8066.4 8071.9 8074.5 8123.2 6812.5 7332.8 7814.9 7833.6 7860.3 8031.6 8066.2 8068.2 8084.0 8091.6 7382.0 7586.5 7600.3 7619.0 7628.6 6057.3 6582.2 6913.0 7406.7 7444.4 6945.8 7579.0 8053.8 8064.5 8068.0 4961.3 4963.9 4991.8 5004.5 5020.6 7312.7 7547.1 7566.7 7580.2 7633.5 5994.7 7215.2 7302.1 7307.2 7331.8 7272.7 7308.9 7319.6 7326.3 7338.4 7129.1 7153.6 7160.0 7172.8 7188.7 7097.1 7291.7 7350.4 7350.9 7397.7 5642.0 6932.2 7158.8 7190.9 7256.7 03:41:20 INFO - PROCESS | 1972 | 03:41:20 INFO - PROCESS | 1972 | [#5] yui.html Cycles:180 Average:18562.01 Median:28597.72 stddev:26397.84 (92.3%) stddev-sans-first:26437.31 03:41:20 INFO - PROCESS | 1972 | Values: 568.5 717.2 767.5 775.8 785.8 12699.7 15121.5 15314.6 15365.7 15505.5 14278.0 14306.6 14316.4 14326.7 14586.1 791.6 937.1 937.3 950.3 953.8 884.6 918.7 942.1 956.2 957.9 990.6 994.5 1036.0 1036.3 1047.1 991.8 994.5 1024.3 1029.3 1033.6 741.0 770.3 777.9 789.3 790.2 15158.2 15254.7 15270.5 15277.9 15326.8 13074.0 13170.5 13198.3 13296.5 13297.1 10034.3 10165.4 10281.2 10286.7 10427.5 3473.1 3592.1 3607.8 3699.7 3757.1 81534.6 81631.6 81660.6 82651.0 87489.6 9457.1 9490.5 9851.3 10251.3 10323.3 20705.5 20947.6 20985.0 20987.5 21418.6 7569.4 7734.7 7792.2 7821.8 7863.4 4215.0 4231.8 4261.7 4312.5 4319.8 3466.2 3708.3 3799.8 3801.9 3803.7 562.7 679.9 706.7 713.7 715.6 474.3 568.7 574.0 579.5 593.7 7902.5 7949.4 7977.6 8047.2 8357.3 517.9 557.6 576.1 584.0 589.3 3440.6 3771.5 3856.4 3860.4 4104.5 96371.0 97146.1 97701.0 98279.5 99634.0 80258.0 81073.0 82141.6 82179.0 82369.4 73009.6 74368.9 75787.2 76490.7 77889.2 8583.9 8681.5 8705.7 8842.2 8936.8 34882.0 44637.8 44961.9 46534.3 50057.7 56632.7 59002.1 64545.7 65292.7 67295.0 10985.3 11078.0 11226.8 11418.9 11728.1 11831.6 12053.4 12194.3 12486.9 12699.4 9858.6 11626.3 11678.3 11698.6 11864.1 9544.1 11700.3 11716.0 11835.8 11904.6 11200.0 11489.7 11839.6 11901.5 11908.2 9677.8 9910.0 9931.6 9941.2 10210.7 9656.9 9731.1 9774.2 9903.3 9956.8 03:41:20 INFO - PROCESS | 1972 | -------- Summary: end -------- 03:41:20 INFO - PROCESS | 1972 | 03:41:20 INFO - TEST-INFO | 1972: exit 0 03:41:20 INFO - TEST-OK | dromaeo_css | took 1109494ms 03:41:20 INFO - TEST-START | kraken 03:41:20 INFO - operating with platform_type : mac_ 03:41:20 INFO - Initialising browser for kraken test... 03:41:20 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpGIfFlR/profile http://localhost:52659/getInfo.html) 03:41:23 INFO - PROCESS | 2000 | __metrics Screen width/height:1600/1200 03:41:23 INFO - PROCESS | 2000 | colorDepth:24 03:41:23 INFO - PROCESS | 2000 | Browser inner width/height: 1024/689 03:41:23 INFO - PROCESS | 2000 | __metrics 03:41:23 ERROR - PROCESS | 2000 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 03:41:24 INFO - TEST-INFO | 2000: exit 0 03:41:24 INFO - Browser initialized. 03:41:24 INFO - Running cycle 1/1 for kraken test... 03:41:24 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpGIfFlR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:36 INFO - PROCESS | 2004 | RSS: Main: 171057152 03:41:36 INFO - PROCESS | 2004 | 03:41:39 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52659/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:39 INFO - PROCESS | 2004 | RSS: Main: 183853056 03:41:39 INFO - PROCESS | 2004 | 03:41:42 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52659/tests/kraken/driver.html?testName=audio-dft) 03:41:43 INFO - PROCESS | 2004 | RSS: Main: 192491520 03:41:43 INFO - PROCESS | 2004 | 03:41:46 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52659/tests/kraken/driver.html?testName=audio-fft) 03:41:47 INFO - PROCESS | 2004 | RSS: Main: 196030464 03:41:47 INFO - PROCESS | 2004 | 03:41:49 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52659/tests/kraken/driver.html?testName=audio-oscillator) 03:41:49 INFO - PROCESS | 2004 | RSS: Main: 196337664 03:41:49 INFO - PROCESS | 2004 | 03:41:51 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52659/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:52 INFO - PROCESS | 2004 | RSS: Main: 197894144 03:41:52 INFO - PROCESS | 2004 | 03:41:55 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52659/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:55 INFO - PROCESS | 2004 | RSS: Main: 198746112 03:41:55 INFO - PROCESS | 2004 | 03:41:58 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52659/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:59 INFO - PROCESS | 2004 | RSS: Main: 198750208 03:41:59 INFO - PROCESS | 2004 | 03:42:02 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52659/tests/kraken/driver.html?testName=json-parse-financial) 03:42:03 INFO - PROCESS | 2004 | RSS: Main: 198971392 03:42:03 INFO - PROCESS | 2004 | 03:42:04 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52659/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:05 INFO - PROCESS | 2004 | RSS: Main: 197914624 03:42:05 INFO - PROCESS | 2004 | 03:42:07 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52659/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:07 INFO - PROCESS | 2004 | RSS: Main: 197931008 03:42:07 INFO - PROCESS | 2004 | 03:42:09 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52659/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:10 INFO - PROCESS | 2004 | RSS: Main: 197857280 03:42:10 INFO - PROCESS | 2004 | 03:42:13 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:14 INFO - PROCESS | 2004 | RSS: Main: 198045696 03:42:14 INFO - PROCESS | 2004 | 03:42:16 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:17 INFO - PROCESS | 2004 | RSS: Main: 198012928 03:42:17 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:52659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52659/tests/kraken/driver.html?testName=ai-astar) 03:42:19 INFO - PROCESS | 2004 | RSS: Main: 200007680 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | __start_tp_report 03:42:19 INFO - PROCESS | 2004 | _x_x_mozilla_page_load 03:42:19 INFO - PROCESS | 2004 | _x_x_mozilla_page_load_details 03:42:19 INFO - PROCESS | 2004 | |i|pagename|runs| 03:42:19 INFO - PROCESS | 2004 | |0;ai-astar;117;111;118;118;116;132;116;115;119;117 03:42:19 INFO - PROCESS | 2004 | |1;audio-beat-detection;158;128;181;187;138;138;126;146;140;147 03:42:19 INFO - PROCESS | 2004 | |2;audio-dft;198;197;195;195;195;195;195;196;197;237 03:42:19 INFO - PROCESS | 2004 | |3;audio-fft;64;73;82;149;84;80;81;71;128;59 03:42:19 INFO - PROCESS | 2004 | |4;audio-oscillator;80;82;131;76;77;88;119;80;79;120 03:42:19 INFO - PROCESS | 2004 | |5;imaging-gaussian-blur;88;89;131;85;90;91;88;123;80;132 03:42:19 INFO - PROCESS | 2004 | |6;imaging-darkroom;93;95;103;144;103;139;153;94;129;153 03:42:19 INFO - PROCESS | 2004 | |7;imaging-desaturate;90;92;89;96;92;90;110;144;121;91 03:42:19 INFO - PROCESS | 2004 | |8;json-parse-financial;48;60;88;96;94;93;65;78;60;60 03:42:19 INFO - PROCESS | 2004 | |9;json-stringify-tinderbox;64;79;104;71;73;71;67;64;65;56 03:42:19 INFO - PROCESS | 2004 | |10;stanford-crypto-aes;83;80;79;80;81;80;81;81;84;84 03:42:19 INFO - PROCESS | 2004 | |11;stanford-crypto-ccm;130;130;147;142;152;145;129;143;175;161 03:42:19 INFO - PROCESS | 2004 | |12;stanford-crypto-pbkdf2;164;162;165;163;165;166;164;162;161;164 03:42:19 INFO - PROCESS | 2004 | |13;stanford-crypto-sha256-iterative;75;83;93;94;95;93;87;67;66;71 03:42:19 INFO - PROCESS | 2004 | __end_tp_report 03:42:19 INFO - PROCESS | 2004 | __start_cc_report 03:42:19 INFO - PROCESS | 2004 | _x_x_mozilla_cycle_collect,1047 03:42:19 INFO - PROCESS | 2004 | __end_cc_report 03:42:19 INFO - PROCESS | 2004 | __startTimestamp1467974539644__endTimestamp 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | ------- Summary: start ------- 03:42:19 INFO - PROCESS | 2004 | Number of tests: 14 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#0] ai-astar Cycles:10 Average:117.90 Median:117.50 stddev:5.43 (4.6%) stddev-sans-first:5.74 03:42:19 INFO - PROCESS | 2004 | Values: 117.0 111.0 118.0 118.0 116.0 132.0 116.0 115.0 119.0 117.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:146.50 stddev:20.70 (14.1%) stddev-sans-first:21.69 03:42:19 INFO - PROCESS | 2004 | Values: 158.0 128.0 181.0 187.0 138.0 138.0 126.0 146.0 140.0 147.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#2] audio-dft Cycles:10 Average:200.00 Median:196.50 stddev:13.05 (6.6%) stddev-sans-first:13.82 03:42:19 INFO - PROCESS | 2004 | Values: 198.0 197.0 195.0 195.0 195.0 195.0 195.0 196.0 197.0 237.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#3] audio-fft Cycles:10 Average:87.10 Median:76.50 stddev:28.69 (37.5%) stddev-sans-first:29.19 03:42:19 INFO - PROCESS | 2004 | Values: 64.0 73.0 82.0 149.0 84.0 80.0 81.0 71.0 128.0 59.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:79.50 stddev:21.27 (26.8%) stddev-sans-first:22.02 03:42:19 INFO - PROCESS | 2004 | Values: 80.0 82.0 131.0 76.0 77.0 88.0 119.0 80.0 79.0 120.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#5] imaging-gaussian-blur Cycles:10 Average:99.70 Median:88.00 stddev:20.35 (23.1%) stddev-sans-first:21.14 03:42:19 INFO - PROCESS | 2004 | Values: 88.0 89.0 131.0 85.0 90.0 91.0 88.0 123.0 80.0 132.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#6] imaging-darkroom Cycles:10 Average:120.60 Median:153.00 stddev:25.39 (16.6%) stddev-sans-first:24.88 03:42:19 INFO - PROCESS | 2004 | Values: 93.0 95.0 103.0 144.0 103.0 139.0 153.0 94.0 129.0 153.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#7] imaging-desaturate Cycles:10 Average:101.50 Median:90.50 stddev:18.26 (20.2%) stddev-sans-first:18.89 03:42:19 INFO - PROCESS | 2004 | Values: 90.0 92.0 89.0 96.0 92.0 90.0 110.0 144.0 121.0 91.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#8] json-parse-financial Cycles:10 Average:74.20 Median:83.00 stddev:17.64 (21.3%) stddev-sans-first:15.96 03:42:19 INFO - PROCESS | 2004 | Values: 48.0 60.0 88.0 96.0 94.0 93.0 65.0 78.0 60.0 60.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:69.00 stddev:13.04 (18.9%) stddev-sans-first:13.55 03:42:19 INFO - PROCESS | 2004 | Values: 64.0 79.0 104.0 71.0 73.0 71.0 67.0 64.0 65.0 56.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:1.77 (2.2%) stddev-sans-first:1.76 03:42:19 INFO - PROCESS | 2004 | Values: 83.0 80.0 79.0 80.0 81.0 80.0 81.0 81.0 84.0 84.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:146.00 stddev:14.63 (10.0%) stddev-sans-first:14.42 03:42:19 INFO - PROCESS | 2004 | Values: 130.0 130.0 147.0 142.0 152.0 145.0 129.0 143.0 175.0 161.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:164.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 03:42:19 INFO - PROCESS | 2004 | Values: 164.0 162.0 165.0 163.0 165.0 166.0 164.0 162.0 161.0 164.0 03:42:19 INFO - PROCESS | 2004 | 03:42:19 INFO - PROCESS | 2004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.40 Median:90.00 stddev:11.69 (13.0%) stddev-sans-first:12.09 03:42:19 INFO - PROCESS | 2004 | Values: 75.0 83.0 93.0 94.0 95.0 93.0 87.0 67.0 66.0 71.0 03:42:19 INFO - PROCESS | 2004 | -------- Summary: end -------- 03:42:19 INFO - PROCESS | 2004 | 03:42:20 INFO - TEST-INFO | 2004: exit 0 03:42:20 INFO - TEST-OK | kraken | took 59459ms 03:42:20 INFO - SUITE-END | took 1168s 03:42:20 INFO - Completed test suite (00:19:29) 03:42:20 INFO - javascript benchmark 03:42:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2909.7817663675223, 3641.435577485489, 3674.0080178351855, 3687.612800655933, 3703.4815125882383, 5889.823305300848, 6016.60892042017, 6023.909641355378, 6026.306974697911, 6031.125486804422, 5984.760609575612, 6003.0695242237525, 6016.368281330452, 6044.607100538462, 6063.242094738158, 5304.230886521452, 5341.412444631087, 5373.892522149555, 5410.702411367373, 5531.0, 5327.094393953018, 5379.35447746271, 5422.48486393792, 5507.642003269794, 5523.0, 5410.161424979115, 5418.674879507223, 5424.457554244584, 5425.240466334716, 5429.158480435539, 5352.116900711398, 5411.675299482024, 5427.674339539641, 5445.047116754552, 5452.836414907559, 5295.894082118336, 5407.134858422673, 5439.864003399907, 5443.237946687427, 5456.590755693339, 5784.942150578525, 5808.941910580882, 5857.76568937242, 6032.66820324882, 6129.387061293835, 6266.843328916768, 6351.0, 6351.682415879188, 6359.904601430936, 6363.96818015907, 6340.651264180468, 6364.554481186319, 6374.87250254997, 6391.45672617828, 6391.8402039948905, 4913.968066705996, 5929.258842644669, 5991.820245392645, 6070.726817293233, 6090.0, 6444.162258906312, 6533.705983230766, 6548.476121910236, 6551.868962620721, 6556.213254409406, 6273.247210334698, 6292.402221788922, 6297.96851015742, 6309.33751956038, 6314.936850631527, 6324.051392291193, 6337.429631333202, 6388.872222555523, 6409.230892292955, 6409.359064093554, 6227.252729672468, 6263.592866463757, 6312.084747711648, 6317.936820631827, 6326.936730632635, 6287.151234583364, 6293.685315734195, 6307.653079080695, 6328.886223954466, 6336.651484168415, 4907.141250281186, 5071.112555302807, 5095.1847704367865, 5110.386753589593, 5112.718800465936, 4562.543745625411, 4591.701539399928, 4594.770261486912, 4598.747068911175, 4603.861884143481, 6106.794380079809, 6245.96877015612, 6271.717772700239, 6305.211848518935, 6320.178376810985, 6305.873882522415, 6351.460125889259, 6358.523110766711, 6383.521235907233, 6408.327125651833, 6288.654124023131, 6293.276273228637, 6296.590721603081, 6299.748010079546, 6351.872962540816, 5577.079781836032, 5690.573207009408, 5713.400092990176, 5713.714314284269, 5752.108423194411, 6674.933250667528, 6694.129763130762, 6734.595924244659, 6737.056812046318, 6756.223034351113, 5543.9168412474655, 5634.464725851038, 6309.2744334400295, 6346.460550853045, 6392.456641185551, 6579.111819904251, 6632.668366581748, 6752.864942701217, 6754.560953538201, 6757.797266082025, 6309.179806625109, 6361.2048493938255, 6371.840703982252, 6377.4579160771855, 6391.616503009835, 6345.7144428499905, 6346.301906790157, 6399.8080057598345, 6418.0, 6430.292667806444, 5255.78976840922, 6170.074488826712, 6217.906731398942, 6278.277998030285, 6327.620342779448, 6110.51115910735, 6266.968665156827, 6272.121902933502, 6281.497480201664, 6297.496200303873, 5800.274965629296, 6306.243250809932, 6306.621602703853, 6312.810615681537, 6333.556651034568, 5021.447640759587, 5222.8955420892125, 6234.127222188807, 6245.313015568375, 6321.8735625288155, 5269.868253293698, 6266.780662676784, 6290.465310448663, 6319.368063193828, 6329.8734025320155], "value": 5890.497601640993, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.029863855951, 552.6766841397782, 565.4147956864645, 565.6719102920307, 565.6775637886406, 31124.53313200301, 39207.607923920754, 39217.60782392175, 39323.60676393235, 39414.60585394145, 40262.39606405899, 40608.593914060926, 40767.59232407675, 40792.796036019776, 40865.795671021675, 8868.467891926473, 9433.81132377352, 9450.621975120986, 9710.0, 9751.366161199534, 7664.808379790494, 9297.4886381249, 9565.426074435522, 9771.36486128403, 9801.852972205386, 9740.51297435129, 9776.755581110458, 9782.755431114243, 9822.705318840446, 9830.508474576243, 9723.513824308791, 9764.951175244078, 9784.461854597994, 9796.118349348557, 9808.06823351784, 9643.758906027406, 9723.222142228675, 9771.022897710243, 9776.560054797552, 9801.0, 39067.804660976515, 39285.80357098225, 39306.41040384396, 39624.60375396238, 39716.0, 3180.5865237518974, 3748.6438788315068, 3814.4906685849087, 3903.0632648164237, 3921.607839216084, 27732.584011239847, 27930.441391172266, 28030.159095227176, 28108.875644974178, 28144.85927570349, 2770.5844123381453, 2777.6805667348312, 2837.205582436921, 2873.396586716792, 2893.8842446302124, 484572.0, 489091.0, 490629.546852267, 492952.0, 494755.0, 37296.627033729856, 59820.700896496106, 60367.39632603706, 60844.0, 60946.0, 35800.10499737475, 35948.46077308842, 36143.0, 36163.638363616024, 36334.81832590873, 15853.207339632972, 16080.67838643244, 16095.275712592962, 16139.757903631455, 16148.0, 13266.469341226435, 13301.201927884358, 13369.331533423485, 13622.318884055956, 13692.863071369358, 8295.585220738938, 8330.375221858385, 8411.948506436695, 8416.326693864476, 8504.44721093127, 3561.8753343633366, 3578.982105089458, 3601.5318008659233, 3620.475031120473, 3629.891103266906, 956.4309236004566, 1088.6244245735209, 1105.9557617695202, 1160.802663547199, 1180.5454899863614, 30543.93096241621, 30613.928512501956, 30621.69378306233, 30867.536986944764, 30971.380572388876, 1147.4778975566098, 1176.864660564029, 1206.3968015992004, 1249.5130794354689, 1252.117257333596, 12658.683532911751, 15204.619884502976, 15416.0, 15455.92272038655, 16168.191590420667, 508409.0, 510831.0, 514315.0, 515187.0, 521080.0, 58093.70953145207, 59816.803663926476, 59859.700701496215, 59978.700106499185, 60028.0, 1562.5546719184977, 1563.8905276630526, 1571.4657016614635, 1579.0446779698118, 1585.2549301828121, 30084.548731768602, 30870.69129308678, 31027.844860775553, 31608.209794754395, 31961.0, 57525.712371437876, 57934.0, 58121.0, 58191.0, 58317.4168258312, 582031.0, 584122.0, 589306.0, 590479.0, 591155.0, 41122.56071037499, 43192.35211471893, 43349.78325108354, 44924.0, 44977.87555311144, 35695.82152089223, 39714.41142354273, 40568.594314056485, 43489.78255108704, 44400.0, 30558.0, 34359.0, 34999.0, 36388.454173186896, 36470.63529364672, 27477.862610687618, 35573.1106722334, 36292.63707362998, 36296.0, 36979.44530832094, 32698.019059428254, 38040.61959380481, 38246.61753382542, 39443.605563945144, 39666.206675865746, 29450.410991779616, 31827.36345273035, 31953.201169970936, 32013.519797203528, 32139.517907230944, 24526.0, 24658.0, 24815.751842481342, 24909.626355605043, 25443.87278063598], "value": 18958.20403430016, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.3019012963155, 416.67499350506614, 420.8884645568925, 426.430714995481, 426.7951383335998, 20204.69692954605, 20909.686354704674, 20927.267545635907, 20951.790482095195, 21982.670259946113, 20530.794692053074, 20901.58196836066, 21118.149049878262, 21289.57420851582, 21733.891330543363, 5629.943700563003, 6314.71583778731, 6318.652474113922, 6330.873382532347, 6349.650769207692, 4226.640735537468, 5991.460768530831, 6077.544184186182, 6242.25092988842, 6272.6236425814595, 6203.162573052626, 6215.0366693162405, 6259.374062593727, 6278.30938596754, 6308.936910630904, 6246.781362652308, 6391.48868090554, 6852.45180385568, 6852.588844669311, 6862.553933994274, 6049.818505444844, 6091.51267898567, 6104.633721976651, 6106.175666285039, 6106.694665266719, 20150.193992240293, 23728.881355593283, 24912.377190570198, 24940.750592494205, 25337.733113344442, 2246.3261021693424, 2298.482841360697, 2304.331743794298, 2795.566687163493, 2805.8316501010004, 9806.0, 9824.803503929952, 9919.603215871357, 10024.59901603935, 10132.797344053077, 1772.0342413384735, 1775.0858307971405, 1797.8651601129836, 1908.8472922166193, 1910.646530391868, 106779.0, 106985.46507267414, 107462.0, 115630.0, 119451.4027429866, 11912.04703623708, 12398.25610463375, 12400.00799936003, 12450.190737602026, 12465.688357790947, 15531.922340388452, 15635.374585016472, 15668.451604193799, 15694.979826311253, 15697.822663300298, 7691.30778229962, 9192.95403522978, 9328.207102396373, 9379.874415070235, 9383.436993780395, 9238.953805231065, 9339.626414943326, 9341.90658093424, 9403.247740180768, 9417.905820941703, 4064.349704047338, 4802.975985120122, 4892.2661600760175, 4905.3132561441425, 4918.877028074256, 1998.3505360757813, 2009.2264478175716, 2071.2025870039843, 2077.802608752166, 2134.4450442884963, 988.5403287471361, 1010.8231059564547, 1030.314840630987, 1036.2849633752687, 1052.095198129608, 18497.260109595467, 20279.797202027792, 21936.780632193793, 22023.22918697838, 22144.778552214593, 978.295627148452, 981.6122631560636, 1002.0330381182195, 1082.0586090101503, 1095.9890401096047, 9617.374870633526, 10924.945375273073, 11141.832872506919, 11345.773084538263, 11355.034822040054, 659284.0, 664715.0, 664933.2557179165, 679649.0, 685618.0, 111975.0, 136604.0, 142007.0, 144343.0, 144437.0, 1088.1838621034224, 1093.573506332531, 1106.6679996001167, 1110.584005393114, 1114.5764609448358, 18571.0, 18901.0, 19031.90484047571, 19142.947137907548, 19463.026848657228, 49675.254871176236, 53775.73112134414, 55257.17114243209, 58295.4170458307, 59771.0, 79211.60394197992, 82888.75666864881, 83775.0, 84226.31547368896, 84333.0, 11464.598739044093, 11832.881671183522, 12370.381480926098, 12745.0, 12834.55079072228, 13302.93348533251, 13452.798208027083, 13651.726965460834, 13879.583612491642, 14080.929595351958, 5641.830745077655, 11121.888781112086, 11808.586699465477, 11821.290722556674, 11985.22096063753, 10267.0, 11391.202615816814, 11837.82243266369, 11911.0, 11934.940325298665, 11169.776604467703, 11523.250988686044, 11541.307521548733, 11990.40047997614, 12196.451159698012, 12766.936165319114, 12888.742225155633, 12942.67643308887, 12951.158174718614, 13024.47902083906, 10247.590096396061, 12081.154319197572, 12099.274043557414, 12131.272123672608, 12297.877021230031], "value": 10247.626316326869, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1631.8694504439645, 1643.868490520758, 1919.2898627507825, 2001.279539365828, 2050.8256798172156, 7710.190430004845, 8309.335253179746, 8941.463512189273, 9334.346595738301, 9384.155426011666, 9108.271338292938, 9145.039770824067, 9219.723408297745, 9222.584983675733, 9255.352125351228, 2133.775953524877, 2547.350425641459, 2547.4905018996183, 2555.540002799495, 2559.0, 2257.0, 2401.6157414813633, 2447.865367404792, 2583.509133264674, 2586.0431640293023, 2152.4511249631323, 2259.4464356232747, 2539.9840063974375, 2572.2026171886682, 2586.922392328233, 2145.5816115857415, 2546.9745302547017, 2552.2981180175416, 2570.910018149365, 2582.1349847801007, 2552.5788244939563, 2561.2828408045775, 2580.4710034443083, 2590.818642695012, 2601.115620688975, 9375.06249375057, 9408.294377921684, 9409.717708468757, 9416.90583094167, 9427.104425079675, 5720.942790572082, 5792.420757924216, 5796.82609521715, 5835.562332825055, 5909.172715819789, 3689.2068205335713, 3774.698024158061, 3800.3159431302356, 3814.0846196912817, 3822.808859557011, 1050.406520316019, 1073.693997210799, 1074.2641290715885, 1090.4711215060688, 1090.5910283643634, 12646.988240940702, 12694.682632934251, 12705.745885082246, 12716.300603466805, 12749.42627581761, 4964.478729733398, 5018.648694591417, 5060.114479965991, 5070.518300761421, 5137.229415587692, 10697.358158510515, 10731.443940628722, 10771.89228107709, 10776.515056822462, 10856.457177141112, 5682.943170568324, 5746.482816546447, 5780.132980053026, 5780.5953583248765, 5785.450382213683, 4251.234777740036, 5077.669951453144, 5184.870378240499, 5198.766055527511, 5229.712365819916, 3626.546681664792, 4301.07526881722, 4317.956820431818, 4328.372386004012, 4358.877237749668, 1417.9929100354432, 1444.2850788859582, 1452.6345235478827, 1453.5784622459369, 1461.8903582231376, 966.2415004221652, 991.5637119667323, 992.2855544008303, 1013.6604237580345, 1023.8072645368212, 6150.692465376803, 6172.9074063889075, 6195.504359651217, 6247.718852651642, 6377.139086223393, 1013.807376598444, 1025.497506221946, 1029.1149611334247, 1055.551390658967, 1071.121680222226, 3963.3856752203455, 4041.5756345583877, 4129.174165166979, 4152.148809494047, 4213.810378532973, 10877.0, 11215.32708037504, 11278.379689117013, 11352.262102963281, 11362.261453005529, 11038.227324087236, 11252.831207531894, 11263.493142808593, 11272.267302625303, 11398.601048963412, 8771.649134034695, 8830.823383532294, 8954.731358059269, 8979.191872731486, 9016.0, 5866.149408335853, 6025.457708806229, 6057.757689692363, 6196.008638617799, 6213.689315534296, 10156.238282129018, 10205.795884082128, 10218.948905255425, 10233.079022887976, 10338.689839304832, 9666.420014799134, 9957.950210248902, 10031.996800320201, 10043.196544276294, 10154.39073655583, 7101.218865924848, 7805.0, 7936.880946785687, 8219.383546234176, 8455.492670439793, 6925.861482770216, 8312.0, 8371.41400101987, 8396.454230475, 8423.410361274897, 6225.221847269091, 7413.888791668237, 7553.924460755322, 7720.884186737316, 7733.92266077332, 7396.186419493959, 7454.291842274975, 7475.850482990419, 7514.661840217094, 7583.582902940391, 7197.71209151628, 7267.709291628275, 7292.708291668486, 7329.377002954595, 7340.412766978522, 5076.822311219237, 5102.659104228489, 5134.255532947627, 5187.754938814582, 5194.584433245256, 5105.821296254613, 5142.408623008402, 5217.373915130209, 5242.606804489602, 5472.50747432733], "value": 4846.072926660679, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7774108289325, 319.594115473349, 336.3810588517128, 336.5533211336842, 344.61059003326227, 5639.6334238274485, 6713.355227969155, 6758.45932325414, 6801.149856267966, 6893.586384816915, 6616.801495955129, 6666.50001249907, 6686.832829179273, 6761.256261811197, 6782.118324617805, 5023.271625614284, 5024.346834911456, 5029.949700503003, 5036.6726162799305, 5039.949600504003, 5039.916417970136, 5043.697378157304, 5044.672096313746, 5052.444231134572, 5068.34111565496, 4981.352424184851, 4988.201887697969, 4988.401391832967, 5005.399352077738, 5019.974900125494, 4795.952040479586, 4949.678270912379, 4960.851174464772, 4965.851024469253, 4978.178600530908, 4304.5910638489295, 4312.633426158749, 4339.002029533225, 4348.565143485658, 4363.476382834048, 6441.645709485976, 6471.741130354781, 6496.805095847132, 6517.804465866032, 6529.575577587441, 5979.730912108966, 5981.282246130492, 5997.7001149942325, 5998.4601385875485, 6006.819795406102, 7261.019762332123, 7270.818229544251, 7288.963555182243, 7301.2698730127095, 7314.305141011649, 4645.187092258841, 4823.807047718087, 4843.782029808667, 4871.050145221683, 4875.195592727196, 7624.19945905683, 7628.923710762877, 7685.308322251024, 7697.307242348215, 7720.227977202291, 4165.958340416557, 4909.214525675875, 4932.654714169974, 4946.950530494649, 4956.826511072095, 5037.11850426174, 5041.974790126026, 5052.69683818972, 5053.646244762905, 5070.264811602371, 4800.591949684246, 5917.881642367214, 5929.584929054925, 5942.346341902387, 5982.312034116046, 7022.08712867324, 7241.348278654947, 7246.601436920914, 7295.452841036943, 7319.707211711579, 1427.6216802547333, 1445.6964037552023, 1731.073875476614, 1733.0641453614908, 1752.6144248265362, 1050.3120456101267, 1120.5237773946203, 1120.5405783628673, 1148.55780524497, 1153.7577108807245, 5631.352394474688, 6886.724531018703, 6951.513394062367, 6982.79051628452, 7019.473539484559, 6084.421979911901, 7543.434242431839, 7556.282153195438, 7557.811054723676, 7559.0, 5848.713283077716, 6736.191657001191, 6904.4821638377325, 6967.581945083311, 7029.89455158173, 3548.574171099433, 3985.720999530005, 4031.133306339151, 4032.1532478179324, 4039.8586049488126, 7211.8557628848175, 8066.354691624656, 8071.878921816177, 8074.475159114639, 8123.228293312126, 6812.523123381415, 7332.816679583053, 7814.921850781533, 7833.608319583998, 7860.292573668397, 8031.598420078973, 8066.1933806620045, 8068.193180681885, 8083.959580202179, 8091.635876385577, 7382.0, 7586.468947173866, 7600.2779735925, 7618.961905190438, 7628.580428076509, 6057.333693293646, 6582.243042050034, 6912.953543912871, 7406.666699998405, 7444.441666875115, 6945.826354341182, 7579.0, 8053.83892322162, 8064.516129032277, 8068.0, 4961.330220420341, 4963.925541116814, 4991.80032798684, 5004.524570165829, 5020.598352131748, 7312.670929808065, 7547.0943486781935, 7566.697332106654, 7580.241975802596, 7633.503822251536, 5994.70026498682, 7215.242399547972, 7302.087239095114, 7307.2367730619835, 7331.816704582428, 7272.745453909088, 7308.926910730825, 7319.560826350436, 7326.289272969036, 7338.412926965937, 7129.073220481304, 7153.606551639502, 7160.0, 7172.784816455514, 7188.712451501881, 7097.148342198969, 7291.708331666674, 7350.411967042731, 7350.889736654061, 7397.704091836266, 5642.025291148066, 6932.237453879969, 7158.785236442915, 7190.928090719235, 7256.714135047654], "value": 5309.290010362797, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.4798409455349, 717.2003216413699, 767.4512723402765, 775.7595145504894, 785.8114052627371, 12699.682507937294, 15121.470748523803, 15314.617134571627, 15365.69268614627, 15505.457308994188, 14278.0, 14306.642333941656, 14316.42734290627, 14326.713465730705, 14586.124832510057, 791.6279348706099, 937.1237892570434, 937.2736129499624, 950.301528376646, 953.7567920180344, 884.5577211394303, 918.6738707758716, 942.0673533202115, 956.2159029595699, 957.8850537935457, 990.5938565188275, 994.4530508220486, 1035.9741006474824, 1036.3263878478974, 1047.1151876664244, 991.7768502087044, 994.4729293474434, 1024.2727663359024, 1029.3206483720746, 1033.6175615022453, 740.9555426674417, 770.2951799103813, 777.8949841771345, 789.2896393246067, 790.2295262119445, 15158.242087895671, 15254.694906101928, 15270.541883743506, 15277.923610381877, 15326.770098448533, 13074.019448541303, 13170.473181072746, 13198.340082995812, 13296.468141274338, 13297.135686180367, 10034.347767395097, 10165.390076595353, 10281.228907831943, 10286.691399258034, 10427.530761115691, 3473.0987004564563, 3592.119930616989, 3607.8196090195383, 3699.722520810923, 3757.0982964088694, 81534.59232703799, 81631.5918420404, 81660.59169704173, 82651.0, 87489.56255218748, 9457.10157535033, 9490.525473726286, 9851.310408271353, 10251.33366331201, 10323.328983616191, 20705.482362940747, 20947.581048379252, 20985.0, 20987.475313117295, 21418.571628567654, 7569.394448444111, 7734.690612375442, 7792.220777922275, 7821.765347039598, 7863.410244231705, 4214.978925105354, 4231.809568569361, 4261.722988005832, 4312.525622181557, 4319.762413067248, 3466.1507930557177, 3708.2583483303447, 3799.772013679188, 3801.9429708554394, 3803.7147213959065, 562.7270773674765, 679.9359003160039, 706.6996526476227, 713.6717110129399, 715.6278735057845, 474.2743602288504, 568.6987040231413, 574.029889486766, 579.507418694115, 593.6616128806625, 7902.4863383879865, 7949.364050875916, 7977.5612341321785, 8047.155048719917, 8357.289630381485, 517.9459799308389, 557.6013150597342, 576.0638961687258, 584.0025028678688, 589.2987345059452, 3440.569928758905, 3771.4908487353855, 3856.402257650069, 3860.4209368594375, 4104.527979282361, 96371.0, 97146.05707885802, 97701.0, 98279.50860245652, 99634.00365996247, 80258.0, 81073.0, 82141.58929205316, 82179.0, 82369.3526129474, 73009.63495182597, 74368.88446673196, 75787.24212757913, 76490.70527884172, 77889.22110778933, 8583.914160858312, 8681.522516261413, 8705.651773929225, 8842.24840888506, 8936.821263574562, 34882.0, 44637.776811115735, 44961.87595310144, 46534.30198546957, 50057.749711251214, 56632.7168364172, 59002.11496827637, 64545.70908581896, 65292.67353663201, 67295.0, 10985.340879547253, 11078.0, 11226.831597526207, 11418.942905285421, 11728.12039097054, 11831.585894493652, 12053.397330133634, 12194.268343899394, 12486.875131248571, 12699.36503174856, 9858.605655773688, 11626.302421854716, 11678.286480318058, 11698.590549330733, 11864.070740315075, 9544.08197613963, 11700.29798212076, 11715.966936900406, 11835.822462662894, 11904.620324671587, 11200.0, 11489.680417842595, 11839.58561450345, 11901.523939042341, 11908.225965312227, 9677.758056048655, 9910.0, 9931.553080111267, 9941.204703623838, 10210.693679189637, 9656.855147172939, 9731.12419882214, 9774.218062554837, 9903.306768526134, 9956.800863982824], "value": 7038.513872011415, "unit": "score"}], "name": "dromaeo_css", "value": 7692.819400940916, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 118.0, 118.0, 116.0, 132.0, 116.0, 115.0, 119.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 181.0, 187.0, 138.0, 138.0, 126.0, 146.0, 140.0, 147.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 197.0, 195.0, 195.0, 195.0, 195.0, 195.0, 196.0, 197.0, 237.0], "value": 200.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 82.0, 149.0, 84.0, 80.0, 81.0, 71.0, 128.0, 59.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 131.0, 76.0, 77.0, 88.0, 119.0, 80.0, 79.0, 120.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 131.0, 85.0, 90.0, 91.0, 88.0, 123.0, 80.0, 132.0], "value": 99.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 103.0, 144.0, 103.0, 139.0, 153.0, 94.0, 129.0, 153.0], "value": 120.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 89.0, 96.0, 92.0, 90.0, 110.0, 144.0, 121.0, 91.0], "value": 101.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 60.0, 88.0, 96.0, 94.0, 93.0, 65.0, 78.0, 60.0, 60.0], "value": 74.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 79.0, 104.0, 71.0, 73.0, 71.0, 67.0, 64.0, 65.0, 56.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 79.0, 80.0, 81.0, 80.0, 81.0, 81.0, 84.0, 84.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 147.0, 142.0, 152.0, 145.0, 129.0, 143.0, 175.0, 161.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 165.0, 163.0, 165.0, 166.0, 164.0, 162.0, 161.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 93.0, 94.0, 95.0, 93.0, 87.0, 67.0, 66.0, 71.0], "value": 82.4, "unit": "score"}], "name": "kraken", "value": 1587.2000000000003, "alertThreshold": 2.0}]} 03:42:20 INFO - Return code: 0 03:42:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:42:20 ERROR - # TBPL SUCCESS # 03:42:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:42:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:42:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:42:20 INFO - 2016-07-08 03:42:20.970 screenresolution[2009:21715] starting screenresolution argv=screenresolution get 03:42:20 INFO - 2016-07-08 03:42:20.972 screenresolution[2009:21715] Display 0: 1600x1200x32@60 03:42:20 INFO - 2016-07-08 03:42:20.978 screenresolution[2010:21718] starting screenresolution argv=screenresolution list 03:42:20 INFO - Available Modes on Display 0 03:42:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:42:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:42:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:42:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:42:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:42:21 INFO - Intel Iris: 03:42:21 INFO - Chipset Model: Intel Iris 03:42:21 INFO - Type: GPU 03:42:21 INFO - Bus: Built-In 03:42:21 INFO - VRAM (Dynamic, Max): 1536 MB 03:42:21 INFO - Vendor: Intel (0x8086) 03:42:21 INFO - Device ID: 0x0a2e 03:42:21 INFO - Revision ID: 0x0009 03:42:21 INFO - Displays: 03:42:21 INFO - Display: 03:42:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:42:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:42:21 INFO - Display Serial Number: 1600x1200 60 03:42:21 INFO - Main Display: Yes 03:42:21 INFO - Mirror: Off 03:42:21 INFO - Online: Yes 03:42:21 INFO - Rotation: Supported 03:42:21 INFO - Return code: 0 03:42:21 INFO - Running post-action listener: _resource_record_post_action 03:42:21 INFO - Running post-run listener: _resource_record_post_run 03:42:22 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 1019904; Write bytes: 498399744; Read time: 7; Write time: 1565 03:42:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191119872; Write bytes: 191002624; Read time: 17258; Write time: 404 03:42:22 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 1019904; Write bytes: 300814848; Read time: 7; Write time: 1133 03:42:22 INFO - Running post-run listener: _upload_blobber_files 03:42:22 INFO - Blob upload gear active. 03:42:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:42:22 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 03:42:22 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:42:22 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:42:22 INFO - (blobuploader) - INFO - Open directory for files ... 03:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:42:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:23 INFO - (blobuploader) - INFO - Done attempting. 03:42:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:42:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:42:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:24 INFO - (blobuploader) - INFO - Done attempting. 03:42:24 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:24 INFO - Return code: 0 03:42:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b08d38ebb6fba823338749b09db4785239951970637c2b910b5d754619ea01fd8c136a9cda3976686f56b011ee0985ec1b24cde79c61c7069e78d915c8a6570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f98eb26acbc528473c8bb8f187a46e373f3d2caccdede79533a464e0d24387658079a585e9ec9e3ac35b3c3852ae4ba3b481c1c113582788dbad92a234dfe032"} 03:42:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:24 INFO - Contents: 03:42:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b08d38ebb6fba823338749b09db4785239951970637c2b910b5d754619ea01fd8c136a9cda3976686f56b011ee0985ec1b24cde79c61c7069e78d915c8a6570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f98eb26acbc528473c8bb8f187a46e373f3d2caccdede79533a464e0d24387658079a585e9ec9e3ac35b3c3852ae4ba3b481c1c113582788dbad92a234dfe032"} 03:42:24 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:24 INFO - Copying logs to upload dir... 03:42:24 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.120866 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-07-08 03:42:24.994864) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 03:42:24.998409) ========= 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.dkL9IhdftA/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.v01mzz2rwq/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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/Mozilla-Beta/sha512/1b08d38ebb6fba823338749b09db4785239951970637c2b910b5d754619ea01fd8c136a9cda3976686f56b011ee0985ec1b24cde79c61c7069e78d915c8a6570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f98eb26acbc528473c8bb8f187a46e373f3d2caccdede79533a464e0d24387658079a585e9ec9e3ac35b3c3852ae4ba3b481c1c113582788dbad92a234dfe032"} build_url:https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b08d38ebb6fba823338749b09db4785239951970637c2b910b5d754619ea01fd8c136a9cda3976686f56b011ee0985ec1b24cde79c61c7069e78d915c8a6570", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f98eb26acbc528473c8bb8f187a46e373f3d2caccdede79533a464e0d24387658079a585e9ec9e3ac35b3c3852ae4ba3b481c1c113582788dbad92a234dfe032"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 03:42:25.031226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:42:25.031545) ========= 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.dkL9IhdftA/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.v01mzz2rwq/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.005303 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:42:25.080098) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 03:42:25.080419) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 03:42:25.080741) ========= ========= Total master_lag: 0.18 =========