builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0193 starttime: 1467644948.68 results: success (0) buildid: 20160704064626 builduid: 71b343b4f7574b7684a5cbed19eef54c revision: ebaf4086c18c2d1e3f0af12ade55840413342bc3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:08.679784) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:08.680258) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:08.680543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:08.706129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:08.706590) ========= 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.I7b7fSfOse/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.xivNXvuA7X/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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-04 08:09:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.5M=0s 2016-07-04 08:09:08 (29.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169814 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:08.898627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:08.898986) ========= 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.I7b7fSfOse/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.xivNXvuA7X/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.029368 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:08.948178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-04 08:09:08.948546) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ebaf4086c18c2d1e3f0af12ade55840413342bc3 --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 ebaf4086c18c2d1e3f0af12ade55840413342bc3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I7b7fSfOse/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.xivNXvuA7X/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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-04 08:09:09,023 truncating revision to first 12 chars 2016-07-04 08:09:09,023 Setting DEBUG logging. 2016-07-04 08:09:09,023 attempt 1/10 2016-07-04 08:09:09,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ebaf4086c18c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 08:09:10,896 unpacking tar archive at: mozilla-beta-ebaf4086c18c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.115692 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-04 08:09:11.086318) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:11.086687) ========= script_repo_revision: ebaf4086c18c2d1e3f0af12ade55840413342bc3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:11.087120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:11.087390) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 08:09:11.105481) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-04 08:09:11.105920) ========= /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.I7b7fSfOse/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.xivNXvuA7X/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 08:09:11 INFO - MultiFileLogger online at 20160704 08:09:11 in /builds/slave/test 08:09:11 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 08:09:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:09:11 INFO - {'append_to_log': False, 08:09:11 INFO - 'base_work_dir': '/builds/slave/test', 08:09:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:09:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:09:11 INFO - 'branch': 'Mozilla-Beta', 08:09:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:09:11 INFO - 'config_files': ('talos/mac_config.py',), 08:09:11 INFO - 'default_actions': ('clobber', 08:09:11 INFO - 'read-buildbot-config', 08:09:11 INFO - 'download-and-extract', 08:09:11 INFO - 'populate-webroot', 08:09:11 INFO - 'create-virtualenv', 08:09:11 INFO - 'install', 08:09:11 INFO - 'run-tests'), 08:09:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:09:11 INFO - 'download_minidump_stackwalk': True, 08:09:11 INFO - 'download_symbols': 'ondemand', 08:09:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:09:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:09:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:09:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:09:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:09:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:09:11 INFO - 'installer_path': 'installer.exe', 08:09:11 INFO - 'log_level': 'info', 08:09:11 INFO - 'log_name': 'talos', 08:09:11 INFO - 'log_to_console': True, 08:09:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:09:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:09:11 INFO - 'opt_config_files': (), 08:09:11 INFO - 'pip_index': False, 08:09:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:09:11 INFO - 'cmd': ('bash', 08:09:11 INFO - '-c', 08:09:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:09:11 INFO - 'enabled': True, 08:09:11 INFO - 'halt_on_failure': False, 08:09:11 INFO - 'name': 'check_screen_resolution'},), 08:09:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:09:11 INFO - 'cmd': ('bash', 08:09:11 INFO - '-c', 08:09:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:09:11 INFO - 'enabled': True, 08:09:11 INFO - 'halt_on_failure': False, 08:09:11 INFO - 'name': 'check_screen_resolution'},), 08:09:11 INFO - 'run_cmd_checks_enabled': True, 08:09:11 INFO - 'sps_profile': False, 08:09:11 INFO - 'sps_profile_interval': 0, 08:09:11 INFO - 'suite': 'dromaeojs-e10s', 08:09:11 INFO - 'system_bits': '32', 08:09:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:09:11 INFO - 'title': 't-yosemite-r7-0193', 08:09:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:09:11 INFO - 'use_talos_json': True, 08:09:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:09:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:09:11 INFO - 'work_dir': 'build'} 08:09:11 INFO - ##### 08:09:11 INFO - ##### Running clobber step. 08:09:11 INFO - ##### 08:09:11 INFO - Running pre-action listener: _resource_record_pre_action 08:09:11 INFO - Running main action method: clobber 08:09:11 INFO - rmtree: /builds/slave/test/build 08:09:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:13 INFO - Running post-action listener: _resource_record_post_action 08:09:13 INFO - ##### 08:09:13 INFO - ##### Running read-buildbot-config step. 08:09:13 INFO - ##### 08:09:13 INFO - Running pre-action listener: _resource_record_pre_action 08:09:13 INFO - Running main action method: read_buildbot_config 08:09:13 INFO - Using buildbot properties: 08:09:13 INFO - { 08:09:13 INFO - "project": "", 08:09:13 INFO - "product": "firefox", 08:09:13 INFO - "script_repo_revision": "production", 08:09:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 08:09:13 INFO - "repository": "", 08:09:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 08:09:13 INFO - "buildid": "20160704064626", 08:09:13 INFO - "pgo_build": "False", 08:09:13 INFO - "basedir": "/builds/slave/test", 08:09:13 INFO - "buildnumber": 16, 08:09:13 INFO - "slavename": "t-yosemite-r7-0193", 08:09:13 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:09:13 INFO - "platform": "yosemite_r7", 08:09:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:09:13 INFO - "branch": "mozilla-beta", 08:09:13 INFO - "repo_path": "releases/mozilla-beta", 08:09:13 INFO - "revision": "ebaf4086c18c2d1e3f0af12ade55840413342bc3", 08:09:13 INFO - "stage_platform": "macosx64", 08:09:13 INFO - "builduid": "71b343b4f7574b7684a5cbed19eef54c", 08:09:13 INFO - "slavebuilddir": "test" 08:09:13 INFO - } 08:09:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 08:09:13 INFO - Running post-action listener: _resource_record_post_action 08:09:13 INFO - ##### 08:09:13 INFO - ##### Running download-and-extract step. 08:09:13 INFO - ##### 08:09:13 INFO - Running pre-action listener: _resource_record_pre_action 08:09:13 INFO - Running main action method: download_and_extract 08:09:13 INFO - mkdir: /builds/slave/test/build/tests 08:09: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')]} 08:09:13 INFO - https://queue.taskcluster.net/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:09:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:09:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:09:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/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 08:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/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 08:09:22 INFO - Downloaded 1165 bytes. 08:09:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:09:22 INFO - Using the following test package requirements: 08:09:22 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:09:22 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:09:22 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 08:09:22 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:09:22 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 08:09:22 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:09:22 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:09:22 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 08:09:22 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:09:22 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:09:22 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 08:09:22 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:09:22 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 08:09:22 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:09:22 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 08:09:22 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:09:22 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 08:09:22 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 08:09: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')]} 08:09:22 INFO - https://queue.taskcluster.net/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:09:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:09:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:09:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/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 08:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/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 08:09:25 INFO - Downloaded 18351343 bytes. 08:09:25 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'] 08:09:25 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 08:09:28 INFO - Return code: 0 08:09:28 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 08:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:28 INFO - https://queue.taskcluster.net/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/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 08:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/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 08:09:31 INFO - Downloaded 18351343 bytes. 08:09:31 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'] 08:09:31 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 08:09:35 INFO - Return code: 0 08:09: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')]} 08:09:35 INFO - https://queue.taskcluster.net/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:09:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:09:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:09:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/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 08:09:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/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 08:09:36 INFO - Downloaded 10840145 bytes. 08:09:36 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'] 08:09:36 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 08:09:36 INFO - Return code: 0 08:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:36 INFO - https://queue.taskcluster.net/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 08:09:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:09:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:09:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 08:09:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BW1kiYJrRpqN7ZNZb5e67g/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 08:09:39 INFO - Downloaded 86196615 bytes. 08:09:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:09:39 INFO - mkdir: /builds/slave/test/properties 08:09:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:39 INFO - Contents: 08:09:39 INFO - build_url:https://queue.taskcluster.net/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:09:41 INFO - Running post-action listener: _resource_record_post_action 08:09:41 INFO - Running post-action listener: set_extra_try_arguments 08:09:41 INFO - ##### 08:09:41 INFO - ##### Running populate-webroot step. 08:09:41 INFO - ##### 08:09:41 INFO - Running pre-action listener: _resource_record_pre_action 08:09:41 INFO - Running main action method: populate_webroot 08:09:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:41 INFO - '--tppagecycles', 08:09:41 INFO - '7'], 08:09:41 INFO - 'tests': ['tsvgm']}}, 08:09:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:09:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:09:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:09:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:09:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:41 INFO - 'talos_options': ['--disable-e10s'], 08:09:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:41 INFO - 'talos_options': ['--disable-e10s'], 08:09:41 INFO - 'tests': ['damp', 'tps']}, 08:09:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:41 INFO - 'tests': ['damp', 'tps']}, 08:09:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:09:41 INFO - 'tests': ['dromaeo_dom']}, 08:09:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:09:41 INFO - 'tests': ['a11yr', 08:09:41 INFO - 'ts_paint', 08:09:41 INFO - 'tpaint', 08:09:41 INFO - 'sessionrestore', 08:09:41 INFO - 'sessionrestore_no_auto_restore', 08:09:41 INFO - 'tabpaint']}, 08:09:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:09:41 INFO - 'ts_paint', 08:09:41 INFO - 'tpaint', 08:09:41 INFO - 'sessionrestore', 08:09:41 INFO - 'sessionrestore_no_auto_restore', 08:09:41 INFO - 'tabpaint']}, 08:09:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:09:41 INFO - 'ts_paint', 08:09:41 INFO - 'tpaint', 08:09:41 INFO - 'sessionrestore', 08:09:41 INFO - 'sessionrestore_no_auto_restore', 08:09:41 INFO - 'tabpaint']}, 08:09:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:09:41 INFO - 'ts_paint', 08:09:41 INFO - 'tpaint', 08:09:41 INFO - 'sessionrestore', 08:09:41 INFO - 'sessionrestore_no_auto_restore', 08:09:41 INFO - 'tabpaint']}, 08:09:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:09:41 INFO - 'tests': ['a11yr', 08:09:41 INFO - 'ts_paint', 08:09:41 INFO - 'tpaint', 08:09:41 INFO - 'sessionrestore', 08:09:41 INFO - 'sessionrestore_no_auto_restore', 08:09:41 INFO - 'tabpaint']}, 08:09:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:09:41 INFO - 'tests': ['a11yr', 08:09:41 INFO - 'ts_paint', 08:09:41 INFO - 'tpaint', 08:09:41 INFO - 'sessionrestore', 08:09:41 INFO - 'sessionrestore_no_auto_restore', 08:09:41 INFO - 'tabpaint']}, 08:09:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:09:41 INFO - 'tests': ['tsvgx', 08:09:41 INFO - 'tsvgr_opacity', 08:09:41 INFO - 'tart', 08:09:41 INFO - 'tscrollx', 08:09:41 INFO - 'cart']}, 08:09:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:09:41 INFO - 'tsvgr_opacity', 08:09:41 INFO - 'tart', 08:09:41 INFO - 'tscrollx', 08:09:41 INFO - 'cart']}, 08:09:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:41 INFO - 'talos_options': ['--disable-e10s'], 08:09:41 INFO - 'tests': ['tp5o']}, 08:09:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:41 INFO - 'tests': ['tp5o']}, 08:09:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:41 INFO - 'talos_options': ['--disable-e10s', 08:09:41 INFO - '--xperf_path', 08:09:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:41 INFO - 'tests': ['tp5n']}, 08:09:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:41 INFO - 'talos_options': ['--xperf_path', 08:09:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:41 INFO - 'tests': ['tp5n']}}, 08:09:41 INFO - 'talos.zip': {'path': '', 08:09:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:41 INFO - Running post-action listener: _resource_record_post_action 08:09:41 INFO - ##### 08:09:41 INFO - ##### Running create-virtualenv step. 08:09:41 INFO - ##### 08:09:41 INFO - Running pre-action listener: _resource_record_pre_action 08:09:41 INFO - Running main action method: create_virtualenv 08:09:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:41 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 08:09:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:41 INFO - Using real prefix '/tools/python27' 08:09:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:44 INFO - Installing pip.................done. 08:09:44 INFO - Return code: 0 08:09:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:44 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')]} 08:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:44 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')]} 08:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:44 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 0x10668aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10669a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1705dd980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106529e00>, '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 0x106392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106524b20>, '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.I7b7fSfOse/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.xivNXvuA7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 08:09:44 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 08:09:44 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 08:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I7b7fSfOse/Render', 08:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:44 INFO - 'HOME': '/Users/cltbld', 08:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:44 INFO - 'LOGNAME': 'cltbld', 08:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:44 INFO - 'MOZ_NO_REMOTE': '1', 08:09:44 INFO - 'NO_EM_RESTART': '1', 08:09:44 INFO - 'PAGER': '/bin/cat', 08:09:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:44 INFO - 'PWD': '/builds/slave/test', 08:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:44 INFO - 'SHELL': '/bin/bash', 08:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xivNXvuA7X/Listeners', 08:09:44 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:44 INFO - 'USER': 'cltbld', 08:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:44 INFO - 'XPC_FLAGS': '0x0', 08:09:44 INFO - 'XPC_SERVICE_NAME': '0', 08:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:45 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 08:09:45 INFO - Cleaning up... 08:09:45 INFO - Return code: 0 08:09:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10668aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10669a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1705dd980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106529e00>, '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 0x106392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106524b20>, '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.I7b7fSfOse/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.xivNXvuA7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 08:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:09:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I7b7fSfOse/Render', 08:09:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:45 INFO - 'HOME': '/Users/cltbld', 08:09:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:45 INFO - 'LOGNAME': 'cltbld', 08:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:45 INFO - 'MOZ_NO_REMOTE': '1', 08:09:45 INFO - 'NO_EM_RESTART': '1', 08:09:45 INFO - 'PAGER': '/bin/cat', 08:09:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:45 INFO - 'PWD': '/builds/slave/test', 08:09:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:45 INFO - 'SHELL': '/bin/bash', 08:09:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xivNXvuA7X/Listeners', 08:09:45 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:09:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:45 INFO - 'USER': 'cltbld', 08:09:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:45 INFO - 'XPC_FLAGS': '0x0', 08:09:45 INFO - 'XPC_SERVICE_NAME': '0', 08:09:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:45 INFO - Downloading/unpacking psutil>=0.7.1 08:09:45 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 08:09:45 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 08:09:45 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 08:09:45 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 08:09:45 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 08:09:45 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 08:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:48 INFO - Installing collected packages: psutil 08:09:48 INFO - Running setup.py install for psutil 08:09:48 INFO - building 'psutil._psutil_osx' extension 08:09:48 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 08:09:48 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 08:09:49 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 08:09:49 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 08:09:49 INFO - building 'psutil._psutil_posix' extension 08:09:49 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 08:09:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:09:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:09:49 INFO - ^ 08:09:49 INFO - 1 warning generated. 08:09:49 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 08:09:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:49 INFO - Successfully installed psutil 08:09:49 INFO - Cleaning up... 08:09:49 INFO - Return code: 0 08:09:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:49 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 0x10668aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10669a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1705dd980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106529e00>, '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 0x106392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106524b20>, '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.I7b7fSfOse/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.xivNXvuA7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 08:09:49 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 08:09:49 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 08:09:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I7b7fSfOse/Render', 08:09:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:49 INFO - 'HOME': '/Users/cltbld', 08:09:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:49 INFO - 'LOGNAME': 'cltbld', 08:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:49 INFO - 'MOZ_NO_REMOTE': '1', 08:09:49 INFO - 'NO_EM_RESTART': '1', 08:09:49 INFO - 'PAGER': '/bin/cat', 08:09:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:49 INFO - 'PWD': '/builds/slave/test', 08:09:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:49 INFO - 'SHELL': '/bin/bash', 08:09:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xivNXvuA7X/Listeners', 08:09:49 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:09:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:49 INFO - 'USER': 'cltbld', 08:09:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:49 INFO - 'XPC_FLAGS': '0x0', 08:09:49 INFO - 'XPC_SERVICE_NAME': '0', 08:09:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:09:52 INFO - Installing collected packages: mozsystemmonitor 08:09:52 INFO - Running setup.py install for mozsystemmonitor 08:09:52 INFO - Successfully installed mozsystemmonitor 08:09:52 INFO - Cleaning up... 08:09:52 INFO - Return code: 0 08:09:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10668aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10669a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1705dd980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106529e00>, '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 0x106392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106524b20>, '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.I7b7fSfOse/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.xivNXvuA7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 08:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I7b7fSfOse/Render', 08:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:52 INFO - 'HOME': '/Users/cltbld', 08:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:52 INFO - 'LOGNAME': 'cltbld', 08:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:52 INFO - 'MOZ_NO_REMOTE': '1', 08:09:52 INFO - 'NO_EM_RESTART': '1', 08:09:52 INFO - 'PAGER': '/bin/cat', 08:09:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:52 INFO - 'PWD': '/builds/slave/test', 08:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:52 INFO - 'SHELL': '/bin/bash', 08:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xivNXvuA7X/Listeners', 08:09:52 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:52 INFO - 'USER': 'cltbld', 08:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:52 INFO - 'XPC_FLAGS': '0x0', 08:09:52 INFO - 'XPC_SERVICE_NAME': '0', 08:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:52 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:55 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:56 INFO - Downloading docopt-0.6.1.tar.gz 08:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:56 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:56 INFO - Running setup.py install for blobuploader 08:09:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:56 INFO - Running setup.py install for requests 08:09:57 INFO - Running setup.py install for docopt 08:09:57 INFO - Successfully installed blobuploader requests docopt 08:09:57 INFO - Cleaning up... 08:09:57 INFO - Return code: 0 08:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10668aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10669a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1705dd980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106529e00>, '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 0x106392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106524b20>, '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.I7b7fSfOse/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.xivNXvuA7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 08:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I7b7fSfOse/Render', 08:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:57 INFO - 'HOME': '/Users/cltbld', 08:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:57 INFO - 'LOGNAME': 'cltbld', 08:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:57 INFO - 'MOZ_NO_REMOTE': '1', 08:09:57 INFO - 'NO_EM_RESTART': '1', 08:09:57 INFO - 'PAGER': '/bin/cat', 08:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:57 INFO - 'PWD': '/builds/slave/test', 08:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:57 INFO - 'SHELL': '/bin/bash', 08:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xivNXvuA7X/Listeners', 08:09:57 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:57 INFO - 'USER': 'cltbld', 08:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:57 INFO - 'XPC_FLAGS': '0x0', 08:09:57 INFO - 'XPC_SERVICE_NAME': '0', 08:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:57 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-GvKEwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:57 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-t7VtsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:57 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-79NYjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:57 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-CTk9Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:57 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-RMTt06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:58 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-i1WiXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:58 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-05e6il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:58 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-TXnnHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:58 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-arYZcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:58 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-F9WBUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:58 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-JtuAvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:58 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-McHmIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:58 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-tyTKRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:58 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-TdW768-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:59 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-CzzDKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:59 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-ymq5Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:59 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Qu3qd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:59 INFO - Running setup.py install for manifestparser 08:09:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:59 INFO - Running setup.py install for mozcrash 08:09:59 INFO - Running setup.py install for mozdebug 08:09:59 INFO - Running setup.py install for mozdevice 08:09:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:59 INFO - Running setup.py install for mozfile 08:10:00 INFO - Running setup.py install for mozhttpd 08:10:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:10:00 INFO - Running setup.py install for mozinfo 08:10:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:10:00 INFO - Running setup.py install for mozInstall 08:10:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:10:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:10:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:10:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:10:00 INFO - Running setup.py install for mozleak 08:10:00 INFO - Running setup.py install for mozlog 08:10:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:10:00 INFO - Running setup.py install for moznetwork 08:10:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:10:01 INFO - Running setup.py install for mozprocess 08:10:01 INFO - Running setup.py install for mozprofile 08:10:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:10:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:10:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:10:01 INFO - Running setup.py install for mozrunner 08:10:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:10:01 INFO - Running setup.py install for mozscreenshot 08:10:01 INFO - Running setup.py install for moztest 08:10:01 INFO - Running setup.py install for mozversion 08:10:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:10:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:10:01 INFO - Cleaning up... 08:10:01 INFO - Return code: 0 08:10:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10668aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10669a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1705dd980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106529e00>, '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 0x106392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106524b20>, '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.I7b7fSfOse/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.xivNXvuA7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 08:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I7b7fSfOse/Render', 08:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:01 INFO - 'HOME': '/Users/cltbld', 08:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:01 INFO - 'LOGNAME': 'cltbld', 08:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:01 INFO - 'MOZ_NO_REMOTE': '1', 08:10:01 INFO - 'NO_EM_RESTART': '1', 08:10:01 INFO - 'PAGER': '/bin/cat', 08:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:01 INFO - 'PWD': '/builds/slave/test', 08:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:01 INFO - 'SHELL': '/bin/bash', 08:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xivNXvuA7X/Listeners', 08:10:01 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:01 INFO - 'USER': 'cltbld', 08:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:01 INFO - 'XPC_FLAGS': '0x0', 08:10:01 INFO - 'XPC_SERVICE_NAME': '0', 08:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:02 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-QPMklu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:02 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Ii9bqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:02 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-kukzhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:02 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-tlsv1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:02 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-mThSug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:02 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-kWYrK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:02 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-X10qgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:02 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-v9twHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:03 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)) 08:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:03 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-pKhUkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:03 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)) 08:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:03 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-hMD7P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:03 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)) 08:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:03 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-6zxfk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:03 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-VXrJXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:03 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)) 08:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:03 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-OK5d2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:03 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-8WIRO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:03 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)) 08:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:03 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-nquFBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:03 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-f5H94d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:03 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-4SHV59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:04 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)) 08:10:04 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)) 08:10:04 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)) 08:10:04 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)) 08:10:04 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)) 08:10:04 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)) 08:10:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:06 INFO - Downloading blessings-1.6.tar.gz 08:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:10:06 INFO - Installing collected packages: blessings 08:10:06 INFO - Running setup.py install for blessings 08:10:06 INFO - Successfully installed blessings 08:10:06 INFO - Cleaning up... 08:10:06 INFO - Return code: 0 08:10:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:10:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:07 INFO - Reading from file tmpfile_stdout 08:10:07 INFO - Current package versions: 08:10:07 INFO - blessings == 1.6 08:10:07 INFO - blobuploader == 1.2.4 08:10:07 INFO - docopt == 0.6.1 08:10:07 INFO - manifestparser == 1.1 08:10:07 INFO - mozInstall == 1.12 08:10:07 INFO - mozcrash == 0.17 08:10:07 INFO - mozdebug == 0.1 08:10:07 INFO - mozdevice == 0.48 08:10:07 INFO - mozfile == 1.2 08:10:07 INFO - mozhttpd == 0.7 08:10:07 INFO - mozinfo == 0.9 08:10:07 INFO - mozleak == 0.1 08:10:07 INFO - mozlog == 3.1 08:10:07 INFO - moznetwork == 0.27 08:10:07 INFO - mozprocess == 0.22 08:10:07 INFO - mozprofile == 0.28 08:10:07 INFO - mozrunner == 6.11 08:10:07 INFO - mozscreenshot == 0.1 08:10:07 INFO - mozsystemmonitor == 0.0 08:10:07 INFO - moztest == 0.7 08:10:07 INFO - mozversion == 1.4 08:10:07 INFO - psutil == 3.1.1 08:10:07 INFO - requests == 1.2.3 08:10:07 INFO - wsgiref == 0.1.2 08:10:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:07 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 0x10668aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10669a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1705dd980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106529e00>, '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 0x106392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106524b20>, '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.I7b7fSfOse/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.xivNXvuA7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 08:10:07 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 08:10:07 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 08:10:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I7b7fSfOse/Render', 08:10:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:07 INFO - 'HOME': '/Users/cltbld', 08:10:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:07 INFO - 'LOGNAME': 'cltbld', 08:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:07 INFO - 'MOZ_NO_REMOTE': '1', 08:10:07 INFO - 'NO_EM_RESTART': '1', 08:10:07 INFO - 'PAGER': '/bin/cat', 08:10:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:07 INFO - 'PWD': '/builds/slave/test', 08:10:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:07 INFO - 'SHELL': '/bin/bash', 08:10:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xivNXvuA7X/Listeners', 08:10:07 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:10:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:07 INFO - 'USER': 'cltbld', 08:10:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:07 INFO - 'XPC_FLAGS': '0x0', 08:10:07 INFO - 'XPC_SERVICE_NAME': '0', 08:10:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:10:07 INFO - Cleaning up... 08:10:07 INFO - Return code: 0 08:10:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10668aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10669a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1705dd980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106529e00>, '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 0x106392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106524b20>, '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.I7b7fSfOse/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.xivNXvuA7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 08:10:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:10:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I7b7fSfOse/Render', 08:10:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:07 INFO - 'HOME': '/Users/cltbld', 08:10:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:07 INFO - 'LOGNAME': 'cltbld', 08:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:07 INFO - 'MOZ_NO_REMOTE': '1', 08:10:07 INFO - 'NO_EM_RESTART': '1', 08:10:07 INFO - 'PAGER': '/bin/cat', 08:10:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:07 INFO - 'PWD': '/builds/slave/test', 08:10:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:07 INFO - 'SHELL': '/bin/bash', 08:10:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xivNXvuA7X/Listeners', 08:10:07 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:10:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:07 INFO - 'USER': 'cltbld', 08:10:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:07 INFO - 'XPC_FLAGS': '0x0', 08:10:07 INFO - 'XPC_SERVICE_NAME': '0', 08:10:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:07 INFO - Downloading/unpacking jsonschema 08:10: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 08:10: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 08:10: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 08:10: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 08:10: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 08:10: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 08:10:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:10 INFO - Downloading/unpacking functools32 (from jsonschema) 08:10:10 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 08:10:10 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 08:10:10 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 08:10:10 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 08:10:10 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 08:10:10 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 08:10:11 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:10:11 INFO - warning: no files found matching '*.txt' 08:10:11 INFO - no previously-included directories found matching 'build' 08:10:11 INFO - no previously-included directories found matching 'dist' 08:10:11 INFO - no previously-included directories found matching '.git*' 08:10:11 INFO - Installing collected packages: jsonschema, functools32 08:10:11 INFO - Running setup.py install for functools32 08:10:11 INFO - warning: no files found matching '*.txt' 08:10:11 INFO - no previously-included directories found matching 'build' 08:10:11 INFO - no previously-included directories found matching 'dist' 08:10:11 INFO - no previously-included directories found matching '.git*' 08:10:11 INFO - Successfully installed jsonschema functools32 08:10:11 INFO - Cleaning up... 08:10:11 INFO - Return code: 0 08:10:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:11 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 0x10668aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10669a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1705dd980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106529e00>, '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 0x106392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106524b20>, '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.I7b7fSfOse/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.xivNXvuA7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 08:10:11 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 08:10:11 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 08:10:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I7b7fSfOse/Render', 08:10:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:11 INFO - 'HOME': '/Users/cltbld', 08:10:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:11 INFO - 'LOGNAME': 'cltbld', 08:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:11 INFO - 'MOZ_NO_REMOTE': '1', 08:10:11 INFO - 'NO_EM_RESTART': '1', 08:10:11 INFO - 'PAGER': '/bin/cat', 08:10:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:11 INFO - 'PWD': '/builds/slave/test', 08:10:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:11 INFO - 'SHELL': '/bin/bash', 08:10:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xivNXvuA7X/Listeners', 08:10:11 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:10:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:11 INFO - 'USER': 'cltbld', 08:10:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:11 INFO - 'XPC_FLAGS': '0x0', 08:10:11 INFO - 'XPC_SERVICE_NAME': '0', 08:10:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:11 INFO - Downloading/unpacking flake8 08:10:11 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 08:10:11 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 08:10:11 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 08:10:11 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 08:10:11 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 08:10:11 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 08:10:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:10:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:10:14 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 08:10:14 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 08:10:14 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 08:10:14 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 08:10:14 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 08:10:14 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 08:10:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:10:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:10:14 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 08:10:14 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 08:10:14 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 08:10:14 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 08:10:14 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 08:10:14 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 08:10:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:10: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 08:10: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 08:10: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 08:10: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 08:10: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 08:10: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 08:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:10:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:10:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:10:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:10:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:10:15 INFO - no previously-included directories found matching 'docs/_build' 08:10:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:10:15 INFO - Running setup.py install for pep8 08:10:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:10:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:10:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:10:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:10:15 INFO - no previously-included directories found matching 'docs/_build' 08:10:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:10:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:10:15 INFO - Cleaning up... 08:10:15 INFO - Return code: 0 08:10:15 INFO - Running post-action listener: _resource_record_post_action 08:10:15 INFO - Running post-action listener: _start_resource_monitoring 08:10:15 INFO - Starting resource monitoring. 08:10:15 INFO - ##### 08:10:15 INFO - ##### Running install step. 08:10:15 INFO - ##### 08:10:15 INFO - Running pre-action listener: _resource_record_pre_action 08:10:15 INFO - Running main action method: install 08:10:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:16 INFO - Reading from file tmpfile_stdout 08:10:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:10:16 INFO - Reading from file tmpfile_stdout 08:10:16 INFO - Output received: 08:10:16 INFO - Usage: mozinstall [options] installer 08:10:16 INFO - Options: 08:10:16 INFO - -h, --help show this help message and exit 08:10:16 INFO - -d DEST, --destination=DEST 08:10:16 INFO - Directory to install application into. [default: 08:10:16 INFO - "/builds/slave/test"] 08:10:16 INFO - --app=APP Application being installed. [default: firefox] 08:10:16 INFO - mkdir: /builds/slave/test/build/application 08:10:16 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'] 08:10:16 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 08:10:38 INFO - Reading from file tmpfile_stdout 08:10:38 INFO - Output received: 08:10:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:10:38 INFO - Running post-action listener: _resource_record_post_action 08:10:38 INFO - ##### 08:10:38 INFO - ##### Running run-tests step. 08:10:38 INFO - ##### 08:10:38 INFO - Running pre-action listener: _resource_record_pre_action 08:10:38 INFO - Running main action method: run_tests 08:10:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:10:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:10:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:10:38 INFO - 2016-07-04 08:10:38.071 screenresolution[1633:7439] starting screenresolution argv=screenresolution get 08:10:38 INFO - 2016-07-04 08:10:38.073 screenresolution[1633:7439] Display 0: 1600x1200x32@60 08:10:38 INFO - 2016-07-04 08:10:38.079 screenresolution[1634:7441] starting screenresolution argv=screenresolution list 08:10:38 INFO - Available Modes on Display 0 08:10:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:10:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:10:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:10:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:10:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:10:38 INFO - Intel Iris: 08:10:38 INFO - Chipset Model: Intel Iris 08:10:38 INFO - Type: GPU 08:10:38 INFO - Bus: Built-In 08:10:38 INFO - VRAM (Dynamic, Max): 1536 MB 08:10:38 INFO - Vendor: Intel (0x8086) 08:10:38 INFO - Device ID: 0x0a2e 08:10:38 INFO - Revision ID: 0x0009 08:10:38 INFO - Displays: 08:10:38 INFO - Display: 08:10:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:10:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:10:38 INFO - Display Serial Number: 1600x1200 60 08:10:38 INFO - Main Display: Yes 08:10:38 INFO - Mirror: Off 08:10:38 INFO - Online: Yes 08:10:38 INFO - Rotation: Supported 08:10:38 INFO - Return code: 0 08:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:38 INFO - Python 2.7.3 08:10:38 INFO - Return code: 0 08:10:38 INFO - grabbing minidump binary from tooltool 08:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:38 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 0x106529e00>, '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 0x106392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106524b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:38 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 08:10:38 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 08:10:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:38 INFO - Return code: 0 08:10:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:10:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:10:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:10:39 INFO - Return code: 0 08:10:39 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/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--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 08:10:39 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/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0193 --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 08:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I7b7fSfOse/Render', 08:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:39 INFO - 'HOME': '/Users/cltbld', 08:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:39 INFO - 'LOGNAME': 'cltbld', 08:10:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:39 INFO - 'MOZ_NO_REMOTE': '1', 08:10:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:39 INFO - 'NO_EM_RESTART': '1', 08:10:39 INFO - 'PAGER': '/bin/cat', 08:10:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:39 INFO - 'PWD': '/builds/slave/test', 08:10:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:39 INFO - 'SHELL': '/bin/bash', 08:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xivNXvuA7X/Listeners', 08:10:39 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 08:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:39 INFO - 'USER': 'cltbld', 08:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:39 INFO - 'XPC_FLAGS': '0x0', 08:10:39 INFO - 'XPC_SERVICE_NAME': '0', 08:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:39 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/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--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 08:10:39 INFO - mozversion application_buildid: 20160704064626 08:10:39 INFO - mozversion application_changeset: ebaf4086c18c2d1e3f0af12ade55840413342bc3 08:10:39 INFO - mozversion application_display_name: Firefox 08:10:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:39 INFO - mozversion application_name: Firefox 08:10:39 INFO - mozversion application_remotingname: firefox 08:10:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:10:39 INFO - mozversion application_vendor: Mozilla 08:10:39 INFO - mozversion application_version: 48.0 08:10:39 INFO - mozversion platform_buildid: 20160704064626 08:10:39 INFO - mozversion platform_changeset: ebaf4086c18c2d1e3f0af12ade55840413342bc3 08:10:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:10:39 INFO - mozversion platform_version: 48.0 08:10:39 INFO - using testdate: 1467645039 08:10:39 INFO - actual date: 1467645039 08:10:39 INFO - starting webserver on 'localhost:49280' 08:10:39 INFO - SUITE-START | Running 2 tests 08:10:39 INFO - TEST-START | dromaeo_css 08:10:39 INFO - operating with platform_type : mac_ 08:10:39 INFO - Initialising browser for dromaeo_css test... 08:10:39 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpvbuJsK/profile http://localhost:49280/getInfo.html) 08:10:42 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 08:10:42 INFO - PROCESS | 1652 | colorDepth:24 08:10:42 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 08:10:42 INFO - PROCESS | 1652 | __metrics 08:10:42 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:10:43 INFO - TEST-INFO | 1652: exit 0 08:10:43 INFO - Browser initialized. 08:10:43 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:43 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpvbuJsK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:55 INFO - PROCESS | 1656 | RSS: Main: 171544576 08:10:55 INFO - PROCESS | 1656 | 08:11:44 INFO - PROCESS | 1656 | 1467645104914 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] 08:13:54 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 08:13:55 INFO - PROCESS | 1656 | RSS: Main: 181850112 08:13:55 INFO - PROCESS | 1656 | 08:16:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 08:16:58 INFO - PROCESS | 1656 | RSS: Main: 192819200 08:16:58 INFO - PROCESS | 1656 | 08:20:00 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 08:20:00 INFO - PROCESS | 1656 | RSS: Main: 194969600 08:20:00 INFO - PROCESS | 1656 | 08:23:02 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 08:23:03 INFO - PROCESS | 1656 | RSS: Main: 198553600 08:23:03 INFO - PROCESS | 1656 | 08:26:05 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 08:26:06 INFO - PROCESS | 1656 | RSS: Main: 197791744 08:26:06 INFO - PROCESS | 1656 | 08:29:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 08:29:08 INFO - PROCESS | 1656 | RSS: Main: 202731520 08:29:08 INFO - PROCESS | 1656 | 08:29:08 INFO - PROCESS | 1656 | __start_tp_report 08:29:08 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 08:29:08 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 08:29:08 INFO - PROCESS | 1656 | |i|pagename|runs| 08:29:08 INFO - PROCESS | 1656 | |0;dojo.html;2917.489439348114;3023.3499797543523;3571.232185080208;3591.856325746972;3647.288778688157;5254.553362964148;5727.885442291152;5904.2324497815225;5904.380040095787;5947.940520594792;4979.278004689327;5879.52963762899;5883.823485295437;5904.291485021803;5921.141434491996;5242.292290540785;5288.286081379022;5340.279062326575;5342.759575819078;5353.063213937565;4397.9340309895215;4406.25093734066;5241.842744717665;5349.759260833272;5369.328833895763;5326.813561525348;5346.465353464661;5347.919781203285;5362.008028514718;5370.194470829388;5300.310959575249;5312.681239125626;5332.999999999981;5343.786248550092;5371.704556249405;5189.169732842727;5218.895622087537;5309.814156504503;5338.466153384669;5348.705821179872;4455.77721113943;5537.1140617501405;5757.0788673811985;5893.911591326134;5913.438223368773;6173.59871608344;6234.688265586748;6246.843828904268;6276.5292603054495;6291.087792270096;6242.219722534684;6272.278687950853;6280.748770049193;6300.117983482316;6311.337309582474;5843.620164689281;5940.34656187819;5943.197668314765;5974.581779275452;5975.551833612496;6380.649064301508;6387.425131738166;6435.066915297256;6452.419282264619;6477.319881412478;6204.844878877974;6237.937620623827;6247.843803904939;6249.218847644044;6252.218472690914;6244.7814326499265;6292.748290068437;6294.464970477469;6319.178506794087;6356.682165891687;6195.504359651217;6236.906446403307;6239.157713708682;6255.46828519581;6274.780382686584;6233.376662333821;6244.063390491372;6255.655938923403;6258.687065646791;6277.309495955441;4864.489228630943;5009.474005229471;5057.848264552069;5073.771680274396;5106.846794596094;4536.909261814745;4555.567221113989;4576.267797152506;4580.38164847748;4612.238980568169;5363.329583802025;5814.505767009851;5870;6051.031834906482;6143.078538219213;6172.660503672341;6256.74973001084;6257.249130104326;6288.339724328879;6361.9045714314325;6057;6067.423594758491;6070.605410648293;6074.362191969868;6082.422169893853;5453.23654688344;5564.221009058735;5566.582506311962;5569.610127291051;5572.024895643246;5340.91988620171;6506.682080464054;6512.6092434454085;6550.2794692583775;6563.278039415661;5206.8958620828125;6316.11574379578;6324.557280990287;6348.984162533972;6524.086627872197;6359.650219237987;6461.903071454026;6542.476601871744;6542.574732642363;6549.803505894831;6237.033259844731;6283.654399008098;6298.590591611531;6302.810915672537;6303.117563541016;6351.491880649629;6356.55504114726;6370.90443643355;6381.106645069787;6390.9041364378645;6104.755809767559;6154.753809847556;6158.291796443466;6198.969005155126;6213.689315534296;6058.545609079249;6130.887362651087;6139.6009259398;6175.3515880831865;6253.749850005949;5506.972465137648;6136.8772624548155;6141.7543298267565;6167.907481387872;6168.383161683796;5160.174372100596;5657.717114144194;6141.240538582634;6143;6235.75056997715;6117.327094019565;6157.415045570664;6164.4143806338325;6170.475509581735;6180.6291622502795 08:29:08 INFO - PROCESS | 1656 | |1;ext.html;530.7797264135384;552.1386636846519;578.0655691517009;608.5314307982852;613.450961389556;31495.527567086512;38385.424218636705;39465.21069578607;39594.41622335103;39674.40488392676;40574.797126014404;41369.965750856165;41493.58506414935;41974.16051678965;41979.58020419795;9552.80894382112;9703.902960970407;9704.369216000972;9779.217662586976;9803.6078556858;9682.46746428946;9865.013498650149;9931.404115753041;9950.701478955643;9978.201743860474;9765.072318129802;9894.40633561985;9917.355371900803;10001.249906257024;10003.199744020461;9887.307888447811;9910.90089099107;9954.35296705719;9966.65116720915;9972.700818975442;9769.364991275545;9800.921898591148;9863.556139973718;9871.703848884545;9895.455749933752;39549.80225098856;40260.39609405861;40413.59586404128;40601.1879762406;40798.9800254993;3273.3616944695796;3327.600687917441;3360.6975372216375;3467.3412051710093;3812.923741525182;26334.86832565844;26500;27158.728412715816;27457.588136177972;27766.722332776615;2755.9448811023867;2764.944701105987;2770.6952235254107;2773.5839624056553;2792.1483947396036;411260;411656;413136.93431532953;415793.92103039596;416628;37577.81211093927;38344.61655383466;62478;64291;64399;30876.69123308783;36167;37140;37404.81297593495;37449.43825842615;13675.863241367659;16469.83530164707;16536.83463165377;16537.83462165387;16579.91710041442;13631.659208519668;13923.373448194652;14071.648208794863;14118.435262589586;14145.434182632785;8447.690607955778;8461.450005749606;8585.141485851489;8630.568471576396;8679.869801952977;3122.765792565521;3510.087377281874;3524.6827785499427;3545.1137215696076;3588.372034893883;1020.4693559349097;1070.2240875365299;1087.9075278601408;1138.7494751154732;1175.1245322234818;26706.332341691224;30142.69857301399;30939.535906961413;31437.685623143934;31841.363172736415;1181.1023622047305;1214.993925030387;1225.5096375029773;1230.8276841242234;1239.8202260672151;12065.879341206652;14376.712465750627;14806.407743690132;15816.76274855878;15892.920535397248;588462;590569;592089;595289;599036;62055;63046.684766575876;63343.6832815833;63349;63353.68323158355;1528.3504510582957;1537.8385269546536;1543.7375646140183;1548.9612759681097;1559.6958593074241;30475.085747427613;30842;30966.53550196704;31035.53446698256;31370.52944205793;54553.72723136359;54610.18084728653;55201.72399137979;55274.170887437525;55320;435521;435612;437246;545879;546745;27309.317267068483;27819.860900695367;28210.012649557168;28266;28658.570121447778;46918.76540617275;47741.52258477371;47767.04465910732;48993.51006490032;49179.508204917496;39059.41410878896;39742.15941490021;40047.79976100218;40129;40187.79906100451;38931.805340973115;39090.60909390869;39381;39551.40672889967;39724;38376;38750.6124938747;38927;38930.61069389383;39570.60429395669;33502.60904301859;34487.65512344844;34599;34764.47853282152;35999.820000899825;22357.217497388163;25856.627929585047;26021.739782601933;26144.477110458065;26412.471750565266 08:29:08 INFO - PROCESS | 1656 | |2;jquery.html;370.3444902522537;412.39995806102127;413.1509747468952;418.48944287968675;427.18621026943663;16012.119333436656;17225.224864881096;20246.29137980171;21710.782892171075;21813.454663633416;20734;21074;21119.049642766073;22579.435514112116;22596.43508912278;5687.203791469197;5714.028615135416;6000.759969601221;6052.848678783043;6225.439710426061;6060.424259695322;6066.454019138277;6109.389061093877;6151;6174.8147555573405;5777.884442311151;6063.818085457443;6120.1125836753645;6153.600015998968;6174.413430724074;5090.185570308751;6041.486473649745;6083.543734219951;6126.816195514164;6156.507479401659;5278.392984806758;5291.1798671206025;5351.09031464652;5398.595105367113;5444.074507333763;24981.125660601974;26245;26283.868580657167;27275;27523.86238068817;2109.4726318420394;2182.978170218309;2253.233900473847;2311.1857192104285;2880.2079428157217;9767.413955162712;10191.03185197405;10247.38515689061;10395.688129356131;10548.05067543917;1625.0655872873144;1664.4424117920512;1767.761352217447;1815.464437990796;1838.3933302010305;94270;104775;114552.38739994398;119591.2061319081;121063.78936210614;11485.712857178638;11738.237014594195;11890.28658280506;11936.820947685792;12074.456649450796;12757.936210319074;15129.546113616609;15134.621634459007;15480;15591.532254032398;9388.8591671125;9395.557155139577;9410.106039926197;9451.952740236393;9523.380980236263;8951.507667078373;9068.455892646462;9113.043130471338;9339.066093390607;9459.858102128474;4182.393552934807;4655.930161047587;4845.63657725665;4867.561919427198;4915.336429581961;1873.428604275709;1949.756280464942;2050.7846676099093;2052.5073982244453;2069.9586008280053;969.1762002298132;978.8791833350773;1003.2575893838507;1043.118564812732;1053.5417093564324;16953.745693814602;21061.47346316324;21125.438809912746;21231.256906008526;21455.14179432805;992.5781542844262;1013.3463915774284;1030.469308306223;1036.6319956415514;1040.8490768838476;9302.395344302598;9693.127618514227;11638.709032274091;11645.41772911368;11673.591424300108;634548;650386;658323;675273;680681;128376.91744344129;131107;136045;136463;136545;1057.984130238047;1095.3318475729639;1104.1939384249542;1104.4367372639852;1108.7172770943519;18740.437786866416;19353.4193974181;19502.707459387835;19558.511037224183;19727.704084438457;51979;52242.738786305825;53167.20249196343;53525;56389.71805140948;78473.2152678466;81725.59137204514;81775.18224817676;81936;83972.16027839643;7342.265773422615;8300.377471689768;8310.168983101641;8327.95836020816;8394.538300393537;9143.862842057242;12763.553275635308;12952.093353465167;13250.46998120103;13318.800217996544;11007.339559626447;11259.268147570381;11459.541618335174;11608.941955290169;11682.649520514398;10795.6221532246;11072.557097716324;11155.665330040112;11371.147163962902;11393.259438136494;11459.31244125355;11479.8278025828;11615.825762613737;11690.298582085103;11744.354060526754;7163.677634506355;8021.639026243716;8250;8312.335013198808;8581.8712719308;10487.318324308895;11382.772344553228;11508.482118304864;11591.710207244887;11593.420328983348 08:29:08 INFO - PROCESS | 1656 | |3;mootools.html;1619.303699409254;1640.48324777695;1911.827935485806;1996.4310171601087;2044.3866839948012;6961.825954351144;7521.247875212476;8164.22439868213;8874.511901845412;9161.26709863211;8784.253338466238;8813;8859.778505537364;8885.333599979995;8910.91089089109;2185.8305806393582;2403;2502.2618327593314;2519.0805356045003;2522.798176145913;2131.3073251193346;2493.252024392675;2510.3849556858595;2514.107491840398;2531.227975467482;2511.2842839790665;2526.002229119497;2529.6964364276314;2543.2878793937725;2543.567593509108;2465.827392082555;2477.7770000699934;2495.9376015599664;2506.7994560435122;2525.8358206716503;2485.5898776701824;2492.8628925409093;2500.349909023667;2522.6972763268527;2536.7843733282693;9018.59416326267;9071.410358326688;9090.13643703847;9090.2273306769;9091.227245684058;5568.52667523261;5617.157426386075;5617.662940223599;5722.656640601577;5745.655260684331;3428.3143371325837;3568;3626.7279954003557;3712.3874560697454;3740.9251814963823;1070.796548655753;1085.1535802074395;1086.3427626286061;1087.1846115413439;1088.885667004961;12142.878571214264;12158.270503769802;12171.634850954486;12171.99999999991;12185.086118541056;4831.275308703723;4873.269009648581;4925.753712314442;4941.1847045237855;4941.530554597308;10215.438150901624;10238.744031399274;10278.383297002054;10314.381137131797;10341.224408169266;5472.753726082336;5539.19681646159;5555.77776888928;5560.582956278296;5585.636933599303;4562.406887104655;4960.305557221992;4981.701097934136;4986.501349865057;5029.1953287473825;3482.407990641597;4134.090500089976;4207.621314081747;4244.766537840448;4277.529471758104;1194.2893978083027;1403.599974007403;1403.8175037245094;1432.6633241188313;1435.4975758484657;926.8285367207088;929.3215952354684;985.9161971232382;994.9651762188289;997.1275134257525;5503.871706300199;6060.090986351995;6137.447629713347;6253.6873156342;6277.497800175975;863.9222469977732;958.5351104714208;960.9519524023771;1002.904724051214;1004.1815920025156;3478.669526394988;4052.756834589934;4169.770662613525;4174.039970806732;4193.01827598226;11030.952059554329;11310.773784524428;11358.375289359165;11477.71305717347;11499.655010349703;10849.78300433987;11063.059639930696;11097.500612472459;11147.21969462146;11283.94358028221;8626.482411055356;8706.39055266138;8772.38593298463;8795.604197811113;8798.912010879809;5831.4168583141345;6061.818145455643;6081.695915204134;6097.847553811191;6115.7247923844425;9999.700008999742;10013.699589012342;10085.991400859855;10132.949335253277;10173;9923.1069203772;10150.23873209527;10191.439470829175;10480.580776768844;10482.947585262025;6151.292601350902;7241.384482319062;7449.515781474187;7668.309852113113;7680.500767450098;8238.09380968105;8255.876161857457;8461.365397595082;8498.192671696179;8544.957275213585;7434.73978410753;7617.69529218825;7644.273793989562;7665.578393188428;7719.807004824925;7288.890666639899;7392.075990501187;7475.813104672427;7503.812404689927;7560.243975602396;6225.688715564294;6358.268799088164;7096.787096387116;7113.288671132846;7122.5726456412785;4956.083124621957;5024.924626130684;5049.2173713074535;5103.948960510495;5185.481451854785;5147.279380886604;5173.379194496684;5264.684118952875;5317.1492561190025;5381.704006279692 08:29:08 INFO - PROCESS | 1656 | |4;prototype.html;335.9798412095273;336.3743437206795;337.8952524717338;343.2774010707461;347.19450873972363;7048.647567621624;7077.079979602658;7082.50422470426;7115.039469671593;7126.8574628507395;5911.970440147793;6819.840627093394;7073.610951397671;7075.568349350561;7083.972823940526;4906.9263961040615;4919.286703428001;5082.923756143661;5097.770600322976;5114.079465696192;4763.571278584926;5042.193249080148;5095.0574143783515;5105.974470127644;5127.538521533062;5036.546710796028;5052.69683818972;5055.69665820052;5057.873553161164;5066.113430149728;5046.596272298244;5062.519060689266;5107.540321371076;5123.51326623972;5143.09995750744;4379.693421460499;4383.780810959471;4386.188555117314;4390.517043125254;4399.5160532341415;6510.5442619016685;6793;6794.184697836242;6840.41856442203;6846.178458584952;5140.794368225266;5983.611065280743;5996.520278377763;6023.969880150571;6024.006039003559;7580.431467639949;7586.4689471737;7586.772396828104;7588.203238659971;7603.619819009083;4805.447373552051;4808.831690890802;4822.324874517535;4827.662063655511;4831.444383895861;6336.207974003296;7265.564066155995;7946.404019698488;8034.276915077671;8054.395920305942;4709.270063140219;4846.176150054499;4851.102546028996;4889.535494128052;4916.975415122902;4966.925496117561;4970.65205435616;4971.527704868032;4974;4978.083437876444;5958.731857066442;5977.282726072899;5981.026261333749;5987;6002.279726432856;7519.511231769918;7569.167391586921;7574.431917606202;7595.5822429766895;7602;1620.5705488045678;1677.5722190841257;1682.4027470248132;1725.2064050536642;1730.074410190542;947.6162154327509;1059.819830628795;1075.9677209683723;1080.3841810168285;1091.7052395853234;7091.574505529582;7112.182099058571;7147.499675022803;7156;7165;7820.061592608923;7825.530468171928;7834.294913457816;7841.607919603997;7849.803754906173;5826.737027264745;7020.894686579705;7072.7524536642;7124;7147.499675022698;3252.6747325267283;4136.503619565611;4138.8344466221015;4146;4162.729422587522;8323.084460709317;8335.916640833635;8336.958315208385;8347.707830225912;8370;7592.278733520307;7639.770806875803;8205.384596155192;8241.917580824234;8287.95856020728;8294.668213271521;8302.211289927567;8308.626111824862;8316.293115085286;8325.417220794607;6323.557350985387;7645.847083058196;7909.644066016928;7938.483998540077;7940.0471943367165;7781.805454863674;7787.688492460238;7809.687612495437;7820.17888121739;7828.960855195687;7389.261073892568;7590.734324298623;8273.627686753991;8286;8309.542975136426;4010.498687664042;4599.62011396573;4800.991791723777;4888.951110488992;4911.705297682151;6877.552959057645;7505.774826755206;7667.961660191663;7694.576798276148;7835;7610.200928902385;7652.426068044808;7668.118166410711;7683.846323073619;7716.035495563055;6158.661273629993;6187.690615469299;7625.580593067212;7628.42786791004;7715.189905059888;7441.181470038183;7447.515911465737;7452.031235939293;7478.962605187157;7485.812854678677;7423.554586724814;7602.923970760222;7621.466497345355;7624.618769061635;7644.044494438195;6103.633781972918;6383.946648802896;7081.929180708127;7463.51487153355;7494 08:29:08 INFO - PROCESS | 1656 | |5;yui.html;724.583364565375;745.1691364128994;747.6971826410304;768.5964868444063;777.9572123533203;12722.872771272285;15924;15949.043057416535;16015.439459618916;16016.11911344877;14621.97646164769;14627.78058329126;14640.34118464669;14663.633409164777;14698.118112913206;774.2373761844578;925.6760133953113;930.7114794413753;965.8020105878313;968.9806203875918;951.0822056715268;960.5821467661555;962.6630679262272;962.93259471837;963.0177219236409;967.1875624475439;993.0863605482937;1001.0940099210227;1003.372891942536;1005.5475036233687;961.7835986902961;961.8124465729186;962.2350231565922;963.1187463470916;963.7012526116891;723.5477826358526;744.3858816476375;745.6346390268784;745.8694728422504;748.4311922938606;14108.858911410856;14279.57161285163;14471.493497727633;14512.637184070378;14521.273936303143;13522.32388380577;13534.458621655122;13579.253141077237;13612.319384030858;13681.521146759816;10391.740206494822;10496.370217786956;10561.683149505527;10565.894341056568;10870.130389568816;3296.862582409065;3549.1482044309437;3596.478510615972;3606.8376923038527;3856.3058649443087;79021;79325.41349172984;79558;79619.8057029145;80965;9626.47054412;10023.448710321003;10105.242106842017;10233.539490722935;10258.538365773558;22818.201362952215;23503.647445288334;23558.293251202493;23595.7640423597;23680.934357953935;7743.032120984877;7769.106552746506;7828.647710853025;7832.451728378959;7951;3576.570811502584;4200.91598168041;4218.831246750157;4266.381374700651;4285.8285668573535;3221.548983142362;3304.3721692878275;3601.7573936991694;3776.37689781183;3794.354959656865;669.4610838275138;682.5733916302311;683.7504310926575;684.8904175332023;687.5771400588702;512.6667666017119;533.0964015992932;575.4619430832186;586.4135864135864;622.2035794183453;8410.201030902055;8486.363522735819;8527.18991695788;8620.78448038804;8631.266342360845;539.919012148181;595.9195508606283;613.1109890658474;629.5467263570222;633.597665482422;3877;3929.548101968253;3974.5627980922077;4074.7555146691293;4077.836886524565;92952;96033;96587;96602.55096173563;97613.51193243988;74554.8816767749;75162;76900;82270.17729822744;82591;72792.90810637844;73177.63411183016;73515.63242183861;73805.26194738092;74364.99999999892;7568.270868613091;7654.961725191339;7699.191584883507;7794.510178877273;7896.052473702963;50670.74664626653;50902.96388144581;52231.73884130555;52822.73588632032;53239.733801330745;58143.12785308308;61122.694386527786;69953;70337.64831175811;71598.64200678964;10924.2899211551;11247.437628118398;11311.604093856675;11378.487968041292;11646;12043.698907527032;12196;12251.632451026484;12319.199252048587;13047.804282935953;11632.360220187971;11682.357470339213;11727;11818.881811182122;12132.029437645144;11665.24175928562;11706.590269340873;11803.350815705218;11821.054315654555;12399.380030998595;11395.544178232778;11479.139064570023;11483.94258028738;11831.64505064815;11928.642140735792;9759;9944.403335799585;10119.291649584458;10368.015038571324;10459.372437653765;7862.781268903101;9897.703068907944;9906.936344459611;10132.949335253277;10145.64490242838 08:29:08 INFO - PROCESS | 1656 | __end_tp_report 08:29:08 INFO - PROCESS | 1656 | __start_cc_report 08:29:08 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,401 08:29:08 INFO - PROCESS | 1656 | __end_cc_report 08:29:08 INFO - PROCESS | 1656 | __startTimestamp1467646148730__endTimestamp 08:29:08 INFO - PROCESS | 1656 | 08:29:08 INFO - PROCESS | 1656 | ------- Summary: start ------- 08:29:08 INFO - PROCESS | 1656 | Number of tests: 6 08:29:08 INFO - PROCESS | 1656 | 08:29:08 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5810.75 Median:6130.89 stddev:683.72 (11.2%) stddev-sans-first:647.05 08:29:08 INFO - PROCESS | 1656 | Values: 2917.5 3023.3 3571.2 3591.9 3647.3 5254.6 5727.9 5904.2 5904.4 5947.9 4979.3 5879.5 5883.8 5904.3 5921.1 5242.3 5288.3 5340.3 5342.8 5353.1 4397.9 4406.3 5241.8 5349.8 5369.3 5326.8 5346.5 5347.9 5362.0 5370.2 5300.3 5312.7 5333.0 5343.8 5371.7 5189.2 5218.9 5309.8 5338.5 5348.7 4455.8 5537.1 5757.1 5893.9 5913.4 6173.6 6234.7 6246.8 6276.5 6291.1 6242.2 6272.3 6280.7 6300.1 6311.3 5843.6 5940.3 5943.2 5974.6 5975.6 6380.6 6387.4 6435.1 6452.4 6477.3 6204.8 6237.9 6247.8 6249.2 6252.2 6244.8 6292.7 6294.5 6319.2 6356.7 6195.5 6236.9 6239.2 6255.5 6274.8 6233.4 6244.1 6255.7 6258.7 6277.3 4864.5 5009.5 5057.8 5073.8 5106.8 4536.9 4555.6 4576.3 4580.4 4612.2 5363.3 5814.5 5870.0 6051.0 6143.1 6172.7 6256.7 6257.2 6288.3 6361.9 6057.0 6067.4 6070.6 6074.4 6082.4 5453.2 5564.2 5566.6 5569.6 5572.0 5340.9 6506.7 6512.6 6550.3 6563.3 5206.9 6316.1 6324.6 6349.0 6524.1 6359.7 6461.9 6542.5 6542.6 6549.8 6237.0 6283.7 6298.6 6302.8 6303.1 6351.5 6356.6 6370.9 6381.1 6390.9 6104.8 6154.8 6158.3 6199.0 6213.7 6058.5 6130.9 6139.6 6175.4 6253.7 5507.0 6136.9 6141.8 6167.9 6168.4 5160.2 5657.7 6141.2 6143.0 6235.8 6117.3 6157.4 6164.4 6170.5 6180.6 08:29:08 INFO - PROCESS | 1656 | 08:29:08 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:63131.29 Median:38995.61 stddev:133965.08 (343.5%) stddev-sans-first:134258.43 08:29:08 INFO - PROCESS | 1656 | Values: 530.8 552.1 578.1 608.5 613.5 31495.5 38385.4 39465.2 39594.4 39674.4 40574.8 41370.0 41493.6 41974.2 41979.6 9552.8 9703.9 9704.4 9779.2 9803.6 9682.5 9865.0 9931.4 9950.7 9978.2 9765.1 9894.4 9917.4 10001.2 10003.2 9887.3 9910.9 9954.4 9966.7 9972.7 9769.4 9800.9 9863.6 9871.7 9895.5 39549.8 40260.4 40413.6 40601.2 40799.0 3273.4 3327.6 3360.7 3467.3 3812.9 26334.9 26500.0 27158.7 27457.6 27766.7 2755.9 2764.9 2770.7 2773.6 2792.1 411260.0 411656.0 413136.9 415793.9 416628.0 37577.8 38344.6 62478.0 64291.0 64399.0 30876.7 36167.0 37140.0 37404.8 37449.4 13675.9 16469.8 16536.8 16537.8 16579.9 13631.7 13923.4 14071.6 14118.4 14145.4 8447.7 8461.5 8585.1 8630.6 8679.9 3122.8 3510.1 3524.7 3545.1 3588.4 1020.5 1070.2 1087.9 1138.7 1175.1 26706.3 30142.7 30939.5 31437.7 31841.4 1181.1 1215.0 1225.5 1230.8 1239.8 12065.9 14376.7 14806.4 15816.8 15892.9 588462.0 590569.0 592089.0 595289.0 599036.0 62055.0 63046.7 63343.7 63349.0 63353.7 1528.4 1537.8 1543.7 1549.0 1559.7 30475.1 30842.0 30966.5 31035.5 31370.5 54553.7 54610.2 55201.7 55274.2 55320.0 435521.0 435612.0 437246.0 545879.0 546745.0 27309.3 27819.9 28210.0 28266.0 28658.6 46918.8 47741.5 47767.0 48993.5 49179.5 39059.4 39742.2 40047.8 40129.0 40187.8 38931.8 39090.6 39381.0 39551.4 39724.0 38376.0 38750.6 38927.0 38930.6 39570.6 33502.6 34487.7 34599.0 34764.5 35999.8 22357.2 25856.6 26021.7 26144.5 26412.5 08:29:08 INFO - PROCESS | 1656 | 08:29:08 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:36960.62 Median:11998.22 stddev:109646.96 (913.9%) stddev-sans-first:109920.13 08:29:08 INFO - PROCESS | 1656 | Values: 370.3 412.4 413.2 418.5 427.2 16012.1 17225.2 20246.3 21710.8 21813.5 20734.0 21074.0 21119.0 22579.4 22596.4 5687.2 5714.0 6000.8 6052.8 6225.4 6060.4 6066.5 6109.4 6151.0 6174.8 5777.9 6063.8 6120.1 6153.6 6174.4 5090.2 6041.5 6083.5 6126.8 6156.5 5278.4 5291.2 5351.1 5398.6 5444.1 24981.1 26245.0 26283.9 27275.0 27523.9 2109.5 2183.0 2253.2 2311.2 2880.2 9767.4 10191.0 10247.4 10395.7 10548.1 1625.1 1664.4 1767.8 1815.5 1838.4 94270.0 104775.0 114552.4 119591.2 121063.8 11485.7 11738.2 11890.3 11936.8 12074.5 12757.9 15129.5 15134.6 15480.0 15591.5 9388.9 9395.6 9410.1 9452.0 9523.4 8951.5 9068.5 9113.0 9339.1 9459.9 4182.4 4655.9 4845.6 4867.6 4915.3 1873.4 1949.8 2050.8 2052.5 2070.0 969.2 978.9 1003.3 1043.1 1053.5 16953.7 21061.5 21125.4 21231.3 21455.1 992.6 1013.3 1030.5 1036.6 1040.8 9302.4 9693.1 11638.7 11645.4 11673.6 634548.0 650386.0 658323.0 675273.0 680681.0 128376.9 131107.0 136045.0 136463.0 136545.0 1058.0 1095.3 1104.2 1104.4 1108.7 18740.4 19353.4 19502.7 19558.5 19727.7 51979.0 52242.7 53167.2 53525.0 56389.7 78473.2 81725.6 81775.2 81936.0 83972.2 7342.3 8300.4 8310.2 8328.0 8394.5 9143.9 12763.6 12952.1 13250.5 13318.8 11007.3 11259.3 11459.5 11608.9 11682.6 10795.6 11072.6 11155.7 11371.1 11393.3 11459.3 11479.8 11615.8 11690.3 11744.4 7163.7 8021.6 8250.0 8312.3 8581.9 10487.3 11382.8 11508.5 11591.7 11593.4 08:29:08 INFO - PROCESS | 1656 | 08:29:08 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5866.75 Median:4948.81 stddev:3265.64 (66.0%) stddev-sans-first:3259.20 08:29:08 INFO - PROCESS | 1656 | Values: 1619.3 1640.5 1911.8 1996.4 2044.4 6961.8 7521.2 8164.2 8874.5 9161.3 8784.3 8813.0 8859.8 8885.3 8910.9 2185.8 2403.0 2502.3 2519.1 2522.8 2131.3 2493.3 2510.4 2514.1 2531.2 2511.3 2526.0 2529.7 2543.3 2543.6 2465.8 2477.8 2495.9 2506.8 2525.8 2485.6 2492.9 2500.3 2522.7 2536.8 9018.6 9071.4 9090.1 9090.2 9091.2 5568.5 5617.2 5617.7 5722.7 5745.7 3428.3 3568.0 3626.7 3712.4 3740.9 1070.8 1085.2 1086.3 1087.2 1088.9 12142.9 12158.3 12171.6 12172.0 12185.1 4831.3 4873.3 4925.8 4941.2 4941.5 10215.4 10238.7 10278.4 10314.4 10341.2 5472.8 5539.2 5555.8 5560.6 5585.6 4562.4 4960.3 4981.7 4986.5 5029.2 3482.4 4134.1 4207.6 4244.8 4277.5 1194.3 1403.6 1403.8 1432.7 1435.5 926.8 929.3 985.9 995.0 997.1 5503.9 6060.1 6137.4 6253.7 6277.5 863.9 958.5 961.0 1002.9 1004.2 3478.7 4052.8 4169.8 4174.0 4193.0 11031.0 11310.8 11358.4 11477.7 11499.7 10849.8 11063.1 11097.5 11147.2 11283.9 8626.5 8706.4 8772.4 8795.6 8798.9 5831.4 6061.8 6081.7 6097.8 6115.7 9999.7 10013.7 10086.0 10132.9 10173.0 9923.1 10150.2 10191.4 10480.6 10482.9 6151.3 7241.4 7449.5 7668.3 7680.5 8238.1 8255.9 8461.4 8498.2 8545.0 7434.7 7617.7 7644.3 7665.6 7719.8 7288.9 7392.1 7475.8 7503.8 7560.2 6225.7 6358.3 7096.8 7113.3 7122.6 4956.1 5024.9 5049.2 5103.9 5185.5 5147.3 5173.4 5264.7 5317.1 5381.7 08:29:08 INFO - PROCESS | 1656 | 08:29:08 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:6111.95 Median:7060.70 stddev:2010.40 (28.5%) stddev-sans-first:1968.74 08:29:08 INFO - PROCESS | 1656 | Values: 336.0 336.4 337.9 343.3 347.2 7048.6 7077.1 7082.5 7115.0 7126.9 5912.0 6819.8 7073.6 7075.6 7084.0 4906.9 4919.3 5082.9 5097.8 5114.1 4763.6 5042.2 5095.1 5106.0 5127.5 5036.5 5052.7 5055.7 5057.9 5066.1 5046.6 5062.5 5107.5 5123.5 5143.1 4379.7 4383.8 4386.2 4390.5 4399.5 6510.5 6793.0 6794.2 6840.4 6846.2 5140.8 5983.6 5996.5 6024.0 6024.0 7580.4 7586.5 7586.8 7588.2 7603.6 4805.4 4808.8 4822.3 4827.7 4831.4 6336.2 7265.6 7946.4 8034.3 8054.4 4709.3 4846.2 4851.1 4889.5 4917.0 4966.9 4970.7 4971.5 4974.0 4978.1 5958.7 5977.3 5981.0 5987.0 6002.3 7519.5 7569.2 7574.4 7595.6 7602.0 1620.6 1677.6 1682.4 1725.2 1730.1 947.6 1059.8 1076.0 1080.4 1091.7 7091.6 7112.2 7147.5 7156.0 7165.0 7820.1 7825.5 7834.3 7841.6 7849.8 5826.7 7020.9 7072.8 7124.0 7147.5 3252.7 4136.5 4138.8 4146.0 4162.7 8323.1 8335.9 8337.0 8347.7 8370.0 7592.3 7639.8 8205.4 8241.9 8288.0 8294.7 8302.2 8308.6 8316.3 8325.4 6323.6 7645.8 7909.6 7938.5 7940.0 7781.8 7787.7 7809.7 7820.2 7829.0 7389.3 7590.7 8273.6 8286.0 8309.5 4010.5 4599.6 4801.0 4889.0 4911.7 6877.6 7505.8 7668.0 7694.6 7835.0 7610.2 7652.4 7668.1 7683.8 7716.0 6158.7 6187.7 7625.6 7628.4 7715.2 7441.2 7447.5 7452.0 7479.0 7485.8 7423.6 7602.9 7621.5 7624.6 7644.0 6103.6 6383.9 7081.9 7463.5 7494.0 08:29:08 INFO - PROCESS | 1656 | 08:29:08 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:18690.37 Median:52527.24 stddev:26111.94 (49.7%) stddev-sans-first:26150.35 08:29:08 INFO - PROCESS | 1656 | Values: 724.6 745.2 747.7 768.6 778.0 12722.9 15924.0 15949.0 16015.4 16016.1 14622.0 14627.8 14640.3 14663.6 14698.1 774.2 925.7 930.7 965.8 969.0 951.1 960.6 962.7 962.9 963.0 967.2 993.1 1001.1 1003.4 1005.5 961.8 961.8 962.2 963.1 963.7 723.5 744.4 745.6 745.9 748.4 14108.9 14279.6 14471.5 14512.6 14521.3 13522.3 13534.5 13579.3 13612.3 13681.5 10391.7 10496.4 10561.7 10565.9 10870.1 3296.9 3549.1 3596.5 3606.8 3856.3 79021.0 79325.4 79558.0 79619.8 80965.0 9626.5 10023.4 10105.2 10233.5 10258.5 22818.2 23503.6 23558.3 23595.8 23680.9 7743.0 7769.1 7828.6 7832.5 7951.0 3576.6 4200.9 4218.8 4266.4 4285.8 3221.5 3304.4 3601.8 3776.4 3794.4 669.5 682.6 683.8 684.9 687.6 512.7 533.1 575.5 586.4 622.2 8410.2 8486.4 8527.2 8620.8 8631.3 539.9 595.9 613.1 629.5 633.6 3877.0 3929.5 3974.6 4074.8 4077.8 92952.0 96033.0 96587.0 96602.6 97613.5 74554.9 75162.0 76900.0 82270.2 82591.0 72792.9 73177.6 73515.6 73805.3 74365.0 7568.3 7655.0 7699.2 7794.5 7896.1 50670.7 50903.0 52231.7 52822.7 53239.7 58143.1 61122.7 69953.0 70337.6 71598.6 10924.3 11247.4 11311.6 11378.5 11646.0 12043.7 12196.0 12251.6 12319.2 13047.8 11632.4 11682.4 11727.0 11818.9 12132.0 11665.2 11706.6 11803.4 11821.1 12399.4 11395.5 11479.1 11483.9 11831.6 11928.6 9759.0 9944.4 10119.3 10368.0 10459.4 7862.8 9897.7 9906.9 10132.9 10145.6 08:29:08 INFO - PROCESS | 1656 | -------- Summary: end -------- 08:29:08 INFO - PROCESS | 1656 | 08:29:09 INFO - TEST-INFO | 1656: exit 0 08:29:09 INFO - TEST-OK | dromaeo_css | took 1109530ms 08:29:09 INFO - TEST-START | kraken 08:29:09 INFO - operating with platform_type : mac_ 08:29:09 INFO - Initialising browser for kraken test... 08:29:09 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpctt2CH/profile http://localhost:49280/getInfo.html) 08:29:11 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 08:29:11 INFO - PROCESS | 1668 | colorDepth:24 08:29:11 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 08:29:11 INFO - PROCESS | 1668 | __metrics 08:29:11 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:29:12 INFO - TEST-INFO | 1668: exit 0 08:29:12 INFO - Browser initialized. 08:29:12 INFO - Running cycle 1/1 for kraken test... 08:29:12 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpctt2CH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:24 INFO - PROCESS | 1672 | RSS: Main: 171720704 08:29:24 INFO - PROCESS | 1672 | 08:29:27 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:27 INFO - PROCESS | 1672 | RSS: Main: 184045568 08:29:27 INFO - PROCESS | 1672 | 08:29:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 08:29:31 INFO - PROCESS | 1672 | RSS: Main: 192704512 08:29:31 INFO - PROCESS | 1672 | 08:29:34 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 08:29:35 INFO - PROCESS | 1672 | RSS: Main: 196116480 08:29:35 INFO - PROCESS | 1672 | 08:29:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 08:29:37 INFO - PROCESS | 1672 | RSS: Main: 196694016 08:29:37 INFO - PROCESS | 1672 | 08:29:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:40 INFO - PROCESS | 1672 | RSS: Main: 196747264 08:29:40 INFO - PROCESS | 1672 | 08:29:43 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:43 INFO - PROCESS | 1672 | RSS: Main: 197451776 08:29:43 INFO - PROCESS | 1672 | 08:29:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:47 INFO - PROCESS | 1672 | RSS: Main: 198524928 08:29:47 INFO - PROCESS | 1672 | 08:29:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 08:29:50 INFO - PROCESS | 1672 | RSS: Main: 198823936 08:29:50 INFO - PROCESS | 1672 | 08:29:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:53 INFO - PROCESS | 1672 | RSS: Main: 197836800 08:29:53 INFO - PROCESS | 1672 | 08:29:54 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:55 INFO - PROCESS | 1672 | RSS: Main: 198053888 08:29:55 INFO - PROCESS | 1672 | 08:29:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:58 INFO - PROCESS | 1672 | RSS: Main: 198287360 08:29:58 INFO - PROCESS | 1672 | 08:30:01 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:30:01 INFO - PROCESS | 1672 | RSS: Main: 199172096 08:30:01 INFO - PROCESS | 1672 | 08:30:04 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:30:05 INFO - PROCESS | 1672 | RSS: Main: 198365184 08:30:05 INFO - PROCESS | 1672 | 08:30:06 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 08:30:07 INFO - PROCESS | 1672 | RSS: Main: 200335360 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | __start_tp_report 08:30:07 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 08:30:07 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 08:30:07 INFO - PROCESS | 1672 | |i|pagename|runs| 08:30:07 INFO - PROCESS | 1672 | |0;ai-astar;115;118;107;115;121;118;109;113;114;113 08:30:07 INFO - PROCESS | 1672 | |1;audio-beat-detection;179;153;149;187;113;173;168;124;176;120 08:30:07 INFO - PROCESS | 1672 | |2;audio-dft;197;192;200;202;197;197;197;195;199;199 08:30:07 INFO - PROCESS | 1672 | |3;audio-fft;64;79;74;140;59;73;88;54;145;86 08:30:07 INFO - PROCESS | 1672 | |4;audio-oscillator;77;80;123;77;79;92;119;80;79;124 08:30:07 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;88;86;88;86;88;85;89;84;93;119 08:30:07 INFO - PROCESS | 1672 | |6;imaging-darkroom;95;95;97;99;94;95;95;118;91;132 08:30:07 INFO - PROCESS | 1672 | |7;imaging-desaturate;118;144;88;90;90;90;88;114;143;109 08:30:07 INFO - PROCESS | 1672 | |8;json-parse-financial;60;63;64;64;67;65;66;78;64;61 08:30:07 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;62;66;71;66;78;74;74;66;65;65 08:30:07 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;83;79;70;95;96;105;90;81;84;85 08:30:07 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;146;151;147;136;138;143;148;125;147;143 08:30:07 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;161;164;170;164;169;160;158;162;165;162 08:30:07 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;69;70;69;68;68;69;68;66;62;57 08:30:07 INFO - PROCESS | 1672 | __end_tp_report 08:30:07 INFO - PROCESS | 1672 | __start_cc_report 08:30:07 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1062 08:30:07 INFO - PROCESS | 1672 | __end_cc_report 08:30:07 INFO - PROCESS | 1672 | __startTimestamp1467646207084__endTimestamp 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | ------- Summary: start ------- 08:30:07 INFO - PROCESS | 1672 | Number of tests: 14 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:4.19 (3.6%) stddev-sans-first:4.44 08:30:07 INFO - PROCESS | 1672 | Values: 115.0 118.0 107.0 115.0 121.0 118.0 109.0 113.0 114.0 113.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:170.50 stddev:26.91 (15.8%) stddev-sans-first:27.01 08:30:07 INFO - PROCESS | 1672 | Values: 179.0 153.0 149.0 187.0 113.0 173.0 168.0 124.0 176.0 120.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:197.50 Median:198.00 stddev:2.76 (1.4%) stddev-sans-first:2.92 08:30:07 INFO - PROCESS | 1672 | Values: 197.0 192.0 200.0 202.0 197.0 197.0 197.0 195.0 199.0 199.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:86.20 Median:73.50 stddev:31.62 (43.0%) stddev-sans-first:32.50 08:30:07 INFO - PROCESS | 1672 | Values: 64.0 79.0 74.0 140.0 59.0 73.0 88.0 54.0 145.0 86.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:79.00 stddev:20.49 (25.9%) stddev-sans-first:20.90 08:30:07 INFO - PROCESS | 1672 | Values: 77.0 80.0 123.0 77.0 79.0 92.0 119.0 80.0 79.0 124.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:88.00 stddev:10.29 (11.7%) stddev-sans-first:10.87 08:30:07 INFO - PROCESS | 1672 | Values: 88.0 86.0 88.0 86.0 88.0 85.0 89.0 84.0 93.0 119.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:101.10 Median:95.00 stddev:13.18 (13.9%) stddev-sans-first:13.79 08:30:07 INFO - PROCESS | 1672 | Values: 95.0 95.0 97.0 99.0 94.0 95.0 95.0 118.0 91.0 132.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:107.40 Median:88.00 stddev:22.18 (25.2%) stddev-sans-first:23.19 08:30:07 INFO - PROCESS | 1672 | Values: 118.0 144.0 88.0 90.0 90.0 90.0 88.0 114.0 143.0 109.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:64.50 stddev:4.96 (7.7%) stddev-sans-first:4.89 08:30:07 INFO - PROCESS | 1672 | Values: 60.0 63.0 64.0 64.0 67.0 65.0 66.0 78.0 64.0 61.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:5.19 (7.6%) stddev-sans-first:4.90 08:30:07 INFO - PROCESS | 1672 | Values: 62.0 66.0 71.0 66.0 78.0 74.0 74.0 66.0 65.0 65.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:84.50 stddev:9.98 (11.8%) stddev-sans-first:10.49 08:30:07 INFO - PROCESS | 1672 | Values: 83.0 79.0 70.0 95.0 96.0 105.0 90.0 81.0 84.0 85.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:146.50 stddev:7.63 (5.2%) stddev-sans-first:7.98 08:30:07 INFO - PROCESS | 1672 | Values: 146.0 151.0 147.0 136.0 138.0 143.0 148.0 125.0 147.0 143.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.00 stddev:3.78 (2.3%) stddev-sans-first:3.90 08:30:07 INFO - PROCESS | 1672 | Values: 161.0 164.0 170.0 164.0 169.0 160.0 158.0 162.0 165.0 162.0 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:68.50 stddev:4.06 (5.9%) stddev-sans-first:4.21 08:30:07 INFO - PROCESS | 1672 | Values: 69.0 70.0 69.0 68.0 68.0 69.0 68.0 66.0 62.0 57.0 08:30:07 INFO - PROCESS | 1672 | -------- Summary: end -------- 08:30:07 INFO - PROCESS | 1672 | 08:30:07 INFO - TEST-INFO | 1672: exit 0 08:30:07 INFO - TEST-OK | kraken | took 58593ms 08:30:07 INFO - SUITE-END | took 1168s 08:30:08 INFO - Completed test suite (00:19:28) 08:30:08 INFO - javascript benchmark 08:30:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2917.489439348114, 3023.3499797543523, 3571.232185080208, 3591.856325746972, 3647.288778688157, 5254.553362964148, 5727.885442291152, 5904.2324497815225, 5904.380040095787, 5947.940520594792, 4979.278004689327, 5879.52963762899, 5883.823485295437, 5904.291485021803, 5921.141434491996, 5242.292290540785, 5288.286081379022, 5340.279062326575, 5342.759575819078, 5353.063213937565, 4397.9340309895215, 4406.25093734066, 5241.842744717665, 5349.759260833272, 5369.328833895763, 5326.813561525348, 5346.465353464661, 5347.919781203285, 5362.008028514718, 5370.194470829388, 5300.310959575249, 5312.681239125626, 5332.999999999981, 5343.786248550092, 5371.704556249405, 5189.169732842727, 5218.895622087537, 5309.814156504503, 5338.466153384669, 5348.705821179872, 4455.77721113943, 5537.1140617501405, 5757.0788673811985, 5893.911591326134, 5913.438223368773, 6173.59871608344, 6234.688265586748, 6246.843828904268, 6276.5292603054495, 6291.087792270096, 6242.219722534684, 6272.278687950853, 6280.748770049193, 6300.117983482316, 6311.337309582474, 5843.620164689281, 5940.34656187819, 5943.197668314765, 5974.581779275452, 5975.551833612496, 6380.649064301508, 6387.425131738166, 6435.066915297256, 6452.419282264619, 6477.319881412478, 6204.844878877974, 6237.937620623827, 6247.843803904939, 6249.218847644044, 6252.218472690914, 6244.7814326499265, 6292.748290068437, 6294.464970477469, 6319.178506794087, 6356.682165891687, 6195.504359651217, 6236.906446403307, 6239.157713708682, 6255.46828519581, 6274.780382686584, 6233.376662333821, 6244.063390491372, 6255.655938923403, 6258.687065646791, 6277.309495955441, 4864.489228630943, 5009.474005229471, 5057.848264552069, 5073.771680274396, 5106.846794596094, 4536.909261814745, 4555.567221113989, 4576.267797152506, 4580.38164847748, 4612.238980568169, 5363.329583802025, 5814.505767009851, 5870.0, 6051.031834906482, 6143.078538219213, 6172.660503672341, 6256.74973001084, 6257.249130104326, 6288.339724328879, 6361.9045714314325, 6057.0, 6067.423594758491, 6070.605410648293, 6074.362191969868, 6082.422169893853, 5453.23654688344, 5564.221009058735, 5566.582506311962, 5569.610127291051, 5572.024895643246, 5340.91988620171, 6506.682080464054, 6512.6092434454085, 6550.2794692583775, 6563.278039415661, 5206.8958620828125, 6316.11574379578, 6324.557280990287, 6348.984162533972, 6524.086627872197, 6359.650219237987, 6461.903071454026, 6542.476601871744, 6542.574732642363, 6549.803505894831, 6237.033259844731, 6283.654399008098, 6298.590591611531, 6302.810915672537, 6303.117563541016, 6351.491880649629, 6356.55504114726, 6370.90443643355, 6381.106645069787, 6390.9041364378645, 6104.755809767559, 6154.753809847556, 6158.291796443466, 6198.969005155126, 6213.689315534296, 6058.545609079249, 6130.887362651087, 6139.6009259398, 6175.3515880831865, 6253.749850005949, 5506.972465137648, 6136.8772624548155, 6141.7543298267565, 6167.907481387872, 6168.383161683796, 5160.174372100596, 5657.717114144194, 6141.240538582634, 6143.0, 6235.75056997715, 6117.327094019565, 6157.415045570664, 6164.4143806338325, 6170.475509581735, 6180.6291622502795], "value": 5767.771913023295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.7797264135384, 552.1386636846519, 578.0655691517009, 608.5314307982852, 613.450961389556, 31495.527567086512, 38385.424218636705, 39465.21069578607, 39594.41622335103, 39674.40488392676, 40574.797126014404, 41369.965750856165, 41493.58506414935, 41974.16051678965, 41979.58020419795, 9552.80894382112, 9703.902960970407, 9704.369216000972, 9779.217662586976, 9803.6078556858, 9682.46746428946, 9865.013498650149, 9931.404115753041, 9950.701478955643, 9978.201743860474, 9765.072318129802, 9894.40633561985, 9917.355371900803, 10001.249906257024, 10003.199744020461, 9887.307888447811, 9910.90089099107, 9954.35296705719, 9966.65116720915, 9972.700818975442, 9769.364991275545, 9800.921898591148, 9863.556139973718, 9871.703848884545, 9895.455749933752, 39549.80225098856, 40260.39609405861, 40413.59586404128, 40601.1879762406, 40798.9800254993, 3273.3616944695796, 3327.600687917441, 3360.6975372216375, 3467.3412051710093, 3812.923741525182, 26334.86832565844, 26500.0, 27158.728412715816, 27457.588136177972, 27766.722332776615, 2755.9448811023867, 2764.944701105987, 2770.6952235254107, 2773.5839624056553, 2792.1483947396036, 411260.0, 411656.0, 413136.93431532953, 415793.92103039596, 416628.0, 37577.81211093927, 38344.61655383466, 62478.0, 64291.0, 64399.0, 30876.69123308783, 36167.0, 37140.0, 37404.81297593495, 37449.43825842615, 13675.863241367659, 16469.83530164707, 16536.83463165377, 16537.83462165387, 16579.91710041442, 13631.659208519668, 13923.373448194652, 14071.648208794863, 14118.435262589586, 14145.434182632785, 8447.690607955778, 8461.450005749606, 8585.141485851489, 8630.568471576396, 8679.869801952977, 3122.765792565521, 3510.087377281874, 3524.6827785499427, 3545.1137215696076, 3588.372034893883, 1020.4693559349097, 1070.2240875365299, 1087.9075278601408, 1138.7494751154732, 1175.1245322234818, 26706.332341691224, 30142.69857301399, 30939.535906961413, 31437.685623143934, 31841.363172736415, 1181.1023622047305, 1214.993925030387, 1225.5096375029773, 1230.8276841242234, 1239.8202260672151, 12065.879341206652, 14376.712465750627, 14806.407743690132, 15816.76274855878, 15892.920535397248, 588462.0, 590569.0, 592089.0, 595289.0, 599036.0, 62055.0, 63046.684766575876, 63343.6832815833, 63349.0, 63353.68323158355, 1528.3504510582957, 1537.8385269546536, 1543.7375646140183, 1548.9612759681097, 1559.6958593074241, 30475.085747427613, 30842.0, 30966.53550196704, 31035.53446698256, 31370.52944205793, 54553.72723136359, 54610.18084728653, 55201.72399137979, 55274.170887437525, 55320.0, 435521.0, 435612.0, 437246.0, 545879.0, 546745.0, 27309.317267068483, 27819.860900695367, 28210.012649557168, 28266.0, 28658.570121447778, 46918.76540617275, 47741.52258477371, 47767.04465910732, 48993.51006490032, 49179.508204917496, 39059.41410878896, 39742.15941490021, 40047.79976100218, 40129.0, 40187.79906100451, 38931.805340973115, 39090.60909390869, 39381.0, 39551.40672889967, 39724.0, 38376.0, 38750.6124938747, 38927.0, 38930.61069389383, 39570.60429395669, 33502.60904301859, 34487.65512344844, 34599.0, 34764.47853282152, 35999.820000899825, 22357.217497388163, 25856.627929585047, 26021.739782601933, 26144.477110458065, 26412.471750565266], "value": 18916.050699823856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.3444902522537, 412.39995806102127, 413.1509747468952, 418.48944287968675, 427.18621026943663, 16012.119333436656, 17225.224864881096, 20246.29137980171, 21710.782892171075, 21813.454663633416, 20734.0, 21074.0, 21119.049642766073, 22579.435514112116, 22596.43508912278, 5687.203791469197, 5714.028615135416, 6000.759969601221, 6052.848678783043, 6225.439710426061, 6060.424259695322, 6066.454019138277, 6109.389061093877, 6151.0, 6174.8147555573405, 5777.884442311151, 6063.818085457443, 6120.1125836753645, 6153.600015998968, 6174.413430724074, 5090.185570308751, 6041.486473649745, 6083.543734219951, 6126.816195514164, 6156.507479401659, 5278.392984806758, 5291.1798671206025, 5351.09031464652, 5398.595105367113, 5444.074507333763, 24981.125660601974, 26245.0, 26283.868580657167, 27275.0, 27523.86238068817, 2109.4726318420394, 2182.978170218309, 2253.233900473847, 2311.1857192104285, 2880.2079428157217, 9767.413955162712, 10191.03185197405, 10247.38515689061, 10395.688129356131, 10548.05067543917, 1625.0655872873144, 1664.4424117920512, 1767.761352217447, 1815.464437990796, 1838.3933302010305, 94270.0, 104775.0, 114552.38739994398, 119591.2061319081, 121063.78936210614, 11485.712857178638, 11738.237014594195, 11890.28658280506, 11936.820947685792, 12074.456649450796, 12757.936210319074, 15129.546113616609, 15134.621634459007, 15480.0, 15591.532254032398, 9388.8591671125, 9395.557155139577, 9410.106039926197, 9451.952740236393, 9523.380980236263, 8951.507667078373, 9068.455892646462, 9113.043130471338, 9339.066093390607, 9459.858102128474, 4182.393552934807, 4655.930161047587, 4845.63657725665, 4867.561919427198, 4915.336429581961, 1873.428604275709, 1949.756280464942, 2050.7846676099093, 2052.5073982244453, 2069.9586008280053, 969.1762002298132, 978.8791833350773, 1003.2575893838507, 1043.118564812732, 1053.5417093564324, 16953.745693814602, 21061.47346316324, 21125.438809912746, 21231.256906008526, 21455.14179432805, 992.5781542844262, 1013.3463915774284, 1030.469308306223, 1036.6319956415514, 1040.8490768838476, 9302.395344302598, 9693.127618514227, 11638.709032274091, 11645.41772911368, 11673.591424300108, 634548.0, 650386.0, 658323.0, 675273.0, 680681.0, 128376.91744344129, 131107.0, 136045.0, 136463.0, 136545.0, 1057.984130238047, 1095.3318475729639, 1104.1939384249542, 1104.4367372639852, 1108.7172770943519, 18740.437786866416, 19353.4193974181, 19502.707459387835, 19558.511037224183, 19727.704084438457, 51979.0, 52242.738786305825, 53167.20249196343, 53525.0, 56389.71805140948, 78473.2152678466, 81725.59137204514, 81775.18224817676, 81936.0, 83972.16027839643, 7342.265773422615, 8300.377471689768, 8310.168983101641, 8327.95836020816, 8394.538300393537, 9143.862842057242, 12763.553275635308, 12952.093353465167, 13250.46998120103, 13318.800217996544, 11007.339559626447, 11259.268147570381, 11459.541618335174, 11608.941955290169, 11682.649520514398, 10795.6221532246, 11072.557097716324, 11155.665330040112, 11371.147163962902, 11393.259438136494, 11459.31244125355, 11479.8278025828, 11615.825762613737, 11690.298582085103, 11744.354060526754, 7163.677634506355, 8021.639026243716, 8250.0, 8312.335013198808, 8581.8712719308, 10487.318324308895, 11382.772344553228, 11508.482118304864, 11591.710207244887, 11593.420328983348], "value": 9820.46811840905, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1619.303699409254, 1640.48324777695, 1911.827935485806, 1996.4310171601087, 2044.3866839948012, 6961.825954351144, 7521.247875212476, 8164.22439868213, 8874.511901845412, 9161.26709863211, 8784.253338466238, 8813.0, 8859.778505537364, 8885.333599979995, 8910.91089089109, 2185.8305806393582, 2403.0, 2502.2618327593314, 2519.0805356045003, 2522.798176145913, 2131.3073251193346, 2493.252024392675, 2510.3849556858595, 2514.107491840398, 2531.227975467482, 2511.2842839790665, 2526.002229119497, 2529.6964364276314, 2543.2878793937725, 2543.567593509108, 2465.827392082555, 2477.7770000699934, 2495.9376015599664, 2506.7994560435122, 2525.8358206716503, 2485.5898776701824, 2492.8628925409093, 2500.349909023667, 2522.6972763268527, 2536.7843733282693, 9018.59416326267, 9071.410358326688, 9090.13643703847, 9090.2273306769, 9091.227245684058, 5568.52667523261, 5617.157426386075, 5617.662940223599, 5722.656640601577, 5745.655260684331, 3428.3143371325837, 3568.0, 3626.7279954003557, 3712.3874560697454, 3740.9251814963823, 1070.796548655753, 1085.1535802074395, 1086.3427626286061, 1087.1846115413439, 1088.885667004961, 12142.878571214264, 12158.270503769802, 12171.634850954486, 12171.99999999991, 12185.086118541056, 4831.275308703723, 4873.269009648581, 4925.753712314442, 4941.1847045237855, 4941.530554597308, 10215.438150901624, 10238.744031399274, 10278.383297002054, 10314.381137131797, 10341.224408169266, 5472.753726082336, 5539.19681646159, 5555.77776888928, 5560.582956278296, 5585.636933599303, 4562.406887104655, 4960.305557221992, 4981.701097934136, 4986.501349865057, 5029.1953287473825, 3482.407990641597, 4134.090500089976, 4207.621314081747, 4244.766537840448, 4277.529471758104, 1194.2893978083027, 1403.599974007403, 1403.8175037245094, 1432.6633241188313, 1435.4975758484657, 926.8285367207088, 929.3215952354684, 985.9161971232382, 994.9651762188289, 997.1275134257525, 5503.871706300199, 6060.090986351995, 6137.447629713347, 6253.6873156342, 6277.497800175975, 863.9222469977732, 958.5351104714208, 960.9519524023771, 1002.904724051214, 1004.1815920025156, 3478.669526394988, 4052.756834589934, 4169.770662613525, 4174.039970806732, 4193.01827598226, 11030.952059554329, 11310.773784524428, 11358.375289359165, 11477.71305717347, 11499.655010349703, 10849.78300433987, 11063.059639930696, 11097.500612472459, 11147.21969462146, 11283.94358028221, 8626.482411055356, 8706.39055266138, 8772.38593298463, 8795.604197811113, 8798.912010879809, 5831.4168583141345, 6061.818145455643, 6081.695915204134, 6097.847553811191, 6115.7247923844425, 9999.700008999742, 10013.699589012342, 10085.991400859855, 10132.949335253277, 10173.0, 9923.1069203772, 10150.23873209527, 10191.439470829175, 10480.580776768844, 10482.947585262025, 6151.292601350902, 7241.384482319062, 7449.515781474187, 7668.309852113113, 7680.500767450098, 8238.09380968105, 8255.876161857457, 8461.365397595082, 8498.192671696179, 8544.957275213585, 7434.73978410753, 7617.69529218825, 7644.273793989562, 7665.578393188428, 7719.807004824925, 7288.890666639899, 7392.075990501187, 7475.813104672427, 7503.812404689927, 7560.243975602396, 6225.688715564294, 6358.268799088164, 7096.787096387116, 7113.288671132846, 7122.5726456412785, 4956.083124621957, 5024.924626130684, 5049.2173713074535, 5103.948960510495, 5185.481451854785, 5147.279380886604, 5173.379194496684, 5264.684118952875, 5317.1492561190025, 5381.704006279692], "value": 4746.421292792381, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.9798412095273, 336.3743437206795, 337.8952524717338, 343.2774010707461, 347.19450873972363, 7048.647567621624, 7077.079979602658, 7082.50422470426, 7115.039469671593, 7126.8574628507395, 5911.970440147793, 6819.840627093394, 7073.610951397671, 7075.568349350561, 7083.972823940526, 4906.9263961040615, 4919.286703428001, 5082.923756143661, 5097.770600322976, 5114.079465696192, 4763.571278584926, 5042.193249080148, 5095.0574143783515, 5105.974470127644, 5127.538521533062, 5036.546710796028, 5052.69683818972, 5055.69665820052, 5057.873553161164, 5066.113430149728, 5046.596272298244, 5062.519060689266, 5107.540321371076, 5123.51326623972, 5143.09995750744, 4379.693421460499, 4383.780810959471, 4386.188555117314, 4390.517043125254, 4399.5160532341415, 6510.5442619016685, 6793.0, 6794.184697836242, 6840.41856442203, 6846.178458584952, 5140.794368225266, 5983.611065280743, 5996.520278377763, 6023.969880150571, 6024.006039003559, 7580.431467639949, 7586.4689471737, 7586.772396828104, 7588.203238659971, 7603.619819009083, 4805.447373552051, 4808.831690890802, 4822.324874517535, 4827.662063655511, 4831.444383895861, 6336.207974003296, 7265.564066155995, 7946.404019698488, 8034.276915077671, 8054.395920305942, 4709.270063140219, 4846.176150054499, 4851.102546028996, 4889.535494128052, 4916.975415122902, 4966.925496117561, 4970.65205435616, 4971.527704868032, 4974.0, 4978.083437876444, 5958.731857066442, 5977.282726072899, 5981.026261333749, 5987.0, 6002.279726432856, 7519.511231769918, 7569.167391586921, 7574.431917606202, 7595.5822429766895, 7602.0, 1620.5705488045678, 1677.5722190841257, 1682.4027470248132, 1725.2064050536642, 1730.074410190542, 947.6162154327509, 1059.819830628795, 1075.9677209683723, 1080.3841810168285, 1091.7052395853234, 7091.574505529582, 7112.182099058571, 7147.499675022803, 7156.0, 7165.0, 7820.061592608923, 7825.530468171928, 7834.294913457816, 7841.607919603997, 7849.803754906173, 5826.737027264745, 7020.894686579705, 7072.7524536642, 7124.0, 7147.499675022698, 3252.6747325267283, 4136.503619565611, 4138.8344466221015, 4146.0, 4162.729422587522, 8323.084460709317, 8335.916640833635, 8336.958315208385, 8347.707830225912, 8370.0, 7592.278733520307, 7639.770806875803, 8205.384596155192, 8241.917580824234, 8287.95856020728, 8294.668213271521, 8302.211289927567, 8308.626111824862, 8316.293115085286, 8325.417220794607, 6323.557350985387, 7645.847083058196, 7909.644066016928, 7938.483998540077, 7940.0471943367165, 7781.805454863674, 7787.688492460238, 7809.687612495437, 7820.17888121739, 7828.960855195687, 7389.261073892568, 7590.734324298623, 8273.627686753991, 8286.0, 8309.542975136426, 4010.498687664042, 4599.62011396573, 4800.991791723777, 4888.951110488992, 4911.705297682151, 6877.552959057645, 7505.774826755206, 7667.961660191663, 7694.576798276148, 7835.0, 7610.200928902385, 7652.426068044808, 7668.118166410711, 7683.846323073619, 7716.035495563055, 6158.661273629993, 6187.690615469299, 7625.580593067212, 7628.42786791004, 7715.189905059888, 7441.181470038183, 7447.515911465737, 7452.031235939293, 7478.962605187157, 7485.812854678677, 7423.554586724814, 7602.923970760222, 7621.466497345355, 7624.618769061635, 7644.044494438195, 6103.633781972918, 6383.946648802896, 7081.929180708127, 7463.51487153355, 7494.0], "value": 5431.6935851117905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.583364565375, 745.1691364128994, 747.6971826410304, 768.5964868444063, 777.9572123533203, 12722.872771272285, 15924.0, 15949.043057416535, 16015.439459618916, 16016.11911344877, 14621.97646164769, 14627.78058329126, 14640.34118464669, 14663.633409164777, 14698.118112913206, 774.2373761844578, 925.6760133953113, 930.7114794413753, 965.8020105878313, 968.9806203875918, 951.0822056715268, 960.5821467661555, 962.6630679262272, 962.93259471837, 963.0177219236409, 967.1875624475439, 993.0863605482937, 1001.0940099210227, 1003.372891942536, 1005.5475036233687, 961.7835986902961, 961.8124465729186, 962.2350231565922, 963.1187463470916, 963.7012526116891, 723.5477826358526, 744.3858816476375, 745.6346390268784, 745.8694728422504, 748.4311922938606, 14108.858911410856, 14279.57161285163, 14471.493497727633, 14512.637184070378, 14521.273936303143, 13522.32388380577, 13534.458621655122, 13579.253141077237, 13612.319384030858, 13681.521146759816, 10391.740206494822, 10496.370217786956, 10561.683149505527, 10565.894341056568, 10870.130389568816, 3296.862582409065, 3549.1482044309437, 3596.478510615972, 3606.8376923038527, 3856.3058649443087, 79021.0, 79325.41349172984, 79558.0, 79619.8057029145, 80965.0, 9626.47054412, 10023.448710321003, 10105.242106842017, 10233.539490722935, 10258.538365773558, 22818.201362952215, 23503.647445288334, 23558.293251202493, 23595.7640423597, 23680.934357953935, 7743.032120984877, 7769.106552746506, 7828.647710853025, 7832.451728378959, 7951.0, 3576.570811502584, 4200.91598168041, 4218.831246750157, 4266.381374700651, 4285.8285668573535, 3221.548983142362, 3304.3721692878275, 3601.7573936991694, 3776.37689781183, 3794.354959656865, 669.4610838275138, 682.5733916302311, 683.7504310926575, 684.8904175332023, 687.5771400588702, 512.6667666017119, 533.0964015992932, 575.4619430832186, 586.4135864135864, 622.2035794183453, 8410.201030902055, 8486.363522735819, 8527.18991695788, 8620.78448038804, 8631.266342360845, 539.919012148181, 595.9195508606283, 613.1109890658474, 629.5467263570222, 633.597665482422, 3877.0, 3929.548101968253, 3974.5627980922077, 4074.7555146691293, 4077.836886524565, 92952.0, 96033.0, 96587.0, 96602.55096173563, 97613.51193243988, 74554.8816767749, 75162.0, 76900.0, 82270.17729822744, 82591.0, 72792.90810637844, 73177.63411183016, 73515.63242183861, 73805.26194738092, 74364.99999999892, 7568.270868613091, 7654.961725191339, 7699.191584883507, 7794.510178877273, 7896.052473702963, 50670.74664626653, 50902.96388144581, 52231.73884130555, 52822.73588632032, 53239.733801330745, 58143.12785308308, 61122.694386527786, 69953.0, 70337.64831175811, 71598.64200678964, 10924.2899211551, 11247.437628118398, 11311.604093856675, 11378.487968041292, 11646.0, 12043.698907527032, 12196.0, 12251.632451026484, 12319.199252048587, 13047.804282935953, 11632.360220187971, 11682.357470339213, 11727.0, 11818.881811182122, 12132.029437645144, 11665.24175928562, 11706.590269340873, 11803.350815705218, 11821.054315654555, 12399.380030998595, 11395.544178232778, 11479.139064570023, 11483.94258028738, 11831.64505064815, 11928.642140735792, 9759.0, 9944.403335799585, 10119.291649584458, 10368.015038571324, 10459.372437653765, 7862.781268903101, 9897.703068907944, 9906.936344459611, 10132.949335253277, 10145.64490242838], "value": 7095.10407094049, "unit": "score"}], "name": "dromaeo_css", "value": 7621.563094899373, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 107.0, 115.0, 121.0, 118.0, 109.0, 113.0, 114.0, 113.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 153.0, 149.0, 187.0, 113.0, 173.0, 168.0, 124.0, 176.0, 120.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 192.0, 200.0, 202.0, 197.0, 197.0, 197.0, 195.0, 199.0, 199.0], "value": 197.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 79.0, 74.0, 140.0, 59.0, 73.0, 88.0, 54.0, 145.0, 86.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 123.0, 77.0, 79.0, 92.0, 119.0, 80.0, 79.0, 124.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 88.0, 85.0, 89.0, 84.0, 93.0, 119.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 99.0, 94.0, 95.0, 95.0, 118.0, 91.0, 132.0], "value": 101.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 144.0, 88.0, 90.0, 90.0, 90.0, 88.0, 114.0, 143.0, 109.0], "value": 107.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 64.0, 64.0, 67.0, 65.0, 66.0, 78.0, 64.0, 61.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 71.0, 66.0, 78.0, 74.0, 74.0, 66.0, 65.0, 65.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 70.0, 95.0, 96.0, 105.0, 90.0, 81.0, 84.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 151.0, 147.0, 136.0, 138.0, 143.0, 148.0, 125.0, 147.0, 143.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 170.0, 164.0, 169.0, 160.0, 158.0, 162.0, 165.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 68.0, 68.0, 69.0, 68.0, 66.0, 62.0, 57.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1537.5, "alertThreshold": 2.0}]} 08:30:08 INFO - Return code: 0 08:30:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:30:08 ERROR - # TBPL SUCCESS # 08:30:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:30:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:30:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:30:08 INFO - 2016-07-04 08:30:08.439 screenresolution[1678:10309] starting screenresolution argv=screenresolution get 08:30:08 INFO - 2016-07-04 08:30:08.442 screenresolution[1678:10309] Display 0: 1600x1200x32@60 08:30:08 INFO - 2016-07-04 08:30:08.447 screenresolution[1679:10312] starting screenresolution argv=screenresolution list 08:30:08 INFO - Available Modes on Display 0 08:30:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:30:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:30:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:30:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:30:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:30:08 INFO - Intel Iris: 08:30:08 INFO - Chipset Model: Intel Iris 08:30:08 INFO - Type: GPU 08:30:08 INFO - Bus: Built-In 08:30:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:30:08 INFO - Vendor: Intel (0x8086) 08:30:08 INFO - Device ID: 0x0a2e 08:30:08 INFO - Revision ID: 0x0009 08:30:08 INFO - Displays: 08:30:08 INFO - Display: 08:30:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:30:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:30:08 INFO - Display Serial Number: 1600x1200 60 08:30:08 INFO - Main Display: Yes 08:30:08 INFO - Mirror: Off 08:30:08 INFO - Online: Yes 08:30:08 INFO - Rotation: Supported 08:30:08 INFO - Return code: 0 08:30:08 INFO - Running post-action listener: _resource_record_post_action 08:30:08 INFO - Running post-run listener: _resource_record_post_run 08:30:09 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 38045184; Write bytes: 496005632; Read time: 402; Write time: 1947 08:30:09 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 195056128; Write bytes: 195819520; Read time: 17525; Write time: 401 08:30:09 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 36009472; Write bytes: 299178496; Read time: 375; Write time: 1542 08:30:09 INFO - Running post-run listener: _upload_blobber_files 08:30:09 INFO - Blob upload gear active. 08:30:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:30:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:30:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:30:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:30:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:30:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:11 INFO - (blobuploader) - INFO - Done attempting. 08:30:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:30:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:30:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:12 INFO - (blobuploader) - INFO - Done attempting. 08:30:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:30:12 INFO - Return code: 0 08:30:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:30:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:30:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a01001faf608d21c90b2cdda47071889d279b142fe6aaf8ae0319baf4edd5e1abcb970132b05ba7012f126edcfd7e2a0016aa576327b024a1dca3d14f5be31a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c63b762ba1dfc48435e623b388920c9ced78d76e4869a68051bf5f4ae5ab1e90a2b4eacffc256ccd17cad76d61da0a2147996ebccb38e12fedae3e4fa944746"} 08:30:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:30:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:30:12 INFO - Contents: 08:30:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a01001faf608d21c90b2cdda47071889d279b142fe6aaf8ae0319baf4edd5e1abcb970132b05ba7012f126edcfd7e2a0016aa576327b024a1dca3d14f5be31a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c63b762ba1dfc48435e623b388920c9ced78d76e4869a68051bf5f4ae5ab1e90a2b4eacffc256ccd17cad76d61da0a2147996ebccb38e12fedae3e4fa944746"} 08:30:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:30:12 INFO - Copying logs to upload dir... 08:30:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:30:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.246986 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-04 08:30:12.391138) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 08:30:12.395276) ========= 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.I7b7fSfOse/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.xivNXvuA7X/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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/a01001faf608d21c90b2cdda47071889d279b142fe6aaf8ae0319baf4edd5e1abcb970132b05ba7012f126edcfd7e2a0016aa576327b024a1dca3d14f5be31a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c63b762ba1dfc48435e623b388920c9ced78d76e4869a68051bf5f4ae5ab1e90a2b4eacffc256ccd17cad76d61da0a2147996ebccb38e12fedae3e4fa944746"} build_url:https://queue.taskcluster.net/v1/task/BW1kiYJrRpqN7ZNZb5e67g/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010801 build_url: 'https://queue.taskcluster.net/v1/task/BW1kiYJrRpqN7ZNZb5e67g/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/a01001faf608d21c90b2cdda47071889d279b142fe6aaf8ae0319baf4edd5e1abcb970132b05ba7012f126edcfd7e2a0016aa576327b024a1dca3d14f5be31a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8c63b762ba1dfc48435e623b388920c9ced78d76e4869a68051bf5f4ae5ab1e90a2b4eacffc256ccd17cad76d61da0a2147996ebccb38e12fedae3e4fa944746"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 08:30:12.427522) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:30:12.427928) ========= 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.I7b7fSfOse/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.xivNXvuA7X/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.005129 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:30:12.476685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 08:30:12.477016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 08:30:12.477374) ========= ========= Total master_lag: 0.17 =========