builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0020 starttime: 1467889597.68 results: success (0) buildid: 20160706215822 builduid: 005acac198204b229cc2500b323a4168 revision: d142c49033c015f67272562b37dbe2912cfc7f14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.684623) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.685240) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.685664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.717910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.718652) ========= 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.aRyuJsSn0n/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.kHomyi7uJD/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-07 04:06:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.3M=0.001s 2016-07-07 04:06:37 (14.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125736 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.867906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.868306) ========= 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.aRyuJsSn0n/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.kHomyi7uJD/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.032658 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:37.922423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 04:06:37.922783) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d142c49033c015f67272562b37dbe2912cfc7f14 --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 d142c49033c015f67272562b37dbe2912cfc7f14 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aRyuJsSn0n/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.kHomyi7uJD/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-07 04:06:37,994 truncating revision to first 12 chars 2016-07-07 04:06:37,994 Setting DEBUG logging. 2016-07-07 04:06:37,994 attempt 1/10 2016-07-07 04:06:37,995 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d142c49033c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 04:06:39,644 unpacking tar archive at: mozilla-beta-d142c49033c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.933046 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 04:06:39.879757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:39.880325) ========= script_repo_revision: d142c49033c015f67272562b37dbe2912cfc7f14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:39.880917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:39.881369) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:06:39.901899) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-07 04:06:39.902525) ========= /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.aRyuJsSn0n/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.kHomyi7uJD/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 04:06:40 INFO - MultiFileLogger online at 20160707 04:06:40 in /builds/slave/test 04:06:40 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 04:06:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:06:40 INFO - {'append_to_log': False, 04:06:40 INFO - 'base_work_dir': '/builds/slave/test', 04:06:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:06:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:06:40 INFO - 'branch': 'Mozilla-Beta', 04:06:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:40 INFO - 'config_files': ('talos/mac_config.py',), 04:06:40 INFO - 'default_actions': ('clobber', 04:06:40 INFO - 'read-buildbot-config', 04:06:40 INFO - 'download-and-extract', 04:06:40 INFO - 'populate-webroot', 04:06:40 INFO - 'create-virtualenv', 04:06:40 INFO - 'install', 04:06:40 INFO - 'run-tests'), 04:06:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:40 INFO - 'download_minidump_stackwalk': True, 04:06:40 INFO - 'download_symbols': 'ondemand', 04:06:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:40 INFO - 'installer_path': 'installer.exe', 04:06:40 INFO - 'log_level': 'info', 04:06:40 INFO - 'log_name': 'talos', 04:06:40 INFO - 'log_to_console': True, 04:06:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:06:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:06:40 INFO - 'opt_config_files': (), 04:06:40 INFO - 'pip_index': False, 04:06:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:06:40 INFO - 'cmd': ('bash', 04:06:40 INFO - '-c', 04:06:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:06:40 INFO - 'enabled': True, 04:06:40 INFO - 'halt_on_failure': False, 04:06:40 INFO - 'name': 'check_screen_resolution'},), 04:06:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:06:40 INFO - 'cmd': ('bash', 04:06:40 INFO - '-c', 04:06:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:06:40 INFO - 'enabled': True, 04:06:40 INFO - 'halt_on_failure': False, 04:06:40 INFO - 'name': 'check_screen_resolution'},), 04:06:40 INFO - 'run_cmd_checks_enabled': True, 04:06:40 INFO - 'sps_profile': False, 04:06:40 INFO - 'sps_profile_interval': 0, 04:06:40 INFO - 'suite': 'dromaeojs-e10s', 04:06:40 INFO - 'system_bits': '32', 04:06:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:40 INFO - 'title': 't-yosemite-r7-0020', 04:06:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:40 INFO - 'use_talos_json': True, 04:06:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:06:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:40 INFO - 'work_dir': 'build'} 04:06:40 INFO - ##### 04:06:40 INFO - ##### Running clobber step. 04:06:40 INFO - ##### 04:06:40 INFO - Running pre-action listener: _resource_record_pre_action 04:06:40 INFO - Running main action method: clobber 04:06:40 INFO - rmtree: /builds/slave/test/build 04:06:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:06:41 INFO - Running post-action listener: _resource_record_post_action 04:06:41 INFO - ##### 04:06:41 INFO - ##### Running read-buildbot-config step. 04:06:41 INFO - ##### 04:06:41 INFO - Running pre-action listener: _resource_record_pre_action 04:06:41 INFO - Running main action method: read_buildbot_config 04:06:41 INFO - Using buildbot properties: 04:06:41 INFO - { 04:06:41 INFO - "project": "", 04:06:41 INFO - "product": "firefox", 04:06:41 INFO - "script_repo_revision": "production", 04:06:41 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:06:41 INFO - "repository": "", 04:06:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:06:41 INFO - "buildid": "20160706215822", 04:06:41 INFO - "pgo_build": "False", 04:06:41 INFO - "basedir": "/builds/slave/test", 04:06:41 INFO - "buildnumber": 28, 04:06:41 INFO - "slavename": "t-yosemite-r7-0020", 04:06:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:06:41 INFO - "platform": "yosemite_r7", 04:06:41 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:06:41 INFO - "branch": "mozilla-beta", 04:06:41 INFO - "repo_path": "releases/mozilla-beta", 04:06:41 INFO - "revision": "d142c49033c015f67272562b37dbe2912cfc7f14", 04:06:41 INFO - "stage_platform": "macosx64", 04:06:41 INFO - "builduid": "005acac198204b229cc2500b323a4168", 04:06:41 INFO - "slavebuilddir": "test" 04:06:41 INFO - } 04:06:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 04:06:41 INFO - Running post-action listener: _resource_record_post_action 04:06:41 INFO - ##### 04:06:41 INFO - ##### Running download-and-extract step. 04:06:41 INFO - ##### 04:06:41 INFO - Running pre-action listener: _resource_record_pre_action 04:06:41 INFO - Running main action method: download_and_extract 04:06:41 INFO - mkdir: /builds/slave/test/build/tests 04:06: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')]} 04:06:41 INFO - https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/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 04:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/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 04:06:43 INFO - Downloaded 1165 bytes. 04:06:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:06:43 INFO - Using the following test package requirements: 04:06:43 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:06:43 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:43 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:06:43 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:43 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:06:43 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:06:43 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:43 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:06:43 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:06:43 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:43 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:06:43 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:43 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:06:43 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:43 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:06:43 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:06:43 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:06:43 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 04:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:43 INFO - https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:06:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:06:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:06:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/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 04:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/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 04:06:44 INFO - Downloaded 18351388 bytes. 04:06:44 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'] 04:06:44 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 04:06:48 INFO - Return code: 0 04:06:48 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 04:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:48 INFO - https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:06:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:06:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:06:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/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 04:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/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 04:06:52 INFO - Downloaded 18351388 bytes. 04:06:52 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'] 04:06:52 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 04:06:55 INFO - Return code: 0 04:06:55 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')]} 04:06:55 INFO - https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:06:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:06:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:06:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/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 04:06:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/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 04:06:57 INFO - Downloaded 10840145 bytes. 04:06:57 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'] 04:06:57 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 04:06:57 INFO - Return code: 0 04:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:57 INFO - https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 04:06:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:06:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:06:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 04:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeiigZlwTaKgLwp6GbYdWQ/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 04:07:01 INFO - Downloaded 86189077 bytes. 04:07:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:07:01 INFO - mkdir: /builds/slave/test/properties 04:07:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:07:01 INFO - Writing to file /builds/slave/test/properties/build_url 04:07:01 INFO - Contents: 04:07:01 INFO - build_url:https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:07:02 INFO - Running post-action listener: _resource_record_post_action 04:07:02 INFO - Running post-action listener: set_extra_try_arguments 04:07:02 INFO - ##### 04:07:02 INFO - ##### Running populate-webroot step. 04:07:02 INFO - ##### 04:07:02 INFO - Running pre-action listener: _resource_record_pre_action 04:07:02 INFO - Running main action method: populate_webroot 04:07:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:07:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:07:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:07:02 INFO - '--tppagecycles', 04:07:02 INFO - '7'], 04:07:02 INFO - 'tests': ['tsvgm']}}, 04:07:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:07:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:07:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:07:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:07:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:07:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:07:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:02 INFO - 'talos_options': ['--disable-e10s'], 04:07:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:07:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:02 INFO - 'talos_options': ['--disable-e10s'], 04:07:02 INFO - 'tests': ['damp', 'tps']}, 04:07:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:02 INFO - 'tests': ['damp', 'tps']}, 04:07:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:07:02 INFO - 'tests': ['dromaeo_dom']}, 04:07:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:07:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:07:02 INFO - 'tests': ['a11yr', 04:07:02 INFO - 'ts_paint', 04:07:02 INFO - 'tpaint', 04:07:02 INFO - 'sessionrestore', 04:07:02 INFO - 'sessionrestore_no_auto_restore', 04:07:02 INFO - 'tabpaint']}, 04:07:02 INFO - 'other-e10s': {'tests': ['a11yr', 04:07:02 INFO - 'ts_paint', 04:07:02 INFO - 'tpaint', 04:07:02 INFO - 'sessionrestore', 04:07:02 INFO - 'sessionrestore_no_auto_restore', 04:07:02 INFO - 'tabpaint']}, 04:07:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:07:02 INFO - 'ts_paint', 04:07:02 INFO - 'tpaint', 04:07:02 INFO - 'sessionrestore', 04:07:02 INFO - 'sessionrestore_no_auto_restore', 04:07:02 INFO - 'tabpaint']}, 04:07:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:07:02 INFO - 'ts_paint', 04:07:02 INFO - 'tpaint', 04:07:02 INFO - 'sessionrestore', 04:07:02 INFO - 'sessionrestore_no_auto_restore', 04:07:02 INFO - 'tabpaint']}, 04:07:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:07:02 INFO - 'tests': ['a11yr', 04:07:02 INFO - 'ts_paint', 04:07:02 INFO - 'tpaint', 04:07:02 INFO - 'sessionrestore', 04:07:02 INFO - 'sessionrestore_no_auto_restore', 04:07:02 INFO - 'tabpaint']}, 04:07:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:07:02 INFO - 'tests': ['a11yr', 04:07:02 INFO - 'ts_paint', 04:07:02 INFO - 'tpaint', 04:07:02 INFO - 'sessionrestore', 04:07:02 INFO - 'sessionrestore_no_auto_restore', 04:07:02 INFO - 'tabpaint']}, 04:07:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:07:02 INFO - 'tests': ['tsvgx', 04:07:02 INFO - 'tsvgr_opacity', 04:07:02 INFO - 'tart', 04:07:02 INFO - 'tscrollx', 04:07:02 INFO - 'cart']}, 04:07:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:07:02 INFO - 'tsvgr_opacity', 04:07:02 INFO - 'tart', 04:07:02 INFO - 'tscrollx', 04:07:02 INFO - 'cart']}, 04:07:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:02 INFO - 'talos_options': ['--disable-e10s'], 04:07:02 INFO - 'tests': ['tp5o']}, 04:07:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:02 INFO - 'tests': ['tp5o']}, 04:07:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:02 INFO - 'talos_options': ['--disable-e10s', 04:07:02 INFO - '--xperf_path', 04:07:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:02 INFO - 'tests': ['tp5n']}, 04:07:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:07:02 INFO - 'talos_options': ['--xperf_path', 04:07:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:07:02 INFO - 'tests': ['tp5n']}}, 04:07:02 INFO - 'talos.zip': {'path': '', 04:07:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:07:02 INFO - Running post-action listener: _resource_record_post_action 04:07:02 INFO - ##### 04:07:02 INFO - ##### Running create-virtualenv step. 04:07:02 INFO - ##### 04:07:02 INFO - Running pre-action listener: _resource_record_pre_action 04:07:02 INFO - Running main action method: create_virtualenv 04:07:02 INFO - Creating virtualenv /builds/slave/test/build/venv 04:07:02 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 04:07:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:07:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:07:02 INFO - Using real prefix '/tools/python27' 04:07:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:07:03 INFO - Installing distribute.............................................................................................................................................................................................done. 04:07:06 INFO - Installing pip.................done. 04:07:06 INFO - Return code: 0 04:07:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8585b8bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a0e00>, '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 0x109809db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.aRyuJsSn0n/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.kHomyi7uJD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 04:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:07:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aRyuJsSn0n/Render', 04:07:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:06 INFO - 'HOME': '/Users/cltbld', 04:07:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:06 INFO - 'LOGNAME': 'cltbld', 04:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:06 INFO - 'MOZ_NO_REMOTE': '1', 04:07:06 INFO - 'NO_EM_RESTART': '1', 04:07:06 INFO - 'PAGER': '/bin/cat', 04:07:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:06 INFO - 'PWD': '/builds/slave/test', 04:07:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:06 INFO - 'SHELL': '/bin/bash', 04:07:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kHomyi7uJD/Listeners', 04:07:06 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 04:07:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:06 INFO - 'USER': 'cltbld', 04:07:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:06 INFO - 'XPC_FLAGS': '0x0', 04:07:06 INFO - 'XPC_SERVICE_NAME': '0', 04:07:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:06 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 04:07:06 INFO - Cleaning up... 04:07:06 INFO - Return code: 0 04:07:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109b01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8585b8bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a0e00>, '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 0x109809db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.aRyuJsSn0n/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.kHomyi7uJD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 04:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:07:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aRyuJsSn0n/Render', 04:07:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:06 INFO - 'HOME': '/Users/cltbld', 04:07:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:06 INFO - 'LOGNAME': 'cltbld', 04:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:06 INFO - 'MOZ_NO_REMOTE': '1', 04:07:06 INFO - 'NO_EM_RESTART': '1', 04:07:06 INFO - 'PAGER': '/bin/cat', 04:07:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:06 INFO - 'PWD': '/builds/slave/test', 04:07:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:06 INFO - 'SHELL': '/bin/bash', 04:07:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kHomyi7uJD/Listeners', 04:07:06 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 04:07:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:06 INFO - 'USER': 'cltbld', 04:07:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:06 INFO - 'XPC_FLAGS': '0x0', 04:07:06 INFO - 'XPC_SERVICE_NAME': '0', 04:07:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:06 INFO - Downloading/unpacking psutil>=0.7.1 04:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:07:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:09 INFO - Installing collected packages: psutil 04:07:09 INFO - Running setup.py install for psutil 04:07:10 INFO - building 'psutil._psutil_osx' extension 04:07:10 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 04:07:10 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 04:07:10 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 04:07:10 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 04:07:10 INFO - building 'psutil._psutil_posix' extension 04:07:10 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 04:07:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:07:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:07:10 INFO - ^ 04:07:10 INFO - 1 warning generated. 04:07:10 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 04:07:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:07:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:07:11 INFO - Successfully installed psutil 04:07:11 INFO - Cleaning up... 04:07:11 INFO - Return code: 0 04:07:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109b01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8585b8bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a0e00>, '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 0x109809db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.aRyuJsSn0n/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.kHomyi7uJD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 04:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:07:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aRyuJsSn0n/Render', 04:07:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:11 INFO - 'HOME': '/Users/cltbld', 04:07:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:11 INFO - 'LOGNAME': 'cltbld', 04:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:11 INFO - 'MOZ_NO_REMOTE': '1', 04:07:11 INFO - 'NO_EM_RESTART': '1', 04:07:11 INFO - 'PAGER': '/bin/cat', 04:07:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:11 INFO - 'PWD': '/builds/slave/test', 04:07:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:11 INFO - 'SHELL': '/bin/bash', 04:07:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kHomyi7uJD/Listeners', 04:07:11 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 04:07:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:11 INFO - 'USER': 'cltbld', 04:07:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:11 INFO - 'XPC_FLAGS': '0x0', 04:07:11 INFO - 'XPC_SERVICE_NAME': '0', 04:07:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:07: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 04:07: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 04:07: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 04:07: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 04:07: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 04:07: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 04:07:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:07:13 INFO - Installing collected packages: mozsystemmonitor 04:07:13 INFO - Running setup.py install for mozsystemmonitor 04:07:14 INFO - Successfully installed mozsystemmonitor 04:07:14 INFO - Cleaning up... 04:07:14 INFO - Return code: 0 04:07:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:07:14 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')]} 04:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:14 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')]} 04:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:14 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 0x109b01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8585b8bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a0e00>, '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 0x109809db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.aRyuJsSn0n/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.kHomyi7uJD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 04:07:14 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 04:07:14 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 04:07:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aRyuJsSn0n/Render', 04:07:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:14 INFO - 'HOME': '/Users/cltbld', 04:07:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:14 INFO - 'LOGNAME': 'cltbld', 04:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:14 INFO - 'MOZ_NO_REMOTE': '1', 04:07:14 INFO - 'NO_EM_RESTART': '1', 04:07:14 INFO - 'PAGER': '/bin/cat', 04:07:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:14 INFO - 'PWD': '/builds/slave/test', 04:07:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:14 INFO - 'SHELL': '/bin/bash', 04:07:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kHomyi7uJD/Listeners', 04:07:14 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 04:07:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:14 INFO - 'USER': 'cltbld', 04:07:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:14 INFO - 'XPC_FLAGS': '0x0', 04:07:14 INFO - 'XPC_SERVICE_NAME': '0', 04:07:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:14 INFO - Downloading/unpacking blobuploader==1.2.4 04:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:07:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:07:16 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 04:07:16 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 04:07:16 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 04:07:16 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 04:07:16 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 04:07:16 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 04:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:07:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:18 INFO - Downloading docopt-0.6.1.tar.gz 04:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:07:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:07:18 INFO - Running setup.py install for blobuploader 04:07:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:07:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:07:18 INFO - Running setup.py install for requests 04:07:18 INFO - Running setup.py install for docopt 04:07:18 INFO - Successfully installed blobuploader requests docopt 04:07:18 INFO - Cleaning up... 04:07:19 INFO - Return code: 0 04:07:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:19 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 0x109b01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8585b8bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a0e00>, '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 0x109809db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.aRyuJsSn0n/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.kHomyi7uJD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 04:07:19 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 04:07:19 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 04:07:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aRyuJsSn0n/Render', 04:07:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:19 INFO - 'HOME': '/Users/cltbld', 04:07:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:19 INFO - 'LOGNAME': 'cltbld', 04:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:19 INFO - 'MOZ_NO_REMOTE': '1', 04:07:19 INFO - 'NO_EM_RESTART': '1', 04:07:19 INFO - 'PAGER': '/bin/cat', 04:07:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:19 INFO - 'PWD': '/builds/slave/test', 04:07:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:19 INFO - 'SHELL': '/bin/bash', 04:07:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kHomyi7uJD/Listeners', 04:07:19 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 04:07:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:19 INFO - 'USER': 'cltbld', 04:07:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:19 INFO - 'XPC_FLAGS': '0x0', 04:07:19 INFO - 'XPC_SERVICE_NAME': '0', 04:07:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:19 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-AgZ0SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:19 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-cdsIPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:19 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-ZnZ3gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:19 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-SfrDR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:19 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-QlTHen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:19 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Y1gi2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:19 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-3POXiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-CtdbUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-evYHQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-E5lnvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-SClrsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-yPrRra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-LSaKEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-zTNgYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-uv55gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-79agAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Ajgtdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:07:21 INFO - Running setup.py install for manifestparser 04:07:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:07:21 INFO - Running setup.py install for mozcrash 04:07:21 INFO - Running setup.py install for mozdebug 04:07:21 INFO - Running setup.py install for mozdevice 04:07:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:07:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:07:21 INFO - Running setup.py install for mozfile 04:07:21 INFO - Running setup.py install for mozhttpd 04:07:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:07:21 INFO - Running setup.py install for mozinfo 04:07:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:07:22 INFO - Running setup.py install for mozInstall 04:07:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:07:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:07:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:07:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:07:22 INFO - Running setup.py install for mozleak 04:07:22 INFO - Running setup.py install for mozlog 04:07:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:07:22 INFO - Running setup.py install for moznetwork 04:07:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:07:22 INFO - Running setup.py install for mozprocess 04:07:22 INFO - Running setup.py install for mozprofile 04:07:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:07:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:07:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:07:22 INFO - Running setup.py install for mozrunner 04:07:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:07:23 INFO - Running setup.py install for mozscreenshot 04:07:23 INFO - Running setup.py install for moztest 04:07:23 INFO - Running setup.py install for mozversion 04:07:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:07:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:23 INFO - Cleaning up... 04:07:23 INFO - Return code: 0 04:07:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:23 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')]} 04:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:23 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')]} 04:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:23 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 0x109b01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8585b8bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a0e00>, '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 0x109809db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.aRyuJsSn0n/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.kHomyi7uJD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 04:07:23 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 04:07:23 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 04:07:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aRyuJsSn0n/Render', 04:07:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:23 INFO - 'HOME': '/Users/cltbld', 04:07:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:23 INFO - 'LOGNAME': 'cltbld', 04:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:23 INFO - 'MOZ_NO_REMOTE': '1', 04:07:23 INFO - 'NO_EM_RESTART': '1', 04:07:23 INFO - 'PAGER': '/bin/cat', 04:07:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:23 INFO - 'PWD': '/builds/slave/test', 04:07:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:23 INFO - 'SHELL': '/bin/bash', 04:07:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kHomyi7uJD/Listeners', 04:07:23 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 04:07:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:23 INFO - 'USER': 'cltbld', 04:07:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:23 INFO - 'XPC_FLAGS': '0x0', 04:07:23 INFO - 'XPC_SERVICE_NAME': '0', 04:07:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:23 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-wR2XuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:23 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)) 04:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:23 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-KPFJcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:24 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)) 04:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:24 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-0IzYkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:24 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)) 04:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:24 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-eRQZ5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:24 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)) 04:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:24 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-tD1LN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:24 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)) 04:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:24 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-SlNL45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:24 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)) 04:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:24 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-3prH4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:24 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)) 04:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:24 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-B9iVBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:24 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)) 04:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:24 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Ot0TZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:24 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)) 04:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:24 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-VjjTSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:24 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)) 04:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:24 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-adsUjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:25 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)) 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:25 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-TU1gNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:25 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)) 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:25 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-_3r6TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:25 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)) 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:25 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-TL8QfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:25 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)) 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:25 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Wc06Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:25 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)) 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:25 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-QqxviC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:25 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)) 04:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:25 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-_J0uaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 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)) 04:07:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:28 INFO - Downloading blessings-1.6.tar.gz 04:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:28 INFO - Installing collected packages: blessings 04:07:28 INFO - Running setup.py install for blessings 04:07:28 INFO - Successfully installed blessings 04:07:28 INFO - Cleaning up... 04:07:28 INFO - Return code: 0 04:07:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:28 INFO - Reading from file tmpfile_stdout 04:07:28 INFO - Current package versions: 04:07:28 INFO - blessings == 1.6 04:07:28 INFO - blobuploader == 1.2.4 04:07:28 INFO - docopt == 0.6.1 04:07:28 INFO - manifestparser == 1.1 04:07:28 INFO - mozInstall == 1.12 04:07:28 INFO - mozcrash == 0.17 04:07:28 INFO - mozdebug == 0.1 04:07:28 INFO - mozdevice == 0.48 04:07:28 INFO - mozfile == 1.2 04:07:28 INFO - mozhttpd == 0.7 04:07:28 INFO - mozinfo == 0.9 04:07:28 INFO - mozleak == 0.1 04:07:28 INFO - mozlog == 3.1 04:07:28 INFO - moznetwork == 0.27 04:07:28 INFO - mozprocess == 0.22 04:07:28 INFO - mozprofile == 0.28 04:07:28 INFO - mozrunner == 6.11 04:07:28 INFO - mozscreenshot == 0.1 04:07:28 INFO - mozsystemmonitor == 0.0 04:07:28 INFO - moztest == 0.7 04:07:28 INFO - mozversion == 1.4 04:07:28 INFO - psutil == 3.1.1 04:07:28 INFO - requests == 1.2.3 04:07:28 INFO - wsgiref == 0.1.2 04:07:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04: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')]} 04:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:29 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')]} 04:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:29 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 0x109b01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8585b8bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a0e00>, '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 0x109809db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.aRyuJsSn0n/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.kHomyi7uJD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 04:07:29 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 04:07:29 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 04:07:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aRyuJsSn0n/Render', 04:07:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:29 INFO - 'HOME': '/Users/cltbld', 04:07:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:29 INFO - 'LOGNAME': 'cltbld', 04:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:29 INFO - 'MOZ_NO_REMOTE': '1', 04:07:29 INFO - 'NO_EM_RESTART': '1', 04:07:29 INFO - 'PAGER': '/bin/cat', 04:07:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:29 INFO - 'PWD': '/builds/slave/test', 04:07:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:29 INFO - 'SHELL': '/bin/bash', 04:07:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kHomyi7uJD/Listeners', 04:07:29 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 04:07:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:29 INFO - 'USER': 'cltbld', 04:07:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:29 INFO - 'XPC_FLAGS': '0x0', 04:07:29 INFO - 'XPC_SERVICE_NAME': '0', 04:07:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 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)) 04:07:29 INFO - Cleaning up... 04:07:29 INFO - Return code: 0 04:07:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:07:29 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')]} 04:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:29 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')]} 04:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:29 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 0x109b01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8585b8bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a0e00>, '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 0x109809db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.aRyuJsSn0n/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.kHomyi7uJD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 04:07:29 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 04:07:29 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 04:07:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aRyuJsSn0n/Render', 04:07:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:29 INFO - 'HOME': '/Users/cltbld', 04:07:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:29 INFO - 'LOGNAME': 'cltbld', 04:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:29 INFO - 'MOZ_NO_REMOTE': '1', 04:07:29 INFO - 'NO_EM_RESTART': '1', 04:07:29 INFO - 'PAGER': '/bin/cat', 04:07:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:29 INFO - 'PWD': '/builds/slave/test', 04:07:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:29 INFO - 'SHELL': '/bin/bash', 04:07:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kHomyi7uJD/Listeners', 04:07:29 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 04:07:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:29 INFO - 'USER': 'cltbld', 04:07:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:29 INFO - 'XPC_FLAGS': '0x0', 04:07:29 INFO - 'XPC_SERVICE_NAME': '0', 04:07:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:29 INFO - Downloading/unpacking jsonschema 04:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:32 INFO - Downloading/unpacking functools32 (from jsonschema) 04:07:32 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 04:07:32 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 04:07:32 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 04:07:32 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 04:07:32 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 04:07:32 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 04:07:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:33 INFO - warning: no files found matching '*.txt' 04:07:33 INFO - no previously-included directories found matching 'build' 04:07:33 INFO - no previously-included directories found matching 'dist' 04:07:33 INFO - no previously-included directories found matching '.git*' 04:07:33 INFO - Installing collected packages: jsonschema, functools32 04:07:33 INFO - Running setup.py install for functools32 04:07:33 INFO - warning: no files found matching '*.txt' 04:07:33 INFO - no previously-included directories found matching 'build' 04:07:33 INFO - no previously-included directories found matching 'dist' 04:07:33 INFO - no previously-included directories found matching '.git*' 04:07:33 INFO - Successfully installed jsonschema functools32 04:07:33 INFO - Cleaning up... 04:07:33 INFO - Return code: 0 04:07:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04: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')]} 04:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:33 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 0x109b01a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b11420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8585b8bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a0e00>, '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 0x109809db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.aRyuJsSn0n/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.kHomyi7uJD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 04:07:33 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 04:07:33 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 04:07:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aRyuJsSn0n/Render', 04:07:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:33 INFO - 'HOME': '/Users/cltbld', 04:07:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:33 INFO - 'LOGNAME': 'cltbld', 04:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:33 INFO - 'MOZ_NO_REMOTE': '1', 04:07:33 INFO - 'NO_EM_RESTART': '1', 04:07:33 INFO - 'PAGER': '/bin/cat', 04:07:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:33 INFO - 'PWD': '/builds/slave/test', 04:07:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:33 INFO - 'SHELL': '/bin/bash', 04:07:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kHomyi7uJD/Listeners', 04:07:33 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 04:07:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:33 INFO - 'USER': 'cltbld', 04:07:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:33 INFO - 'XPC_FLAGS': '0x0', 04:07:33 INFO - 'XPC_SERVICE_NAME': '0', 04:07:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:33 INFO - Downloading/unpacking flake8 04:07:33 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 04:07:33 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 04:07:33 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 04:07:33 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 04:07:33 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 04:07:33 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 04:07:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:07:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:07:36 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 04:07:36 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 04:07:36 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 04:07:36 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 04:07:36 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 04:07:36 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 04:07:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:07:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:07:36 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 04:07:36 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 04:07:36 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 04:07:36 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 04:07:36 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 04:07:36 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 04:07:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:07:36 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 04:07:36 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 04:07:36 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 04:07:36 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 04:07:36 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 04:07:36 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 04:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:07:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:37 INFO - no previously-included directories found matching 'docs/_build' 04:07:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:07:37 INFO - Running setup.py install for pep8 04:07:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:37 INFO - no previously-included directories found matching 'docs/_build' 04:07:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:07:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:07:37 INFO - Cleaning up... 04:07:37 INFO - Return code: 0 04:07:37 INFO - Running post-action listener: _resource_record_post_action 04:07:37 INFO - Running post-action listener: _start_resource_monitoring 04:07:37 INFO - Starting resource monitoring. 04:07:37 INFO - ##### 04:07:37 INFO - ##### Running install step. 04:07:37 INFO - ##### 04:07:37 INFO - Running pre-action listener: _resource_record_pre_action 04:07:37 INFO - Running main action method: install 04:07:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:38 INFO - Reading from file tmpfile_stdout 04:07:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:38 INFO - Reading from file tmpfile_stdout 04:07:38 INFO - Output received: 04:07:38 INFO - Usage: mozinstall [options] installer 04:07:38 INFO - Options: 04:07:38 INFO - -h, --help show this help message and exit 04:07:38 INFO - -d DEST, --destination=DEST 04:07:38 INFO - Directory to install application into. [default: 04:07:38 INFO - "/builds/slave/test"] 04:07:38 INFO - --app=APP Application being installed. [default: firefox] 04:07:38 INFO - mkdir: /builds/slave/test/build/application 04:07:38 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'] 04:07:38 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 04:08:00 INFO - Reading from file tmpfile_stdout 04:08:00 INFO - Output received: 04:08:00 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:08:00 INFO - Running post-action listener: _resource_record_post_action 04:08:00 INFO - ##### 04:08:00 INFO - ##### Running run-tests step. 04:08:00 INFO - ##### 04:08:00 INFO - Running pre-action listener: _resource_record_pre_action 04:08:00 INFO - Running main action method: run_tests 04:08:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:08:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:08:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:08:00 INFO - 2016-07-07 04:08:00.265 screenresolution[1635:7539] starting screenresolution argv=screenresolution get 04:08:00 INFO - 2016-07-07 04:08:00.267 screenresolution[1635:7539] Display 0: 1600x1200x32@60 04:08:00 INFO - 2016-07-07 04:08:00.273 screenresolution[1636:7542] starting screenresolution argv=screenresolution list 04:08:00 INFO - Available Modes on Display 0 04:08:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:08:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:08:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:08:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:08:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:08:00 INFO - Intel Iris: 04:08:00 INFO - Chipset Model: Intel Iris 04:08:00 INFO - Type: GPU 04:08:00 INFO - Bus: Built-In 04:08:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:08:00 INFO - Vendor: Intel (0x8086) 04:08:00 INFO - Device ID: 0x0a2e 04:08:00 INFO - Revision ID: 0x0009 04:08:00 INFO - Displays: 04:08:00 INFO - Display: 04:08:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:08:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:08:00 INFO - Display Serial Number: 1600x1200 60 04:08:00 INFO - Main Display: Yes 04:08:00 INFO - Mirror: Off 04:08:00 INFO - Online: Yes 04:08:00 INFO - Rotation: Supported 04:08:00 INFO - Return code: 0 04:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:08:00 INFO - Python 2.7.3 04:08:00 INFO - Return code: 0 04:08:00 INFO - grabbing minidump binary from tooltool 04:08:00 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')]} 04:08:00 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 0x1099a0e00>, '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 0x109809db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:08:00 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 04:08:00 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 04:08:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:08:00 INFO - Return code: 0 04:08:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:08:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:08:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:08:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:08:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:08:01 INFO - Return code: 0 04:08:01 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/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 04:08:01 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/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0020 --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 04:08:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aRyuJsSn0n/Render', 04:08:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:01 INFO - 'HOME': '/Users/cltbld', 04:08:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:01 INFO - 'LOGNAME': 'cltbld', 04:08:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:08:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:01 INFO - 'MOZ_NO_REMOTE': '1', 04:08:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:08:01 INFO - 'NO_EM_RESTART': '1', 04:08:01 INFO - 'PAGER': '/bin/cat', 04:08:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:01 INFO - 'PWD': '/builds/slave/test', 04:08:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:08:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:01 INFO - 'SHELL': '/bin/bash', 04:08:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kHomyi7uJD/Listeners', 04:08:01 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 04:08:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:01 INFO - 'USER': 'cltbld', 04:08:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:01 INFO - 'XPC_FLAGS': '0x0', 04:08:01 INFO - 'XPC_SERVICE_NAME': '0', 04:08:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:01 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/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 04:08:01 INFO - mozversion application_buildid: 20160706215822 04:08:01 INFO - mozversion application_changeset: d142c49033c015f67272562b37dbe2912cfc7f14 04:08:01 INFO - mozversion application_display_name: Firefox 04:08:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:08:01 INFO - mozversion application_name: Firefox 04:08:01 INFO - mozversion application_remotingname: firefox 04:08:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:08:01 INFO - mozversion application_vendor: Mozilla 04:08:01 INFO - mozversion application_version: 48.0 04:08:01 INFO - mozversion platform_buildid: 20160706215822 04:08:01 INFO - mozversion platform_changeset: d142c49033c015f67272562b37dbe2912cfc7f14 04:08:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:08:01 INFO - mozversion platform_version: 48.0 04:08:01 INFO - using testdate: 1467889681 04:08:01 INFO - actual date: 1467889681 04:08:01 INFO - starting webserver on 'localhost:49279' 04:08:01 INFO - SUITE-START | Running 2 tests 04:08:01 INFO - TEST-START | dromaeo_css 04:08:01 INFO - operating with platform_type : mac_ 04:08:01 INFO - Initialising browser for dromaeo_css test... 04:08:01 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpqcYDk6/profile http://localhost:49279/getInfo.html) 04:08:04 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 04:08:04 INFO - PROCESS | 1654 | colorDepth:24 04:08:04 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 04:08:04 INFO - PROCESS | 1654 | __metrics 04:08:05 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:08:05 INFO - TEST-INFO | 1654: exit 0 04:08:05 INFO - Browser initialized. 04:08:05 INFO - Running cycle 1/1 for dromaeo_css test... 04:08:05 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpqcYDk6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:17 INFO - PROCESS | 1658 | RSS: Main: 171073536 04:08:17 INFO - PROCESS | 1658 | 04:09:07 INFO - PROCESS | 1658 | 1467889747367 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] 04:11:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 04:11:18 INFO - PROCESS | 1658 | RSS: Main: 182951936 04:11:18 INFO - PROCESS | 1658 | 04:14:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 04:14:21 INFO - PROCESS | 1658 | RSS: Main: 192479232 04:14:21 INFO - PROCESS | 1658 | 04:17:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 04:17:23 INFO - PROCESS | 1658 | RSS: Main: 194666496 04:17:23 INFO - PROCESS | 1658 | 04:20:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 04:20:25 INFO - PROCESS | 1658 | RSS: Main: 198344704 04:20:25 INFO - PROCESS | 1658 | 04:23:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 04:23:29 INFO - PROCESS | 1658 | RSS: Main: 197529600 04:23:29 INFO - PROCESS | 1658 | 04:26:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 04:26:31 INFO - PROCESS | 1658 | RSS: Main: 202412032 04:26:31 INFO - PROCESS | 1658 | 04:26:31 INFO - PROCESS | 1658 | __start_tp_report 04:26:31 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 04:26:31 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 04:26:31 INFO - PROCESS | 1658 | |i|pagename|runs| 04:26:31 INFO - PROCESS | 1658 | |0;dojo.html;3605.477205805158;3672.70618350532;3689.0224090616007;3711.795851228183;3721.181340105176;5836.15375770513;5921.73352199151;5929.822105336836;5952.077427998656;5959.106134079891;5722.99999999999;5829.446202610756;5840.970795146029;5876.794312199063;6007.639541627505;4486.5289144639755;5315.521603055724;5347.786088556453;5353.437889021655;5425.891482170354;5310.867228319285;5364.1149210380245;5366.275552800381;5421.810236641718;5438.075527160392;5240.899411123669;5375.381831089416;5396.5952553558445;5397.649152805075;5414.512693857552;3939.5469521005166;4771.856844294677;5256.500632439912;5319.494648008433;5346.331708536433;5233.084210263189;5239.266502689627;5285.6300058995885;5287.048331300364;5318.042752304584;4408.757518336491;5836.124581312794;5856.862245280442;5882.176495290662;5882.55880808941;6186.195794546725;6198.287196972361;6243.812685619393;6245.219347581552;6245.718942647546;6253.687315634245;6274.811755647338;6279.654618995954;6291.339409362043;6300.117983482316;5982.252218472691;6025.6987150642735;6045.093236014589;6048.818535443944;6051.788187413507;6296.968515157395;6363.745450181941;6436.388543088399;6452.774152904626;6464.353564643498;6232.657203853832;6253.937460625427;6263.906041409383;6268.279147897959;6272.560920735596;6313.842153946096;6315.621062736159;6318.589291696025;6321.683915804191;6332.8416789579705;6154.938450615526;6188.319284878659;6207.379262073757;6216.129741836146;6292.307846136921;6170.321264660884;6189.35011823761;6189.81430557084;6212.378762123842;6240.968795155995;5020.748962551857;5031.320771695848;5044.1677123274985;5064.11378008847;5088.567471764867;4452.554744525586;4458.464984201916;4515.796789144496;4525.004499010212;4604.010137820384;6011.849703757441;6096.512279017668;6154.230721159855;6175.567710260329;6188.195534580475;6240.563160578716;6246.562740608114;6331.525135614847;6349.777757778455;6350.237971443364;6049.576529642883;6130.509559235251;6139.140520327158;6200.472959798378;6206.224221972254;5587.357453892854;5591.8881622368135;5597.776088956478;5614.242077319591;5627.971860140673;6338.366163383625;6590.978398348264;6599.835004124935;6614.305497922649;6616.172978377703;6259.436650701458;6319.273283572448;6319.557630965788;6322.49420046386;6342.23893132827;5452.318460192476;5531.9723401382735;6107.534191794026;6547.148870646976;6577.046328282468;6093.806229757372;6200.193974783249;6272.466840318624;6279.591826531261;6296.370362963667;6215.316315205414;6258;6283.3088360281245;6288.088227207121;6291.307956124914;6149.354317796746;6181.81454556364;6182.783602573888;6186.752529898754;6202.534809889186;5103.821366252163;6098.481629061579;6103.664298463627;6115.296740874856;6132.263729246545;6049.678086399811;6135.14108024868;6138.539609529393;6176.444120029039;6214.40963108504;6177.4749146323065;6227.782027629192;6247.9062814056915;6251.156093927261;6277.529185311028;6167.660778657217;6189.257289125334;6211.161493198541;6235.812925612239;6263.530235232284 04:26:31 INFO - PROCESS | 1658 | |1;ext.html;543.562432242045;555.8304717061295;559.9714563222263;597.3190562758456;604.18435112598;38497.80751096248;39734;39776;39934.80032599837;40010.99999999996;40377.39433908494;40426.989325266884;40430.98922526938;40431.19137617246;40638.39042414359;9556.904430955707;9751.317407781458;9770.267229957746;9786.90213097867;9789;9665.758356041086;9767.316287859852;9815.263855210853;9868.210543156567;9911.207103431709;9808.01919808017;9851.65519206828;9880.011998800099;9889.357191782547;9962.850557241647;9864.062914023156;9874.358166719141;9915;9916.355436896614;9926;9674.661386851427;9782.853257201148;9812.460314682761;9822.066903644143;9853.50732463381;33840.49239261413;40078.59921400778;40201;40463;40489;3096.9690303096904;3224.9032529024166;3279.0818570799975;3378.3074469733647;3396.609389920166;27072;27800.40379587976;28289.292767680974;30031.948881789252;31332;2767.764739997103;2779.596958441035;2789.1074856046075;2820.4500122476124;2837.049588387872;319870;320915.7908420909;321522.3923880389;322831;324025;37571.62428375736;38190.80904595459;65217;65598.34401655922;65642.34357656362;36060.09849753777;36453;36792.26415471676;36843.81578092146;36978.63021369806;16109.758353624706;16293.266802993894;16374.754378684329;16502.2573984171;16554;13340.466381344831;13584.524541641193;13684.93157534206;13716.931415342859;13760.793588096187;8399.41204115706;8441.915580844236;8493.745187644381;8506.78733031679;8509.319254459628;3085.0436364727007;3443.2941247044296;3525.7179425645886;3544.7341449391397;3578.1233597768714;970.898055704155;1016.1464369929147;1030.0214795943884;1046.0742243114898;1096.7093720164003;28681.28296792597;28778.568321475195;29144.708552914624;29252.561211581844;29328.706712933024;1097.9066779323687;1142.5258517715056;1157;1167.6847251242286;1212.89083982442;12310.953568946561;14888.404463821325;15110.697786044218;15535.611609709847;16428.75356869648;592615;602413;621201;635714;639996;64442.71114577776;64749.352506475276;64885;65108.697826043215;65382.67308663426;1375.7248550289983;1550.3643506162418;1560.7112684153467;1584.9207539622973;1591.4589039726318;30835.074947751604;31142.688573113977;31267.37465250728;31595.84202078975;31794.68205317917;54841;55006;55218.44781552133;55936.44063559312;56234;593442;594450;595615;595645;595701;27211.72788272092;43899;44633;45338.959746812136;46281.305780414;33115;38889.22221555497;41381.58618413898;42441.36337954995;42688;31453.05640830687;38459;38643.03392415212;38682.80658596689;38825.223495530496;32420.513692295106;32580.02259932111;36618.26763464769;37249.32378043049;37353.43969840509;33049.83475082609;38327.616723832405;38417;39220.607793922834;39815.80092099521;27023.83726984706;32064;32664;33602.66397335995;34134.487982679784;21671;25508.489830203664;25751.96992120294;26093.608595870697;26144.738552614992 04:26:31 INFO - PROCESS | 1658 | |2;jquery.html;410.50944121774484;410.7761270107793;413.3510388689758;416.23412920226775;420.9452771139751;15046.548603541883;17039.659206815857;20817;21471;21487.247946321902;21037.474063148427;21503;21769;22146.22488212913;22322.441938951495;5512.751926163332;5607.467290607386;5623.240862483573;5689.630174038695;5977.133315669225;6071.666058366788;6080.087986801971;6085.695715214221;6088.634681919077;6153.077038444247;5909.7636094556165;6023.578349515536;6078.787242446515;6130.2643682758135;6178.474829639486;6001.039833626599;6051.062085376773;6079.05774604937;6080.878382432371;6108.938910610881;5046.596272298208;5095.3376061112185;5300.178472336794;5411.296531450926;5426.75579598919;13354.599362019155;14026.08830426019;14094.942879283992;27151.592726109124;27443.17670469889;1818.2726909236278;2121.6817477378363;2207.724034495688;2209.2709405896017;2274.54509098181;9970.601175952954;10061.647842325558;10199.18406527476;10428.426436545988;10581.470926453647;1793.7309403589436;1823.216017112641;1825.6805059114602;1845.723141528768;1855.916483758234;107055;110684;114623.2806507903;115219.42390287995;116010.41994790056;12078.154529182873;12128.514859405701;12159.696007599703;12173.565286942647;12179.634610961686;15111.168885711171;15575.532734017997;15604.765928510855;15608.29762660683;15616.984895981725;8829.779255518664;9236.445813251226;9308.813823723487;9330.253579713606;9426.151646351862;9051.547422628842;9194.264458843276;9369;9379.155875971195;9478.289128315266;4267.1892340455215;4751.429828420612;4762.214234651244;4773.737444440589;4807.903841923142;1842.4380563927862;1981.9405417837488;2076.802703743142;2081.250749730096;2083.7186979757844;943.2218419803689;964.9385675756752;971.3734641156415;1028.2442404832443;1043.9425831579183;20904.37286881396;21733;21749;21812.89093554522;21890.45273868166;826.1243082332746;1013.6756238003916;1014;1038.1487180512058;1106.164845541611;9381.624735010522;9796.510174491246;11341.43292835355;11659;12140.15018948665;559182;644312;647730;649327;667252;88804;96211.0378896202;124763;125088.7491125077;131813.34093329663;979.0014185530719;1010.4240582867695;1013.6249587652616;1045.3727763341933;1049.5067318360511;16596.336146554484;18812.811871881106;18955;19023.429297121107;19100.853948763117;48531.27203092027;50463.73840654013;50545.49454505555;51247;51441.742791285804;77491.61254193693;80677.78983315373;81245;82877;83416.58291708502;7310.96344518274;8307.335413167053;8363.874541881998;8448.577571121297;8492;9432.62269509212;11351.659450216506;13129.60611181666;13254.469821207043;13316.800247996094;9790.51047447639;11226.719332016764;11517;11557;12015.819762703391;11179.66461006171;11302.610402746259;11703.180777345504;11759.000484958875;11775.646730598095;11562.88437115618;11817.527298908291;11919.821202681793;11971.580994665144;12044.75910481803;8067.798305042421;8389.338819041415;8407.159284071544;8520.74437766868;8706.3034957202;7028.648567571703;10258.128059115059;11724.413779311171;11744.823827642764;11893.345865977108 04:26:31 INFO - PROCESS | 1658 | |3;mootools.html;1643.6383995520985;1671.8578920791736;1722.6813039587678;2043.50955770615;2085.8748475091506;8156.959215203916;8889.55552222388;8973.820523589533;9160.954195229024;9214.032526584713;9015.188633023026;9065.546722663858;9084.27325813935;9145.908540914588;9167.90832091679;2544.75824796644;2548.120898290087;2554.3741783263035;2572.369769406498;2575.974240257592;2506.8997240110466;2553.2850801775535;2571.3186005708503;2579.1230981466297;2586.7283935186815;2282.82878784091;2536.9112081077164;2565.8973641054336;2570.5373032854077;2594.1050337633487;2187.595294870454;2564.3717289264064;2566.2814411964678;2569.4732579821093;2570.498752743216;2543.4531575711126;2556.6804149481313;2591;2592.961105583418;2594.4032872439443;9344.112309330603;9371.109744574254;9377.484238366887;9389.169112023159;9392.201662858664;5678.687672178028;5681.57388195887;5763.5101016413655;5770.509506691894;5816.243888294494;3659.6340365963456;3750.49368335274;3797.7341586088983;3804.3152232598122;3812.4281357796276;961.9466683981029;1064.9307794993301;1067.3542506783363;1091.241587096968;1105.0883021507289;12147.878521214763;12286.262824230664;12506.249625022438;12527.185732927423;12560.309182994932;4989.25161225819;5031.4465408805;5102.438731739506;5150.175971844487;5159.922601160985;10354.326968747007;10482.37105773656;10526.368417894952;10564.418956957441;10579.94710026445;5722.284714410699;5771.076627739541;5771.769129234867;5793.275840519935;5818.21454103699;4292.313229883203;4641.512641172696;5140.254663073833;5212.087884620252;5227.790888364499;4197.45433093702;4233.386159006926;4316.1583491219535;4338.154059958278;4344.391785150082;1409.7110092431028;1429.1353730992807;1445.1762495377743;1447.9276036198148;1449.0725935401351;957.4446820843893;965.0783501755807;969.3021024862088;979.4123525884555;990.7108400111704;6081.604695694766;6130.63216207029;6186.969065154645;6231.003039513656;6289.55973081889;419.6370139829026;430.14830635342196;495.2793685188043;1027.7636143686843;1050.7478205230843;3926.332523471017;3960.9009774755864;3991.8004099794894;4008.2183974124764;4079.3676980068135;10726.249162558703;11084.833727494093;11115.666530004113;11134.832977505344;11147.163962702667;10615.575376984989;10634.202434817265;10683.09193718527;10916.563337466412;10972.957569030928;8223.21879421454;8553.016403113597;8554.05905350411;8595.65617375298;8685.044645089036;5996.940030599638;6020.488258498077;6053.334133245427;6144.723487442986;6164.660943648142;9719.514024298614;9854.802903941738;9880.752981175528;9937.006299370294;9952.303338766216;9581.377210481296;9928.25538084661;10048;10176.592936282466;10193.388396696222;7051.153861536648;7483.625818709152;7706.229377062249;7709.614519274126;7889.723859664884;8373.995120585569;8513.702020429502;8538.060813310654;8570.228679418882;8577.614007369808;7458.216887226763;7617.542947423172;7637.083549974039;7678.193789652006;7682.193369696101;7423.331900129015;7474.514156579805;7490.962545187239;7598.012258406372;7639;7079.07971963662;7106;7168.8924666129005;7223.061002069698;7277.563346199245;4942.604591632733;4956.231784073474;5047.621428392812;5090.669106508065;5124.231365295235;5061.7469126544265;5076.18780995039;5081.72050537224;5172.301739265151;5288.3918349390315 04:26:31 INFO - PROCESS | 1658 | |4;prototype.html;287.4337555016617;337.96282408934997;340.23107776425286;345.75624184949606;351.2553386819942;6939.61832099235;6982.476314276437;6984.790456286307;6986.650667466625;6988.790336289913;6957.61733104679;6972.721091156361;6996.755113571026;7008.194057683368;7008.509404341698;4841.225403935371;4995.600351971833;5121.513456221653;5148;5160.56135228506;4426.313921342181;4861.173600487926;5108.8978220435565;5129.846104616868;5156.922646160292;4301.892452688677;4980.12847751642;5117.872053198663;5132;5132.409772876111;5123.513266239701;5136.178211486163;5155.046316431472;5155.793768249284;5167.250748641463;4381.4961279452955;4389.078293558357;4394.274944634131;4400.185965596375;4411.669124815651;5388.218708287276;6317.526185536057;6383.521235907279;6656.134702488694;6743.966280168617;4894.853154405374;5334.679919204821;5944.64332140073;5977.910331345033;5977.940220597782;7455.813604659873;7460.365868901095;7477.513961592479;7482.700691972314;7497.475176737576;4768.833090841804;4770.427548694144;4771.570558649703;4782.378290822206;4784.40194975628;7558.811029724246;7853.175416581234;7896.881546776803;7932.603369831543;7937.642806073741;4094.7133700641266;5004.949950500449;5032;5044.1677123274985;5045.823396181116;5094.337736094284;5122.103631864409;5128.640995130305;5138.409082955433;5162.251473536317;5150.27896094547;5897.555099000687;6051.636901785907;6065.484433823086;6079.240094988127;7411.925880741123;7481.70073197066;7482.4388170887405;7485.887711684329;7487.401007919353;1743.1405105263307;1747.4582879307454;1767.328415202215;1806.2955447375534;1808.502661767998;1144.7882141803793;1152.464104191555;1161.1291531351487;1163.406662602079;1169.999650298999;7023.543469674455;7105.111861017373;7150.320719531636;7159.713611455588;7189.604571748604;7487.251274872469;7585;7776.339011184;7792.961035194901;7813.062432508135;6617;6934.375906168469;7114.893276600855;7124.893126603001;7153.785386438415;4074.633283004544;4137.855175068858;4139.503259608806;4148.108156746253;4159.875203743893;8236.958815205886;8258.091609922903;8262.091169971298;8263.380900987266;8310.792230194173;7798.532088074734;8076.596170191467;8097.2712455879255;8120.228578285053;8125.471844330218;8195.631196596167;8207.753767386988;8223.876641850376;8225.876611850706;8227.218414250636;7807.453478256468;7810.765677029698;7814.648340824563;7814.765557033298;7816.687332506864;7318.81702957409;7639.159692433939;7644.082710074605;7648.770536883902;7653.770386888402;8222.424430289822;8222.588870556569;8225.753227402947;8234.711785087493;8241.83516329658;5040.36995375578;5048.1165795984825;5093.1341671915125;5095.898082038412;5098.5411312982005;7725.459217854921;7729.652165652672;7741.5742134183165;7748.302652761278;7765.1846556110795;6019.398060193946;7163.176234733072;7454.850902982019;7473.663685134291;7487.588182650006;6402.967985160044;7009.929900701131;7381;7428.4800063995;7445.739399121005;7317.304856038668;7326.487145899736;7331.120265568166;7332.120145582564;7333.523320984119;6013.6692481913915;7462.514936529108;7462.552246865205;7474.738384156529;7510.098788145458;6276.9372306276355;6752.459803215829;7358.448116391399;7376.668049937658;7380.704771809067 04:26:31 INFO - PROCESS | 1658 | |5;yui.html;678.9626570538625;682.0689758479674;757.148208265701;787.5471603827797;793.8134538383481;16137.677246455078;16198.514044578667;17797.466076017707;17798.555036124104;17868.285268589272;16036.278367473462;16317.265723042461;16629.50111496654;16766.58083547912;16886.662266754658;790.9248621380959;964.3587014635259;969.6460791811008;970.5001924009141;972.0473935543137;953.2421724728822;988.3032462114228;997.2271489595549;999.3104757717189;1002.959881604735;1025.3232866308238;1042.3329069395593;1042.8331466965287;1046.08467590858;1046.3251202974077;1027.6916924922493;1031.1441503552035;1032.3702541449709;1034.6223628375665;1036.4092467293647;742.4691345687805;752.713968691899;768.2394429514796;775.379696243009;780.1886038519932;16003.119828409433;16008.359665613361;16194.919025404797;16222.269997850126;16253.837461625351;12739.42672579736;12796.424160912688;12841.67895802603;12979.415926283245;13207.40566674502;10079.936051159117;11183.496742646601;11469.426528673617;11571.710707232302;11687.824682629767;3194.2653189766484;3312.585926759155;3372.578427696538;3584.7490675652716;3869.1101046759404;80002;81249;81354;84109;85699;9377.906220937839;9378.390404623678;9417.62329506812;9448.196903263299;9764.902350976541;19717;20139;20350;20361.796382036286;20370.59258814845;7201.71193152268;7338.046054012944;7358.0495487188855;7394.667239974106;7484.513506622052;4097.549269580344;4173.08192197716;4173.457450531411;4191.3293872980175;4193.412922190896;3781.6785573226584;3791.4881490998364;3821.656050955372;3827.78947157909;3831.4061320495366;533.751805410486;588.485075558886;677.8339306869849;682.222266616058;685.9279775623587;578.4475825586554;616.1374076293135;625.6934102289936;632.2476253258608;635.9014352775328;6838.863222735517;8245.83508329842;8287.751367458986;8289;8575.035271404222;562.4066609726696;600.5075837813039;601.2691250788845;612.6599737145838;620.8044465993288;3809.2191100824266;3829.4830197922925;3835.4055121455663;3920.8080325838887;4053.2906741320153;63680.771173008725;80339.59830200928;83636.58181709053;97048;97500;65953.35116622123;70802;74481.62759186169;76547;77704.61147694226;66980.6650966742;68387.65806171036;68440.97338539927;68502.65748671225;68819;6945.930540694529;8267.751967440987;8381.916180838114;8446.873296900429;8510.617022234139;44232;44253.45112921032;45558.772206138754;45594.632161035224;48485.7878553039;59302.22093337207;61953;62313.37686623257;64203.03695444479;64791;11097.445127743742;11150.944245278723;11182.608608698656;11264.929831665979;11309.547618095185;11996.940015299868;12076.21504602198;12076.75846483083;12174.904258616767;12609.43257553394;11231.66305010851;11298.4915678793;11485.48315325829;11826.645200643994;11846.170768046153;11285.379304138023;11447.084233261485;11486.138539609396;11554.48004839801;11804.586839460577;11345.432728363383;11355;11475.139364547525;11534.711632209262;11989.160758746804;9607.759806004906;9610.471424071744;9798.80402391934;9832;10054.497275136067;9713.222942164752;9840.409575425498;9882.66584011178;9943.453110079015;9964.950175249078 04:26:31 INFO - PROCESS | 1658 | __end_tp_report 04:26:31 INFO - PROCESS | 1658 | __start_cc_report 04:26:31 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,386 04:26:31 INFO - PROCESS | 1658 | __end_cc_report 04:26:31 INFO - PROCESS | 1658 | __startTimestamp1467890791710__endTimestamp 04:26:31 INFO - PROCESS | 1658 | 04:26:31 INFO - PROCESS | 1658 | ------- Summary: start ------- 04:26:31 INFO - PROCESS | 1658 | Number of tests: 6 04:26:31 INFO - PROCESS | 1658 | 04:26:31 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5845.88 Median:6149.35 stddev:648.42 (10.5%) stddev-sans-first:626.13 04:26:31 INFO - PROCESS | 1658 | Values: 3605.5 3672.7 3689.0 3711.8 3721.2 5836.2 5921.7 5929.8 5952.1 5959.1 5723.0 5829.4 5841.0 5876.8 6007.6 4486.5 5315.5 5347.8 5353.4 5425.9 5310.9 5364.1 5366.3 5421.8 5438.1 5240.9 5375.4 5396.6 5397.6 5414.5 3939.5 4771.9 5256.5 5319.5 5346.3 5233.1 5239.3 5285.6 5287.0 5318.0 4408.8 5836.1 5856.9 5882.2 5882.6 6186.2 6198.3 6243.8 6245.2 6245.7 6253.7 6274.8 6279.7 6291.3 6300.1 5982.3 6025.7 6045.1 6048.8 6051.8 6297.0 6363.7 6436.4 6452.8 6464.4 6232.7 6253.9 6263.9 6268.3 6272.6 6313.8 6315.6 6318.6 6321.7 6332.8 6154.9 6188.3 6207.4 6216.1 6292.3 6170.3 6189.4 6189.8 6212.4 6241.0 5020.7 5031.3 5044.2 5064.1 5088.6 4452.6 4458.5 4515.8 4525.0 4604.0 6011.8 6096.5 6154.2 6175.6 6188.2 6240.6 6246.6 6331.5 6349.8 6350.2 6049.6 6130.5 6139.1 6200.5 6206.2 5587.4 5591.9 5597.8 5614.2 5628.0 6338.4 6591.0 6599.8 6614.3 6616.2 6259.4 6319.3 6319.6 6322.5 6342.2 5452.3 5532.0 6107.5 6547.1 6577.0 6093.8 6200.2 6272.5 6279.6 6296.4 6215.3 6258.0 6283.3 6288.1 6291.3 6149.4 6181.8 6182.8 6186.8 6202.5 5103.8 6098.5 6103.7 6115.3 6132.3 6049.7 6135.1 6138.5 6176.4 6214.4 6177.5 6227.8 6247.9 6251.2 6277.5 6167.7 6189.3 6211.2 6235.8 6263.5 04:26:31 INFO - PROCESS | 1658 | 04:26:31 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:64430.62 Median:38259.21 stddev:141854.25 (370.8%) stddev-sans-first:142171.09 04:26:31 INFO - PROCESS | 1658 | Values: 543.6 555.8 560.0 597.3 604.2 38497.8 39734.0 39776.0 39934.8 40011.0 40377.4 40427.0 40431.0 40431.2 40638.4 9556.9 9751.3 9770.3 9786.9 9789.0 9665.8 9767.3 9815.3 9868.2 9911.2 9808.0 9851.7 9880.0 9889.4 9962.9 9864.1 9874.4 9915.0 9916.4 9926.0 9674.7 9782.9 9812.5 9822.1 9853.5 33840.5 40078.6 40201.0 40463.0 40489.0 3097.0 3224.9 3279.1 3378.3 3396.6 27072.0 27800.4 28289.3 30031.9 31332.0 2767.8 2779.6 2789.1 2820.5 2837.0 319870.0 320915.8 321522.4 322831.0 324025.0 37571.6 38190.8 65217.0 65598.3 65642.3 36060.1 36453.0 36792.3 36843.8 36978.6 16109.8 16293.3 16374.8 16502.3 16554.0 13340.5 13584.5 13684.9 13716.9 13760.8 8399.4 8441.9 8493.7 8506.8 8509.3 3085.0 3443.3 3525.7 3544.7 3578.1 970.9 1016.1 1030.0 1046.1 1096.7 28681.3 28778.6 29144.7 29252.6 29328.7 1097.9 1142.5 1157.0 1167.7 1212.9 12311.0 14888.4 15110.7 15535.6 16428.8 592615.0 602413.0 621201.0 635714.0 639996.0 64442.7 64749.4 64885.0 65108.7 65382.7 1375.7 1550.4 1560.7 1584.9 1591.5 30835.1 31142.7 31267.4 31595.8 31794.7 54841.0 55006.0 55218.4 55936.4 56234.0 593442.0 594450.0 595615.0 595645.0 595701.0 27211.7 43899.0 44633.0 45339.0 46281.3 33115.0 38889.2 41381.6 42441.4 42688.0 31453.1 38459.0 38643.0 38682.8 38825.2 32420.5 32580.0 36618.3 37249.3 37353.4 33049.8 38327.6 38417.0 39220.6 39815.8 27023.8 32064.0 32664.0 33602.7 34134.5 21671.0 25508.5 25752.0 26093.6 26144.7 04:26:31 INFO - PROCESS | 1658 | 04:26:31 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35439.60 Median:2208.50 stddev:105238.79 (4765.2%) stddev-sans-first:105501.15 04:26:31 INFO - PROCESS | 1658 | Values: 410.5 410.8 413.4 416.2 420.9 15046.5 17039.7 20817.0 21471.0 21487.2 21037.5 21503.0 21769.0 22146.2 22322.4 5512.8 5607.5 5623.2 5689.6 5977.1 6071.7 6080.1 6085.7 6088.6 6153.1 5909.8 6023.6 6078.8 6130.3 6178.5 6001.0 6051.1 6079.1 6080.9 6108.9 5046.6 5095.3 5300.2 5411.3 5426.8 13354.6 14026.1 14094.9 27151.6 27443.2 1818.3 2121.7 2207.7 2209.3 2274.5 9970.6 10061.6 10199.2 10428.4 10581.5 1793.7 1823.2 1825.7 1845.7 1855.9 107055.0 110684.0 114623.3 115219.4 116010.4 12078.2 12128.5 12159.7 12173.6 12179.6 15111.2 15575.5 15604.8 15608.3 15617.0 8829.8 9236.4 9308.8 9330.3 9426.2 9051.5 9194.3 9369.0 9379.2 9478.3 4267.2 4751.4 4762.2 4773.7 4807.9 1842.4 1981.9 2076.8 2081.3 2083.7 943.2 964.9 971.4 1028.2 1043.9 20904.4 21733.0 21749.0 21812.9 21890.5 826.1 1013.7 1014.0 1038.1 1106.2 9381.6 9796.5 11341.4 11659.0 12140.2 559182.0 644312.0 647730.0 649327.0 667252.0 88804.0 96211.0 124763.0 125088.7 131813.3 979.0 1010.4 1013.6 1045.4 1049.5 16596.3 18812.8 18955.0 19023.4 19100.9 48531.3 50463.7 50545.5 51247.0 51441.7 77491.6 80677.8 81245.0 82877.0 83416.6 7311.0 8307.3 8363.9 8448.6 8492.0 9432.6 11351.7 13129.6 13254.5 13316.8 9790.5 11226.7 11517.0 11557.0 12015.8 11179.7 11302.6 11703.2 11759.0 11775.6 11562.9 11817.5 11919.8 11971.6 12044.8 8067.8 8389.3 8407.2 8520.7 8706.3 7028.6 10258.1 11724.4 11744.8 11893.3 04:26:31 INFO - PROCESS | 1658 | 04:26:31 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5930.37 Median:5078.95 stddev:3272.66 (64.4%) stddev-sans-first:3265.99 04:26:31 INFO - PROCESS | 1658 | Values: 1643.6 1671.9 1722.7 2043.5 2085.9 8157.0 8889.6 8973.8 9161.0 9214.0 9015.2 9065.5 9084.3 9145.9 9167.9 2544.8 2548.1 2554.4 2572.4 2576.0 2506.9 2553.3 2571.3 2579.1 2586.7 2282.8 2536.9 2565.9 2570.5 2594.1 2187.6 2564.4 2566.3 2569.5 2570.5 2543.5 2556.7 2591.0 2593.0 2594.4 9344.1 9371.1 9377.5 9389.2 9392.2 5678.7 5681.6 5763.5 5770.5 5816.2 3659.6 3750.5 3797.7 3804.3 3812.4 961.9 1064.9 1067.4 1091.2 1105.1 12147.9 12286.3 12506.2 12527.2 12560.3 4989.3 5031.4 5102.4 5150.2 5159.9 10354.3 10482.4 10526.4 10564.4 10579.9 5722.3 5771.1 5771.8 5793.3 5818.2 4292.3 4641.5 5140.3 5212.1 5227.8 4197.5 4233.4 4316.2 4338.2 4344.4 1409.7 1429.1 1445.2 1447.9 1449.1 957.4 965.1 969.3 979.4 990.7 6081.6 6130.6 6187.0 6231.0 6289.6 419.6 430.1 495.3 1027.8 1050.7 3926.3 3960.9 3991.8 4008.2 4079.4 10726.2 11084.8 11115.7 11134.8 11147.2 10615.6 10634.2 10683.1 10916.6 10973.0 8223.2 8553.0 8554.1 8595.7 8685.0 5996.9 6020.5 6053.3 6144.7 6164.7 9719.5 9854.8 9880.8 9937.0 9952.3 9581.4 9928.3 10048.0 10176.6 10193.4 7051.2 7483.6 7706.2 7709.6 7889.7 8374.0 8513.7 8538.1 8570.2 8577.6 7458.2 7617.5 7637.1 7678.2 7682.2 7423.3 7474.5 7491.0 7598.0 7639.0 7079.1 7106.0 7168.9 7223.1 7277.6 4942.6 4956.2 5047.6 5090.7 5124.2 5061.7 5076.2 5081.7 5172.3 5288.4 04:26:31 INFO - PROCESS | 1658 | 04:26:31 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:6102.72 Median:6983.63 stddev:1972.15 (28.2%) stddev-sans-first:1928.77 04:26:31 INFO - PROCESS | 1658 | Values: 287.4 338.0 340.2 345.8 351.3 6939.6 6982.5 6984.8 6986.7 6988.8 6957.6 6972.7 6996.8 7008.2 7008.5 4841.2 4995.6 5121.5 5148.0 5160.6 4426.3 4861.2 5108.9 5129.8 5156.9 4301.9 4980.1 5117.9 5132.0 5132.4 5123.5 5136.2 5155.0 5155.8 5167.3 4381.5 4389.1 4394.3 4400.2 4411.7 5388.2 6317.5 6383.5 6656.1 6744.0 4894.9 5334.7 5944.6 5977.9 5977.9 7455.8 7460.4 7477.5 7482.7 7497.5 4768.8 4770.4 4771.6 4782.4 4784.4 7558.8 7853.2 7896.9 7932.6 7937.6 4094.7 5004.9 5032.0 5044.2 5045.8 5094.3 5122.1 5128.6 5138.4 5162.3 5150.3 5897.6 6051.6 6065.5 6079.2 7411.9 7481.7 7482.4 7485.9 7487.4 1743.1 1747.5 1767.3 1806.3 1808.5 1144.8 1152.5 1161.1 1163.4 1170.0 7023.5 7105.1 7150.3 7159.7 7189.6 7487.3 7585.0 7776.3 7793.0 7813.1 6617.0 6934.4 7114.9 7124.9 7153.8 4074.6 4137.9 4139.5 4148.1 4159.9 8237.0 8258.1 8262.1 8263.4 8310.8 7798.5 8076.6 8097.3 8120.2 8125.5 8195.6 8207.8 8223.9 8225.9 8227.2 7807.5 7810.8 7814.6 7814.8 7816.7 7318.8 7639.2 7644.1 7648.8 7653.8 8222.4 8222.6 8225.8 8234.7 8241.8 5040.4 5048.1 5093.1 5095.9 5098.5 7725.5 7729.7 7741.6 7748.3 7765.2 6019.4 7163.2 7454.9 7473.7 7487.6 6403.0 7009.9 7381.0 7428.5 7445.7 7317.3 7326.5 7331.1 7332.1 7333.5 6013.7 7462.5 7462.6 7474.7 7510.1 6276.9 6752.5 7358.4 7376.7 7380.7 04:26:31 INFO - PROCESS | 1658 | 04:26:31 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:17883.65 Median:47040.21 stddev:24408.05 (51.9%) stddev-sans-first:24442.34 04:26:31 INFO - PROCESS | 1658 | Values: 679.0 682.1 757.1 787.5 793.8 16137.7 16198.5 17797.5 17798.6 17868.3 16036.3 16317.3 16629.5 16766.6 16886.7 790.9 964.4 969.6 970.5 972.0 953.2 988.3 997.2 999.3 1003.0 1025.3 1042.3 1042.8 1046.1 1046.3 1027.7 1031.1 1032.4 1034.6 1036.4 742.5 752.7 768.2 775.4 780.2 16003.1 16008.4 16194.9 16222.3 16253.8 12739.4 12796.4 12841.7 12979.4 13207.4 10079.9 11183.5 11469.4 11571.7 11687.8 3194.3 3312.6 3372.6 3584.7 3869.1 80002.0 81249.0 81354.0 84109.0 85699.0 9377.9 9378.4 9417.6 9448.2 9764.9 19717.0 20139.0 20350.0 20361.8 20370.6 7201.7 7338.0 7358.0 7394.7 7484.5 4097.5 4173.1 4173.5 4191.3 4193.4 3781.7 3791.5 3821.7 3827.8 3831.4 533.8 588.5 677.8 682.2 685.9 578.4 616.1 625.7 632.2 635.9 6838.9 8245.8 8287.8 8289.0 8575.0 562.4 600.5 601.3 612.7 620.8 3809.2 3829.5 3835.4 3920.8 4053.3 63680.8 80339.6 83636.6 97048.0 97500.0 65953.4 70802.0 74481.6 76547.0 77704.6 66980.7 68387.7 68441.0 68502.7 68819.0 6945.9 8267.8 8381.9 8446.9 8510.6 44232.0 44253.5 45558.8 45594.6 48485.8 59302.2 61953.0 62313.4 64203.0 64791.0 11097.4 11150.9 11182.6 11264.9 11309.5 11996.9 12076.2 12076.8 12174.9 12609.4 11231.7 11298.5 11485.5 11826.6 11846.2 11285.4 11447.1 11486.1 11554.5 11804.6 11345.4 11355.0 11475.1 11534.7 11989.2 9607.8 9610.5 9798.8 9832.0 10054.5 9713.2 9840.4 9882.7 9943.5 9965.0 04:26:31 INFO - PROCESS | 1658 | -------- Summary: end -------- 04:26:31 INFO - PROCESS | 1658 | 04:26:32 INFO - TEST-INFO | 1658: exit 0 04:26:32 INFO - TEST-OK | dromaeo_css | took 1110307ms 04:26:32 INFO - TEST-START | kraken 04:26:32 INFO - operating with platform_type : mac_ 04:26:32 INFO - Initialising browser for kraken test... 04:26:32 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpEgFxFv/profile http://localhost:49279/getInfo.html) 04:26:34 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 04:26:34 INFO - PROCESS | 1669 | colorDepth:24 04:26:34 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 04:26:34 INFO - PROCESS | 1669 | __metrics 04:26:34 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:26:35 INFO - TEST-INFO | 1669: exit 0 04:26:35 INFO - Browser initialized. 04:26:35 INFO - Running cycle 1/1 for kraken test... 04:26:35 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpEgFxFv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:47 INFO - PROCESS | 1673 | RSS: Main: 171466752 04:26:47 INFO - PROCESS | 1673 | 04:26:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:51 INFO - PROCESS | 1673 | RSS: Main: 183816192 04:26:51 INFO - PROCESS | 1673 | 04:26:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 04:26:54 INFO - PROCESS | 1673 | RSS: Main: 192405504 04:26:54 INFO - PROCESS | 1673 | 04:26:57 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 04:26:58 INFO - PROCESS | 1673 | RSS: Main: 196079616 04:26:58 INFO - PROCESS | 1673 | 04:27:00 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 04:27:01 INFO - PROCESS | 1673 | RSS: Main: 196403200 04:27:01 INFO - PROCESS | 1673 | 04:27:03 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:27:03 INFO - PROCESS | 1673 | RSS: Main: 196620288 04:27:03 INFO - PROCESS | 1673 | 04:27:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 04:27:07 INFO - PROCESS | 1673 | RSS: Main: 198119424 04:27:07 INFO - PROCESS | 1673 | 04:27:09 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 04:27:10 INFO - PROCESS | 1673 | RSS: Main: 198189056 04:27:10 INFO - PROCESS | 1673 | 04:27:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 04:27:14 INFO - PROCESS | 1673 | RSS: Main: 198332416 04:27:14 INFO - PROCESS | 1673 | 04:27:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:16 INFO - PROCESS | 1673 | RSS: Main: 198078464 04:27:16 INFO - PROCESS | 1673 | 04:27:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:18 INFO - PROCESS | 1673 | RSS: Main: 198017024 04:27:18 INFO - PROCESS | 1673 | 04:27:20 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:21 INFO - PROCESS | 1673 | RSS: Main: 198172672 04:27:21 INFO - PROCESS | 1673 | 04:27:24 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:24 INFO - PROCESS | 1673 | RSS: Main: 198262784 04:27:24 INFO - PROCESS | 1673 | 04:27:27 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:28 INFO - PROCESS | 1673 | RSS: Main: 198279168 04:27:28 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 04:27:30 INFO - PROCESS | 1673 | RSS: Main: 200245248 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | __start_tp_report 04:27:30 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 04:27:30 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 04:27:30 INFO - PROCESS | 1673 | |i|pagename|runs| 04:27:30 INFO - PROCESS | 1673 | |0;ai-astar;165;159;127;117;117;116;108;134;116;117 04:27:30 INFO - PROCESS | 1673 | |1;audio-beat-detection;152;124;144;182;105;169;150;190;180;121 04:27:30 INFO - PROCESS | 1673 | |2;audio-dft;201;197;197;196;193;221;267;219;199;197 04:27:30 INFO - PROCESS | 1673 | |3;audio-fft;66;82;76;187;53;66;85;82;136;54 04:27:30 INFO - PROCESS | 1673 | |4;audio-oscillator;81;80;129;78;77;82;121;81;79;121 04:27:30 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;89;90;122;85;89;85;89;87;88;85 04:27:30 INFO - PROCESS | 1673 | |6;imaging-darkroom;95;96;94;94;94;95;104;133;94;95 04:27:30 INFO - PROCESS | 1673 | |7;imaging-desaturate;91;91;90;117;142;90;125;146;104;142 04:27:30 INFO - PROCESS | 1673 | |8;json-parse-financial;58;65;65;63;64;66;65;77;62;60 04:27:30 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;61;65;64;72;75;72;70;66;66;67 04:27:30 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;80;78;80;81;80;81;81;80;81;84 04:27:30 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;132;142;142;119;130;135;143;151;169;173 04:27:30 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;164;163;178;209;176;192;216;193;163;179 04:27:30 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;66;68;65;68;67;69;68;67;66;67 04:27:30 INFO - PROCESS | 1673 | __end_tp_report 04:27:30 INFO - PROCESS | 1673 | __start_cc_report 04:27:30 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1036 04:27:30 INFO - PROCESS | 1673 | __end_cc_report 04:27:30 INFO - PROCESS | 1673 | __startTimestamp1467890850461__endTimestamp 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | ------- Summary: start ------- 04:27:30 INFO - PROCESS | 1673 | Number of tests: 14 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:127.60 Median:122.00 stddev:19.48 (16.0%) stddev-sans-first:15.26 04:27:30 INFO - PROCESS | 1673 | Values: 165.0 159.0 127.0 117.0 117.0 116.0 108.0 134.0 116.0 117.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:160.50 stddev:28.75 (17.9%) stddev-sans-first:30.49 04:27:30 INFO - PROCESS | 1673 | Values: 152.0 124.0 144.0 182.0 105.0 169.0 150.0 190.0 180.0 121.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:208.70 Median:200.00 stddev:22.68 (11.3%) stddev-sans-first:23.88 04:27:30 INFO - PROCESS | 1673 | Values: 201.0 197.0 197.0 196.0 193.0 221.0 267.0 219.0 199.0 197.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:88.70 Median:71.00 stddev:41.73 (58.8%) stddev-sans-first:43.45 04:27:30 INFO - PROCESS | 1673 | Values: 66.0 82.0 76.0 187.0 53.0 66.0 85.0 82.0 136.0 54.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:79.50 stddev:21.39 (26.9%) stddev-sans-first:22.25 04:27:30 INFO - PROCESS | 1673 | Values: 81.0 80.0 129.0 78.0 77.0 82.0 121.0 81.0 79.0 121.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:90.90 Median:88.50 stddev:11.09 (12.5%) stddev-sans-first:11.74 04:27:30 INFO - PROCESS | 1673 | Values: 89.0 90.0 122.0 85.0 89.0 85.0 89.0 87.0 88.0 85.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:94.50 stddev:12.19 (12.9%) stddev-sans-first:12.82 04:27:30 INFO - PROCESS | 1673 | Values: 95.0 96.0 94.0 94.0 94.0 95.0 104.0 133.0 94.0 95.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:113.80 Median:118.00 stddev:23.64 (20.0%) stddev-sans-first:23.60 04:27:30 INFO - PROCESS | 1673 | Values: 91.0 91.0 90.0 117.0 142.0 90.0 125.0 146.0 104.0 142.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:5.06 (7.8%) stddev-sans-first:4.79 04:27:30 INFO - PROCESS | 1673 | Values: 58.0 65.0 65.0 63.0 64.0 66.0 65.0 77.0 62.0 60.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.50 stddev:4.32 (6.3%) stddev-sans-first:3.81 04:27:30 INFO - PROCESS | 1673 | Values: 61.0 65.0 64.0 72.0 75.0 72.0 70.0 66.0 66.0 67.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:81.00 stddev:1.51 (1.9%) stddev-sans-first:1.58 04:27:30 INFO - PROCESS | 1673 | Values: 80.0 78.0 80.0 81.0 80.0 81.0 81.0 80.0 81.0 84.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:142.50 stddev:16.89 (11.9%) stddev-sans-first:17.39 04:27:30 INFO - PROCESS | 1673 | Values: 132.0 142.0 142.0 119.0 130.0 135.0 143.0 151.0 169.0 173.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.30 Median:185.50 stddev:18.84 (10.2%) stddev-sans-first:18.65 04:27:30 INFO - PROCESS | 1673 | Values: 164.0 163.0 178.0 209.0 176.0 192.0 216.0 193.0 163.0 179.0 04:27:30 INFO - PROCESS | 1673 | 04:27:30 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.20 (1.8%) stddev-sans-first:1.20 04:27:30 INFO - PROCESS | 1673 | Values: 66.0 68.0 65.0 68.0 67.0 69.0 68.0 67.0 66.0 67.0 04:27:30 INFO - PROCESS | 1673 | -------- Summary: end -------- 04:27:30 INFO - PROCESS | 1673 | 04:27:31 INFO - TEST-INFO | 1673: exit 0 04:27:31 INFO - TEST-OK | kraken | took 58973ms 04:27:31 INFO - SUITE-END | took 1169s 04:27:31 INFO - Completed test suite (00:19:29) 04:27:31 INFO - javascript benchmark 04:27:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3605.477205805158, 3672.70618350532, 3689.0224090616007, 3711.795851228183, 3721.181340105176, 5836.15375770513, 5921.73352199151, 5929.822105336836, 5952.077427998656, 5959.106134079891, 5722.99999999999, 5829.446202610756, 5840.970795146029, 5876.794312199063, 6007.639541627505, 4486.5289144639755, 5315.521603055724, 5347.786088556453, 5353.437889021655, 5425.891482170354, 5310.867228319285, 5364.1149210380245, 5366.275552800381, 5421.810236641718, 5438.075527160392, 5240.899411123669, 5375.381831089416, 5396.5952553558445, 5397.649152805075, 5414.512693857552, 3939.5469521005166, 4771.856844294677, 5256.500632439912, 5319.494648008433, 5346.331708536433, 5233.084210263189, 5239.266502689627, 5285.6300058995885, 5287.048331300364, 5318.042752304584, 4408.757518336491, 5836.124581312794, 5856.862245280442, 5882.176495290662, 5882.55880808941, 6186.195794546725, 6198.287196972361, 6243.812685619393, 6245.219347581552, 6245.718942647546, 6253.687315634245, 6274.811755647338, 6279.654618995954, 6291.339409362043, 6300.117983482316, 5982.252218472691, 6025.6987150642735, 6045.093236014589, 6048.818535443944, 6051.788187413507, 6296.968515157395, 6363.745450181941, 6436.388543088399, 6452.774152904626, 6464.353564643498, 6232.657203853832, 6253.937460625427, 6263.906041409383, 6268.279147897959, 6272.560920735596, 6313.842153946096, 6315.621062736159, 6318.589291696025, 6321.683915804191, 6332.8416789579705, 6154.938450615526, 6188.319284878659, 6207.379262073757, 6216.129741836146, 6292.307846136921, 6170.321264660884, 6189.35011823761, 6189.81430557084, 6212.378762123842, 6240.968795155995, 5020.748962551857, 5031.320771695848, 5044.1677123274985, 5064.11378008847, 5088.567471764867, 4452.554744525586, 4458.464984201916, 4515.796789144496, 4525.004499010212, 4604.010137820384, 6011.849703757441, 6096.512279017668, 6154.230721159855, 6175.567710260329, 6188.195534580475, 6240.563160578716, 6246.562740608114, 6331.525135614847, 6349.777757778455, 6350.237971443364, 6049.576529642883, 6130.509559235251, 6139.140520327158, 6200.472959798378, 6206.224221972254, 5587.357453892854, 5591.8881622368135, 5597.776088956478, 5614.242077319591, 5627.971860140673, 6338.366163383625, 6590.978398348264, 6599.835004124935, 6614.305497922649, 6616.172978377703, 6259.436650701458, 6319.273283572448, 6319.557630965788, 6322.49420046386, 6342.23893132827, 5452.318460192476, 5531.9723401382735, 6107.534191794026, 6547.148870646976, 6577.046328282468, 6093.806229757372, 6200.193974783249, 6272.466840318624, 6279.591826531261, 6296.370362963667, 6215.316315205414, 6258.0, 6283.3088360281245, 6288.088227207121, 6291.307956124914, 6149.354317796746, 6181.81454556364, 6182.783602573888, 6186.752529898754, 6202.534809889186, 5103.821366252163, 6098.481629061579, 6103.664298463627, 6115.296740874856, 6132.263729246545, 6049.678086399811, 6135.14108024868, 6138.539609529393, 6176.444120029039, 6214.40963108504, 6177.4749146323065, 6227.782027629192, 6247.9062814056915, 6251.156093927261, 6277.529185311028, 6167.660778657217, 6189.257289125334, 6211.161493198541, 6235.812925612239, 6263.530235232284], "value": 5808.115595729173, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.562432242045, 555.8304717061295, 559.9714563222263, 597.3190562758456, 604.18435112598, 38497.80751096248, 39734.0, 39776.0, 39934.80032599837, 40010.99999999996, 40377.39433908494, 40426.989325266884, 40430.98922526938, 40431.19137617246, 40638.39042414359, 9556.904430955707, 9751.317407781458, 9770.267229957746, 9786.90213097867, 9789.0, 9665.758356041086, 9767.316287859852, 9815.263855210853, 9868.210543156567, 9911.207103431709, 9808.01919808017, 9851.65519206828, 9880.011998800099, 9889.357191782547, 9962.850557241647, 9864.062914023156, 9874.358166719141, 9915.0, 9916.355436896614, 9926.0, 9674.661386851427, 9782.853257201148, 9812.460314682761, 9822.066903644143, 9853.50732463381, 33840.49239261413, 40078.59921400778, 40201.0, 40463.0, 40489.0, 3096.9690303096904, 3224.9032529024166, 3279.0818570799975, 3378.3074469733647, 3396.609389920166, 27072.0, 27800.40379587976, 28289.292767680974, 30031.948881789252, 31332.0, 2767.764739997103, 2779.596958441035, 2789.1074856046075, 2820.4500122476124, 2837.049588387872, 319870.0, 320915.7908420909, 321522.3923880389, 322831.0, 324025.0, 37571.62428375736, 38190.80904595459, 65217.0, 65598.34401655922, 65642.34357656362, 36060.09849753777, 36453.0, 36792.26415471676, 36843.81578092146, 36978.63021369806, 16109.758353624706, 16293.266802993894, 16374.754378684329, 16502.2573984171, 16554.0, 13340.466381344831, 13584.524541641193, 13684.93157534206, 13716.931415342859, 13760.793588096187, 8399.41204115706, 8441.915580844236, 8493.745187644381, 8506.78733031679, 8509.319254459628, 3085.0436364727007, 3443.2941247044296, 3525.7179425645886, 3544.7341449391397, 3578.1233597768714, 970.898055704155, 1016.1464369929147, 1030.0214795943884, 1046.0742243114898, 1096.7093720164003, 28681.28296792597, 28778.568321475195, 29144.708552914624, 29252.561211581844, 29328.706712933024, 1097.9066779323687, 1142.5258517715056, 1157.0, 1167.6847251242286, 1212.89083982442, 12310.953568946561, 14888.404463821325, 15110.697786044218, 15535.611609709847, 16428.75356869648, 592615.0, 602413.0, 621201.0, 635714.0, 639996.0, 64442.71114577776, 64749.352506475276, 64885.0, 65108.697826043215, 65382.67308663426, 1375.7248550289983, 1550.3643506162418, 1560.7112684153467, 1584.9207539622973, 1591.4589039726318, 30835.074947751604, 31142.688573113977, 31267.37465250728, 31595.84202078975, 31794.68205317917, 54841.0, 55006.0, 55218.44781552133, 55936.44063559312, 56234.0, 593442.0, 594450.0, 595615.0, 595645.0, 595701.0, 27211.72788272092, 43899.0, 44633.0, 45338.959746812136, 46281.305780414, 33115.0, 38889.22221555497, 41381.58618413898, 42441.36337954995, 42688.0, 31453.05640830687, 38459.0, 38643.03392415212, 38682.80658596689, 38825.223495530496, 32420.513692295106, 32580.02259932111, 36618.26763464769, 37249.32378043049, 37353.43969840509, 33049.83475082609, 38327.616723832405, 38417.0, 39220.607793922834, 39815.80092099521, 27023.83726984706, 32064.0, 32664.0, 33602.66397335995, 34134.487982679784, 21671.0, 25508.489830203664, 25751.96992120294, 26093.608595870697, 26144.738552614992], "value": 18820.696777650985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.50944121774484, 410.7761270107793, 413.3510388689758, 416.23412920226775, 420.9452771139751, 15046.548603541883, 17039.659206815857, 20817.0, 21471.0, 21487.247946321902, 21037.474063148427, 21503.0, 21769.0, 22146.22488212913, 22322.441938951495, 5512.751926163332, 5607.467290607386, 5623.240862483573, 5689.630174038695, 5977.133315669225, 6071.666058366788, 6080.087986801971, 6085.695715214221, 6088.634681919077, 6153.077038444247, 5909.7636094556165, 6023.578349515536, 6078.787242446515, 6130.2643682758135, 6178.474829639486, 6001.039833626599, 6051.062085376773, 6079.05774604937, 6080.878382432371, 6108.938910610881, 5046.596272298208, 5095.3376061112185, 5300.178472336794, 5411.296531450926, 5426.75579598919, 13354.599362019155, 14026.08830426019, 14094.942879283992, 27151.592726109124, 27443.17670469889, 1818.2726909236278, 2121.6817477378363, 2207.724034495688, 2209.2709405896017, 2274.54509098181, 9970.601175952954, 10061.647842325558, 10199.18406527476, 10428.426436545988, 10581.470926453647, 1793.7309403589436, 1823.216017112641, 1825.6805059114602, 1845.723141528768, 1855.916483758234, 107055.0, 110684.0, 114623.2806507903, 115219.42390287995, 116010.41994790056, 12078.154529182873, 12128.514859405701, 12159.696007599703, 12173.565286942647, 12179.634610961686, 15111.168885711171, 15575.532734017997, 15604.765928510855, 15608.29762660683, 15616.984895981725, 8829.779255518664, 9236.445813251226, 9308.813823723487, 9330.253579713606, 9426.151646351862, 9051.547422628842, 9194.264458843276, 9369.0, 9379.155875971195, 9478.289128315266, 4267.1892340455215, 4751.429828420612, 4762.214234651244, 4773.737444440589, 4807.903841923142, 1842.4380563927862, 1981.9405417837488, 2076.802703743142, 2081.250749730096, 2083.7186979757844, 943.2218419803689, 964.9385675756752, 971.3734641156415, 1028.2442404832443, 1043.9425831579183, 20904.37286881396, 21733.0, 21749.0, 21812.89093554522, 21890.45273868166, 826.1243082332746, 1013.6756238003916, 1014.0, 1038.1487180512058, 1106.164845541611, 9381.624735010522, 9796.510174491246, 11341.43292835355, 11659.0, 12140.15018948665, 559182.0, 644312.0, 647730.0, 649327.0, 667252.0, 88804.0, 96211.0378896202, 124763.0, 125088.7491125077, 131813.34093329663, 979.0014185530719, 1010.4240582867695, 1013.6249587652616, 1045.3727763341933, 1049.5067318360511, 16596.336146554484, 18812.811871881106, 18955.0, 19023.429297121107, 19100.853948763117, 48531.27203092027, 50463.73840654013, 50545.49454505555, 51247.0, 51441.742791285804, 77491.61254193693, 80677.78983315373, 81245.0, 82877.0, 83416.58291708502, 7310.96344518274, 8307.335413167053, 8363.874541881998, 8448.577571121297, 8492.0, 9432.62269509212, 11351.659450216506, 13129.60611181666, 13254.469821207043, 13316.800247996094, 9790.51047447639, 11226.719332016764, 11517.0, 11557.0, 12015.819762703391, 11179.66461006171, 11302.610402746259, 11703.180777345504, 11759.000484958875, 11775.646730598095, 11562.88437115618, 11817.527298908291, 11919.821202681793, 11971.580994665144, 12044.75910481803, 8067.798305042421, 8389.338819041415, 8407.159284071544, 8520.74437766868, 8706.3034957202, 7028.648567571703, 10258.128059115059, 11724.413779311171, 11744.823827642764, 11893.345865977108], "value": 9638.005344530511, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1643.6383995520985, 1671.8578920791736, 1722.6813039587678, 2043.50955770615, 2085.8748475091506, 8156.959215203916, 8889.55552222388, 8973.820523589533, 9160.954195229024, 9214.032526584713, 9015.188633023026, 9065.546722663858, 9084.27325813935, 9145.908540914588, 9167.90832091679, 2544.75824796644, 2548.120898290087, 2554.3741783263035, 2572.369769406498, 2575.974240257592, 2506.8997240110466, 2553.2850801775535, 2571.3186005708503, 2579.1230981466297, 2586.7283935186815, 2282.82878784091, 2536.9112081077164, 2565.8973641054336, 2570.5373032854077, 2594.1050337633487, 2187.595294870454, 2564.3717289264064, 2566.2814411964678, 2569.4732579821093, 2570.498752743216, 2543.4531575711126, 2556.6804149481313, 2591.0, 2592.961105583418, 2594.4032872439443, 9344.112309330603, 9371.109744574254, 9377.484238366887, 9389.169112023159, 9392.201662858664, 5678.687672178028, 5681.57388195887, 5763.5101016413655, 5770.509506691894, 5816.243888294494, 3659.6340365963456, 3750.49368335274, 3797.7341586088983, 3804.3152232598122, 3812.4281357796276, 961.9466683981029, 1064.9307794993301, 1067.3542506783363, 1091.241587096968, 1105.0883021507289, 12147.878521214763, 12286.262824230664, 12506.249625022438, 12527.185732927423, 12560.309182994932, 4989.25161225819, 5031.4465408805, 5102.438731739506, 5150.175971844487, 5159.922601160985, 10354.326968747007, 10482.37105773656, 10526.368417894952, 10564.418956957441, 10579.94710026445, 5722.284714410699, 5771.076627739541, 5771.769129234867, 5793.275840519935, 5818.21454103699, 4292.313229883203, 4641.512641172696, 5140.254663073833, 5212.087884620252, 5227.790888364499, 4197.45433093702, 4233.386159006926, 4316.1583491219535, 4338.154059958278, 4344.391785150082, 1409.7110092431028, 1429.1353730992807, 1445.1762495377743, 1447.9276036198148, 1449.0725935401351, 957.4446820843893, 965.0783501755807, 969.3021024862088, 979.4123525884555, 990.7108400111704, 6081.604695694766, 6130.63216207029, 6186.969065154645, 6231.003039513656, 6289.55973081889, 419.6370139829026, 430.14830635342196, 495.2793685188043, 1027.7636143686843, 1050.7478205230843, 3926.332523471017, 3960.9009774755864, 3991.8004099794894, 4008.2183974124764, 4079.3676980068135, 10726.249162558703, 11084.833727494093, 11115.666530004113, 11134.832977505344, 11147.163962702667, 10615.575376984989, 10634.202434817265, 10683.09193718527, 10916.563337466412, 10972.957569030928, 8223.21879421454, 8553.016403113597, 8554.05905350411, 8595.65617375298, 8685.044645089036, 5996.940030599638, 6020.488258498077, 6053.334133245427, 6144.723487442986, 6164.660943648142, 9719.514024298614, 9854.802903941738, 9880.752981175528, 9937.006299370294, 9952.303338766216, 9581.377210481296, 9928.25538084661, 10048.0, 10176.592936282466, 10193.388396696222, 7051.153861536648, 7483.625818709152, 7706.229377062249, 7709.614519274126, 7889.723859664884, 8373.995120585569, 8513.702020429502, 8538.060813310654, 8570.228679418882, 8577.614007369808, 7458.216887226763, 7617.542947423172, 7637.083549974039, 7678.193789652006, 7682.193369696101, 7423.331900129015, 7474.514156579805, 7490.962545187239, 7598.012258406372, 7639.0, 7079.07971963662, 7106.0, 7168.8924666129005, 7223.061002069698, 7277.563346199245, 4942.604591632733, 4956.231784073474, 5047.621428392812, 5090.669106508065, 5124.231365295235, 5061.7469126544265, 5076.18780995039, 5081.72050537224, 5172.301739265151, 5288.3918349390315], "value": 4768.904050109194, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.4337555016617, 337.96282408934997, 340.23107776425286, 345.75624184949606, 351.2553386819942, 6939.61832099235, 6982.476314276437, 6984.790456286307, 6986.650667466625, 6988.790336289913, 6957.61733104679, 6972.721091156361, 6996.755113571026, 7008.194057683368, 7008.509404341698, 4841.225403935371, 4995.600351971833, 5121.513456221653, 5148.0, 5160.56135228506, 4426.313921342181, 4861.173600487926, 5108.8978220435565, 5129.846104616868, 5156.922646160292, 4301.892452688677, 4980.12847751642, 5117.872053198663, 5132.0, 5132.409772876111, 5123.513266239701, 5136.178211486163, 5155.046316431472, 5155.793768249284, 5167.250748641463, 4381.4961279452955, 4389.078293558357, 4394.274944634131, 4400.185965596375, 4411.669124815651, 5388.218708287276, 6317.526185536057, 6383.521235907279, 6656.134702488694, 6743.966280168617, 4894.853154405374, 5334.679919204821, 5944.64332140073, 5977.910331345033, 5977.940220597782, 7455.813604659873, 7460.365868901095, 7477.513961592479, 7482.700691972314, 7497.475176737576, 4768.833090841804, 4770.427548694144, 4771.570558649703, 4782.378290822206, 4784.40194975628, 7558.811029724246, 7853.175416581234, 7896.881546776803, 7932.603369831543, 7937.642806073741, 4094.7133700641266, 5004.949950500449, 5032.0, 5044.1677123274985, 5045.823396181116, 5094.337736094284, 5122.103631864409, 5128.640995130305, 5138.409082955433, 5162.251473536317, 5150.27896094547, 5897.555099000687, 6051.636901785907, 6065.484433823086, 6079.240094988127, 7411.925880741123, 7481.70073197066, 7482.4388170887405, 7485.887711684329, 7487.401007919353, 1743.1405105263307, 1747.4582879307454, 1767.328415202215, 1806.2955447375534, 1808.502661767998, 1144.7882141803793, 1152.464104191555, 1161.1291531351487, 1163.406662602079, 1169.999650298999, 7023.543469674455, 7105.111861017373, 7150.320719531636, 7159.713611455588, 7189.604571748604, 7487.251274872469, 7585.0, 7776.339011184, 7792.961035194901, 7813.062432508135, 6617.0, 6934.375906168469, 7114.893276600855, 7124.893126603001, 7153.785386438415, 4074.633283004544, 4137.855175068858, 4139.503259608806, 4148.108156746253, 4159.875203743893, 8236.958815205886, 8258.091609922903, 8262.091169971298, 8263.380900987266, 8310.792230194173, 7798.532088074734, 8076.596170191467, 8097.2712455879255, 8120.228578285053, 8125.471844330218, 8195.631196596167, 8207.753767386988, 8223.876641850376, 8225.876611850706, 8227.218414250636, 7807.453478256468, 7810.765677029698, 7814.648340824563, 7814.765557033298, 7816.687332506864, 7318.81702957409, 7639.159692433939, 7644.082710074605, 7648.770536883902, 7653.770386888402, 8222.424430289822, 8222.588870556569, 8225.753227402947, 8234.711785087493, 8241.83516329658, 5040.36995375578, 5048.1165795984825, 5093.1341671915125, 5095.898082038412, 5098.5411312982005, 7725.459217854921, 7729.652165652672, 7741.5742134183165, 7748.302652761278, 7765.1846556110795, 6019.398060193946, 7163.176234733072, 7454.850902982019, 7473.663685134291, 7487.588182650006, 6402.967985160044, 7009.929900701131, 7381.0, 7428.4800063995, 7445.739399121005, 7317.304856038668, 7326.487145899736, 7331.120265568166, 7332.120145582564, 7333.523320984119, 6013.6692481913915, 7462.514936529108, 7462.552246865205, 7474.738384156529, 7510.098788145458, 6276.9372306276355, 6752.459803215829, 7358.448116391399, 7376.668049937658, 7380.704771809067], "value": 5444.218135436299, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.9626570538625, 682.0689758479674, 757.148208265701, 787.5471603827797, 793.8134538383481, 16137.677246455078, 16198.514044578667, 17797.466076017707, 17798.555036124104, 17868.285268589272, 16036.278367473462, 16317.265723042461, 16629.50111496654, 16766.58083547912, 16886.662266754658, 790.9248621380959, 964.3587014635259, 969.6460791811008, 970.5001924009141, 972.0473935543137, 953.2421724728822, 988.3032462114228, 997.2271489595549, 999.3104757717189, 1002.959881604735, 1025.3232866308238, 1042.3329069395593, 1042.8331466965287, 1046.08467590858, 1046.3251202974077, 1027.6916924922493, 1031.1441503552035, 1032.3702541449709, 1034.6223628375665, 1036.4092467293647, 742.4691345687805, 752.713968691899, 768.2394429514796, 775.379696243009, 780.1886038519932, 16003.119828409433, 16008.359665613361, 16194.919025404797, 16222.269997850126, 16253.837461625351, 12739.42672579736, 12796.424160912688, 12841.67895802603, 12979.415926283245, 13207.40566674502, 10079.936051159117, 11183.496742646601, 11469.426528673617, 11571.710707232302, 11687.824682629767, 3194.2653189766484, 3312.585926759155, 3372.578427696538, 3584.7490675652716, 3869.1101046759404, 80002.0, 81249.0, 81354.0, 84109.0, 85699.0, 9377.906220937839, 9378.390404623678, 9417.62329506812, 9448.196903263299, 9764.902350976541, 19717.0, 20139.0, 20350.0, 20361.796382036286, 20370.59258814845, 7201.71193152268, 7338.046054012944, 7358.0495487188855, 7394.667239974106, 7484.513506622052, 4097.549269580344, 4173.08192197716, 4173.457450531411, 4191.3293872980175, 4193.412922190896, 3781.6785573226584, 3791.4881490998364, 3821.656050955372, 3827.78947157909, 3831.4061320495366, 533.751805410486, 588.485075558886, 677.8339306869849, 682.222266616058, 685.9279775623587, 578.4475825586554, 616.1374076293135, 625.6934102289936, 632.2476253258608, 635.9014352775328, 6838.863222735517, 8245.83508329842, 8287.751367458986, 8289.0, 8575.035271404222, 562.4066609726696, 600.5075837813039, 601.2691250788845, 612.6599737145838, 620.8044465993288, 3809.2191100824266, 3829.4830197922925, 3835.4055121455663, 3920.8080325838887, 4053.2906741320153, 63680.771173008725, 80339.59830200928, 83636.58181709053, 97048.0, 97500.0, 65953.35116622123, 70802.0, 74481.62759186169, 76547.0, 77704.61147694226, 66980.6650966742, 68387.65806171036, 68440.97338539927, 68502.65748671225, 68819.0, 6945.930540694529, 8267.751967440987, 8381.916180838114, 8446.873296900429, 8510.617022234139, 44232.0, 44253.45112921032, 45558.772206138754, 45594.632161035224, 48485.7878553039, 59302.22093337207, 61953.0, 62313.37686623257, 64203.03695444479, 64791.0, 11097.445127743742, 11150.944245278723, 11182.608608698656, 11264.929831665979, 11309.547618095185, 11996.940015299868, 12076.21504602198, 12076.75846483083, 12174.904258616767, 12609.43257553394, 11231.66305010851, 11298.4915678793, 11485.48315325829, 11826.645200643994, 11846.170768046153, 11285.379304138023, 11447.084233261485, 11486.138539609396, 11554.48004839801, 11804.586839460577, 11345.432728363383, 11355.0, 11475.139364547525, 11534.711632209262, 11989.160758746804, 9607.759806004906, 9610.471424071744, 9798.80402391934, 9832.0, 10054.497275136067, 9713.222942164752, 9840.409575425498, 9882.66584011178, 9943.453110079015, 9964.950175249078], "value": 7051.573139199198, "unit": "score"}], "name": "dromaeo_css", "value": 7601.3102534944655, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 159.0, 127.0, 117.0, 117.0, 116.0, 108.0, 134.0, 116.0, 117.0], "value": 127.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 144.0, 182.0, 105.0, 169.0, 150.0, 190.0, 180.0, 121.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 197.0, 197.0, 196.0, 193.0, 221.0, 267.0, 219.0, 199.0, 197.0], "value": 208.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 82.0, 76.0, 187.0, 53.0, 66.0, 85.0, 82.0, 136.0, 54.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 129.0, 78.0, 77.0, 82.0, 121.0, 81.0, 79.0, 121.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 122.0, 85.0, 89.0, 85.0, 89.0, 87.0, 88.0, 85.0], "value": 90.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 94.0, 94.0, 95.0, 104.0, 133.0, 94.0, 95.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 90.0, 117.0, 142.0, 90.0, 125.0, 146.0, 104.0, 142.0], "value": 113.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 65.0, 65.0, 63.0, 64.0, 66.0, 65.0, 77.0, 62.0, 60.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 64.0, 72.0, 75.0, 72.0, 70.0, 66.0, 66.0, 67.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 80.0, 81.0, 80.0, 81.0, 81.0, 80.0, 81.0, 84.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 142.0, 142.0, 119.0, 130.0, 135.0, 143.0, 151.0, 169.0, 173.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 178.0, 209.0, 176.0, 192.0, 216.0, 193.0, 163.0, 179.0], "value": 183.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 65.0, 68.0, 67.0, 69.0, 68.0, 67.0, 66.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1580.5999999999995, "alertThreshold": 2.0}]} 04:27:31 INFO - Return code: 0 04:27:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:27:31 ERROR - # TBPL SUCCESS # 04:27:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:27:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:27:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:27:31 INFO - 2016-07-07 04:27:31.779 screenresolution[1678:10604] starting screenresolution argv=screenresolution get 04:27:31 INFO - 2016-07-07 04:27:31.781 screenresolution[1678:10604] Display 0: 1600x1200x32@60 04:27:31 INFO - 2016-07-07 04:27:31.787 screenresolution[1679:10607] starting screenresolution argv=screenresolution list 04:27:31 INFO - Available Modes on Display 0 04:27:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:27:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:27:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:27:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:27:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:27:32 INFO - Intel Iris: 04:27:32 INFO - Chipset Model: Intel Iris 04:27:32 INFO - Type: GPU 04:27:32 INFO - Bus: Built-In 04:27:32 INFO - VRAM (Dynamic, Max): 1536 MB 04:27:32 INFO - Vendor: Intel (0x8086) 04:27:32 INFO - Device ID: 0x0a2e 04:27:32 INFO - Revision ID: 0x0009 04:27:32 INFO - Displays: 04:27:32 INFO - Display: 04:27:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:27:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:27:32 INFO - Display Serial Number: 1600x1200 60 04:27:32 INFO - Main Display: Yes 04:27:32 INFO - Mirror: Off 04:27:32 INFO - Online: Yes 04:27:32 INFO - Rotation: Supported 04:27:32 INFO - Return code: 0 04:27:32 INFO - Running post-action listener: _resource_record_post_action 04:27:32 INFO - Running post-run listener: _resource_record_post_run 04:27:33 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 38147584; Write bytes: 496998400; Read time: 383; Write time: 1649 04:27:33 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 189268480; Write bytes: 188200960; Read time: 17486; Write time: 543 04:27:33 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 36333056; Write bytes: 298004480; Read time: 363; Write time: 1071 04:27:33 INFO - Running post-run listener: _upload_blobber_files 04:27:33 INFO - Blob upload gear active. 04:27:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:33 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 04:27:33 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'] 04:27:33 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 04:27:33 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:27:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:34 INFO - (blobuploader) - INFO - Done attempting. 04:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:27:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:35 INFO - (blobuploader) - INFO - Done attempting. 04:27:35 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:35 INFO - Return code: 0 04:27:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/921313f1067bca71430f3237a2a84a13649b7009622bdccbcf736df4d429c3c07eedcaa7cb56b41d0a6c101dfca2cc6a7c51930a48b1f6218ceae1a435efbaf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f36377ff2193fa5c44dc8c6c5d2ae6d0486cae79a46f5decf4a4271d8dfc64324e8059809432614773ee9da2c01430f48b563d7885271f9d0a871e8d06349ff7"} 04:27:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:35 INFO - Contents: 04:27:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/921313f1067bca71430f3237a2a84a13649b7009622bdccbcf736df4d429c3c07eedcaa7cb56b41d0a6c101dfca2cc6a7c51930a48b1f6218ceae1a435efbaf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f36377ff2193fa5c44dc8c6c5d2ae6d0486cae79a46f5decf4a4271d8dfc64324e8059809432614773ee9da2c01430f48b563d7885271f9d0a871e8d06349ff7"} 04:27:35 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:35 INFO - Copying logs to upload dir... 04:27:35 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.870303 ========= master_lag: 0.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-07 04:27:36.267851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:36.271479) ========= 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.aRyuJsSn0n/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.kHomyi7uJD/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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/921313f1067bca71430f3237a2a84a13649b7009622bdccbcf736df4d429c3c07eedcaa7cb56b41d0a6c101dfca2cc6a7c51930a48b1f6218ceae1a435efbaf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f36377ff2193fa5c44dc8c6c5d2ae6d0486cae79a46f5decf4a4271d8dfc64324e8059809432614773ee9da2c01430f48b563d7885271f9d0a871e8d06349ff7"} build_url:https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/FeiigZlwTaKgLwp6GbYdWQ/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/921313f1067bca71430f3237a2a84a13649b7009622bdccbcf736df4d429c3c07eedcaa7cb56b41d0a6c101dfca2cc6a7c51930a48b1f6218ceae1a435efbaf2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f36377ff2193fa5c44dc8c6c5d2ae6d0486cae79a46f5decf4a4271d8dfc64324e8059809432614773ee9da2c01430f48b563d7885271f9d0a871e8d06349ff7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:36.309936) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:36.310294) ========= 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.aRyuJsSn0n/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.kHomyi7uJD/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005147 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:27:36.359088) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:27:36.359425) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:27:36.359798) ========= ========= Total master_lag: 0.63 =========