builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0365 starttime: 1464947355.07 results: success (0) buildid: 20160603004101 builduid: d3d53c7dcb0f4d7795846bf280fe9beb revision: effbb9ad4e93c4383e484f3a515d23194d3c6329 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:15.065962) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:15.066367) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:15.070689) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:15.529976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:15.530374) ========= 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.3FNfntaYPM/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.tGBdg0DJKH/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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-06-03 02:49:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 25.0M=0s 2016-06-03 02:49:16 (25.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.449357 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:16.019942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:16.020235) ========= 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.3FNfntaYPM/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.tGBdg0DJKH/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.025534 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:16.070377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 02:49:16.073792) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev effbb9ad4e93c4383e484f3a515d23194d3c6329 --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-aurora --rev effbb9ad4e93c4383e484f3a515d23194d3c6329 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3FNfntaYPM/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.tGBdg0DJKH/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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-06-03 02:49:16,156 truncating revision to first 12 chars 2016-06-03 02:49:16,156 Setting DEBUG logging. 2016-06-03 02:49:16,156 attempt 1/10 2016-06-03 02:49:16,156 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/effbb9ad4e93?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 02:49:17,256 unpacking tar archive at: mozilla-aurora-effbb9ad4e93/testing/mozharness/ program finished with exit code 0 elapsedTime=1.393299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 02:49:17.489369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:17.490588) ========= script_repo_revision: effbb9ad4e93c4383e484f3a515d23194d3c6329 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:17.491799) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:17.492566) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 02:49:17.509601) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-06-03 02:49:17.509878) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3FNfntaYPM/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.tGBdg0DJKH/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 02:49:17 INFO - MultiFileLogger online at 20160603 02:49:17 in /builds/slave/test 02:49:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:49:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:49:17 INFO - {'append_to_log': False, 02:49:17 INFO - 'base_work_dir': '/builds/slave/test', 02:49:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:49:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:49:17 INFO - 'branch': 'Mozilla-Aurora', 02:49:17 INFO - 'buildbot_json_path': 'buildprops.json', 02:49:17 INFO - 'config_files': ('talos/mac_config.py',), 02:49:17 INFO - 'default_actions': ('clobber', 02:49:17 INFO - 'read-buildbot-config', 02:49:17 INFO - 'download-and-extract', 02:49:17 INFO - 'populate-webroot', 02:49:17 INFO - 'create-virtualenv', 02:49:17 INFO - 'install', 02:49:17 INFO - 'run-tests'), 02:49:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:49:17 INFO - 'download_minidump_stackwalk': True, 02:49:17 INFO - 'download_symbols': 'ondemand', 02:49:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:49:17 INFO - 'tooltool.py': '/tools/tooltool.py', 02:49:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:49:17 INFO - '/tools/misc-python/virtualenv.py')}, 02:49:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:49:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:49:17 INFO - 'installer_path': 'installer.exe', 02:49:17 INFO - 'log_level': 'info', 02:49:17 INFO - 'log_name': 'talos', 02:49:17 INFO - 'log_to_console': True, 02:49:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:49:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:49:17 INFO - 'opt_config_files': (), 02:49:17 INFO - 'pip_index': False, 02:49:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:49:17 INFO - 'cmd': ('bash', 02:49:17 INFO - '-c', 02:49:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:49:17 INFO - 'enabled': True, 02:49:17 INFO - 'halt_on_failure': False, 02:49:17 INFO - 'name': 'check_screen_resolution'},), 02:49:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:49:17 INFO - 'cmd': ('bash', 02:49:17 INFO - '-c', 02:49:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:49:17 INFO - 'enabled': True, 02:49:17 INFO - 'halt_on_failure': False, 02:49:17 INFO - 'name': 'check_screen_resolution'},), 02:49:17 INFO - 'run_cmd_checks_enabled': True, 02:49:17 INFO - 'sps_profile': False, 02:49:17 INFO - 'sps_profile_interval': 0, 02:49:17 INFO - 'suite': 'dromaeojs-e10s', 02:49:17 INFO - 'system_bits': '32', 02:49:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:49:17 INFO - 'title': 't-yosemite-r7-0365', 02:49:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:49:17 INFO - 'use_talos_json': True, 02:49:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:49:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:49:17 INFO - 'work_dir': 'build'} 02:49:17 INFO - ##### 02:49:17 INFO - ##### Running clobber step. 02:49:17 INFO - ##### 02:49:17 INFO - Running pre-action listener: _resource_record_pre_action 02:49:17 INFO - Running main action method: clobber 02:49:17 INFO - rmtree: /builds/slave/test/build 02:49:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:49:19 INFO - Running post-action listener: _resource_record_post_action 02:49:19 INFO - ##### 02:49:19 INFO - ##### Running read-buildbot-config step. 02:49:19 INFO - ##### 02:49:19 INFO - Running pre-action listener: _resource_record_pre_action 02:49:19 INFO - Running main action method: read_buildbot_config 02:49:19 INFO - Using buildbot properties: 02:49:19 INFO - { 02:49:19 INFO - "project": "", 02:49:19 INFO - "product": "firefox", 02:49:19 INFO - "script_repo_revision": "production", 02:49:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:49:19 INFO - "repository": "", 02:49:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:49:19 INFO - "buildid": "20160603004101", 02:49:19 INFO - "stage_platform": "macosx64", 02:49:19 INFO - "basedir": "/builds/slave/test", 02:49:19 INFO - "nightly_build": "True", 02:49:19 INFO - "buildnumber": 24, 02:49:19 INFO - "slavename": "t-yosemite-r7-0365", 02:49:19 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:49:19 INFO - "platform": "yosemite_r7", 02:49:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:49:19 INFO - "branch": "mozilla-aurora", 02:49:19 INFO - "repo_path": "releases/mozilla-aurora", 02:49:19 INFO - "revision": "effbb9ad4e93c4383e484f3a515d23194d3c6329", 02:49:19 INFO - "pgo_build": "False", 02:49:19 INFO - "builduid": "d3d53c7dcb0f4d7795846bf280fe9beb", 02:49:19 INFO - "slavebuilddir": "test" 02:49:19 INFO - } 02:49:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 02:49:19 INFO - Running post-action listener: _resource_record_post_action 02:49:19 INFO - ##### 02:49:19 INFO - ##### Running download-and-extract step. 02:49:19 INFO - ##### 02:49:19 INFO - Running pre-action listener: _resource_record_pre_action 02:49:19 INFO - Running main action method: download_and_extract 02:49:19 INFO - mkdir: /builds/slave/test/build/tests 02:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:19 INFO - https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 02:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 02:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 02:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 02:49:27 INFO - Downloaded 1199 bytes. 02:49:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 02:49:27 INFO - Using the following test package requirements: 02:49:27 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 02:49:27 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:49:27 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 02:49:27 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:49:27 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 02:49:27 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:49:27 INFO - u'jsshell-mac.zip'], 02:49:27 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:49:27 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 02:49:27 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 02:49:27 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:49:27 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 02:49:27 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:49:27 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 02:49:27 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:49:27 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 02:49:27 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:49:27 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 02:49:27 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:27 INFO - https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:49:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:49:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:49:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:49:29 INFO - Downloaded 18463908 bytes. 02:49:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:49:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:49:32 INFO - Return code: 0 02:49:32 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:32 INFO - https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:49:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:49:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:49:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:49:34 INFO - Downloaded 18463908 bytes. 02:49:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:49:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:49:37 INFO - Return code: 0 02:49:37 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')]} 02:49:37 INFO - https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:49:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 02:49:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 02:49:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 02:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:49:38 INFO - Downloaded 10840145 bytes. 02:49:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:49:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:49:39 INFO - Return code: 0 02:49:39 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')]} 02:49:39 INFO - https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:49:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:49:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:49:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 02:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 02:49:44 INFO - Downloaded 114225261 bytes. 02:49:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:49:44 INFO - mkdir: /builds/slave/test/properties 02:49:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:49:44 INFO - Writing to file /builds/slave/test/properties/build_url 02:49:44 INFO - Contents: 02:49:44 INFO - build_url:https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:49:45 INFO - Running post-action listener: _resource_record_post_action 02:49:45 INFO - Running post-action listener: set_extra_try_arguments 02:49:45 INFO - ##### 02:49:45 INFO - ##### Running populate-webroot step. 02:49:45 INFO - ##### 02:49:45 INFO - Running pre-action listener: _resource_record_pre_action 02:49:45 INFO - Running main action method: populate_webroot 02:49:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:49:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:49:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:49:45 INFO - '--tppagecycles', 02:49:45 INFO - '7'], 02:49:45 INFO - 'tests': ['tsvgm']}}, 02:49:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:49:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:49:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:49:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:49:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:49:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:49:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:45 INFO - 'talos_options': ['--disable-e10s'], 02:49:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:49:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:49:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:45 INFO - 'talos_options': ['--disable-e10s'], 02:49:45 INFO - 'tests': ['damp', 'tps']}, 02:49:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:45 INFO - 'tests': ['damp', 'tps']}, 02:49:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:49:45 INFO - 'tests': ['dromaeo_dom']}, 02:49:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:49:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:49:45 INFO - 'tests': ['a11yr', 02:49:45 INFO - 'ts_paint', 02:49:45 INFO - 'tpaint', 02:49:45 INFO - 'sessionrestore', 02:49:45 INFO - 'sessionrestore_no_auto_restore', 02:49:45 INFO - 'tabpaint']}, 02:49:45 INFO - 'other-e10s': {'tests': ['a11yr', 02:49:45 INFO - 'ts_paint', 02:49:45 INFO - 'tpaint', 02:49:45 INFO - 'sessionrestore', 02:49:45 INFO - 'sessionrestore_no_auto_restore', 02:49:45 INFO - 'tabpaint']}, 02:49:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:49:45 INFO - 'ts_paint', 02:49:45 INFO - 'tpaint', 02:49:45 INFO - 'sessionrestore', 02:49:45 INFO - 'sessionrestore_no_auto_restore', 02:49:45 INFO - 'tabpaint']}, 02:49:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:49:45 INFO - 'ts_paint', 02:49:45 INFO - 'tpaint', 02:49:45 INFO - 'sessionrestore', 02:49:45 INFO - 'sessionrestore_no_auto_restore', 02:49:45 INFO - 'tabpaint']}, 02:49:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:49:45 INFO - 'tests': ['a11yr', 02:49:45 INFO - 'ts_paint', 02:49:45 INFO - 'tpaint', 02:49:45 INFO - 'sessionrestore', 02:49:45 INFO - 'sessionrestore_no_auto_restore', 02:49:45 INFO - 'tabpaint']}, 02:49:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:49:45 INFO - 'tests': ['a11yr', 02:49:45 INFO - 'ts_paint', 02:49:45 INFO - 'tpaint', 02:49:45 INFO - 'sessionrestore', 02:49:45 INFO - 'sessionrestore_no_auto_restore', 02:49:45 INFO - 'tabpaint']}, 02:49:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:49:45 INFO - 'tests': ['tsvgx', 02:49:45 INFO - 'tsvgr_opacity', 02:49:45 INFO - 'tart', 02:49:45 INFO - 'tscrollx', 02:49:45 INFO - 'cart']}, 02:49:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:49:45 INFO - 'tsvgr_opacity', 02:49:45 INFO - 'tart', 02:49:45 INFO - 'tscrollx', 02:49:45 INFO - 'cart']}, 02:49:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:45 INFO - 'talos_options': ['--disable-e10s'], 02:49:45 INFO - 'tests': ['tp5o']}, 02:49:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:45 INFO - 'tests': ['tp5o']}, 02:49:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:45 INFO - 'talos_options': ['--disable-e10s', 02:49:45 INFO - '--xperf_path', 02:49:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:49:45 INFO - 'tests': ['tp5n']}, 02:49:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:49:45 INFO - 'talos_options': ['--xperf_path', 02:49:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:49:45 INFO - 'tests': ['tp5n']}}, 02:49:45 INFO - 'talos.zip': {'path': '', 02:49:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:49:45 INFO - Running post-action listener: _resource_record_post_action 02:49:45 INFO - ##### 02:49:45 INFO - ##### Running create-virtualenv step. 02:49:45 INFO - ##### 02:49:45 INFO - Running pre-action listener: _resource_record_pre_action 02:49:45 INFO - Running main action method: create_virtualenv 02:49:45 INFO - Creating virtualenv /builds/slave/test/build/venv 02:49:45 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 02:49:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:49:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:49:45 INFO - Using real prefix '/tools/python27' 02:49:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:49:46 INFO - Installing distribute.............................................................................................................................................................................................done. 02:49:49 INFO - Installing pip.................done. 02:49:49 INFO - Return code: 0 02:49:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110547420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1514e6cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103d6e00>, '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 0x11023fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d1b20>, '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.3FNfntaYPM/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.tGBdg0DJKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 02:49:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:49:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3FNfntaYPM/Render', 02:49:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:49 INFO - 'HOME': '/Users/cltbld', 02:49:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:49 INFO - 'LOGNAME': 'cltbld', 02:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:49 INFO - 'MOZ_NO_REMOTE': '1', 02:49:49 INFO - 'NO_EM_RESTART': '1', 02:49:49 INFO - 'PAGER': '/bin/cat', 02:49:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:49 INFO - 'PWD': '/builds/slave/test', 02:49:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:49 INFO - 'SHELL': '/bin/bash', 02:49:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGBdg0DJKH/Listeners', 02:49:49 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 02:49:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:49 INFO - 'USER': 'cltbld', 02:49:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:49 INFO - 'XPC_FLAGS': '0x0', 02:49:49 INFO - 'XPC_SERVICE_NAME': '0', 02:49:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:49 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 02:49:49 INFO - Cleaning up... 02:49:49 INFO - Return code: 0 02:49:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110547420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1514e6cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103d6e00>, '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 0x11023fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d1b20>, '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.3FNfntaYPM/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.tGBdg0DJKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 02:49:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:49:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3FNfntaYPM/Render', 02:49:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:49 INFO - 'HOME': '/Users/cltbld', 02:49:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:49 INFO - 'LOGNAME': 'cltbld', 02:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:49 INFO - 'MOZ_NO_REMOTE': '1', 02:49:49 INFO - 'NO_EM_RESTART': '1', 02:49:49 INFO - 'PAGER': '/bin/cat', 02:49:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:49 INFO - 'PWD': '/builds/slave/test', 02:49:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:49 INFO - 'SHELL': '/bin/bash', 02:49:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGBdg0DJKH/Listeners', 02:49:49 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 02:49:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:49 INFO - 'USER': 'cltbld', 02:49:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:49 INFO - 'XPC_FLAGS': '0x0', 02:49:49 INFO - 'XPC_SERVICE_NAME': '0', 02:49:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:49 INFO - Downloading/unpacking psutil>=0.7.1 02:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:49:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:49:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:49:52 INFO - Installing collected packages: psutil 02:49:52 INFO - Running setup.py install for psutil 02:49:53 INFO - building 'psutil._psutil_osx' extension 02:49:53 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 02:49:53 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 02:49:53 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 02:49:53 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 02:49:53 INFO - building 'psutil._psutil_posix' extension 02:49:53 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 02:49:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:49:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:49:53 INFO - ^ 02:49:53 INFO - 1 warning generated. 02:49:53 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 02:49:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:49:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:49:54 INFO - Successfully installed psutil 02:49:54 INFO - Cleaning up... 02:49:54 INFO - Return code: 0 02:49:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:49:54 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')]} 02:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:54 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')]} 02:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:54 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 0x110537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110547420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1514e6cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103d6e00>, '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 0x11023fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d1b20>, '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.3FNfntaYPM/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.tGBdg0DJKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 02:49:54 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 02:49:54 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 02:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3FNfntaYPM/Render', 02:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:54 INFO - 'HOME': '/Users/cltbld', 02:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:54 INFO - 'LOGNAME': 'cltbld', 02:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:54 INFO - 'MOZ_NO_REMOTE': '1', 02:49:54 INFO - 'NO_EM_RESTART': '1', 02:49:54 INFO - 'PAGER': '/bin/cat', 02:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:54 INFO - 'PWD': '/builds/slave/test', 02:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:54 INFO - 'SHELL': '/bin/bash', 02:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGBdg0DJKH/Listeners', 02:49:54 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 02:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:54 INFO - 'USER': 'cltbld', 02:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:54 INFO - 'XPC_FLAGS': '0x0', 02:49:54 INFO - 'XPC_SERVICE_NAME': '0', 02:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:49:54 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 02:49:54 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 02:49:54 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 02:49:54 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 02:49:54 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 02:49:54 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 02:49:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:49:56 INFO - Installing collected packages: mozsystemmonitor 02:49:56 INFO - Running setup.py install for mozsystemmonitor 02:49:57 INFO - Successfully installed mozsystemmonitor 02:49:57 INFO - Cleaning up... 02:49:57 INFO - Return code: 0 02:49:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:57 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 0x110537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110547420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1514e6cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103d6e00>, '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 0x11023fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d1b20>, '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.3FNfntaYPM/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.tGBdg0DJKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 02:49:57 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 02:49:57 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 02:49:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3FNfntaYPM/Render', 02:49:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:57 INFO - 'HOME': '/Users/cltbld', 02:49:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:57 INFO - 'LOGNAME': 'cltbld', 02:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:57 INFO - 'MOZ_NO_REMOTE': '1', 02:49:57 INFO - 'NO_EM_RESTART': '1', 02:49:57 INFO - 'PAGER': '/bin/cat', 02:49:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:57 INFO - 'PWD': '/builds/slave/test', 02:49:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:57 INFO - 'SHELL': '/bin/bash', 02:49:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGBdg0DJKH/Listeners', 02:49:57 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 02:49:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:57 INFO - 'USER': 'cltbld', 02:49:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:57 INFO - 'XPC_FLAGS': '0x0', 02:49:57 INFO - 'XPC_SERVICE_NAME': '0', 02:49:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:57 INFO - Downloading/unpacking blobuploader==1.2.4 02:49:57 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 02:49:57 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 02:49:57 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 02:49:57 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 02:49:57 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 02:49:57 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 02:49:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:49:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:50:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:00 INFO - Downloading docopt-0.6.1.tar.gz 02:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:50:01 INFO - Installing collected packages: blobuploader, requests, docopt 02:50:01 INFO - Running setup.py install for blobuploader 02:50:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:50:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:50:01 INFO - Running setup.py install for requests 02:50:01 INFO - Running setup.py install for docopt 02:50:01 INFO - Successfully installed blobuploader requests docopt 02:50:01 INFO - Cleaning up... 02:50:01 INFO - Return code: 0 02:50:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:01 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 0x110537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110547420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1514e6cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103d6e00>, '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 0x11023fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d1b20>, '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.3FNfntaYPM/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.tGBdg0DJKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 02:50:01 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 02:50:01 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 02:50:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3FNfntaYPM/Render', 02:50:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:01 INFO - 'HOME': '/Users/cltbld', 02:50:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:01 INFO - 'LOGNAME': 'cltbld', 02:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:01 INFO - 'MOZ_NO_REMOTE': '1', 02:50:01 INFO - 'NO_EM_RESTART': '1', 02:50:01 INFO - 'PAGER': '/bin/cat', 02:50:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:01 INFO - 'PWD': '/builds/slave/test', 02:50:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:01 INFO - 'SHELL': '/bin/bash', 02:50:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGBdg0DJKH/Listeners', 02:50:01 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 02:50:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:01 INFO - 'USER': 'cltbld', 02:50:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:01 INFO - 'XPC_FLAGS': '0x0', 02:50:01 INFO - 'XPC_SERVICE_NAME': '0', 02:50:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:50:02 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-GSSKD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:50:02 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Nf8x4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:50:02 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-ADthTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:50:02 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-zvNCyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:50:02 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-xTUlQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:50:02 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-u05tqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:50:02 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-xipMwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:50:02 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-6QuBHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:50:03 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-AUpl2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:50:03 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-L3nHCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:50:03 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Wyxv3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:50:03 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-m4QIZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:50:03 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-vvb0f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:50:03 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-94I97G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:03 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-ko7e85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:50:03 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-8O9KBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:50:03 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-zmMAqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:50:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:50:03 INFO - Running setup.py install for manifestparser 02:50:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:50:04 INFO - Running setup.py install for mozcrash 02:50:04 INFO - Running setup.py install for mozdebug 02:50:04 INFO - Running setup.py install for mozdevice 02:50:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:50:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:50:04 INFO - Running setup.py install for mozfile 02:50:04 INFO - Running setup.py install for mozhttpd 02:50:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:50:04 INFO - Running setup.py install for mozinfo 02:50:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:50:04 INFO - Running setup.py install for mozInstall 02:50:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:50:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:50:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:50:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:50:05 INFO - Running setup.py install for mozleak 02:50:05 INFO - Running setup.py install for mozlog 02:50:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:50:05 INFO - Running setup.py install for moznetwork 02:50:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:50:05 INFO - Running setup.py install for mozprocess 02:50:05 INFO - Running setup.py install for mozprofile 02:50:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:50:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:50:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:50:05 INFO - Running setup.py install for mozrunner 02:50:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:50:06 INFO - Running setup.py install for mozscreenshot 02:50:06 INFO - Running setup.py install for moztest 02:50:06 INFO - Running setup.py install for mozversion 02:50:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:50:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:50:06 INFO - Cleaning up... 02:50:06 INFO - Return code: 0 02:50:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:06 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 0x110537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110547420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1514e6cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103d6e00>, '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 0x11023fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d1b20>, '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.3FNfntaYPM/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.tGBdg0DJKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 02:50:06 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 02:50:06 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 02:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3FNfntaYPM/Render', 02:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:06 INFO - 'HOME': '/Users/cltbld', 02:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:06 INFO - 'LOGNAME': 'cltbld', 02:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:06 INFO - 'MOZ_NO_REMOTE': '1', 02:50:06 INFO - 'NO_EM_RESTART': '1', 02:50:06 INFO - 'PAGER': '/bin/cat', 02:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:06 INFO - 'PWD': '/builds/slave/test', 02:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:06 INFO - 'SHELL': '/bin/bash', 02:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGBdg0DJKH/Listeners', 02:50:06 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 02:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:06 INFO - 'USER': 'cltbld', 02:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:06 INFO - 'XPC_FLAGS': '0x0', 02:50:06 INFO - 'XPC_SERVICE_NAME': '0', 02:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:50:06 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-XgYVVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:50:06 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)) 02:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:50:06 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-dfilJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:50:06 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)) 02:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:50:06 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-3OzmjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:50:07 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)) 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:50:07 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-jMr6Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:50:07 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)) 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:50:07 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-bHMw7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:50:07 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)) 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:50:07 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-v5PKnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:50:07 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)) 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:50:07 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-qfVbJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:50:07 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)) 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:50:07 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-v_y2Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:50:07 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)) 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:50:07 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-iwvPDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:50:07 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)) 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:50:07 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-la6gh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:50:07 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)) 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:50:07 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-HS2yxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:50:07 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)) 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:50:07 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-oCtcYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:50:08 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)) 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:50:08 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-46dxS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:50:08 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)) 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:50:08 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-XcnyT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:50:08 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)) 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:08 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-38wB8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:08 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)) 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:50:08 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-6v4f9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:50:08 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)) 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:50:08 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-6TmN8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:50:08 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)) 02:50:08 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)) 02:50:08 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)) 02:50:08 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)) 02:50:08 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)) 02:50:08 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)) 02:50:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:50:08 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 02:50:08 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 02:50:08 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 02:50:08 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 02:50:08 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 02:50:08 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 02:50:10 INFO - Downloading blessings-1.6.tar.gz 02:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:50:11 INFO - Installing collected packages: blessings 02:50:11 INFO - Running setup.py install for blessings 02:50:11 INFO - Successfully installed blessings 02:50:11 INFO - Cleaning up... 02:50:11 INFO - Return code: 0 02:50:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:50:11 INFO - Reading from file tmpfile_stdout 02:50:11 INFO - Current package versions: 02:50:11 INFO - blessings == 1.6 02:50:11 INFO - blobuploader == 1.2.4 02:50:11 INFO - docopt == 0.6.1 02:50:11 INFO - manifestparser == 1.1 02:50:11 INFO - mozInstall == 1.12 02:50:11 INFO - mozcrash == 0.17 02:50:11 INFO - mozdebug == 0.1 02:50:11 INFO - mozdevice == 0.48 02:50:11 INFO - mozfile == 1.2 02:50:11 INFO - mozhttpd == 0.7 02:50:11 INFO - mozinfo == 0.9 02:50:11 INFO - mozleak == 0.1 02:50:11 INFO - mozlog == 3.1 02:50:11 INFO - moznetwork == 0.27 02:50:11 INFO - mozprocess == 0.22 02:50:11 INFO - mozprofile == 0.28 02:50:11 INFO - mozrunner == 6.11 02:50:11 INFO - mozscreenshot == 0.1 02:50:11 INFO - mozsystemmonitor == 0.0 02:50:11 INFO - moztest == 0.7 02:50:11 INFO - mozversion == 1.4 02:50:11 INFO - psutil == 3.1.1 02:50:11 INFO - requests == 1.2.3 02:50:11 INFO - wsgiref == 0.1.2 02:50:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50: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')]} 02:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50: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')]} 02:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:11 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 0x110537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110547420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1514e6cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103d6e00>, '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 0x11023fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d1b20>, '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.3FNfntaYPM/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.tGBdg0DJKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 02:50:11 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 02:50:11 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 02:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3FNfntaYPM/Render', 02:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:11 INFO - 'HOME': '/Users/cltbld', 02:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:11 INFO - 'LOGNAME': 'cltbld', 02:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:11 INFO - 'MOZ_NO_REMOTE': '1', 02:50:11 INFO - 'NO_EM_RESTART': '1', 02:50:11 INFO - 'PAGER': '/bin/cat', 02:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:11 INFO - 'PWD': '/builds/slave/test', 02:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:11 INFO - 'SHELL': '/bin/bash', 02:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGBdg0DJKH/Listeners', 02:50:11 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 02:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:11 INFO - 'USER': 'cltbld', 02:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:11 INFO - 'XPC_FLAGS': '0x0', 02:50:11 INFO - 'XPC_SERVICE_NAME': '0', 02:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 INFO - Cleaning up... 02:50:11 INFO - Return code: 0 02:50:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:50: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')]} 02:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50: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')]} 02:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110547420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1514e6cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103d6e00>, '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 0x11023fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d1b20>, '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.3FNfntaYPM/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.tGBdg0DJKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 02:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3FNfntaYPM/Render', 02:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:11 INFO - 'HOME': '/Users/cltbld', 02:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:11 INFO - 'LOGNAME': 'cltbld', 02:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:11 INFO - 'MOZ_NO_REMOTE': '1', 02:50:11 INFO - 'NO_EM_RESTART': '1', 02:50:11 INFO - 'PAGER': '/bin/cat', 02:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:11 INFO - 'PWD': '/builds/slave/test', 02:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:11 INFO - 'SHELL': '/bin/bash', 02:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGBdg0DJKH/Listeners', 02:50:11 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 02:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:11 INFO - 'USER': 'cltbld', 02:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:11 INFO - 'XPC_FLAGS': '0x0', 02:50:11 INFO - 'XPC_SERVICE_NAME': '0', 02:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:12 INFO - Downloading/unpacking jsonschema 02:50:12 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 02:50:12 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 02:50:12 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 02:50:12 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 02:50:12 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 02:50:12 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 02:50:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:50:14 INFO - Downloading/unpacking functools32 (from jsonschema) 02:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:15 INFO - Downloading functools32-3.2.3-2.tar.gz 02:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:50:15 INFO - warning: no files found matching '*.txt' 02:50:15 INFO - no previously-included directories found matching 'build' 02:50:15 INFO - no previously-included directories found matching 'dist' 02:50:15 INFO - no previously-included directories found matching '.git*' 02:50:15 INFO - Installing collected packages: jsonschema, functools32 02:50:15 INFO - Running setup.py install for functools32 02:50:15 INFO - warning: no files found matching '*.txt' 02:50:15 INFO - no previously-included directories found matching 'build' 02:50:15 INFO - no previously-included directories found matching 'dist' 02:50:15 INFO - no previously-included directories found matching '.git*' 02:50:15 INFO - Successfully installed jsonschema functools32 02:50:15 INFO - Cleaning up... 02:50:15 INFO - Return code: 0 02:50:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:15 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 0x110537a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110547420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1514e6cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103d6e00>, '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 0x11023fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d1b20>, '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.3FNfntaYPM/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.tGBdg0DJKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 02:50:15 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 02:50:15 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 02:50:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3FNfntaYPM/Render', 02:50:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:15 INFO - 'HOME': '/Users/cltbld', 02:50:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:15 INFO - 'LOGNAME': 'cltbld', 02:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:15 INFO - 'MOZ_NO_REMOTE': '1', 02:50:15 INFO - 'NO_EM_RESTART': '1', 02:50:15 INFO - 'PAGER': '/bin/cat', 02:50:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:15 INFO - 'PWD': '/builds/slave/test', 02:50:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:15 INFO - 'SHELL': '/bin/bash', 02:50:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGBdg0DJKH/Listeners', 02:50:15 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 02:50:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:15 INFO - 'USER': 'cltbld', 02:50:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:15 INFO - 'XPC_FLAGS': '0x0', 02:50:15 INFO - 'XPC_SERVICE_NAME': '0', 02:50:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:15 INFO - Downloading/unpacking flake8 02:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:50:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:50:18 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 02:50:18 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 02:50:18 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 02:50:18 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 02:50:18 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 02:50:18 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 02:50:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:50:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:50:18 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 02:50:18 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 02:50:18 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 02:50:18 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 02:50:18 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 02:50:18 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 02:50:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:50:18 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 02:50:18 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 02:50:18 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 02:50:18 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 02:50:18 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 02:50:18 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 02:50:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:50:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:50:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:50:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:50:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:50:19 INFO - no previously-included directories found matching 'docs/_build' 02:50:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:50:19 INFO - Running setup.py install for pep8 02:50:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:50:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:50:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:50:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:50:19 INFO - no previously-included directories found matching 'docs/_build' 02:50:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:50:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:50:19 INFO - Cleaning up... 02:50:19 INFO - Return code: 0 02:50:19 INFO - Running post-action listener: _resource_record_post_action 02:50:19 INFO - Running post-action listener: _start_resource_monitoring 02:50:19 INFO - Starting resource monitoring. 02:50:19 INFO - ##### 02:50:19 INFO - ##### Running install step. 02:50:19 INFO - ##### 02:50:19 INFO - Running pre-action listener: _resource_record_pre_action 02:50:19 INFO - Running main action method: install 02:50:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:50:19 INFO - Reading from file tmpfile_stdout 02:50:19 INFO - Detecting whether we're running mozinstall >=1.0... 02:50:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:50:20 INFO - Reading from file tmpfile_stdout 02:50:20 INFO - Output received: 02:50:20 INFO - Usage: mozinstall [options] installer 02:50:20 INFO - Options: 02:50:20 INFO - -h, --help show this help message and exit 02:50:20 INFO - -d DEST, --destination=DEST 02:50:20 INFO - Directory to install application into. [default: 02:50:20 INFO - "/builds/slave/test"] 02:50:20 INFO - --app=APP Application being installed. [default: firefox] 02:50:20 INFO - mkdir: /builds/slave/test/build/application 02:50:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:50:51 INFO - Reading from file tmpfile_stdout 02:50:51 INFO - Output received: 02:50:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:50:51 INFO - Running post-action listener: _resource_record_post_action 02:50:51 INFO - ##### 02:50:51 INFO - ##### Running run-tests step. 02:50:51 INFO - ##### 02:50:51 INFO - Running pre-action listener: _resource_record_pre_action 02:50:51 INFO - Running main action method: run_tests 02:50:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:50:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:50:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:50:51 INFO - 2016-06-03 02:50:51.240 screenresolution[1650:8226] starting screenresolution argv=screenresolution get 02:50:51 INFO - 2016-06-03 02:50:51.242 screenresolution[1650:8226] Display 0: 1600x1200x32@60 02:50:51 INFO - 2016-06-03 02:50:51.250 screenresolution[1651:8228] starting screenresolution argv=screenresolution list 02:50:51 INFO - Available Modes on Display 0 02:50:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:50:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:50:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:50:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:50:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:50:51 INFO - Intel Iris: 02:50:51 INFO - Chipset Model: Intel Iris 02:50:51 INFO - Type: GPU 02:50:51 INFO - Bus: Built-In 02:50:51 INFO - VRAM (Dynamic, Max): 1536 MB 02:50:51 INFO - Vendor: Intel (0x8086) 02:50:51 INFO - Device ID: 0x0a2e 02:50:51 INFO - Revision ID: 0x0009 02:50:51 INFO - Displays: 02:50:51 INFO - Display: 02:50:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:50:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:50:51 INFO - Display Serial Number: 1600x1200 60 02:50:51 INFO - Main Display: Yes 02:50:51 INFO - Mirror: Off 02:50:51 INFO - Online: Yes 02:50:51 INFO - Rotation: Supported 02:50:51 INFO - Return code: 0 02:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:50:51 INFO - Python 2.7.3 02:50:51 INFO - Return code: 0 02:50:51 INFO - grabbing minidump binary from tooltool 02:50:51 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')]} 02:50:51 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 0x1103d6e00>, '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 0x11023fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103d1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:50:51 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 02:50:51 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 02:50:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:50:51 INFO - Return code: 0 02:50:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:50:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:50:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:50:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:50:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:50:52 INFO - Return code: 0 02:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--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 02:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0365 --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 02:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3FNfntaYPM/Render', 02:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:52 INFO - 'HOME': '/Users/cltbld', 02:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:52 INFO - 'LOGNAME': 'cltbld', 02:50:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:50:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:52 INFO - 'MOZ_NO_REMOTE': '1', 02:50:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:50:52 INFO - 'NO_EM_RESTART': '1', 02:50:52 INFO - 'PAGER': '/bin/cat', 02:50:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:52 INFO - 'PWD': '/builds/slave/test', 02:50:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:52 INFO - 'SHELL': '/bin/bash', 02:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGBdg0DJKH/Listeners', 02:50:52 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 02:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:52 INFO - 'USER': 'cltbld', 02:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:52 INFO - 'XPC_FLAGS': '0x0', 02:50:52 INFO - 'XPC_SERVICE_NAME': '0', 02:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--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 02:50:52 INFO - mozversion application_buildid: 20160603004101 02:50:52 INFO - mozversion application_changeset: effbb9ad4e93c4383e484f3a515d23194d3c6329 02:50:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:50:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:50:52 INFO - mozversion application_name: Firefox 02:50:52 INFO - mozversion application_remotingname: firefox-dev 02:50:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:50:52 INFO - mozversion application_vendor: Mozilla 02:50:52 INFO - mozversion application_version: 48.0a2 02:50:52 INFO - mozversion platform_buildid: 20160603004101 02:50:52 INFO - mozversion platform_changeset: effbb9ad4e93c4383e484f3a515d23194d3c6329 02:50:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:50:52 INFO - mozversion platform_version: 48.0a2 02:50:52 INFO - using testdate: 1464947452 02:50:52 INFO - actual date: 1464947452 02:50:52 INFO - starting webserver on 'localhost:49276' 02:50:52 INFO - SUITE-START | Running 2 tests 02:50:52 INFO - TEST-START | dromaeo_css 02:50:52 INFO - operating with platform_type : mac_ 02:50:52 INFO - Initialising browser for dromaeo_css test... 02:50:52 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpQtl63k/profile http://localhost:49276/getInfo.html) 02:50:56 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 02:50:56 INFO - PROCESS | 1669 | colorDepth:24 02:50:56 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 02:50:56 INFO - PROCESS | 1669 | __metrics 02:50:56 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:50:56 INFO - TEST-INFO | 1669: exit 0 02:50:56 INFO - Browser initialized. 02:50:56 INFO - Running cycle 1/1 for dromaeo_css test... 02:50:56 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpQtl63k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:08 INFO - PROCESS | 1674 | RSS: Main: 220635136 02:51:08 INFO - PROCESS | 1674 | 02:51:58 INFO - PROCESS | 1674 | 1464947518411 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] 02:54:09 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 02:54:11 INFO - PROCESS | 1674 | RSS: Main: 231354368 02:54:11 INFO - PROCESS | 1674 | 02:57:13 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 02:57:13 INFO - PROCESS | 1674 | RSS: Main: 243048448 02:57:13 INFO - PROCESS | 1674 | 03:00:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 03:00:16 INFO - PROCESS | 1674 | RSS: Main: 245133312 03:00:16 INFO - PROCESS | 1674 | 03:03:17 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 03:03:18 INFO - PROCESS | 1674 | RSS: Main: 247742464 03:03:18 INFO - PROCESS | 1674 | 03:06:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 03:06:21 INFO - PROCESS | 1674 | RSS: Main: 249671680 03:06:21 INFO - PROCESS | 1674 | 03:09:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 03:09:24 INFO - PROCESS | 1674 | RSS: Main: 251752448 03:09:24 INFO - PROCESS | 1674 | 03:09:24 INFO - PROCESS | 1674 | __start_tp_report 03:09:24 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 03:09:24 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 03:09:24 INFO - PROCESS | 1674 | |i|pagename|runs| 03:09:24 INFO - PROCESS | 1674 | |0;dojo.html;3280.4259254630433;3446.9655303446966;3464.2725027744173;3505.193805424753;3519.6480351964806;5069.9493005069935;5276.314079169707;5742.741576629051;5796.50729687977;5796.739146738396;5754.942450575493;5759.049756790125;5802.332731735852;5843.912341314873;5851.063829787235;5306.283651707028;5309.070912590281;5325.334333208349;5373.462653734615;5375.543078838304;5250.264962905197;5394.811181608645;5396.5952553558445;5405.405405405402;5430.402655707869;4500.774961251941;5373.570114390839;5374.220737992989;5385.676859388449;5391.892162156754;5322.281491998569;5352;5359.598030147716;5364.678119312854;5367.141257398817;5190.636655434121;5268.525832675077;5325.520703136697;5355.384130824966;5373.086575282172;5743.971280143614;5750.281214848144;5785.595008349417;5798.275215598051;5806.941930580682;6125.724342404558;6126.9452004266695;6215.7513699451965;6272.937270627326;6280.560360774748;6193.535484838655;6244.625322480666;6250.249970003583;6260.624362538217;6273.435390814803;5057.266696329012;5847.590668653196;5878.353381128115;5917.023691090965;5929.703514824241;6168.414000669929;6274.341194174637;6292.402221788922;6314.116023756677;6330.493560515148;6170.5372097092;6238.500919926395;6241.906371404432;6243.500519958392;6250.249970003538;6205.379462053849;6230.252369715663;6253.6873156342;6253.812385628438;6259.624422534572;6115.331611965994;6166.458385403649;6235.719392627343;6268.435840774261;6282.963311053625;5491.039068163135;6108.847278818065;6245.437910587978;6284.308726040132;6288.748450061947;4813.9037219255415;4946.925796113062;4969.3291405659775;4991.550760431506;5011.523905228997;4021.3766866135797;4282.721623094551;4462.665300102441;4467.24056910326;4473.306637471197;5796.942030579725;5836.88326233473;5845.824625261249;5853.560982926298;5867.911981320283;6212.378762123752;6247.375262473807;6259.0924315973925;6261.96869015652;6271.027990661455;4894.143524883131;5697.857553561194;5849.415058494116;5874.618149820248;5875.383084776037;5404.83785486436;5443.34679838414;5459.099248623933;5470.589705772083;5472.589555783253;6230.968845155745;6349.333320001333;6371.872562548816;6379.617222966637;6381.649009304533;4785.114753770564;5273.393559740679;6164.599301045418;6172.722227499863;6180.289266734203;5065.696058236517;5695.8860822784145;6381.298057213796;6385.201849768779;6397.200349956255;6266.530010249158;6269.059641053878;6281.96859015702;6290.2451705793765;6307.779227727191;6115.602485838406;6193.318734939243;6219.315875253628;6241.157443745036;6249.9062514063235;6136.171616831671;6200.3179650237535;6232.844178895382;6233.875322493434;6241.3134555197985;5831.620944638585;6199.969000154971;6237.313895471404;6246;6246.500279977682;5786.537077033911;5903.173555702119;6059.484943779652;6068.241469816273;6096.8780624388155;6172.290186628596;6180.351063138306;6181.258249010148;6192.783252586318;6200.875982480416;5831.679257640871;6004.099385092271;6066.907956567684;6084.726187321669;6101.7559297627595 03:09:24 INFO - PROCESS | 1674 | |1;ext.html;510.9194054574576;523.5994464234861;539.196597070365;550.6668465578327;555.6832605414912;35228;38661.420078698844;38893.61106388935;38960.61039389605;38977.41533876994;42306;42585;42852.14295714092;42865.92835179122;42931.78534107333;9542.379745316566;9775.804483910317;9783.95108024459;9801.41191528507;9801.754956126082;9637.180839628605;9670.854937175947;9742.269329800258;9770.267229957746;9789.510524473784;9679.854802177937;9739.756506087333;9748.171405430547;9767.120959113678;9779.608815647365;8411.327093832479;9511.096445837635;9621.326507144502;9661.227101831872;9715.125638692516;9585;9608.951955240249;9609.615615375447;9700.951495242478;9752.414855108716;32486.675133248602;33356.49965250499;35846.953008994264;39301.803490982646;39329.60670393288;2686.489566982267;3211.5343275224964;3257.625373082102;3305.8677652893857;3400.9797060881883;27711.584326235123;28062;28504.857475712695;28549.000784972635;29748.8512557438;2455.58255096634;2756.834589924611;2771.2656146121094;2776.0422654184276;2913.009576743917;345487;345609;349754;351113.24443377875;351206;30152;36864.63135368612;59474.405255946884;59975.700121499984;60119;34736;34776.82611586926;35273.47089793655;35530.46704299437;35579;15480.071195728293;15639.609009774847;15665.373385064699;15668.138252396;15698.450554230547;12855.935720321526;12860.356982150855;13172.341382931007;13235.801462978063;13245.337733113305;8094;8110.959445202854;8262.876056859031;8386.287165590871;8398.41211115216;3070.1250143708935;3486.337595856779;3490;3525.5593050868642;3559;997.9950100249453;1039.2050081687514;1051.8683327042663;1072.324435605579;1130.2257953302014;30085.849570752005;30099.699003010126;30174.54738178929;30252.394952100836;30401.847990759903;925.953702314895;1078.1374900079904;1078.660222030058;1110.9666709998712;1141.7431078007548;14563.927180364242;15305.770413443808;15522.37910483568;15682.47533311468;15702.214889255492;625793;630979;632701;639106;643878;57981;58296.70851645715;58738.70630646819;58784;58942.70528647329;1496.9775453368209;1516.2494565190082;1517.67370015445;1522.1247782524872;1527.9236038198046;28854.711452885203;29597.704022959493;29885.5517167247;30454.84772576123;30466.84766576153;51664;52090.47909520856;52419;52449.47550524446;52451.475485246185;560507;566755;566964;569745;571538;26923;27275.31811704723;27356.452870942867;27390.767415465954;41979.95050123771;42799.3580096305;43361;44116.67649970506;44956;47066.76466617645;35713.28573428465;35820.462693060144;36050.63949360473;36189;36490.27019459649;34773;34865.47701784526;35187.82406087953;35385.292294153456;35555.644443556266;34847.303053938274;35255.64744352524;35277.76527821514;35429.46855797217;35600.821995889855;30932.53601196029;33164.33671326608;33165.33669326552;33189.33621327608;33420;24774.25677229686;25045;25124;25462;25512.362190945376 03:09:24 INFO - PROCESS | 1674 | |2;jquery.html;380.8933498620386;402;402.29196613959425;405.5640186799191;410.9486314210724;20110;20465.795342046575;20798.89600551999;20862.06120724567;21487.785122148773;20225.797742022576;20513.38459846207;20804.89597552014;20932;21176.576468470623;5519.254900588419;5655.095184770437;5927.555433342495;6005.579609427342;6013.368596297391;5191.377034755816;5819;5819.912701309484;5873.383294754053;5936;5642.351129620085;5777.682227477487;5835.649861008353;5933.406659334075;5933.851653708649;5787.21872547207;5819.156222347757;5838.095095260199;5853.268341457318;5859.882802343951;4919.926201106986;5156.278121063054;5178.352705911761;5228.764705588258;5261.579073674096;26318;26477;26752;26773.73226267732;26851.462970740475;2067.7208576842086;2189.4745261137373;2458.7172475165407;2614.3202767280454;2803.0189433698247;14594.70810583793;14652.780208296885;14744.778828317583;14962.17708026058;15015.924920375328;1660.1865086107841;1670.9665806683797;1681.6720739455811;1727.8704097192635;1767.2842498788011;105079;106935.93064069415;110273.34589981157;112951;114491;10912.945435272773;11310.208285419942;11316.094712422986;11337.489812958273;11451.484683189277;12190.634280971584;14194.361253743606;14254.857451425352;14295.642608934651;14305;8904.376693631384;8913.688020919237;8948.105189481;8964.775880602907;9040.231580315747;9075.500847453453;9117.673476312659;9160.038195989458;9209.079092090871;9213.35506514551;5666.829995100154;6837.589744615339;6923.2038315593345;6940.444764418834;6984.406325462291;1928.5275107598727;1958.5886963737776;1995.8764533505018;2003.8697484663742;2005.1878989009474;905.4883990545321;978.2907392140642;1029.7425643589104;1100.2518287564533;1131.4229742831214;20840.895795520926;21369.931503424767;21497.355079347646;21760.673589896163;21848.344549663536;864.8183881384854;994.2791476179711;994.2990191914682;1052.1214785654065;1075.6504136155781;8958.68644597436;9552.808943821085;9970;10494.475276236157;11740.236884602473;245632;608545.9572702108;612510.6204332091;619661;631007.534886977;82750.17249827425;115501;117416.8258317423;118748;120890;1046.8011077895176;1049.1606714628267;1065.1798115451058;1068.5832525315288;1069.550788668761;19113.90443047776;19167.94576298317;19191.52021199481;19392.030398480303;19454.12456439492;48708;49105.75447122742;50272.74863625658;51131.23303150381;51884.96230075302;71890.64054679693;73250;74295;74647;76656;7561.3950883928055;7732.690692372242;8050.27547520726;8137.79655508617;8181.059178194584;12492.188007779465;12814.871851281368;12987.285699286253;13035.47858085666;13248.20510769357;11031.558737650725;11130.16523760705;11270.042046426146;11467.910548497879;11564.537418503165;9678.806423871623;10893.455327233765;10995.230333876552;11223.831642525205;11425.942870285595;10599.682009539727;11461.4269286537;11493.138014649103;11687.649370518899;11802.114841387101;7970.960145199469;7995.960525131928;8061.717839875576;8127.2279133482225;8197.46716463428;11187.32876027441;11354.489047993025;11430.942845285721;11461.255018423775;11581.478833452345 03:09:24 INFO - PROCESS | 1674 | |3;mootools.html;1439.6688761584835;1605.3498333175064;1802.810704875988;1896.1751638037454;1967.2622766462578;7778.066632004154;8363.916360836405;8541.145885411455;8835;8862.423942443746;8531.78670533237;8554.272886804614;8654.048054713976;8670.913290867089;8713.477191368507;2373.9169129080487;2384.3204686664303;2392.0670938334065;2402.267308470916;2407.843490173133;2098.8635738677012;2425.2118061629953;2451.669024681663;2465.9876700616473;2471.5798314286526;2300.6779050932882;2316.733575638798;2337.0885354711677;2340.4499942513494;2343.5195784864145;2441.389652586853;2453.0433131078894;2463.901443942258;2479.8760061996827;2485.1177831869695;2148.3877095027997;2430.2466235466886;2453.0678342230017;2457.1400009996537;2464.7904928081134;8647.394682372236;8756;8786.07746186654;8818.426802257833;8834.911650883474;5364.088105022156;5487.506124448779;5506.504414602705;5529.695866727328;5545.390007099216;3533.699635530957;3598.6401359863803;3651.47053677218;3652.36083685354;3666.3767159582935;950.5627411390768;972.7665360313474;976.4336684722844;977.1010670183377;1024.8052869954686;11581.652550423416;11887.10846686502;11893.702657433547;11903.226290291102;11934.104942129288;4868.367112275381;4890.877728056827;4953.207486802166;4981.402231732215;4991.376077990251;9969.202463802878;10045.045720656526;10153;10153.543090560943;10155.593776248867;5425.810096646598;5436.130219164915;5465.453454654503;5515.889682206333;5534.335879694462;4400.691951563424;4820.035992801384;4909.042736666387;4909.729964851896;5022.7990880365105;3768.981155094262;3825.8087095645665;3829.0235989822418;3832.80835958201;3869.090763670535;1131.8664317760915;1360.31984007996;1374.6632075141454;1376.1399125546534;1380.8550102239121;931.8369285375032;933.6545478173119;934.3226161033197;956.9138777510058;974.8294048541477;5823.039198532279;5915.201447804578;5974.522038236931;6065.484433823086;6090.33006369299;465.0698602794411;471.32129733184104;474.74126601002536;476.790212306584;489.56917912237003;3722.962770372316;3725.75187312248;3917.353636649978;3941.8226179821404;4046.919061618751;10518.737031574272;10578.788424231472;10654;10766.192535559865;10910.399928003877;10468.581256749645;10493.632722854663;10525;10563.313384629975;10622.575096996188;8202.097769245378;8247.95876020616;8267.131951145164;8409.285210757032;8459.069502354736;5549.334079910436;5741.531638583815;5751.396103409082;5813.15709222152;6004.189434426296;9276.350655454053;9310.813783724423;9323.440593564408;9388.906110938804;9403.871535415521;9543.665971690958;9644.324897257125;9684.837819461709;9715.659951901649;9801.11789938909;6806.319368063154;7315.049043624294;7348.742794002184;7445.4415918805225;7502.287282708134;8149.551774652451;8201.95899020501;8206.302464290364;8206.835863282582;8306.169383061646;7197.640117993975;7349.4855360124275;7353.889691654736;7438.404927605887;7480.3641690456925;7188.712451501881;7264.237255088351;7277.38142257914;7352.264773522605;7367.300106489874;7010.018597396471;7038.507304488637;7074.186468555976;7076.433885289268;7077.893831592633;4924;5105.821296254613;5146.228065790161;5211.635185536976;5213.739313034409;4880.560749532559;5192.013517431676;5265.262863199232;5272;5394.624370785425 03:09:24 INFO - PROCESS | 1674 | |4;prototype.html;319.3102897740882;326.39942505789344;332.70555558330875;333.0292198242124;334.60850804558663;6674.666266686659;6682.465402767779;6699.899501507482;6760.087388202591;6768.458523318135;6780.864382712342;6796.830079248009;6804.319568043205;6810.761623343184;6827.146606674153;5003.149464591028;5028.798848046092;5035.597152227831;5037.471065538111;5051.747412629354;5039.420466646327;5045.772940217699;5046.772895219724;5050;5071.492850714917;3783.69730421567;4934.383202099738;4966.553010229079;4979.751012449381;4983.725895075788;4689.413823272091;4881.316615673809;4970.726610036429;4975.626827987898;5012.52381023804;3717.5538935327663;3917.177392747498;4140.130572579762;4153.231652144363;4177.97911010446;6447.419732224075;6513.250976137758;6518.250401203874;6530.510211734091;6556.901646475307;5782.421757824226;5808.535317174616;5811.738471768781;5813.854653633651;5833.4749872511675;7190.820229494252;7196.928030719678;7207.38737207338;7210.459215558802;7244.782656520313;3699.8890033298776;4652.488226295105;4663.906721865544;4665.766711664403;4688.718676879398;6588.472922166263;6895.034695142684;7527.096748390229;7595.202503737139;7639.350655194316;3969.900752481153;4680.438347398334;4726.385569875963;4731.976340118277;4737.336772851803;4120.484939382577;4727.770779597329;4823.493533179036;4836.419629644465;4841.080194763054;4752.2158843790385;5716.456936591017;5768.3366412862215;5786.797462088891;5789.768409263666;5877.353491115974;6979.511434199659;7240;7258.782236532807;7276.235995220532;1643.3919449803411;1650.521348808856;1664.9334026638799;1668.549491637251;1671.540326410247;986.2356673577891;1039.248865661363;1047.984280235797;1062.4793851013103;1069.9781708468395;5944.840756052615;6426.935730642634;6658.6337751424135;6797.728090876409;6801.047853300542;7558.508696934791;7594.924050759532;7598.544087354777;7608.31525162738;7640.541567505968;6785.898211526733;6793.932060679429;6799.796006119825;6804.489663275274;6830.692618832164;3853.7880416576795;3943.2902077626304;3951.308521008812;3976.602339766;4007.6192761687594;7450.547143307003;7748.8450230996195;7878.487898286593;7884.29041386278;7922.128565857751;6775.593464392152;7818.765437036898;7831.569263690438;7839;7840.45116841827;7844.529328240324;7886;7890.9605451972375;7898.9210107899335;7915.683372665029;6094.3600921904335;7238.8914166286495;7524.435667325082;7543.547387156788;7554.66004029809;5983.982722937024;7313.817154571178;7402.629868506661;7411.147718012282;7429.331360177393;7914.762557123296;7916.129225785044;7923.564203968606;7930.405219608437;7962.243586859239;4657;4741.170295198395;4742.66801323904;4744.810207591796;4746.098241334135;7179.210286868336;7453.105627324756;7544.905988631727;7565.2812982766545;7581;7197.352238298578;7215.927840721525;7255.709771609077;7263.164736055422;7269.709211631475;7219.494635375473;7250.891236631349;7252.4560657949805;7273;7298.2701729826595;7064.986478853502;7075.893861591977;7081.645917704197;7094;7096.325849044539;6507.577007494498;6509.967450162719;6758.2565917748025;7275.8181045472165;7300.634968251672;5469.890602188014;5740.030368416967;6709.329067093252;6985.1967023790885;7029.929700702927 03:09:24 INFO - PROCESS | 1674 | |5;yui.html;684.7979845945446;719.6581623728727;747.9476436649435;751.9134850141547;757.7953952432844;14634.926825365857;14727.705445891075;14888.702225955501;15005.249737513122;15022.92488537557;11209.551617935273;11480.425978701074;12439.129260951715;13937.58187254384;13988.58034258974;736.7936977646268;912.9087091290884;925.430860021089;928.5496534180917;951.1487218939045;936.7798567336671;936.8875734911786;938.6339327662217;938.7887725261829;940.0740270833223;939.2439086535336;986.57577241786;993.2203220471931;997.4065431068502;997.6358629100399;966.4587830814731;980.6273616025865;987.5605355616754;988.9604415823359;989.4211886046635;726.2809818279918;726.8400951790597;728.726727477196;746.171749358212;747.0810902589791;14959.551213463614;15068.472603458937;15076.321565529577;15120.5463836084;15152.393904243818;12472.688182795502;12513.812292815615;12552.560660376843;12717.364131793465;12752.80870786939;9966.750831229205;10062.698119056367;10070.69787906364;10353.327033742782;10369.481525923673;3463.740219483549;3485.6862882340456;3494.0391392367046;3498.4577390504514;3501.3872572299747;76192.23807761907;77536;77603.6119819403;79678.60160699218;80072.59963700145;9251.306152038489;9469.526523673789;9513.04869513057;9582.952085239669;9755.609775609038;20676;20682.965851707355;20696.58606827855;20726.792732072485;20765.79234207669;5821.767129314865;7293.16128645202;7340.816479588053;7418.035655364876;7475.962620186864;3941.684665226775;4148.730332528376;4166.8749937501925;4172.436721042681;4200.075983283734;3706.7961262130843;3744.7940363279736;3747.194353214072;3771.151490914522;3774.962250377516;698.4935921456903;708.2634060577045;731.3016069653468;732.74353976109;742.5730205132071;500.269606374697;528.8915772266677;550.3423409026175;552.7208759576388;569.0042425754929;8164.142765009708;8219.178082191733;8236.917630823615;8251.463654862535;8365.8326833463;573;577.7688924430178;604.9866473656607;607.2955371768727;619.2012304127715;3384.340053689507;3722.7952462614817;3735.701143908481;3873.2253549290253;3995.5604883462797;93929;95795;96732;96985;97190.51404742931;76850.23149768542;77222.22777772263;78401;78993.0251743711;82248.17751822525;64227.6788616054;65351.346486535476;66173.66913165404;67605;69594.65202673954;7904.762857114296;8344.207300306462;8460.407771455939;8534.359923005924;8795.749998755138;47216.527834721215;48052.75973620109;49944.25083623676;49953;50226.74886625543;64630;66876.6656166716;66881.99677004946;68161.65919170373;69303.65348173227;10925.945370273097;11016.944915275373;11155.944220278847;11171.724398338549;11289.20975531705;11971.521139154336;11976.580819671619;12062.336571488653;12083.69790755203;12525.060620453685;11215.55137794479;11321.830172547583;11426;11605.535778569101;12222.572209972608;11155.442227888736;11508.94245528767;11515.30908145514;11570.479328430072;11574.189806713786;10470.738231544272;11036.337819730841;11290;11469.0251328638;11536.884631153582;9736.172425343924;9965;9967.302288839712;10067.496625168858;10210.234232432449;9609.9039009609;9761.951190244003;9819.263555233529;9828.967958364268;9877.753056173366 03:09:24 INFO - PROCESS | 1674 | __end_tp_report 03:09:24 INFO - PROCESS | 1674 | __start_cc_report 03:09:24 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,414 03:09:24 INFO - PROCESS | 1674 | __end_cc_report 03:09:24 INFO - PROCESS | 1674 | __startTimestamp1464948564233__endTimestamp 03:09:24 INFO - PROCESS | 1674 | 03:09:24 INFO - PROCESS | 1674 | ------- Summary: start ------- 03:09:24 INFO - PROCESS | 1674 | Number of tests: 6 03:09:24 INFO - PROCESS | 1674 | 03:09:24 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5754.41 Median:5917.02 stddev:647.40 (10.9%) stddev-sans-first:619.62 03:09:24 INFO - PROCESS | 1674 | Values: 3280.4 3447.0 3464.3 3505.2 3519.6 5069.9 5276.3 5742.7 5796.5 5796.7 5754.9 5759.0 5802.3 5843.9 5851.1 5306.3 5309.1 5325.3 5373.5 5375.5 5250.3 5394.8 5396.6 5405.4 5430.4 4500.8 5373.6 5374.2 5385.7 5391.9 5322.3 5352.0 5359.6 5364.7 5367.1 5190.6 5268.5 5325.5 5355.4 5373.1 5744.0 5750.3 5785.6 5798.3 5806.9 6125.7 6126.9 6215.8 6272.9 6280.6 6193.5 6244.6 6250.2 6260.6 6273.4 5057.3 5847.6 5878.4 5917.0 5929.7 6168.4 6274.3 6292.4 6314.1 6330.5 6170.5 6238.5 6241.9 6243.5 6250.2 6205.4 6230.3 6253.7 6253.8 6259.6 6115.3 6166.5 6235.7 6268.4 6283.0 5491.0 6108.8 6245.4 6284.3 6288.7 4813.9 4946.9 4969.3 4991.6 5011.5 4021.4 4282.7 4462.7 4467.2 4473.3 5796.9 5836.9 5845.8 5853.6 5867.9 6212.4 6247.4 6259.1 6262.0 6271.0 4894.1 5697.9 5849.4 5874.6 5875.4 5404.8 5443.3 5459.1 5470.6 5472.6 6231.0 6349.3 6371.9 6379.6 6381.6 4785.1 5273.4 6164.6 6172.7 6180.3 5065.7 5695.9 6381.3 6385.2 6397.2 6266.5 6269.1 6282.0 6290.2 6307.8 6115.6 6193.3 6219.3 6241.2 6249.9 6136.2 6200.3 6232.8 6233.9 6241.3 5831.6 6200.0 6237.3 6246.0 6246.5 5786.5 5903.2 6059.5 6068.2 6096.9 6172.3 6180.4 6181.3 6192.8 6200.9 5831.7 6004.1 6066.9 6084.7 6101.8 03:09:24 INFO - PROCESS | 1674 | 03:09:24 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:64003.54 Median:35479.97 stddev:142322.61 (401.1%) stddev-sans-first:142642.03 03:09:24 INFO - PROCESS | 1674 | Values: 510.9 523.6 539.2 550.7 555.7 35228.0 38661.4 38893.6 38960.6 38977.4 42306.0 42585.0 42852.1 42865.9 42931.8 9542.4 9775.8 9784.0 9801.4 9801.8 9637.2 9670.9 9742.3 9770.3 9789.5 9679.9 9739.8 9748.2 9767.1 9779.6 8411.3 9511.1 9621.3 9661.2 9715.1 9585.0 9609.0 9609.6 9701.0 9752.4 32486.7 33356.5 35847.0 39301.8 39329.6 2686.5 3211.5 3257.6 3305.9 3401.0 27711.6 28062.0 28504.9 28549.0 29748.9 2455.6 2756.8 2771.3 2776.0 2913.0 345487.0 345609.0 349754.0 351113.2 351206.0 30152.0 36864.6 59474.4 59975.7 60119.0 34736.0 34776.8 35273.5 35530.5 35579.0 15480.1 15639.6 15665.4 15668.1 15698.5 12855.9 12860.4 13172.3 13235.8 13245.3 8094.0 8111.0 8262.9 8386.3 8398.4 3070.1 3486.3 3490.0 3525.6 3559.0 998.0 1039.2 1051.9 1072.3 1130.2 30085.8 30099.7 30174.5 30252.4 30401.8 926.0 1078.1 1078.7 1111.0 1141.7 14563.9 15305.8 15522.4 15682.5 15702.2 625793.0 630979.0 632701.0 639106.0 643878.0 57981.0 58296.7 58738.7 58784.0 58942.7 1497.0 1516.2 1517.7 1522.1 1527.9 28854.7 29597.7 29885.6 30454.8 30466.8 51664.0 52090.5 52419.0 52449.5 52451.5 560507.0 566755.0 566964.0 569745.0 571538.0 26923.0 27275.3 27356.5 27390.8 41980.0 42799.4 43361.0 44116.7 44956.0 47066.8 35713.3 35820.5 36050.6 36189.0 36490.3 34773.0 34865.5 35187.8 35385.3 35555.6 34847.3 35255.6 35277.8 35429.5 35600.8 30932.5 33164.3 33165.3 33189.3 33420.0 24774.3 25045.0 25124.0 25462.0 25512.4 03:09:24 INFO - PROCESS | 1674 | 03:09:24 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:32898.10 Median:12018.91 stddev:93880.92 (781.1%) stddev-sans-first:94112.53 03:09:24 INFO - PROCESS | 1674 | Values: 380.9 402.0 402.3 405.6 410.9 20110.0 20465.8 20798.9 20862.1 21487.8 20225.8 20513.4 20804.9 20932.0 21176.6 5519.3 5655.1 5927.6 6005.6 6013.4 5191.4 5819.0 5819.9 5873.4 5936.0 5642.4 5777.7 5835.6 5933.4 5933.9 5787.2 5819.2 5838.1 5853.3 5859.9 4919.9 5156.3 5178.4 5228.8 5261.6 26318.0 26477.0 26752.0 26773.7 26851.5 2067.7 2189.5 2458.7 2614.3 2803.0 14594.7 14652.8 14744.8 14962.2 15015.9 1660.2 1671.0 1681.7 1727.9 1767.3 105079.0 106935.9 110273.3 112951.0 114491.0 10912.9 11310.2 11316.1 11337.5 11451.5 12190.6 14194.4 14254.9 14295.6 14305.0 8904.4 8913.7 8948.1 8964.8 9040.2 9075.5 9117.7 9160.0 9209.1 9213.4 5666.8 6837.6 6923.2 6940.4 6984.4 1928.5 1958.6 1995.9 2003.9 2005.2 905.5 978.3 1029.7 1100.3 1131.4 20840.9 21369.9 21497.4 21760.7 21848.3 864.8 994.3 994.3 1052.1 1075.7 8958.7 9552.8 9970.0 10494.5 11740.2 245632.0 608546.0 612510.6 619661.0 631007.5 82750.2 115501.0 117416.8 118748.0 120890.0 1046.8 1049.2 1065.2 1068.6 1069.6 19113.9 19167.9 19191.5 19392.0 19454.1 48708.0 49105.8 50272.7 51131.2 51885.0 71890.6 73250.0 74295.0 74647.0 76656.0 7561.4 7732.7 8050.3 8137.8 8181.1 12492.2 12814.9 12987.3 13035.5 13248.2 11031.6 11130.2 11270.0 11467.9 11564.5 9678.8 10893.5 10995.2 11223.8 11425.9 10599.7 11461.4 11493.1 11687.6 11802.1 7971.0 7996.0 8061.7 8127.2 8197.5 11187.3 11354.5 11430.9 11461.3 11581.5 03:09:24 INFO - PROCESS | 1674 | 03:09:24 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5696.94 Median:5212.69 stddev:3163.97 (60.7%) stddev-sans-first:3156.67 03:09:24 INFO - PROCESS | 1674 | Values: 1439.7 1605.3 1802.8 1896.2 1967.3 7778.1 8363.9 8541.1 8835.0 8862.4 8531.8 8554.3 8654.0 8670.9 8713.5 2373.9 2384.3 2392.1 2402.3 2407.8 2098.9 2425.2 2451.7 2466.0 2471.6 2300.7 2316.7 2337.1 2340.4 2343.5 2441.4 2453.0 2463.9 2479.9 2485.1 2148.4 2430.2 2453.1 2457.1 2464.8 8647.4 8756.0 8786.1 8818.4 8834.9 5364.1 5487.5 5506.5 5529.7 5545.4 3533.7 3598.6 3651.5 3652.4 3666.4 950.6 972.8 976.4 977.1 1024.8 11581.7 11887.1 11893.7 11903.2 11934.1 4868.4 4890.9 4953.2 4981.4 4991.4 9969.2 10045.0 10153.0 10153.5 10155.6 5425.8 5436.1 5465.5 5515.9 5534.3 4400.7 4820.0 4909.0 4909.7 5022.8 3769.0 3825.8 3829.0 3832.8 3869.1 1131.9 1360.3 1374.7 1376.1 1380.9 931.8 933.7 934.3 956.9 974.8 5823.0 5915.2 5974.5 6065.5 6090.3 465.1 471.3 474.7 476.8 489.6 3723.0 3725.8 3917.4 3941.8 4046.9 10518.7 10578.8 10654.0 10766.2 10910.4 10468.6 10493.6 10525.0 10563.3 10622.6 8202.1 8248.0 8267.1 8409.3 8459.1 5549.3 5741.5 5751.4 5813.2 6004.2 9276.4 9310.8 9323.4 9388.9 9403.9 9543.7 9644.3 9684.8 9715.7 9801.1 6806.3 7315.0 7348.7 7445.4 7502.3 8149.6 8202.0 8206.3 8206.8 8306.2 7197.6 7349.5 7353.9 7438.4 7480.4 7188.7 7264.2 7277.4 7352.3 7367.3 7010.0 7038.5 7074.2 7076.4 7077.9 4924.0 5105.8 5146.2 5211.6 5213.7 4880.6 5192.0 5265.3 5272.0 5394.6 03:09:24 INFO - PROCESS | 1674 | 03:09:24 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5852.62 Median:6678.57 stddev:1906.94 (28.6%) stddev-sans-first:1866.51 03:09:24 INFO - PROCESS | 1674 | Values: 319.3 326.4 332.7 333.0 334.6 6674.7 6682.5 6699.9 6760.1 6768.5 6780.9 6796.8 6804.3 6810.8 6827.1 5003.1 5028.8 5035.6 5037.5 5051.7 5039.4 5045.8 5046.8 5050.0 5071.5 3783.7 4934.4 4966.6 4979.8 4983.7 4689.4 4881.3 4970.7 4975.6 5012.5 3717.6 3917.2 4140.1 4153.2 4178.0 6447.4 6513.3 6518.3 6530.5 6556.9 5782.4 5808.5 5811.7 5813.9 5833.5 7190.8 7196.9 7207.4 7210.5 7244.8 3699.9 4652.5 4663.9 4665.8 4688.7 6588.5 6895.0 7527.1 7595.2 7639.4 3969.9 4680.4 4726.4 4732.0 4737.3 4120.5 4727.8 4823.5 4836.4 4841.1 4752.2 5716.5 5768.3 5786.8 5789.8 5877.4 6979.5 7240.0 7258.8 7276.2 1643.4 1650.5 1664.9 1668.5 1671.5 986.2 1039.2 1048.0 1062.5 1070.0 5944.8 6426.9 6658.6 6797.7 6801.0 7558.5 7594.9 7598.5 7608.3 7640.5 6785.9 6793.9 6799.8 6804.5 6830.7 3853.8 3943.3 3951.3 3976.6 4007.6 7450.5 7748.8 7878.5 7884.3 7922.1 6775.6 7818.8 7831.6 7839.0 7840.5 7844.5 7886.0 7891.0 7898.9 7915.7 6094.4 7238.9 7524.4 7543.5 7554.7 5984.0 7313.8 7402.6 7411.1 7429.3 7914.8 7916.1 7923.6 7930.4 7962.2 4657.0 4741.2 4742.7 4744.8 4746.1 7179.2 7453.1 7544.9 7565.3 7581.0 7197.4 7215.9 7255.7 7263.2 7269.7 7219.5 7250.9 7252.5 7273.0 7298.3 7065.0 7075.9 7081.6 7094.0 7096.3 6507.6 6510.0 6758.3 7275.8 7300.6 5469.9 5740.0 6709.3 6985.2 7029.9 03:09:24 INFO - PROCESS | 1674 | 03:09:24 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18183.33 Median:613.25 stddev:25633.59 (4180.0%) stddev-sans-first:25671.83 03:09:24 INFO - PROCESS | 1674 | Values: 684.8 719.7 747.9 751.9 757.8 14634.9 14727.7 14888.7 15005.2 15022.9 11209.6 11480.4 12439.1 13937.6 13988.6 736.8 912.9 925.4 928.5 951.1 936.8 936.9 938.6 938.8 940.1 939.2 986.6 993.2 997.4 997.6 966.5 980.6 987.6 989.0 989.4 726.3 726.8 728.7 746.2 747.1 14959.6 15068.5 15076.3 15120.5 15152.4 12472.7 12513.8 12552.6 12717.4 12752.8 9966.8 10062.7 10070.7 10353.3 10369.5 3463.7 3485.7 3494.0 3498.5 3501.4 76192.2 77536.0 77603.6 79678.6 80072.6 9251.3 9469.5 9513.0 9583.0 9755.6 20676.0 20683.0 20696.6 20726.8 20765.8 5821.8 7293.2 7340.8 7418.0 7476.0 3941.7 4148.7 4166.9 4172.4 4200.1 3706.8 3744.8 3747.2 3771.2 3775.0 698.5 708.3 731.3 732.7 742.6 500.3 528.9 550.3 552.7 569.0 8164.1 8219.2 8236.9 8251.5 8365.8 573.0 577.8 605.0 607.3 619.2 3384.3 3722.8 3735.7 3873.2 3995.6 93929.0 95795.0 96732.0 96985.0 97190.5 76850.2 77222.2 78401.0 78993.0 82248.2 64227.7 65351.3 66173.7 67605.0 69594.7 7904.8 8344.2 8460.4 8534.4 8795.7 47216.5 48052.8 49944.3 49953.0 50226.7 64630.0 66876.7 66882.0 68161.7 69303.7 10925.9 11016.9 11155.9 11171.7 11289.2 11971.5 11976.6 12062.3 12083.7 12525.1 11215.6 11321.8 11426.0 11605.5 12222.6 11155.4 11508.9 11515.3 11570.5 11574.2 10470.7 11036.3 11290.0 11469.0 11536.9 9736.2 9965.0 9967.3 10067.5 10210.2 9609.9 9762.0 9819.3 9829.0 9877.8 03:09:24 INFO - PROCESS | 1674 | -------- Summary: end -------- 03:09:24 INFO - PROCESS | 1674 | 03:09:24 INFO - TEST-INFO | 1674: exit 0 03:09:24 INFO - TEST-OK | dromaeo_css | took 1111804ms 03:09:24 INFO - TEST-START | kraken 03:09:24 INFO - operating with platform_type : mac_ 03:09:24 INFO - Initialising browser for kraken test... 03:09:24 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmp3JYp6u/profile http://localhost:49276/getInfo.html) 03:09:27 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 03:09:27 INFO - PROCESS | 1681 | colorDepth:24 03:09:27 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 03:09:27 INFO - PROCESS | 1681 | __metrics 03:09:27 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 03:09:28 INFO - TEST-INFO | 1681: exit 0 03:09:28 INFO - Browser initialized. 03:09:28 INFO - Running cycle 1/1 for kraken test... 03:09:28 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmp3JYp6u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:09:40 INFO - PROCESS | 1685 | RSS: Main: 220770304 03:09:40 INFO - PROCESS | 1685 | 03:09:42 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 03:09:43 INFO - PROCESS | 1685 | RSS: Main: 232910848 03:09:43 INFO - PROCESS | 1685 | 03:09:46 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 03:09:46 INFO - PROCESS | 1685 | RSS: Main: 241815552 03:09:46 INFO - PROCESS | 1685 | 03:09:50 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 03:09:50 INFO - PROCESS | 1685 | RSS: Main: 245235712 03:09:50 INFO - PROCESS | 1685 | 03:09:52 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 03:09:53 INFO - PROCESS | 1685 | RSS: Main: 246091776 03:09:53 INFO - PROCESS | 1685 | 03:09:55 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:09:56 INFO - PROCESS | 1685 | RSS: Main: 247676928 03:09:56 INFO - PROCESS | 1685 | 03:09:59 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 03:09:59 INFO - PROCESS | 1685 | RSS: Main: 247373824 03:09:59 INFO - PROCESS | 1685 | 03:10:02 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 03:10:03 INFO - PROCESS | 1685 | RSS: Main: 247480320 03:10:03 INFO - PROCESS | 1685 | 03:10:06 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 03:10:07 INFO - PROCESS | 1685 | RSS: Main: 247582720 03:10:07 INFO - PROCESS | 1685 | 03:10:08 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:10:09 INFO - PROCESS | 1685 | RSS: Main: 247205888 03:10:09 INFO - PROCESS | 1685 | 03:10:11 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:10:11 INFO - PROCESS | 1685 | RSS: Main: 247250944 03:10:11 INFO - PROCESS | 1685 | 03:10:13 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:10:14 INFO - PROCESS | 1685 | RSS: Main: 247459840 03:10:14 INFO - PROCESS | 1685 | 03:10:17 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:10:18 INFO - PROCESS | 1685 | RSS: Main: 247500800 03:10:18 INFO - PROCESS | 1685 | 03:10:20 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:10:21 INFO - PROCESS | 1685 | RSS: Main: 247558144 03:10:21 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 03:10:23 INFO - PROCESS | 1685 | RSS: Main: 249462784 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | __start_tp_report 03:10:23 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 03:10:23 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 03:10:23 INFO - PROCESS | 1685 | |i|pagename|runs| 03:10:23 INFO - PROCESS | 1685 | |0;ai-astar;111;120;111;116;120;117;106;114;117;117 03:10:23 INFO - PROCESS | 1685 | |1;audio-beat-detection;145;123;156;150;120;141;147;155;168;148 03:10:23 INFO - PROCESS | 1685 | |2;audio-dft;198;197;194;198;193;194;195;197;197;196 03:10:23 INFO - PROCESS | 1685 | |3;audio-fft;56;105;106;166;66;81;82;94;135;57 03:10:23 INFO - PROCESS | 1685 | |4;audio-oscillator;80;82;123;77;79;82;111;81;104;151 03:10:23 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;89;96;117;87;85;112;116;113;89;131 03:10:23 INFO - PROCESS | 1685 | |6;imaging-darkroom;94;150;94;94;95;95;108;95;94;101 03:10:23 INFO - PROCESS | 1685 | |7;imaging-desaturate;92;104;135;92;90;90;80;148;148;94 03:10:23 INFO - PROCESS | 1685 | |8;json-parse-financial;60;64;66;65;66;64;64;77;63;61 03:10:23 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;65;82;97;101;98;76;69;65;67;68 03:10:23 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;83;82;85;83;86;82;85;82;87;88 03:10:23 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;130;127;134;129;135;152;159;138;161;165 03:10:23 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;168;171;173;182;164;162;165;163;172;222 03:10:23 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;74;85;77;71;61;83;70;59;57;83 03:10:23 INFO - PROCESS | 1685 | __end_tp_report 03:10:23 INFO - PROCESS | 1685 | __start_cc_report 03:10:23 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,1094 03:10:23 INFO - PROCESS | 1685 | __end_cc_report 03:10:23 INFO - PROCESS | 1685 | __startTimestamp1464948623612__endTimestamp 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | ------- Summary: start ------- 03:10:23 INFO - PROCESS | 1685 | Number of tests: 14 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:114.90 Median:117.00 stddev:4.43 (3.8%) stddev-sans-first:4.47 03:10:23 INFO - PROCESS | 1685 | Values: 111.0 120.0 111.0 116.0 120.0 117.0 106.0 114.0 117.0 117.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:149.00 stddev:14.58 (9.8%) stddev-sans-first:15.46 03:10:23 INFO - PROCESS | 1685 | Values: 145.0 123.0 156.0 150.0 120.0 141.0 147.0 155.0 168.0 148.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:195.90 Median:197.00 stddev:1.79 (0.9%) stddev-sans-first:1.73 03:10:23 INFO - PROCESS | 1685 | Values: 198.0 197.0 194.0 198.0 193.0 194.0 195.0 197.0 197.0 196.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:94.80 Median:61.50 stddev:35.01 (56.9%) stddev-sans-first:34.21 03:10:23 INFO - PROCESS | 1685 | Values: 56.0 105.0 106.0 166.0 66.0 81.0 82.0 94.0 135.0 57.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:79.50 stddev:24.85 (31.3%) stddev-sans-first:25.58 03:10:23 INFO - PROCESS | 1685 | Values: 80.0 82.0 123.0 77.0 79.0 82.0 111.0 81.0 104.0 151.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:103.50 Median:86.00 stddev:16.15 (18.8%) stddev-sans-first:16.26 03:10:23 INFO - PROCESS | 1685 | Values: 89.0 96.0 117.0 87.0 85.0 112.0 116.0 113.0 89.0 131.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:102.00 Median:94.00 stddev:17.46 (18.6%) stddev-sans-first:18.28 03:10:23 INFO - PROCESS | 1685 | Values: 94.0 150.0 94.0 94.0 95.0 95.0 108.0 95.0 94.0 101.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:107.30 Median:90.00 stddev:25.99 (28.9%) stddev-sans-first:26.97 03:10:23 INFO - PROCESS | 1685 | Values: 92.0 104.0 135.0 92.0 90.0 90.0 80.0 148.0 148.0 94.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.50 stddev:4.64 (7.2%) stddev-sans-first:4.56 03:10:23 INFO - PROCESS | 1685 | Values: 60.0 64.0 66.0 65.0 66.0 64.0 64.0 77.0 63.0 61.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:78.80 Median:72.50 stddev:14.70 (20.3%) stddev-sans-first:14.71 03:10:23 INFO - PROCESS | 1685 | Values: 65.0 82.0 97.0 101.0 98.0 76.0 69.0 65.0 67.0 68.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:2.21 (2.6%) stddev-sans-first:2.30 03:10:23 INFO - PROCESS | 1685 | Values: 83.0 82.0 85.0 83.0 86.0 82.0 85.0 82.0 87.0 88.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:145.00 stddev:14.67 (10.1%) stddev-sans-first:14.78 03:10:23 INFO - PROCESS | 1685 | Values: 130.0 127.0 134.0 129.0 135.0 152.0 159.0 138.0 161.0 165.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:171.50 stddev:17.84 (10.4%) stddev-sans-first:18.78 03:10:23 INFO - PROCESS | 1685 | Values: 168.0 171.0 173.0 182.0 164.0 162.0 165.0 163.0 172.0 222.0 03:10:23 INFO - PROCESS | 1685 | 03:10:23 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:75.50 stddev:10.33 (13.7%) stddev-sans-first:10.93 03:10:23 INFO - PROCESS | 1685 | Values: 74.0 85.0 77.0 71.0 61.0 83.0 70.0 59.0 57.0 83.0 03:10:23 INFO - PROCESS | 1685 | -------- Summary: end -------- 03:10:23 INFO - PROCESS | 1685 | 03:10:24 INFO - TEST-INFO | 1685: exit 0 03:10:24 INFO - TEST-OK | kraken | took 59697ms 03:10:24 INFO - SUITE-END | took 1171s 03:10:24 INFO - Completed test suite (00:19:31) 03:10:24 INFO - javascript benchmark 03:10:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3280.4259254630433, 3446.9655303446966, 3464.2725027744173, 3505.193805424753, 3519.6480351964806, 5069.9493005069935, 5276.314079169707, 5742.741576629051, 5796.50729687977, 5796.739146738396, 5754.942450575493, 5759.049756790125, 5802.332731735852, 5843.912341314873, 5851.063829787235, 5306.283651707028, 5309.070912590281, 5325.334333208349, 5373.462653734615, 5375.543078838304, 5250.264962905197, 5394.811181608645, 5396.5952553558445, 5405.405405405402, 5430.402655707869, 4500.774961251941, 5373.570114390839, 5374.220737992989, 5385.676859388449, 5391.892162156754, 5322.281491998569, 5352.0, 5359.598030147716, 5364.678119312854, 5367.141257398817, 5190.636655434121, 5268.525832675077, 5325.520703136697, 5355.384130824966, 5373.086575282172, 5743.971280143614, 5750.281214848144, 5785.595008349417, 5798.275215598051, 5806.941930580682, 6125.724342404558, 6126.9452004266695, 6215.7513699451965, 6272.937270627326, 6280.560360774748, 6193.535484838655, 6244.625322480666, 6250.249970003583, 6260.624362538217, 6273.435390814803, 5057.266696329012, 5847.590668653196, 5878.353381128115, 5917.023691090965, 5929.703514824241, 6168.414000669929, 6274.341194174637, 6292.402221788922, 6314.116023756677, 6330.493560515148, 6170.5372097092, 6238.500919926395, 6241.906371404432, 6243.500519958392, 6250.249970003538, 6205.379462053849, 6230.252369715663, 6253.6873156342, 6253.812385628438, 6259.624422534572, 6115.331611965994, 6166.458385403649, 6235.719392627343, 6268.435840774261, 6282.963311053625, 5491.039068163135, 6108.847278818065, 6245.437910587978, 6284.308726040132, 6288.748450061947, 4813.9037219255415, 4946.925796113062, 4969.3291405659775, 4991.550760431506, 5011.523905228997, 4021.3766866135797, 4282.721623094551, 4462.665300102441, 4467.24056910326, 4473.306637471197, 5796.942030579725, 5836.88326233473, 5845.824625261249, 5853.560982926298, 5867.911981320283, 6212.378762123752, 6247.375262473807, 6259.0924315973925, 6261.96869015652, 6271.027990661455, 4894.143524883131, 5697.857553561194, 5849.415058494116, 5874.618149820248, 5875.383084776037, 5404.83785486436, 5443.34679838414, 5459.099248623933, 5470.589705772083, 5472.589555783253, 6230.968845155745, 6349.333320001333, 6371.872562548816, 6379.617222966637, 6381.649009304533, 4785.114753770564, 5273.393559740679, 6164.599301045418, 6172.722227499863, 6180.289266734203, 5065.696058236517, 5695.8860822784145, 6381.298057213796, 6385.201849768779, 6397.200349956255, 6266.530010249158, 6269.059641053878, 6281.96859015702, 6290.2451705793765, 6307.779227727191, 6115.602485838406, 6193.318734939243, 6219.315875253628, 6241.157443745036, 6249.9062514063235, 6136.171616831671, 6200.3179650237535, 6232.844178895382, 6233.875322493434, 6241.3134555197985, 5831.620944638585, 6199.969000154971, 6237.313895471404, 6246.0, 6246.500279977682, 5786.537077033911, 5903.173555702119, 6059.484943779652, 6068.241469816273, 6096.8780624388155, 6172.290186628596, 6180.351063138306, 6181.258249010148, 6192.783252586318, 6200.875982480416, 5831.679257640871, 6004.099385092271, 6066.907956567684, 6084.726187321669, 6101.7559297627595], "value": 5715.410690074865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.9194054574576, 523.5994464234861, 539.196597070365, 550.6668465578327, 555.6832605414912, 35228.0, 38661.420078698844, 38893.61106388935, 38960.61039389605, 38977.41533876994, 42306.0, 42585.0, 42852.14295714092, 42865.92835179122, 42931.78534107333, 9542.379745316566, 9775.804483910317, 9783.95108024459, 9801.41191528507, 9801.754956126082, 9637.180839628605, 9670.854937175947, 9742.269329800258, 9770.267229957746, 9789.510524473784, 9679.854802177937, 9739.756506087333, 9748.171405430547, 9767.120959113678, 9779.608815647365, 8411.327093832479, 9511.096445837635, 9621.326507144502, 9661.227101831872, 9715.125638692516, 9585.0, 9608.951955240249, 9609.615615375447, 9700.951495242478, 9752.414855108716, 32486.675133248602, 33356.49965250499, 35846.953008994264, 39301.803490982646, 39329.60670393288, 2686.489566982267, 3211.5343275224964, 3257.625373082102, 3305.8677652893857, 3400.9797060881883, 27711.584326235123, 28062.0, 28504.857475712695, 28549.000784972635, 29748.8512557438, 2455.58255096634, 2756.834589924611, 2771.2656146121094, 2776.0422654184276, 2913.009576743917, 345487.0, 345609.0, 349754.0, 351113.24443377875, 351206.0, 30152.0, 36864.63135368612, 59474.405255946884, 59975.700121499984, 60119.0, 34736.0, 34776.82611586926, 35273.47089793655, 35530.46704299437, 35579.0, 15480.071195728293, 15639.609009774847, 15665.373385064699, 15668.138252396, 15698.450554230547, 12855.935720321526, 12860.356982150855, 13172.341382931007, 13235.801462978063, 13245.337733113305, 8094.0, 8110.959445202854, 8262.876056859031, 8386.287165590871, 8398.41211115216, 3070.1250143708935, 3486.337595856779, 3490.0, 3525.5593050868642, 3559.0, 997.9950100249453, 1039.2050081687514, 1051.8683327042663, 1072.324435605579, 1130.2257953302014, 30085.849570752005, 30099.699003010126, 30174.54738178929, 30252.394952100836, 30401.847990759903, 925.953702314895, 1078.1374900079904, 1078.660222030058, 1110.9666709998712, 1141.7431078007548, 14563.927180364242, 15305.770413443808, 15522.37910483568, 15682.47533311468, 15702.214889255492, 625793.0, 630979.0, 632701.0, 639106.0, 643878.0, 57981.0, 58296.70851645715, 58738.70630646819, 58784.0, 58942.70528647329, 1496.9775453368209, 1516.2494565190082, 1517.67370015445, 1522.1247782524872, 1527.9236038198046, 28854.711452885203, 29597.704022959493, 29885.5517167247, 30454.84772576123, 30466.84766576153, 51664.0, 52090.47909520856, 52419.0, 52449.47550524446, 52451.475485246185, 560507.0, 566755.0, 566964.0, 569745.0, 571538.0, 26923.0, 27275.31811704723, 27356.452870942867, 27390.767415465954, 41979.95050123771, 42799.3580096305, 43361.0, 44116.67649970506, 44956.0, 47066.76466617645, 35713.28573428465, 35820.462693060144, 36050.63949360473, 36189.0, 36490.27019459649, 34773.0, 34865.47701784526, 35187.82406087953, 35385.292294153456, 35555.644443556266, 34847.303053938274, 35255.64744352524, 35277.76527821514, 35429.46855797217, 35600.821995889855, 30932.53601196029, 33164.33671326608, 33165.33669326552, 33189.33621327608, 33420.0, 24774.25677229686, 25045.0, 25124.0, 25462.0, 25512.362190945376], "value": 18325.595991763366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.8933498620386, 402.0, 402.29196613959425, 405.5640186799191, 410.9486314210724, 20110.0, 20465.795342046575, 20798.89600551999, 20862.06120724567, 21487.785122148773, 20225.797742022576, 20513.38459846207, 20804.89597552014, 20932.0, 21176.576468470623, 5519.254900588419, 5655.095184770437, 5927.555433342495, 6005.579609427342, 6013.368596297391, 5191.377034755816, 5819.0, 5819.912701309484, 5873.383294754053, 5936.0, 5642.351129620085, 5777.682227477487, 5835.649861008353, 5933.406659334075, 5933.851653708649, 5787.21872547207, 5819.156222347757, 5838.095095260199, 5853.268341457318, 5859.882802343951, 4919.926201106986, 5156.278121063054, 5178.352705911761, 5228.764705588258, 5261.579073674096, 26318.0, 26477.0, 26752.0, 26773.73226267732, 26851.462970740475, 2067.7208576842086, 2189.4745261137373, 2458.7172475165407, 2614.3202767280454, 2803.0189433698247, 14594.70810583793, 14652.780208296885, 14744.778828317583, 14962.17708026058, 15015.924920375328, 1660.1865086107841, 1670.9665806683797, 1681.6720739455811, 1727.8704097192635, 1767.2842498788011, 105079.0, 106935.93064069415, 110273.34589981157, 112951.0, 114491.0, 10912.945435272773, 11310.208285419942, 11316.094712422986, 11337.489812958273, 11451.484683189277, 12190.634280971584, 14194.361253743606, 14254.857451425352, 14295.642608934651, 14305.0, 8904.376693631384, 8913.688020919237, 8948.105189481, 8964.775880602907, 9040.231580315747, 9075.500847453453, 9117.673476312659, 9160.038195989458, 9209.079092090871, 9213.35506514551, 5666.829995100154, 6837.589744615339, 6923.2038315593345, 6940.444764418834, 6984.406325462291, 1928.5275107598727, 1958.5886963737776, 1995.8764533505018, 2003.8697484663742, 2005.1878989009474, 905.4883990545321, 978.2907392140642, 1029.7425643589104, 1100.2518287564533, 1131.4229742831214, 20840.895795520926, 21369.931503424767, 21497.355079347646, 21760.673589896163, 21848.344549663536, 864.8183881384854, 994.2791476179711, 994.2990191914682, 1052.1214785654065, 1075.6504136155781, 8958.68644597436, 9552.808943821085, 9970.0, 10494.475276236157, 11740.236884602473, 245632.0, 608545.9572702108, 612510.6204332091, 619661.0, 631007.534886977, 82750.17249827425, 115501.0, 117416.8258317423, 118748.0, 120890.0, 1046.8011077895176, 1049.1606714628267, 1065.1798115451058, 1068.5832525315288, 1069.550788668761, 19113.90443047776, 19167.94576298317, 19191.52021199481, 19392.030398480303, 19454.12456439492, 48708.0, 49105.75447122742, 50272.74863625658, 51131.23303150381, 51884.96230075302, 71890.64054679693, 73250.0, 74295.0, 74647.0, 76656.0, 7561.3950883928055, 7732.690692372242, 8050.27547520726, 8137.79655508617, 8181.059178194584, 12492.188007779465, 12814.871851281368, 12987.285699286253, 13035.47858085666, 13248.20510769357, 11031.558737650725, 11130.16523760705, 11270.042046426146, 11467.910548497879, 11564.537418503165, 9678.806423871623, 10893.455327233765, 10995.230333876552, 11223.831642525205, 11425.942870285595, 10599.682009539727, 11461.4269286537, 11493.138014649103, 11687.649370518899, 11802.114841387101, 7970.960145199469, 7995.960525131928, 8061.717839875576, 8127.2279133482225, 8197.46716463428, 11187.32876027441, 11354.489047993025, 11430.942845285721, 11461.255018423775, 11581.478833452345], "value": 9756.386132016589, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.6688761584835, 1605.3498333175064, 1802.810704875988, 1896.1751638037454, 1967.2622766462578, 7778.066632004154, 8363.916360836405, 8541.145885411455, 8835.0, 8862.423942443746, 8531.78670533237, 8554.272886804614, 8654.048054713976, 8670.913290867089, 8713.477191368507, 2373.9169129080487, 2384.3204686664303, 2392.0670938334065, 2402.267308470916, 2407.843490173133, 2098.8635738677012, 2425.2118061629953, 2451.669024681663, 2465.9876700616473, 2471.5798314286526, 2300.6779050932882, 2316.733575638798, 2337.0885354711677, 2340.4499942513494, 2343.5195784864145, 2441.389652586853, 2453.0433131078894, 2463.901443942258, 2479.8760061996827, 2485.1177831869695, 2148.3877095027997, 2430.2466235466886, 2453.0678342230017, 2457.1400009996537, 2464.7904928081134, 8647.394682372236, 8756.0, 8786.07746186654, 8818.426802257833, 8834.911650883474, 5364.088105022156, 5487.506124448779, 5506.504414602705, 5529.695866727328, 5545.390007099216, 3533.699635530957, 3598.6401359863803, 3651.47053677218, 3652.36083685354, 3666.3767159582935, 950.5627411390768, 972.7665360313474, 976.4336684722844, 977.1010670183377, 1024.8052869954686, 11581.652550423416, 11887.10846686502, 11893.702657433547, 11903.226290291102, 11934.104942129288, 4868.367112275381, 4890.877728056827, 4953.207486802166, 4981.402231732215, 4991.376077990251, 9969.202463802878, 10045.045720656526, 10153.0, 10153.543090560943, 10155.593776248867, 5425.810096646598, 5436.130219164915, 5465.453454654503, 5515.889682206333, 5534.335879694462, 4400.691951563424, 4820.035992801384, 4909.042736666387, 4909.729964851896, 5022.7990880365105, 3768.981155094262, 3825.8087095645665, 3829.0235989822418, 3832.80835958201, 3869.090763670535, 1131.8664317760915, 1360.31984007996, 1374.6632075141454, 1376.1399125546534, 1380.8550102239121, 931.8369285375032, 933.6545478173119, 934.3226161033197, 956.9138777510058, 974.8294048541477, 5823.039198532279, 5915.201447804578, 5974.522038236931, 6065.484433823086, 6090.33006369299, 465.0698602794411, 471.32129733184104, 474.74126601002536, 476.790212306584, 489.56917912237003, 3722.962770372316, 3725.75187312248, 3917.353636649978, 3941.8226179821404, 4046.919061618751, 10518.737031574272, 10578.788424231472, 10654.0, 10766.192535559865, 10910.399928003877, 10468.581256749645, 10493.632722854663, 10525.0, 10563.313384629975, 10622.575096996188, 8202.097769245378, 8247.95876020616, 8267.131951145164, 8409.285210757032, 8459.069502354736, 5549.334079910436, 5741.531638583815, 5751.396103409082, 5813.15709222152, 6004.189434426296, 9276.350655454053, 9310.813783724423, 9323.440593564408, 9388.906110938804, 9403.871535415521, 9543.665971690958, 9644.324897257125, 9684.837819461709, 9715.659951901649, 9801.11789938909, 6806.319368063154, 7315.049043624294, 7348.742794002184, 7445.4415918805225, 7502.287282708134, 8149.551774652451, 8201.95899020501, 8206.302464290364, 8206.835863282582, 8306.169383061646, 7197.640117993975, 7349.4855360124275, 7353.889691654736, 7438.404927605887, 7480.3641690456925, 7188.712451501881, 7264.237255088351, 7277.38142257914, 7352.264773522605, 7367.300106489874, 7010.018597396471, 7038.507304488637, 7074.186468555976, 7076.433885289268, 7077.893831592633, 4924.0, 5105.821296254613, 5146.228065790161, 5211.635185536976, 5213.739313034409, 4880.560749532559, 5192.013517431676, 5265.262863199232, 5272.0, 5394.624370785425], "value": 4528.79071017312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.3102897740882, 326.39942505789344, 332.70555558330875, 333.0292198242124, 334.60850804558663, 6674.666266686659, 6682.465402767779, 6699.899501507482, 6760.087388202591, 6768.458523318135, 6780.864382712342, 6796.830079248009, 6804.319568043205, 6810.761623343184, 6827.146606674153, 5003.149464591028, 5028.798848046092, 5035.597152227831, 5037.471065538111, 5051.747412629354, 5039.420466646327, 5045.772940217699, 5046.772895219724, 5050.0, 5071.492850714917, 3783.69730421567, 4934.383202099738, 4966.553010229079, 4979.751012449381, 4983.725895075788, 4689.413823272091, 4881.316615673809, 4970.726610036429, 4975.626827987898, 5012.52381023804, 3717.5538935327663, 3917.177392747498, 4140.130572579762, 4153.231652144363, 4177.97911010446, 6447.419732224075, 6513.250976137758, 6518.250401203874, 6530.510211734091, 6556.901646475307, 5782.421757824226, 5808.535317174616, 5811.738471768781, 5813.854653633651, 5833.4749872511675, 7190.820229494252, 7196.928030719678, 7207.38737207338, 7210.459215558802, 7244.782656520313, 3699.8890033298776, 4652.488226295105, 4663.906721865544, 4665.766711664403, 4688.718676879398, 6588.472922166263, 6895.034695142684, 7527.096748390229, 7595.202503737139, 7639.350655194316, 3969.900752481153, 4680.438347398334, 4726.385569875963, 4731.976340118277, 4737.336772851803, 4120.484939382577, 4727.770779597329, 4823.493533179036, 4836.419629644465, 4841.080194763054, 4752.2158843790385, 5716.456936591017, 5768.3366412862215, 5786.797462088891, 5789.768409263666, 5877.353491115974, 6979.511434199659, 7240.0, 7258.782236532807, 7276.235995220532, 1643.3919449803411, 1650.521348808856, 1664.9334026638799, 1668.549491637251, 1671.540326410247, 986.2356673577891, 1039.248865661363, 1047.984280235797, 1062.4793851013103, 1069.9781708468395, 5944.840756052615, 6426.935730642634, 6658.6337751424135, 6797.728090876409, 6801.047853300542, 7558.508696934791, 7594.924050759532, 7598.544087354777, 7608.31525162738, 7640.541567505968, 6785.898211526733, 6793.932060679429, 6799.796006119825, 6804.489663275274, 6830.692618832164, 3853.7880416576795, 3943.2902077626304, 3951.308521008812, 3976.602339766, 4007.6192761687594, 7450.547143307003, 7748.8450230996195, 7878.487898286593, 7884.29041386278, 7922.128565857751, 6775.593464392152, 7818.765437036898, 7831.569263690438, 7839.0, 7840.45116841827, 7844.529328240324, 7886.0, 7890.9605451972375, 7898.9210107899335, 7915.683372665029, 6094.3600921904335, 7238.8914166286495, 7524.435667325082, 7543.547387156788, 7554.66004029809, 5983.982722937024, 7313.817154571178, 7402.629868506661, 7411.147718012282, 7429.331360177393, 7914.762557123296, 7916.129225785044, 7923.564203968606, 7930.405219608437, 7962.243586859239, 4657.0, 4741.170295198395, 4742.66801323904, 4744.810207591796, 4746.098241334135, 7179.210286868336, 7453.105627324756, 7544.905988631727, 7565.2812982766545, 7581.0, 7197.352238298578, 7215.927840721525, 7255.709771609077, 7263.164736055422, 7269.709211631475, 7219.494635375473, 7250.891236631349, 7252.4560657949805, 7273.0, 7298.2701729826595, 7064.986478853502, 7075.893861591977, 7081.645917704197, 7094.0, 7096.325849044539, 6507.577007494498, 6509.967450162719, 6758.2565917748025, 7275.8181045472165, 7300.634968251672, 5469.890602188014, 5740.030368416967, 6709.329067093252, 6985.1967023790885, 7029.929700702927], "value": 5213.182979815267, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.7979845945446, 719.6581623728727, 747.9476436649435, 751.9134850141547, 757.7953952432844, 14634.926825365857, 14727.705445891075, 14888.702225955501, 15005.249737513122, 15022.92488537557, 11209.551617935273, 11480.425978701074, 12439.129260951715, 13937.58187254384, 13988.58034258974, 736.7936977646268, 912.9087091290884, 925.430860021089, 928.5496534180917, 951.1487218939045, 936.7798567336671, 936.8875734911786, 938.6339327662217, 938.7887725261829, 940.0740270833223, 939.2439086535336, 986.57577241786, 993.2203220471931, 997.4065431068502, 997.6358629100399, 966.4587830814731, 980.6273616025865, 987.5605355616754, 988.9604415823359, 989.4211886046635, 726.2809818279918, 726.8400951790597, 728.726727477196, 746.171749358212, 747.0810902589791, 14959.551213463614, 15068.472603458937, 15076.321565529577, 15120.5463836084, 15152.393904243818, 12472.688182795502, 12513.812292815615, 12552.560660376843, 12717.364131793465, 12752.80870786939, 9966.750831229205, 10062.698119056367, 10070.69787906364, 10353.327033742782, 10369.481525923673, 3463.740219483549, 3485.6862882340456, 3494.0391392367046, 3498.4577390504514, 3501.3872572299747, 76192.23807761907, 77536.0, 77603.6119819403, 79678.60160699218, 80072.59963700145, 9251.306152038489, 9469.526523673789, 9513.04869513057, 9582.952085239669, 9755.609775609038, 20676.0, 20682.965851707355, 20696.58606827855, 20726.792732072485, 20765.79234207669, 5821.767129314865, 7293.16128645202, 7340.816479588053, 7418.035655364876, 7475.962620186864, 3941.684665226775, 4148.730332528376, 4166.8749937501925, 4172.436721042681, 4200.075983283734, 3706.7961262130843, 3744.7940363279736, 3747.194353214072, 3771.151490914522, 3774.962250377516, 698.4935921456903, 708.2634060577045, 731.3016069653468, 732.74353976109, 742.5730205132071, 500.269606374697, 528.8915772266677, 550.3423409026175, 552.7208759576388, 569.0042425754929, 8164.142765009708, 8219.178082191733, 8236.917630823615, 8251.463654862535, 8365.8326833463, 573.0, 577.7688924430178, 604.9866473656607, 607.2955371768727, 619.2012304127715, 3384.340053689507, 3722.7952462614817, 3735.701143908481, 3873.2253549290253, 3995.5604883462797, 93929.0, 95795.0, 96732.0, 96985.0, 97190.51404742931, 76850.23149768542, 77222.22777772263, 78401.0, 78993.0251743711, 82248.17751822525, 64227.6788616054, 65351.346486535476, 66173.66913165404, 67605.0, 69594.65202673954, 7904.762857114296, 8344.207300306462, 8460.407771455939, 8534.359923005924, 8795.749998755138, 47216.527834721215, 48052.75973620109, 49944.25083623676, 49953.0, 50226.74886625543, 64630.0, 66876.6656166716, 66881.99677004946, 68161.65919170373, 69303.65348173227, 10925.945370273097, 11016.944915275373, 11155.944220278847, 11171.724398338549, 11289.20975531705, 11971.521139154336, 11976.580819671619, 12062.336571488653, 12083.69790755203, 12525.060620453685, 11215.55137794479, 11321.830172547583, 11426.0, 11605.535778569101, 12222.572209972608, 11155.442227888736, 11508.94245528767, 11515.30908145514, 11570.479328430072, 11574.189806713786, 10470.738231544272, 11036.337819730841, 11290.0, 11469.0251328638, 11536.884631153582, 9736.172425343924, 9965.0, 9967.302288839712, 10067.496625168858, 10210.234232432449, 9609.9039009609, 9761.951190244003, 9819.263555233529, 9828.967958364268, 9877.753056173366], "value": 6927.6089702579575, "unit": "score"}], "name": "dromaeo_css", "value": 7421.921414899789, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 120.0, 111.0, 116.0, 120.0, 117.0, 106.0, 114.0, 117.0, 117.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 123.0, 156.0, 150.0, 120.0, 141.0, 147.0, 155.0, 168.0, 148.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 197.0, 194.0, 198.0, 193.0, 194.0, 195.0, 197.0, 197.0, 196.0], "value": 195.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 105.0, 106.0, 166.0, 66.0, 81.0, 82.0, 94.0, 135.0, 57.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 123.0, 77.0, 79.0, 82.0, 111.0, 81.0, 104.0, 151.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 96.0, 117.0, 87.0, 85.0, 112.0, 116.0, 113.0, 89.0, 131.0], "value": 103.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 150.0, 94.0, 94.0, 95.0, 95.0, 108.0, 95.0, 94.0, 101.0], "value": 102.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 104.0, 135.0, 92.0, 90.0, 90.0, 80.0, 148.0, 148.0, 94.0], "value": 107.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 66.0, 65.0, 66.0, 64.0, 64.0, 77.0, 63.0, 61.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 82.0, 97.0, 101.0, 98.0, 76.0, 69.0, 65.0, 67.0, 68.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 85.0, 83.0, 86.0, 82.0, 85.0, 82.0, 87.0, 88.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 134.0, 129.0, 135.0, 152.0, 159.0, 138.0, 161.0, 165.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 173.0, 182.0, 164.0, 162.0, 165.0, 163.0, 172.0, 222.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 85.0, 77.0, 71.0, 61.0, 83.0, 70.0, 59.0, 57.0, 83.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1577.9999999999998, "alertThreshold": 2.0}]} 03:10:24 INFO - Return code: 0 03:10:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:10:24 ERROR - # TBPL SUCCESS # 03:10:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:10:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:10:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:10:24 INFO - 2016-06-03 03:10:24.902 screenresolution[1690:11017] starting screenresolution argv=screenresolution get 03:10:24 INFO - 2016-06-03 03:10:24.905 screenresolution[1690:11017] Display 0: 1600x1200x32@60 03:10:24 INFO - 2016-06-03 03:10:24.911 screenresolution[1691:11020] starting screenresolution argv=screenresolution list 03:10:24 INFO - Available Modes on Display 0 03:10:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:10:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:10:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:10:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:10:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:10:25 INFO - Intel Iris: 03:10:25 INFO - Chipset Model: Intel Iris 03:10:25 INFO - Type: GPU 03:10:25 INFO - Bus: Built-In 03:10:25 INFO - VRAM (Dynamic, Max): 1536 MB 03:10:25 INFO - Vendor: Intel (0x8086) 03:10:25 INFO - Device ID: 0x0a2e 03:10:25 INFO - Revision ID: 0x0009 03:10:25 INFO - Displays: 03:10:25 INFO - Display: 03:10:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:10:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:10:25 INFO - Display Serial Number: 1600x1200 60 03:10:25 INFO - Main Display: Yes 03:10:25 INFO - Mirror: Off 03:10:25 INFO - Online: Yes 03:10:25 INFO - Rotation: Supported 03:10:25 INFO - Return code: 0 03:10:25 INFO - Running post-action listener: _resource_record_post_action 03:10:25 INFO - Running post-run listener: _resource_record_post_run 03:10:26 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 31481344; Write bytes: 654589952; Read time: 195; Write time: 1826 03:10:26 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 349069824; Write bytes: 347059200; Read time: 26562; Write time: 694 03:10:26 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 29683200; Write bytes: 296737792; Read time: 179; Write time: 1096 03:10:26 INFO - Running post-run listener: _upload_blobber_files 03:10:26 INFO - Blob upload gear active. 03:10:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:10:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:10:26 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:10:26 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:10:26 INFO - (blobuploader) - INFO - Open directory for files ... 03:10:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:10:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:10:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:10:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:10:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:10:27 INFO - (blobuploader) - INFO - Done attempting. 03:10:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:10:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:10:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:10:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:10:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:10:29 INFO - (blobuploader) - INFO - Done attempting. 03:10:29 INFO - (blobuploader) - INFO - Iteration through files over. 03:10:29 INFO - Return code: 0 03:10:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:10:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:10:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de8149f92c5dfa772364b883cb892a193406c998aebd665c6d477c93dad50c5182f68a1d3dd682c83ce6e71e1a8470ea8926678cc5345fb35727ef7137648812", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fb7730d865cd5dc08947fe1ed548c24d9fd74e005f0f01fbee8a737c148f4bdc92eb59de33f28150561fe3b41420264e0f5d8514ff155a54a1c7aab68a28c2c"} 03:10:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:10:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:10:29 INFO - Contents: 03:10:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de8149f92c5dfa772364b883cb892a193406c998aebd665c6d477c93dad50c5182f68a1d3dd682c83ce6e71e1a8470ea8926678cc5345fb35727ef7137648812", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fb7730d865cd5dc08947fe1ed548c24d9fd74e005f0f01fbee8a737c148f4bdc92eb59de33f28150561fe3b41420264e0f5d8514ff155a54a1c7aab68a28c2c"} 03:10:29 INFO - Running post-run listener: copy_logs_to_upload_dir 03:10:29 INFO - Copying logs to upload dir... 03:10:29 INFO - mkdir: /builds/slave/test/build/upload/logs 03:10:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.752644 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-06-03 03:10:29.301323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 03:10:29.305038) ========= 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.3FNfntaYPM/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.tGBdg0DJKH/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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-Aurora/sha512/de8149f92c5dfa772364b883cb892a193406c998aebd665c6d477c93dad50c5182f68a1d3dd682c83ce6e71e1a8470ea8926678cc5345fb35727ef7137648812", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fb7730d865cd5dc08947fe1ed548c24d9fd74e005f0f01fbee8a737c148f4bdc92eb59de33f28150561fe3b41420264e0f5d8514ff155a54a1c7aab68a28c2c"} build_url:https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011138 build_url: 'https://queue.taskcluster.net/v1/task/WE4SlDMmQ4K4jZR1miItZA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de8149f92c5dfa772364b883cb892a193406c998aebd665c6d477c93dad50c5182f68a1d3dd682c83ce6e71e1a8470ea8926678cc5345fb35727ef7137648812", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fb7730d865cd5dc08947fe1ed548c24d9fd74e005f0f01fbee8a737c148f4bdc92eb59de33f28150561fe3b41420264e0f5d8514ff155a54a1c7aab68a28c2c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 03:10:29.338244) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 03:10:29.338751) ========= 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.3FNfntaYPM/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.tGBdg0DJKH/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.005367 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 03:10:29.388040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 03:10:29.388387) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 03:10:29.388846) ========= ========= Total master_lag: 0.19 =========