builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0163 starttime: 1466586433.67 results: success (0) buildid: 20160622005102 builduid: 903bf3ba67ac4973b547cb89e44da7aa revision: 3d3e03d528e015cb85dd7acf15e65443c0d3d589 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:13.666590) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:13.667169) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:13.667580) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:13.706685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:13.707142) ========= 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.sizEhYZXvB/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.u81Z2iv8gt/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-22 02:07:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.4M=0.001s 2016-06-22 02:07:14 (15.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.545533 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:14.276542) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:14.277056) ========= 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.sizEhYZXvB/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.u81Z2iv8gt/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.026559 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:14.328420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 02:07:14.328759) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3d3e03d528e015cb85dd7acf15e65443c0d3d589 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3d3e03d528e015cb85dd7acf15e65443c0d3d589 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sizEhYZXvB/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.u81Z2iv8gt/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-22 02:07:14,405 truncating revision to first 12 chars 2016-06-22 02:07:14,406 Setting DEBUG logging. 2016-06-22 02:07:14,406 attempt 1/10 2016-06-22 02:07:14,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3d3e03d528e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 02:07:15,264 unpacking tar archive at: mozilla-beta-3d3e03d528e0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.139602 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 02:07:15.489438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:15.489755) ========= script_repo_revision: 3d3e03d528e015cb85dd7acf15e65443c0d3d589 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:15.490153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:15.490434) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:15.507982) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-22 02:07:15.508381) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sizEhYZXvB/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.u81Z2iv8gt/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:07:15 INFO - MultiFileLogger online at 20160622 02:07:15 in /builds/slave/test 02:07:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 02:07:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:07:15 INFO - {'append_to_log': False, 02:07:15 INFO - 'base_work_dir': '/builds/slave/test', 02:07:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:07:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:07:15 INFO - 'branch': 'Mozilla-Beta', 02:07:15 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:15 INFO - 'config_files': ('talos/mac_config.py',), 02:07:15 INFO - 'default_actions': ('clobber', 02:07:15 INFO - 'read-buildbot-config', 02:07:15 INFO - 'download-and-extract', 02:07:15 INFO - 'populate-webroot', 02:07:15 INFO - 'create-virtualenv', 02:07:15 INFO - 'install', 02:07:15 INFO - 'run-tests'), 02:07:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:15 INFO - 'download_minidump_stackwalk': True, 02:07:15 INFO - 'download_symbols': 'ondemand', 02:07:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:15 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:15 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:15 INFO - 'installer_path': 'installer.exe', 02:07:15 INFO - 'log_level': 'info', 02:07:15 INFO - 'log_name': 'talos', 02:07:15 INFO - 'log_to_console': True, 02:07:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:07:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:07:15 INFO - 'opt_config_files': (), 02:07:15 INFO - 'pip_index': False, 02:07:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:15 INFO - 'cmd': ('bash', 02:07:15 INFO - '-c', 02:07:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:15 INFO - 'enabled': True, 02:07:15 INFO - 'halt_on_failure': False, 02:07:15 INFO - 'name': 'check_screen_resolution'},), 02:07:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:15 INFO - 'cmd': ('bash', 02:07:15 INFO - '-c', 02:07:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:15 INFO - 'enabled': True, 02:07:15 INFO - 'halt_on_failure': False, 02:07:15 INFO - 'name': 'check_screen_resolution'},), 02:07:15 INFO - 'run_cmd_checks_enabled': True, 02:07:15 INFO - 'sps_profile': False, 02:07:15 INFO - 'sps_profile_interval': 0, 02:07:15 INFO - 'suite': 'dromaeojs-e10s', 02:07:15 INFO - 'system_bits': '32', 02:07:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:15 INFO - 'title': 't-yosemite-r7-0163', 02:07:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:15 INFO - 'use_talos_json': True, 02:07:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:07:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:15 INFO - 'work_dir': 'build'} 02:07:15 INFO - ##### 02:07:15 INFO - ##### Running clobber step. 02:07:15 INFO - ##### 02:07:15 INFO - Running pre-action listener: _resource_record_pre_action 02:07:15 INFO - Running main action method: clobber 02:07:15 INFO - rmtree: /builds/slave/test/build 02:07:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:17 INFO - Running post-action listener: _resource_record_post_action 02:07:17 INFO - ##### 02:07:17 INFO - ##### Running read-buildbot-config step. 02:07:17 INFO - ##### 02:07:17 INFO - Running pre-action listener: _resource_record_pre_action 02:07:17 INFO - Running main action method: read_buildbot_config 02:07:17 INFO - Using buildbot properties: 02:07:17 INFO - { 02:07:17 INFO - "project": "", 02:07:17 INFO - "product": "firefox", 02:07:17 INFO - "script_repo_revision": "production", 02:07:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 02:07:17 INFO - "repository": "", 02:07:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 02:07:17 INFO - "buildid": "20160622005102", 02:07:17 INFO - "pgo_build": "False", 02:07:17 INFO - "basedir": "/builds/slave/test", 02:07:17 INFO - "buildnumber": 10, 02:07:17 INFO - "slavename": "t-yosemite-r7-0163", 02:07:17 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:07:17 INFO - "platform": "yosemite_r7", 02:07:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 02:07:17 INFO - "branch": "mozilla-beta", 02:07:17 INFO - "repo_path": "releases/mozilla-beta", 02:07:17 INFO - "revision": "3d3e03d528e015cb85dd7acf15e65443c0d3d589", 02:07:17 INFO - "stage_platform": "macosx64", 02:07:17 INFO - "builduid": "903bf3ba67ac4973b547cb89e44da7aa", 02:07:17 INFO - "slavebuilddir": "test" 02:07:17 INFO - } 02:07:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 02:07:17 INFO - Running post-action listener: _resource_record_post_action 02:07:17 INFO - ##### 02:07:17 INFO - ##### Running download-and-extract step. 02:07:17 INFO - ##### 02:07:17 INFO - Running pre-action listener: _resource_record_pre_action 02:07:17 INFO - Running main action method: download_and_extract 02:07:17 INFO - mkdir: /builds/slave/test/build/tests 02:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:17 INFO - https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:07:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 02:07:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 02:07:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 02:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 02:07:22 INFO - Downloaded 1165 bytes. 02:07:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 02:07:22 INFO - Using the following test package requirements: 02:07:22 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:07:22 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:22 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 02:07:22 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:22 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 02:07:22 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:07:22 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:22 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 02:07:22 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:07:22 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:22 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 02:07:22 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:22 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 02:07:22 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:22 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 02:07:22 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:22 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 02:07:22 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 02:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:22 INFO - https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 02:07:25 INFO - Downloaded 18301167 bytes. 02:07:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:07:28 INFO - Return code: 0 02:07:28 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 02:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:28 INFO - https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:07:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 02:07:29 INFO - Downloaded 18301167 bytes. 02:07:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:07:33 INFO - Return code: 0 02:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:33 INFO - https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 02:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 02:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 02:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 02:07:34 INFO - Downloaded 10840145 bytes. 02:07:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:07:34 INFO - Return code: 0 02:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:34 INFO - https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 02:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 02:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 02:07:36 INFO - Downloaded 86248654 bytes. 02:07:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:07:36 INFO - mkdir: /builds/slave/test/properties 02:07:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:07:36 INFO - Writing to file /builds/slave/test/properties/build_url 02:07:36 INFO - Contents: 02:07:36 INFO - build_url:https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:07:37 INFO - Running post-action listener: _resource_record_post_action 02:07:37 INFO - Running post-action listener: set_extra_try_arguments 02:07:37 INFO - ##### 02:07:37 INFO - ##### Running populate-webroot step. 02:07:37 INFO - ##### 02:07:37 INFO - Running pre-action listener: _resource_record_pre_action 02:07:37 INFO - Running main action method: populate_webroot 02:07:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:07:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:07:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:07:37 INFO - '--tppagecycles', 02:07:37 INFO - '7'], 02:07:37 INFO - 'tests': ['tsvgm']}}, 02:07:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:07:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:07:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:07:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:07:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['damp', 'tps']}, 02:07:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'tests': ['damp', 'tps']}, 02:07:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['dromaeo_dom']}, 02:07:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:07:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'other-e10s': {'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['tsvgx', 02:07:37 INFO - 'tsvgr_opacity', 02:07:37 INFO - 'tart', 02:07:37 INFO - 'tscrollx', 02:07:37 INFO - 'cart']}, 02:07:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:07:37 INFO - 'tsvgr_opacity', 02:07:37 INFO - 'tart', 02:07:37 INFO - 'tscrollx', 02:07:37 INFO - 'cart']}, 02:07:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['tp5o']}, 02:07:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'tests': ['tp5o']}, 02:07:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'talos_options': ['--disable-e10s', 02:07:37 INFO - '--xperf_path', 02:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:37 INFO - 'tests': ['tp5n']}, 02:07:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'talos_options': ['--xperf_path', 02:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:37 INFO - 'tests': ['tp5n']}}, 02:07:37 INFO - 'talos.zip': {'path': '', 02:07:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:07:37 INFO - Running post-action listener: _resource_record_post_action 02:07:37 INFO - ##### 02:07:37 INFO - ##### Running create-virtualenv step. 02:07:37 INFO - ##### 02:07:37 INFO - Running pre-action listener: _resource_record_pre_action 02:07:37 INFO - Running main action method: create_virtualenv 02:07:37 INFO - Creating virtualenv /builds/slave/test/build/venv 02:07:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:07:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:07:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:07:38 INFO - Using real prefix '/tools/python27' 02:07:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:07:38 INFO - Installing distribute.............................................................................................................................................................................................done. 02:07:41 INFO - Installing pip.................done. 02:07:41 INFO - Return code: 0 02:07:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10547ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d85dc0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531ae00>, '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 0x105183db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105315b20>, '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.sizEhYZXvB/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.u81Z2iv8gt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:07:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sizEhYZXvB/Render', 02:07:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:41 INFO - 'HOME': '/Users/cltbld', 02:07:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:41 INFO - 'LOGNAME': 'cltbld', 02:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:41 INFO - 'MOZ_NO_REMOTE': '1', 02:07:41 INFO - 'NO_EM_RESTART': '1', 02:07:41 INFO - 'PAGER': '/bin/cat', 02:07:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:41 INFO - 'PWD': '/builds/slave/test', 02:07:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:41 INFO - 'SHELL': '/bin/bash', 02:07:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u81Z2iv8gt/Listeners', 02:07:41 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 02:07:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:41 INFO - 'USER': 'cltbld', 02:07:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:41 INFO - 'XPC_FLAGS': '0x0', 02:07:41 INFO - 'XPC_SERVICE_NAME': '0', 02:07:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:07:41 INFO - Cleaning up... 02:07:41 INFO - Return code: 0 02:07:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10547ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d85dc0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531ae00>, '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 0x105183db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105315b20>, '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.sizEhYZXvB/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.u81Z2iv8gt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:07:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:07:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:07:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sizEhYZXvB/Render', 02:07:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:42 INFO - 'HOME': '/Users/cltbld', 02:07:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:42 INFO - 'LOGNAME': 'cltbld', 02:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:42 INFO - 'MOZ_NO_REMOTE': '1', 02:07:42 INFO - 'NO_EM_RESTART': '1', 02:07:42 INFO - 'PAGER': '/bin/cat', 02:07:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:42 INFO - 'PWD': '/builds/slave/test', 02:07:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:42 INFO - 'SHELL': '/bin/bash', 02:07:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u81Z2iv8gt/Listeners', 02:07:42 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 02:07:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:42 INFO - 'USER': 'cltbld', 02:07:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:42 INFO - 'XPC_FLAGS': '0x0', 02:07:42 INFO - 'XPC_SERVICE_NAME': '0', 02:07:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:42 INFO - Downloading/unpacking psutil>=0.7.1 02:07:42 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:07:42 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:07:42 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:07:42 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:07:42 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:07:42 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:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:07:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:45 INFO - Installing collected packages: psutil 02:07:45 INFO - Running setup.py install for psutil 02:07:45 INFO - building 'psutil._psutil_osx' extension 02:07:45 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:07:45 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:07:45 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:07:46 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:07:46 INFO - building 'psutil._psutil_posix' extension 02:07:46 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:07:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:07:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:07:46 INFO - ^ 02:07:46 INFO - 1 warning generated. 02:07:46 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:07:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:46 INFO - Successfully installed psutil 02:07:46 INFO - Cleaning up... 02:07:46 INFO - Return code: 0 02:07:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:07:46 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:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:46 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:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:46 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 0x10547ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d85dc0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531ae00>, '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 0x105183db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105315b20>, '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.sizEhYZXvB/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.u81Z2iv8gt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:07:46 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:07:46 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:07:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sizEhYZXvB/Render', 02:07:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:46 INFO - 'HOME': '/Users/cltbld', 02:07:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:46 INFO - 'LOGNAME': 'cltbld', 02:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:46 INFO - 'MOZ_NO_REMOTE': '1', 02:07:46 INFO - 'NO_EM_RESTART': '1', 02:07:46 INFO - 'PAGER': '/bin/cat', 02:07:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:46 INFO - 'PWD': '/builds/slave/test', 02:07:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:46 INFO - 'SHELL': '/bin/bash', 02:07:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u81Z2iv8gt/Listeners', 02:07:46 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 02:07:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:46 INFO - 'USER': 'cltbld', 02:07:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:46 INFO - 'XPC_FLAGS': '0x0', 02:07:46 INFO - 'XPC_SERVICE_NAME': '0', 02:07:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:07:49 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:07:49 INFO - Installing collected packages: mozsystemmonitor 02:07:49 INFO - Running setup.py install for mozsystemmonitor 02:07:49 INFO - Successfully installed mozsystemmonitor 02:07:49 INFO - Cleaning up... 02:07:49 INFO - Return code: 0 02:07:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:07: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:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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', '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 0x10547ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d85dc0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531ae00>, '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 0x105183db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105315b20>, '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.sizEhYZXvB/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.u81Z2iv8gt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:07: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:07: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 blobuploader==1.2.4 02:07:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sizEhYZXvB/Render', 02:07:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:49 INFO - 'HOME': '/Users/cltbld', 02:07:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:49 INFO - 'LOGNAME': 'cltbld', 02:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:49 INFO - 'MOZ_NO_REMOTE': '1', 02:07:49 INFO - 'NO_EM_RESTART': '1', 02:07:49 INFO - 'PAGER': '/bin/cat', 02:07:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:49 INFO - 'PWD': '/builds/slave/test', 02:07:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:49 INFO - 'SHELL': '/bin/bash', 02:07:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u81Z2iv8gt/Listeners', 02:07:49 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 02:07:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:49 INFO - 'USER': 'cltbld', 02:07:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:49 INFO - 'XPC_FLAGS': '0x0', 02:07:49 INFO - 'XPC_SERVICE_NAME': '0', 02:07:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:49 INFO - Downloading/unpacking blobuploader==1.2.4 02:07: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:07: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:07: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:07: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:07: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:07: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:07:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:07:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:07:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:53 INFO - Downloading docopt-0.6.1.tar.gz 02:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:07:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:07:53 INFO - Running setup.py install for blobuploader 02:07:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:07:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:07:53 INFO - Running setup.py install for requests 02:07:54 INFO - Running setup.py install for docopt 02:07:54 INFO - Successfully installed blobuploader requests docopt 02:07:54 INFO - Cleaning up... 02:07:54 INFO - Return code: 0 02:07:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07: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:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:54 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 0x10547ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d85dc0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531ae00>, '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 0x105183db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105315b20>, '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.sizEhYZXvB/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.u81Z2iv8gt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:07:54 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:07:54 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:07:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sizEhYZXvB/Render', 02:07:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:54 INFO - 'HOME': '/Users/cltbld', 02:07:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:54 INFO - 'LOGNAME': 'cltbld', 02:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:54 INFO - 'MOZ_NO_REMOTE': '1', 02:07:54 INFO - 'NO_EM_RESTART': '1', 02:07:54 INFO - 'PAGER': '/bin/cat', 02:07:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:54 INFO - 'PWD': '/builds/slave/test', 02:07:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:54 INFO - 'SHELL': '/bin/bash', 02:07:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u81Z2iv8gt/Listeners', 02:07:54 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 02:07:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:54 INFO - 'USER': 'cltbld', 02:07:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:54 INFO - 'XPC_FLAGS': '0x0', 02:07:54 INFO - 'XPC_SERVICE_NAME': '0', 02:07:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-CtvlU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-C2eb_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-DpKytl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-uid4fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-DEyMup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-FzbRk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-GSGhuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-h7xv4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-wgUZ6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-tJ_6qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-TuKQjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-YR_oay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-LZsxu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:55 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-bIWRlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-eRuGEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-95Axyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:56 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-DvXerA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:07:56 INFO - Running setup.py install for manifestparser 02:07:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Running setup.py install for mozcrash 02:07:56 INFO - Running setup.py install for mozdebug 02:07:56 INFO - Running setup.py install for mozdevice 02:07:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Running setup.py install for mozfile 02:07:57 INFO - Running setup.py install for mozhttpd 02:07:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Running setup.py install for mozinfo 02:07:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Running setup.py install for mozInstall 02:07:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Running setup.py install for mozleak 02:07:57 INFO - Running setup.py install for mozlog 02:07:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Running setup.py install for moznetwork 02:07:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Running setup.py install for mozprocess 02:07:58 INFO - Running setup.py install for mozprofile 02:07:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:07:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:07:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:07:58 INFO - Running setup.py install for mozrunner 02:07:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:07:58 INFO - Running setup.py install for mozscreenshot 02:07:58 INFO - Running setup.py install for moztest 02:07:58 INFO - Running setup.py install for mozversion 02:07:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:07:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:07:58 INFO - Cleaning up... 02:07:58 INFO - Return code: 0 02:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:58 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:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:58 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:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:58 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 0x10547ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d85dc0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531ae00>, '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 0x105183db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105315b20>, '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.sizEhYZXvB/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.u81Z2iv8gt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:07:58 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:07:58 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:07:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sizEhYZXvB/Render', 02:07:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:58 INFO - 'HOME': '/Users/cltbld', 02:07:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:58 INFO - 'LOGNAME': 'cltbld', 02:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:58 INFO - 'MOZ_NO_REMOTE': '1', 02:07:58 INFO - 'NO_EM_RESTART': '1', 02:07:58 INFO - 'PAGER': '/bin/cat', 02:07:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:58 INFO - 'PWD': '/builds/slave/test', 02:07:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:58 INFO - 'SHELL': '/bin/bash', 02:07:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u81Z2iv8gt/Listeners', 02:07:58 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 02:07:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:58 INFO - 'USER': 'cltbld', 02:07:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:58 INFO - 'XPC_FLAGS': '0x0', 02:07:58 INFO - 'XPC_SERVICE_NAME': '0', 02:07:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-cIWZr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-hzcslx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-WGqlbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-cwWQp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-vOttRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-frHefj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3YzdtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:59 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:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:59 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-7W0F3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08:00 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:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:00 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-wVd823-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08:00 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:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:00 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rfqRia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:00 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:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:00 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-yDIqtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08:00 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:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:00 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ZYqqO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:00 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:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:00 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-7sO6mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:00 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:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:00 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-35AqXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:00 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:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:00 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-17wVWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:00 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:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:00 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-clN5ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:00 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:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:00 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-LSytnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:08: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:08: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:08: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:08:01 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:08:01 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:08:01 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:08:03 INFO - Downloading blessings-1.6.tar.gz 02:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:08:03 INFO - Installing collected packages: blessings 02:08:03 INFO - Running setup.py install for blessings 02:08:03 INFO - Successfully installed blessings 02:08:03 INFO - Cleaning up... 02:08:03 INFO - Return code: 0 02:08:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:04 INFO - Reading from file tmpfile_stdout 02:08:04 INFO - Current package versions: 02:08:04 INFO - blessings == 1.6 02:08:04 INFO - blobuploader == 1.2.4 02:08:04 INFO - docopt == 0.6.1 02:08:04 INFO - manifestparser == 1.1 02:08:04 INFO - mozInstall == 1.12 02:08:04 INFO - mozcrash == 0.17 02:08:04 INFO - mozdebug == 0.1 02:08:04 INFO - mozdevice == 0.48 02:08:04 INFO - mozfile == 1.2 02:08:04 INFO - mozhttpd == 0.7 02:08:04 INFO - mozinfo == 0.9 02:08:04 INFO - mozleak == 0.1 02:08:04 INFO - mozlog == 3.1 02:08:04 INFO - moznetwork == 0.27 02:08:04 INFO - mozprocess == 0.22 02:08:04 INFO - mozprofile == 0.28 02:08:04 INFO - mozrunner == 6.11 02:08:04 INFO - mozscreenshot == 0.1 02:08:04 INFO - mozsystemmonitor == 0.0 02:08:04 INFO - moztest == 0.7 02:08:04 INFO - mozversion == 1.4 02:08:04 INFO - psutil == 3.1.1 02:08:04 INFO - requests == 1.2.3 02:08:04 INFO - wsgiref == 0.1.2 02:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:04 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 0x10547ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d85dc0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531ae00>, '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 0x105183db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105315b20>, '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.sizEhYZXvB/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.u81Z2iv8gt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:08:04 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:08:04 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:08:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sizEhYZXvB/Render', 02:08:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:04 INFO - 'HOME': '/Users/cltbld', 02:08:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:04 INFO - 'LOGNAME': 'cltbld', 02:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:04 INFO - 'MOZ_NO_REMOTE': '1', 02:08:04 INFO - 'NO_EM_RESTART': '1', 02:08:04 INFO - 'PAGER': '/bin/cat', 02:08:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:04 INFO - 'PWD': '/builds/slave/test', 02:08:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:04 INFO - 'SHELL': '/bin/bash', 02:08:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u81Z2iv8gt/Listeners', 02:08:04 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 02:08:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:04 INFO - 'USER': 'cltbld', 02:08:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:04 INFO - 'XPC_FLAGS': '0x0', 02:08:04 INFO - 'XPC_SERVICE_NAME': '0', 02:08:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 INFO - Cleaning up... 02:08:04 INFO - Return code: 0 02:08:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:04 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 0x10547ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d85dc0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531ae00>, '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 0x105183db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105315b20>, '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.sizEhYZXvB/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.u81Z2iv8gt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:08:04 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:08:04 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:08:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sizEhYZXvB/Render', 02:08:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:04 INFO - 'HOME': '/Users/cltbld', 02:08:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:04 INFO - 'LOGNAME': 'cltbld', 02:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:04 INFO - 'MOZ_NO_REMOTE': '1', 02:08:04 INFO - 'NO_EM_RESTART': '1', 02:08:04 INFO - 'PAGER': '/bin/cat', 02:08:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:04 INFO - 'PWD': '/builds/slave/test', 02:08:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:04 INFO - 'SHELL': '/bin/bash', 02:08:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u81Z2iv8gt/Listeners', 02:08:04 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 02:08:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:04 INFO - 'USER': 'cltbld', 02:08:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:04 INFO - 'XPC_FLAGS': '0x0', 02:08:04 INFO - 'XPC_SERVICE_NAME': '0', 02:08:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:04 INFO - Downloading/unpacking jsonschema 02:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:08:07 INFO - Downloading/unpacking functools32 (from jsonschema) 02:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:08:07 INFO - warning: no files found matching '*.txt' 02:08:07 INFO - no previously-included directories found matching 'build' 02:08:07 INFO - no previously-included directories found matching 'dist' 02:08:07 INFO - no previously-included directories found matching '.git*' 02:08:07 INFO - Installing collected packages: jsonschema, functools32 02:08:07 INFO - Running setup.py install for functools32 02:08:07 INFO - warning: no files found matching '*.txt' 02:08:07 INFO - no previously-included directories found matching 'build' 02:08:07 INFO - no previously-included directories found matching 'dist' 02:08:07 INFO - no previously-included directories found matching '.git*' 02:08:07 INFO - Successfully installed jsonschema functools32 02:08:07 INFO - Cleaning up... 02:08:07 INFO - Return code: 0 02:08:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10547ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5d85dc0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531ae00>, '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 0x105183db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105315b20>, '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.sizEhYZXvB/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.u81Z2iv8gt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sizEhYZXvB/Render', 02:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:07 INFO - 'HOME': '/Users/cltbld', 02:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:07 INFO - 'LOGNAME': 'cltbld', 02:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:07 INFO - 'MOZ_NO_REMOTE': '1', 02:08:07 INFO - 'NO_EM_RESTART': '1', 02:08:07 INFO - 'PAGER': '/bin/cat', 02:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:07 INFO - 'PWD': '/builds/slave/test', 02:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:07 INFO - 'SHELL': '/bin/bash', 02:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u81Z2iv8gt/Listeners', 02:08:07 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 02:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:07 INFO - 'USER': 'cltbld', 02:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:07 INFO - 'XPC_FLAGS': '0x0', 02:08:07 INFO - 'XPC_SERVICE_NAME': '0', 02:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:08 INFO - Downloading/unpacking flake8 02:08: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:08: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:08: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:08: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:08: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:08: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:08:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:08:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:08:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:11 INFO - no previously-included directories found matching 'docs/_build' 02:08:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:08:11 INFO - Running setup.py install for pep8 02:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:12 INFO - no previously-included directories found matching 'docs/_build' 02:08:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:08:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:08:12 INFO - Cleaning up... 02:08:12 INFO - Return code: 0 02:08:12 INFO - Running post-action listener: _resource_record_post_action 02:08:12 INFO - Running post-action listener: _start_resource_monitoring 02:08:12 INFO - Starting resource monitoring. 02:08:12 INFO - ##### 02:08:12 INFO - ##### Running install step. 02:08:12 INFO - ##### 02:08:12 INFO - Running pre-action listener: _resource_record_pre_action 02:08:12 INFO - Running main action method: install 02:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:12 INFO - Reading from file tmpfile_stdout 02:08:12 INFO - Detecting whether we're running mozinstall >=1.0... 02:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:08:12 INFO - Reading from file tmpfile_stdout 02:08:12 INFO - Output received: 02:08:12 INFO - Usage: mozinstall [options] installer 02:08:12 INFO - Options: 02:08:12 INFO - -h, --help show this help message and exit 02:08:12 INFO - -d DEST, --destination=DEST 02:08:12 INFO - Directory to install application into. [default: 02:08:12 INFO - "/builds/slave/test"] 02:08:12 INFO - --app=APP Application being installed. [default: firefox] 02:08:12 INFO - mkdir: /builds/slave/test/build/application 02:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 02:08:33 INFO - Reading from file tmpfile_stdout 02:08:33 INFO - Output received: 02:08:33 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 02:08:33 INFO - Running post-action listener: _resource_record_post_action 02:08:33 INFO - ##### 02:08:33 INFO - ##### Running run-tests step. 02:08:33 INFO - ##### 02:08:33 INFO - Running pre-action listener: _resource_record_pre_action 02:08:33 INFO - Running main action method: run_tests 02:08:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:08:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:08:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:08:33 INFO - 2016-06-22 02:08:33.973 screenresolution[1641:7631] starting screenresolution argv=screenresolution get 02:08:33 INFO - 2016-06-22 02:08:33.976 screenresolution[1641:7631] Display 0: 1600x1200x32@60 02:08:33 INFO - 2016-06-22 02:08:33.982 screenresolution[1642:7633] starting screenresolution argv=screenresolution list 02:08:33 INFO - Available Modes on Display 0 02:08:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:08:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:08:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:08:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:08:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:08:34 INFO - Intel Iris: 02:08:34 INFO - Chipset Model: Intel Iris 02:08:34 INFO - Type: GPU 02:08:34 INFO - Bus: Built-In 02:08:34 INFO - VRAM (Dynamic, Max): 1536 MB 02:08:34 INFO - Vendor: Intel (0x8086) 02:08:34 INFO - Device ID: 0x0a2e 02:08:34 INFO - Revision ID: 0x0009 02:08:34 INFO - Displays: 02:08:34 INFO - Display: 02:08:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:08:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:08:34 INFO - Display Serial Number: 1600x1200 60 02:08:34 INFO - Main Display: Yes 02:08:34 INFO - Mirror: Off 02:08:34 INFO - Online: Yes 02:08:34 INFO - Rotation: Supported 02:08:34 INFO - Return code: 0 02:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:08:34 INFO - Python 2.7.3 02:08:34 INFO - Return code: 0 02:08:34 INFO - grabbing minidump binary from tooltool 02:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531ae00>, '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 0x105183db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105315b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:08:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:08:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:08:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:08:34 INFO - Return code: 0 02:08:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:08:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:08:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:08:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:08:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:08:35 INFO - Return code: 0 02:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --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:08:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sizEhYZXvB/Render', 02:08:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:35 INFO - 'HOME': '/Users/cltbld', 02:08:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:35 INFO - 'LOGNAME': 'cltbld', 02:08:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:08:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:35 INFO - 'MOZ_NO_REMOTE': '1', 02:08:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:08:35 INFO - 'NO_EM_RESTART': '1', 02:08:35 INFO - 'PAGER': '/bin/cat', 02:08:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:35 INFO - 'PWD': '/builds/slave/test', 02:08:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:08:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:35 INFO - 'SHELL': '/bin/bash', 02:08:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u81Z2iv8gt/Listeners', 02:08:35 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 02:08:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:35 INFO - 'USER': 'cltbld', 02:08:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:35 INFO - 'XPC_FLAGS': '0x0', 02:08:35 INFO - 'XPC_SERVICE_NAME': '0', 02:08:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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:08:35 INFO - mozversion application_buildid: 20160622005102 02:08:35 INFO - mozversion application_changeset: 3d3e03d528e015cb85dd7acf15e65443c0d3d589 02:08:35 INFO - mozversion application_display_name: Firefox 02:08:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:08:35 INFO - mozversion application_name: Firefox 02:08:35 INFO - mozversion application_remotingname: firefox 02:08:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:08:35 INFO - mozversion application_vendor: Mozilla 02:08:35 INFO - mozversion application_version: 48.0 02:08:35 INFO - mozversion platform_buildid: 20160622005102 02:08:35 INFO - mozversion platform_changeset: 3d3e03d528e015cb85dd7acf15e65443c0d3d589 02:08:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:08:35 INFO - mozversion platform_version: 48.0 02:08:35 INFO - using testdate: 1466586515 02:08:35 INFO - actual date: 1466586515 02:08:35 INFO - starting webserver on 'localhost:49275' 02:08:35 INFO - SUITE-START | Running 2 tests 02:08:35 INFO - TEST-START | dromaeo_css 02:08:35 INFO - operating with platform_type : mac_ 02:08:35 INFO - Initialising browser for dromaeo_css test... 02:08:35 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpYsZxbT/profile http://localhost:49275/getInfo.html) 02:08:38 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 02:08:38 INFO - PROCESS | 1660 | colorDepth:24 02:08:38 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 02:08:38 INFO - PROCESS | 1660 | __metrics 02:08:38 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:08:39 INFO - TEST-INFO | 1660: exit 0 02:08:39 INFO - Browser initialized. 02:08:39 INFO - Running cycle 1/1 for dromaeo_css test... 02:08:39 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpYsZxbT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:51 INFO - PROCESS | 1664 | RSS: Main: 170909696 02:08:51 INFO - PROCESS | 1664 | 02:09:41 INFO - PROCESS | 1664 | 1466586580999 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:11:51 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 02:11:53 INFO - PROCESS | 1664 | RSS: Main: 181784576 02:11:53 INFO - PROCESS | 1664 | 02:14:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 02:14:55 INFO - PROCESS | 1664 | RSS: Main: 192438272 02:14:55 INFO - PROCESS | 1664 | 02:17:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 02:17:58 INFO - PROCESS | 1664 | RSS: Main: 194449408 02:17:58 INFO - PROCESS | 1664 | 02:20:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 02:21:00 INFO - PROCESS | 1664 | RSS: Main: 198316032 02:21:00 INFO - PROCESS | 1664 | 02:24:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 02:24:03 INFO - PROCESS | 1664 | RSS: Main: 197570560 02:24:03 INFO - PROCESS | 1664 | 02:27:05 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 02:27:05 INFO - PROCESS | 1664 | RSS: Main: 202518528 02:27:05 INFO - PROCESS | 1664 | 02:27:05 INFO - PROCESS | 1664 | __start_tp_report 02:27:05 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 02:27:05 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 02:27:05 INFO - PROCESS | 1664 | |i|pagename|runs| 02:27:05 INFO - PROCESS | 1664 | |0;dojo.html;3640.435732461468;3644.3075815595034;3700.4264339027427;3716.628337166284;3722.1066943933447;5921.88156236875;5939.079442686385;5943.316518600368;5945.405459454063;5949.643021418718;5909.468147866691;5920.023196172627;5945.37573554777;5950.345461999176;5954.493868021213;5302.946970530304;5326.280952071459;5345;5424.755885985121;5436.293281873351;5312.442193569677;5370.516653501184;5393.2449457076045;5420.647657902244;5427.348718153827;5357.4374690657505;5387.4073851876265;5388.218708287315;5392.703401312926;5398.865028374303;5348.91976620351;5391.433899440581;5412.323459567574;5444.047291723932;5482.698451585161;5306.071437498461;5352.384475785296;5365.946340536584;5398.24424580559;5425.294711687495;4785.545373189576;5720.427957204246;5772.30732312121;5788.82633520995;5907.438793314628;6194.132821405007;6285.622862628257;6299.968500157515;6306.842328941767;6321.778737744157;6008.648054187816;6113.633182009094;6254;6261.27995280544;6263.404976527223;5365.812196573102;5766.163906233573;5785.855353616151;5904.7933322334375;5986.640801551921;5508.641938274;6340.239171299381;6384;6409.839754006187;6466.256380516207;6289.088082228142;6290.8427289317215;6301.905471417932;6315.179026726588;6317.684115794192;6217.098520714471;6291.937080629226;6317.210348706411;6335.493160547145;6362.491000719931;5597.356304025007;6250.874982500324;6253.280872699606;6303.936960630427;6317.842053948688;5732;6230.345813689588;6276.780312689125;6305.842353941188;6325.7785977491485;4533.38799262102;4917.188663870421;5029.723365214948;5041.949580504148;5045.445001049881;4502.099580083931;4518.932216016762;4519.887002824956;4564.726116432958;4589.128065667513;6067.635941843503;6069.968105422001;6091.786787462506;6093.969530152321;6100.816975490742;5710.772183980464;6286.937130628635;6297.653629050446;6326.335734747877;6358.3641635836975;5980.342162362137;6043.407169588098;6057.303410107806;6060.727267272895;6089.695515224221;5483.7806487740045;5554.555635549227;5604;5623.690697011703;5629.915551266734;6370.8088757337355;6509.804705858832;6513.446357059608;6569.080328753978;6588;6279.403456671609;6306.905396419149;6313;6333.524985626004;6343.55595108338;6340.682965851597;6530.314316996647;6555.344465553407;6568.310327415553;6580.177477815273;6254.562180647311;6269.404406581368;6277.1525844010475;6286.748530058747;6293.024581189923;5286.788528458818;6261.029540421242;6265.686715664289;6299.905501417574;6318.241810982711;5491.670499770026;5581.441855814386;6053.545984051126;6190.1952746142715;6205.751769929152;5647.802326918538;6023.969880150571;6271.62370257786;6290.937090629218;6295.055741638791;6061.666608336407;6147.877042459215;6156.353582873734;6197.287311959002;6198.597091189058;6188.226471691039;6191.535634827316;6219.40915613016;6263.65549894742;6263.812085637438;6083.8174854754425;6142.877142457215;6158.846028849314;6188.659623720739;6207.410296021871 02:27:05 INFO - PROCESS | 1664 | |1;ext.html;553.8864532770782;561.0657467043181;563.3999790223412;570.96859672718;579.9362070172282;33045.50431743526;40193.79903100484;40201.798991005;40382.78851634448;40562.59437405625;44590.33114503277;45086.32370514445;45361;45579.088418231615;45631.77184114083;9748.171405430547;9957.253206009542;9967;9973;9978.800423991515;9896.35673681212;9992.45041522716;10009.699709008704;10028.946960569145;10037.69886903394;8498.235158835703;9995.350302230368;10052.14556762676;10057.698269051903;10069.64756233532;9955.203583713286;10009.399436033862;10035.397876127456;10054.899451005469;10085.49572521371;9691.466969316685;9773.609055637766;9808.754781130458;9813.754656133582;9830.754231144207;34740.784072557595;40409.39385909214;40973;41191;41363;2824.6398410332836;3326.850291736878;3489.389356862539;3624.2026754114318;3933.2723446162267;29069;30088.548671769942;30324.8483757582;30442.695573044206;30939.69060309413;2803.243124356433;2821.478026565092;2879.0499135285304;2881;2945.307852654646;436409;438149;439713;440277.59722402686;442027;38114.42828357577;39088.609113909064;64418.35581644217;64792;64809.703805923615;37125.814370927976;37138.44292335617;37175.25649486995;37202.8139859299;37301.44047839285;16316.184190790651;16750.74873876893;16855.494335169966;17016;17025.06362150069;13898.652533686738;14301.856981430261;14345.067570608086;14358.641033974025;14445.85554144445;8562.058173600899;8620.396572239883;8649.3512986525;8659.177378149066;8688.913110868936;3077.723004929567;3503.827626871356;3568.3576956148145;3578.8031658258524;3586.228960773394;1009.4649835587151;1018.556927736437;1054.7027156597428;1113.8718204315555;1225.393430252013;30737.69262307393;31137.221569460493;31333.06000819979;31353.059408217334;32002.67997319997;1173.7124404520946;1201.08117290273;1209.238179946628;1218.7562487502535;1270.917390369623;15506.689866202612;16081.356745730274;16126.032438053755;16254.268557914922;16411.58971025734;677775;679892;694116;696191;697444;64700;65460;65761.67119164373;66041.33958660351;66848.66575667188;1434.6556826361598;1434.952484686164;1553.8057742781925;1568.8860908754912;1569.4663814303192;30916.536251956688;31009.534856977614;31042.068737937898;31318.843405782824;31559;54923.450765491834;55362.72318638381;55423.16865246944;55432;55441.33675989727;617983;622599;627071;627196;627855;27699;44411;44626.330605040304;45972.390966316016;46730;45449.77275113735;45725.62823115312;46079;46692.06615867596;46740.53259467498;36979;37537;37763.43354849624;38452.038699032746;38770.80614596909;38469.6153038466;39022.4146637795;39134;39225;39783.403248951865;38299;38513.92879450344;38882;38959.41560876646;39683.2063358737;33156.00531984044;34245.65754342425;34409.48385774165;34480.82759586186;34673.826630866686;25708.742912571382;25787.87106064458;25885.653458550063;25932.96268149253;26311 02:27:05 INFO - PROCESS | 1664 | |2;jquery.html;361.53362162809975;414.1365253446564;422.97885105744723;426.14770459081836;435.3404592043053;18265.726014109765;20895.582088358224;21404.678929816047;21433.035513401894;21642;20313.289034883783;20682.48293792656;20774.376768696926;20806.375808725763;20869.68695469569;5773.134029895528;5834.4165583441745;6042.063480160582;6070.878582428349;6077.11881777142;5281.762320695578;5970;5975.521958243352;6017.48851347636;6060.727267272961;5125.384953805548;5750.453706897838;6000.8499787505225;6067.059605761114;6088.939110608903;5829.09649004405;6004.96997515014;6033.758649654031;6077.483413909823;6155.10750941111;5775.480206781368;5930.584859059867;5991.700414979234;6009.729562169713;6015.428534289235;13711.588652340446;13758.724825503534;14064.2967851607;14080.718385632332;14081.718365632732;2059.217497351012;2195.8902054897353;2197.1870407949;2238.6194346961056;2239.0260236797044;10107.191424686007;10125.886152523217;10289.3311934724;10466.63366782159;10518.211134164969;1709.632429027765;1797.4158398520403;1811.7916439609482;1816.4550634809636;1831.6062046660031;95227;103453;104003.47998260036;109043;110440.34339484914;11971.700707482383;12036.578719744766;12100.334481603597;12113.454894529767;12150.57472988441;12645.873541264653;13970.371333290026;15396;15516.612084697972;15571.532854014398;9066.727998160066;9154.86267705985;9290.581923813445;9290.860637090449;9406.341556091145;7594.620268986529;9164.495952722531;9179.036201198778;9202.35583509148;9368.67209647659;4326.502452218036;4496.820127194876;4772.308015337826;4849.733264670406;4855.95144048555;1802.180008096313;2009.668404713206;2067.638163321413;2083.270855200698;2086.645270304052;884.1467983396054;931.6180366049887;959.5681943125621;997.33677104726;1055.9915280906716;20408.877511737;20714.896425518076;20747.68878466824;20813.1674733012;20814.167433302497;868.6351732272461;953.7186529973675;988.4761076629397;1007.2194049611463;1032.4476405123373;10678.946605266923;11011.064059554867;11066.336019838835;11078.0583650389;11099.334039957628;670328;695421;701069;701901;710567;99701;124263;126177.36911315568;127190;130504;1044.2011860926398;1052.7104297235978;1065.7495488560182;1066.898644628759;1070.0957690751302;17854.821451785316;18288.90855545714;18350;18727.71908421402;18762.906185469532;43917;48392;52982.4701752993;53608.195877061095;54546.45453545414;73666.26333736809;74780.62609686916;76604.61697691475;76888;77898;8176.877346839683;8340.541270230196;8442.071372149181;8605.870911936201;8721.738347849574;11527.193096483166;11983.64049078529;13011;13150;13177.934110329386;10778.29941053829;11102.833457498306;11235.438228088726;11386.829197561878;11396.715082122682;5333.906549157336;6382.6170429774365;11079.224454288122;11458.312501249951;11759.764804703687;9085.318601105077;11392.601258955896;11455.312681239153;12090.637280881587;12190.695232619255;8109.797255068671;8342.29090527312;8564.828703426021;8641.8703719443;8824.294056475339;10423.114035307084;11276.718082048015;11443;11589.304641721523;11604.825927611262 02:27:05 INFO - PROCESS | 1664 | |3;mootools.html;1606.2611198848529;1613.798275215598;1905;1997.460685614884;2054.7123402723614;8161.347092232622;8947.91052089479;9196.678116265924;9402.623895044208;9429.00995395483;7957.840843183148;8790.769292299083;8862.291016718664;9010.54947252638;9096.454212747223;2518.848869067853;2534.4170840706647;2536.1503896194795;2541.3265484646586;2543.26245388837;2489.7759201671847;2520.735322791108;2548.7323830997757;2563.5641940870096;2571.3571607098224;2529.544681957247;2545.37638278622;2566.8459892406518;2574.073333599912;2576.9226923192336;2200.449887528118;2524.924252272435;2535.860527670968;2540.983606557373;2564.1538292363475;2535.467551814121;2564.2050964201158;2575.7681808637312;2580.7935365170742;2582.1607977407416;9120.996690364054;9192.218661413788;9202.355835091546;9210.217131543826;9261.72214833556;5608.803691870765;5631.71841407928;5743.023685973395;5751.309842818889;5752.36723960364;3671.7980511071883;3746.063484128968;3750.774953502799;3769.208466222097;3783.8675646352244;1082.8484012238293;1098.214776434845;1099.3623698254994;1116.8380584815238;1124.8987591116838;12321.69195770104;12448.75102497945;12460.190087644274;12465.12744107922;12478.43847026877;4969.35398398206;5020.748962551857;5097;5114.207297868837;5127.230915362651;10438;10502;10590;10611.363318200933;10620.991005854432;5607.8598035048635;5623.015972204929;5626.85932851682;5756.194132821408;5756.366799652035;4640.816591769078;5039;5064.18972964324;5089.8218562350885;5103.668261562986;4234.809433575435;4249.97875010623;4373.950251939512;4412.470503539532;4418.668599855024;1358.5652591170929;1359.3543067043272;1361.4145917255676;1363.817891373794;1364.7543442180304;888.9111088891059;936.6440752514137;987.9429010958349;994.7910938702953;1014.7868947520956;5269.683818970874;6174.938250617526;6270.843228919313;6329.461995730415;6346.936530634727;498.78296955428635;507.4899725775646;508.189437846634;1034.5292891734243;1073.1307640810812;3591.658792414769;4102.897427564275;4155.937660935088;4179.874603761831;4181.456410666594;10749.785004300027;10888.945555272174;11063.446827658585;11081.889181108247;11235.494402751896;10879.619213327496;10943.83584246237;11013;11048;11075.556977720962;8303.211194936472;8708.042115367305;8800.691975780945;8921.732348029569;9021.233195178484;5812.94187058141;5960.97019514917;6039.305479869871;6087.66517841523;6135.049067394561;9188.219001384958;9796.363236389898;10087.949560252151;10263.794724105626;10264.846027309746;10085.546150423395;10279.794404112026;10498.002689744462;10696.358218506915;10710.30383025132;6243;6741.730330786713;7114.857702846018;7378.7786366406945;7503.287187717158;8571.871421928801;8581.8712719308;8674.132586741276;8678.435901666624;8710.47737135774;7560.243975602396;7682.6158692064055;7729.07251129868;7739.071311442663;7758.883616745867;7509.699612015458;7524.247575242432;7554.4334174936;7652.349550288288;7679.500832445873;7320.487565870551;7335.669894854851;7336.046313979148;7360.631968401665;7380.114386273682;5033.899322013466;5054.2671312660195;5120.6159538035545;5231.921521177109;5241.6068794839775;5178.378594568676;5211.296474975829;5310.601704872072;5413.296271484682;5427.565794736491 02:27:05 INFO - PROCESS | 1664 | |4;prototype.html;343.23287452543576;346.19164251472813;350.37807890993497;351.7502573173047;358.6771905285245;5403.864903377417;5480.26016487774;6476.22285325761;6710.261871194165;6744.86510269795;5442.401335853053;6570.572912760667;6612.768553100643;6703.463722902168;6713.697883595238;4703.929441058387;4923.852284431473;4951.678140920847;4953.653244272902;4959.132151873408;4049.777262250575;4856.077345304381;4939.135651261015;4956.801727930879;4957.157283261854;4854.684445511049;4860.635452341071;4865.854024379274;4869.245266983623;4902.632302577304;4868.196747536652;4869.2939523768855;4883.218685010382;4895.804167833282;4925.655204135712;3470.5661792275964;4154.50145982481;4158.521769996459;4163.75017498951;4168.8332466701295;6376.808695739135;6475.7085931133215;6526;6529.640869752162;6540.4767618590395;5540.612157149001;5761.711914404263;5780.624259423124;5797.478226959552;5811.854703632401;7140.92859071413;7161.570305781618;7210.2789721028;7231;7256.056712627377;4656.976715116402;4684.110019096361;4699.765011749399;4703.858884233478;4705.223638099709;7504.3246107850555;7567.243275672444;7604.885926711104;7628.732994345227;7657.961710191414;4025.577314381948;4764.857054288307;4770.499097594772;4778.1399348116975;4792.880177995578;4564.42944631921;4769.57073863354;4838.782254798542;4842.370491836039;4861.756912154378;5745.368009518949;5747;5759.337676167211;5760.049591817303;5791.362950075489;7133.144022717307;7150.642467876585;7171.49799514029;7194;7239.565626062453;1655.337864854044;1670.6491636756175;1675.2377668160957;1675.7235056215588;1682.973386234396;896.4576431259125;1030.90206430389;1057.7038429239826;1068.060107105742;1078.6710053433778;6766.15423072116;6782.355676210851;6791.592504449749;6817.965910170417;6851.862962740717;7475;7490.250974902466;7499.287567681062;7520.435967302365;7525.548467091882;6546.279909209983;6775.966120169368;6813.977903314443;6866.485013623998;6876.346747059021;3243.4810430331504;3662.6814346835117;3912.471816304819;3953.5058117735284;3954.7231693781737;7694.99965004557;7843.490173138728;7880.896674465579;7894.368450523944;7907.130215676271;5520.751566179531;7763;7781.92218077812;7800.5709685966685;7846.489978151402;6287.811365659038;7615.4669173157345;7876.369890408753;7917.287444129941;7946.562939038293;7480.438967077382;7531.171571127062;7543.47195696296;7551.73568925085;7556.2443755624;5392.919106213489;6125.877482450237;6941.201761797458;7386.039814824253;7400.185979542353;6384.521160912857;7868.173841746763;7879.487833290817;7880.645370958436;7897.526148431112;4577.427821522309;4747.643926705442;4750.762461876823;4761.357216775691;4774.474807771073;7366.484346095936;7397.186309506058;7410.703571857281;7412;7429.517081389692;7122.21655617892;7144.571325720265;7150.7497237596435;7155.248698886542;7165.7850264492145;7140.214576396696;7143.9285607143265;7148.142222933281;7155.570665760071;7211.747588834575;6730.158730158731;6951.895721564281;6962.686679099554;6981.895271571032;7003.7548685795755;7093.1488221413765;7125.394341481032;7127.786166415016;7144.142702875688;7145.285471452813;5614.438556144353;6916.273791252047;6930.48021398387;6956.965215173892;6969.58182509051 02:27:05 INFO - PROCESS | 1664 | |5;yui.html;732.9926700732991;739.4343327354574;747.7345542332472;767.2404319723472;806.7216810200479;15348.846511534895;15417.229138543084;15622.765658515103;15657.138857362841;15744.29150688219;14482.637934051627;14488.420463181461;14515.49195778148;14530.636734081654;14551.854481455182;813.7111325479458;991.2417000994209;996.6611352140271;998.236349192868;1000.6997900629818;920.4431319051978;982.9580644516835;987.4519641598946;992.9354591951536;993.5280741647696;972.4068318325816;1044.075992746421;1051.337657275915;1053.1943063556384;1056.1234175634243;974.4640447753707;1026.5226669598635;1046.7801761630028;1050.8318669012997;1051.0277992856654;745.8732015557368;769.6459628570864;788.1606089514648;793.2067932067932;798.0503201190564;13878.306084695825;13959.441622335095;14006.439742410292;14012.439502419891;14059.718805623932;11583.36291503967;11622.535098596047;11634.767304653944;11746.647600571996;11961;9389.483578403186;9626.229901607925;9732.610695572168;9739.56171972263;9763.218942484584;3511.8595256189724;3557.6620221078956;3561.465780132975;3579.8926032219074;3632.0919770057485;72917.27082729158;80514;85460.99999999937;87312.56343718304;88106;9920.4543750093;10154.949225253826;10171.694849154537;10182.490875456346;10305;22539.32382028542;22880.771192288197;23030.424239393815;23091.88454057719;23149.074037038667;6806.76176333826;7872.488288261245;7924.247196516321;7993.360531157494;8118.391120665974;4247.723897946624;4304.289792184317;4310.935335969963;4353.978230108829;4428.579284967923;3736.813159342022;3791.9810400947817;3815.751976121543;3824.4836947012354;3836.462895194675;691.9377256046879;692.7021380806302;699.4614147106699;710.9324614161646;713.6075158662715;620.7548018532655;633.7718421368304;636.4049613611288;639.11163482759;650.4016304999412;8161.306288965505;8483.703070392507;8519.148085191555;8595.398322117391;8769.824603507894;623.9594426362272;638.1894993358502;645.3868824616633;646.2923099206362;649.1074772188241;3898.5516665583823;3961.7821019844187;3977.721559490808;3999.960000400017;4052.9797351013644;87325;91318.54340728254;92478;92646;93302;67305.32694673089;76708.082297943;81288.59355703184;81809.59095204486;82767.58616207;68503.3149668507;68684.65657671679;69266.61466770637;69374.61250774957;69832.95250571246;8336.666533338841;8411.957940210259;8525.104863989192;8607.397482176188;8659.177378149066;46261.07477850492;46302.76848615735;48563;48692.269615956495;49845;51491.74254128705;57415.138772917606;58336.70831645815;60578.4855378619;61520.69239653952;11157;11204.66386008421;11336.433178340885;11436.828447573127;11558.07535397183;12031.4585843639;12154.392280386122;12255.877441225473;12291.32397718134;12485.812712809497;9298.395604285699;11577.6526704199;11745.647630571097;11884.643460696192;11984.161108722306;10409.63566275207;11453.885461145283;11538.192326537062;11675.88324116782;12221.205621634565;11274.830877536679;11506.884931150582;11561.959423651911;11833.290002599872;11861.229020113666;9549.37756035476;9672.032796720554;9729.610815567297;9792.216622670312;9953.104220620178;9742.512874356396;10030.598776049168;10053.849192262269;10097.545610447694;10098.899011009797 02:27:05 INFO - PROCESS | 1664 | __end_tp_report 02:27:05 INFO - PROCESS | 1664 | __start_cc_report 02:27:05 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,394 02:27:05 INFO - PROCESS | 1664 | __end_cc_report 02:27:05 INFO - PROCESS | 1664 | __startTimestamp1466587625777__endTimestamp 02:27:05 INFO - PROCESS | 1664 | 02:27:05 INFO - PROCESS | 1664 | ------- Summary: start ------- 02:27:05 INFO - PROCESS | 1664 | Number of tests: 6 02:27:05 INFO - PROCESS | 1664 | 02:27:05 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5850.19 Median:6069.97 stddev:615.88 (10.1%) stddev-sans-first:592.87 02:27:05 INFO - PROCESS | 1664 | Values: 3640.4 3644.3 3700.4 3716.6 3722.1 5921.9 5939.1 5943.3 5945.4 5949.6 5909.5 5920.0 5945.4 5950.3 5954.5 5302.9 5326.3 5345.0 5424.8 5436.3 5312.4 5370.5 5393.2 5420.6 5427.3 5357.4 5387.4 5388.2 5392.7 5398.9 5348.9 5391.4 5412.3 5444.0 5482.7 5306.1 5352.4 5365.9 5398.2 5425.3 4785.5 5720.4 5772.3 5788.8 5907.4 6194.1 6285.6 6300.0 6306.8 6321.8 6008.6 6113.6 6254.0 6261.3 6263.4 5365.8 5766.2 5785.9 5904.8 5986.6 5508.6 6340.2 6384.0 6409.8 6466.3 6289.1 6290.8 6301.9 6315.2 6317.7 6217.1 6291.9 6317.2 6335.5 6362.5 5597.4 6250.9 6253.3 6303.9 6317.8 5732.0 6230.3 6276.8 6305.8 6325.8 4533.4 4917.2 5029.7 5041.9 5045.4 4502.1 4518.9 4519.9 4564.7 4589.1 6067.6 6070.0 6091.8 6094.0 6100.8 5710.8 6286.9 6297.7 6326.3 6358.4 5980.3 6043.4 6057.3 6060.7 6089.7 5483.8 5554.6 5604.0 5623.7 5629.9 6370.8 6509.8 6513.4 6569.1 6588.0 6279.4 6306.9 6313.0 6333.5 6343.6 6340.7 6530.3 6555.3 6568.3 6580.2 6254.6 6269.4 6277.2 6286.7 6293.0 5286.8 6261.0 6265.7 6299.9 6318.2 5491.7 5581.4 6053.5 6190.2 6205.8 5647.8 6024.0 6271.6 6290.9 6295.1 6061.7 6147.9 6156.4 6197.3 6198.6 6188.2 6191.5 6219.4 6263.7 6263.8 6083.8 6142.9 6158.8 6188.7 6207.4 02:27:05 INFO - PROCESS | 1664 | 02:27:05 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:71260.90 Median:38206.71 stddev:159139.93 (416.5%) stddev-sans-first:159497.81 02:27:05 INFO - PROCESS | 1664 | Values: 553.9 561.1 563.4 571.0 579.9 33045.5 40193.8 40201.8 40382.8 40562.6 44590.3 45086.3 45361.0 45579.1 45631.8 9748.2 9957.3 9967.0 9973.0 9978.8 9896.4 9992.5 10009.7 10028.9 10037.7 8498.2 9995.4 10052.1 10057.7 10069.6 9955.2 10009.4 10035.4 10054.9 10085.5 9691.5 9773.6 9808.8 9813.8 9830.8 34740.8 40409.4 40973.0 41191.0 41363.0 2824.6 3326.9 3489.4 3624.2 3933.3 29069.0 30088.5 30324.8 30442.7 30939.7 2803.2 2821.5 2879.0 2881.0 2945.3 436409.0 438149.0 439713.0 440277.6 442027.0 38114.4 39088.6 64418.4 64792.0 64809.7 37125.8 37138.4 37175.3 37202.8 37301.4 16316.2 16750.7 16855.5 17016.0 17025.1 13898.7 14301.9 14345.1 14358.6 14445.9 8562.1 8620.4 8649.4 8659.2 8688.9 3077.7 3503.8 3568.4 3578.8 3586.2 1009.5 1018.6 1054.7 1113.9 1225.4 30737.7 31137.2 31333.1 31353.1 32002.7 1173.7 1201.1 1209.2 1218.8 1270.9 15506.7 16081.4 16126.0 16254.3 16411.6 677775.0 679892.0 694116.0 696191.0 697444.0 64700.0 65460.0 65761.7 66041.3 66848.7 1434.7 1435.0 1553.8 1568.9 1569.5 30916.5 31009.5 31042.1 31318.8 31559.0 54923.5 55362.7 55423.2 55432.0 55441.3 617983.0 622599.0 627071.0 627196.0 627855.0 27699.0 44411.0 44626.3 45972.4 46730.0 45449.8 45725.6 46079.0 46692.1 46740.5 36979.0 37537.0 37763.4 38452.0 38770.8 38469.6 39022.4 39134.0 39225.0 39783.4 38299.0 38513.9 38882.0 38959.4 39683.2 33156.0 34245.7 34409.5 34480.8 34673.8 25708.7 25787.9 25885.7 25933.0 26311.0 02:27:05 INFO - PROCESS | 1664 | 02:27:05 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:36810.02 Median:21150.13 stddev:114990.99 (543.7%) stddev-sans-first:115281.00 02:27:05 INFO - PROCESS | 1664 | Values: 361.5 414.1 423.0 426.1 435.3 18265.7 20895.6 21404.7 21433.0 21642.0 20313.3 20682.5 20774.4 20806.4 20869.7 5773.1 5834.4 6042.1 6070.9 6077.1 5281.8 5970.0 5975.5 6017.5 6060.7 5125.4 5750.5 6000.8 6067.1 6088.9 5829.1 6005.0 6033.8 6077.5 6155.1 5775.5 5930.6 5991.7 6009.7 6015.4 13711.6 13758.7 14064.3 14080.7 14081.7 2059.2 2195.9 2197.2 2238.6 2239.0 10107.2 10125.9 10289.3 10466.6 10518.2 1709.6 1797.4 1811.8 1816.5 1831.6 95227.0 103453.0 104003.5 109043.0 110440.3 11971.7 12036.6 12100.3 12113.5 12150.6 12645.9 13970.4 15396.0 15516.6 15571.5 9066.7 9154.9 9290.6 9290.9 9406.3 7594.6 9164.5 9179.0 9202.4 9368.7 4326.5 4496.8 4772.3 4849.7 4856.0 1802.2 2009.7 2067.6 2083.3 2086.6 884.1 931.6 959.6 997.3 1056.0 20408.9 20714.9 20747.7 20813.2 20814.2 868.6 953.7 988.5 1007.2 1032.4 10678.9 11011.1 11066.3 11078.1 11099.3 670328.0 695421.0 701069.0 701901.0 710567.0 99701.0 124263.0 126177.4 127190.0 130504.0 1044.2 1052.7 1065.7 1066.9 1070.1 17854.8 18288.9 18350.0 18727.7 18762.9 43917.0 48392.0 52982.5 53608.2 54546.5 73666.3 74780.6 76604.6 76888.0 77898.0 8176.9 8340.5 8442.1 8605.9 8721.7 11527.2 11983.6 13011.0 13150.0 13177.9 10778.3 11102.8 11235.4 11386.8 11396.7 5333.9 6382.6 11079.2 11458.3 11759.8 9085.3 11392.6 11455.3 12090.6 12190.7 8109.8 8342.3 8564.8 8641.9 8824.3 10423.1 11276.7 11443.0 11589.3 11604.8 02:27:05 INFO - PROCESS | 1664 | 02:27:05 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5946.80 Median:5036.45 stddev:3297.57 (65.5%) stddev-sans-first:3290.69 02:27:05 INFO - PROCESS | 1664 | Values: 1606.3 1613.8 1905.0 1997.5 2054.7 8161.3 8947.9 9196.7 9402.6 9429.0 7957.8 8790.8 8862.3 9010.5 9096.5 2518.8 2534.4 2536.2 2541.3 2543.3 2489.8 2520.7 2548.7 2563.6 2571.4 2529.5 2545.4 2566.8 2574.1 2576.9 2200.4 2524.9 2535.9 2541.0 2564.2 2535.5 2564.2 2575.8 2580.8 2582.2 9121.0 9192.2 9202.4 9210.2 9261.7 5608.8 5631.7 5743.0 5751.3 5752.4 3671.8 3746.1 3750.8 3769.2 3783.9 1082.8 1098.2 1099.4 1116.8 1124.9 12321.7 12448.8 12460.2 12465.1 12478.4 4969.4 5020.7 5097.0 5114.2 5127.2 10438.0 10502.0 10590.0 10611.4 10621.0 5607.9 5623.0 5626.9 5756.2 5756.4 4640.8 5039.0 5064.2 5089.8 5103.7 4234.8 4250.0 4374.0 4412.5 4418.7 1358.6 1359.4 1361.4 1363.8 1364.8 888.9 936.6 987.9 994.8 1014.8 5269.7 6174.9 6270.8 6329.5 6346.9 498.8 507.5 508.2 1034.5 1073.1 3591.7 4102.9 4155.9 4179.9 4181.5 10749.8 10888.9 11063.4 11081.9 11235.5 10879.6 10943.8 11013.0 11048.0 11075.6 8303.2 8708.0 8800.7 8921.7 9021.2 5812.9 5961.0 6039.3 6087.7 6135.0 9188.2 9796.4 10087.9 10263.8 10264.8 10085.5 10279.8 10498.0 10696.4 10710.3 6243.0 6741.7 7114.9 7378.8 7503.3 8571.9 8581.9 8674.1 8678.4 8710.5 7560.2 7682.6 7729.1 7739.1 7758.9 7509.7 7524.2 7554.4 7652.3 7679.5 7320.5 7335.7 7336.0 7360.6 7380.1 5033.9 5054.3 5120.6 5231.9 5241.6 5178.4 5211.3 5310.6 5413.3 5427.6 02:27:05 INFO - PROCESS | 1664 | 02:27:05 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5821.45 Median:6591.67 stddev:1892.60 (28.7%) stddev-sans-first:1852.70 02:27:05 INFO - PROCESS | 1664 | Values: 343.2 346.2 350.4 351.8 358.7 5403.9 5480.3 6476.2 6710.3 6744.9 5442.4 6570.6 6612.8 6703.5 6713.7 4703.9 4923.9 4951.7 4953.7 4959.1 4049.8 4856.1 4939.1 4956.8 4957.2 4854.7 4860.6 4865.9 4869.2 4902.6 4868.2 4869.3 4883.2 4895.8 4925.7 3470.6 4154.5 4158.5 4163.8 4168.8 6376.8 6475.7 6526.0 6529.6 6540.5 5540.6 5761.7 5780.6 5797.5 5811.9 7140.9 7161.6 7210.3 7231.0 7256.1 4657.0 4684.1 4699.8 4703.9 4705.2 7504.3 7567.2 7604.9 7628.7 7658.0 4025.6 4764.9 4770.5 4778.1 4792.9 4564.4 4769.6 4838.8 4842.4 4861.8 5745.4 5747.0 5759.3 5760.0 5791.4 7133.1 7150.6 7171.5 7194.0 7239.6 1655.3 1670.6 1675.2 1675.7 1683.0 896.5 1030.9 1057.7 1068.1 1078.7 6766.2 6782.4 6791.6 6818.0 6851.9 7475.0 7490.3 7499.3 7520.4 7525.5 6546.3 6776.0 6814.0 6866.5 6876.3 3243.5 3662.7 3912.5 3953.5 3954.7 7695.0 7843.5 7880.9 7894.4 7907.1 5520.8 7763.0 7781.9 7800.6 7846.5 6287.8 7615.5 7876.4 7917.3 7946.6 7480.4 7531.2 7543.5 7551.7 7556.2 5392.9 6125.9 6941.2 7386.0 7400.2 6384.5 7868.2 7879.5 7880.6 7897.5 4577.4 4747.6 4750.8 4761.4 4774.5 7366.5 7397.2 7410.7 7412.0 7429.5 7122.2 7144.6 7150.7 7155.2 7165.8 7140.2 7143.9 7148.1 7155.6 7211.7 6730.2 6951.9 6962.7 6981.9 7003.8 7093.1 7125.4 7127.8 7144.1 7145.3 5614.4 6916.3 6930.5 6957.0 6969.6 02:27:05 INFO - PROCESS | 1664 | 02:27:05 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18092.47 Median:50668.37 stddev:25168.51 (49.7%) stddev-sans-first:25205.36 02:27:05 INFO - PROCESS | 1664 | Values: 733.0 739.4 747.7 767.2 806.7 15348.8 15417.2 15622.8 15657.1 15744.3 14482.6 14488.4 14515.5 14530.6 14551.9 813.7 991.2 996.7 998.2 1000.7 920.4 983.0 987.5 992.9 993.5 972.4 1044.1 1051.3 1053.2 1056.1 974.5 1026.5 1046.8 1050.8 1051.0 745.9 769.6 788.2 793.2 798.1 13878.3 13959.4 14006.4 14012.4 14059.7 11583.4 11622.5 11634.8 11746.6 11961.0 9389.5 9626.2 9732.6 9739.6 9763.2 3511.9 3557.7 3561.5 3579.9 3632.1 72917.3 80514.0 85461.0 87312.6 88106.0 9920.5 10154.9 10171.7 10182.5 10305.0 22539.3 22880.8 23030.4 23091.9 23149.1 6806.8 7872.5 7924.2 7993.4 8118.4 4247.7 4304.3 4310.9 4354.0 4428.6 3736.8 3792.0 3815.8 3824.5 3836.5 691.9 692.7 699.5 710.9 713.6 620.8 633.8 636.4 639.1 650.4 8161.3 8483.7 8519.1 8595.4 8769.8 624.0 638.2 645.4 646.3 649.1 3898.6 3961.8 3977.7 4000.0 4053.0 87325.0 91318.5 92478.0 92646.0 93302.0 67305.3 76708.1 81288.6 81809.6 82767.6 68503.3 68684.7 69266.6 69374.6 69833.0 8336.7 8412.0 8525.1 8607.4 8659.2 46261.1 46302.8 48563.0 48692.3 49845.0 51491.7 57415.1 58336.7 60578.5 61520.7 11157.0 11204.7 11336.4 11436.8 11558.1 12031.5 12154.4 12255.9 12291.3 12485.8 9298.4 11577.7 11745.6 11884.6 11984.2 10409.6 11453.9 11538.2 11675.9 12221.2 11274.8 11506.9 11562.0 11833.3 11861.2 9549.4 9672.0 9729.6 9792.2 9953.1 9742.5 10030.6 10053.8 10097.5 10098.9 02:27:05 INFO - PROCESS | 1664 | -------- Summary: end -------- 02:27:05 INFO - PROCESS | 1664 | 02:27:06 INFO - TEST-INFO | 1664: exit 0 02:27:06 INFO - TEST-OK | dromaeo_css | took 1110653ms 02:27:06 INFO - TEST-START | kraken 02:27:06 INFO - operating with platform_type : mac_ 02:27:06 INFO - Initialising browser for kraken test... 02:27:06 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp3y9qPv/profile http://localhost:49275/getInfo.html) 02:27:08 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 02:27:08 INFO - PROCESS | 1673 | colorDepth:24 02:27:08 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 02:27:08 INFO - PROCESS | 1673 | __metrics 02:27:08 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:27:09 INFO - TEST-INFO | 1673: exit 0 02:27:09 INFO - Browser initialized. 02:27:09 INFO - Running cycle 1/1 for kraken test... 02:27:09 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp3y9qPv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:21 INFO - PROCESS | 1677 | RSS: Main: 170811392 02:27:21 INFO - PROCESS | 1677 | 02:27:24 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 02:27:24 INFO - PROCESS | 1677 | RSS: Main: 183345152 02:27:24 INFO - PROCESS | 1677 | 02:27:27 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 02:27:28 INFO - PROCESS | 1677 | RSS: Main: 192020480 02:27:28 INFO - PROCESS | 1677 | 02:27:31 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 02:27:32 INFO - PROCESS | 1677 | RSS: Main: 195383296 02:27:32 INFO - PROCESS | 1677 | 02:27:34 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 02:27:34 INFO - PROCESS | 1677 | RSS: Main: 196177920 02:27:34 INFO - PROCESS | 1677 | 02:27:36 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:27:37 INFO - PROCESS | 1677 | RSS: Main: 196464640 02:27:37 INFO - PROCESS | 1677 | 02:27:40 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 02:27:41 INFO - PROCESS | 1677 | RSS: Main: 196591616 02:27:41 INFO - PROCESS | 1677 | 02:27:43 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 02:27:44 INFO - PROCESS | 1677 | RSS: Main: 196632576 02:27:44 INFO - PROCESS | 1677 | 02:27:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 02:27:47 INFO - PROCESS | 1677 | RSS: Main: 197943296 02:27:47 INFO - PROCESS | 1677 | 02:27:49 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:27:50 INFO - PROCESS | 1677 | RSS: Main: 197316608 02:27:50 INFO - PROCESS | 1677 | 02:27:51 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:27:52 INFO - PROCESS | 1677 | RSS: Main: 197468160 02:27:52 INFO - PROCESS | 1677 | 02:27:54 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:27:55 INFO - PROCESS | 1677 | RSS: Main: 197726208 02:27:55 INFO - PROCESS | 1677 | 02:27:57 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:27:58 INFO - PROCESS | 1677 | RSS: Main: 198037504 02:27:58 INFO - PROCESS | 1677 | 02:28:01 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:28:01 INFO - PROCESS | 1677 | RSS: Main: 197951488 02:28:01 INFO - PROCESS | 1677 | 02:28:03 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 02:28:04 INFO - PROCESS | 1677 | RSS: Main: 199938048 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | __start_tp_report 02:28:04 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 02:28:04 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 02:28:04 INFO - PROCESS | 1677 | |i|pagename|runs| 02:28:04 INFO - PROCESS | 1677 | |0;ai-astar;118;113;118;117;117;131;116;117;118;116 02:28:04 INFO - PROCESS | 1677 | |1;audio-beat-detection;170;147;144;161;122;148;167;154;188;144 02:28:04 INFO - PROCESS | 1677 | |2;audio-dft;194;197;200;195;195;194;193;198;199;196 02:28:04 INFO - PROCESS | 1677 | |3;audio-fft;65;83;77;155;54;60;81;95;150;53 02:28:04 INFO - PROCESS | 1677 | |4;audio-oscillator;79;78;124;92;114;76;149;117;113;153 02:28:04 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;95;130;88;91;93;84;88;91;125;85 02:28:04 INFO - PROCESS | 1677 | |6;imaging-darkroom;94;94;93;94;93;94;117;129;93;117 02:28:04 INFO - PROCESS | 1677 | |7;imaging-desaturate;90;92;89;90;96;91;90;92;90;89 02:28:04 INFO - PROCESS | 1677 | |8;json-parse-financial;55;62;63;63;64;65;65;77;59;55 02:28:04 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;62;64;64;65;69;66;66;65;65;66 02:28:04 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;79;79;83;80;79;80;80;80;85;84 02:28:04 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;125;129;140;121;124;127;128;125;141;139 02:28:04 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;217;167;161;162;218;214;162;161;162;163 02:28:04 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;72;85;89;92;94;92;92;77;67;68 02:28:04 INFO - PROCESS | 1677 | __end_tp_report 02:28:04 INFO - PROCESS | 1677 | __start_cc_report 02:28:04 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1039 02:28:04 INFO - PROCESS | 1677 | __end_cc_report 02:28:04 INFO - PROCESS | 1677 | __startTimestamp1466587684062__endTimestamp 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | ------- Summary: start ------- 02:28:04 INFO - PROCESS | 1677 | Number of tests: 14 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:118.10 Median:117.50 stddev:4.77 (4.1%) stddev-sans-first:5.06 02:28:04 INFO - PROCESS | 1677 | Values: 118.0 113.0 118.0 117.0 117.0 131.0 116.0 117.0 118.0 116.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:157.50 stddev:18.06 (11.5%) stddev-sans-first:18.27 02:28:04 INFO - PROCESS | 1677 | Values: 170.0 147.0 144.0 161.0 122.0 148.0 167.0 154.0 188.0 144.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:196.10 Median:196.50 stddev:2.33 (1.2%) stddev-sans-first:2.35 02:28:04 INFO - PROCESS | 1677 | Values: 194.0 197.0 200.0 195.0 195.0 194.0 193.0 198.0 199.0 196.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:87.30 Median:71.00 stddev:36.92 (52.0%) stddev-sans-first:38.26 02:28:04 INFO - PROCESS | 1677 | Values: 65.0 83.0 77.0 155.0 54.0 60.0 81.0 95.0 150.0 53.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:114.50 stddev:28.09 (24.5%) stddev-sans-first:27.54 02:28:04 INFO - PROCESS | 1677 | Values: 79.0 78.0 124.0 92.0 114.0 76.0 149.0 117.0 113.0 153.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:97.00 Median:89.50 stddev:16.47 (18.4%) stddev-sans-first:17.45 02:28:04 INFO - PROCESS | 1677 | Values: 95.0 130.0 88.0 91.0 93.0 84.0 88.0 91.0 125.0 85.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:101.80 Median:93.50 stddev:13.65 (14.6%) stddev-sans-first:14.19 02:28:04 INFO - PROCESS | 1677 | Values: 94.0 94.0 93.0 94.0 93.0 94.0 117.0 129.0 93.0 117.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:90.90 Median:90.50 stddev:2.08 (2.3%) stddev-sans-first:2.18 02:28:04 INFO - PROCESS | 1677 | Values: 90.0 92.0 89.0 90.0 96.0 91.0 90.0 92.0 90.0 89.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.50 stddev:6.23 (9.8%) stddev-sans-first:5.94 02:28:04 INFO - PROCESS | 1677 | Values: 55.0 62.0 63.0 63.0 64.0 65.0 65.0 77.0 59.0 55.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:1.81 (2.8%) stddev-sans-first:1.51 02:28:04 INFO - PROCESS | 1677 | Values: 62.0 64.0 64.0 65.0 69.0 66.0 66.0 65.0 65.0 66.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:2.23 (2.8%) stddev-sans-first:2.26 02:28:04 INFO - PROCESS | 1677 | Values: 79.0 79.0 83.0 80.0 79.0 80.0 80.0 80.0 85.0 84.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:128.50 stddev:7.32 (5.7%) stddev-sans-first:7.55 02:28:04 INFO - PROCESS | 1677 | Values: 125.0 129.0 140.0 121.0 124.0 127.0 128.0 125.0 141.0 139.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:165.00 stddev:26.04 (15.8%) stddev-sans-first:23.65 02:28:04 INFO - PROCESS | 1677 | Values: 217.0 167.0 161.0 162.0 218.0 214.0 162.0 161.0 162.0 163.0 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.80 Median:90.50 stddev:10.76 (11.9%) stddev-sans-first:10.68 02:28:04 INFO - PROCESS | 1677 | Values: 72.0 85.0 89.0 92.0 94.0 92.0 92.0 77.0 67.0 68.0 02:28:04 INFO - PROCESS | 1677 | -------- Summary: end -------- 02:28:04 INFO - PROCESS | 1677 | 02:28:04 INFO - TEST-INFO | 1677: exit 0 02:28:04 INFO - TEST-OK | kraken | took 58480ms 02:28:04 INFO - SUITE-END | took 1169s 02:28:05 INFO - Completed test suite (00:19:29) 02:28:05 INFO - javascript benchmark 02:28:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3640.435732461468, 3644.3075815595034, 3700.4264339027427, 3716.628337166284, 3722.1066943933447, 5921.88156236875, 5939.079442686385, 5943.316518600368, 5945.405459454063, 5949.643021418718, 5909.468147866691, 5920.023196172627, 5945.37573554777, 5950.345461999176, 5954.493868021213, 5302.946970530304, 5326.280952071459, 5345.0, 5424.755885985121, 5436.293281873351, 5312.442193569677, 5370.516653501184, 5393.2449457076045, 5420.647657902244, 5427.348718153827, 5357.4374690657505, 5387.4073851876265, 5388.218708287315, 5392.703401312926, 5398.865028374303, 5348.91976620351, 5391.433899440581, 5412.323459567574, 5444.047291723932, 5482.698451585161, 5306.071437498461, 5352.384475785296, 5365.946340536584, 5398.24424580559, 5425.294711687495, 4785.545373189576, 5720.427957204246, 5772.30732312121, 5788.82633520995, 5907.438793314628, 6194.132821405007, 6285.622862628257, 6299.968500157515, 6306.842328941767, 6321.778737744157, 6008.648054187816, 6113.633182009094, 6254.0, 6261.27995280544, 6263.404976527223, 5365.812196573102, 5766.163906233573, 5785.855353616151, 5904.7933322334375, 5986.640801551921, 5508.641938274, 6340.239171299381, 6384.0, 6409.839754006187, 6466.256380516207, 6289.088082228142, 6290.8427289317215, 6301.905471417932, 6315.179026726588, 6317.684115794192, 6217.098520714471, 6291.937080629226, 6317.210348706411, 6335.493160547145, 6362.491000719931, 5597.356304025007, 6250.874982500324, 6253.280872699606, 6303.936960630427, 6317.842053948688, 5732.0, 6230.345813689588, 6276.780312689125, 6305.842353941188, 6325.7785977491485, 4533.38799262102, 4917.188663870421, 5029.723365214948, 5041.949580504148, 5045.445001049881, 4502.099580083931, 4518.932216016762, 4519.887002824956, 4564.726116432958, 4589.128065667513, 6067.635941843503, 6069.968105422001, 6091.786787462506, 6093.969530152321, 6100.816975490742, 5710.772183980464, 6286.937130628635, 6297.653629050446, 6326.335734747877, 6358.3641635836975, 5980.342162362137, 6043.407169588098, 6057.303410107806, 6060.727267272895, 6089.695515224221, 5483.7806487740045, 5554.555635549227, 5604.0, 5623.690697011703, 5629.915551266734, 6370.8088757337355, 6509.804705858832, 6513.446357059608, 6569.080328753978, 6588.0, 6279.403456671609, 6306.905396419149, 6313.0, 6333.524985626004, 6343.55595108338, 6340.682965851597, 6530.314316996647, 6555.344465553407, 6568.310327415553, 6580.177477815273, 6254.562180647311, 6269.404406581368, 6277.1525844010475, 6286.748530058747, 6293.024581189923, 5286.788528458818, 6261.029540421242, 6265.686715664289, 6299.905501417574, 6318.241810982711, 5491.670499770026, 5581.441855814386, 6053.545984051126, 6190.1952746142715, 6205.751769929152, 5647.802326918538, 6023.969880150571, 6271.62370257786, 6290.937090629218, 6295.055741638791, 6061.666608336407, 6147.877042459215, 6156.353582873734, 6197.287311959002, 6198.597091189058, 6188.226471691039, 6191.535634827316, 6219.40915613016, 6263.65549894742, 6263.812085637438, 6083.8174854754425, 6142.877142457215, 6158.846028849314, 6188.659623720739, 6207.410296021871], "value": 5815.436363568555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.8864532770782, 561.0657467043181, 563.3999790223412, 570.96859672718, 579.9362070172282, 33045.50431743526, 40193.79903100484, 40201.798991005, 40382.78851634448, 40562.59437405625, 44590.33114503277, 45086.32370514445, 45361.0, 45579.088418231615, 45631.77184114083, 9748.171405430547, 9957.253206009542, 9967.0, 9973.0, 9978.800423991515, 9896.35673681212, 9992.45041522716, 10009.699709008704, 10028.946960569145, 10037.69886903394, 8498.235158835703, 9995.350302230368, 10052.14556762676, 10057.698269051903, 10069.64756233532, 9955.203583713286, 10009.399436033862, 10035.397876127456, 10054.899451005469, 10085.49572521371, 9691.466969316685, 9773.609055637766, 9808.754781130458, 9813.754656133582, 9830.754231144207, 34740.784072557595, 40409.39385909214, 40973.0, 41191.0, 41363.0, 2824.6398410332836, 3326.850291736878, 3489.389356862539, 3624.2026754114318, 3933.2723446162267, 29069.0, 30088.548671769942, 30324.8483757582, 30442.695573044206, 30939.69060309413, 2803.243124356433, 2821.478026565092, 2879.0499135285304, 2881.0, 2945.307852654646, 436409.0, 438149.0, 439713.0, 440277.59722402686, 442027.0, 38114.42828357577, 39088.609113909064, 64418.35581644217, 64792.0, 64809.703805923615, 37125.814370927976, 37138.44292335617, 37175.25649486995, 37202.8139859299, 37301.44047839285, 16316.184190790651, 16750.74873876893, 16855.494335169966, 17016.0, 17025.06362150069, 13898.652533686738, 14301.856981430261, 14345.067570608086, 14358.641033974025, 14445.85554144445, 8562.058173600899, 8620.396572239883, 8649.3512986525, 8659.177378149066, 8688.913110868936, 3077.723004929567, 3503.827626871356, 3568.3576956148145, 3578.8031658258524, 3586.228960773394, 1009.4649835587151, 1018.556927736437, 1054.7027156597428, 1113.8718204315555, 1225.393430252013, 30737.69262307393, 31137.221569460493, 31333.06000819979, 31353.059408217334, 32002.67997319997, 1173.7124404520946, 1201.08117290273, 1209.238179946628, 1218.7562487502535, 1270.917390369623, 15506.689866202612, 16081.356745730274, 16126.032438053755, 16254.268557914922, 16411.58971025734, 677775.0, 679892.0, 694116.0, 696191.0, 697444.0, 64700.0, 65460.0, 65761.67119164373, 66041.33958660351, 66848.66575667188, 1434.6556826361598, 1434.952484686164, 1553.8057742781925, 1568.8860908754912, 1569.4663814303192, 30916.536251956688, 31009.534856977614, 31042.068737937898, 31318.843405782824, 31559.0, 54923.450765491834, 55362.72318638381, 55423.16865246944, 55432.0, 55441.33675989727, 617983.0, 622599.0, 627071.0, 627196.0, 627855.0, 27699.0, 44411.0, 44626.330605040304, 45972.390966316016, 46730.0, 45449.77275113735, 45725.62823115312, 46079.0, 46692.06615867596, 46740.53259467498, 36979.0, 37537.0, 37763.43354849624, 38452.038699032746, 38770.80614596909, 38469.6153038466, 39022.4146637795, 39134.0, 39225.0, 39783.403248951865, 38299.0, 38513.92879450344, 38882.0, 38959.41560876646, 39683.2063358737, 33156.00531984044, 34245.65754342425, 34409.48385774165, 34480.82759586186, 34673.826630866686, 25708.742912571382, 25787.87106064458, 25885.653458550063, 25932.96268149253, 26311.0], "value": 19618.544880709538, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.53362162809975, 414.1365253446564, 422.97885105744723, 426.14770459081836, 435.3404592043053, 18265.726014109765, 20895.582088358224, 21404.678929816047, 21433.035513401894, 21642.0, 20313.289034883783, 20682.48293792656, 20774.376768696926, 20806.375808725763, 20869.68695469569, 5773.134029895528, 5834.4165583441745, 6042.063480160582, 6070.878582428349, 6077.11881777142, 5281.762320695578, 5970.0, 5975.521958243352, 6017.48851347636, 6060.727267272961, 5125.384953805548, 5750.453706897838, 6000.8499787505225, 6067.059605761114, 6088.939110608903, 5829.09649004405, 6004.96997515014, 6033.758649654031, 6077.483413909823, 6155.10750941111, 5775.480206781368, 5930.584859059867, 5991.700414979234, 6009.729562169713, 6015.428534289235, 13711.588652340446, 13758.724825503534, 14064.2967851607, 14080.718385632332, 14081.718365632732, 2059.217497351012, 2195.8902054897353, 2197.1870407949, 2238.6194346961056, 2239.0260236797044, 10107.191424686007, 10125.886152523217, 10289.3311934724, 10466.63366782159, 10518.211134164969, 1709.632429027765, 1797.4158398520403, 1811.7916439609482, 1816.4550634809636, 1831.6062046660031, 95227.0, 103453.0, 104003.47998260036, 109043.0, 110440.34339484914, 11971.700707482383, 12036.578719744766, 12100.334481603597, 12113.454894529767, 12150.57472988441, 12645.873541264653, 13970.371333290026, 15396.0, 15516.612084697972, 15571.532854014398, 9066.727998160066, 9154.86267705985, 9290.581923813445, 9290.860637090449, 9406.341556091145, 7594.620268986529, 9164.495952722531, 9179.036201198778, 9202.35583509148, 9368.67209647659, 4326.502452218036, 4496.820127194876, 4772.308015337826, 4849.733264670406, 4855.95144048555, 1802.180008096313, 2009.668404713206, 2067.638163321413, 2083.270855200698, 2086.645270304052, 884.1467983396054, 931.6180366049887, 959.5681943125621, 997.33677104726, 1055.9915280906716, 20408.877511737, 20714.896425518076, 20747.68878466824, 20813.1674733012, 20814.167433302497, 868.6351732272461, 953.7186529973675, 988.4761076629397, 1007.2194049611463, 1032.4476405123373, 10678.946605266923, 11011.064059554867, 11066.336019838835, 11078.0583650389, 11099.334039957628, 670328.0, 695421.0, 701069.0, 701901.0, 710567.0, 99701.0, 124263.0, 126177.36911315568, 127190.0, 130504.0, 1044.2011860926398, 1052.7104297235978, 1065.7495488560182, 1066.898644628759, 1070.0957690751302, 17854.821451785316, 18288.90855545714, 18350.0, 18727.71908421402, 18762.906185469532, 43917.0, 48392.0, 52982.4701752993, 53608.195877061095, 54546.45453545414, 73666.26333736809, 74780.62609686916, 76604.61697691475, 76888.0, 77898.0, 8176.877346839683, 8340.541270230196, 8442.071372149181, 8605.870911936201, 8721.738347849574, 11527.193096483166, 11983.64049078529, 13011.0, 13150.0, 13177.934110329386, 10778.29941053829, 11102.833457498306, 11235.438228088726, 11386.829197561878, 11396.715082122682, 5333.906549157336, 6382.6170429774365, 11079.224454288122, 11458.312501249951, 11759.764804703687, 9085.318601105077, 11392.601258955896, 11455.312681239153, 12090.637280881587, 12190.695232619255, 8109.797255068671, 8342.29090527312, 8564.828703426021, 8641.8703719443, 8824.294056475339, 10423.114035307084, 11276.718082048015, 11443.0, 11589.304641721523, 11604.825927611262], "value": 9510.798994729827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1606.2611198848529, 1613.798275215598, 1905.0, 1997.460685614884, 2054.7123402723614, 8161.347092232622, 8947.91052089479, 9196.678116265924, 9402.623895044208, 9429.00995395483, 7957.840843183148, 8790.769292299083, 8862.291016718664, 9010.54947252638, 9096.454212747223, 2518.848869067853, 2534.4170840706647, 2536.1503896194795, 2541.3265484646586, 2543.26245388837, 2489.7759201671847, 2520.735322791108, 2548.7323830997757, 2563.5641940870096, 2571.3571607098224, 2529.544681957247, 2545.37638278622, 2566.8459892406518, 2574.073333599912, 2576.9226923192336, 2200.449887528118, 2524.924252272435, 2535.860527670968, 2540.983606557373, 2564.1538292363475, 2535.467551814121, 2564.2050964201158, 2575.7681808637312, 2580.7935365170742, 2582.1607977407416, 9120.996690364054, 9192.218661413788, 9202.355835091546, 9210.217131543826, 9261.72214833556, 5608.803691870765, 5631.71841407928, 5743.023685973395, 5751.309842818889, 5752.36723960364, 3671.7980511071883, 3746.063484128968, 3750.774953502799, 3769.208466222097, 3783.8675646352244, 1082.8484012238293, 1098.214776434845, 1099.3623698254994, 1116.8380584815238, 1124.8987591116838, 12321.69195770104, 12448.75102497945, 12460.190087644274, 12465.12744107922, 12478.43847026877, 4969.35398398206, 5020.748962551857, 5097.0, 5114.207297868837, 5127.230915362651, 10438.0, 10502.0, 10590.0, 10611.363318200933, 10620.991005854432, 5607.8598035048635, 5623.015972204929, 5626.85932851682, 5756.194132821408, 5756.366799652035, 4640.816591769078, 5039.0, 5064.18972964324, 5089.8218562350885, 5103.668261562986, 4234.809433575435, 4249.97875010623, 4373.950251939512, 4412.470503539532, 4418.668599855024, 1358.5652591170929, 1359.3543067043272, 1361.4145917255676, 1363.817891373794, 1364.7543442180304, 888.9111088891059, 936.6440752514137, 987.9429010958349, 994.7910938702953, 1014.7868947520956, 5269.683818970874, 6174.938250617526, 6270.843228919313, 6329.461995730415, 6346.936530634727, 498.78296955428635, 507.4899725775646, 508.189437846634, 1034.5292891734243, 1073.1307640810812, 3591.658792414769, 4102.897427564275, 4155.937660935088, 4179.874603761831, 4181.456410666594, 10749.785004300027, 10888.945555272174, 11063.446827658585, 11081.889181108247, 11235.494402751896, 10879.619213327496, 10943.83584246237, 11013.0, 11048.0, 11075.556977720962, 8303.211194936472, 8708.042115367305, 8800.691975780945, 8921.732348029569, 9021.233195178484, 5812.94187058141, 5960.97019514917, 6039.305479869871, 6087.66517841523, 6135.049067394561, 9188.219001384958, 9796.363236389898, 10087.949560252151, 10263.794724105626, 10264.846027309746, 10085.546150423395, 10279.794404112026, 10498.002689744462, 10696.358218506915, 10710.30383025132, 6243.0, 6741.730330786713, 7114.857702846018, 7378.7786366406945, 7503.287187717158, 8571.871421928801, 8581.8712719308, 8674.132586741276, 8678.435901666624, 8710.47737135774, 7560.243975602396, 7682.6158692064055, 7729.07251129868, 7739.071311442663, 7758.883616745867, 7509.699612015458, 7524.247575242432, 7554.4334174936, 7652.349550288288, 7679.500832445873, 7320.487565870551, 7335.669894854851, 7336.046313979148, 7360.631968401665, 7380.114386273682, 5033.899322013466, 5054.2671312660195, 5120.6159538035545, 5231.921521177109, 5241.6068794839775, 5178.378594568676, 5211.296474975829, 5310.601704872072, 5413.296271484682, 5427.565794736491], "value": 4782.165685485652, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.23287452543576, 346.19164251472813, 350.37807890993497, 351.7502573173047, 358.6771905285245, 5403.864903377417, 5480.26016487774, 6476.22285325761, 6710.261871194165, 6744.86510269795, 5442.401335853053, 6570.572912760667, 6612.768553100643, 6703.463722902168, 6713.697883595238, 4703.929441058387, 4923.852284431473, 4951.678140920847, 4953.653244272902, 4959.132151873408, 4049.777262250575, 4856.077345304381, 4939.135651261015, 4956.801727930879, 4957.157283261854, 4854.684445511049, 4860.635452341071, 4865.854024379274, 4869.245266983623, 4902.632302577304, 4868.196747536652, 4869.2939523768855, 4883.218685010382, 4895.804167833282, 4925.655204135712, 3470.5661792275964, 4154.50145982481, 4158.521769996459, 4163.75017498951, 4168.8332466701295, 6376.808695739135, 6475.7085931133215, 6526.0, 6529.640869752162, 6540.4767618590395, 5540.612157149001, 5761.711914404263, 5780.624259423124, 5797.478226959552, 5811.854703632401, 7140.92859071413, 7161.570305781618, 7210.2789721028, 7231.0, 7256.056712627377, 4656.976715116402, 4684.110019096361, 4699.765011749399, 4703.858884233478, 4705.223638099709, 7504.3246107850555, 7567.243275672444, 7604.885926711104, 7628.732994345227, 7657.961710191414, 4025.577314381948, 4764.857054288307, 4770.499097594772, 4778.1399348116975, 4792.880177995578, 4564.42944631921, 4769.57073863354, 4838.782254798542, 4842.370491836039, 4861.756912154378, 5745.368009518949, 5747.0, 5759.337676167211, 5760.049591817303, 5791.362950075489, 7133.144022717307, 7150.642467876585, 7171.49799514029, 7194.0, 7239.565626062453, 1655.337864854044, 1670.6491636756175, 1675.2377668160957, 1675.7235056215588, 1682.973386234396, 896.4576431259125, 1030.90206430389, 1057.7038429239826, 1068.060107105742, 1078.6710053433778, 6766.15423072116, 6782.355676210851, 6791.592504449749, 6817.965910170417, 6851.862962740717, 7475.0, 7490.250974902466, 7499.287567681062, 7520.435967302365, 7525.548467091882, 6546.279909209983, 6775.966120169368, 6813.977903314443, 6866.485013623998, 6876.346747059021, 3243.4810430331504, 3662.6814346835117, 3912.471816304819, 3953.5058117735284, 3954.7231693781737, 7694.99965004557, 7843.490173138728, 7880.896674465579, 7894.368450523944, 7907.130215676271, 5520.751566179531, 7763.0, 7781.92218077812, 7800.5709685966685, 7846.489978151402, 6287.811365659038, 7615.4669173157345, 7876.369890408753, 7917.287444129941, 7946.562939038293, 7480.438967077382, 7531.171571127062, 7543.47195696296, 7551.73568925085, 7556.2443755624, 5392.919106213489, 6125.877482450237, 6941.201761797458, 7386.039814824253, 7400.185979542353, 6384.521160912857, 7868.173841746763, 7879.487833290817, 7880.645370958436, 7897.526148431112, 4577.427821522309, 4747.643926705442, 4750.762461876823, 4761.357216775691, 4774.474807771073, 7366.484346095936, 7397.186309506058, 7410.703571857281, 7412.0, 7429.517081389692, 7122.21655617892, 7144.571325720265, 7150.7497237596435, 7155.248698886542, 7165.7850264492145, 7140.214576396696, 7143.9285607143265, 7148.142222933281, 7155.570665760071, 7211.747588834575, 6730.158730158731, 6951.895721564281, 6962.686679099554, 6981.895271571032, 7003.7548685795755, 7093.1488221413765, 7125.394341481032, 7127.786166415016, 7144.142702875688, 7145.285471452813, 5614.438556144353, 6916.273791252047, 6930.48021398387, 6956.965215173892, 6969.58182509051], "value": 5196.288794515326, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.9926700732991, 739.4343327354574, 747.7345542332472, 767.2404319723472, 806.7216810200479, 15348.846511534895, 15417.229138543084, 15622.765658515103, 15657.138857362841, 15744.29150688219, 14482.637934051627, 14488.420463181461, 14515.49195778148, 14530.636734081654, 14551.854481455182, 813.7111325479458, 991.2417000994209, 996.6611352140271, 998.236349192868, 1000.6997900629818, 920.4431319051978, 982.9580644516835, 987.4519641598946, 992.9354591951536, 993.5280741647696, 972.4068318325816, 1044.075992746421, 1051.337657275915, 1053.1943063556384, 1056.1234175634243, 974.4640447753707, 1026.5226669598635, 1046.7801761630028, 1050.8318669012997, 1051.0277992856654, 745.8732015557368, 769.6459628570864, 788.1606089514648, 793.2067932067932, 798.0503201190564, 13878.306084695825, 13959.441622335095, 14006.439742410292, 14012.439502419891, 14059.718805623932, 11583.36291503967, 11622.535098596047, 11634.767304653944, 11746.647600571996, 11961.0, 9389.483578403186, 9626.229901607925, 9732.610695572168, 9739.56171972263, 9763.218942484584, 3511.8595256189724, 3557.6620221078956, 3561.465780132975, 3579.8926032219074, 3632.0919770057485, 72917.27082729158, 80514.0, 85460.99999999937, 87312.56343718304, 88106.0, 9920.4543750093, 10154.949225253826, 10171.694849154537, 10182.490875456346, 10305.0, 22539.32382028542, 22880.771192288197, 23030.424239393815, 23091.88454057719, 23149.074037038667, 6806.76176333826, 7872.488288261245, 7924.247196516321, 7993.360531157494, 8118.391120665974, 4247.723897946624, 4304.289792184317, 4310.935335969963, 4353.978230108829, 4428.579284967923, 3736.813159342022, 3791.9810400947817, 3815.751976121543, 3824.4836947012354, 3836.462895194675, 691.9377256046879, 692.7021380806302, 699.4614147106699, 710.9324614161646, 713.6075158662715, 620.7548018532655, 633.7718421368304, 636.4049613611288, 639.11163482759, 650.4016304999412, 8161.306288965505, 8483.703070392507, 8519.148085191555, 8595.398322117391, 8769.824603507894, 623.9594426362272, 638.1894993358502, 645.3868824616633, 646.2923099206362, 649.1074772188241, 3898.5516665583823, 3961.7821019844187, 3977.721559490808, 3999.960000400017, 4052.9797351013644, 87325.0, 91318.54340728254, 92478.0, 92646.0, 93302.0, 67305.32694673089, 76708.082297943, 81288.59355703184, 81809.59095204486, 82767.58616207, 68503.3149668507, 68684.65657671679, 69266.61466770637, 69374.61250774957, 69832.95250571246, 8336.666533338841, 8411.957940210259, 8525.104863989192, 8607.397482176188, 8659.177378149066, 46261.07477850492, 46302.76848615735, 48563.0, 48692.269615956495, 49845.0, 51491.74254128705, 57415.138772917606, 58336.70831645815, 60578.4855378619, 61520.69239653952, 11157.0, 11204.66386008421, 11336.433178340885, 11436.828447573127, 11558.07535397183, 12031.4585843639, 12154.392280386122, 12255.877441225473, 12291.32397718134, 12485.812712809497, 9298.395604285699, 11577.6526704199, 11745.647630571097, 11884.643460696192, 11984.161108722306, 10409.63566275207, 11453.885461145283, 11538.192326537062, 11675.88324116782, 12221.205621634565, 11274.830877536679, 11506.884931150582, 11561.959423651911, 11833.290002599872, 11861.229020113666, 9549.37756035476, 9672.032796720554, 9729.610815567297, 9792.216622670312, 9953.104220620178, 9742.512874356396, 10030.598776049168, 10053.849192262269, 10097.545610447694, 10098.899011009797], "value": 7092.9077662776035, "unit": "score"}], "name": "dromaeo_css", "value": 7590.560619926428, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 113.0, 118.0, 117.0, 117.0, 131.0, 116.0, 117.0, 118.0, 116.0], "value": 118.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 147.0, 144.0, 161.0, 122.0, 148.0, 167.0, 154.0, 188.0, 144.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 197.0, 200.0, 195.0, 195.0, 194.0, 193.0, 198.0, 199.0, 196.0], "value": 196.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 83.0, 77.0, 155.0, 54.0, 60.0, 81.0, 95.0, 150.0, 53.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 124.0, 92.0, 114.0, 76.0, 149.0, 117.0, 113.0, 153.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 130.0, 88.0, 91.0, 93.0, 84.0, 88.0, 91.0, 125.0, 85.0], "value": 97.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 117.0, 129.0, 93.0, 117.0], "value": 101.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 89.0, 90.0, 96.0, 91.0, 90.0, 92.0, 90.0, 89.0], "value": 90.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 62.0, 63.0, 63.0, 64.0, 65.0, 65.0, 77.0, 59.0, 55.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 64.0, 65.0, 69.0, 66.0, 66.0, 65.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 83.0, 80.0, 79.0, 80.0, 80.0, 80.0, 85.0, 84.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 140.0, 121.0, 124.0, 127.0, 128.0, 125.0, 141.0, 139.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 167.0, 161.0, 162.0, 218.0, 214.0, 162.0, 161.0, 162.0, 163.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 85.0, 89.0, 92.0, 94.0, 92.0, 92.0, 77.0, 67.0, 68.0], "value": 82.8, "unit": "score"}], "name": "kraken", "value": 1555.5, "alertThreshold": 2.0}]} 02:28:05 INFO - Return code: 0 02:28:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:28:05 ERROR - # TBPL SUCCESS # 02:28:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:28:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:28:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:28:05 INFO - 2016-06-22 02:28:05.366 screenresolution[1682:10478] starting screenresolution argv=screenresolution get 02:28:05 INFO - 2016-06-22 02:28:05.369 screenresolution[1682:10478] Display 0: 1600x1200x32@60 02:28:05 INFO - 2016-06-22 02:28:05.375 screenresolution[1683:10481] starting screenresolution argv=screenresolution list 02:28:05 INFO - Available Modes on Display 0 02:28:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:28:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:28:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:28:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:28:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:28:05 INFO - Intel Iris: 02:28:05 INFO - Chipset Model: Intel Iris 02:28:05 INFO - Type: GPU 02:28:05 INFO - Bus: Built-In 02:28:05 INFO - VRAM (Dynamic, Max): 1536 MB 02:28:05 INFO - Vendor: Intel (0x8086) 02:28:05 INFO - Device ID: 0x0a2e 02:28:05 INFO - Revision ID: 0x0009 02:28:05 INFO - Displays: 02:28:05 INFO - Display: 02:28:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:28:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:28:05 INFO - Display Serial Number: 1600x1200 60 02:28:05 INFO - Main Display: Yes 02:28:05 INFO - Mirror: Off 02:28:05 INFO - Online: Yes 02:28:05 INFO - Rotation: Supported 02:28:05 INFO - Return code: 0 02:28:05 INFO - Running post-action listener: _resource_record_post_action 02:28:05 INFO - Running post-run listener: _resource_record_post_run 02:28:06 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 37766656; Write bytes: 493448192; Read time: 398; Write time: 2075 02:28:06 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 191392256; Write bytes: 184700928; Read time: 16553; Write time: 352 02:28:06 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 31510016; Write bytes: 298793984; Read time: 313; Write time: 1690 02:28:06 INFO - Running post-run listener: _upload_blobber_files 02:28:06 INFO - Blob upload gear active. 02:28:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:28:06 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 02:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:28:07 INFO - (blobuploader) - INFO - Open directory for files ... 02:28:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:28:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:08 INFO - (blobuploader) - INFO - Done attempting. 02:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:28:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:09 INFO - (blobuploader) - INFO - Done attempting. 02:28:09 INFO - (blobuploader) - INFO - Iteration through files over. 02:28:09 INFO - Return code: 0 02:28:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:28:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:28:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/979cc67c21db6b4b87a8c7f95588cff912df10ec7650ef6fede9cb6601c5e477bda7c9a10c60d8989574aa41e03ea0db572618d98ad12b7bfdc4db27f29e1d6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4972e99142c09a871b6193b937d0e1ba180aab451173c5f721d1d876b0f363ddc9235d19b8aad5ee7e699d49c75d782ab99a9a62df81ac6b20278efaf8f37a6b"} 02:28:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:28:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:28:09 INFO - Contents: 02:28:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/979cc67c21db6b4b87a8c7f95588cff912df10ec7650ef6fede9cb6601c5e477bda7c9a10c60d8989574aa41e03ea0db572618d98ad12b7bfdc4db27f29e1d6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4972e99142c09a871b6193b937d0e1ba180aab451173c5f721d1d876b0f363ddc9235d19b8aad5ee7e699d49c75d782ab99a9a62df81ac6b20278efaf8f37a6b"} 02:28:09 INFO - Running post-run listener: copy_logs_to_upload_dir 02:28:09 INFO - Copying logs to upload dir... 02:28:09 INFO - mkdir: /builds/slave/test/build/upload/logs 02:28:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.702292 ========= master_lag: 2.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-22 02:28:11.476587) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 02:28:11.479957) ========= 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.sizEhYZXvB/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.u81Z2iv8gt/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/979cc67c21db6b4b87a8c7f95588cff912df10ec7650ef6fede9cb6601c5e477bda7c9a10c60d8989574aa41e03ea0db572618d98ad12b7bfdc4db27f29e1d6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4972e99142c09a871b6193b937d0e1ba180aab451173c5f721d1d876b0f363ddc9235d19b8aad5ee7e699d49c75d782ab99a9a62df81ac6b20278efaf8f37a6b"} build_url:https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011126 build_url: 'https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/979cc67c21db6b4b87a8c7f95588cff912df10ec7650ef6fede9cb6601c5e477bda7c9a10c60d8989574aa41e03ea0db572618d98ad12b7bfdc4db27f29e1d6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4972e99142c09a871b6193b937d0e1ba180aab451173c5f721d1d876b0f363ddc9235d19b8aad5ee7e699d49c75d782ab99a9a62df81ac6b20278efaf8f37a6b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 02:28:11.517955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:28:11.518286) ========= 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.sizEhYZXvB/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.u81Z2iv8gt/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005186 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:28:11.566247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 02:28:11.566565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 02:28:11.566926) ========= ========= Total master_lag: 2.41 =========