builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0078 starttime: 1463507744.67 results: success (0) buildid: 20160516203739 builduid: 35109f84dca34c5782941e77d47db877 revision: b9598d922a0ba3957d4cf178a03b877d76354fb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.665927) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.666444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.666731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.727114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.727441) ========= 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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-17 10:55:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-05-17 10:55:44 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155234 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.920004) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.923309) ========= 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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.027308 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.982769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 10:55:44.983090) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b9598d922a0ba3957d4cf178a03b877d76354fb1 --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 b9598d922a0ba3957d4cf178a03b877d76354fb1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-17 10:55:45,057 truncating revision to first 12 chars 2016-05-17 10:55:45,057 Setting DEBUG logging. 2016-05-17 10:55:45,057 attempt 1/10 2016-05-17 10:55:45,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b9598d922a0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 10:55:45,975 unpacking tar archive at: mozilla-beta-b9598d922a0b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.165155 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 10:55:46.219266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:46.219568) ========= script_repo_revision: b9598d922a0ba3957d4cf178a03b877d76354fb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:46.219920) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:46.220185) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:46.301192) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2016-05-17 10:55:46.301531) ========= /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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:55:46 INFO - MultiFileLogger online at 20160517 10:55:46 in /builds/slave/test 10:55:46 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 10:55:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:55:46 INFO - {'append_to_log': False, 10:55:46 INFO - 'base_work_dir': '/builds/slave/test', 10:55:46 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:55:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:55:46 INFO - 'branch': 'Mozilla-Beta', 10:55:46 INFO - 'buildbot_json_path': 'buildprops.json', 10:55:46 INFO - 'config_files': ('talos/mac_config.py',), 10:55:46 INFO - 'default_actions': ('clobber', 10:55:46 INFO - 'read-buildbot-config', 10:55:46 INFO - 'download-and-extract', 10:55:46 INFO - 'populate-webroot', 10:55:46 INFO - 'create-virtualenv', 10:55:46 INFO - 'install', 10:55:46 INFO - 'run-tests'), 10:55:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:55:46 INFO - 'download_minidump_stackwalk': True, 10:55:46 INFO - 'download_symbols': 'ondemand', 10:55:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:55:46 INFO - 'tooltool.py': '/tools/tooltool.py', 10:55:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:55:46 INFO - '/tools/misc-python/virtualenv.py')}, 10:55:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:55:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:55:46 INFO - 'installer_path': 'installer.exe', 10:55:46 INFO - 'log_level': 'info', 10:55:46 INFO - 'log_name': 'talos', 10:55:46 INFO - 'log_to_console': True, 10:55:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:55:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:55:46 INFO - 'opt_config_files': (), 10:55:46 INFO - 'pip_index': False, 10:55:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:55:46 INFO - 'cmd': ('bash', 10:55:46 INFO - '-c', 10:55:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:55:46 INFO - 'enabled': True, 10:55:46 INFO - 'halt_on_failure': False, 10:55:46 INFO - 'name': 'check_screen_resolution'},), 10:55:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:55:46 INFO - 'cmd': ('bash', 10:55:46 INFO - '-c', 10:55:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:55:46 INFO - 'enabled': True, 10:55:46 INFO - 'halt_on_failure': False, 10:55:46 INFO - 'name': 'check_screen_resolution'},), 10:55:46 INFO - 'run_cmd_checks_enabled': True, 10:55:46 INFO - 'sps_profile': False, 10:55:46 INFO - 'sps_profile_interval': 0, 10:55:46 INFO - 'suite': 'dromaeojs-e10s', 10:55:46 INFO - 'system_bits': '32', 10:55:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:55:46 INFO - 'title': 't-yosemite-r7-0078', 10:55:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:55:46 INFO - 'use_talos_json': True, 10:55:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:55:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:55:46 INFO - 'work_dir': 'build'} 10:55:46 INFO - ##### 10:55:46 INFO - ##### Running clobber step. 10:55:46 INFO - ##### 10:55:46 INFO - Running pre-action listener: _resource_record_pre_action 10:55:46 INFO - Running main action method: clobber 10:55:46 INFO - rmtree: /builds/slave/test/build 10:55:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:55:48 INFO - Running post-action listener: _resource_record_post_action 10:55:48 INFO - ##### 10:55:48 INFO - ##### Running read-buildbot-config step. 10:55:48 INFO - ##### 10:55:48 INFO - Running pre-action listener: _resource_record_pre_action 10:55:48 INFO - Running main action method: read_buildbot_config 10:55:48 INFO - Using buildbot properties: 10:55:48 INFO - { 10:55:48 INFO - "project": "", 10:55:48 INFO - "product": "firefox", 10:55:48 INFO - "script_repo_revision": "production", 10:55:48 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:55:48 INFO - "repository": "", 10:55:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:55:48 INFO - "buildid": "20160516203739", 10:55:48 INFO - "pgo_build": "False", 10:55:48 INFO - "basedir": "/builds/slave/test", 10:55:48 INFO - "buildnumber": 25, 10:55:48 INFO - "slavename": "t-yosemite-r7-0078", 10:55:48 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:55:48 INFO - "platform": "yosemite_r7", 10:55:48 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:55:48 INFO - "branch": "mozilla-beta", 10:55:48 INFO - "repo_path": "releases/mozilla-beta", 10:55:48 INFO - "revision": "b9598d922a0ba3957d4cf178a03b877d76354fb1", 10:55:48 INFO - "stage_platform": "macosx64", 10:55:48 INFO - "builduid": "35109f84dca34c5782941e77d47db877", 10:55:48 INFO - "slavebuilddir": "test" 10:55:48 INFO - } 10:55:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 10:55:48 INFO - Running post-action listener: _resource_record_post_action 10:55:48 INFO - ##### 10:55:48 INFO - ##### Running download-and-extract step. 10:55:48 INFO - ##### 10:55:48 INFO - Running pre-action listener: _resource_record_pre_action 10:55:48 INFO - Running main action method: download_and_extract 10:55:48 INFO - mkdir: /builds/slave/test/build/tests 10:55: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')]} 10:55:48 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:55:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:55:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:55:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/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 10:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/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 10:56:18 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json: timed out 10:56:18 INFO - retry: attempt #1 caught exception: timed out 10:56:18 INFO - retry: Failed, sleeping 30 seconds before retrying 10:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/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 #2 10:56:59 INFO - Downloaded 1241 bytes. 10:56:59 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:56:59 INFO - Using the following test package requirements: 10:56:59 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:56:59 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:59 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 10:56:59 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:59 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 10:56:59 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:56:59 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:59 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 10:56:59 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:56:59 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:59 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 10:56:59 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:59 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 10:56:59 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:59 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 10:56:59 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:56:59 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:59 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 10:56:59 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 10:56:59 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')]} 10:56:59 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:56:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:56:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:56:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/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 10:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/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 10:57:01 INFO - Downloaded 17747789 bytes. 10:57:01 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'] 10:57:01 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 10:57:04 INFO - Return code: 0 10:57:04 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 10:57:04 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')]} 10:57:04 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:57:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:57:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:57:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/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 10:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/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 10:57:05 INFO - Downloaded 17747789 bytes. 10:57:05 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'] 10:57:05 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 10:57:09 INFO - Return code: 0 10:57:09 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')]} 10:57:09 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:57:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:57:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:57:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/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 10:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/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 10:57:09 INFO - Downloaded 10845194 bytes. 10:57:09 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'] 10:57:09 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 10:57:10 INFO - Return code: 0 10:57:10 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')]} 10:57:10 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:57:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:57:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:57:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 10:57:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/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 10:57:12 INFO - Downloaded 88288778 bytes. 10:57:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:57:12 INFO - mkdir: /builds/slave/test/properties 10:57:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:57:12 INFO - Writing to file /builds/slave/test/properties/build_url 10:57:12 INFO - Contents: 10:57:12 INFO - build_url:https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:57:13 WARNING - Can't figure out symbols_url from installer_url: https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg! 10:57:13 INFO - Running post-action listener: _resource_record_post_action 10:57:13 INFO - Running post-action listener: set_extra_try_arguments 10:57:13 INFO - ##### 10:57:13 INFO - ##### Running populate-webroot step. 10:57:13 INFO - ##### 10:57:13 INFO - Running pre-action listener: _resource_record_pre_action 10:57:13 INFO - Running main action method: populate_webroot 10:57:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:57:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:57:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:57:13 INFO - '--tppagecycles', 10:57:13 INFO - '7'], 10:57:13 INFO - 'tests': ['tsvgm']}}, 10:57:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:57:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:57:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:57:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:57:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:57:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:57:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:13 INFO - 'talos_options': ['--e10s'], 10:57:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:13 INFO - 'tests': ['damp', 'tps']}, 10:57:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:13 INFO - 'talos_options': ['--e10s'], 10:57:13 INFO - 'tests': ['damp', 'tps']}, 10:57:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:57:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:57:13 INFO - 'other': {'tests': ['a11yr', 10:57:13 INFO - 'ts_paint', 10:57:13 INFO - 'tpaint', 10:57:13 INFO - 'sessionrestore', 10:57:13 INFO - 'sessionrestore_no_auto_restore', 10:57:13 INFO - 'tabpaint']}, 10:57:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:57:13 INFO - 'tests': ['a11yr', 10:57:13 INFO - 'ts_paint', 10:57:13 INFO - 'tpaint', 10:57:13 INFO - 'sessionrestore', 10:57:13 INFO - 'sessionrestore_no_auto_restore', 10:57:13 INFO - 'tabpaint']}, 10:57:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:57:13 INFO - 'tests': ['a11yr', 10:57:13 INFO - 'ts_paint', 10:57:13 INFO - 'tpaint', 10:57:13 INFO - 'sessionrestore', 10:57:13 INFO - 'sessionrestore_no_auto_restore', 10:57:13 INFO - 'tabpaint']}, 10:57:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:57:13 INFO - 'tests': ['a11yr', 10:57:13 INFO - 'ts_paint', 10:57:13 INFO - 'tpaint', 10:57:13 INFO - 'sessionrestore', 10:57:13 INFO - 'sessionrestore_no_auto_restore', 10:57:13 INFO - 'tabpaint']}, 10:57:13 INFO - 'other_l64': {'tests': ['a11yr', 10:57:13 INFO - 'ts_paint', 10:57:13 INFO - 'tpaint', 10:57:13 INFO - 'sessionrestore', 10:57:13 INFO - 'sessionrestore_no_auto_restore', 10:57:13 INFO - 'tabpaint']}, 10:57:13 INFO - 'other_nol64': {'tests': ['a11yr', 10:57:13 INFO - 'ts_paint', 10:57:13 INFO - 'tpaint', 10:57:13 INFO - 'sessionrestore', 10:57:13 INFO - 'sessionrestore_no_auto_restore', 10:57:13 INFO - 'tabpaint']}, 10:57:13 INFO - 'svgr': {'tests': ['tsvgx', 10:57:13 INFO - 'tsvgr_opacity', 10:57:13 INFO - 'tart', 10:57:13 INFO - 'tscrollx', 10:57:13 INFO - 'cart']}, 10:57:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:57:13 INFO - 'tests': ['tsvgx', 10:57:13 INFO - 'tsvgr_opacity', 10:57:13 INFO - 'tart', 10:57:13 INFO - 'tscrollx', 10:57:13 INFO - 'cart']}, 10:57:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:13 INFO - 'tests': ['tp5o']}, 10:57:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:13 INFO - 'talos_options': ['--e10s'], 10:57:13 INFO - 'tests': ['tp5o']}, 10:57:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:13 INFO - 'talos_options': ['--xperf_path', 10:57:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:13 INFO - 'tests': ['tp5n']}, 10:57:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:13 INFO - 'talos_options': ['--e10s', 10:57:13 INFO - '--xperf_path', 10:57:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:13 INFO - 'tests': ['tp5n']}}, 10:57:13 INFO - 'talos.zip': {'path': '', 10:57:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:57:13 INFO - Running post-action listener: _resource_record_post_action 10:57:13 INFO - ##### 10:57:13 INFO - ##### Running create-virtualenv step. 10:57:13 INFO - ##### 10:57:13 INFO - Running pre-action listener: _resource_record_pre_action 10:57:13 INFO - Running main action method: create_virtualenv 10:57:13 INFO - Creating virtualenv /builds/slave/test/build/venv 10:57:13 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 10:57:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:57:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:57:13 INFO - Using real prefix '/tools/python27' 10:57:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:57:14 INFO - Installing distribute.............................................................................................................................................................................................done. 10:57:17 INFO - Installing pip.................done. 10:57:17 INFO - Return code: 0 10:57:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:17 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 0x10c8eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e994b8340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c78ed30>, '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 0x10c5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c785b20>, '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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:57:17 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 10:57:17 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 10:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2vQO4KHr4v/Render', 10:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:17 INFO - 'HOME': '/Users/cltbld', 10:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:17 INFO - 'LOGNAME': 'cltbld', 10:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:17 INFO - 'MOZ_NO_REMOTE': '1', 10:57:17 INFO - 'NO_EM_RESTART': '1', 10:57:17 INFO - 'PAGER': '/bin/cat', 10:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:17 INFO - 'PWD': '/builds/slave/test', 10:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:17 INFO - 'SHELL': '/bin/bash', 10:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jpMHZ3yNq/Listeners', 10:57:17 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:17 INFO - 'USER': 'cltbld', 10:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:17 INFO - 'XPC_FLAGS': '0x0', 10:57:17 INFO - 'XPC_SERVICE_NAME': '0', 10:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:17 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 10:57:17 INFO - Cleaning up... 10:57:17 INFO - Return code: 0 10:57:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:17 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 0x10c8eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e994b8340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c78ed30>, '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 0x10c5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c785b20>, '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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:57:17 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 10:57:17 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 10:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2vQO4KHr4v/Render', 10:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:17 INFO - 'HOME': '/Users/cltbld', 10:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:17 INFO - 'LOGNAME': 'cltbld', 10:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:17 INFO - 'MOZ_NO_REMOTE': '1', 10:57:17 INFO - 'NO_EM_RESTART': '1', 10:57:17 INFO - 'PAGER': '/bin/cat', 10:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:17 INFO - 'PWD': '/builds/slave/test', 10:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:17 INFO - 'SHELL': '/bin/bash', 10:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jpMHZ3yNq/Listeners', 10:57:17 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:17 INFO - 'USER': 'cltbld', 10:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:17 INFO - 'XPC_FLAGS': '0x0', 10:57:17 INFO - 'XPC_SERVICE_NAME': '0', 10:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:17 INFO - Downloading/unpacking psutil>=0.7.1 10:57:17 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 10:57:17 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 10:57:17 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 10:57:17 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 10:57:17 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 10:57:17 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 10:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:57:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:21 INFO - Installing collected packages: psutil 10:57:21 INFO - Running setup.py install for psutil 10:57:21 INFO - building 'psutil._psutil_osx' extension 10:57:21 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 10:57:22 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 10:57:22 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 10:57:22 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 10:57:22 INFO - building 'psutil._psutil_posix' extension 10:57:22 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 10:57:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:57:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:57:22 INFO - ^ 10:57:22 INFO - 1 warning generated. 10:57:22 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 10:57:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:22 INFO - Successfully installed psutil 10:57:22 INFO - Cleaning up... 10:57:22 INFO - Return code: 0 10:57:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:57: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')]} 10:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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')]} 10:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c8eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e994b8340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c78ed30>, '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 0x10c5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c785b20>, '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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:57:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2vQO4KHr4v/Render', 10:57:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:22 INFO - 'HOME': '/Users/cltbld', 10:57:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:22 INFO - 'LOGNAME': 'cltbld', 10:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:22 INFO - 'MOZ_NO_REMOTE': '1', 10:57:22 INFO - 'NO_EM_RESTART': '1', 10:57:22 INFO - 'PAGER': '/bin/cat', 10:57:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:22 INFO - 'PWD': '/builds/slave/test', 10:57:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:22 INFO - 'SHELL': '/bin/bash', 10:57:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jpMHZ3yNq/Listeners', 10:57:22 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:57:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:22 INFO - 'USER': 'cltbld', 10:57:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:22 INFO - 'XPC_FLAGS': '0x0', 10:57:22 INFO - 'XPC_SERVICE_NAME': '0', 10:57:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:57:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:57:25 INFO - Installing collected packages: mozsystemmonitor 10:57:25 INFO - Running setup.py install for mozsystemmonitor 10:57:25 INFO - Successfully installed mozsystemmonitor 10:57:25 INFO - Cleaning up... 10:57:25 INFO - Return code: 0 10:57:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:25 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 0x10c8eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e994b8340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c78ed30>, '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 0x10c5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c785b20>, '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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:57:25 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 10:57:25 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 10:57:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2vQO4KHr4v/Render', 10:57:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:25 INFO - 'HOME': '/Users/cltbld', 10:57:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:25 INFO - 'LOGNAME': 'cltbld', 10:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:25 INFO - 'MOZ_NO_REMOTE': '1', 10:57:25 INFO - 'NO_EM_RESTART': '1', 10:57:25 INFO - 'PAGER': '/bin/cat', 10:57:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:25 INFO - 'PWD': '/builds/slave/test', 10:57:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:25 INFO - 'SHELL': '/bin/bash', 10:57:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jpMHZ3yNq/Listeners', 10:57:25 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:57:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:25 INFO - 'USER': 'cltbld', 10:57:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:25 INFO - 'XPC_FLAGS': '0x0', 10:57:25 INFO - 'XPC_SERVICE_NAME': '0', 10:57:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:25 INFO - Downloading/unpacking blobuploader==1.2.4 10:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:28 INFO - Downloading blobuploader-1.2.4.tar.gz 10:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:57:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:57:28 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 10:57:28 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 10:57:28 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 10:57:28 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 10:57:28 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 10:57:28 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 10:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:57:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:57:29 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 10:57:29 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 10:57:29 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 10:57:29 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 10:57:29 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 10:57:29 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 10:57:29 INFO - Downloading docopt-0.6.1.tar.gz 10:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:57:29 INFO - Installing collected packages: blobuploader, requests, docopt 10:57:29 INFO - Running setup.py install for blobuploader 10:57:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:57:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:57:29 INFO - Running setup.py install for requests 10:57:30 INFO - Running setup.py install for docopt 10:57:30 INFO - Successfully installed blobuploader requests docopt 10:57:30 INFO - Cleaning up... 10:57:30 INFO - Return code: 0 10:57:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:30 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')]} 10:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:30 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')]} 10:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:30 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 0x10c8eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e994b8340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c78ed30>, '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 0x10c5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c785b20>, '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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:57:30 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 10:57:30 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 10:57:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2vQO4KHr4v/Render', 10:57:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:30 INFO - 'HOME': '/Users/cltbld', 10:57:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:30 INFO - 'LOGNAME': 'cltbld', 10:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:30 INFO - 'MOZ_NO_REMOTE': '1', 10:57:30 INFO - 'NO_EM_RESTART': '1', 10:57:30 INFO - 'PAGER': '/bin/cat', 10:57:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:30 INFO - 'PWD': '/builds/slave/test', 10:57:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:30 INFO - 'SHELL': '/bin/bash', 10:57:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jpMHZ3yNq/Listeners', 10:57:30 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:57:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:30 INFO - 'USER': 'cltbld', 10:57:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:30 INFO - 'XPC_FLAGS': '0x0', 10:57:30 INFO - 'XPC_SERVICE_NAME': '0', 10:57:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:30 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-XvXg1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:30 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-fBM2_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:30 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-r9HLng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:31 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-afzu9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:31 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Rk5oSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:31 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-MTomU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:31 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-iVwgbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:31 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-IKOK6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:31 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-jnETvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:31 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-4GLpER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:31 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-fcVn5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:31 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7XkeB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:31 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-pZ90wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-1CDFnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-qStA1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-qHVG11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-TrnByE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:57:32 INFO - Running setup.py install for manifestparser 10:57:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:57:32 INFO - Running setup.py install for mozcrash 10:57:32 INFO - Running setup.py install for mozdebug 10:57:32 INFO - Running setup.py install for mozdevice 10:57:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:57:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:57:33 INFO - Running setup.py install for mozfile 10:57:33 INFO - Running setup.py install for mozhttpd 10:57:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:57:33 INFO - Running setup.py install for mozinfo 10:57:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:57:33 INFO - Running setup.py install for mozInstall 10:57:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:57:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:57:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:57:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:57:33 INFO - Running setup.py install for mozleak 10:57:33 INFO - Running setup.py install for mozlog 10:57:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:57:33 INFO - Running setup.py install for moznetwork 10:57:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:57:34 INFO - Running setup.py install for mozprocess 10:57:34 INFO - Running setup.py install for mozprofile 10:57:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:57:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:57:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:57:34 INFO - Running setup.py install for mozrunner 10:57:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:57:34 INFO - Running setup.py install for mozscreenshot 10:57:34 INFO - Running setup.py install for moztest 10:57:34 INFO - Running setup.py install for mozversion 10:57:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:57:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:57:34 INFO - Cleaning up... 10:57:35 INFO - Return code: 0 10:57:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:35 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 0x10c8eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e994b8340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c78ed30>, '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 0x10c5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c785b20>, '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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:57:35 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 10:57:35 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 10:57:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2vQO4KHr4v/Render', 10:57:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:35 INFO - 'HOME': '/Users/cltbld', 10:57:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:35 INFO - 'LOGNAME': 'cltbld', 10:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:35 INFO - 'MOZ_NO_REMOTE': '1', 10:57:35 INFO - 'NO_EM_RESTART': '1', 10:57:35 INFO - 'PAGER': '/bin/cat', 10:57:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:35 INFO - 'PWD': '/builds/slave/test', 10:57:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:35 INFO - 'SHELL': '/bin/bash', 10:57:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jpMHZ3yNq/Listeners', 10:57:35 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:57:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:35 INFO - 'USER': 'cltbld', 10:57:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:35 INFO - 'XPC_FLAGS': '0x0', 10:57:35 INFO - 'XPC_SERVICE_NAME': '0', 10:57:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:35 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-8hgVBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:35 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)) 10:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:35 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ZJsBRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:35 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)) 10:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:35 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7LnhH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:35 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)) 10:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:35 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-acpJPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:35 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)) 10:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:35 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ng35ZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:35 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)) 10:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:35 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-GPqIfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:35 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)) 10:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:35 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-RHz2rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:36 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)) 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-_YZCNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:36 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)) 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-VNuvKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:36 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)) 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-TGufZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:36 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)) 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-PzFOCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:36 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)) 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-F74FMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:36 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)) 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-LZuhO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:36 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)) 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ec9EuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:36 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)) 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-aMc7WM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:36 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)) 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-1aj5Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:36 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)) 10:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-SLsCtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:37 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)) 10:57:37 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)) 10:57:37 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)) 10:57:37 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)) 10:57:37 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)) 10:57:37 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)) 10:57:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:57:37 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 10:57:37 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 10:57:37 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 10:57:37 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 10:57:37 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 10:57:37 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 10:57:39 INFO - Downloading blessings-1.6.tar.gz 10:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:57:39 INFO - Installing collected packages: blessings 10:57:39 INFO - Running setup.py install for blessings 10:57:39 INFO - Successfully installed blessings 10:57:39 INFO - Cleaning up... 10:57:39 INFO - Return code: 0 10:57:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:40 INFO - Reading from file tmpfile_stdout 10:57:40 INFO - Current package versions: 10:57:40 INFO - blessings == 1.6 10:57:40 INFO - blobuploader == 1.2.4 10:57:40 INFO - docopt == 0.6.1 10:57:40 INFO - manifestparser == 1.1 10:57:40 INFO - mozInstall == 1.12 10:57:40 INFO - mozcrash == 0.17 10:57:40 INFO - mozdebug == 0.1 10:57:40 INFO - mozdevice == 0.48 10:57:40 INFO - mozfile == 1.2 10:57:40 INFO - mozhttpd == 0.7 10:57:40 INFO - mozinfo == 0.9 10:57:40 INFO - mozleak == 0.1 10:57:40 INFO - mozlog == 3.1 10:57:40 INFO - moznetwork == 0.27 10:57:40 INFO - mozprocess == 0.22 10:57:40 INFO - mozprofile == 0.28 10:57:40 INFO - mozrunner == 6.11 10:57:40 INFO - mozscreenshot == 0.1 10:57:40 INFO - mozsystemmonitor == 0.0 10:57:40 INFO - moztest == 0.7 10:57:40 INFO - mozversion == 1.4 10:57:40 INFO - psutil == 3.1.1 10:57:40 INFO - requests == 1.2.3 10:57:40 INFO - wsgiref == 0.1.2 10:57:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:40 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 0x10c8eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e994b8340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c78ed30>, '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 0x10c5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c785b20>, '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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:57:40 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 10:57:40 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 10:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2vQO4KHr4v/Render', 10:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:40 INFO - 'HOME': '/Users/cltbld', 10:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:40 INFO - 'LOGNAME': 'cltbld', 10:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:40 INFO - 'MOZ_NO_REMOTE': '1', 10:57:40 INFO - 'NO_EM_RESTART': '1', 10:57:40 INFO - 'PAGER': '/bin/cat', 10:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:40 INFO - 'PWD': '/builds/slave/test', 10:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:40 INFO - 'SHELL': '/bin/bash', 10:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jpMHZ3yNq/Listeners', 10:57:40 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:40 INFO - 'USER': 'cltbld', 10:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:40 INFO - 'XPC_FLAGS': '0x0', 10:57:40 INFO - 'XPC_SERVICE_NAME': '0', 10:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:40 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)) 10:57:40 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)) 10:57:40 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)) 10:57:40 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)) 10:57:40 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)) 10:57:40 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)) 10:57:40 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)) 10:57:40 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)) 10:57:40 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)) 10:57:40 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)) 10:57:40 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)) 10:57:40 INFO - Cleaning up... 10:57:40 INFO - Return code: 0 10:57:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:40 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 0x10c8eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e994b8340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c78ed30>, '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 0x10c5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c785b20>, '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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:57:40 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 10:57:40 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 10:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2vQO4KHr4v/Render', 10:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:40 INFO - 'HOME': '/Users/cltbld', 10:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:40 INFO - 'LOGNAME': 'cltbld', 10:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:40 INFO - 'MOZ_NO_REMOTE': '1', 10:57:40 INFO - 'NO_EM_RESTART': '1', 10:57:40 INFO - 'PAGER': '/bin/cat', 10:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:40 INFO - 'PWD': '/builds/slave/test', 10:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:40 INFO - 'SHELL': '/bin/bash', 10:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jpMHZ3yNq/Listeners', 10:57:40 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:40 INFO - 'USER': 'cltbld', 10:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:40 INFO - 'XPC_FLAGS': '0x0', 10:57:40 INFO - 'XPC_SERVICE_NAME': '0', 10:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:40 INFO - Downloading/unpacking jsonschema 10:57:40 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 10:57:40 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 10:57:40 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 10:57:40 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 10:57:40 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 10:57:40 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 10:57:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:57:43 INFO - Downloading/unpacking functools32 (from jsonschema) 10:57:43 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 10:57:43 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 10:57:43 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 10:57:43 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 10:57:43 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 10:57:43 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 10:57:43 INFO - Downloading functools32-3.2.3-2.tar.gz 10:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:57:43 INFO - warning: no files found matching '*.txt' 10:57:43 INFO - no previously-included directories found matching 'build' 10:57:43 INFO - no previously-included directories found matching 'dist' 10:57:43 INFO - no previously-included directories found matching '.git*' 10:57:43 INFO - Installing collected packages: jsonschema, functools32 10:57:43 INFO - Running setup.py install for functools32 10:57:43 INFO - warning: no files found matching '*.txt' 10:57:43 INFO - no previously-included directories found matching 'build' 10:57:43 INFO - no previously-included directories found matching 'dist' 10:57:43 INFO - no previously-included directories found matching '.git*' 10:57:43 INFO - Successfully installed jsonschema functools32 10:57:43 INFO - Cleaning up... 10:57:43 INFO - Return code: 0 10:57:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e994b8340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c78ed30>, '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 0x10c5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c785b20>, '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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:57:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:57:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2vQO4KHr4v/Render', 10:57:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:43 INFO - 'HOME': '/Users/cltbld', 10:57:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:43 INFO - 'LOGNAME': 'cltbld', 10:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:43 INFO - 'MOZ_NO_REMOTE': '1', 10:57:43 INFO - 'NO_EM_RESTART': '1', 10:57:43 INFO - 'PAGER': '/bin/cat', 10:57:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:43 INFO - 'PWD': '/builds/slave/test', 10:57:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:43 INFO - 'SHELL': '/bin/bash', 10:57:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jpMHZ3yNq/Listeners', 10:57:43 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:57:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:43 INFO - 'USER': 'cltbld', 10:57:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:43 INFO - 'XPC_FLAGS': '0x0', 10:57:43 INFO - 'XPC_SERVICE_NAME': '0', 10:57:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:44 INFO - Downloading/unpacking flake8 10:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:57:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:57:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:57:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:47 INFO - no previously-included directories found matching 'docs/_build' 10:57:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:57:47 INFO - Running setup.py install for pep8 10:57:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:48 INFO - no previously-included directories found matching 'docs/_build' 10:57:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:57:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:57:48 INFO - Cleaning up... 10:57:48 INFO - Return code: 0 10:57:48 INFO - Running post-action listener: _resource_record_post_action 10:57:48 INFO - Running post-action listener: _start_resource_monitoring 10:57:48 INFO - Starting resource monitoring. 10:57:48 INFO - ##### 10:57:48 INFO - ##### Running install step. 10:57:48 INFO - ##### 10:57:48 INFO - Running pre-action listener: _resource_record_pre_action 10:57:48 INFO - Running main action method: install 10:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:48 INFO - Reading from file tmpfile_stdout 10:57:48 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:57:48 INFO - Reading from file tmpfile_stdout 10:57:48 INFO - Output received: 10:57:48 INFO - Usage: mozinstall [options] installer 10:57:48 INFO - Options: 10:57:48 INFO - -h, --help show this help message and exit 10:57:48 INFO - -d DEST, --destination=DEST 10:57:48 INFO - Directory to install application into. [default: 10:57:48 INFO - "/builds/slave/test"] 10:57:48 INFO - --app=APP Application being installed. [default: firefox] 10:57:48 INFO - mkdir: /builds/slave/test/build/application 10:57:48 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'] 10:57:48 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 10:58:11 INFO - Reading from file tmpfile_stdout 10:58:11 INFO - Output received: 10:58:11 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:58:11 INFO - Running post-action listener: _resource_record_post_action 10:58:11 INFO - ##### 10:58:11 INFO - ##### Running run-tests step. 10:58:11 INFO - ##### 10:58:11 INFO - Running pre-action listener: _resource_record_pre_action 10:58:11 INFO - Running main action method: run_tests 10:58:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:58:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:58:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:58:11 INFO - 2016-05-17 10:58:11.534 screenresolution[1652:8749] starting screenresolution argv=screenresolution get 10:58:11 INFO - 2016-05-17 10:58:11.536 screenresolution[1652:8749] Display 0: 1600x1200x32@60 10:58:11 INFO - 2016-05-17 10:58:11.542 screenresolution[1653:8751] starting screenresolution argv=screenresolution list 10:58:11 INFO - Available Modes on Display 0 10:58:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:58:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:58:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:58:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:58:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:58:11 INFO - Intel Iris: 10:58:11 INFO - Chipset Model: Intel Iris 10:58:11 INFO - Type: GPU 10:58:11 INFO - Bus: Built-In 10:58:11 INFO - VRAM (Dynamic, Max): 1536 MB 10:58:11 INFO - Vendor: Intel (0x8086) 10:58:11 INFO - Device ID: 0x0a2e 10:58:11 INFO - Revision ID: 0x0009 10:58:11 INFO - Displays: 10:58:11 INFO - Display: 10:58:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:58:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:58:11 INFO - Display Serial Number: 1600x1200 60 10:58:11 INFO - Main Display: Yes 10:58:11 INFO - Mirror: Off 10:58:11 INFO - Online: Yes 10:58:11 INFO - Rotation: Supported 10:58:11 INFO - Return code: 0 10:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:58:11 INFO - Python 2.7.3 10:58:11 INFO - Return code: 0 10:58:11 INFO - grabbing minidump binary from tooltool 10:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:11 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 0x10c78ed30>, '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 0x10c5f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c785b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:58:11 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 10:58:11 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 10:58:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:58:11 INFO - Return code: 0 10:58:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:58:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:58:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:58:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:58:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:58:13 INFO - Return code: 0 10:58:13 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', '--title', 't-yosemite-r7-0078', '--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 10:58:13 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 --title t-yosemite-r7-0078 --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 10:58:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2vQO4KHr4v/Render', 10:58:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:58:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:58:13 INFO - 'HOME': '/Users/cltbld', 10:58:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:58:13 INFO - 'LOGNAME': 'cltbld', 10:58:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:58:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:13 INFO - 'MOZ_NO_REMOTE': '1', 10:58:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:58:13 INFO - 'NO_EM_RESTART': '1', 10:58:13 INFO - 'PAGER': '/bin/cat', 10:58:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:13 INFO - 'PWD': '/builds/slave/test', 10:58:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:58:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:58:13 INFO - 'SHELL': '/bin/bash', 10:58:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jpMHZ3yNq/Listeners', 10:58:13 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:58:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:58:13 INFO - 'USER': 'cltbld', 10:58:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:58:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:13 INFO - 'XPC_FLAGS': '0x0', 10:58:13 INFO - 'XPC_SERVICE_NAME': '0', 10:58:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:58:13 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', '--title', 't-yosemite-r7-0078', '--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 10:58:13 INFO - mozversion application_buildid: 20160516203739 10:58:13 INFO - mozversion application_changeset: b9598d922a0ba3957d4cf178a03b877d76354fb1 10:58:13 INFO - mozversion application_display_name: Firefox 10:58:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:58:13 INFO - mozversion application_name: Firefox 10:58:13 INFO - mozversion application_remotingname: firefox 10:58:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:58:13 INFO - mozversion application_vendor: Mozilla 10:58:13 INFO - mozversion application_version: 47.0 10:58:13 INFO - mozversion platform_buildid: 20160516203739 10:58:13 INFO - mozversion platform_changeset: b9598d922a0ba3957d4cf178a03b877d76354fb1 10:58:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:58:13 INFO - mozversion platform_version: 47.0 10:58:13 INFO - using testdate: 1463507893 10:58:13 INFO - actual date: 1463507893 10:58:13 INFO - starting webserver on 'localhost:49283' 10:58:13 INFO - SUITE-START | Running 2 tests 10:58:13 INFO - TEST-START | dromaeo_css 10:58:13 INFO - operating with platform_type : mac_ 10:58:13 INFO - Initialising browser for dromaeo_css test... 10:58:13 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpiVuoXZ/profile http://localhost:49283/getInfo.html) 10:58:16 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 10:58:16 INFO - PROCESS | 1671 | colorDepth:24 10:58:16 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 10:58:16 INFO - PROCESS | 1671 | __metrics 10:58:16 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 10:58:16 INFO - TEST-INFO | 1671: exit 0 10:58:16 INFO - Browser initialized. 10:58:16 INFO - Running cycle 1/1 for dromaeo_css test... 10:58:16 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpiVuoXZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:28 INFO - PROCESS | 1676 | RSS: Main: 167911424 10:58:28 INFO - PROCESS | 1676 | 10:59:18 INFO - PROCESS | 1676 | 1463507958484 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:01:28 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 11:01:30 INFO - PROCESS | 1676 | RSS: Main: 178597888 11:01:30 INFO - PROCESS | 1676 | 11:04:32 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 11:04:32 INFO - PROCESS | 1676 | RSS: Main: 189956096 11:04:32 INFO - PROCESS | 1676 | 11:07:34 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 11:07:34 INFO - PROCESS | 1676 | RSS: Main: 192499712 11:07:34 INFO - PROCESS | 1676 | 11:10:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 11:10:37 INFO - PROCESS | 1676 | RSS: Main: 195338240 11:10:37 INFO - PROCESS | 1676 | 11:13:39 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 11:13:40 INFO - PROCESS | 1676 | RSS: Main: 194629632 11:13:40 INFO - PROCESS | 1676 | 11:16:42 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 11:16:42 INFO - PROCESS | 1676 | RSS: Main: 199790592 11:16:42 INFO - PROCESS | 1676 | 11:16:42 INFO - PROCESS | 1676 | __start_tp_report 11:16:42 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 11:16:42 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 11:16:42 INFO - PROCESS | 1676 | |i|pagename|runs| 11:16:42 INFO - PROCESS | 1676 | |0;dojo.html;3660.871869484568;3709.51776269085;3741.7380783345143;3764.34124028295;3770.547534295884;5993.760249590022;6079.483243924261;6081.908771368428;6098.207233059701;6113.969430152849;6016.338202797689;6077.209962704842;6080.543959203066;6092.634441933487;6104.145419641254;5340.786368545254;5383.757730902119;5418.756155972971;5458.4814442627885;5490.752916118784;4260.552641972595;5441.29263195786;5459.235707001023;5515.586331025169;5546.584006199531;4334.783260836962;5436.510714035736;5441.455854414567;5457.126859702448;5475.178723191513;4081.7755023473696;5363.651362661414;5392;5438.673679579238;5442.564594832404;5292.311999440087;5292.973535132338;5366.114591092465;5377.274068000848;5388.892222155574;5788.710564471759;5855.677937713424;5909.881802363929;5939.227900372967;6002.249718785152;5665.801696940628;6231.9688401557705;6254.0618907163835;6302.306746257908;6315.557910946236;6019.909701354483;6423.8394040148905;6434.774782882623;6483.513736469784;6511.8697626047215;6166.568340216142;6176.96911515444;6179.876402471926;6187.102870083902;6189;6333.65164915934;6591.670416479157;6602.2737498875085;6604.702788374535;6611.63636000015;6241.18864547615;6274.717637706314;6315.494760419156;6317.1156038154695;6336.303006669263;5373.946260537345;6381.776637817654;6403.871922561522;6441.066045423388;6450.0647406125845;6075.817725468243;6265.060240963892;6275.184226050585;6321.431071203614;6336.52476064297;6215.9378406216265;6322.652254125976;6328.778492752732;6329;6342.5243106767175;3793.525809273841;4986.601071914238;5037.3955125384455;5037.974810125999;5061.240813877947;4517.412736344254;4547.454305483363;4584.426946631671;4590.8163673453355;4610.331501932268;6092.268927728701;6142.928535732134;6193.411625895533;6243.063540468966;6251.531135164881;5305.31030965972;6332.271788744353;6407.295197528269;6434.163558737334;6434.388733070351;5184.974075129676;5381.54256888161;6056.152138700585;6250.718717657716;6251.281102673251;4931.939632978927;5559.277293951841;5578.023845826964;5617.9719101404235;5655.066913959151;6649.235337936103;6669.63317017559;6679.799606011828;6686.297938716365;6691.531592788653;6342.587731797418;6430.196225471816;6487.124238227779;6491.902621460587;6512.3162067982175;6636.27001029896;6667.833304167435;6688.197416310074;6688.230853451915;6718.764843230463;6373.74505019794;6389.9041514376395;6401.423871851555;6406.935930640634;6409.455196308179;6229.314775374796;6376.776812811529;6420.711068001858;6436.8390790230615;6443.613383197023;6290.496760259077;6293.465055470337;6303.873922521616;6320.494360451061;6321.431071203614;6035.78874739382;6282.403171698681;6289.49684025286;6296.590721603081;6334.619922804646;6142.508599312134;6152.477039451696;6209.658468784261;6220.937790622036;6235.906461402992;6248.531360148098;6254.343293954069;6293.118963345227;6294.748210071546;6295;6238.500919926486;6251.124842521959;6306.432421082125;6315.052742088724;6319 11:16:42 INFO - PROCESS | 1676 | |1;ext.html;519.3170980161088;597.5309382135022;603.7222877476361;606.6936197220408;623.429561950815;39950.40074398883;40710.38934415986;40813.7959310203;40835.795821020925;40855;41993.95015124624;42574.78712606433;42614.786926065404;42802.14395712084;42807.571924280746;9608.567614457366;9785.755356116082;9833.360831545926;9863.60545578176;9877.308588398815;9569.569369378394;9866.309358344919;9870.60517579296;9928.354656947311;9959.352642078278;8959.776005599848;9777.41335519871;9829.066238707312;9912.256580756437;9965.551550180224;9828.852567211497;9875.407475551454;9895.257855660855;9905.801883962316;9911.306208565404;9838.557264923096;9928.751781205456;9938.055884690943;9986.650467233685;10018.998100189996;40746.38880416796;40811.38782918229;41217;41399.379009314885;41432.37851432231;2922.853857307126;2977.523596224615;3307.966920330814;3365.74756893234;3550.9879684289854;24104.397390065213;30015.849920750476;30049.549256761165;30384.84807575948;31248.21879453032;2736.220177249494;2800.621916041329;2800.929976750577;2826.547752359613;2962.155785601115;568702;588008;589082;593119.9999999957;593821;48821;70094.64952675204;70683.64658176676;71103;71182.64408677924;47093;47770.04459910852;47825.76087119542;47997.280040799415;48056;16769.916150419413;16807.075610841275;17062.658746824993;17266;17366.65266694659;13715.45138194481;14141.929290353482;14144.929275353557;14154.292285385689;14246.786298205536;14989.625259368386;15427.614309642124;15756.448524301595;15824.92087539555;15849.445269415515;6517.739290428424;6558.376954189344;6646.6676666166495;6684.598924064571;6713.1944166700305;960.6301573893961;1057.619257067455;1094.2887123369874;1098.6099934523288;1136.1989797193125;30663.08010759636;30754.53868191979;31324.843375782973;31541.52687709686;31547.526787098213;1174.6593487888588;1181.6041626055196;1198.7902117129468;1238.54173955637;1298.3914262422386;15539.30073146711;15679;15868;15948.2823272953;15952.122633255283;527562;534347;535229;535682;536331;61756;62852.37147628557;63266.683666581375;63273.68363158247;63311.36688633147;1529.5946574157856;1565.0296815974168;1567.0597641415288;1573.244842475618;1575.558843523815;29829.70170298356;30974.84512577513;32604.673953261114;32680.67319326776;32733.18167045843;56711.71644141753;57203.141952869904;57704;58042.709786450796;58188.4181158183;443820;450687;456335;457344;457635;38874;45893;46657.76671116623;47599.762001189774;47718.761406194135;49141;49233.2615010768;49608;50295.245571317195;50368.496315036384;39233.803830980665;39917.401238980856;40741.796291018356;41125.383119252634;41605.58394416017;33235.83382083074;38651.61348386593;40595;40838.59161408467;41470.79264603658;31802.681973180897;32988;35647.28705425929;40805.38791918183;41397.379039315034;31758.52362214615;33129.83435082809;33419.66580334165;33460;33467.99596012123;25426.2201645883;25441.61837572475;25767.840447179547;25910.35224119412;26022.73977260203 11:16:42 INFO - PROCESS | 1676 | |2;jquery.html;375.9567649720281;383.7735735915809;384.4060925869533;384.4156881540059;386.2564563215809;17616;18810.2475900964;19509.512262193453;20835.374938751826;21577.784222157774;21642.458938526546;22079.33761987139;22241.2215572455;22348.664770028423;22646.320610381714;5932.466078052975;6125.816225513219;6179.196704428418;6206.162168107293;6207.379262073801;4542.704724192917;5295.867603309909;6475.83810404739;6668.499862510307;6751.628660423675;6672.76645317414;6764.154480689914;6765.830854228634;6795.388415042645;6806.727730890759;5678.4605462480995;5813.563982701272;5924.792632257871;5934.050551911673;5947.1971283876555;5566.387697353288;5598.272224610815;5669.262995810518;5670.979223739725;5686.0617998030275;13430.529931452353;13762.793558096637;13800.240986745725;21774.564508709896;25120.497590048097;2126.202673997251;2128.7445506539316;2213.966790498144;2372.857628542293;2618.8428694278405;8690.130986901322;10107.545160467724;10585.73535661607;10635.096016838577;10793.460326983619;1796.083997161444;1806.3226290141197;1815.2557451444843;1879.8872067675984;1927.6433859735994;108031;113545.43227283811;114459;114706;118390.63218735578;11667;11721.648350549498;11999.280043197261;12021;12028.699282518008;14294.356753946098;14537.418503259963;14570.05294655844;14589.41642334316;14592.927035364755;7725.918371428004;8844.027157012852;8969.327300452493;9031.916170059634;9082.500462474627;9140.405873618194;9175.954120229357;9193.678221262357;9236.261099112055;9287.62849486013;4493.775311234425;4505.819767209275;4539.773011349419;4558.566936141061;4606.470255920612;1810.6831304521656;1880.9247630094642;1905.1046008376318;1955.8141976512209;1961.4115765270362;969.3844408800462;1015.1624909449733;1094.141099237111;1104.4312179227704;1108.9354219948939;19438;19603.705944410845;19853.801461985484;20072.799272007385;20233.24925704873;987.3434166279487;1000.7998400319965;1018.3787889387615;1020.0819262663662;1116.8715597706368;8655.956720216485;10839.566417343376;10920;11027.117830573536;11076.39079850616;655059;665225;687682;694617;696327;112726;117371;117799;120105;123769;1037.4397825174321;1054.46222426563;1060.437967877011;1079.865016872891;1085.9511321990528;18194.772453240083;18474.907625461787;18763.530911727317;18830.3409380671;19022.524436889187;38872;41017.99999999881;52595.474045259056;53862.46137538574;56860.715696421255;70740;72506.63746681233;74013;74454.2554574469;77288.61355693186;7117;8231.382646301432;8245.628946697532;8373.37199710012;8409.62156702962;7565.735199268;10136.935621759609;10188.032136946978;12854.228746275254;13784.966127540274;9496.620135194791;11882.881171188523;11916.642500724645;12096.818547721616;12116.21244619097;9815.803683926139;11725.41372931367;11751.706207344885;11756.647300580997;11816.645500634995;11942.104342174545;11989.100817438553;12310.938445307716;12334.876651233373;12497.312647804458;8139.83720325602;8315.12691167443;8317.542535160383;8416.789580260542;8766.736997890073;8734.82530349402;10120.544575494268;10785.083267922315;11691.298522088362;11959.342236177094 11:16:42 INFO - PROCESS | 1676 | |3;mootools.html;1657.2211060801424;1663.9833601663984;1822.6263615958721;2042.8161465468104;2079.854410191287;8381.036180839204;9043.593038313275;9045.773855653611;9260.073992600737;9279.76800579985;7548.622568871562;9013.278937684985;9026.052264512231;9101.544922753868;9114.179723824855;2542.148380292604;2549.4773571417863;2550.2094350751236;2573.5367633825904;2586.961195582068;2474.072222916406;2537.6827896512937;2541.796656267494;2547.1594373856674;2554.859482728449;2511.635812807142;2554.9872250638723;2560.2831207261997;2561.666983292179;2578.5358635445614;2521.508305880345;2534.531111744333;2539.5555777738823;2556.297018319958;2560.8463492190526;2544.1604270590847;2558.513882362345;2568.4734629401114;2571.215779187347;2596.857172855492;8962.82074358509;9068.183863452321;9104.908950910472;9115.316351273681;9145.771355716093;5617.325920889479;5619.719014049322;5663.263775709132;5806.65160090396;5819.709014549256;3542.557180352456;3744.0452684565535;3763.8118094095184;3768.717346199046;3783.375743002401;1065.6696424108552;1080.0333701337258;1082.1018554599664;1098.1653943003296;1099.4997276239292;11947.745486723856;12164.270143791313;12173.96521295682;12299;12310.95356894665;5016.949830501649;5028.34631497903;5168.457311982263;5178.741062946838;5202.895942081137;10304.536295866705;10392.792144157074;10511.1591072714;10542.998415150549;10549.050585447347;5023.924641130386;5511.421300763443;5625.071863142617;5631.493165615114;5752.453516915886;4703.388559487314;5087.135187018216;5182.093133701663;5196.376434827769;5217.817376391884;4006.092168615517;4134.421181034598;4137.482814648169;4155.314373128461;4158.295099009391;1339.733951415922;1381.1643955407035;1389.867962543577;1390.450771945076;1391.930403479822;1423.4021710881455;1423.9715205695827;1438.1443041390355;1459.839417664056;1488.9553313400615;8227.095019547845;8235.917640823514;8330.875036874451;8412.957935210285;8420.53687047206;519.8362515807509;528.5058470330254;530.4589318894783;535.8821059366933;537.6773935638664;6220.25356957159;6239.220097487814;6312.652804095819;6360.745570177233;6387.489000879918;10861;11115.333080015225;11143.275687080313;11202.607908723156;11209;10642.787144257227;10779;10905.618303359344;10983.286086404358;11049.116070714324;8602.483850968962;8746.956265218632;8783.121687831166;8788.340874434443;8791.164839340252;7926.128125906031;8005.359571234404;8086.110527841815;8150.510969341858;8171.591420428836;9688.515574221401;9875.40747555149;9899.851502227328;9922.950385248028;10102.848457273294;8847.778805529655;10172.237082219011;10348.482575871327;10364.274500785174;10382.221333399873;7555.244475552401;7605.125410577854;7619.619019048914;7633.31300182964;7702.268284512962;8349.37379696513;8378.58107094655;8474.110218426977;8484.278836298983;8557.57212139403;7491.513051651626;7616.3906887447765;7656.042994625672;7707.11368192665;7734.690612375442;7412.444066695128;7500.849983000418;7516.135644400964;7609;7617;7973.681052757825;8032.59837008159;8075.152109028468;8113.7565873023905;8119.512829230265;7210.098737657793;7273.199948005821;7290.9635451822405;7297.781066568012;7298.671559779928;7333.303336183054;7377.336039756233;7390.556566606021;7398.778036658909;7415.036045314075 11:16:42 INFO - PROCESS | 1676 | |4;prototype.html;338.96610338966104;340.2310777642528;342.06615938487914;344.8310327939309;349.45485043332394;6952.2700116487795;6980.092587963564;7007.01901733757;7019.368256856882;7029.226785053653;6990.126234220723;7003.19463261725;7003.859922801541;7015.088038554981;7022.789316320519;4916.926246106311;4957.934044180501;4979.053979743855;5099.991005306868;5188.688678679291;4358.65130789536;5127.128388174019;5154.020736060155;5162.251473536335;5165.070287348276;3962.9009274768073;4821.758912054401;5025.673331233476;5080.415752188509;5121.462246464123;3924.3917192835015;4048.5951404859425;5123.257127716461;5127.769250383723;5140.974295128501;3803.353429916921;4395.252807022814;4407.779611019436;4412.492563355191;4418.845340413102;6426.389492998158;6645.800625981228;6701.631410272433;6710.865782684319;6716.764913228014;5983.551233657449;6018.097285407181;6022.006368949118;6037.30570984338;6065.090236464522;7418.925810741932;7422.554646721214;7433.070866141732;7445.957565940773;7450.18048014718;4920.630952678528;4923.163062279421;4925.926111108336;4934.629902757308;4943.2585112233455;7611.847763044708;7866.095399029127;7881.684732610689;7882.487638303549;7899.289063984269;4975.925361119586;5005.674631148963;5012.824551140692;5015.974920125449;5018.824341148115;5073.289739436482;5090.9236361454605;5117.360329958755;5123.666961647481;5136.20388839723;6005.189299444606;6008.909866352008;6011;6013.879722405527;6040.546958978094;6010.729517171738;7447.962760186273;7462.10454745434;7470.738524151738;7471.589062601501;1767.0546257752042;1798.2896755781394;1798.6492633936257;1801.1534578747967;1802.4142153799805;1053.9262251642313;1087.6682611803476;1090.4111779639065;1091.3560999010463;1094.578587243901;7080.539764915264;7096.325849044332;7096.432285417154;7096.645167741695;7125.287471252833;7775.883361749578;7795.259450352208;7804.0635123785505;7815.218478152139;7828.84342313162;7023.33278338557;7087.61018144007;7261.128664560287;7315.9757633931295;7333.339999400079;4167.416561681367;4180.644645205191;4188.267053265667;4188.832446702158;4196.433481479961;8245.422820402635;8255.25702686749;8278.048024477263;8287.917120828835;8353.624086916103;7884.84230315402;8132.959335203404;8152.347812175011;8158.102608713037;8168.550729709923;8180.795480112925;8235.341172706168;8263.380246481538;8288.709895153761;8289.668413263522;7814.296713295831;7839.137694853447;7876.488028278143;7885.881711774213;7909.52542847431;7691.423143264165;7701.576413297323;7702.537847729154;7716.92283077162;7733.226677332447;7929.484583502054;8217.096119426738;8239.505629662;8257.00915890097;8259.21537453941;4835.226363781778;4863.367762190893;4884.169691152441;4890.462049174659;4896.779644915916;7367.926320736939;7386.781181105058;7753.767386978399;7760.18518055596;7772.572508512086;6195.938040619536;7352.705891764484;7499.512531685423;7515.13575938774;7552.509086909334;7278.818029549304;7505.324520792937;7514.8872766909635;7539.396848252017;7581.658825352762;7340.70637174507;7410.740624078131;7414.962925185339;7416.851662966818;7446.962765186356;6313.305536390902;7425.848993406031;7572.280633339824;7586.127595326608;7589.696412143452;5807.128930660266;7271.854562908818;7398.408127349907;7404.92595074064;7431.702731890664 11:16:42 INFO - PROCESS | 1676 | |5;yui.html;717.5228473065412;749.5015814483368;762.2377622377622;780.2977320411629;784.2040329065999;15612.921935390335;15621.06273623582;15877.68244635108;15879.92060039701;15906.204689765524;12199.512019519208;14726.410943562272;14754.483593074245;14765.18791466469;14829.03611265267;948.9478078705669;950.5864948747283;950.619752099159;951.9904800952006;975.653642956749;917.499962520428;924.2513564013137;933.9159475647224;947.4694171264114;979.9853002204973;997.6308765756644;999.8200323941687;1004.6433516101788;1004.8894621591619;1046.1212581431596;964.7973925475659;981.8281800684887;993;995.9502024898762;1037.2169012395668;713.803703981404;720.4452571519953;725.1624373848214;751.999840212516;755.1768572256267;11939.94030029853;14475;14490.492832750802;14515.201663908481;14543.78184327236;11612.012978896804;11711.590094346657;11846.526138954432;12034;12280.447379867837;9661.90338096617;9669.806603867954;10020.198384129251;11198.216124871262;11621.825672614917;4111.650509706678;4165.729227600196;4168.756175429366;4191.077962848169;4307.418498502693;85095.72356414658;86354.13645863524;86503.56748216282;88160.23679526438;89181;9450.480223587769;9580.18568421692;9581.377210481296;9621.470819105016;9648.276379271583;20918;20962;21824.45438864041;21837.344879653636;21870.562588748453;7485.363744081814;7627.161012288644;7642.579658118746;7717.344025757873;7807.882881756778;4127.380892866034;4169.082801783603;4218.261804184255;4234.110836724322;4282.143571285756;3702.9444558331647;3760.9247815043545;3767.020574650556;3774.7735135891935;3774.8298027611527;589.1398558105215;658.1805651963336;674.5649056358621;681.1009467502947;684.0560027162584;590.7223604905687;591.5858898770878;603.5171862509975;629.6977450823539;639.5459223951046;7754.961225193951;7796.220377962159;7966.123726390092;8071.798205044921;8276.131006244257;527.2539356810071;562.5752556819657;606.8695230525458;612.7242740766673;633.1800318587441;3771.585125636178;3855.768653880776;3957.762534247897;3990.780507072081;4161.667066634662;90838.54580727186;93826;95147.52426237964;98217.50891245498;99069.50465247627;85866.57066714752;86069.56965215135;86239.56880215558;86533.56733216293;91941;75597.62201188959;76999.23000770033;79249.20750792534;79430.80853787198;80705.99999999882;8506.574671266288;8523.701670441505;8923.241524470493;8953.015168331609;8986.82026359456;40051.198976020896;51576.48423515867;51880.44358669095;52414.47585524096;54337.72831135819;66587.66706166438;67799.3220067793;70991.93512097426;73901.6304918472;74419.25580744124;10007.499625018865;12156.574519891761;12168.634940951786;12241.449134788778;12478.251304921734;11717.824232636347;12025.819612705642;12150.756984860076;12300.753984920431;12404.56584019555;11624;11660.475278612314;11677;11940.402979850798;12274.263544187377;11691.590794322497;11770.234934729215;11803.173777835469;11946.761064778482;12369.62891113232;11154.163437742363;11554.653360399201;11693.415329233674;11718.589849355232;12205.389730513261;7512;8506.702265420681;9093.681721139728;9420.105090016437;10321.174306055647;9120.315976301672;10099.495025248854;10105.494725263854;10117.797644047225;10143.442110683687 11:16:42 INFO - PROCESS | 1676 | __end_tp_report 11:16:42 INFO - PROCESS | 1676 | __start_cc_report 11:16:42 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,354 11:16:42 INFO - PROCESS | 1676 | __end_cc_report 11:16:42 INFO - PROCESS | 1676 | __startTimestamp1463509002539__endTimestamp 11:16:42 INFO - PROCESS | 1676 | 11:16:42 INFO - PROCESS | 1676 | ------- Summary: start ------- 11:16:42 INFO - PROCESS | 1676 | Number of tests: 6 11:16:42 INFO - PROCESS | 1676 | 11:16:42 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5920.96 Median:6229.31 stddev:696.03 (11.2%) stddev-sans-first:675.20 11:16:42 INFO - PROCESS | 1676 | Values: 3660.9 3709.5 3741.7 3764.3 3770.5 5993.8 6079.5 6081.9 6098.2 6114.0 6016.3 6077.2 6080.5 6092.6 6104.1 5340.8 5383.8 5418.8 5458.5 5490.8 4260.6 5441.3 5459.2 5515.6 5546.6 4334.8 5436.5 5441.5 5457.1 5475.2 4081.8 5363.7 5392.0 5438.7 5442.6 5292.3 5293.0 5366.1 5377.3 5388.9 5788.7 5855.7 5909.9 5939.2 6002.2 5665.8 6232.0 6254.1 6302.3 6315.6 6019.9 6423.8 6434.8 6483.5 6511.9 6166.6 6177.0 6179.9 6187.1 6189.0 6333.7 6591.7 6602.3 6604.7 6611.6 6241.2 6274.7 6315.5 6317.1 6336.3 5373.9 6381.8 6403.9 6441.1 6450.1 6075.8 6265.1 6275.2 6321.4 6336.5 6215.9 6322.7 6328.8 6329.0 6342.5 3793.5 4986.6 5037.4 5038.0 5061.2 4517.4 4547.5 4584.4 4590.8 4610.3 6092.3 6142.9 6193.4 6243.1 6251.5 5305.3 6332.3 6407.3 6434.2 6434.4 5185.0 5381.5 6056.2 6250.7 6251.3 4931.9 5559.3 5578.0 5618.0 5655.1 6649.2 6669.6 6679.8 6686.3 6691.5 6342.6 6430.2 6487.1 6491.9 6512.3 6636.3 6667.8 6688.2 6688.2 6718.8 6373.7 6389.9 6401.4 6406.9 6409.5 6229.3 6376.8 6420.7 6436.8 6443.6 6290.5 6293.5 6303.9 6320.5 6321.4 6035.8 6282.4 6289.5 6296.6 6334.6 6142.5 6152.5 6209.7 6220.9 6235.9 6248.5 6254.3 6293.1 6294.7 6295.0 6238.5 6251.1 6306.4 6315.1 6319.0 11:16:42 INFO - PROCESS | 1676 | 11:16:42 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:67309.63 Median:41307.19 stddev:140406.80 (339.9%) stddev-sans-first:140711.12 11:16:42 INFO - PROCESS | 1676 | Values: 519.3 597.5 603.7 606.7 623.4 39950.4 40710.4 40813.8 40835.8 40855.0 41994.0 42574.8 42614.8 42802.1 42807.6 9608.6 9785.8 9833.4 9863.6 9877.3 9569.6 9866.3 9870.6 9928.4 9959.4 8959.8 9777.4 9829.1 9912.3 9965.6 9828.9 9875.4 9895.3 9905.8 9911.3 9838.6 9928.8 9938.1 9986.7 10019.0 40746.4 40811.4 41217.0 41399.4 41432.4 2922.9 2977.5 3308.0 3365.7 3551.0 24104.4 30015.8 30049.5 30384.8 31248.2 2736.2 2800.6 2800.9 2826.5 2962.2 568702.0 588008.0 589082.0 593120.0 593821.0 48821.0 70094.6 70683.6 71103.0 71182.6 47093.0 47770.0 47825.8 47997.3 48056.0 16769.9 16807.1 17062.7 17266.0 17366.7 13715.5 14141.9 14144.9 14154.3 14246.8 14989.6 15427.6 15756.4 15824.9 15849.4 6517.7 6558.4 6646.7 6684.6 6713.2 960.6 1057.6 1094.3 1098.6 1136.2 30663.1 30754.5 31324.8 31541.5 31547.5 1174.7 1181.6 1198.8 1238.5 1298.4 15539.3 15679.0 15868.0 15948.3 15952.1 527562.0 534347.0 535229.0 535682.0 536331.0 61756.0 62852.4 63266.7 63273.7 63311.4 1529.6 1565.0 1567.1 1573.2 1575.6 29829.7 30974.8 32604.7 32680.7 32733.2 56711.7 57203.1 57704.0 58042.7 58188.4 443820.0 450687.0 456335.0 457344.0 457635.0 38874.0 45893.0 46657.8 47599.8 47718.8 49141.0 49233.3 49608.0 50295.2 50368.5 39233.8 39917.4 40741.8 41125.4 41605.6 33235.8 38651.6 40595.0 40838.6 41470.8 31802.7 32988.0 35647.3 40805.4 41397.4 31758.5 33129.8 33419.7 33460.0 33468.0 25426.2 25441.6 25767.8 25910.4 26022.7 11:16:42 INFO - PROCESS | 1676 | 11:16:42 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:36525.57 Median:11853.26 stddev:112476.39 (948.9%) stddev-sans-first:112759.16 11:16:42 INFO - PROCESS | 1676 | Values: 376.0 383.8 384.4 384.4 386.3 17616.0 18810.2 19509.5 20835.4 21577.8 21642.5 22079.3 22241.2 22348.7 22646.3 5932.5 6125.8 6179.2 6206.2 6207.4 4542.7 5295.9 6475.8 6668.5 6751.6 6672.8 6764.2 6765.8 6795.4 6806.7 5678.5 5813.6 5924.8 5934.1 5947.2 5566.4 5598.3 5669.3 5671.0 5686.1 13430.5 13762.8 13800.2 21774.6 25120.5 2126.2 2128.7 2214.0 2372.9 2618.8 8690.1 10107.5 10585.7 10635.1 10793.5 1796.1 1806.3 1815.3 1879.9 1927.6 108031.0 113545.4 114459.0 114706.0 118390.6 11667.0 11721.6 11999.3 12021.0 12028.7 14294.4 14537.4 14570.1 14589.4 14592.9 7725.9 8844.0 8969.3 9031.9 9082.5 9140.4 9176.0 9193.7 9236.3 9287.6 4493.8 4505.8 4539.8 4558.6 4606.5 1810.7 1880.9 1905.1 1955.8 1961.4 969.4 1015.2 1094.1 1104.4 1108.9 19438.0 19603.7 19853.8 20072.8 20233.2 987.3 1000.8 1018.4 1020.1 1116.9 8656.0 10839.6 10920.0 11027.1 11076.4 655059.0 665225.0 687682.0 694617.0 696327.0 112726.0 117371.0 117799.0 120105.0 123769.0 1037.4 1054.5 1060.4 1079.9 1086.0 18194.8 18474.9 18763.5 18830.3 19022.5 38872.0 41018.0 52595.5 53862.5 56860.7 70740.0 72506.6 74013.0 74454.3 77288.6 7117.0 8231.4 8245.6 8373.4 8409.6 7565.7 10136.9 10188.0 12854.2 13785.0 9496.6 11882.9 11916.6 12096.8 12116.2 9815.8 11725.4 11751.7 11756.6 11816.6 11942.1 11989.1 12310.9 12334.9 12497.3 8139.8 8315.1 8317.5 8416.8 8766.7 8734.8 10120.5 10785.1 11691.3 11959.3 11:16:42 INFO - PROCESS | 1676 | 11:16:42 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:6252.33 Median:5210.36 stddev:3285.72 (63.1%) stddev-sans-first:3276.78 11:16:42 INFO - PROCESS | 1676 | Values: 1657.2 1664.0 1822.6 2042.8 2079.9 8381.0 9043.6 9045.8 9260.1 9279.8 7548.6 9013.3 9026.1 9101.5 9114.2 2542.1 2549.5 2550.2 2573.5 2587.0 2474.1 2537.7 2541.8 2547.2 2554.9 2511.6 2555.0 2560.3 2561.7 2578.5 2521.5 2534.5 2539.6 2556.3 2560.8 2544.2 2558.5 2568.5 2571.2 2596.9 8962.8 9068.2 9104.9 9115.3 9145.8 5617.3 5619.7 5663.3 5806.7 5819.7 3542.6 3744.0 3763.8 3768.7 3783.4 1065.7 1080.0 1082.1 1098.2 1099.5 11947.7 12164.3 12174.0 12299.0 12311.0 5016.9 5028.3 5168.5 5178.7 5202.9 10304.5 10392.8 10511.2 10543.0 10549.1 5023.9 5511.4 5625.1 5631.5 5752.5 4703.4 5087.1 5182.1 5196.4 5217.8 4006.1 4134.4 4137.5 4155.3 4158.3 1339.7 1381.2 1389.9 1390.5 1391.9 1423.4 1424.0 1438.1 1459.8 1489.0 8227.1 8235.9 8330.9 8413.0 8420.5 519.8 528.5 530.5 535.9 537.7 6220.3 6239.2 6312.7 6360.7 6387.5 10861.0 11115.3 11143.3 11202.6 11209.0 10642.8 10779.0 10905.6 10983.3 11049.1 8602.5 8747.0 8783.1 8788.3 8791.2 7926.1 8005.4 8086.1 8150.5 8171.6 9688.5 9875.4 9899.9 9923.0 10102.8 8847.8 10172.2 10348.5 10364.3 10382.2 7555.2 7605.1 7619.6 7633.3 7702.3 8349.4 8378.6 8474.1 8484.3 8557.6 7491.5 7616.4 7656.0 7707.1 7734.7 7412.4 7500.8 7516.1 7609.0 7617.0 7973.7 8032.6 8075.2 8113.8 8119.5 7210.1 7273.2 7291.0 7297.8 7298.7 7333.3 7377.3 7390.6 7398.8 7415.0 11:16:42 INFO - PROCESS | 1676 | 11:16:42 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:6133.52 Median:7017.23 stddev:1997.75 (28.5%) stddev-sans-first:1955.43 11:16:42 INFO - PROCESS | 1676 | Values: 339.0 340.2 342.1 344.8 349.5 6952.3 6980.1 7007.0 7019.4 7029.2 6990.1 7003.2 7003.9 7015.1 7022.8 4916.9 4957.9 4979.1 5100.0 5188.7 4358.7 5127.1 5154.0 5162.3 5165.1 3962.9 4821.8 5025.7 5080.4 5121.5 3924.4 4048.6 5123.3 5127.8 5141.0 3803.4 4395.3 4407.8 4412.5 4418.8 6426.4 6645.8 6701.6 6710.9 6716.8 5983.6 6018.1 6022.0 6037.3 6065.1 7418.9 7422.6 7433.1 7446.0 7450.2 4920.6 4923.2 4925.9 4934.6 4943.3 7611.8 7866.1 7881.7 7882.5 7899.3 4975.9 5005.7 5012.8 5016.0 5018.8 5073.3 5090.9 5117.4 5123.7 5136.2 6005.2 6008.9 6011.0 6013.9 6040.5 6010.7 7448.0 7462.1 7470.7 7471.6 1767.1 1798.3 1798.6 1801.2 1802.4 1053.9 1087.7 1090.4 1091.4 1094.6 7080.5 7096.3 7096.4 7096.6 7125.3 7775.9 7795.3 7804.1 7815.2 7828.8 7023.3 7087.6 7261.1 7316.0 7333.3 4167.4 4180.6 4188.3 4188.8 4196.4 8245.4 8255.3 8278.0 8287.9 8353.6 7884.8 8133.0 8152.3 8158.1 8168.6 8180.8 8235.3 8263.4 8288.7 8289.7 7814.3 7839.1 7876.5 7885.9 7909.5 7691.4 7701.6 7702.5 7716.9 7733.2 7929.5 8217.1 8239.5 8257.0 8259.2 4835.2 4863.4 4884.2 4890.5 4896.8 7367.9 7386.8 7753.8 7760.2 7772.6 6195.9 7352.7 7499.5 7515.1 7552.5 7278.8 7505.3 7514.9 7539.4 7581.7 7340.7 7410.7 7415.0 7416.9 7447.0 6313.3 7425.8 7572.3 7586.1 7589.7 5807.1 7271.9 7398.4 7404.9 7431.7 11:16:42 INFO - PROCESS | 1676 | 11:16:42 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:19233.53 Median:591.15 stddev:27622.17 (4672.6%) stddev-sans-first:27664.67 11:16:42 INFO - PROCESS | 1676 | Values: 717.5 749.5 762.2 780.3 784.2 15612.9 15621.1 15877.7 15879.9 15906.2 12199.5 14726.4 14754.5 14765.2 14829.0 948.9 950.6 950.6 952.0 975.7 917.5 924.3 933.9 947.5 980.0 997.6 999.8 1004.6 1004.9 1046.1 964.8 981.8 993.0 996.0 1037.2 713.8 720.4 725.2 752.0 755.2 11939.9 14475.0 14490.5 14515.2 14543.8 11612.0 11711.6 11846.5 12034.0 12280.4 9661.9 9669.8 10020.2 11198.2 11621.8 4111.7 4165.7 4168.8 4191.1 4307.4 85095.7 86354.1 86503.6 88160.2 89181.0 9450.5 9580.2 9581.4 9621.5 9648.3 20918.0 20962.0 21824.5 21837.3 21870.6 7485.4 7627.2 7642.6 7717.3 7807.9 4127.4 4169.1 4218.3 4234.1 4282.1 3702.9 3760.9 3767.0 3774.8 3774.8 589.1 658.2 674.6 681.1 684.1 590.7 591.6 603.5 629.7 639.5 7755.0 7796.2 7966.1 8071.8 8276.1 527.3 562.6 606.9 612.7 633.2 3771.6 3855.8 3957.8 3990.8 4161.7 90838.5 93826.0 95147.5 98217.5 99069.5 85866.6 86069.6 86239.6 86533.6 91941.0 75597.6 76999.2 79249.2 79430.8 80706.0 8506.6 8523.7 8923.2 8953.0 8986.8 40051.2 51576.5 51880.4 52414.5 54337.7 66587.7 67799.3 70991.9 73901.6 74419.3 10007.5 12156.6 12168.6 12241.4 12478.3 11717.8 12025.8 12150.8 12300.8 12404.6 11624.0 11660.5 11677.0 11940.4 12274.3 11691.6 11770.2 11803.2 11946.8 12369.6 11154.2 11554.7 11693.4 11718.6 12205.4 7512.0 8506.7 9093.7 9420.1 10321.2 9120.3 10099.5 10105.5 10117.8 10143.4 11:16:42 INFO - PROCESS | 1676 | -------- Summary: end -------- 11:16:42 INFO - PROCESS | 1676 | 11:16:43 INFO - TEST-INFO | 1676: exit 0 11:16:43 INFO - TEST-OK | dromaeo_css | took 1109752ms 11:16:43 INFO - TEST-START | kraken 11:16:43 INFO - operating with platform_type : mac_ 11:16:43 INFO - Initialising browser for kraken test... 11:16:43 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpDmURxi/profile http://localhost:49283/getInfo.html) 11:16:45 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 11:16:45 INFO - PROCESS | 1687 | colorDepth:24 11:16:45 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 11:16:45 INFO - PROCESS | 1687 | __metrics 11:16:45 ERROR - PROCESS | 1687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:16:46 INFO - TEST-INFO | 1687: exit 0 11:16:46 INFO - Browser initialized. 11:16:46 INFO - Running cycle 1/1 for kraken test... 11:16:46 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpDmURxi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:57 INFO - PROCESS | 1691 | RSS: Main: 167759872 11:16:57 INFO - PROCESS | 1691 | 11:17:00 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 11:17:01 INFO - PROCESS | 1691 | RSS: Main: 179777536 11:17:01 INFO - PROCESS | 1691 | 11:17:03 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 11:17:04 INFO - PROCESS | 1691 | RSS: Main: 188825600 11:17:04 INFO - PROCESS | 1691 | 11:17:07 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 11:17:08 INFO - PROCESS | 1691 | RSS: Main: 192344064 11:17:08 INFO - PROCESS | 1691 | 11:17:10 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 11:17:10 INFO - PROCESS | 1691 | RSS: Main: 192823296 11:17:10 INFO - PROCESS | 1691 | 11:17:12 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:17:13 INFO - PROCESS | 1691 | RSS: Main: 194318336 11:17:13 INFO - PROCESS | 1691 | 11:17:16 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 11:17:16 INFO - PROCESS | 1691 | RSS: Main: 194564096 11:17:16 INFO - PROCESS | 1691 | 11:17:19 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 11:17:20 INFO - PROCESS | 1691 | RSS: Main: 194482176 11:17:20 INFO - PROCESS | 1691 | 11:17:23 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 11:17:24 INFO - PROCESS | 1691 | RSS: Main: 194473984 11:17:24 INFO - PROCESS | 1691 | 11:17:25 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:17:26 INFO - PROCESS | 1691 | RSS: Main: 194256896 11:17:26 INFO - PROCESS | 1691 | 11:17:28 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:17:28 INFO - PROCESS | 1691 | RSS: Main: 194326528 11:17:28 INFO - PROCESS | 1691 | 11:17:30 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:17:31 INFO - PROCESS | 1691 | RSS: Main: 194400256 11:17:31 INFO - PROCESS | 1691 | 11:17:33 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:17:34 INFO - PROCESS | 1691 | RSS: Main: 194379776 11:17:34 INFO - PROCESS | 1691 | 11:17:37 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:37 INFO - PROCESS | 1691 | RSS: Main: 194478080 11:17:37 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 11:17:39 INFO - PROCESS | 1691 | RSS: Main: 196079616 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | __start_tp_report 11:17:39 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 11:17:39 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 11:17:39 INFO - PROCESS | 1691 | |i|pagename|runs| 11:17:39 INFO - PROCESS | 1691 | |0;ai-astar;116;112;115;113;115;129;113;113;116;115 11:17:39 INFO - PROCESS | 1691 | |1;audio-beat-detection;150;122;157;150;121;137;142;185;146;121 11:17:39 INFO - PROCESS | 1691 | |2;audio-dft;186;200;202;221;202;199;200;194;194;195 11:17:39 INFO - PROCESS | 1691 | |3;audio-fft;64;74;72;114;65;86;82;84;147;57 11:17:39 INFO - PROCESS | 1691 | |4;audio-oscillator;88;87;117;78;79;80;117;78;80;119 11:17:39 INFO - PROCESS | 1691 | |5;imaging-gaussian-blur;91;89;90;90;92;89;93;90;113;88 11:17:39 INFO - PROCESS | 1691 | |6;imaging-darkroom;142;112;147;116;96;97;98;97;98;91 11:17:39 INFO - PROCESS | 1691 | |7;imaging-desaturate;148;144;94;125;85;142;91;97;106;95 11:17:39 INFO - PROCESS | 1691 | |8;json-parse-financial;55;58;59;59;57;88;88;89;87;78 11:17:39 INFO - PROCESS | 1691 | |9;json-stringify-tinderbox;62;62;80;75;79;103;103;56;75;84 11:17:39 INFO - PROCESS | 1691 | |10;stanford-crypto-aes;84;83;83;82;80;80;82;84;84;84 11:17:39 INFO - PROCESS | 1691 | |11;stanford-crypto-ccm;136;116;123;116;121;148;130;130;119;118 11:17:39 INFO - PROCESS | 1691 | |12;stanford-crypto-pbkdf2;126;134;136;133;138;125;141;168;162;137 11:17:39 INFO - PROCESS | 1691 | |13;stanford-crypto-sha256-iterative;67;65;64;66;66;67;67;64;68;65 11:17:39 INFO - PROCESS | 1691 | __end_tp_report 11:17:39 INFO - PROCESS | 1691 | __start_cc_report 11:17:39 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,908 11:17:39 INFO - PROCESS | 1691 | __end_cc_report 11:17:39 INFO - PROCESS | 1691 | __startTimestamp1463509059566__endTimestamp 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | ------- Summary: start ------- 11:17:39 INFO - PROCESS | 1691 | Number of tests: 14 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#0] ai-astar Cycles:10 Average:115.70 Median:115.00 stddev:4.88 (4.2%) stddev-sans-first:5.17 11:17:39 INFO - PROCESS | 1691 | Values: 116.0 112.0 115.0 113.0 115.0 129.0 113.0 113.0 116.0 115.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:148.00 stddev:19.76 (13.3%) stddev-sans-first:20.80 11:17:39 INFO - PROCESS | 1691 | Values: 150.0 122.0 157.0 150.0 121.0 137.0 142.0 185.0 146.0 121.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#2] audio-dft Cycles:10 Average:199.30 Median:200.00 stddev:9.06 (4.5%) stddev-sans-first:8.23 11:17:39 INFO - PROCESS | 1691 | Values: 186.0 200.0 202.0 221.0 202.0 199.0 200.0 194.0 194.0 195.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#3] audio-fft Cycles:10 Average:84.50 Median:73.00 stddev:27.10 (37.1%) stddev-sans-first:27.71 11:17:39 INFO - PROCESS | 1691 | Values: 64.0 74.0 72.0 114.0 65.0 86.0 82.0 84.0 147.0 57.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:79.50 stddev:17.85 (22.5%) stddev-sans-first:18.87 11:17:39 INFO - PROCESS | 1691 | Values: 88.0 87.0 117.0 78.0 79.0 80.0 117.0 78.0 80.0 119.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:90.00 stddev:7.35 (8.2%) stddev-sans-first:7.78 11:17:39 INFO - PROCESS | 1691 | Values: 91.0 89.0 90.0 90.0 92.0 89.0 93.0 90.0 113.0 88.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#6] imaging-darkroom Cycles:10 Average:109.40 Median:96.50 stddev:20.03 (20.8%) stddev-sans-first:17.43 11:17:39 INFO - PROCESS | 1691 | Values: 142.0 112.0 147.0 116.0 96.0 97.0 98.0 97.0 98.0 91.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#7] imaging-desaturate Cycles:10 Average:112.70 Median:88.00 stddev:24.56 (27.9%) stddev-sans-first:22.48 11:17:39 INFO - PROCESS | 1691 | Values: 148.0 144.0 94.0 125.0 85.0 142.0 91.0 97.0 106.0 95.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#8] json-parse-financial Cycles:10 Average:71.80 Median:82.50 stddev:15.31 (18.6%) stddev-sans-first:14.98 11:17:39 INFO - PROCESS | 1691 | Values: 55.0 58.0 59.0 59.0 57.0 88.0 88.0 89.0 87.0 78.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#9] json-stringify-tinderbox Cycles:10 Average:77.90 Median:75.00 stddev:16.00 (21.3%) stddev-sans-first:15.91 11:17:39 INFO - PROCESS | 1691 | Values: 62.0 62.0 80.0 75.0 79.0 103.0 103.0 56.0 75.0 84.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.50 stddev:1.58 (1.9%) stddev-sans-first:1.59 11:17:39 INFO - PROCESS | 1691 | Values: 84.0 83.0 83.0 82.0 80.0 80.0 82.0 84.0 84.0 84.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:126.50 stddev:10.34 (8.2%) stddev-sans-first:10.27 11:17:39 INFO - PROCESS | 1691 | Values: 136.0 116.0 123.0 116.0 121.0 148.0 130.0 130.0 119.0 118.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.00 Median:137.50 stddev:14.16 (10.3%) stddev-sans-first:14.08 11:17:39 INFO - PROCESS | 1691 | Values: 126.0 134.0 136.0 133.0 138.0 125.0 141.0 168.0 162.0 137.0 11:17:39 INFO - PROCESS | 1691 | 11:17:39 INFO - PROCESS | 1691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:1.37 (2.1%) stddev-sans-first:1.39 11:17:39 INFO - PROCESS | 1691 | Values: 67.0 65.0 64.0 66.0 66.0 67.0 67.0 64.0 68.0 65.0 11:17:39 INFO - PROCESS | 1691 | -------- Summary: end -------- 11:17:39 INFO - PROCESS | 1691 | 11:17:40 INFO - TEST-INFO | 1691: exit 0 11:17:40 INFO - TEST-OK | kraken | took 57250ms 11:17:40 INFO - SUITE-END | took 1167s 11:17:40 INFO - Completed test suite (00:19:27) 11:17:40 INFO - javascript benchmark 11:17:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3660.871869484568, 3709.51776269085, 3741.7380783345143, 3764.34124028295, 3770.547534295884, 5993.760249590022, 6079.483243924261, 6081.908771368428, 6098.207233059701, 6113.969430152849, 6016.338202797689, 6077.209962704842, 6080.543959203066, 6092.634441933487, 6104.145419641254, 5340.786368545254, 5383.757730902119, 5418.756155972971, 5458.4814442627885, 5490.752916118784, 4260.552641972595, 5441.29263195786, 5459.235707001023, 5515.586331025169, 5546.584006199531, 4334.783260836962, 5436.510714035736, 5441.455854414567, 5457.126859702448, 5475.178723191513, 4081.7755023473696, 5363.651362661414, 5392.0, 5438.673679579238, 5442.564594832404, 5292.311999440087, 5292.973535132338, 5366.114591092465, 5377.274068000848, 5388.892222155574, 5788.710564471759, 5855.677937713424, 5909.881802363929, 5939.227900372967, 6002.249718785152, 5665.801696940628, 6231.9688401557705, 6254.0618907163835, 6302.306746257908, 6315.557910946236, 6019.909701354483, 6423.8394040148905, 6434.774782882623, 6483.513736469784, 6511.8697626047215, 6166.568340216142, 6176.96911515444, 6179.876402471926, 6187.102870083902, 6189.0, 6333.65164915934, 6591.670416479157, 6602.2737498875085, 6604.702788374535, 6611.63636000015, 6241.18864547615, 6274.717637706314, 6315.494760419156, 6317.1156038154695, 6336.303006669263, 5373.946260537345, 6381.776637817654, 6403.871922561522, 6441.066045423388, 6450.0647406125845, 6075.817725468243, 6265.060240963892, 6275.184226050585, 6321.431071203614, 6336.52476064297, 6215.9378406216265, 6322.652254125976, 6328.778492752732, 6329.0, 6342.5243106767175, 3793.525809273841, 4986.601071914238, 5037.3955125384455, 5037.974810125999, 5061.240813877947, 4517.412736344254, 4547.454305483363, 4584.426946631671, 4590.8163673453355, 4610.331501932268, 6092.268927728701, 6142.928535732134, 6193.411625895533, 6243.063540468966, 6251.531135164881, 5305.31030965972, 6332.271788744353, 6407.295197528269, 6434.163558737334, 6434.388733070351, 5184.974075129676, 5381.54256888161, 6056.152138700585, 6250.718717657716, 6251.281102673251, 4931.939632978927, 5559.277293951841, 5578.023845826964, 5617.9719101404235, 5655.066913959151, 6649.235337936103, 6669.63317017559, 6679.799606011828, 6686.297938716365, 6691.531592788653, 6342.587731797418, 6430.196225471816, 6487.124238227779, 6491.902621460587, 6512.3162067982175, 6636.27001029896, 6667.833304167435, 6688.197416310074, 6688.230853451915, 6718.764843230463, 6373.74505019794, 6389.9041514376395, 6401.423871851555, 6406.935930640634, 6409.455196308179, 6229.314775374796, 6376.776812811529, 6420.711068001858, 6436.8390790230615, 6443.613383197023, 6290.496760259077, 6293.465055470337, 6303.873922521616, 6320.494360451061, 6321.431071203614, 6035.78874739382, 6282.403171698681, 6289.49684025286, 6296.590721603081, 6334.619922804646, 6142.508599312134, 6152.477039451696, 6209.658468784261, 6220.937790622036, 6235.906461402992, 6248.531360148098, 6254.343293954069, 6293.118963345227, 6294.748210071546, 6295.0, 6238.500919926486, 6251.124842521959, 6306.432421082125, 6315.052742088724, 6319.0], "unit": "score", "name": "dojo.html", "value": 5879.479909409549}, {"lowerIsBetter": false, "replicates": [519.3170980161088, 597.5309382135022, 603.7222877476361, 606.6936197220408, 623.429561950815, 39950.40074398883, 40710.38934415986, 40813.7959310203, 40835.795821020925, 40855.0, 41993.95015124624, 42574.78712606433, 42614.786926065404, 42802.14395712084, 42807.571924280746, 9608.567614457366, 9785.755356116082, 9833.360831545926, 9863.60545578176, 9877.308588398815, 9569.569369378394, 9866.309358344919, 9870.60517579296, 9928.354656947311, 9959.352642078278, 8959.776005599848, 9777.41335519871, 9829.066238707312, 9912.256580756437, 9965.551550180224, 9828.852567211497, 9875.407475551454, 9895.257855660855, 9905.801883962316, 9911.306208565404, 9838.557264923096, 9928.751781205456, 9938.055884690943, 9986.650467233685, 10018.998100189996, 40746.38880416796, 40811.38782918229, 41217.0, 41399.379009314885, 41432.37851432231, 2922.853857307126, 2977.523596224615, 3307.966920330814, 3365.74756893234, 3550.9879684289854, 24104.397390065213, 30015.849920750476, 30049.549256761165, 30384.84807575948, 31248.21879453032, 2736.220177249494, 2800.621916041329, 2800.929976750577, 2826.547752359613, 2962.155785601115, 568702.0, 588008.0, 589082.0, 593119.9999999957, 593821.0, 48821.0, 70094.64952675204, 70683.64658176676, 71103.0, 71182.64408677924, 47093.0, 47770.04459910852, 47825.76087119542, 47997.280040799415, 48056.0, 16769.916150419413, 16807.075610841275, 17062.658746824993, 17266.0, 17366.65266694659, 13715.45138194481, 14141.929290353482, 14144.929275353557, 14154.292285385689, 14246.786298205536, 14989.625259368386, 15427.614309642124, 15756.448524301595, 15824.92087539555, 15849.445269415515, 6517.739290428424, 6558.376954189344, 6646.6676666166495, 6684.598924064571, 6713.1944166700305, 960.6301573893961, 1057.619257067455, 1094.2887123369874, 1098.6099934523288, 1136.1989797193125, 30663.08010759636, 30754.53868191979, 31324.843375782973, 31541.52687709686, 31547.526787098213, 1174.6593487888588, 1181.6041626055196, 1198.7902117129468, 1238.54173955637, 1298.3914262422386, 15539.30073146711, 15679.0, 15868.0, 15948.2823272953, 15952.122633255283, 527562.0, 534347.0, 535229.0, 535682.0, 536331.0, 61756.0, 62852.37147628557, 63266.683666581375, 63273.68363158247, 63311.36688633147, 1529.5946574157856, 1565.0296815974168, 1567.0597641415288, 1573.244842475618, 1575.558843523815, 29829.70170298356, 30974.84512577513, 32604.673953261114, 32680.67319326776, 32733.18167045843, 56711.71644141753, 57203.141952869904, 57704.0, 58042.709786450796, 58188.4181158183, 443820.0, 450687.0, 456335.0, 457344.0, 457635.0, 38874.0, 45893.0, 46657.76671116623, 47599.762001189774, 47718.761406194135, 49141.0, 49233.2615010768, 49608.0, 50295.245571317195, 50368.496315036384, 39233.803830980665, 39917.401238980856, 40741.796291018356, 41125.383119252634, 41605.58394416017, 33235.83382083074, 38651.61348386593, 40595.0, 40838.59161408467, 41470.79264603658, 31802.681973180897, 32988.0, 35647.28705425929, 40805.38791918183, 41397.379039315034, 31758.52362214615, 33129.83435082809, 33419.66580334165, 33460.0, 33467.99596012123, 25426.2201645883, 25441.61837572475, 25767.840447179547, 25910.35224119412, 26022.73977260203], "unit": "score", "name": "ext.html", "value": 20422.098838754668}, {"lowerIsBetter": false, "replicates": [375.9567649720281, 383.7735735915809, 384.4060925869533, 384.4156881540059, 386.2564563215809, 17616.0, 18810.2475900964, 19509.512262193453, 20835.374938751826, 21577.784222157774, 21642.458938526546, 22079.33761987139, 22241.2215572455, 22348.664770028423, 22646.320610381714, 5932.466078052975, 6125.816225513219, 6179.196704428418, 6206.162168107293, 6207.379262073801, 4542.704724192917, 5295.867603309909, 6475.83810404739, 6668.499862510307, 6751.628660423675, 6672.76645317414, 6764.154480689914, 6765.830854228634, 6795.388415042645, 6806.727730890759, 5678.4605462480995, 5813.563982701272, 5924.792632257871, 5934.050551911673, 5947.1971283876555, 5566.387697353288, 5598.272224610815, 5669.262995810518, 5670.979223739725, 5686.0617998030275, 13430.529931452353, 13762.793558096637, 13800.240986745725, 21774.564508709896, 25120.497590048097, 2126.202673997251, 2128.7445506539316, 2213.966790498144, 2372.857628542293, 2618.8428694278405, 8690.130986901322, 10107.545160467724, 10585.73535661607, 10635.096016838577, 10793.460326983619, 1796.083997161444, 1806.3226290141197, 1815.2557451444843, 1879.8872067675984, 1927.6433859735994, 108031.0, 113545.43227283811, 114459.0, 114706.0, 118390.63218735578, 11667.0, 11721.648350549498, 11999.280043197261, 12021.0, 12028.699282518008, 14294.356753946098, 14537.418503259963, 14570.05294655844, 14589.41642334316, 14592.927035364755, 7725.918371428004, 8844.027157012852, 8969.327300452493, 9031.916170059634, 9082.500462474627, 9140.405873618194, 9175.954120229357, 9193.678221262357, 9236.261099112055, 9287.62849486013, 4493.775311234425, 4505.819767209275, 4539.773011349419, 4558.566936141061, 4606.470255920612, 1810.6831304521656, 1880.9247630094642, 1905.1046008376318, 1955.8141976512209, 1961.4115765270362, 969.3844408800462, 1015.1624909449733, 1094.141099237111, 1104.4312179227704, 1108.9354219948939, 19438.0, 19603.705944410845, 19853.801461985484, 20072.799272007385, 20233.24925704873, 987.3434166279487, 1000.7998400319965, 1018.3787889387615, 1020.0819262663662, 1116.8715597706368, 8655.956720216485, 10839.566417343376, 10920.0, 11027.117830573536, 11076.39079850616, 655059.0, 665225.0, 687682.0, 694617.0, 696327.0, 112726.0, 117371.0, 117799.0, 120105.0, 123769.0, 1037.4397825174321, 1054.46222426563, 1060.437967877011, 1079.865016872891, 1085.9511321990528, 18194.772453240083, 18474.907625461787, 18763.530911727317, 18830.3409380671, 19022.524436889187, 38872.0, 41017.99999999881, 52595.474045259056, 53862.46137538574, 56860.715696421255, 70740.0, 72506.63746681233, 74013.0, 74454.2554574469, 77288.61355693186, 7117.0, 8231.382646301432, 8245.628946697532, 8373.37199710012, 8409.62156702962, 7565.735199268, 10136.935621759609, 10188.032136946978, 12854.228746275254, 13784.966127540274, 9496.620135194791, 11882.881171188523, 11916.642500724645, 12096.818547721616, 12116.21244619097, 9815.803683926139, 11725.41372931367, 11751.706207344885, 11756.647300580997, 11816.645500634995, 11942.104342174545, 11989.100817438553, 12310.938445307716, 12334.876651233373, 12497.312647804458, 8139.83720325602, 8315.12691167443, 8317.542535160383, 8416.789580260542, 8766.736997890073, 8734.82530349402, 10120.544575494268, 10785.083267922315, 11691.298522088362, 11959.342236177094], "unit": "score", "name": "jquery.html", "value": 9601.084464614241}, {"lowerIsBetter": false, "replicates": [1657.2211060801424, 1663.9833601663984, 1822.6263615958721, 2042.8161465468104, 2079.854410191287, 8381.036180839204, 9043.593038313275, 9045.773855653611, 9260.073992600737, 9279.76800579985, 7548.622568871562, 9013.278937684985, 9026.052264512231, 9101.544922753868, 9114.179723824855, 2542.148380292604, 2549.4773571417863, 2550.2094350751236, 2573.5367633825904, 2586.961195582068, 2474.072222916406, 2537.6827896512937, 2541.796656267494, 2547.1594373856674, 2554.859482728449, 2511.635812807142, 2554.9872250638723, 2560.2831207261997, 2561.666983292179, 2578.5358635445614, 2521.508305880345, 2534.531111744333, 2539.5555777738823, 2556.297018319958, 2560.8463492190526, 2544.1604270590847, 2558.513882362345, 2568.4734629401114, 2571.215779187347, 2596.857172855492, 8962.82074358509, 9068.183863452321, 9104.908950910472, 9115.316351273681, 9145.771355716093, 5617.325920889479, 5619.719014049322, 5663.263775709132, 5806.65160090396, 5819.709014549256, 3542.557180352456, 3744.0452684565535, 3763.8118094095184, 3768.717346199046, 3783.375743002401, 1065.6696424108552, 1080.0333701337258, 1082.1018554599664, 1098.1653943003296, 1099.4997276239292, 11947.745486723856, 12164.270143791313, 12173.96521295682, 12299.0, 12310.95356894665, 5016.949830501649, 5028.34631497903, 5168.457311982263, 5178.741062946838, 5202.895942081137, 10304.536295866705, 10392.792144157074, 10511.1591072714, 10542.998415150549, 10549.050585447347, 5023.924641130386, 5511.421300763443, 5625.071863142617, 5631.493165615114, 5752.453516915886, 4703.388559487314, 5087.135187018216, 5182.093133701663, 5196.376434827769, 5217.817376391884, 4006.092168615517, 4134.421181034598, 4137.482814648169, 4155.314373128461, 4158.295099009391, 1339.733951415922, 1381.1643955407035, 1389.867962543577, 1390.450771945076, 1391.930403479822, 1423.4021710881455, 1423.9715205695827, 1438.1443041390355, 1459.839417664056, 1488.9553313400615, 8227.095019547845, 8235.917640823514, 8330.875036874451, 8412.957935210285, 8420.53687047206, 519.8362515807509, 528.5058470330254, 530.4589318894783, 535.8821059366933, 537.6773935638664, 6220.25356957159, 6239.220097487814, 6312.652804095819, 6360.745570177233, 6387.489000879918, 10861.0, 11115.333080015225, 11143.275687080313, 11202.607908723156, 11209.0, 10642.787144257227, 10779.0, 10905.618303359344, 10983.286086404358, 11049.116070714324, 8602.483850968962, 8746.956265218632, 8783.121687831166, 8788.340874434443, 8791.164839340252, 7926.128125906031, 8005.359571234404, 8086.110527841815, 8150.510969341858, 8171.591420428836, 9688.515574221401, 9875.40747555149, 9899.851502227328, 9922.950385248028, 10102.848457273294, 8847.778805529655, 10172.237082219011, 10348.482575871327, 10364.274500785174, 10382.221333399873, 7555.244475552401, 7605.125410577854, 7619.619019048914, 7633.31300182964, 7702.268284512962, 8349.37379696513, 8378.58107094655, 8474.110218426977, 8484.278836298983, 8557.57212139403, 7491.513051651626, 7616.3906887447765, 7656.042994625672, 7707.11368192665, 7734.690612375442, 7412.444066695128, 7500.849983000418, 7516.135644400964, 7609.0, 7617.0, 7973.681052757825, 8032.59837008159, 8075.152109028468, 8113.7565873023905, 8119.512829230265, 7210.098737657793, 7273.199948005821, 7290.9635451822405, 7297.781066568012, 7298.671559779928, 7333.303336183054, 7377.336039756233, 7390.556566606021, 7398.778036658909, 7415.036045314075], "unit": "score", "name": "mootools.html", "value": 5035.261304555112}, {"lowerIsBetter": false, "replicates": [338.96610338966104, 340.2310777642528, 342.06615938487914, 344.8310327939309, 349.45485043332394, 6952.2700116487795, 6980.092587963564, 7007.01901733757, 7019.368256856882, 7029.226785053653, 6990.126234220723, 7003.19463261725, 7003.859922801541, 7015.088038554981, 7022.789316320519, 4916.926246106311, 4957.934044180501, 4979.053979743855, 5099.991005306868, 5188.688678679291, 4358.65130789536, 5127.128388174019, 5154.020736060155, 5162.251473536335, 5165.070287348276, 3962.9009274768073, 4821.758912054401, 5025.673331233476, 5080.415752188509, 5121.462246464123, 3924.3917192835015, 4048.5951404859425, 5123.257127716461, 5127.769250383723, 5140.974295128501, 3803.353429916921, 4395.252807022814, 4407.779611019436, 4412.492563355191, 4418.845340413102, 6426.389492998158, 6645.800625981228, 6701.631410272433, 6710.865782684319, 6716.764913228014, 5983.551233657449, 6018.097285407181, 6022.006368949118, 6037.30570984338, 6065.090236464522, 7418.925810741932, 7422.554646721214, 7433.070866141732, 7445.957565940773, 7450.18048014718, 4920.630952678528, 4923.163062279421, 4925.926111108336, 4934.629902757308, 4943.2585112233455, 7611.847763044708, 7866.095399029127, 7881.684732610689, 7882.487638303549, 7899.289063984269, 4975.925361119586, 5005.674631148963, 5012.824551140692, 5015.974920125449, 5018.824341148115, 5073.289739436482, 5090.9236361454605, 5117.360329958755, 5123.666961647481, 5136.20388839723, 6005.189299444606, 6008.909866352008, 6011.0, 6013.879722405527, 6040.546958978094, 6010.729517171738, 7447.962760186273, 7462.10454745434, 7470.738524151738, 7471.589062601501, 1767.0546257752042, 1798.2896755781394, 1798.6492633936257, 1801.1534578747967, 1802.4142153799805, 1053.9262251642313, 1087.6682611803476, 1090.4111779639065, 1091.3560999010463, 1094.578587243901, 7080.539764915264, 7096.325849044332, 7096.432285417154, 7096.645167741695, 7125.287471252833, 7775.883361749578, 7795.259450352208, 7804.0635123785505, 7815.218478152139, 7828.84342313162, 7023.33278338557, 7087.61018144007, 7261.128664560287, 7315.9757633931295, 7333.339999400079, 4167.416561681367, 4180.644645205191, 4188.267053265667, 4188.832446702158, 4196.433481479961, 8245.422820402635, 8255.25702686749, 8278.048024477263, 8287.917120828835, 8353.624086916103, 7884.84230315402, 8132.959335203404, 8152.347812175011, 8158.102608713037, 8168.550729709923, 8180.795480112925, 8235.341172706168, 8263.380246481538, 8288.709895153761, 8289.668413263522, 7814.296713295831, 7839.137694853447, 7876.488028278143, 7885.881711774213, 7909.52542847431, 7691.423143264165, 7701.576413297323, 7702.537847729154, 7716.92283077162, 7733.226677332447, 7929.484583502054, 8217.096119426738, 8239.505629662, 8257.00915890097, 8259.21537453941, 4835.226363781778, 4863.367762190893, 4884.169691152441, 4890.462049174659, 4896.779644915916, 7367.926320736939, 7386.781181105058, 7753.767386978399, 7760.18518055596, 7772.572508512086, 6195.938040619536, 7352.705891764484, 7499.512531685423, 7515.13575938774, 7552.509086909334, 7278.818029549304, 7505.324520792937, 7514.8872766909635, 7539.396848252017, 7581.658825352762, 7340.70637174507, 7410.740624078131, 7414.962925185339, 7416.851662966818, 7446.962765186356, 6313.305536390902, 7425.848993406031, 7572.280633339824, 7586.127595326608, 7589.696412143452, 5807.128930660266, 7271.854562908818, 7398.408127349907, 7404.92595074064, 7431.702731890664], "unit": "score", "name": "prototype.html", "value": 5462.715214698469}, {"lowerIsBetter": false, "replicates": [717.5228473065412, 749.5015814483368, 762.2377622377622, 780.2977320411629, 784.2040329065999, 15612.921935390335, 15621.06273623582, 15877.68244635108, 15879.92060039701, 15906.204689765524, 12199.512019519208, 14726.410943562272, 14754.483593074245, 14765.18791466469, 14829.03611265267, 948.9478078705669, 950.5864948747283, 950.619752099159, 951.9904800952006, 975.653642956749, 917.499962520428, 924.2513564013137, 933.9159475647224, 947.4694171264114, 979.9853002204973, 997.6308765756644, 999.8200323941687, 1004.6433516101788, 1004.8894621591619, 1046.1212581431596, 964.7973925475659, 981.8281800684887, 993.0, 995.9502024898762, 1037.2169012395668, 713.803703981404, 720.4452571519953, 725.1624373848214, 751.999840212516, 755.1768572256267, 11939.94030029853, 14475.0, 14490.492832750802, 14515.201663908481, 14543.78184327236, 11612.012978896804, 11711.590094346657, 11846.526138954432, 12034.0, 12280.447379867837, 9661.90338096617, 9669.806603867954, 10020.198384129251, 11198.216124871262, 11621.825672614917, 4111.650509706678, 4165.729227600196, 4168.756175429366, 4191.077962848169, 4307.418498502693, 85095.72356414658, 86354.13645863524, 86503.56748216282, 88160.23679526438, 89181.0, 9450.480223587769, 9580.18568421692, 9581.377210481296, 9621.470819105016, 9648.276379271583, 20918.0, 20962.0, 21824.45438864041, 21837.344879653636, 21870.562588748453, 7485.363744081814, 7627.161012288644, 7642.579658118746, 7717.344025757873, 7807.882881756778, 4127.380892866034, 4169.082801783603, 4218.261804184255, 4234.110836724322, 4282.143571285756, 3702.9444558331647, 3760.9247815043545, 3767.020574650556, 3774.7735135891935, 3774.8298027611527, 589.1398558105215, 658.1805651963336, 674.5649056358621, 681.1009467502947, 684.0560027162584, 590.7223604905687, 591.5858898770878, 603.5171862509975, 629.6977450823539, 639.5459223951046, 7754.961225193951, 7796.220377962159, 7966.123726390092, 8071.798205044921, 8276.131006244257, 527.2539356810071, 562.5752556819657, 606.8695230525458, 612.7242740766673, 633.1800318587441, 3771.585125636178, 3855.768653880776, 3957.762534247897, 3990.780507072081, 4161.667066634662, 90838.54580727186, 93826.0, 95147.52426237964, 98217.50891245498, 99069.50465247627, 85866.57066714752, 86069.56965215135, 86239.56880215558, 86533.56733216293, 91941.0, 75597.62201188959, 76999.23000770033, 79249.20750792534, 79430.80853787198, 80705.99999999882, 8506.574671266288, 8523.701670441505, 8923.241524470493, 8953.015168331609, 8986.82026359456, 40051.198976020896, 51576.48423515867, 51880.44358669095, 52414.47585524096, 54337.72831135819, 66587.66706166438, 67799.3220067793, 70991.93512097426, 73901.6304918472, 74419.25580744124, 10007.499625018865, 12156.574519891761, 12168.634940951786, 12241.449134788778, 12478.251304921734, 11717.824232636347, 12025.819612705642, 12150.756984860076, 12300.753984920431, 12404.56584019555, 11624.0, 11660.475278612314, 11677.0, 11940.402979850798, 12274.263544187377, 11691.590794322497, 11770.234934729215, 11803.173777835469, 11946.761064778482, 12369.62891113232, 11154.163437742363, 11554.653360399201, 11693.415329233674, 11718.589849355232, 12205.389730513261, 7512.0, 8506.702265420681, 9093.681721139728, 9420.105090016437, 10321.174306055647, 9120.315976301672, 10099.495025248854, 10105.494725263854, 10117.797644047225, 10143.442110683687], "unit": "score", "name": "yui.html", "value": 7150.175364186543}], "name": "dromaeo_css", "value": 7808.902490445404}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 112.0, 115.0, 113.0, 115.0, 129.0, 113.0, 113.0, 116.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.7}, {"lowerIsBetter": true, "replicates": [150.0, 122.0, 157.0, 150.0, 121.0, 137.0, 142.0, 185.0, 146.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [186.0, 200.0, 202.0, 221.0, 202.0, 199.0, 200.0, 194.0, 194.0, 195.0], "unit": "score", "name": "audio-dft", "value": 199.3}, {"lowerIsBetter": true, "replicates": [64.0, 74.0, 72.0, 114.0, 65.0, 86.0, 82.0, 84.0, 147.0, 57.0], "unit": "score", "name": "audio-fft", "value": 84.5}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 117.0, 78.0, 79.0, 80.0, 117.0, 78.0, 80.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 92.3}, {"lowerIsBetter": true, "replicates": [91.0, 89.0, 90.0, 90.0, 92.0, 89.0, 93.0, 90.0, 113.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.5}, {"lowerIsBetter": true, "replicates": [142.0, 112.0, 147.0, 116.0, 96.0, 97.0, 98.0, 97.0, 98.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 144.0, 94.0, 125.0, 85.0, 142.0, 91.0, 97.0, 106.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 112.7}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 59.0, 59.0, 57.0, 88.0, 88.0, 89.0, 87.0, 78.0], "unit": "score", "name": "json-parse-financial", "value": 71.8}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 80.0, 75.0, 79.0, 103.0, 103.0, 56.0, 75.0, 84.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.9}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 82.0, 80.0, 80.0, 82.0, 84.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [136.0, 116.0, 123.0, 116.0, 121.0, 148.0, 130.0, 130.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [126.0, 134.0, 136.0, 133.0, 138.0, 125.0, 141.0, 168.0, 162.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.0}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 64.0, 66.0, 66.0, 67.0, 67.0, 64.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1513.4}]} 11:17:40 INFO - Return code: 0 11:17:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:17:40 ERROR - # TBPL SUCCESS # 11:17:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:17:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:17:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:17:40 INFO - 2016-05-17 11:17:40.899 screenresolution[1696:11734] starting screenresolution argv=screenresolution get 11:17:40 INFO - 2016-05-17 11:17:40.902 screenresolution[1696:11734] Display 0: 1600x1200x32@60 11:17:40 INFO - 2016-05-17 11:17:40.908 screenresolution[1697:11736] starting screenresolution argv=screenresolution list 11:17:40 INFO - Available Modes on Display 0 11:17:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:17:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:17:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:17:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:17:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:17:41 INFO - Intel Iris: 11:17:41 INFO - Chipset Model: Intel Iris 11:17:41 INFO - Type: GPU 11:17:41 INFO - Bus: Built-In 11:17:41 INFO - VRAM (Dynamic, Max): 1536 MB 11:17:41 INFO - Vendor: Intel (0x8086) 11:17:41 INFO - Device ID: 0x0a2e 11:17:41 INFO - Revision ID: 0x0009 11:17:41 INFO - Displays: 11:17:41 INFO - Display: 11:17:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:17:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:17:41 INFO - Display Serial Number: 1600x1200 60 11:17:41 INFO - Main Display: Yes 11:17:41 INFO - Mirror: Off 11:17:41 INFO - Online: Yes 11:17:41 INFO - Rotation: Supported 11:17:41 INFO - Return code: 0 11:17:41 INFO - Running post-action listener: _resource_record_post_action 11:17:41 INFO - Running post-run listener: _resource_record_post_run 11:17:42 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 32718336; Write bytes: 514185216; Read time: 339; Write time: 1792 11:17:42 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 202754560; Write bytes: 198633472; Read time: 18737; Write time: 461 11:17:42 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 30936576; Write bytes: 304758784; Read time: 313; Write time: 1293 11:17:42 INFO - Running post-run listener: _upload_blobber_files 11:17:42 INFO - Blob upload gear active. 11:17:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:17:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:17:42 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'] 11:17:42 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 11:17:42 INFO - (blobuploader) - INFO - Open directory for files ... 11:17:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:17:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:17:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:43 INFO - (blobuploader) - INFO - Done attempting. 11:17:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:17:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:17:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:44 INFO - (blobuploader) - INFO - Done attempting. 11:17:44 INFO - (blobuploader) - INFO - Iteration through files over. 11:17:44 INFO - Return code: 0 11:17:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:17:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:17:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a0b55dfa669c08eaac8027b7a2f240eab3658468ef8053c4ae4b0d5e5725785d72eee6038af1241d21a78a311423b276044857a4ec6948ccbf5d56cce303d0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e14c74cfa799e58fc1691fb3e6a499ce03ff24078af35b361be0ac1f2903796d68c48255c96ca3b19d26edf61a42a2e40c81edce1582fd5534afe98f18fa3fa8"} 11:17:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:17:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:17:44 INFO - Contents: 11:17:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a0b55dfa669c08eaac8027b7a2f240eab3658468ef8053c4ae4b0d5e5725785d72eee6038af1241d21a78a311423b276044857a4ec6948ccbf5d56cce303d0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e14c74cfa799e58fc1691fb3e6a499ce03ff24078af35b361be0ac1f2903796d68c48255c96ca3b19d26edf61a42a2e40c81edce1582fd5534afe98f18fa3fa8"} 11:17:44 INFO - Running post-run listener: copy_logs_to_upload_dir 11:17:44 INFO - Copying logs to upload dir... 11:17:44 INFO - mkdir: /builds/slave/test/build/upload/logs 11:17:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.318256 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2016-05-17 11:17:44.674244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:17:44.681681) ========= 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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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/9a0b55dfa669c08eaac8027b7a2f240eab3658468ef8053c4ae4b0d5e5725785d72eee6038af1241d21a78a311423b276044857a4ec6948ccbf5d56cce303d0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e14c74cfa799e58fc1691fb3e6a499ce03ff24078af35b361be0ac1f2903796d68c48255c96ca3b19d26edf61a42a2e40c81edce1582fd5534afe98f18fa3fa8"} build_url:https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010901 build_url: 'https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/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/9a0b55dfa669c08eaac8027b7a2f240eab3658468ef8053c4ae4b0d5e5725785d72eee6038af1241d21a78a311423b276044857a4ec6948ccbf5d56cce303d0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e14c74cfa799e58fc1691fb3e6a499ce03ff24078af35b361be0ac1f2903796d68c48255c96ca3b19d26edf61a42a2e40c81edce1582fd5534afe98f18fa3fa8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:17:44.711932) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:17:44.712251) ========= 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.2vQO4KHr4v/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.8jpMHZ3yNq/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005193 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:17:44.760052) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:17:44.763397) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:17:44.763733) ========= ========= Total master_lag: 0.26 =========