builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0167 starttime: 1463104099.15 results: success (0) buildid: 20160512164138 builduid: 807cdb85801b42c7823919ff44d662cc revision: 55d9570b4520adff40c2362d2e027655f4271f7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:19.148761) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:19.149158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:19.149435) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:19.167144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:19.167595) ========= 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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-05-12 18:48:19-- 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% 156M=0s 2016-05-12 18:48:19 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088388 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:19.274471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:19.274912) ========= 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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.018916 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:19.323974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 18:48:19.324333) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 55d9570b4520adff40c2362d2e027655f4271f7a --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 55d9570b4520adff40c2362d2e027655f4271f7a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bYU6vpWhpc/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.FB6gCdi7aT/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-05-12 18:48:19,401 truncating revision to first 12 chars 2016-05-12 18:48:19,402 Setting DEBUG logging. 2016-05-12 18:48:19,402 attempt 1/10 2016-05-12 18:48:19,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/55d9570b4520?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 18:48:20,365 unpacking tar archive at: mozilla-beta-55d9570b4520/testing/mozharness/ program finished with exit code 0 elapsedTime=1.204257 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 18:48:20.546368) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:20.546707) ========= script_repo_revision: 55d9570b4520adff40c2362d2e027655f4271f7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:20.547113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:20.547422) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 18:48:20.561973) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-12 18:48:20.562268) ========= /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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 18:48:20 INFO - MultiFileLogger online at 20160512 18:48:20 in /builds/slave/test 18:48:20 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 18:48:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:48:20 INFO - {'append_to_log': False, 18:48:20 INFO - 'base_work_dir': '/builds/slave/test', 18:48:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:48:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:48:20 INFO - 'branch': 'Mozilla-Beta', 18:48:20 INFO - 'buildbot_json_path': 'buildprops.json', 18:48:20 INFO - 'config_files': ('talos/mac_config.py',), 18:48:20 INFO - 'default_actions': ('clobber', 18:48:20 INFO - 'read-buildbot-config', 18:48:20 INFO - 'download-and-extract', 18:48:20 INFO - 'populate-webroot', 18:48:20 INFO - 'create-virtualenv', 18:48:20 INFO - 'install', 18:48:20 INFO - 'run-tests'), 18:48:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:48:20 INFO - 'download_minidump_stackwalk': True, 18:48:20 INFO - 'download_symbols': 'ondemand', 18:48:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:48:20 INFO - 'tooltool.py': '/tools/tooltool.py', 18:48:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:48:20 INFO - '/tools/misc-python/virtualenv.py')}, 18:48:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:48:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:48:20 INFO - 'installer_path': 'installer.exe', 18:48:20 INFO - 'log_level': 'info', 18:48:20 INFO - 'log_name': 'talos', 18:48:20 INFO - 'log_to_console': True, 18:48:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:48:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:48:20 INFO - 'opt_config_files': (), 18:48:20 INFO - 'pip_index': False, 18:48:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:48:20 INFO - 'cmd': ('bash', 18:48:20 INFO - '-c', 18:48:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:48:20 INFO - 'enabled': True, 18:48:20 INFO - 'halt_on_failure': False, 18:48:20 INFO - 'name': 'check_screen_resolution'},), 18:48:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:48:20 INFO - 'cmd': ('bash', 18:48:20 INFO - '-c', 18:48:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:48:20 INFO - 'enabled': True, 18:48:20 INFO - 'halt_on_failure': False, 18:48:20 INFO - 'name': 'check_screen_resolution'},), 18:48:20 INFO - 'run_cmd_checks_enabled': True, 18:48:20 INFO - 'sps_profile': False, 18:48:20 INFO - 'sps_profile_interval': 0, 18:48:20 INFO - 'suite': 'dromaeojs-e10s', 18:48:20 INFO - 'system_bits': '32', 18:48:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:48:20 INFO - 'title': 't-yosemite-r7-0167', 18:48:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:48:20 INFO - 'use_talos_json': True, 18:48:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:48:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:48:20 INFO - 'work_dir': 'build'} 18:48:20 INFO - ##### 18:48:20 INFO - ##### Running clobber step. 18:48:20 INFO - ##### 18:48:20 INFO - Running pre-action listener: _resource_record_pre_action 18:48:20 INFO - Running main action method: clobber 18:48:20 INFO - rmtree: /builds/slave/test/build 18:48:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:48:21 INFO - Running post-action listener: _resource_record_post_action 18:48:21 INFO - ##### 18:48:21 INFO - ##### Running read-buildbot-config step. 18:48:21 INFO - ##### 18:48:21 INFO - Running pre-action listener: _resource_record_pre_action 18:48:21 INFO - Running main action method: read_buildbot_config 18:48:21 INFO - Using buildbot properties: 18:48:21 INFO - { 18:48:21 INFO - "project": "", 18:48:21 INFO - "product": "firefox", 18:48:21 INFO - "script_repo_revision": "production", 18:48:21 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 18:48:21 INFO - "repository": "", 18:48:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 18:48:21 INFO - "buildid": "20160512164138", 18:48:21 INFO - "pgo_build": "False", 18:48:21 INFO - "basedir": "/builds/slave/test", 18:48:21 INFO - "buildnumber": 4, 18:48:21 INFO - "slavename": "t-yosemite-r7-0167", 18:48:21 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 18:48:21 INFO - "platform": "yosemite_r7", 18:48:21 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 18:48:21 INFO - "branch": "mozilla-beta", 18:48:21 INFO - "repo_path": "releases/mozilla-beta", 18:48:21 INFO - "revision": "55d9570b4520adff40c2362d2e027655f4271f7a", 18:48:21 INFO - "stage_platform": "macosx64", 18:48:21 INFO - "builduid": "807cdb85801b42c7823919ff44d662cc", 18:48:21 INFO - "slavebuilddir": "test" 18:48:21 INFO - } 18:48:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 18:48:21 INFO - Running post-action listener: _resource_record_post_action 18:48:21 INFO - ##### 18:48:21 INFO - ##### Running download-and-extract step. 18:48:21 INFO - ##### 18:48:21 INFO - Running pre-action listener: _resource_record_pre_action 18:48:21 INFO - Running main action method: download_and_extract 18:48:21 INFO - mkdir: /builds/slave/test/build/tests 18:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:21 INFO - https://queue.taskcluster.net/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:48:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 18:48:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 18:48:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 18:48:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 18:48:22 INFO - Downloaded 1241 bytes. 18:48:22 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 18:48:22 INFO - Using the following test package requirements: 18:48:22 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 18:48:22 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:48:22 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 18:48:22 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:48:22 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 18:48:22 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 18:48:22 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:48:22 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 18:48:22 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 18:48:22 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:48:22 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 18:48:22 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:48:22 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 18:48:22 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:48:22 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 18:48:22 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 18:48:22 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 18:48:22 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 18:48:22 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 18:48: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')]} 18:48:22 INFO - https://queue.taskcluster.net/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:48:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 18:48:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 18:48:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 18:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 18:48:24 INFO - Downloaded 17747497 bytes. 18:48:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:48:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:48:27 INFO - Return code: 0 18:48:27 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 18:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:27 INFO - https://queue.taskcluster.net/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:48:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 18:48:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 18:48:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 18:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 18:48:29 INFO - Downloaded 17747497 bytes. 18:48:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:48:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:48:32 INFO - Return code: 0 18:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:32 INFO - https://queue.taskcluster.net/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:48:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 18:48:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 18:48:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 18:48:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 18:48:33 INFO - Downloaded 10845194 bytes. 18:48:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:48:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:48:33 INFO - Return code: 0 18:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:33 INFO - https://queue.taskcluster.net/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 18:48:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 18:48:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 18:48:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 18:48:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 18:48:36 INFO - Downloaded 88267198 bytes. 18:48:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 18:48:36 INFO - mkdir: /builds/slave/test/properties 18:48:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:48:36 INFO - Writing to file /builds/slave/test/properties/build_url 18:48:36 INFO - Contents: 18:48:36 INFO - build_url:https://queue.taskcluster.net/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 18:48:37 INFO - Running post-action listener: _resource_record_post_action 18:48:37 INFO - Running post-action listener: set_extra_try_arguments 18:48:37 INFO - ##### 18:48:37 INFO - ##### Running populate-webroot step. 18:48:37 INFO - ##### 18:48:37 INFO - Running pre-action listener: _resource_record_pre_action 18:48:37 INFO - Running main action method: populate_webroot 18:48:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:48:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:48:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:48:37 INFO - '--tppagecycles', 18:48:37 INFO - '7'], 18:48:37 INFO - 'tests': ['tsvgm']}}, 18:48:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:48:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:48:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:48:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:48:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:48:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:48:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:48:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:37 INFO - 'talos_options': ['--e10s'], 18:48:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:48:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:37 INFO - 'tests': ['damp', 'tps']}, 18:48:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:37 INFO - 'talos_options': ['--e10s'], 18:48:37 INFO - 'tests': ['damp', 'tps']}, 18:48:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:48:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:48:37 INFO - 'other': {'tests': ['a11yr', 18:48:37 INFO - 'ts_paint', 18:48:37 INFO - 'tpaint', 18:48:37 INFO - 'sessionrestore', 18:48:37 INFO - 'sessionrestore_no_auto_restore', 18:48:37 INFO - 'tabpaint']}, 18:48:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:48:37 INFO - 'tests': ['a11yr', 18:48:37 INFO - 'ts_paint', 18:48:37 INFO - 'tpaint', 18:48:37 INFO - 'sessionrestore', 18:48:37 INFO - 'sessionrestore_no_auto_restore', 18:48:37 INFO - 'tabpaint']}, 18:48:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:48:37 INFO - 'tests': ['a11yr', 18:48:37 INFO - 'ts_paint', 18:48:37 INFO - 'tpaint', 18:48:37 INFO - 'sessionrestore', 18:48:37 INFO - 'sessionrestore_no_auto_restore', 18:48:37 INFO - 'tabpaint']}, 18:48:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:48:37 INFO - 'tests': ['a11yr', 18:48:37 INFO - 'ts_paint', 18:48:37 INFO - 'tpaint', 18:48:37 INFO - 'sessionrestore', 18:48:37 INFO - 'sessionrestore_no_auto_restore', 18:48:37 INFO - 'tabpaint']}, 18:48:37 INFO - 'other_l64': {'tests': ['a11yr', 18:48:37 INFO - 'ts_paint', 18:48:37 INFO - 'tpaint', 18:48:37 INFO - 'sessionrestore', 18:48:37 INFO - 'sessionrestore_no_auto_restore', 18:48:37 INFO - 'tabpaint']}, 18:48:37 INFO - 'other_nol64': {'tests': ['a11yr', 18:48:37 INFO - 'ts_paint', 18:48:37 INFO - 'tpaint', 18:48:37 INFO - 'sessionrestore', 18:48:37 INFO - 'sessionrestore_no_auto_restore', 18:48:37 INFO - 'tabpaint']}, 18:48:37 INFO - 'svgr': {'tests': ['tsvgx', 18:48:37 INFO - 'tsvgr_opacity', 18:48:37 INFO - 'tart', 18:48:37 INFO - 'tscrollx', 18:48:37 INFO - 'cart']}, 18:48:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:48:37 INFO - 'tests': ['tsvgx', 18:48:37 INFO - 'tsvgr_opacity', 18:48:37 INFO - 'tart', 18:48:37 INFO - 'tscrollx', 18:48:37 INFO - 'cart']}, 18:48:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:37 INFO - 'tests': ['tp5o']}, 18:48:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:37 INFO - 'talos_options': ['--e10s'], 18:48:37 INFO - 'tests': ['tp5o']}, 18:48:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:37 INFO - 'talos_options': ['--xperf_path', 18:48:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:37 INFO - 'tests': ['tp5n']}, 18:48:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:37 INFO - 'talos_options': ['--e10s', 18:48:37 INFO - '--xperf_path', 18:48:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:37 INFO - 'tests': ['tp5n']}}, 18:48:37 INFO - 'talos.zip': {'path': '', 18:48:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:48:37 INFO - Running post-action listener: _resource_record_post_action 18:48:37 INFO - ##### 18:48:37 INFO - ##### Running create-virtualenv step. 18:48:37 INFO - ##### 18:48:37 INFO - Running pre-action listener: _resource_record_pre_action 18:48:37 INFO - Running main action method: create_virtualenv 18:48:37 INFO - Creating virtualenv /builds/slave/test/build/venv 18:48:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:48:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:48:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:48:37 INFO - Using real prefix '/tools/python27' 18:48:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:48:38 INFO - Installing distribute.............................................................................................................................................................................................done. 18:48:41 INFO - Installing pip.................done. 18:48:41 INFO - Return code: 0 18:48:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc70a5aaf40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ccad30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cc1b20>, '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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 18:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:48:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bYU6vpWhpc/Render', 18:48:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:48:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:48:41 INFO - 'HOME': '/Users/cltbld', 18:48:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:48:41 INFO - 'LOGNAME': 'cltbld', 18:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:41 INFO - 'MOZ_NO_REMOTE': '1', 18:48:41 INFO - 'NO_EM_RESTART': '1', 18:48:41 INFO - 'PAGER': '/bin/cat', 18:48:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:41 INFO - 'PWD': '/builds/slave/test', 18:48:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:48:41 INFO - 'SHELL': '/bin/bash', 18:48:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FB6gCdi7aT/Listeners', 18:48:41 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 18:48:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:48:41 INFO - 'USER': 'cltbld', 18:48:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:48:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:41 INFO - 'XPC_FLAGS': '0x0', 18:48:41 INFO - 'XPC_SERVICE_NAME': '0', 18:48:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:48:41 INFO - Cleaning up... 18:48:41 INFO - Return code: 0 18:48:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc70a5aaf40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ccad30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cc1b20>, '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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 18:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:48:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bYU6vpWhpc/Render', 18:48:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:48:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:48:41 INFO - 'HOME': '/Users/cltbld', 18:48:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:48:41 INFO - 'LOGNAME': 'cltbld', 18:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:41 INFO - 'MOZ_NO_REMOTE': '1', 18:48:41 INFO - 'NO_EM_RESTART': '1', 18:48:41 INFO - 'PAGER': '/bin/cat', 18:48:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:41 INFO - 'PWD': '/builds/slave/test', 18:48:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:48:41 INFO - 'SHELL': '/bin/bash', 18:48:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FB6gCdi7aT/Listeners', 18:48:41 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 18:48:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:48:41 INFO - 'USER': 'cltbld', 18:48:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:48:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:41 INFO - 'XPC_FLAGS': '0x0', 18:48:41 INFO - 'XPC_SERVICE_NAME': '0', 18:48:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:41 INFO - Downloading/unpacking psutil>=0.7.1 18:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:48:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:44 INFO - Installing collected packages: psutil 18:48:44 INFO - Running setup.py install for psutil 18:48:44 INFO - building 'psutil._psutil_osx' extension 18:48:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:48:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:48:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:48:44 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 18:48:45 INFO - building 'psutil._psutil_posix' extension 18:48:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:48:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:48:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:48:45 INFO - ^ 18:48:45 INFO - 1 warning generated. 18:48:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:48:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:45 INFO - Successfully installed psutil 18:48:45 INFO - Cleaning up... 18:48:45 INFO - Return code: 0 18:48:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:48: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')]} 18:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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')]} 18:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc70a5aaf40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ccad30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cc1b20>, '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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 18:48:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:48:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bYU6vpWhpc/Render', 18:48:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:48:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:48:45 INFO - 'HOME': '/Users/cltbld', 18:48:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:48:45 INFO - 'LOGNAME': 'cltbld', 18:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:45 INFO - 'MOZ_NO_REMOTE': '1', 18:48:45 INFO - 'NO_EM_RESTART': '1', 18:48:45 INFO - 'PAGER': '/bin/cat', 18:48:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:45 INFO - 'PWD': '/builds/slave/test', 18:48:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:48:45 INFO - 'SHELL': '/bin/bash', 18:48:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FB6gCdi7aT/Listeners', 18:48:45 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 18:48:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:48:45 INFO - 'USER': 'cltbld', 18:48:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:48:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:45 INFO - 'XPC_FLAGS': '0x0', 18:48:45 INFO - 'XPC_SERVICE_NAME': '0', 18:48:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:48:48 INFO - Installing collected packages: mozsystemmonitor 18:48:48 INFO - Running setup.py install for mozsystemmonitor 18:48:48 INFO - Successfully installed mozsystemmonitor 18:48:48 INFO - Cleaning up... 18:48:48 INFO - Return code: 0 18:48:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104e26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc70a5aaf40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ccad30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cc1b20>, '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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 18:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bYU6vpWhpc/Render', 18:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:48:48 INFO - 'HOME': '/Users/cltbld', 18:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:48:48 INFO - 'LOGNAME': 'cltbld', 18:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:48 INFO - 'MOZ_NO_REMOTE': '1', 18:48:48 INFO - 'NO_EM_RESTART': '1', 18:48:48 INFO - 'PAGER': '/bin/cat', 18:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:48 INFO - 'PWD': '/builds/slave/test', 18:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:48:48 INFO - 'SHELL': '/bin/bash', 18:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FB6gCdi7aT/Listeners', 18:48:48 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 18:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:48:48 INFO - 'USER': 'cltbld', 18:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:48 INFO - 'XPC_FLAGS': '0x0', 18:48:48 INFO - 'XPC_SERVICE_NAME': '0', 18:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:48 INFO - Downloading/unpacking blobuploader==1.2.4 18:48:48 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 18:48:48 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 18:48:48 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 18:48:48 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 18:48:48 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 18:48:48 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 18:48:50 INFO - Downloading blobuploader-1.2.4.tar.gz 18:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:48:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:48:50 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 18:48:50 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 18:48:50 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 18:48:50 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 18:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:48:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:52 INFO - Downloading docopt-0.6.1.tar.gz 18:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:48:52 INFO - Installing collected packages: blobuploader, requests, docopt 18:48:52 INFO - Running setup.py install for blobuploader 18:48:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:48:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:48:52 INFO - Running setup.py install for requests 18:48:52 INFO - Running setup.py install for docopt 18:48:52 INFO - Successfully installed blobuploader requests docopt 18:48:52 INFO - Cleaning up... 18:48:53 INFO - Return code: 0 18:48:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:53 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 0x104e26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc70a5aaf40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ccad30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cc1b20>, '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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 18:48:53 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 18:48:53 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 18:48:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bYU6vpWhpc/Render', 18:48:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:48:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:48:53 INFO - 'HOME': '/Users/cltbld', 18:48:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:48:53 INFO - 'LOGNAME': 'cltbld', 18:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:53 INFO - 'MOZ_NO_REMOTE': '1', 18:48:53 INFO - 'NO_EM_RESTART': '1', 18:48:53 INFO - 'PAGER': '/bin/cat', 18:48:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:53 INFO - 'PWD': '/builds/slave/test', 18:48:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:48:53 INFO - 'SHELL': '/bin/bash', 18:48:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FB6gCdi7aT/Listeners', 18:48:53 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 18:48:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:48:53 INFO - 'USER': 'cltbld', 18:48:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:48:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:53 INFO - 'XPC_FLAGS': '0x0', 18:48:53 INFO - 'XPC_SERVICE_NAME': '0', 18:48:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:48:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-accKju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:48:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-f81K1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:48:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-iF6Ne4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:48:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-LatGKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:48:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-63LBNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:48:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Ac7MeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:48:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-tKB8Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:48:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-1GOlk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:48:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-udD6EQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:48:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-7BOr0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:48:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-OoqMhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:48:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-MqyjcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:48:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-gMDOgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:48:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-DpFlcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-DCwK8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:48:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-lXqMpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:48:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-MNJSXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:48:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:48:55 INFO - Running setup.py install for manifestparser 18:48:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Running setup.py install for mozcrash 18:48:55 INFO - Running setup.py install for mozdebug 18:48:55 INFO - Running setup.py install for mozdevice 18:48:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Running setup.py install for mozfile 18:48:55 INFO - Running setup.py install for mozhttpd 18:48:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Running setup.py install for mozinfo 18:48:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:48:56 INFO - Running setup.py install for mozInstall 18:48:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:48:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:48:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:48:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:48:56 INFO - Running setup.py install for mozleak 18:48:56 INFO - Running setup.py install for mozlog 18:48:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:48:56 INFO - Running setup.py install for moznetwork 18:48:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:48:56 INFO - Running setup.py install for mozprocess 18:48:56 INFO - Running setup.py install for mozprofile 18:48:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:48:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:48:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:48:57 INFO - Running setup.py install for mozrunner 18:48:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:48:57 INFO - Running setup.py install for mozscreenshot 18:48:57 INFO - Running setup.py install for moztest 18:48:57 INFO - Running setup.py install for mozversion 18:48:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:48:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:48:57 INFO - Cleaning up... 18:48:57 INFO - Return code: 0 18:48:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48: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')]} 18:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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')]} 18:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:57 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 0x104e26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc70a5aaf40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ccad30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cc1b20>, '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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 18:48:57 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 18:48:57 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 18:48:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bYU6vpWhpc/Render', 18:48:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:48:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:48:57 INFO - 'HOME': '/Users/cltbld', 18:48:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:48:57 INFO - 'LOGNAME': 'cltbld', 18:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:57 INFO - 'MOZ_NO_REMOTE': '1', 18:48:57 INFO - 'NO_EM_RESTART': '1', 18:48:57 INFO - 'PAGER': '/bin/cat', 18:48:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:57 INFO - 'PWD': '/builds/slave/test', 18:48:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:48:57 INFO - 'SHELL': '/bin/bash', 18:48:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FB6gCdi7aT/Listeners', 18:48:57 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 18:48:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:48:57 INFO - 'USER': 'cltbld', 18:48:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:48:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:57 INFO - 'XPC_FLAGS': '0x0', 18:48:57 INFO - 'XPC_SERVICE_NAME': '0', 18:48:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:48:57 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-fORdoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:48:58 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)) 18:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:48:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-M9QFw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:48:58 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)) 18:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:48:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-8OBq7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:48:58 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)) 18:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:48:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-81wDSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:48:58 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)) 18:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:48:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-zIkqmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:48:58 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)) 18:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:48:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-FBDzeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:48:58 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)) 18:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:48:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-LuVNWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:48:58 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)) 18:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:48:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-FREuwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:48:58 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)) 18:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:48:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Zt_yHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:48:58 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)) 18:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:48:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Zznpgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:48:58 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)) 18:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:48:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ASoUne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:48:59 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)) 18:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:48:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-SfAO8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:48:59 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)) 18:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:48:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-y_iKnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:48:59 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)) 18:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:48:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-iPVYvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:48:59 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)) 18:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-EJytdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:59 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)) 18:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:48:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-wK3cFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:48:59 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)) 18:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:48:59 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-gvJ5f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:48:59 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)) 18:48:59 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)) 18:48:59 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)) 18:48:59 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)) 18:48:59 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)) 18:48:59 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)) 18:48:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:02 INFO - Downloading blessings-1.6.tar.gz 18:49:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:49:02 INFO - Installing collected packages: blessings 18:49:02 INFO - Running setup.py install for blessings 18:49:02 INFO - Successfully installed blessings 18:49:02 INFO - Cleaning up... 18:49:02 INFO - Return code: 0 18:49:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:49:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:49:02 INFO - Reading from file tmpfile_stdout 18:49:02 INFO - Current package versions: 18:49:02 INFO - blessings == 1.6 18:49:02 INFO - blobuploader == 1.2.4 18:49:02 INFO - docopt == 0.6.1 18:49:02 INFO - manifestparser == 1.1 18:49:02 INFO - mozInstall == 1.12 18:49:02 INFO - mozcrash == 0.17 18:49:02 INFO - mozdebug == 0.1 18:49:02 INFO - mozdevice == 0.48 18:49:02 INFO - mozfile == 1.2 18:49:02 INFO - mozhttpd == 0.7 18:49:02 INFO - mozinfo == 0.9 18:49:02 INFO - mozleak == 0.1 18:49:02 INFO - mozlog == 3.1 18:49:02 INFO - moznetwork == 0.27 18:49:02 INFO - mozprocess == 0.22 18:49:02 INFO - mozprofile == 0.28 18:49:02 INFO - mozrunner == 6.11 18:49:02 INFO - mozscreenshot == 0.1 18:49:02 INFO - mozsystemmonitor == 0.0 18:49:02 INFO - moztest == 0.7 18:49:02 INFO - mozversion == 1.4 18:49:02 INFO - psutil == 3.1.1 18:49:02 INFO - requests == 1.2.3 18:49:02 INFO - wsgiref == 0.1.2 18:49:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:02 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 0x104e26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc70a5aaf40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ccad30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cc1b20>, '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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 18:49:02 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 18:49:02 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 18:49:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bYU6vpWhpc/Render', 18:49:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:49:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:49:02 INFO - 'HOME': '/Users/cltbld', 18:49:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:49:02 INFO - 'LOGNAME': 'cltbld', 18:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:02 INFO - 'MOZ_NO_REMOTE': '1', 18:49:02 INFO - 'NO_EM_RESTART': '1', 18:49:02 INFO - 'PAGER': '/bin/cat', 18:49:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:02 INFO - 'PWD': '/builds/slave/test', 18:49:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:49:02 INFO - 'SHELL': '/bin/bash', 18:49:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FB6gCdi7aT/Listeners', 18:49:02 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 18:49:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:49:02 INFO - 'USER': 'cltbld', 18:49:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:49:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:02 INFO - 'XPC_FLAGS': '0x0', 18:49:02 INFO - 'XPC_SERVICE_NAME': '0', 18:49:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:03 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)) 18:49:03 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)) 18:49:03 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)) 18:49:03 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)) 18:49:03 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)) 18:49:03 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)) 18:49:03 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)) 18:49:03 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)) 18:49:03 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)) 18:49:03 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)) 18:49:03 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)) 18:49:03 INFO - Cleaning up... 18:49:03 INFO - Return code: 0 18:49:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc70a5aaf40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ccad30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cc1b20>, '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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 18:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:49:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bYU6vpWhpc/Render', 18:49:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:49:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:49:03 INFO - 'HOME': '/Users/cltbld', 18:49:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:49:03 INFO - 'LOGNAME': 'cltbld', 18:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:03 INFO - 'MOZ_NO_REMOTE': '1', 18:49:03 INFO - 'NO_EM_RESTART': '1', 18:49:03 INFO - 'PAGER': '/bin/cat', 18:49:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:03 INFO - 'PWD': '/builds/slave/test', 18:49:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:49:03 INFO - 'SHELL': '/bin/bash', 18:49:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FB6gCdi7aT/Listeners', 18:49:03 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 18:49:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:49:03 INFO - 'USER': 'cltbld', 18:49:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:49:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:03 INFO - 'XPC_FLAGS': '0x0', 18:49:03 INFO - 'XPC_SERVICE_NAME': '0', 18:49:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:03 INFO - Downloading/unpacking jsonschema 18:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:49:05 INFO - Downloading/unpacking functools32 (from jsonschema) 18:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:06 INFO - Downloading functools32-3.2.3-2.tar.gz 18:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:49:06 INFO - warning: no files found matching '*.txt' 18:49:06 INFO - no previously-included directories found matching 'build' 18:49:06 INFO - no previously-included directories found matching 'dist' 18:49:06 INFO - no previously-included directories found matching '.git*' 18:49:06 INFO - Installing collected packages: jsonschema, functools32 18:49:06 INFO - Running setup.py install for functools32 18:49:06 INFO - warning: no files found matching '*.txt' 18:49:06 INFO - no previously-included directories found matching 'build' 18:49:06 INFO - no previously-included directories found matching 'dist' 18:49:06 INFO - no previously-included directories found matching '.git*' 18:49:06 INFO - Successfully installed jsonschema functools32 18:49:06 INFO - Cleaning up... 18:49:06 INFO - Return code: 0 18:49:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:06 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 0x104e26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc70a5aaf40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ccad30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cc1b20>, '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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 18:49:06 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 18:49:06 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 18:49:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bYU6vpWhpc/Render', 18:49:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:49:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:49:06 INFO - 'HOME': '/Users/cltbld', 18:49:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:49:06 INFO - 'LOGNAME': 'cltbld', 18:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:06 INFO - 'MOZ_NO_REMOTE': '1', 18:49:06 INFO - 'NO_EM_RESTART': '1', 18:49:06 INFO - 'PAGER': '/bin/cat', 18:49:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:06 INFO - 'PWD': '/builds/slave/test', 18:49:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:49:06 INFO - 'SHELL': '/bin/bash', 18:49:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FB6gCdi7aT/Listeners', 18:49:06 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 18:49:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:49:06 INFO - 'USER': 'cltbld', 18:49:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:49:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:06 INFO - 'XPC_FLAGS': '0x0', 18:49:06 INFO - 'XPC_SERVICE_NAME': '0', 18:49:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:06 INFO - Downloading/unpacking flake8 18:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:49:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:49:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:49:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:49:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:49:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:49:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:49:10 INFO - no previously-included directories found matching 'docs/_build' 18:49:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:49:10 INFO - Running setup.py install for pep8 18:49:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:49:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:49:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:49:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:49:10 INFO - no previously-included directories found matching 'docs/_build' 18:49:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:49:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:49:10 INFO - Cleaning up... 18:49:10 INFO - Return code: 0 18:49:10 INFO - Running post-action listener: _resource_record_post_action 18:49:10 INFO - Running post-action listener: _start_resource_monitoring 18:49:10 INFO - Starting resource monitoring. 18:49:10 INFO - ##### 18:49:10 INFO - ##### Running install step. 18:49:10 INFO - ##### 18:49:10 INFO - Running pre-action listener: _resource_record_pre_action 18:49:10 INFO - Running main action method: install 18:49:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:49:11 INFO - Reading from file tmpfile_stdout 18:49:11 INFO - Detecting whether we're running mozinstall >=1.0... 18:49:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:49:11 INFO - Reading from file tmpfile_stdout 18:49:11 INFO - Output received: 18:49:11 INFO - Usage: mozinstall [options] installer 18:49:11 INFO - Options: 18:49:11 INFO - -h, --help show this help message and exit 18:49:11 INFO - -d DEST, --destination=DEST 18:49:11 INFO - Directory to install application into. [default: 18:49:11 INFO - "/builds/slave/test"] 18:49:11 INFO - --app=APP Application being installed. [default: firefox] 18:49:11 INFO - mkdir: /builds/slave/test/build/application 18:49:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 18:49:33 INFO - Reading from file tmpfile_stdout 18:49:33 INFO - Output received: 18:49:33 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 18:49:33 INFO - Running post-action listener: _resource_record_post_action 18:49:33 INFO - ##### 18:49:33 INFO - ##### Running run-tests step. 18:49:33 INFO - ##### 18:49:33 INFO - Running pre-action listener: _resource_record_pre_action 18:49:33 INFO - Running main action method: run_tests 18:49:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:49:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:49:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:49:34 INFO - 2016-05-12 18:49:34.011 screenresolution[1966:13671] starting screenresolution argv=screenresolution get 18:49:34 INFO - 2016-05-12 18:49:34.014 screenresolution[1966:13671] Display 0: 1600x1200x32@60 18:49:34 INFO - 2016-05-12 18:49:34.020 screenresolution[1967:13673] starting screenresolution argv=screenresolution list 18:49:34 INFO - Available Modes on Display 0 18:49:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:49:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:49:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:49:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:49:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:49:34 INFO - Intel Iris: 18:49:34 INFO - Chipset Model: Intel Iris 18:49:34 INFO - Type: GPU 18:49:34 INFO - Bus: Built-In 18:49:34 INFO - VRAM (Dynamic, Max): 1536 MB 18:49:34 INFO - Vendor: Intel (0x8086) 18:49:34 INFO - Device ID: 0x0a2e 18:49:34 INFO - Revision ID: 0x0009 18:49:34 INFO - Displays: 18:49:34 INFO - Display: 18:49:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:49:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:49:34 INFO - Display Serial Number: 1600x1200 60 18:49:34 INFO - Main Display: Yes 18:49:34 INFO - Mirror: Off 18:49:34 INFO - Online: Yes 18:49:34 INFO - Rotation: Supported 18:49:34 INFO - Return code: 0 18:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:49:34 INFO - Python 2.7.3 18:49:34 INFO - Return code: 0 18:49:34 INFO - grabbing minidump binary from tooltool 18:49:34 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')]} 18:49:34 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 0x104ccad30>, '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 0x104b2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104cc1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:49:34 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 18:49:34 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 18:49:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:49:34 INFO - Return code: 0 18:49:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:49:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:49:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:49:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:49:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:49:35 INFO - Return code: 0 18:49:35 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/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 18:49:35 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/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0167 --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 18:49:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bYU6vpWhpc/Render', 18:49:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:49:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:49:35 INFO - 'HOME': '/Users/cltbld', 18:49:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:49:35 INFO - 'LOGNAME': 'cltbld', 18:49:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:49:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:35 INFO - 'MOZ_NO_REMOTE': '1', 18:49:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:49:35 INFO - 'NO_EM_RESTART': '1', 18:49:35 INFO - 'PAGER': '/bin/cat', 18:49:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:35 INFO - 'PWD': '/builds/slave/test', 18:49:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:49:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:49:35 INFO - 'SHELL': '/bin/bash', 18:49:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FB6gCdi7aT/Listeners', 18:49:35 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 18:49:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:49:35 INFO - 'USER': 'cltbld', 18:49:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:49:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:35 INFO - 'XPC_FLAGS': '0x0', 18:49:35 INFO - 'XPC_SERVICE_NAME': '0', 18:49:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:49:35 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/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 18:49:35 INFO - mozversion application_buildid: 20160512164138 18:49:35 INFO - mozversion application_changeset: 55d9570b4520adff40c2362d2e027655f4271f7a 18:49:35 INFO - mozversion application_display_name: Firefox 18:49:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:49:35 INFO - mozversion application_name: Firefox 18:49:35 INFO - mozversion application_remotingname: firefox 18:49:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:49:35 INFO - mozversion application_vendor: Mozilla 18:49:35 INFO - mozversion application_version: 47.0 18:49:35 INFO - mozversion platform_buildid: 20160512164138 18:49:35 INFO - mozversion platform_changeset: 55d9570b4520adff40c2362d2e027655f4271f7a 18:49:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:49:35 INFO - mozversion platform_version: 47.0 18:49:35 INFO - using testdate: 1463104175 18:49:35 INFO - actual date: 1463104175 18:49:35 INFO - starting webserver on 'localhost:51356' 18:49:35 INFO - SUITE-START | Running 2 tests 18:49:35 INFO - TEST-START | dromaeo_css 18:49:35 INFO - operating with platform_type : mac_ 18:49:35 INFO - Initialising browser for dromaeo_css test... 18:49:35 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpAHYUNh/profile http://localhost:51356/getInfo.html) 18:49:38 INFO - PROCESS | 1985 | __metrics Screen width/height:1600/1200 18:49:38 INFO - PROCESS | 1985 | colorDepth:24 18:49:38 INFO - PROCESS | 1985 | Browser inner width/height: 1024/689 18:49:38 INFO - PROCESS | 1985 | __metrics 18:49:38 ERROR - PROCESS | 1985 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 18:49:38 INFO - TEST-INFO | 1985: exit 0 18:49:38 INFO - Browser initialized. 18:49:38 INFO - Running cycle 1/1 for dromaeo_css test... 18:49:38 INFO - TEST-INFO | started process 1989 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpAHYUNh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:50 INFO - PROCESS | 1989 | RSS: Main: 168308736 18:49:50 INFO - PROCESS | 1989 | 18:50:40 INFO - PROCESS | 1989 | 1463104240577 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] 18:52:51 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:51356/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51356/tests/dromaeo/cssquery-ext.html) 18:52:53 INFO - PROCESS | 1989 | RSS: Main: 178208768 18:52:53 INFO - PROCESS | 1989 | 18:55:54 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:51356/tests/dromaeo/cssquery-ext.html (next: http://localhost:51356/tests/dromaeo/cssquery-jquery.html) 18:55:55 INFO - PROCESS | 1989 | RSS: Main: 190615552 18:55:55 INFO - PROCESS | 1989 | 18:58:57 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:51356/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51356/tests/dromaeo/cssquery-mootools.html) 18:58:57 INFO - PROCESS | 1989 | RSS: Main: 191631360 18:58:57 INFO - PROCESS | 1989 | 19:01:59 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:51356/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51356/tests/dromaeo/cssquery-prototype.html) 19:01:59 INFO - PROCESS | 1989 | RSS: Main: 193482752 19:01:59 INFO - PROCESS | 1989 | 19:05:02 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:51356/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51356/tests/dromaeo/cssquery-yui.html) 19:05:03 INFO - PROCESS | 1989 | RSS: Main: 196255744 19:05:03 INFO - PROCESS | 1989 | 19:08:05 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:51356/tests/dromaeo/cssquery-yui.html (next: http://localhost:51356/tests/dromaeo/cssquery-dojo.html) 19:08:05 INFO - PROCESS | 1989 | RSS: Main: 197476352 19:08:05 INFO - PROCESS | 1989 | 19:08:05 INFO - PROCESS | 1989 | __start_tp_report 19:08:05 INFO - PROCESS | 1989 | _x_x_mozilla_page_load 19:08:05 INFO - PROCESS | 1989 | _x_x_mozilla_page_load_details 19:08:05 INFO - PROCESS | 1989 | |i|pagename|runs| 19:08:05 INFO - PROCESS | 1989 | |0;dojo.html;3676.540432445944;3692.3383481119863;3710.8144592770373;3750.2874453853774;3753.943690844638;5944.554158438113;6061.9696901515545;6063.939360606398;6064.241969753781;6068.211132552773;5955.583109182359;6006.729697163627;6039.154518367421;6055.4247346502125;6064.878702425949;5343.198520221959;5389.380221274545;5414.269073675043;5446.945530544684;5499.340079190482;5353.411124776271;5426.83719488414;5449.891002179954;5456.372517160537;5477.178423236526;5359.678419294835;5434.402215756264;5467.726613669321;5480.7533660985355;5506.779728810863;5448.700321482317;5468.070428027245;5477.534409575191;5478.096114141162;5479.863003424906;3842.385218365076;5276.498732620395;5383.81156659515;5405.486478784509;5509.669419834822;4984.3021976923255;5632.324121105453;5641.2384328116;5887.175795388649;5915.08316210988;5199.740012999335;5963.731632076567;6186.287877652752;6239.65681887496;6251.406116418979;5488.56091512682;6237.500999919996;6253.7185826637915;6313.87372252557;6317.810465686037;6095.603785753956;6131.601445906046;6135.509159267248;6138.324784273726;6146.66193359365;6533.673316334164;6609.966950165314;6621.569597976116;6648.135742353463;6693.464522838161;6120.355709576947;6199.070139479114;6245.812625621239;6252.406021428048;6292.937070629327;6386.616802991743;6399.520035997319;6401.711922963478;6409.0066039763915;6410.038494225811;6270.498360131179;6286.622802631765;6291.1192433059405;6309.779157729457;6311.936880631227;6134.803982731532;6212.378762123752;6227.750889964351;6228.314885362606;6292.276388215322;5019.42276638184;5033.0437216929395;5038.622103342264;5045;5061.089003979246;4086.7139300248696;4552.998340365114;4556;4558.1795276849825;4588.357629931812;5082.618803589746;6001.1898393717165;6031.939680603138;6114.144019837227;6135.202044401884;6332.778352757724;6344.302126766052;6352.650604216812;6364.395382438661;6372.490200783926;6153.353897840751;6179;6179.3820617937845;6184.5052395808225;6212.565120441525;5436.266104075899;5547.889042219133;5567.916481252784;5590.97204513983;5619.381867994517;6679.879688464848;6701.1623547056615;6725.226598940989;6738.831529211809;6771.119754431892;6224.719887604978;6363.490920726424;6415.1981002374705;6419.165508483868;6426.164598602152;6583.604983700993;6680.164979377578;6702.028205910213;6718.093057437183;6724.596524208563;6240.063990401294;6254.499640028877;6255.030470277115;6278.246610406781;6289.276733175743;6194.783182588588;6222.657753823583;6290.182276304235;6299.811005669837;6311.779087732091;4746.881327966828;6271.404216599598;6301.905471417841;6305.621662700252;6307.24313082433;6279.434850863444;6300.21247344082;6302.590331628429;6311.684415779101;6313.715882785194;6056.454919057306;6119.715820550834;6184.165137706352;6192.195014648067;6244.72067695297;6255;6263.185785847811;6273.3099359071375;6275.529335299962;6280.371962803683;6173.104899789416;6174.135621012972;6180.042093475518;6195;6203.348648392034 19:08:05 INFO - PROCESS | 1989 | |1;ext.html;576.0984059946184;594.9791757288493;619.9845003874906;677.6548551126014;683.6581709145426;38928.02679932999;39501.209975800535;39562;39635.00912477186;39666.603333966654;42669.573304266945;42749;42755.931101722475;42820.35769463461;42987.57012429875;9735.56189971453;9985.800283994316;10038.849417258747;10058.994100589918;10090.495475226246;9916.801663966717;10059.5473203706;10060.446675432848;10061.949690251575;10078.848817267746;8846.20384165425;9985.20118390527;10025.59897604095;10076.345037572535;10139.036791504795;8849.823003539925;9812.411255324667;10001.34991225568;10030.297879148462;10098.798024039477;9930.90069099307;10059.748506287327;10063.396196228177;10066.69799906004;10131.544080516394;35989.82005089984;40054.59945400567;40196;40267.39598906019;40390.192196156204;3206.839658017113;3450.5686789151355;3521.894343169709;3937.6652984496354;3999.960000399988;27649.170524884084;27792.583111253145;27862.5820612691;28386.716132838614;28597.28506787326;2744.972550274512;2795.8182718123257;2822.5625028120676;2839.957400638992;2915.518939375022;340861;342946;343169;343669;344494;39405.40891886624;48353.27470087951;68599;68980.6550967242;69177.30822691708;45491.77254113775;45820.54179458229;45906.770466147456;45952.08095838065;46155.76922115368;16777.412790552273;16866.156692165343;17112.48662540126;17261.39585114515;17314.393996210074;13794;13803.447862085404;13838.584842454742;13869.722605548035;13919.582412527641;14884.479043233436;15142.394304227928;15201.6199595011;15275.312610932535;15658.608534786721;6497.675116244169;6606.702698378488;6647.933520664828;6648.800535983832;6651.33486651331;968.912797848183;994;1034.9482525873675;1049.2602715085845;1207.372166473429;30692.53961190584;30821.38357232843;30899;31014.844925775225;31137.532937005963;1108.9944550277196;1128.2046157458972;1158.8783177766381;1256.2085885892013;1298.5455090718174;14697.632559186106;14816.777748333783;15239.161846098572;15340;15379.846201538065;443650.5634943674;445387;449770;450490;451667;58033.419665803645;59689.70155149196;59809;59869.70065149733;59978.100328494234;1512.5613572064199;1555.4244929376202;1559.656875487391;1562.9609259768597;1575.1415478563981;30366.39267214599;30465.086047418612;30654.080377588707;30949.226269342547;31198.37603247968;54182;54205.45794542004;54249.643758904764;54306.91386172333;54434;409107;409975;411203.94398027816;413175.93412032747;413469;34268.65731342655;34747.826260869544;34974.82512587523;35566.466503002994;36007;47188.29217561808;47192.764036180975;48432.75783621059;48621.756891215315;49160.2625960618;33454.83272583621;39133.804330978164;39644.801775990934;39780.403293951196;39908.600913990485;38431.423528646534;38448.27586206919;38475.42286865643;38786;39349;33412.66587334096;38583.614163858;38607;39156.216875662896;39807.601923980386;27150.864245678644;30322.393552128393;32006.67993320037;32256.35487290288;32473.837630811693;21885.890570547046;24599.508009839345;25512.55333928793;25744.098956536433;26224 19:08:05 INFO - PROCESS | 1989 | |2;jquery.html;378.31902575364353;379.5104315433092;388.65603940512636;390.9687225021998;391.5418959817014;17018.40435584755;19516.63383563151;20696.793032069676;22125.557488850234;22248.443788905304;20920.68618970713;20995.685064724043;21217.469563260925;21434.356969290908;21466.570668586657;5843.912341314884;5863.618864773797;6131.846703832395;6161.322254552018;6166.537509686769;4231.724937879043;6011.849703757419;6016.969915150418;6242.406971337716;6318.71565779541;6184.783532576361;6257.342978987186;6287.18266625338;6290.559660823744;6297.08692239625;6420.518461115412;6742.730290788338;6749.797506074826;6827.590344579341;6844.828879278008;5813.389594092644;5967.283925928873;6032.9698351508405;6047.69761511927;6048.516118710492;14166.079204851652;14300;14342.354594043292;14425.134491930517;15565.533034008999;2120.4380839077658;2290.1068583252545;2455.300239431753;2853.6860945296003;2859.6711378191567;9518.95240523793;9633.855492167622;10138.239632027553;10419.583216671324;10543.894561054445;1777.3246166456793;1800.9459716208535;1831.3681779785952;1881.17228419495;1882.7552418185549;105848.47075764649;106662;109475;109904.4504777479;110382;10165.44090075053;11271.59105111861;11325.207235493437;11508.654740357802;11639.59261425846;12919.547815826401;13812.516561920285;14285.642858928402;14536.709265814625;14550.563483095524;6789.422899053636;6920.723171073201;8631;9053.683121090862;9100.362974591715;7947.4039447041705;9246.19699158671;9259.212966897754;9301.348905576544;9339;4077.612626800449;4431.313146462304;4535.092981403733;4546.704464209882;4721.622270218374;1820.8270214329618;1900.8859468431663;1933.2750218668;1978.6834106542883;1995.1121750820746;795.5067857928121;945.8533927241289;963.1283688262134;1020.6784862768204;1029.912457441126;20586.485337866372;21172.941352932292;21227.134714485026;21497.892510537346;21553.892230538746;988.6440881282876;1007.8840933292619;1011.0849681038671;1032.0814475117152;1070.6680928912062;11282.379469129113;11291.209615327012;11996.920277175097;12009.979151772197;12113.939430302968;686162;696148;704889;714952;721358;116567.41716291364;125954.37022814827;127291;127649.36175319063;128840;1109.0905457524752;1122.831575263717;1124.0838716446233;1131.4851742457163;1132.8810474900017;16297.837021629632;19064.23743050318;19634.705479418106;19654.90172549128;19830.305939292633;40056.599434005286;52279.73860130675;54714.452855472526;55002;55043.899122018134;68462.65768671125;68791.31208687849;69349.65325173341;69395.65302173457;71628.28371716425;7580.734674286374;7941;7995.9200407997505;8051.919480805352;8253.422260441712;7222.89165662526;9482.668106616235;10581.418022008864;13870.306484675524;14145.151290922578;11752.76494470123;11781.76436471283;12059.397030148633;12060.216085954386;12079.818802717791;9844.950775246078;11702.414879256174;11764.411779411166;11935.403229838646;12042.096842736655;12037.819432708691;12104.636860894187;12109.515619375126;12231.449584768885;12297.262164270172;8376;8554.657813687383;8564.914350856412;8588.355873309652;8738.519381434082;10915.56337746513;12047.879521204675;12126.696832578904;12222.938885305872;12318.692032698897 19:08:05 INFO - PROCESS | 1989 | |3;mootools.html;1631.583946093746;1639.2623319506222;1979.4655443030383;2066.493709041286;2109.662454007359;8041.9597902010555;8411.074781774;8710.695125670594;9429.434233945967;9433.905660943388;7731.690732370698;9133.406328588637;9230.953845230764;9267.768305792359;9304.441733495994;2586.301698541388;2593.753593408623;2627.842329460229;2629.1849526646706;2632.63103186343;2250.504888924434;2608.2827222513865;2637.116565950409;2640.3531134871982;2647.5896236083436;2206.6028114939304;2607.34816295926;2610.9086181983635;2611.9738802612014;2613.7647611714942;2529.0389651932146;2542.9872850635816;2557.2839604910655;2558.6162075688794;2566.550853600622;2221.8222542196745;2646.695630002536;2676.625272461857;2681.8793154308105;2682.248970288322;9142.268618510503;9220.631174753002;9269.675561355387;9273.07269273074;9300.976892541816;5803.129530570406;5923.170756094107;5989.251343582052;5992.700364981777;5993.490553302974;3698.33429982603;3755.6995440364703;3806.2197249563774;3837.5586807516934;3914.706397020235;1055.2454994678765;1079.7192729890207;1083.6369816111612;1114.0586204657052;1134.3817619397366;12313.815292770527;12336.136470447072;12431.191972521758;12436.875631243662;12476.50093996239;5208.869778255498;5253.474652534793;5302.522772950453;5304.840854774363;5314.12316967696;10728.946355268174;10740;10820.97200765926;10835.295705779257;10888.237823352289;5284.867878303073;5705.172749951317;5806.390329015477;5810.593258471867;5973.462388385066;4735.597474214662;5104.744762761847;5268.762905669254;5290.259363689087;5320;4187.099773548702;4195.517515485697;4215.114825886537;4221.303484925014;4235.237657221668;1264.791309433933;1300.6293206436121;1360.0479664235074;1375.3054707372712;1390.4646711016333;1372.773492373767;1423.523119754873;1423.992880035593;1438.5252866554013;1444.7832825076323;8420.326373890073;8624.223819856243;8664.133586641285;8665.480071195749;8697.130286971378;1285.1582213650074;1294.2428679222571;1298.8636193199577;1300.8894243989178;1305.9608211753473;6494.480441564663;6545.541812073109;6558.376954189344;6593.80218593443;6597.538172327891;10870.021698047214;10921.290116142425;11114.22200445961;11193.49629266685;11249.550017999352;10866.239363244655;10868.67393978182;11056.944715276533;11125.27685700443;11335.319880807177;8627.309815214769;8642;8767.035626081126;8831.24934380572;8854.158854908774;6938.410235130071;7973.960130199312;8139.064007639197;8240.670373185005;8289.253967142986;9726.076022777825;9893.65372211969;9972.650957216463;10079.899201007896;10123.949380253052;10072.345297555636;10257.33327333721;10304.227182961158;10340.948295258475;10366.844497332395;6681.365270299314;7149.82125446868;7167.713291468492;7301.890471642823;7428.33145016951;8396.412251142361;8594.05465398793;8604.526751028754;8643.438176518506;8663.653453861774;7500.324970752658;7597.240275972358;7652.502587332028;7669.041369828771;7747.9927609410415;7427.44294177928;7444.404447644067;7491.325780679765;7491.43814213947;7514.473986821089;8119.4722343047515;8149.877751833846;8212.671493140208;8213.466124701876;8224.218699223564;7264.927350726636;7326.670299836626;7399.445041622008;7415.998840156725;7429.294217049372;7448.5158464699625;7466.178720340649;7502.924970750441;7522.473426860286;7533.773986780406 19:08:05 INFO - PROCESS | 1989 | |4;prototype.html;343.471054575953;346.57890662844636;350.5460428744775;354.63649758997025;358.77576514678327;6999.930000699991;7018.824529386768;7023.122109736283;7043.47173961953;7050.647467626617;5530.889382212354;5628.874225154975;6951.687174077166;6995.125609298838;7007.983842342857;4195.077083041726;4864.781084851173;4982.975085124587;5088.26220198071;5101.285819985205;5070.138076527;5097.260897169908;5103.770330335144;5106.97860427914;5110.66780659256;5029.497050294978;5032.11937910866;5045.394552653686;5045.722485263327;5050.924236136461;5045.4197767256865;5060.51925067118;5067.467915868818;5078.390593128811;5079.212722028092;4394.626456751148;4398;4400.383946247528;4405.493368262659;4407.977960110179;6516.641584712839;6694.062831203635;6773.45812335012;6779.254282028973;6800.557963732342;6040.305364883006;6058.212432383762;6070.301915279755;6088.573799834014;6093.268807743099;5301.1783173608155;6244;6417.454516366114;7438.888416673754;7442.590657513834;4932.235503496928;4936.4076310842565;4940.851774446773;4949.307097006422;4968.1554135797005;7894.486858354188;7912.208779122099;7925.643346049384;7932.762017139437;7939.682412703485;4860.541837448751;5019;5035.144025515671;5041.294218809369;5062.493750624908;5097.617678674114;5138.58891288696;5138.820141295037;5143.048536020848;5159;6007.789727359609;6011.819645410645;6017.789377371859;6029.60807547508;6030;7333.376662983706;7406.814829629195;7417.443691723142;7445.553266804009;7455.0681164854395;1785.419738584965;1823.7082066869236;1825.434115424196;1827.643609496162;1829.1860122245473;1074.4520294649628;1104;1115.9330440173453;1184.6682928779956;1187.9168458208014;7036.788896333118;7072;7074.68163932614;7089.574625522382;7094.184168820549;6236;6353.919833628294;7523.247675232543;7680.231976802275;7831.921680783234;6960.477964152708;7119.359257666835;7188.82027949295;7212.170600381023;7248.637568121573;4102.897427564335;4143.585641435892;4148.211839750437;4153.252414565347;4156.355764856452;6994.8950765738555;7794.025746781653;8212.17878212174;8215.383846211438;8236.876446853303;7836;8104;8112.3104536113915;8128.59357032146;8135.7152499662225;8227.053888802744;8263.876041859377;8270.090290068089;8281.420300579022;8300.418970672115;7835.960820195863;7858.410619203468;7863.449558530848;7869.095054068626;7895.052593688794;7654.923450765421;7677.121079595152;7689.884651730116;7690.423218258541;7714.382849372149;7936.365090792839;8176.509409435453;8274.462159959583;8288.129746376784;8288.875666864882;5112.182050871843;5136.9743151284;5138.254953031864;5143.074246635641;5151.974240128776;7778.49439786412;7802.258785415376;7805.609719513888;7808.336291415066;7818.022747156606;6939.8833355826955;7524.962375188089;7542.132654744555;7548.207438218908;7559.546427214164;7484.139323977813;7517.586532740752;7533.1336896257635;7542.47202695806;7567.356774673995;6975;7371.447141464304;7381.298776616213;7387.482876198829;7394.889076663747;7539.132999705104;7558.093028836574;7558.508696934901;7602.7455469849065;7636.160022397643;7153.141623005273;7331.890021649573;7378.409727221917;7384.52000619958;7394.186639469762 19:08:05 INFO - PROCESS | 1989 | |5;yui.html;695.7919969031797;700.2087640965705;730.8940203670468;752.2552672853873;757.1784613694142;15467.613309667264;15601.843981560181;15640.061596304215;15660.451884184056;15874.682506349895;11418.429078546082;14739.55781326562;14755.631109222275;14755.852441475581;14767;694.7637803146941;805.0741647105816;979.686500319898;990.0297708245887;996.4619105682923;959.1271942532262;963.4604621412032;990.2325697584357;996.9800603987916;999.7400675824265;1010.9545070471846;1053.9262251642388;1061.1722856172198;1062.1555863088863;1063.1813503602223;1035.4977835749655;1048.0201012053717;1051.9842202366933;1055.0082922053323;1057.1912486947492;774.0672489649959;788.9368850491946;795.0737390939548;798.8522123407188;800.9867517590253;15159.848401515954;15369.923150384288;15525.378984840592;15846.603834904105;15921.681566368723;13341.66645833862;13411.597652070453;13426.0601757877;13442.193468391928;13448.663783405394;10298.691039268833;10316.845247321296;10419.95800419952;10451.16390688743;10480;3666.358387282215;3679.0802299425145;3694.741368104234;3703.8333275002688;3722.627737226283;77299.22700772976;77399.22600773977;77763.22236777616;81800.59099704464;81908.77136842952;9932.900670993198;9966.40201587907;9973.750656233653;10054.69835904924;10063.094321510953;21541.892290538446;21755.564888702454;21782.89108554447;21783.564328713335;21808.47340686137;7755.573443460664;7762.8059298516855;7783.377329813601;7841.529508229524;7958.204179581995;4141.97929010353;4165.625093741578;4170.186813571385;4191.832326706958;4197.538270790211;3806.200697853482;3828.2152158807376;3838.2323535293053;3842.6733727632904;3847.3651847444858;666.3436515032689;671.6742379945722;684.7740245718901;685.4927353758183;688.6212583079387;620.6803496199461;632.2160520953984;635.3138610300864;635.3773302163905;657.4346062386344;7460.440466964999;8372.585551520682;8524.95737521321;8612.956935215283;8963.820723585492;520.8723862653674;614.2720875762236;627.689293799563;635.8887194740994;650.3074225949349;3820.9426858597144;3936.881893543198;4005.619466150711;4076.612721791425;4176.227397931392;94791.52604237072;97108.05783884283;98394.01605983992;99578;100161;77285.2271477278;77544;82385.9403514905;84498.5775071133;85244.57377713195;72893.90659140117;73187.26812731911;73512;73564;74489.88265176027;7914.564698941614;8227.382946279173;8236.34109271245;8335.791605209919;8413.411061225655;50713.985720286124;51028;52291;53576;53702;66125.66937165284;68840.31159688339;70002.64998674973;70968.29031709823;72345;10030.448325342177;10186.286959912735;10306.48467576633;10322.948385258025;10356.896431035895;11037;11044.723881902695;11234.101271898066;11307.378094204898;11931.403429828648;10472.371657700562;10628.36229826213;10825.512851921525;10902.345859248153;11224.831627525757;10068.194544436574;10407.06336429725;10679.252452328263;10708.518116684612;11151.330920144817;10259.692209233735;10329.841209716893;10443;10523.894761052292;11003.119750419786;8982.730518084469;9158.633654653739;9170.541472926461;9259.120383563552;9272.072792720674;8779.078196789245;9007.414518056305;9108.407953483002;9128.543572821465;9228.261739060725 19:08:05 INFO - PROCESS | 1989 | __end_tp_report 19:08:05 INFO - PROCESS | 1989 | __start_cc_report 19:08:05 INFO - PROCESS | 1989 | _x_x_mozilla_cycle_collect,357 19:08:05 INFO - PROCESS | 1989 | __end_cc_report 19:08:05 INFO - PROCESS | 1989 | __startTimestamp1463105285371__endTimestamp 19:08:05 INFO - PROCESS | 1989 | 19:08:05 INFO - PROCESS | 1989 | ------- Summary: start ------- 19:08:05 INFO - PROCESS | 1989 | Number of tests: 6 19:08:05 INFO - PROCESS | 1989 | 19:08:05 INFO - PROCESS | 1989 | [#0] dojo.html Cycles:165 Average:5906.05 Median:6179.38 stddev:663.41 (10.7%) stddev-sans-first:641.98 19:08:05 INFO - PROCESS | 1989 | Values: 3676.5 3692.3 3710.8 3750.3 3753.9 5944.6 6062.0 6063.9 6064.2 6068.2 5955.6 6006.7 6039.2 6055.4 6064.9 5343.2 5389.4 5414.3 5446.9 5499.3 5353.4 5426.8 5449.9 5456.4 5477.2 5359.7 5434.4 5467.7 5480.8 5506.8 5448.7 5468.1 5477.5 5478.1 5479.9 3842.4 5276.5 5383.8 5405.5 5509.7 4984.3 5632.3 5641.2 5887.2 5915.1 5199.7 5963.7 6186.3 6239.7 6251.4 5488.6 6237.5 6253.7 6313.9 6317.8 6095.6 6131.6 6135.5 6138.3 6146.7 6533.7 6610.0 6621.6 6648.1 6693.5 6120.4 6199.1 6245.8 6252.4 6292.9 6386.6 6399.5 6401.7 6409.0 6410.0 6270.5 6286.6 6291.1 6309.8 6311.9 6134.8 6212.4 6227.8 6228.3 6292.3 5019.4 5033.0 5038.6 5045.0 5061.1 4086.7 4553.0 4556.0 4558.2 4588.4 5082.6 6001.2 6031.9 6114.1 6135.2 6332.8 6344.3 6352.7 6364.4 6372.5 6153.4 6179.0 6179.4 6184.5 6212.6 5436.3 5547.9 5567.9 5591.0 5619.4 6679.9 6701.2 6725.2 6738.8 6771.1 6224.7 6363.5 6415.2 6419.2 6426.2 6583.6 6680.2 6702.0 6718.1 6724.6 6240.1 6254.5 6255.0 6278.2 6289.3 6194.8 6222.7 6290.2 6299.8 6311.8 4746.9 6271.4 6301.9 6305.6 6307.2 6279.4 6300.2 6302.6 6311.7 6313.7 6056.5 6119.7 6184.2 6192.2 6244.7 6255.0 6263.2 6273.3 6275.5 6280.4 6173.1 6174.1 6180.0 6195.0 6203.3 19:08:05 INFO - PROCESS | 1989 | 19:08:05 INFO - PROCESS | 1989 | [#1] ext.html Cycles:180 Average:55963.45 Median:34861.33 stddev:106485.52 (305.5%) stddev-sans-first:106703.04 19:08:05 INFO - PROCESS | 1989 | Values: 576.1 595.0 620.0 677.7 683.7 38928.0 39501.2 39562.0 39635.0 39666.6 42669.6 42749.0 42755.9 42820.4 42987.6 9735.6 9985.8 10038.8 10059.0 10090.5 9916.8 10059.5 10060.4 10061.9 10078.8 8846.2 9985.2 10025.6 10076.3 10139.0 8849.8 9812.4 10001.3 10030.3 10098.8 9930.9 10059.7 10063.4 10066.7 10131.5 35989.8 40054.6 40196.0 40267.4 40390.2 3206.8 3450.6 3521.9 3937.7 4000.0 27649.2 27792.6 27862.6 28386.7 28597.3 2745.0 2795.8 2822.6 2840.0 2915.5 340861.0 342946.0 343169.0 343669.0 344494.0 39405.4 48353.3 68599.0 68980.7 69177.3 45491.8 45820.5 45906.8 45952.1 46155.8 16777.4 16866.2 17112.5 17261.4 17314.4 13794.0 13803.4 13838.6 13869.7 13919.6 14884.5 15142.4 15201.6 15275.3 15658.6 6497.7 6606.7 6647.9 6648.8 6651.3 968.9 994.0 1034.9 1049.3 1207.4 30692.5 30821.4 30899.0 31014.8 31137.5 1109.0 1128.2 1158.9 1256.2 1298.5 14697.6 14816.8 15239.2 15340.0 15379.8 443650.6 445387.0 449770.0 450490.0 451667.0 58033.4 59689.7 59809.0 59869.7 59978.1 1512.6 1555.4 1559.7 1563.0 1575.1 30366.4 30465.1 30654.1 30949.2 31198.4 54182.0 54205.5 54249.6 54306.9 54434.0 409107.0 409975.0 411203.9 413175.9 413469.0 34268.7 34747.8 34974.8 35566.5 36007.0 47188.3 47192.8 48432.8 48621.8 49160.3 33454.8 39133.8 39644.8 39780.4 39908.6 38431.4 38448.3 38475.4 38786.0 39349.0 33412.7 38583.6 38607.0 39156.2 39807.6 27150.9 30322.4 32006.7 32256.4 32473.8 21885.9 24599.5 25512.6 25744.1 26224.0 19:08:05 INFO - PROCESS | 1989 | 19:08:05 INFO - PROCESS | 1989 | [#2] jquery.html Cycles:180 Average:37214.52 Median:21330.75 stddev:116459.74 (546.0%) stddev-sans-first:116753.60 19:08:05 INFO - PROCESS | 1989 | Values: 378.3 379.5 388.7 391.0 391.5 17018.4 19516.6 20696.8 22125.6 22248.4 20920.7 20995.7 21217.5 21434.4 21466.6 5843.9 5863.6 6131.8 6161.3 6166.5 4231.7 6011.8 6017.0 6242.4 6318.7 6184.8 6257.3 6287.2 6290.6 6297.1 6420.5 6742.7 6749.8 6827.6 6844.8 5813.4 5967.3 6033.0 6047.7 6048.5 14166.1 14300.0 14342.4 14425.1 15565.5 2120.4 2290.1 2455.3 2853.7 2859.7 9519.0 9633.9 10138.2 10419.6 10543.9 1777.3 1800.9 1831.4 1881.2 1882.8 105848.5 106662.0 109475.0 109904.5 110382.0 10165.4 11271.6 11325.2 11508.7 11639.6 12919.5 13812.5 14285.6 14536.7 14550.6 6789.4 6920.7 8631.0 9053.7 9100.4 7947.4 9246.2 9259.2 9301.3 9339.0 4077.6 4431.3 4535.1 4546.7 4721.6 1820.8 1900.9 1933.3 1978.7 1995.1 795.5 945.9 963.1 1020.7 1029.9 20586.5 21172.9 21227.1 21497.9 21553.9 988.6 1007.9 1011.1 1032.1 1070.7 11282.4 11291.2 11996.9 12010.0 12113.9 686162.0 696148.0 704889.0 714952.0 721358.0 116567.4 125954.4 127291.0 127649.4 128840.0 1109.1 1122.8 1124.1 1131.5 1132.9 16297.8 19064.2 19634.7 19654.9 19830.3 40056.6 52279.7 54714.5 55002.0 55043.9 68462.7 68791.3 69349.7 69395.7 71628.3 7580.7 7941.0 7995.9 8051.9 8253.4 7222.9 9482.7 10581.4 13870.3 14145.2 11752.8 11781.8 12059.4 12060.2 12079.8 9845.0 11702.4 11764.4 11935.4 12042.1 12037.8 12104.6 12109.5 12231.4 12297.3 8376.0 8554.7 8564.9 8588.4 8738.5 10915.6 12047.9 12126.7 12222.9 12318.7 19:08:05 INFO - PROCESS | 1989 | 19:08:05 INFO - PROCESS | 1989 | [#3] mootools.html Cycles:180 Average:6338.91 Median:5261.12 stddev:3290.00 (62.5%) stddev-sans-first:3280.20 19:08:05 INFO - PROCESS | 1989 | Values: 1631.6 1639.3 1979.5 2066.5 2109.7 8042.0 8411.1 8710.7 9429.4 9433.9 7731.7 9133.4 9231.0 9267.8 9304.4 2586.3 2593.8 2627.8 2629.2 2632.6 2250.5 2608.3 2637.1 2640.4 2647.6 2206.6 2607.3 2610.9 2612.0 2613.8 2529.0 2543.0 2557.3 2558.6 2566.6 2221.8 2646.7 2676.6 2681.9 2682.2 9142.3 9220.6 9269.7 9273.1 9301.0 5803.1 5923.2 5989.3 5992.7 5993.5 3698.3 3755.7 3806.2 3837.6 3914.7 1055.2 1079.7 1083.6 1114.1 1134.4 12313.8 12336.1 12431.2 12436.9 12476.5 5208.9 5253.5 5302.5 5304.8 5314.1 10728.9 10740.0 10821.0 10835.3 10888.2 5284.9 5705.2 5806.4 5810.6 5973.5 4735.6 5104.7 5268.8 5290.3 5320.0 4187.1 4195.5 4215.1 4221.3 4235.2 1264.8 1300.6 1360.0 1375.3 1390.5 1372.8 1423.5 1424.0 1438.5 1444.8 8420.3 8624.2 8664.1 8665.5 8697.1 1285.2 1294.2 1298.9 1300.9 1306.0 6494.5 6545.5 6558.4 6593.8 6597.5 10870.0 10921.3 11114.2 11193.5 11249.6 10866.2 10868.7 11056.9 11125.3 11335.3 8627.3 8642.0 8767.0 8831.2 8854.2 6938.4 7974.0 8139.1 8240.7 8289.3 9726.1 9893.7 9972.7 10079.9 10123.9 10072.3 10257.3 10304.2 10340.9 10366.8 6681.4 7149.8 7167.7 7301.9 7428.3 8396.4 8594.1 8604.5 8643.4 8663.7 7500.3 7597.2 7652.5 7669.0 7748.0 7427.4 7444.4 7491.3 7491.4 7514.5 8119.5 8149.9 8212.7 8213.5 8224.2 7264.9 7326.7 7399.4 7416.0 7429.3 7448.5 7466.2 7502.9 7522.5 7533.8 19:08:05 INFO - PROCESS | 1989 | 19:08:05 INFO - PROCESS | 1989 | [#4] prototype.html Cycles:180 Average:6126.22 Median:6984.95 stddev:1958.44 (28.0%) stddev-sans-first:1915.23 19:08:05 INFO - PROCESS | 1989 | Values: 343.5 346.6 350.5 354.6 358.8 6999.9 7018.8 7023.1 7043.5 7050.6 5530.9 5628.9 6951.7 6995.1 7008.0 4195.1 4864.8 4983.0 5088.3 5101.3 5070.1 5097.3 5103.8 5107.0 5110.7 5029.5 5032.1 5045.4 5045.7 5050.9 5045.4 5060.5 5067.5 5078.4 5079.2 4394.6 4398.0 4400.4 4405.5 4408.0 6516.6 6694.1 6773.5 6779.3 6800.6 6040.3 6058.2 6070.3 6088.6 6093.3 5301.2 6244.0 6417.5 7438.9 7442.6 4932.2 4936.4 4940.9 4949.3 4968.2 7894.5 7912.2 7925.6 7932.8 7939.7 4860.5 5019.0 5035.1 5041.3 5062.5 5097.6 5138.6 5138.8 5143.0 5159.0 6007.8 6011.8 6017.8 6029.6 6030.0 7333.4 7406.8 7417.4 7445.6 7455.1 1785.4 1823.7 1825.4 1827.6 1829.2 1074.5 1104.0 1115.9 1184.7 1187.9 7036.8 7072.0 7074.7 7089.6 7094.2 6236.0 6353.9 7523.2 7680.2 7831.9 6960.5 7119.4 7188.8 7212.2 7248.6 4102.9 4143.6 4148.2 4153.3 4156.4 6994.9 7794.0 8212.2 8215.4 8236.9 7836.0 8104.0 8112.3 8128.6 8135.7 8227.1 8263.9 8270.1 8281.4 8300.4 7836.0 7858.4 7863.4 7869.1 7895.1 7654.9 7677.1 7689.9 7690.4 7714.4 7936.4 8176.5 8274.5 8288.1 8288.9 5112.2 5137.0 5138.3 5143.1 5152.0 7778.5 7802.3 7805.6 7808.3 7818.0 6939.9 7525.0 7542.1 7548.2 7559.5 7484.1 7517.6 7533.1 7542.5 7567.4 6975.0 7371.4 7381.3 7387.5 7394.9 7539.1 7558.1 7558.5 7602.7 7636.2 7153.1 7331.9 7378.4 7384.5 7394.2 19:08:05 INFO - PROCESS | 1989 | 19:08:05 INFO - PROCESS | 1989 | [#5] yui.html Cycles:180 Average:18726.99 Median:26405.94 stddev:26664.19 (101.0%) stddev-sans-first:26704.62 19:08:05 INFO - PROCESS | 1989 | Values: 695.8 700.2 730.9 752.3 757.2 15467.6 15601.8 15640.1 15660.5 15874.7 11418.4 14739.6 14755.6 14755.9 14767.0 694.8 805.1 979.7 990.0 996.5 959.1 963.5 990.2 997.0 999.7 1011.0 1053.9 1061.2 1062.2 1063.2 1035.5 1048.0 1052.0 1055.0 1057.2 774.1 788.9 795.1 798.9 801.0 15159.8 15369.9 15525.4 15846.6 15921.7 13341.7 13411.6 13426.1 13442.2 13448.7 10298.7 10316.8 10420.0 10451.2 10480.0 3666.4 3679.1 3694.7 3703.8 3722.6 77299.2 77399.2 77763.2 81800.6 81908.8 9932.9 9966.4 9973.8 10054.7 10063.1 21541.9 21755.6 21782.9 21783.6 21808.5 7755.6 7762.8 7783.4 7841.5 7958.2 4142.0 4165.6 4170.2 4191.8 4197.5 3806.2 3828.2 3838.2 3842.7 3847.4 666.3 671.7 684.8 685.5 688.6 620.7 632.2 635.3 635.4 657.4 7460.4 8372.6 8525.0 8613.0 8963.8 520.9 614.3 627.7 635.9 650.3 3820.9 3936.9 4005.6 4076.6 4176.2 94791.5 97108.1 98394.0 99578.0 100161.0 77285.2 77544.0 82385.9 84498.6 85244.6 72893.9 73187.3 73512.0 73564.0 74489.9 7914.6 8227.4 8236.3 8335.8 8413.4 50714.0 51028.0 52291.0 53576.0 53702.0 66125.7 68840.3 70002.6 70968.3 72345.0 10030.4 10186.3 10306.5 10322.9 10356.9 11037.0 11044.7 11234.1 11307.4 11931.4 10472.4 10628.4 10825.5 10902.3 11224.8 10068.2 10407.1 10679.3 10708.5 11151.3 10259.7 10329.8 10443.0 10523.9 11003.1 8982.7 9158.6 9170.5 9259.1 9272.1 8779.1 9007.4 9108.4 9128.5 9228.3 19:08:05 INFO - PROCESS | 1989 | -------- Summary: end -------- 19:08:05 INFO - PROCESS | 1989 | 19:08:05 INFO - TEST-INFO | 1989: exit 0 19:08:05 INFO - TEST-OK | dromaeo_css | took 1110058ms 19:08:05 INFO - TEST-START | kraken 19:08:05 INFO - operating with platform_type : mac_ 19:08:05 INFO - Initialising browser for kraken test... 19:08:05 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpFjSmp7/profile http://localhost:51356/getInfo.html) 19:08:08 INFO - PROCESS | 1994 | __metrics Screen width/height:1600/1200 19:08:08 INFO - PROCESS | 1994 | colorDepth:24 19:08:08 INFO - PROCESS | 1994 | Browser inner width/height: 1024/689 19:08:08 INFO - PROCESS | 1994 | __metrics 19:08:08 ERROR - PROCESS | 1994 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 19:08:09 INFO - TEST-INFO | 1994: exit 0 19:08:09 INFO - Browser initialized. 19:08:09 INFO - Running cycle 1/1 for kraken test... 19:08:09 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpFjSmp7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:20 INFO - PROCESS | 1998 | RSS: Main: 167940096 19:08:20 INFO - PROCESS | 1998 | 19:08:23 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51356/tests/kraken/driver.html?testName=audio-beat-detection) 19:08:24 INFO - PROCESS | 1998 | RSS: Main: 179601408 19:08:24 INFO - PROCESS | 1998 | 19:08:26 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51356/tests/kraken/driver.html?testName=audio-dft) 19:08:27 INFO - PROCESS | 1998 | RSS: Main: 188575744 19:08:27 INFO - PROCESS | 1998 | 19:08:31 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51356/tests/kraken/driver.html?testName=audio-fft) 19:08:31 INFO - PROCESS | 1998 | RSS: Main: 191623168 19:08:31 INFO - PROCESS | 1998 | 19:08:33 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51356/tests/kraken/driver.html?testName=audio-oscillator) 19:08:34 INFO - PROCESS | 1998 | RSS: Main: 193110016 19:08:34 INFO - PROCESS | 1998 | 19:08:36 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51356/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:08:36 INFO - PROCESS | 1998 | RSS: Main: 193863680 19:08:36 INFO - PROCESS | 1998 | 19:08:39 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51356/tests/kraken/driver.html?testName=imaging-darkroom) 19:08:40 INFO - PROCESS | 1998 | RSS: Main: 194707456 19:08:40 INFO - PROCESS | 1998 | 19:08:43 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51356/tests/kraken/driver.html?testName=imaging-desaturate) 19:08:43 INFO - PROCESS | 1998 | RSS: Main: 194371584 19:08:43 INFO - PROCESS | 1998 | 19:08:46 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51356/tests/kraken/driver.html?testName=json-parse-financial) 19:08:47 INFO - PROCESS | 1998 | RSS: Main: 194609152 19:08:47 INFO - PROCESS | 1998 | 19:08:49 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51356/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:08:49 INFO - PROCESS | 1998 | RSS: Main: 193847296 19:08:49 INFO - PROCESS | 1998 | 19:08:51 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51356/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:08:52 INFO - PROCESS | 1998 | RSS: Main: 193978368 19:08:52 INFO - PROCESS | 1998 | 19:08:54 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51356/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:08:54 INFO - PROCESS | 1998 | RSS: Main: 194306048 19:08:54 INFO - PROCESS | 1998 | 19:08:57 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:08:58 INFO - PROCESS | 1998 | RSS: Main: 194523136 19:08:58 INFO - PROCESS | 1998 | 19:09:00 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:09:01 INFO - PROCESS | 1998 | RSS: Main: 194461696 19:09:01 INFO - PROCESS | 1998 | 19:09:02 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:51356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51356/tests/kraken/driver.html?testName=ai-astar) 19:09:03 INFO - PROCESS | 1998 | RSS: Main: 196059136 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | __start_tp_report 19:09:03 INFO - PROCESS | 1998 | _x_x_mozilla_page_load 19:09:03 INFO - PROCESS | 1998 | _x_x_mozilla_page_load_details 19:09:03 INFO - PROCESS | 1998 | |i|pagename|runs| 19:09:03 INFO - PROCESS | 1998 | |0;ai-astar;116;109;116;117;116;129;115;112;115;114 19:09:03 INFO - PROCESS | 1998 | |1;audio-beat-detection;189;153;148;184;149;143;141;124;163;161 19:09:03 INFO - PROCESS | 1998 | |2;audio-dft;227;261;199;219;199;279;235;201;223;278 19:09:03 INFO - PROCESS | 1998 | |3;audio-fft;95;77;74;108;58;58;59;58;117;57 19:09:03 INFO - PROCESS | 1998 | |4;audio-oscillator;87;83;120;62;100;63;117;103;66;118 19:09:03 INFO - PROCESS | 1998 | |5;imaging-gaussian-blur;92;88;86;89;91;87;92;112;78;131 19:09:03 INFO - PROCESS | 1998 | |6;imaging-darkroom;129;120;97;95;96;96;103;151;130;96 19:09:03 INFO - PROCESS | 1998 | |7;imaging-desaturate;93;121;134;137;142;89;147;144;91;91 19:09:03 INFO - PROCESS | 1998 | |8;json-parse-financial;56;60;60;59;58;59;57;67;55;53 19:09:03 INFO - PROCESS | 1998 | |9;json-stringify-tinderbox;65;65;71;71;71;72;67;65;84;100 19:09:03 INFO - PROCESS | 1998 | |10;stanford-crypto-aes;86;82;84;81;85;82;83;85;79;86 19:09:03 INFO - PROCESS | 1998 | |11;stanford-crypto-ccm;125;122;114;128;133;138;131;126;136;130 19:09:03 INFO - PROCESS | 1998 | |12;stanford-crypto-pbkdf2;126;139;139;137;134;137;127;152;168;172 19:09:03 INFO - PROCESS | 1998 | |13;stanford-crypto-sha256-iterative;67;67;67;66;69;67;64;68;67;70 19:09:03 INFO - PROCESS | 1998 | __end_tp_report 19:09:03 INFO - PROCESS | 1998 | __start_cc_report 19:09:03 INFO - PROCESS | 1998 | _x_x_mozilla_cycle_collect,893 19:09:03 INFO - PROCESS | 1998 | __end_cc_report 19:09:03 INFO - PROCESS | 1998 | __startTimestamp1463105343028__endTimestamp 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | ------- Summary: start ------- 19:09:03 INFO - PROCESS | 1998 | Number of tests: 14 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.00 stddev:5.17 (4.5%) stddev-sans-first:5.49 19:09:03 INFO - PROCESS | 1998 | Values: 116.0 109.0 116.0 117.0 116.0 129.0 115.0 112.0 115.0 114.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:157.00 stddev:19.68 (12.5%) stddev-sans-first:16.72 19:09:03 INFO - PROCESS | 1998 | Values: 189.0 153.0 148.0 184.0 149.0 143.0 141.0 124.0 163.0 161.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#2] audio-dft Cycles:10 Average:232.10 Median:231.00 stddev:30.89 (13.4%) stddev-sans-first:32.71 19:09:03 INFO - PROCESS | 1998 | Values: 227.0 261.0 199.0 219.0 199.0 279.0 235.0 201.0 223.0 278.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#3] audio-fft Cycles:10 Average:76.10 Median:58.50 stddev:22.83 (39.0%) stddev-sans-first:23.17 19:09:03 INFO - PROCESS | 1998 | Values: 95.0 77.0 74.0 108.0 58.0 58.0 59.0 58.0 117.0 57.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:62.50 stddev:23.08 (36.9%) stddev-sans-first:24.41 19:09:03 INFO - PROCESS | 1998 | Values: 87.0 83.0 120.0 62.0 100.0 63.0 117.0 103.0 66.0 118.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:88.50 stddev:15.41 (17.4%) stddev-sans-first:16.31 19:09:03 INFO - PROCESS | 1998 | Values: 92.0 88.0 86.0 89.0 91.0 87.0 92.0 112.0 78.0 131.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#6] imaging-darkroom Cycles:10 Average:111.30 Median:95.50 stddev:19.88 (20.8%) stddev-sans-first:20.02 19:09:03 INFO - PROCESS | 1998 | Values: 129.0 120.0 97.0 95.0 96.0 96.0 103.0 151.0 130.0 96.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#7] imaging-desaturate Cycles:10 Average:118.90 Median:118.00 stddev:25.02 (21.2%) stddev-sans-first:24.72 19:09:03 INFO - PROCESS | 1998 | Values: 93.0 121.0 134.0 137.0 142.0 89.0 147.0 144.0 91.0 91.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.00 stddev:3.78 (6.4%) stddev-sans-first:3.91 19:09:03 INFO - PROCESS | 1998 | Values: 56.0 60.0 60.0 59.0 58.0 59.0 57.0 67.0 55.0 53.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:71.00 stddev:11.01 (15.5%) stddev-sans-first:11.28 19:09:03 INFO - PROCESS | 1998 | Values: 65.0 65.0 71.0 71.0 71.0 72.0 67.0 65.0 84.0 100.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.50 stddev:2.31 (2.7%) stddev-sans-first:2.24 19:09:03 INFO - PROCESS | 1998 | Values: 86.0 82.0 84.0 81.0 85.0 82.0 83.0 85.0 79.0 86.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:130.50 stddev:7.04 (5.4%) stddev-sans-first:7.37 19:09:03 INFO - PROCESS | 1998 | Values: 125.0 122.0 114.0 128.0 133.0 138.0 131.0 126.0 136.0 130.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:139.00 stddev:15.91 (11.4%) stddev-sans-first:15.62 19:09:03 INFO - PROCESS | 1998 | Values: 126.0 139.0 139.0 137.0 134.0 137.0 127.0 152.0 168.0 172.0 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - PROCESS | 1998 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.72 19:09:03 INFO - PROCESS | 1998 | Values: 67.0 67.0 67.0 66.0 69.0 67.0 64.0 68.0 67.0 70.0 19:09:03 INFO - PROCESS | 1998 | -------- Summary: end -------- 19:09:03 INFO - PROCESS | 1998 | 19:09:03 INFO - TEST-INFO | 1998: exit 0 19:09:03 INFO - TEST-OK | kraken | took 57860ms 19:09:03 INFO - SUITE-END | took 1167s 19:09:04 INFO - Completed test suite (00:19:28) 19:09:04 INFO - javascript benchmark 19:09:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3676.540432445944, 3692.3383481119863, 3710.8144592770373, 3750.2874453853774, 3753.943690844638, 5944.554158438113, 6061.9696901515545, 6063.939360606398, 6064.241969753781, 6068.211132552773, 5955.583109182359, 6006.729697163627, 6039.154518367421, 6055.4247346502125, 6064.878702425949, 5343.198520221959, 5389.380221274545, 5414.269073675043, 5446.945530544684, 5499.340079190482, 5353.411124776271, 5426.83719488414, 5449.891002179954, 5456.372517160537, 5477.178423236526, 5359.678419294835, 5434.402215756264, 5467.726613669321, 5480.7533660985355, 5506.779728810863, 5448.700321482317, 5468.070428027245, 5477.534409575191, 5478.096114141162, 5479.863003424906, 3842.385218365076, 5276.498732620395, 5383.81156659515, 5405.486478784509, 5509.669419834822, 4984.3021976923255, 5632.324121105453, 5641.2384328116, 5887.175795388649, 5915.08316210988, 5199.740012999335, 5963.731632076567, 6186.287877652752, 6239.65681887496, 6251.406116418979, 5488.56091512682, 6237.500999919996, 6253.7185826637915, 6313.87372252557, 6317.810465686037, 6095.603785753956, 6131.601445906046, 6135.509159267248, 6138.324784273726, 6146.66193359365, 6533.673316334164, 6609.966950165314, 6621.569597976116, 6648.135742353463, 6693.464522838161, 6120.355709576947, 6199.070139479114, 6245.812625621239, 6252.406021428048, 6292.937070629327, 6386.616802991743, 6399.520035997319, 6401.711922963478, 6409.0066039763915, 6410.038494225811, 6270.498360131179, 6286.622802631765, 6291.1192433059405, 6309.779157729457, 6311.936880631227, 6134.803982731532, 6212.378762123752, 6227.750889964351, 6228.314885362606, 6292.276388215322, 5019.42276638184, 5033.0437216929395, 5038.622103342264, 5045.0, 5061.089003979246, 4086.7139300248696, 4552.998340365114, 4556.0, 4558.1795276849825, 4588.357629931812, 5082.618803589746, 6001.1898393717165, 6031.939680603138, 6114.144019837227, 6135.202044401884, 6332.778352757724, 6344.302126766052, 6352.650604216812, 6364.395382438661, 6372.490200783926, 6153.353897840751, 6179.0, 6179.3820617937845, 6184.5052395808225, 6212.565120441525, 5436.266104075899, 5547.889042219133, 5567.916481252784, 5590.97204513983, 5619.381867994517, 6679.879688464848, 6701.1623547056615, 6725.226598940989, 6738.831529211809, 6771.119754431892, 6224.719887604978, 6363.490920726424, 6415.1981002374705, 6419.165508483868, 6426.164598602152, 6583.604983700993, 6680.164979377578, 6702.028205910213, 6718.093057437183, 6724.596524208563, 6240.063990401294, 6254.499640028877, 6255.030470277115, 6278.246610406781, 6289.276733175743, 6194.783182588588, 6222.657753823583, 6290.182276304235, 6299.811005669837, 6311.779087732091, 4746.881327966828, 6271.404216599598, 6301.905471417841, 6305.621662700252, 6307.24313082433, 6279.434850863444, 6300.21247344082, 6302.590331628429, 6311.684415779101, 6313.715882785194, 6056.454919057306, 6119.715820550834, 6184.165137706352, 6192.195014648067, 6244.72067695297, 6255.0, 6263.185785847811, 6273.3099359071375, 6275.529335299962, 6280.371962803683, 6173.104899789416, 6174.135621012972, 6180.042093475518, 6195.0, 6203.348648392034], "unit": "score", "name": "dojo.html", "value": 5867.424312614141}, {"lowerIsBetter": false, "replicates": [576.0984059946184, 594.9791757288493, 619.9845003874906, 677.6548551126014, 683.6581709145426, 38928.02679932999, 39501.209975800535, 39562.0, 39635.00912477186, 39666.603333966654, 42669.573304266945, 42749.0, 42755.931101722475, 42820.35769463461, 42987.57012429875, 9735.56189971453, 9985.800283994316, 10038.849417258747, 10058.994100589918, 10090.495475226246, 9916.801663966717, 10059.5473203706, 10060.446675432848, 10061.949690251575, 10078.848817267746, 8846.20384165425, 9985.20118390527, 10025.59897604095, 10076.345037572535, 10139.036791504795, 8849.823003539925, 9812.411255324667, 10001.34991225568, 10030.297879148462, 10098.798024039477, 9930.90069099307, 10059.748506287327, 10063.396196228177, 10066.69799906004, 10131.544080516394, 35989.82005089984, 40054.59945400567, 40196.0, 40267.39598906019, 40390.192196156204, 3206.839658017113, 3450.5686789151355, 3521.894343169709, 3937.6652984496354, 3999.960000399988, 27649.170524884084, 27792.583111253145, 27862.5820612691, 28386.716132838614, 28597.28506787326, 2744.972550274512, 2795.8182718123257, 2822.5625028120676, 2839.957400638992, 2915.518939375022, 340861.0, 342946.0, 343169.0, 343669.0, 344494.0, 39405.40891886624, 48353.27470087951, 68599.0, 68980.6550967242, 69177.30822691708, 45491.77254113775, 45820.54179458229, 45906.770466147456, 45952.08095838065, 46155.76922115368, 16777.412790552273, 16866.156692165343, 17112.48662540126, 17261.39585114515, 17314.393996210074, 13794.0, 13803.447862085404, 13838.584842454742, 13869.722605548035, 13919.582412527641, 14884.479043233436, 15142.394304227928, 15201.6199595011, 15275.312610932535, 15658.608534786721, 6497.675116244169, 6606.702698378488, 6647.933520664828, 6648.800535983832, 6651.33486651331, 968.912797848183, 994.0, 1034.9482525873675, 1049.2602715085845, 1207.372166473429, 30692.53961190584, 30821.38357232843, 30899.0, 31014.844925775225, 31137.532937005963, 1108.9944550277196, 1128.2046157458972, 1158.8783177766381, 1256.2085885892013, 1298.5455090718174, 14697.632559186106, 14816.777748333783, 15239.161846098572, 15340.0, 15379.846201538065, 443650.5634943674, 445387.0, 449770.0, 450490.0, 451667.0, 58033.419665803645, 59689.70155149196, 59809.0, 59869.70065149733, 59978.100328494234, 1512.5613572064199, 1555.4244929376202, 1559.656875487391, 1562.9609259768597, 1575.1415478563981, 30366.39267214599, 30465.086047418612, 30654.080377588707, 30949.226269342547, 31198.37603247968, 54182.0, 54205.45794542004, 54249.643758904764, 54306.91386172333, 54434.0, 409107.0, 409975.0, 411203.94398027816, 413175.93412032747, 413469.0, 34268.65731342655, 34747.826260869544, 34974.82512587523, 35566.466503002994, 36007.0, 47188.29217561808, 47192.764036180975, 48432.75783621059, 48621.756891215315, 49160.2625960618, 33454.83272583621, 39133.804330978164, 39644.801775990934, 39780.403293951196, 39908.600913990485, 38431.423528646534, 38448.27586206919, 38475.42286865643, 38786.0, 39349.0, 33412.66587334096, 38583.614163858, 38607.0, 39156.216875662896, 39807.601923980386, 27150.864245678644, 30322.393552128393, 32006.67993320037, 32256.35487290288, 32473.837630811693, 21885.890570547046, 24599.508009839345, 25512.55333928793, 25744.098956536433, 26224.0], "unit": "score", "name": "ext.html", "value": 19562.5394374836}, {"lowerIsBetter": false, "replicates": [378.31902575364353, 379.5104315433092, 388.65603940512636, 390.9687225021998, 391.5418959817014, 17018.40435584755, 19516.63383563151, 20696.793032069676, 22125.557488850234, 22248.443788905304, 20920.68618970713, 20995.685064724043, 21217.469563260925, 21434.356969290908, 21466.570668586657, 5843.912341314884, 5863.618864773797, 6131.846703832395, 6161.322254552018, 6166.537509686769, 4231.724937879043, 6011.849703757419, 6016.969915150418, 6242.406971337716, 6318.71565779541, 6184.783532576361, 6257.342978987186, 6287.18266625338, 6290.559660823744, 6297.08692239625, 6420.518461115412, 6742.730290788338, 6749.797506074826, 6827.590344579341, 6844.828879278008, 5813.389594092644, 5967.283925928873, 6032.9698351508405, 6047.69761511927, 6048.516118710492, 14166.079204851652, 14300.0, 14342.354594043292, 14425.134491930517, 15565.533034008999, 2120.4380839077658, 2290.1068583252545, 2455.300239431753, 2853.6860945296003, 2859.6711378191567, 9518.95240523793, 9633.855492167622, 10138.239632027553, 10419.583216671324, 10543.894561054445, 1777.3246166456793, 1800.9459716208535, 1831.3681779785952, 1881.17228419495, 1882.7552418185549, 105848.47075764649, 106662.0, 109475.0, 109904.4504777479, 110382.0, 10165.44090075053, 11271.59105111861, 11325.207235493437, 11508.654740357802, 11639.59261425846, 12919.547815826401, 13812.516561920285, 14285.642858928402, 14536.709265814625, 14550.563483095524, 6789.422899053636, 6920.723171073201, 8631.0, 9053.683121090862, 9100.362974591715, 7947.4039447041705, 9246.19699158671, 9259.212966897754, 9301.348905576544, 9339.0, 4077.612626800449, 4431.313146462304, 4535.092981403733, 4546.704464209882, 4721.622270218374, 1820.8270214329618, 1900.8859468431663, 1933.2750218668, 1978.6834106542883, 1995.1121750820746, 795.5067857928121, 945.8533927241289, 963.1283688262134, 1020.6784862768204, 1029.912457441126, 20586.485337866372, 21172.941352932292, 21227.134714485026, 21497.892510537346, 21553.892230538746, 988.6440881282876, 1007.8840933292619, 1011.0849681038671, 1032.0814475117152, 1070.6680928912062, 11282.379469129113, 11291.209615327012, 11996.920277175097, 12009.979151772197, 12113.939430302968, 686162.0, 696148.0, 704889.0, 714952.0, 721358.0, 116567.41716291364, 125954.37022814827, 127291.0, 127649.36175319063, 128840.0, 1109.0905457524752, 1122.831575263717, 1124.0838716446233, 1131.4851742457163, 1132.8810474900017, 16297.837021629632, 19064.23743050318, 19634.705479418106, 19654.90172549128, 19830.305939292633, 40056.599434005286, 52279.73860130675, 54714.452855472526, 55002.0, 55043.899122018134, 68462.65768671125, 68791.31208687849, 69349.65325173341, 69395.65302173457, 71628.28371716425, 7580.734674286374, 7941.0, 7995.9200407997505, 8051.919480805352, 8253.422260441712, 7222.89165662526, 9482.668106616235, 10581.418022008864, 13870.306484675524, 14145.151290922578, 11752.76494470123, 11781.76436471283, 12059.397030148633, 12060.216085954386, 12079.818802717791, 9844.950775246078, 11702.414879256174, 11764.411779411166, 11935.403229838646, 12042.096842736655, 12037.819432708691, 12104.636860894187, 12109.515619375126, 12231.449584768885, 12297.262164270172, 8376.0, 8554.657813687383, 8564.914350856412, 8588.355873309652, 8738.519381434082, 10915.56337746513, 12047.879521204675, 12126.696832578904, 12222.938885305872, 12318.692032698897], "unit": "score", "name": "jquery.html", "value": 9628.88501742795}, {"lowerIsBetter": false, "replicates": [1631.583946093746, 1639.2623319506222, 1979.4655443030383, 2066.493709041286, 2109.662454007359, 8041.9597902010555, 8411.074781774, 8710.695125670594, 9429.434233945967, 9433.905660943388, 7731.690732370698, 9133.406328588637, 9230.953845230764, 9267.768305792359, 9304.441733495994, 2586.301698541388, 2593.753593408623, 2627.842329460229, 2629.1849526646706, 2632.63103186343, 2250.504888924434, 2608.2827222513865, 2637.116565950409, 2640.3531134871982, 2647.5896236083436, 2206.6028114939304, 2607.34816295926, 2610.9086181983635, 2611.9738802612014, 2613.7647611714942, 2529.0389651932146, 2542.9872850635816, 2557.2839604910655, 2558.6162075688794, 2566.550853600622, 2221.8222542196745, 2646.695630002536, 2676.625272461857, 2681.8793154308105, 2682.248970288322, 9142.268618510503, 9220.631174753002, 9269.675561355387, 9273.07269273074, 9300.976892541816, 5803.129530570406, 5923.170756094107, 5989.251343582052, 5992.700364981777, 5993.490553302974, 3698.33429982603, 3755.6995440364703, 3806.2197249563774, 3837.5586807516934, 3914.706397020235, 1055.2454994678765, 1079.7192729890207, 1083.6369816111612, 1114.0586204657052, 1134.3817619397366, 12313.815292770527, 12336.136470447072, 12431.191972521758, 12436.875631243662, 12476.50093996239, 5208.869778255498, 5253.474652534793, 5302.522772950453, 5304.840854774363, 5314.12316967696, 10728.946355268174, 10740.0, 10820.97200765926, 10835.295705779257, 10888.237823352289, 5284.867878303073, 5705.172749951317, 5806.390329015477, 5810.593258471867, 5973.462388385066, 4735.597474214662, 5104.744762761847, 5268.762905669254, 5290.259363689087, 5320.0, 4187.099773548702, 4195.517515485697, 4215.114825886537, 4221.303484925014, 4235.237657221668, 1264.791309433933, 1300.6293206436121, 1360.0479664235074, 1375.3054707372712, 1390.4646711016333, 1372.773492373767, 1423.523119754873, 1423.992880035593, 1438.5252866554013, 1444.7832825076323, 8420.326373890073, 8624.223819856243, 8664.133586641285, 8665.480071195749, 8697.130286971378, 1285.1582213650074, 1294.2428679222571, 1298.8636193199577, 1300.8894243989178, 1305.9608211753473, 6494.480441564663, 6545.541812073109, 6558.376954189344, 6593.80218593443, 6597.538172327891, 10870.021698047214, 10921.290116142425, 11114.22200445961, 11193.49629266685, 11249.550017999352, 10866.239363244655, 10868.67393978182, 11056.944715276533, 11125.27685700443, 11335.319880807177, 8627.309815214769, 8642.0, 8767.035626081126, 8831.24934380572, 8854.158854908774, 6938.410235130071, 7973.960130199312, 8139.064007639197, 8240.670373185005, 8289.253967142986, 9726.076022777825, 9893.65372211969, 9972.650957216463, 10079.899201007896, 10123.949380253052, 10072.345297555636, 10257.33327333721, 10304.227182961158, 10340.948295258475, 10366.844497332395, 6681.365270299314, 7149.82125446868, 7167.713291468492, 7301.890471642823, 7428.33145016951, 8396.412251142361, 8594.05465398793, 8604.526751028754, 8643.438176518506, 8663.653453861774, 7500.324970752658, 7597.240275972358, 7652.502587332028, 7669.041369828771, 7747.9927609410415, 7427.44294177928, 7444.404447644067, 7491.325780679765, 7491.43814213947, 7514.473986821089, 8119.4722343047515, 8149.877751833846, 8212.671493140208, 8213.466124701876, 8224.218699223564, 7264.927350726636, 7326.670299836626, 7399.445041622008, 7415.998840156725, 7429.294217049372, 7448.5158464699625, 7466.178720340649, 7502.924970750441, 7522.473426860286, 7533.773986780406], "unit": "score", "name": "mootools.html", "value": 5207.8300201162065}, {"lowerIsBetter": false, "replicates": [343.471054575953, 346.57890662844636, 350.5460428744775, 354.63649758997025, 358.77576514678327, 6999.930000699991, 7018.824529386768, 7023.122109736283, 7043.47173961953, 7050.647467626617, 5530.889382212354, 5628.874225154975, 6951.687174077166, 6995.125609298838, 7007.983842342857, 4195.077083041726, 4864.781084851173, 4982.975085124587, 5088.26220198071, 5101.285819985205, 5070.138076527, 5097.260897169908, 5103.770330335144, 5106.97860427914, 5110.66780659256, 5029.497050294978, 5032.11937910866, 5045.394552653686, 5045.722485263327, 5050.924236136461, 5045.4197767256865, 5060.51925067118, 5067.467915868818, 5078.390593128811, 5079.212722028092, 4394.626456751148, 4398.0, 4400.383946247528, 4405.493368262659, 4407.977960110179, 6516.641584712839, 6694.062831203635, 6773.45812335012, 6779.254282028973, 6800.557963732342, 6040.305364883006, 6058.212432383762, 6070.301915279755, 6088.573799834014, 6093.268807743099, 5301.1783173608155, 6244.0, 6417.454516366114, 7438.888416673754, 7442.590657513834, 4932.235503496928, 4936.4076310842565, 4940.851774446773, 4949.307097006422, 4968.1554135797005, 7894.486858354188, 7912.208779122099, 7925.643346049384, 7932.762017139437, 7939.682412703485, 4860.541837448751, 5019.0, 5035.144025515671, 5041.294218809369, 5062.493750624908, 5097.617678674114, 5138.58891288696, 5138.820141295037, 5143.048536020848, 5159.0, 6007.789727359609, 6011.819645410645, 6017.789377371859, 6029.60807547508, 6030.0, 7333.376662983706, 7406.814829629195, 7417.443691723142, 7445.553266804009, 7455.0681164854395, 1785.419738584965, 1823.7082066869236, 1825.434115424196, 1827.643609496162, 1829.1860122245473, 1074.4520294649628, 1104.0, 1115.9330440173453, 1184.6682928779956, 1187.9168458208014, 7036.788896333118, 7072.0, 7074.68163932614, 7089.574625522382, 7094.184168820549, 6236.0, 6353.919833628294, 7523.247675232543, 7680.231976802275, 7831.921680783234, 6960.477964152708, 7119.359257666835, 7188.82027949295, 7212.170600381023, 7248.637568121573, 4102.897427564335, 4143.585641435892, 4148.211839750437, 4153.252414565347, 4156.355764856452, 6994.8950765738555, 7794.025746781653, 8212.17878212174, 8215.383846211438, 8236.876446853303, 7836.0, 8104.0, 8112.3104536113915, 8128.59357032146, 8135.7152499662225, 8227.053888802744, 8263.876041859377, 8270.090290068089, 8281.420300579022, 8300.418970672115, 7835.960820195863, 7858.410619203468, 7863.449558530848, 7869.095054068626, 7895.052593688794, 7654.923450765421, 7677.121079595152, 7689.884651730116, 7690.423218258541, 7714.382849372149, 7936.365090792839, 8176.509409435453, 8274.462159959583, 8288.129746376784, 8288.875666864882, 5112.182050871843, 5136.9743151284, 5138.254953031864, 5143.074246635641, 5151.974240128776, 7778.49439786412, 7802.258785415376, 7805.609719513888, 7808.336291415066, 7818.022747156606, 6939.8833355826955, 7524.962375188089, 7542.132654744555, 7548.207438218908, 7559.546427214164, 7484.139323977813, 7517.586532740752, 7533.1336896257635, 7542.47202695806, 7567.356774673995, 6975.0, 7371.447141464304, 7381.298776616213, 7387.482876198829, 7394.889076663747, 7539.132999705104, 7558.093028836574, 7558.508696934901, 7602.7455469849065, 7636.160022397643, 7153.141623005273, 7331.890021649573, 7378.409727221917, 7384.52000619958, 7394.186639469762], "unit": "score", "name": "prototype.html", "value": 5476.467469648883}, {"lowerIsBetter": false, "replicates": [695.7919969031797, 700.2087640965705, 730.8940203670468, 752.2552672853873, 757.1784613694142, 15467.613309667264, 15601.843981560181, 15640.061596304215, 15660.451884184056, 15874.682506349895, 11418.429078546082, 14739.55781326562, 14755.631109222275, 14755.852441475581, 14767.0, 694.7637803146941, 805.0741647105816, 979.686500319898, 990.0297708245887, 996.4619105682923, 959.1271942532262, 963.4604621412032, 990.2325697584357, 996.9800603987916, 999.7400675824265, 1010.9545070471846, 1053.9262251642388, 1061.1722856172198, 1062.1555863088863, 1063.1813503602223, 1035.4977835749655, 1048.0201012053717, 1051.9842202366933, 1055.0082922053323, 1057.1912486947492, 774.0672489649959, 788.9368850491946, 795.0737390939548, 798.8522123407188, 800.9867517590253, 15159.848401515954, 15369.923150384288, 15525.378984840592, 15846.603834904105, 15921.681566368723, 13341.66645833862, 13411.597652070453, 13426.0601757877, 13442.193468391928, 13448.663783405394, 10298.691039268833, 10316.845247321296, 10419.95800419952, 10451.16390688743, 10480.0, 3666.358387282215, 3679.0802299425145, 3694.741368104234, 3703.8333275002688, 3722.627737226283, 77299.22700772976, 77399.22600773977, 77763.22236777616, 81800.59099704464, 81908.77136842952, 9932.900670993198, 9966.40201587907, 9973.750656233653, 10054.69835904924, 10063.094321510953, 21541.892290538446, 21755.564888702454, 21782.89108554447, 21783.564328713335, 21808.47340686137, 7755.573443460664, 7762.8059298516855, 7783.377329813601, 7841.529508229524, 7958.204179581995, 4141.97929010353, 4165.625093741578, 4170.186813571385, 4191.832326706958, 4197.538270790211, 3806.200697853482, 3828.2152158807376, 3838.2323535293053, 3842.6733727632904, 3847.3651847444858, 666.3436515032689, 671.6742379945722, 684.7740245718901, 685.4927353758183, 688.6212583079387, 620.6803496199461, 632.2160520953984, 635.3138610300864, 635.3773302163905, 657.4346062386344, 7460.440466964999, 8372.585551520682, 8524.95737521321, 8612.956935215283, 8963.820723585492, 520.8723862653674, 614.2720875762236, 627.689293799563, 635.8887194740994, 650.3074225949349, 3820.9426858597144, 3936.881893543198, 4005.619466150711, 4076.612721791425, 4176.227397931392, 94791.52604237072, 97108.05783884283, 98394.01605983992, 99578.0, 100161.0, 77285.2271477278, 77544.0, 82385.9403514905, 84498.5775071133, 85244.57377713195, 72893.90659140117, 73187.26812731911, 73512.0, 73564.0, 74489.88265176027, 7914.564698941614, 8227.382946279173, 8236.34109271245, 8335.791605209919, 8413.411061225655, 50713.985720286124, 51028.0, 52291.0, 53576.0, 53702.0, 66125.66937165284, 68840.31159688339, 70002.64998674973, 70968.29031709823, 72345.0, 10030.448325342177, 10186.286959912735, 10306.48467576633, 10322.948385258025, 10356.896431035895, 11037.0, 11044.723881902695, 11234.101271898066, 11307.378094204898, 11931.403429828648, 10472.371657700562, 10628.36229826213, 10825.512851921525, 10902.345859248153, 11224.831627525757, 10068.194544436574, 10407.06336429725, 10679.252452328263, 10708.518116684612, 11151.330920144817, 10259.692209233735, 10329.841209716893, 10443.0, 10523.894761052292, 11003.119750419786, 8982.730518084469, 9158.633654653739, 9170.541472926461, 9259.120383563552, 9272.072792720674, 8779.078196789245, 9007.414518056305, 9108.407953483002, 9128.543572821465, 9228.261739060725], "unit": "score", "name": "yui.html", "value": 7072.68978318015}], "name": "dromaeo_css", "value": 7787.001149402311}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 109.0, 116.0, 117.0, 116.0, 129.0, 115.0, 112.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.9}, {"lowerIsBetter": true, "replicates": [189.0, 153.0, 148.0, 184.0, 149.0, 143.0, 141.0, 124.0, 163.0, 161.0], "unit": "score", "name": "audio-beat-detection", "value": 155.5}, {"lowerIsBetter": true, "replicates": [227.0, 261.0, 199.0, 219.0, 199.0, 279.0, 235.0, 201.0, 223.0, 278.0], "unit": "score", "name": "audio-dft", "value": 232.1}, {"lowerIsBetter": true, "replicates": [95.0, 77.0, 74.0, 108.0, 58.0, 58.0, 59.0, 58.0, 117.0, 57.0], "unit": "score", "name": "audio-fft", "value": 76.1}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 120.0, 62.0, 100.0, 63.0, 117.0, 103.0, 66.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 91.9}, {"lowerIsBetter": true, "replicates": [92.0, 88.0, 86.0, 89.0, 91.0, 87.0, 92.0, 112.0, 78.0, 131.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.6}, {"lowerIsBetter": true, "replicates": [129.0, 120.0, 97.0, 95.0, 96.0, 96.0, 103.0, 151.0, 130.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 111.3}, {"lowerIsBetter": true, "replicates": [93.0, 121.0, 134.0, 137.0, 142.0, 89.0, 147.0, 144.0, 91.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 118.9}, {"lowerIsBetter": true, "replicates": [56.0, 60.0, 60.0, 59.0, 58.0, 59.0, 57.0, 67.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 71.0, 71.0, 71.0, 72.0, 67.0, 65.0, 84.0, 100.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.1}, {"lowerIsBetter": true, "replicates": [86.0, 82.0, 84.0, 81.0, 85.0, 82.0, 83.0, 85.0, 79.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [125.0, 122.0, 114.0, 128.0, 133.0, 138.0, 131.0, 126.0, 136.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.3}, {"lowerIsBetter": true, "replicates": [126.0, 139.0, 139.0, 137.0, 134.0, 137.0, 127.0, 152.0, 168.0, 172.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 69.0, 67.0, 64.0, 68.0, 67.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1549.6999999999998}]} 19:09:04 INFO - Return code: 0 19:09:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:09:04 ERROR - # TBPL SUCCESS # 19:09:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:09:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:09:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:09:04 INFO - 2016-05-12 19:09:04.351 screenresolution[2003:16257] starting screenresolution argv=screenresolution get 19:09:04 INFO - 2016-05-12 19:09:04.354 screenresolution[2003:16257] Display 0: 1600x1200x32@60 19:09:04 INFO - 2016-05-12 19:09:04.360 screenresolution[2004:16260] starting screenresolution argv=screenresolution list 19:09:04 INFO - Available Modes on Display 0 19:09:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:09:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:09:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:09:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:09:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:09:04 INFO - Intel Iris: 19:09:04 INFO - Chipset Model: Intel Iris 19:09:04 INFO - Type: GPU 19:09:04 INFO - Bus: Built-In 19:09:04 INFO - VRAM (Dynamic, Max): 1536 MB 19:09:04 INFO - Vendor: Intel (0x8086) 19:09:04 INFO - Device ID: 0x0a2e 19:09:04 INFO - Revision ID: 0x0009 19:09:04 INFO - Displays: 19:09:04 INFO - Display: 19:09:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:09:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:09:04 INFO - Display Serial Number: 1600x1200 60 19:09:04 INFO - Main Display: Yes 19:09:04 INFO - Mirror: Off 19:09:04 INFO - Online: Yes 19:09:04 INFO - Rotation: Supported 19:09:04 INFO - Return code: 0 19:09:04 INFO - Running post-action listener: _resource_record_post_action 19:09:04 INFO - Running post-run listener: _resource_record_post_run 19:09:05 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 889344; Write bytes: 509700608; Read time: 12; Write time: 1826 19:09:05 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 205810176; Write bytes: 208700928; Read time: 19376; Write time: 494 19:09:05 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 889344; Write bytes: 299860992; Read time: 12; Write time: 1282 19:09:05 INFO - Running post-run listener: _upload_blobber_files 19:09:05 INFO - Blob upload gear active. 19:09:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:09:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:09:05 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'] 19:09:05 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 19:09:06 INFO - (blobuploader) - INFO - Open directory for files ... 19:09:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:09:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:09:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:06 INFO - (blobuploader) - INFO - Done attempting. 19:09:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:09:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:09:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:07 INFO - (blobuploader) - INFO - Done attempting. 19:09:07 INFO - (blobuploader) - INFO - Iteration through files over. 19:09:07 INFO - Return code: 0 19:09:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:09:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:09:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6fa0d6abb58f2b28a01ee2e0926f8f88a8c16a07f45f08e889983eba07d232022eff36f3a7ea836ac9206f999cfc5bd428f46b1646bfa918ca56dd8aba226f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e3c5c91c154714e41b99f64bf90a6a8c5b8aaaae53c2e705aa46bf64e04bf88c7cf1685456ddec0586a2423b0227391621f29aa7b3029737fe5ece1dfaa907b"} 19:09:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:09:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:09:07 INFO - Contents: 19:09:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6fa0d6abb58f2b28a01ee2e0926f8f88a8c16a07f45f08e889983eba07d232022eff36f3a7ea836ac9206f999cfc5bd428f46b1646bfa918ca56dd8aba226f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e3c5c91c154714e41b99f64bf90a6a8c5b8aaaae53c2e705aa46bf64e04bf88c7cf1685456ddec0586a2423b0227391621f29aa7b3029737fe5ece1dfaa907b"} 19:09:07 INFO - Running post-run listener: copy_logs_to_upload_dir 19:09:07 INFO - Copying logs to upload dir... 19:09:07 INFO - mkdir: /builds/slave/test/build/upload/logs 19:09:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.338246 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-12 19:09:07.935273) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 19:09:07.940615) ========= 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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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/b6fa0d6abb58f2b28a01ee2e0926f8f88a8c16a07f45f08e889983eba07d232022eff36f3a7ea836ac9206f999cfc5bd428f46b1646bfa918ca56dd8aba226f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e3c5c91c154714e41b99f64bf90a6a8c5b8aaaae53c2e705aa46bf64e04bf88c7cf1685456ddec0586a2423b0227391621f29aa7b3029737fe5ece1dfaa907b"} build_url:https://queue.taskcluster.net/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011076 build_url: 'https://queue.taskcluster.net/v1/task/IViHi7wbS3mPIJ0DBvW7BA/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b6fa0d6abb58f2b28a01ee2e0926f8f88a8c16a07f45f08e889983eba07d232022eff36f3a7ea836ac9206f999cfc5bd428f46b1646bfa918ca56dd8aba226f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e3c5c91c154714e41b99f64bf90a6a8c5b8aaaae53c2e705aa46bf64e04bf88c7cf1685456ddec0586a2423b0227391621f29aa7b3029737fe5ece1dfaa907b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 19:09:07.969026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 19:09:07.969392) ========= 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.bYU6vpWhpc/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.FB6gCdi7aT/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005008 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 19:09:08.018402) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 19:09:08.018728) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 19:09:08.019158) ========= ========= Total master_lag: 0.16 =========