builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0303 starttime: 1466445258.15 results: success (0) buildid: 20160620091522 builduid: c39846555818425ba42f227235a9f59f revision: 9798772706750302d87a689cbbf056ae04244f80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:18.154120) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:18.154780) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:18.155077) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:18.184870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:18.185240) ========= 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.xIaipgqVtk/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.lrazNGPIQQ/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-20 10:54:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-06-20 10:54:18 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.625812 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:18.835726) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:18.836017) ========= 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.xIaipgqVtk/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.lrazNGPIQQ/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.025454 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:18.888338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 10:54:18.888724) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9798772706750302d87a689cbbf056ae04244f80 --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 9798772706750302d87a689cbbf056ae04244f80 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xIaipgqVtk/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.lrazNGPIQQ/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-20 10:54:18,975 truncating revision to first 12 chars 2016-06-20 10:54:18,975 Setting DEBUG logging. 2016-06-20 10:54:18,975 attempt 1/10 2016-06-20 10:54:18,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/979877270675?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 10:54:20,618 unpacking tar archive at: mozilla-beta-979877270675/testing/mozharness/ program finished with exit code 0 elapsedTime=1.973431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 10:54:20.883776) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:20.884198) ========= script_repo_revision: 9798772706750302d87a689cbbf056ae04244f80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:20.884666) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:20.885001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 10:54:20.903150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2016-06-20 10:54:20.903569) ========= /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.xIaipgqVtk/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.lrazNGPIQQ/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:54:21 INFO - MultiFileLogger online at 20160620 10:54:21 in /builds/slave/test 10:54:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:54:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:54:21 INFO - {'append_to_log': False, 10:54:21 INFO - 'base_work_dir': '/builds/slave/test', 10:54:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:54:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:54:21 INFO - 'branch': 'Mozilla-Beta', 10:54:21 INFO - 'buildbot_json_path': 'buildprops.json', 10:54:21 INFO - 'config_files': ('talos/mac_config.py',), 10:54:21 INFO - 'default_actions': ('clobber', 10:54:21 INFO - 'read-buildbot-config', 10:54:21 INFO - 'download-and-extract', 10:54:21 INFO - 'populate-webroot', 10:54:21 INFO - 'create-virtualenv', 10:54:21 INFO - 'install', 10:54:21 INFO - 'run-tests'), 10:54:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:54:21 INFO - 'download_minidump_stackwalk': True, 10:54:21 INFO - 'download_symbols': 'ondemand', 10:54:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:54:21 INFO - 'tooltool.py': '/tools/tooltool.py', 10:54:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:54:21 INFO - '/tools/misc-python/virtualenv.py')}, 10:54:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:54:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:54:21 INFO - 'installer_path': 'installer.exe', 10:54:21 INFO - 'log_level': 'info', 10:54:21 INFO - 'log_name': 'talos', 10:54:21 INFO - 'log_to_console': True, 10:54:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:54:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:54:21 INFO - 'opt_config_files': (), 10:54:21 INFO - 'pip_index': False, 10:54:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:54:21 INFO - 'cmd': ('bash', 10:54:21 INFO - '-c', 10:54:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:54:21 INFO - 'enabled': True, 10:54:21 INFO - 'halt_on_failure': False, 10:54:21 INFO - 'name': 'check_screen_resolution'},), 10:54:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:54:21 INFO - 'cmd': ('bash', 10:54:21 INFO - '-c', 10:54:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:54:21 INFO - 'enabled': True, 10:54:21 INFO - 'halt_on_failure': False, 10:54:21 INFO - 'name': 'check_screen_resolution'},), 10:54:21 INFO - 'run_cmd_checks_enabled': True, 10:54:21 INFO - 'sps_profile': False, 10:54:21 INFO - 'sps_profile_interval': 0, 10:54:21 INFO - 'suite': 'dromaeojs-e10s', 10:54:21 INFO - 'system_bits': '32', 10:54:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:54:21 INFO - 'title': 't-yosemite-r7-0303', 10:54:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:54:21 INFO - 'use_talos_json': True, 10:54:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:54:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:54:21 INFO - 'work_dir': 'build'} 10:54:21 INFO - ##### 10:54:21 INFO - ##### Running clobber step. 10:54:21 INFO - ##### 10:54:21 INFO - Running pre-action listener: _resource_record_pre_action 10:54:21 INFO - Running main action method: clobber 10:54:21 INFO - rmtree: /builds/slave/test/build 10:54:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:54:22 INFO - Running post-action listener: _resource_record_post_action 10:54:22 INFO - ##### 10:54:22 INFO - ##### Running read-buildbot-config step. 10:54:22 INFO - ##### 10:54:22 INFO - Running pre-action listener: _resource_record_pre_action 10:54:22 INFO - Running main action method: read_buildbot_config 10:54:22 INFO - Using buildbot properties: 10:54:22 INFO - { 10:54:22 INFO - "project": "", 10:54:22 INFO - "product": "firefox", 10:54:22 INFO - "script_repo_revision": "production", 10:54:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:54:22 INFO - "repository": "", 10:54:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:54:22 INFO - "buildid": "20160620091522", 10:54:22 INFO - "pgo_build": "False", 10:54:22 INFO - "basedir": "/builds/slave/test", 10:54:22 INFO - "buildnumber": 1, 10:54:22 INFO - "slavename": "t-yosemite-r7-0303", 10:54:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:54:22 INFO - "platform": "yosemite_r7", 10:54:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:54:22 INFO - "branch": "mozilla-beta", 10:54:22 INFO - "repo_path": "releases/mozilla-beta", 10:54:22 INFO - "revision": "9798772706750302d87a689cbbf056ae04244f80", 10:54:22 INFO - "stage_platform": "macosx64", 10:54:22 INFO - "builduid": "c39846555818425ba42f227235a9f59f", 10:54:22 INFO - "slavebuilddir": "test" 10:54:22 INFO - } 10:54:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 10:54:22 INFO - Running post-action listener: _resource_record_post_action 10:54:22 INFO - ##### 10:54:22 INFO - ##### Running download-and-extract step. 10:54:22 INFO - ##### 10:54:22 INFO - Running pre-action listener: _resource_record_pre_action 10:54:22 INFO - Running main action method: download_and_extract 10:54:22 INFO - mkdir: /builds/slave/test/build/tests 10:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:22 INFO - https://queue.taskcluster.net/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:54:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 10:54:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 10:54:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/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 10:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/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 10:54:52 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json: timed out 10:54:52 INFO - retry: attempt #1 caught exception: timed out 10:54:52 INFO - retry: Failed, sleeping 30 seconds before retrying 10:55:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/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 #2 10:55:25 INFO - Downloaded 1165 bytes. 10:55:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 10:55:25 INFO - Using the following test package requirements: 10:55:25 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 10:55:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:55:25 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 10:55:25 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:55:25 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 10:55:25 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:55:25 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:55:25 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 10:55:25 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 10:55:25 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:55:25 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 10:55:25 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:55:25 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 10:55:25 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:55:25 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 10:55:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 10:55:25 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 10:55:25 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 10:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:25 INFO - https://queue.taskcluster.net/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:55:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:55:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:55:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/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 10:55:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/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 10:55:26 INFO - Downloaded 18300396 bytes. 10:55:26 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'] 10:55:26 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 10:55:29 INFO - Return code: 0 10:55:29 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 10:55: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')]} 10:55:29 INFO - https://queue.taskcluster.net/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:55:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:55:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 10:55:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/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 10:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/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 10:55:30 INFO - Downloaded 18300396 bytes. 10:55:30 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'] 10:55:30 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 10:55:33 INFO - Return code: 0 10:55: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')]} 10:55:33 INFO - https://queue.taskcluster.net/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:55:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 10:55:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 10:55:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/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 10:55:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/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 10:55:34 INFO - Downloaded 10840145 bytes. 10:55:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:55:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:55:35 INFO - Return code: 0 10:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:35 INFO - https://queue.taskcluster.net/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 10:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PxTKtI7XT2OPLqp2CT2y9g/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 10:55:37 INFO - Downloaded 86251025 bytes. 10:55:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:55:37 INFO - mkdir: /builds/slave/test/properties 10:55:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:55:37 INFO - Writing to file /builds/slave/test/properties/build_url 10:55:37 INFO - Contents: 10:55:37 INFO - build_url:https://queue.taskcluster.net/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.dmg 10:55:38 INFO - Running post-action listener: _resource_record_post_action 10:55:38 INFO - Running post-action listener: set_extra_try_arguments 10:55:38 INFO - ##### 10:55:38 INFO - ##### Running populate-webroot step. 10:55:38 INFO - ##### 10:55:38 INFO - Running pre-action listener: _resource_record_pre_action 10:55:38 INFO - Running main action method: populate_webroot 10:55:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:55:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:55:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:55:38 INFO - '--tppagecycles', 10:55:38 INFO - '7'], 10:55:38 INFO - 'tests': ['tsvgm']}}, 10:55:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:55:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:55:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:55:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:55:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:55:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:55:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:38 INFO - 'talos_options': ['--disable-e10s'], 10:55:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:55:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:55:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:38 INFO - 'talos_options': ['--disable-e10s'], 10:55:38 INFO - 'tests': ['damp', 'tps']}, 10:55:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:38 INFO - 'tests': ['damp', 'tps']}, 10:55:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:55:38 INFO - 'tests': ['dromaeo_dom']}, 10:55:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:55:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:55:38 INFO - 'tests': ['a11yr', 10:55:38 INFO - 'ts_paint', 10:55:38 INFO - 'tpaint', 10:55:38 INFO - 'sessionrestore', 10:55:38 INFO - 'sessionrestore_no_auto_restore', 10:55:38 INFO - 'tabpaint']}, 10:55:38 INFO - 'other-e10s': {'tests': ['a11yr', 10:55:38 INFO - 'ts_paint', 10:55:38 INFO - 'tpaint', 10:55:38 INFO - 'sessionrestore', 10:55:38 INFO - 'sessionrestore_no_auto_restore', 10:55:38 INFO - 'tabpaint']}, 10:55:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:55:38 INFO - 'ts_paint', 10:55:38 INFO - 'tpaint', 10:55:38 INFO - 'sessionrestore', 10:55:38 INFO - 'sessionrestore_no_auto_restore', 10:55:38 INFO - 'tabpaint']}, 10:55:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:55:38 INFO - 'ts_paint', 10:55:38 INFO - 'tpaint', 10:55:38 INFO - 'sessionrestore', 10:55:38 INFO - 'sessionrestore_no_auto_restore', 10:55:38 INFO - 'tabpaint']}, 10:55:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:55:38 INFO - 'tests': ['a11yr', 10:55:38 INFO - 'ts_paint', 10:55:38 INFO - 'tpaint', 10:55:38 INFO - 'sessionrestore', 10:55:38 INFO - 'sessionrestore_no_auto_restore', 10:55:38 INFO - 'tabpaint']}, 10:55:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:55:38 INFO - 'tests': ['a11yr', 10:55:38 INFO - 'ts_paint', 10:55:38 INFO - 'tpaint', 10:55:38 INFO - 'sessionrestore', 10:55:38 INFO - 'sessionrestore_no_auto_restore', 10:55:38 INFO - 'tabpaint']}, 10:55:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:55:38 INFO - 'tests': ['tsvgx', 10:55:38 INFO - 'tsvgr_opacity', 10:55:38 INFO - 'tart', 10:55:38 INFO - 'tscrollx', 10:55:38 INFO - 'cart']}, 10:55:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:55:38 INFO - 'tsvgr_opacity', 10:55:38 INFO - 'tart', 10:55:38 INFO - 'tscrollx', 10:55:38 INFO - 'cart']}, 10:55:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:38 INFO - 'talos_options': ['--disable-e10s'], 10:55:38 INFO - 'tests': ['tp5o']}, 10:55:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:38 INFO - 'tests': ['tp5o']}, 10:55:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:38 INFO - 'talos_options': ['--disable-e10s', 10:55:38 INFO - '--xperf_path', 10:55:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:55:38 INFO - 'tests': ['tp5n']}, 10:55:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:38 INFO - 'talos_options': ['--xperf_path', 10:55:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:55:38 INFO - 'tests': ['tp5n']}}, 10:55:38 INFO - 'talos.zip': {'path': '', 10:55:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:55:38 INFO - Running post-action listener: _resource_record_post_action 10:55:38 INFO - ##### 10:55:38 INFO - ##### Running create-virtualenv step. 10:55:38 INFO - ##### 10:55:38 INFO - Running pre-action listener: _resource_record_pre_action 10:55:38 INFO - Running main action method: create_virtualenv 10:55:38 INFO - Creating virtualenv /builds/slave/test/build/venv 10:55:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:55:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:55:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:55:38 INFO - Using real prefix '/tools/python27' 10:55:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:55:39 INFO - Installing distribute.............................................................................................................................................................................................done. 10:55:42 INFO - Installing pip.................done. 10:55:42 INFO - Return code: 0 10:55:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:42 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 0x10e15ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd672d97660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dffae00>, '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 0x10de63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff5b20>, '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.xIaipgqVtk/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.lrazNGPIQQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:55:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xIaipgqVtk/Render', 10:55:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:42 INFO - 'HOME': '/Users/cltbld', 10:55:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:42 INFO - 'LOGNAME': 'cltbld', 10:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:42 INFO - 'MOZ_NO_REMOTE': '1', 10:55:42 INFO - 'NO_EM_RESTART': '1', 10:55:42 INFO - 'PAGER': '/bin/cat', 10:55:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:42 INFO - 'PWD': '/builds/slave/test', 10:55:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:42 INFO - 'SHELL': '/bin/bash', 10:55:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lrazNGPIQQ/Listeners', 10:55:42 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:55:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:42 INFO - 'USER': 'cltbld', 10:55:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:42 INFO - 'XPC_FLAGS': '0x0', 10:55:42 INFO - 'XPC_SERVICE_NAME': '0', 10:55:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:55:42 INFO - Cleaning up... 10:55:42 INFO - Return code: 0 10:55:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:42 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 0x10e15ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd672d97660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dffae00>, '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 0x10de63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff5b20>, '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.xIaipgqVtk/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.lrazNGPIQQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:55:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xIaipgqVtk/Render', 10:55:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:42 INFO - 'HOME': '/Users/cltbld', 10:55:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:42 INFO - 'LOGNAME': 'cltbld', 10:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:42 INFO - 'MOZ_NO_REMOTE': '1', 10:55:42 INFO - 'NO_EM_RESTART': '1', 10:55:42 INFO - 'PAGER': '/bin/cat', 10:55:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:42 INFO - 'PWD': '/builds/slave/test', 10:55:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:42 INFO - 'SHELL': '/bin/bash', 10:55:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lrazNGPIQQ/Listeners', 10:55:42 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:55:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:42 INFO - 'USER': 'cltbld', 10:55:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:42 INFO - 'XPC_FLAGS': '0x0', 10:55:42 INFO - 'XPC_SERVICE_NAME': '0', 10:55:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:42 INFO - Downloading/unpacking psutil>=0.7.1 10:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:55:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:46 INFO - Installing collected packages: psutil 10:55:46 INFO - Running setup.py install for psutil 10:55:46 INFO - building 'psutil._psutil_osx' extension 10:55:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:55:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:55:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:55:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:55:47 INFO - building 'psutil._psutil_posix' extension 10:55:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:55:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:55:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:55:47 INFO - ^ 10:55:47 INFO - 1 warning generated. 10:55:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:55:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:47 INFO - Successfully installed psutil 10:55:47 INFO - Cleaning up... 10:55:47 INFO - Return code: 0 10:55:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:47 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 0x10e15ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd672d97660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dffae00>, '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 0x10de63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff5b20>, '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.xIaipgqVtk/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.lrazNGPIQQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:55:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xIaipgqVtk/Render', 10:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:47 INFO - 'HOME': '/Users/cltbld', 10:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:47 INFO - 'LOGNAME': 'cltbld', 10:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:47 INFO - 'MOZ_NO_REMOTE': '1', 10:55:47 INFO - 'NO_EM_RESTART': '1', 10:55:47 INFO - 'PAGER': '/bin/cat', 10:55:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:47 INFO - 'PWD': '/builds/slave/test', 10:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:47 INFO - 'SHELL': '/bin/bash', 10:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lrazNGPIQQ/Listeners', 10:55:47 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:47 INFO - 'USER': 'cltbld', 10:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:47 INFO - 'XPC_FLAGS': '0x0', 10:55:47 INFO - 'XPC_SERVICE_NAME': '0', 10:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:55:50 INFO - Installing collected packages: mozsystemmonitor 10:55:50 INFO - Running setup.py install for mozsystemmonitor 10:55:50 INFO - Successfully installed mozsystemmonitor 10:55:50 INFO - Cleaning up... 10:55:50 INFO - Return code: 0 10:55:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:50 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 0x10e15ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd672d97660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dffae00>, '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 0x10de63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff5b20>, '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.xIaipgqVtk/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.lrazNGPIQQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xIaipgqVtk/Render', 10:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:50 INFO - 'HOME': '/Users/cltbld', 10:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:50 INFO - 'LOGNAME': 'cltbld', 10:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:50 INFO - 'MOZ_NO_REMOTE': '1', 10:55:50 INFO - 'NO_EM_RESTART': '1', 10:55:50 INFO - 'PAGER': '/bin/cat', 10:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:50 INFO - 'PWD': '/builds/slave/test', 10:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:50 INFO - 'SHELL': '/bin/bash', 10:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lrazNGPIQQ/Listeners', 10:55:50 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:50 INFO - 'USER': 'cltbld', 10:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:50 INFO - 'XPC_FLAGS': '0x0', 10:55:50 INFO - 'XPC_SERVICE_NAME': '0', 10:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:53 INFO - Downloading blobuploader-1.2.4.tar.gz 10:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:55:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:55:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:54 INFO - Downloading docopt-0.6.1.tar.gz 10:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:55:54 INFO - Installing collected packages: blobuploader, requests, docopt 10:55:54 INFO - Running setup.py install for blobuploader 10:55:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:55:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:55:54 INFO - Running setup.py install for requests 10:55:55 INFO - Running setup.py install for docopt 10:55:55 INFO - Successfully installed blobuploader requests docopt 10:55:55 INFO - Cleaning up... 10:55:55 INFO - Return code: 0 10:55:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55: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')]} 10:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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')]} 10:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:55 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 0x10e15ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd672d97660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dffae00>, '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 0x10de63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff5b20>, '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.xIaipgqVtk/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.lrazNGPIQQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:55:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xIaipgqVtk/Render', 10:55:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:55 INFO - 'HOME': '/Users/cltbld', 10:55:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:55 INFO - 'LOGNAME': 'cltbld', 10:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:55 INFO - 'MOZ_NO_REMOTE': '1', 10:55:55 INFO - 'NO_EM_RESTART': '1', 10:55:55 INFO - 'PAGER': '/bin/cat', 10:55:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:55 INFO - 'PWD': '/builds/slave/test', 10:55:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:55 INFO - 'SHELL': '/bin/bash', 10:55:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lrazNGPIQQ/Listeners', 10:55:55 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:55:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:55 INFO - 'USER': 'cltbld', 10:55:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:55 INFO - 'XPC_FLAGS': '0x0', 10:55:55 INFO - 'XPC_SERVICE_NAME': '0', 10:55:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:55:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-UEbzKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:55:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-WoeOaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:55:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-VksyS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:55:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-mEhsLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:55:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-RXEVvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:55:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-hpOIZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:55:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-4S6Y7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:55:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-cYL9sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:55:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-8zFaXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:55:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-hEi3UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:55:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-1pocqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:55:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-z_sAXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:55:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-wcnacG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:55:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ihg4Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:57 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-6gdkIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:55:57 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Pl4UAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:55:57 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-hG5PE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:55:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:55:57 INFO - Running setup.py install for manifestparser 10:55:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:55:57 INFO - Running setup.py install for mozcrash 10:55:57 INFO - Running setup.py install for mozdebug 10:55:57 INFO - Running setup.py install for mozdevice 10:55:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:55:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:55:57 INFO - Running setup.py install for mozfile 10:55:58 INFO - Running setup.py install for mozhttpd 10:55:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:55:58 INFO - Running setup.py install for mozinfo 10:55:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:55:58 INFO - Running setup.py install for mozInstall 10:55:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:55:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:55:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:55:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:55:58 INFO - Running setup.py install for mozleak 10:55:58 INFO - Running setup.py install for mozlog 10:55:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:55:58 INFO - Running setup.py install for moznetwork 10:55:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:55:58 INFO - Running setup.py install for mozprocess 10:55:59 INFO - Running setup.py install for mozprofile 10:55:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:55:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:55:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:55:59 INFO - Running setup.py install for mozrunner 10:55:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:55:59 INFO - Running setup.py install for mozscreenshot 10:55:59 INFO - Running setup.py install for moztest 10:55:59 INFO - Running setup.py install for mozversion 10:55:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:55:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:55:59 INFO - Cleaning up... 10:55:59 INFO - Return code: 0 10:55:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:59 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 0x10e15ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd672d97660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dffae00>, '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 0x10de63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff5b20>, '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.xIaipgqVtk/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.lrazNGPIQQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xIaipgqVtk/Render', 10:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:59 INFO - 'HOME': '/Users/cltbld', 10:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:59 INFO - 'LOGNAME': 'cltbld', 10:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:59 INFO - 'MOZ_NO_REMOTE': '1', 10:55:59 INFO - 'NO_EM_RESTART': '1', 10:55:59 INFO - 'PAGER': '/bin/cat', 10:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:59 INFO - 'PWD': '/builds/slave/test', 10:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:59 INFO - 'SHELL': '/bin/bash', 10:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lrazNGPIQQ/Listeners', 10:55:59 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:59 INFO - 'USER': 'cltbld', 10:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:59 INFO - 'XPC_FLAGS': '0x0', 10:55:59 INFO - 'XPC_SERVICE_NAME': '0', 10:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:00 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-6gQDXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:00 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-g84X0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:00 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-M6K2Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:00 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-KzrwAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:00 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Qonsq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:00 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-RT3SUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:00 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-CGbPxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:00 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ezyZLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:00 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-fqylIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:01 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ikLO_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:01 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Q55frc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:01 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ceSi4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:01 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-sUix4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:56:01 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-tA5Q6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:01 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-4bJZ5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:56:01 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-swbLYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:56:01 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-JKoabj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:56:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:04 INFO - Downloading blessings-1.6.tar.gz 10:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:56:04 INFO - Installing collected packages: blessings 10:56:04 INFO - Running setup.py install for blessings 10:56:04 INFO - Successfully installed blessings 10:56:04 INFO - Cleaning up... 10:56:04 INFO - Return code: 0 10:56:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:56:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:56:04 INFO - Reading from file tmpfile_stdout 10:56:04 INFO - Current package versions: 10:56:04 INFO - blessings == 1.6 10:56:04 INFO - blobuploader == 1.2.4 10:56:04 INFO - docopt == 0.6.1 10:56:04 INFO - manifestparser == 1.1 10:56:04 INFO - mozInstall == 1.12 10:56:04 INFO - mozcrash == 0.17 10:56:04 INFO - mozdebug == 0.1 10:56:04 INFO - mozdevice == 0.48 10:56:04 INFO - mozfile == 1.2 10:56:04 INFO - mozhttpd == 0.7 10:56:04 INFO - mozinfo == 0.9 10:56:04 INFO - mozleak == 0.1 10:56:04 INFO - mozlog == 3.1 10:56:04 INFO - moznetwork == 0.27 10:56:04 INFO - mozprocess == 0.22 10:56:04 INFO - mozprofile == 0.28 10:56:04 INFO - mozrunner == 6.11 10:56:04 INFO - mozscreenshot == 0.1 10:56:04 INFO - mozsystemmonitor == 0.0 10:56:04 INFO - moztest == 0.7 10:56:04 INFO - mozversion == 1.4 10:56:04 INFO - psutil == 3.1.1 10:56:04 INFO - requests == 1.2.3 10:56:04 INFO - wsgiref == 0.1.2 10:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e15ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd672d97660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dffae00>, '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 0x10de63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff5b20>, '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.xIaipgqVtk/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.lrazNGPIQQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:56:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xIaipgqVtk/Render', 10:56:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:04 INFO - 'HOME': '/Users/cltbld', 10:56:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:04 INFO - 'LOGNAME': 'cltbld', 10:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:04 INFO - 'MOZ_NO_REMOTE': '1', 10:56:04 INFO - 'NO_EM_RESTART': '1', 10:56:04 INFO - 'PAGER': '/bin/cat', 10:56:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:04 INFO - 'PWD': '/builds/slave/test', 10:56:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:04 INFO - 'SHELL': '/bin/bash', 10:56:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lrazNGPIQQ/Listeners', 10:56:04 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:56:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:04 INFO - 'USER': 'cltbld', 10:56:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:04 INFO - 'XPC_FLAGS': '0x0', 10:56:04 INFO - 'XPC_SERVICE_NAME': '0', 10:56:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:56:05 INFO - Cleaning up... 10:56:05 INFO - Return code: 0 10:56:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:05 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 0x10e15ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd672d97660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dffae00>, '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 0x10de63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff5b20>, '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.xIaipgqVtk/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.lrazNGPIQQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xIaipgqVtk/Render', 10:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:05 INFO - 'HOME': '/Users/cltbld', 10:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:05 INFO - 'LOGNAME': 'cltbld', 10:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:05 INFO - 'MOZ_NO_REMOTE': '1', 10:56:05 INFO - 'NO_EM_RESTART': '1', 10:56:05 INFO - 'PAGER': '/bin/cat', 10:56:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:05 INFO - 'PWD': '/builds/slave/test', 10:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:05 INFO - 'SHELL': '/bin/bash', 10:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lrazNGPIQQ/Listeners', 10:56:05 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:05 INFO - 'USER': 'cltbld', 10:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:05 INFO - 'XPC_FLAGS': '0x0', 10:56:05 INFO - 'XPC_SERVICE_NAME': '0', 10:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:05 INFO - Downloading/unpacking jsonschema 10:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:56:07 INFO - Downloading/unpacking functools32 (from jsonschema) 10:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:08 INFO - Downloading functools32-3.2.3-2.tar.gz 10:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:56:08 INFO - warning: no files found matching '*.txt' 10:56:08 INFO - no previously-included directories found matching 'build' 10:56:08 INFO - no previously-included directories found matching 'dist' 10:56:08 INFO - no previously-included directories found matching '.git*' 10:56:08 INFO - Installing collected packages: jsonschema, functools32 10:56:08 INFO - Running setup.py install for functools32 10:56:08 INFO - warning: no files found matching '*.txt' 10:56:08 INFO - no previously-included directories found matching 'build' 10:56:08 INFO - no previously-included directories found matching 'dist' 10:56:08 INFO - no previously-included directories found matching '.git*' 10:56:08 INFO - Successfully installed jsonschema functools32 10:56:08 INFO - Cleaning up... 10:56:08 INFO - Return code: 0 10:56:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:08 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 0x10e15ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e16b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd672d97660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dffae00>, '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 0x10de63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff5b20>, '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.xIaipgqVtk/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.lrazNGPIQQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:56:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xIaipgqVtk/Render', 10:56:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:08 INFO - 'HOME': '/Users/cltbld', 10:56:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:08 INFO - 'LOGNAME': 'cltbld', 10:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:08 INFO - 'MOZ_NO_REMOTE': '1', 10:56:08 INFO - 'NO_EM_RESTART': '1', 10:56:08 INFO - 'PAGER': '/bin/cat', 10:56:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:08 INFO - 'PWD': '/builds/slave/test', 10:56:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:08 INFO - 'SHELL': '/bin/bash', 10:56:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lrazNGPIQQ/Listeners', 10:56:08 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:56:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:08 INFO - 'USER': 'cltbld', 10:56:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:08 INFO - 'XPC_FLAGS': '0x0', 10:56:08 INFO - 'XPC_SERVICE_NAME': '0', 10:56:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:08 INFO - Downloading/unpacking flake8 10:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:56:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:56: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 10:56: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 10:56: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 10:56: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 10:56: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 10:56: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 10:56:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:56:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:56: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 10:56: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 10:56: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 10:56: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 10:56: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 10:56: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 10:56:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:56:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:56:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:56:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:56:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:56:12 INFO - no previously-included directories found matching 'docs/_build' 10:56:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:56:12 INFO - Running setup.py install for pep8 10:56:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:56:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:56:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:56:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:56:12 INFO - no previously-included directories found matching 'docs/_build' 10:56:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:56:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:56:12 INFO - Cleaning up... 10:56:13 INFO - Return code: 0 10:56:13 INFO - Running post-action listener: _resource_record_post_action 10:56:13 INFO - Running post-action listener: _start_resource_monitoring 10:56:13 INFO - Starting resource monitoring. 10:56:13 INFO - ##### 10:56:13 INFO - ##### Running install step. 10:56:13 INFO - ##### 10:56:13 INFO - Running pre-action listener: _resource_record_pre_action 10:56:13 INFO - Running main action method: install 10:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:56:13 INFO - Reading from file tmpfile_stdout 10:56:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:56:13 INFO - Reading from file tmpfile_stdout 10:56:13 INFO - Output received: 10:56:13 INFO - Usage: mozinstall [options] installer 10:56:13 INFO - Options: 10:56:13 INFO - -h, --help show this help message and exit 10:56:13 INFO - -d DEST, --destination=DEST 10:56:13 INFO - Directory to install application into. [default: 10:56:13 INFO - "/builds/slave/test"] 10:56:13 INFO - --app=APP Application being installed. [default: firefox] 10:56:13 INFO - mkdir: /builds/slave/test/build/application 10:56:13 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'] 10:56:13 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 10:56:35 INFO - Reading from file tmpfile_stdout 10:56:35 INFO - Output received: 10:56:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:56:35 INFO - Running post-action listener: _resource_record_post_action 10:56:35 INFO - ##### 10:56:35 INFO - ##### Running run-tests step. 10:56:35 INFO - ##### 10:56:35 INFO - Running pre-action listener: _resource_record_pre_action 10:56:35 INFO - Running main action method: run_tests 10:56:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:56:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:56:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:56:35 INFO - 2016-06-20 10:56:35.235 screenresolution[1651:8305] starting screenresolution argv=screenresolution get 10:56:35 INFO - 2016-06-20 10:56:35.238 screenresolution[1651:8305] Display 0: 1600x1200x32@60 10:56:35 INFO - 2016-06-20 10:56:35.244 screenresolution[1652:8307] starting screenresolution argv=screenresolution list 10:56:35 INFO - Available Modes on Display 0 10:56:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:56:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:56:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:56:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:56:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:56:35 INFO - Intel Iris: 10:56:35 INFO - Chipset Model: Intel Iris 10:56:35 INFO - Type: GPU 10:56:35 INFO - Bus: Built-In 10:56:35 INFO - VRAM (Dynamic, Max): 1536 MB 10:56:35 INFO - Vendor: Intel (0x8086) 10:56:35 INFO - Device ID: 0x0a2e 10:56:35 INFO - Revision ID: 0x0009 10:56:35 INFO - Displays: 10:56:35 INFO - Display: 10:56:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:56:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:56:35 INFO - Display Serial Number: 1600x1200 60 10:56:35 INFO - Main Display: Yes 10:56:35 INFO - Mirror: Off 10:56:35 INFO - Online: Yes 10:56:35 INFO - Rotation: Supported 10:56:35 INFO - Return code: 0 10:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:56:35 INFO - Python 2.7.3 10:56:35 INFO - Return code: 0 10:56:35 INFO - grabbing minidump binary from tooltool 10:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:35 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 0x10dffae00>, '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 0x10de63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:56:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:56:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:56:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:56:35 INFO - Return code: 0 10:56:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:56:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:56:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:56:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:56:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:56:36 INFO - Return code: 0 10:56:36 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/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:56:36 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/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0303 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:56:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xIaipgqVtk/Render', 10:56:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:36 INFO - 'HOME': '/Users/cltbld', 10:56:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:36 INFO - 'LOGNAME': 'cltbld', 10:56:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:56:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:36 INFO - 'MOZ_NO_REMOTE': '1', 10:56:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:56:36 INFO - 'NO_EM_RESTART': '1', 10:56:36 INFO - 'PAGER': '/bin/cat', 10:56:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:36 INFO - 'PWD': '/builds/slave/test', 10:56:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:56:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:36 INFO - 'SHELL': '/bin/bash', 10:56:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lrazNGPIQQ/Listeners', 10:56:36 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 10:56:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:36 INFO - 'USER': 'cltbld', 10:56:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:36 INFO - 'XPC_FLAGS': '0x0', 10:56:36 INFO - 'XPC_SERVICE_NAME': '0', 10:56:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:36 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/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:56:36 INFO - mozversion application_buildid: 20160620091522 10:56:36 INFO - mozversion application_changeset: 9798772706750302d87a689cbbf056ae04244f80 10:56:36 INFO - mozversion application_display_name: Firefox 10:56:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:56:36 INFO - mozversion application_name: Firefox 10:56:36 INFO - mozversion application_remotingname: firefox 10:56:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:56:36 INFO - mozversion application_vendor: Mozilla 10:56:36 INFO - mozversion application_version: 48.0 10:56:36 INFO - mozversion platform_buildid: 20160620091522 10:56:36 INFO - mozversion platform_changeset: 9798772706750302d87a689cbbf056ae04244f80 10:56:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:56:36 INFO - mozversion platform_version: 48.0 10:56:36 INFO - using testdate: 1466445396 10:56:36 INFO - actual date: 1466445396 10:56:36 INFO - starting webserver on 'localhost:49276' 10:56:36 INFO - SUITE-START | Running 2 tests 10:56:36 INFO - TEST-START | dromaeo_css 10:56:36 INFO - operating with platform_type : mac_ 10:56:36 INFO - Initialising browser for dromaeo_css test... 10:56:37 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpoXTg4I/profile http://localhost:49276/getInfo.html) 10:56:39 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 10:56:39 INFO - PROCESS | 1670 | colorDepth:24 10:56:39 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 10:56:39 INFO - PROCESS | 1670 | __metrics 10:56:39 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 10:56:40 INFO - TEST-INFO | 1670: exit 0 10:56:40 INFO - Browser initialized. 10:56:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:56:40 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpoXTg4I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:56:52 INFO - PROCESS | 1675 | RSS: Main: 171008000 10:56:52 INFO - PROCESS | 1675 | 10:57:41 INFO - PROCESS | 1675 | 1466445461886 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] 10:59:51 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 10:59:53 INFO - PROCESS | 1675 | RSS: Main: 182108160 10:59:53 INFO - PROCESS | 1675 | 11:02:55 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 11:02:55 INFO - PROCESS | 1675 | RSS: Main: 192548864 11:02:55 INFO - PROCESS | 1675 | 11:05:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 11:05:58 INFO - PROCESS | 1675 | RSS: Main: 194707456 11:05:58 INFO - PROCESS | 1675 | 11:08:59 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 11:09:00 INFO - PROCESS | 1675 | RSS: Main: 198393856 11:09:00 INFO - PROCESS | 1675 | 11:12:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 11:12:03 INFO - PROCESS | 1675 | RSS: Main: 197570560 11:12:03 INFO - PROCESS | 1675 | 11:15:05 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 11:15:06 INFO - PROCESS | 1675 | RSS: Main: 203284480 11:15:06 INFO - PROCESS | 1675 | 11:15:06 INFO - PROCESS | 1675 | __start_tp_report 11:15:06 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 11:15:06 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 11:15:06 INFO - PROCESS | 1675 | |i|pagename|runs| 11:15:06 INFO - PROCESS | 1675 | |0;dojo.html;2953.763698904087;3665.725070619704;3678.6505281998234;3719.2003719200366;3725.1618385863176;5568.693721845297;5784.942150578493;5795.2466179396615;5797.449242321984;5817.796377126801;5791;5801.680907550083;5812.883742325151;5821.097729851869;5824.563157763174;5223.216517522383;5285.7885684572575;5299.284596579451;5316.3620365556;5326.174442961328;5231.633785634988;5271.314729085233;5287.762050707727;5348.090824559834;5355.919661205085;5327.813526526573;5329.546988505982;5329.946700533003;5330.840074797762;5360.035193665139;4292.33468812333;5170.1986192140275;5273.789048438058;5279.472052794728;5358.973205133969;5106.66806657566;5222.086134926372;5223.37319521656;5261.026710058613;5261.500157485071;5569.303837020372;5678.290213723285;5701.002324593221;5731.254936858223;5749.798757043525;6182.072689096626;6196.845078873019;6264.123022776815;6270.2789179244055;6285.245770507523;6207.068939659042;6250.312465628777;6251.624902505819;6264.123022776815;6266.624002559861;5899.259718383088;5909.940900590982;5922.186961193442;5958.493528050078;5960.0761881908375;6214.316425193225;6291.905621415683;6299.370062993664;6334.5249106317215;6334.619922804646;6171.660558669317;6220.471259942956;6234.127222188807;6241.781537646251;6258.405451482102;6249.156363890907;6273.529485288622;6285.811425657238;6299.086632438362;6305.96847015762;6142.447179753844;6181.505479561624;6245.406686364788;6268;6296.905546416808;6236.18929539157;6238.625682459067;6258.812235632939;6263.154474145932;6393.712282947278;5002.1496345621335;5071.96024814912;5074.898502029939;5087.211482220262;5123.590112790967;4477.7984990675495;4516.435445569304;4526.864194074183;4615.630749540029;4689.062187562433;5900.675462849585;5967.343592204854;5986.311574169026;6066.272047354346;6075.513958883279;5198.792048318101;6200.720967556471;6205.503559715212;6263.561550691499;6292.119103325538;5989.431004054608;6072.453479186895;6116.274903966718;6143.143438301211;6161.907571386433;4715.363425937455;4957.182064959241;5154.639175257771;5178;5511.145772405283;5883.529317654577;6420.6147631142285;6595.4393876521035;6606.042123892009;6627.900581491282;6166.568340216142;6167.198264225622;6217.347178546188;6239;6270.7491700331475;5564.777408903598;6625.204975402982;6647.867042659023;6655.367740064686;6696.799096026932;6112.908306375319;6190.350013248544;6199.132121503083;6203.286622038523;6213.440790328892;6178.938210617836;6204.472619827185;6234;6265.4361107500545;6270;6021.789237376671;6090.543209259412;6176.505879529537;6199.845003874939;6210.844728881814;5211.827338848729;6030.3668114847305;6144.508439324933;6178.691065446799;6208.906866397098;5802;6040.577159598786;6076.33160352352;6100.511959043355;6108.633481990917;4853.95146048535;6218.62688238689;6229.595076320024;6237.1891654084675;6260.530460215593;6012.098185272069;6012.729427175875;6094.573379863367;6118.040554665137;6137.202163718688 11:15:06 INFO - PROCESS | 1675 | |1;ext.html;524.6720799500313;531.1053115101766;562.2381672833308;571.9199312096307;601.0653433910269;35518.46722299165;41147.38278925818;41282.38076428856;41417.171656566854;41533.96165095871;42006.57993420065;42378;42546;42619.14761704772;42621;8834.718965749962;9604.3757155785;9695.127438530531;9923.702288931343;9935.552900119475;9983.950080249588;9987.300888937778;9996.650117245897;9997.250206234525;10020.198384129251;10107.343022703537;10123.29136960413;10145.543450544743;10170.440625765617;10208.234382421311;9833.31166818323;10076.345037572608;10144.137748291405;10159.390436573829;10170.237232207613;9802.803943921082;9828.459434731087;9909.454979976099;9916.405015699009;9926.45404502752;41207.79396103;41244;41936.16127677429;41950;42395.576044239475;2828.188306969432;3104.30153215527;3331.3670402623425;3357.613874404426;3367.5958884933966;27050.594241086204;27270.863645681646;27552.586711199347;27569;27787.72212277892;2696.4876673431986;2719.184244726594;2779.7915156363356;2819.873105710248;2872.4255148970287;354948.22525887465;354957;357450;358474;359105;37699.62300376961;38375.616243837205;65008.02487962684;65693;65709;36724.81637591848;36891.4466283006;37018.25963480715;37037.25925481475;37048;16106.838931610768;16585.17074146288;16761.7485737714;16859.83140168607;16864;13884.166949983033;13955.58133256004;13970.860291397159;14230.857691422952;14350.067245629001;8378.287845533076;8596.183362580545;8597.226249637437;8613.741587752378;8651.740447786577;3414.1123307940115;3614.493970844084;3654.3604869147794;3656.7805931643657;3663.413853783435;889.4040992535017;969.3553786731885;978.7944531648291;1112.2547892911768;1175.4122938530734;26986.865065674938;31199.22001949924;31309.373812524078;31877;31939.201519962186;1126.8028095083328;1144.822552504363;1159.7300955453766;1225.0995518294046;1253.1541209683428;15827.208639568205;15981.299114692085;16003.839961600468;16226.594335141715;16265.443765792019;588237;664135;664353;671368.6431567811;671433;52989;63008.424789379715;63703.6814815923;65911.6817663644;65997.34002660008;1530.2195880101451;1548.6902619475925;1554.7279226135606;1556;1563.491865143833;29069.418611628073;30503.847480762455;31093.689063109985;31553.053408396867;31710.841445793547;51996;52245.69385765386;52322;52336.214956774915;52396.21405678842;585918;589645;593056;595951;597498;28519.144425667262;28960.42079158363;44867.775661121486;45771.31343029924;46866.062678746915;45581.54418455773;45753.31370029385;46194;46286.07427851491;47273.527264726916;34869.825650871586;35739.46390804192;35795.284094317445;36104.097397565274;36219.27561448809;37160.256794864494;37331.626683732815;37807.81096094612;38053.85838424852;38102.80948595239;33379;34339.14152146217;39711.80144099261;41294.1741165181;41920;32473.837630811693;33978.49032264567;34178.31643367169;34317.48523772195;34565.65434345624;25428.364290892874;26158.86920565461;26258.86870565635;26267.21198364052;26270.34324141835 11:15:06 INFO - PROCESS | 1675 | |2;jquery.html;389.9571047184811;394.731582523884;398.6730880677844;399.20956506117903;402.17955371043064;15860.603484912883;20772.480687982807;21339.146434142614;21347.252846150386;21412.357629271108;20714.89642551785;20986.475338116554;21072.789272107275;21087.68368474474;21826.23608173714;5356.276902618155;5961.582689211757;6179.134921111048;6186.041163619624;6228.532860035492;6095.878082438348;6144.692765361737;6199.845003874894;6223.968880155593;6229.844253893666;5938.524918006549;6134.693265336738;6154.692265386735;6165.845853853644;6211.285702144243;5956.9873121569435;6006.279246490405;6049.969750151243;6057.697115144269;6080.0575910733905;5276.92084618731;5278.10272253714;5278.81524146653;5566.471185237437;5588.189712491707;12562.937185314106;12786.360681965865;12904.483820647256;16428.507144785675;26603.733962660513;2183.4977955070262;2215.3796936857543;2299.5745787029455;2324.569954558412;2342.980803350548;7796.571188584626;9374.765630859214;9459;9534.250380725141;9769.413835169842;1781.5100847266976;1781.5278951077976;1781.732740088984;1803.4950213940117;1806.9819301806945;118111;120093.39953300265;123564.38217808944;123665;124738.37630811878;11077.889221107847;11278.210525263154;11299.435028248554;11317.547298108148;11515.19393642437;11440.9703126719;11479.827802582968;13163.934180329037;13791.379387927367;13876.375563099684;7387.113546374362;8203.8359232815;8986.14631609996;9038.09619038091;9104.543273076408;7680.577568233689;9402.905970940203;9524.285678574135;9552.57013434397;9562.61749530011;4313.568643135662;4348.499922508889;4349.217140914666;4350.760708161081;4384.693071484965;1671.3314674130202;1828.542864283929;1908.7518622579253;1909.5035290824485;1937.7093435984716;841.6717480182733;941.6798288581915;989.1345073061071;1026.3790406803926;1037.3568387599585;19732.802671973383;21483.851614838703;21543.67684484734;21815.67276490854;21945.561088778137;996.0537489384968;1015.669907280137;1020.0870221152028;1047.2930771729204;1067.8611780468489;8903.465792052368;9303.627854885865;11353.318800871974;11408.721271661361;11496.482658280398;606155;640761;650196;661762;671406;96130;114939.42530287294;119092.40453797675;121885;130016.69983300235;983.4099540275778;1017.5065093429681;1038.0709265207597;1038.325088692356;1039.9116075133547;19071.809281907004;19539.609207816047;19583.70624440663;19869.801301986794;19901.947134987025;51012.74493627508;51440.48559514357;52869.47130528645;53346;53607.731961339945;80982;82723.3455330902;83072;83537.16462835294;84160;7641.541507509567;7832.412569057457;7855.960720196591;8003.839923201387;8087.8382432349845;12366.938165309115;12857.357132143168;12903.354832258537;12955.740885182055;13014.869851301744;11157.832632510681;11223;11322.358258052702;11430.085593152362;11599.594014209462;10512.632057877938;10561.732592088998;11184.664460066211;11363.886361136614;11414.258073225214;8998.82002359936;11704.005159561533;11724.237924534878;11929.880701193224;11982.880171198176;7765.805854853674;7812.453128280966;7934;8031.83936321282;8060.395470339865;11278.661640150809;11295.039921606756;11399.829002564802;11641.59254426091;11749.941250293694 11:15:06 INFO - PROCESS | 1675 | |3;mootools.html;1564.4837203722768;1583.643680171961;1650.2326418215528;2042.2545770793665;2115.8413119016077;7954.5227286362715;8531.445456045352;8640.35197360198;8830.558472076395;8848.424852384598;8881.60032798524;8894.288456923447;8982.19160275575;8995.550222488882;9005.414648047888;2388.1880160745345;2400.159944019588;2407.987960060197;2410.819188560856;2417.6373543968457;2452.852828830267;2461.3723500507344;2464.18681834994;2497.4880149569294;2514.6479492871013;2418.1536462238164;2483.7640424159677;2490.0413340863806;2499.4251322195814;2502.399424138212;2039.2149022626322;2492.5762620354585;2498.2879879234333;2504.161106029482;2521.697396312436;2491.215267190847;2515.7735803777746;2526.608375701751;2537.2134638262196;2537.429078457351;8954.2836573074;9129.315301352359;9182.403143795633;9200.585973631203;9371.906280937239;5575.860603484945;5585.888282234373;5597.972010139964;5632.493075623172;5737.827865164052;3123.5470856725874;3526.5239192708914;3637.727170462226;3661.9816900915325;3695.704343652528;1000.2947921715173;1004.9949750251202;1010.1312870930993;1015.827309357411;1026.6406757634843;12349.876501234963;12357.629271121881;12395.504179832797;12404;12407.813882791765;4910.582600478928;4980.427250866124;5037.219231019198;5050.621203409759;5055.317532133188;10443.791124177475;10519.631812886511;10533.473326333653;10566.996135367128;10568.101711354468;5532.17017447378;5540.722963851791;5565.7217139143695;5691.544676425876;5726.112452569859;4560.247559152703;4983.651144419856;5028.522290382408;5105.744712764347;5168.7415629218385;4176;4208;4221.838994276599;4233.364995250676;4259.9574004260185;1329.2489743295007;1341.2354957674227;1353.4315587453293;1353.9255340956342;1357.1382172320648;919.8666193402053;958.9232861371073;976.2092704909046;981.1562056631292;1011.9627381933577;5085.720285384339;5945.16767652529;6035.818925432244;6206.224221972254;6277.403646653561;436.6681322195154;446.51107037793565;446.5869071109276;446.7297285142507;447.83653966302063;3732.925341493155;3840.1743625120175;4063.187362527506;4067.898302542401;4152.626263636287;10650.988156125155;10723.981221783917;11021.559137634566;11082.335059896432;11152.60965866207;10911.345319280868;10944;11009.504572294267;11043.337399756041;11050.447477626087;8241.464304820287;8261.339092872557;8517.190866867637;8582.626779715216;8613.138686131337;5755.740991655469;5906.586538942232;6056.212692349966;6058.57589968698;6140.969295153495;9493.477858717837;9583.856242156513;9637;9716.028397160228;9812.411255324703;8243.546604936786;9622.566984485855;9702.660406885725;9714.514274286399;10052.246081543768;6155.846103847261;7043.823904402431;7721.112072111779;7748.186440423674;7852.489588176751;8457.661693532436;8469.322454203771;8507.404481686222;8522.318214542945;8535.06114327411;6361.936380636134;7581.469297149147;7621.085469743666;7742.187070357531;7766.805829854299;6267;7370.189279179393;7391.0761154855645;7411.629418528944;7556.395488360808;6075;7101.431885449048;7136.785896423115;7173.892391614026;7204.783856484314;3665.5601327839763;4514.638828893615;4905.754712264301;5080.441151473261;5080.568151707146;5083.6187285952965;5118.923216151687;5139.743012849417;5177.378714554277;5303.7878484860175 11:15:06 INFO - PROCESS | 1675 | |4;prototype.html;262.34675657612553;321.09131158820543;324.13779346937145;332.3369877095195;336.3122414662016;5370.462953704632;6700.631465269408;6744.898826517606;6786.389224969752;6787.28733482984;5860.76556937723;6658.500612454061;6712;6715.664216789153;6716.261211266757;4572.954270457294;4748;4871.658983871131;4878.243872199797;4897.579701886449;4993.900121997558;4999;5033.270175824503;5044.268581055745;5066.341375621182;4812.663113582051;4877.268729511467;4904.313396124546;4943.233798761198;4959.983203443286;4925.965547235085;4933.654644174909;4934.753262336869;4934.876628084291;4953.678010929314;3427.674370934757;4168.979155104235;4171.937420938689;4176.206520761076;4191.455110835572;6080.30076541199;6334.968325158345;6356.269029061625;6369.808905732835;6396.680165991682;5623.578231632644;5661.264035675377;5661.886762264731;5662.320521537442;5680.31836179657;6146.78486252979;6861.794146175573;7190.101237345332;7230.0239467672245;7252.9637351813435;4551.044280701057;4557.567031132037;4559.019810740673;4561.338605902126;4569.29175977724;7518.887216691754;7599.468037237396;7601.5059021164;7606.733764318277;7624.771256862303;4438.178936896685;4603.976980115078;4617.953820461819;4621.95378046222;4624.352590637313;4647.953520464752;4672.462666793294;4688.507706690748;4695.460022097503;4712.387389639325;5576.968260871752;5612.158176273591;5615.971920140455;5617.550595952314;5627.887442251132;7200.315969982843;7214.170370407365;7222.458315626349;7227;7228.385587225145;1598.5364244369234;1618.7248167811501;1620.9027458352537;1621.6270257840763;1632.0534090227638;989.5794287427815;1015.9542820573092;1025.374521541859;1032.9793404131876;1033.7570670892335;6962.338577835098;6969.128858892638;6997.685104170325;7024.051753013277;7026.473014523931;7179.461540384492;7441.330280274801;7442.66508007141;7458.105027396638;7459.664315105833;5588.385277619459;6859.828504287433;6929.272426395257;6978.616176110363;6996.6851491683;3918.3730603103368;3922.2155568886337;3937.2912875682077;3985.621365970286;3995.10110225197;8026.317762990095;8035.196480352035;8083.151269116775;8093.028836539653;8094.392920530984;7443.739469118555;7744.380449564022;7782.571958542335;7790.5325680459355;7853.725119620786;8011.316209069911;8032.196780321921;8044.195580442026;8047.597620118971;8112.3104536113915;6482.254540727877;6555.754406662719;7479.102507699111;7510.924890751023;7513.39892808585;7431.851362972819;7442.7395041173295;7452.627368631655;7457.589832559044;7464.253574642492;7857.2928436441;8060.11338752725;8069.798255043671;8079.313258372869;8093.514389136671;4566.13243483737;4580.473245576802;4623.144718227139;4627.5603817637275;4648.604868586208;7467.962660186664;7516.24837516244;7524.2851929066655;7541.680205963825;7548.584827834522;7195.13658361;7227.1327440707455;7231.674574644048;7232.855342893218;7268.164161121539;6928.861422771617;7186.496945213994;7206.819829504095;7209.639518023973;7237.3486386225495;6845.965770171118;6988.8951665724035;6999.790006299819;7071;7129.643517824192;7254.96372518134;7255.56466612005;7274.272572742683;7294.854102917806;7311.341979221683;5018.598512118949;5791.478766910998;7066.4346852250665;7130.500864939612;7134.357907788324 11:15:06 INFO - PROCESS | 1675 | |5;yui.html;721.736566153354;730.5616630021991;736.7421402509126;762.1692355332686;795.6538905576075;15219.543413697578;15371.846281537195;15429.919905606612;15468.303926323328;15605.219739013046;14421.134731916092;14447.277636118204;14470.131792092456;14484.927575362135;16070.357185712586;897.0446474504664;906.7597086771995;927.3879239701798;930.9720708378726;933.4446004627235;909.9681511147111;918.2837386838277;925.4632313258294;925.9953700231523;927.6892241099206;941.2611100286276;942.6606421688186;945.3713280668347;972.659569150795;973.352720440906;942.6417961174744;944.655200851691;968.4818622037246;977.5600979559226;985.2216748768465;638.7923924724437;692.5913710910537;706.3148745716646;727.6507276507253;731.9048523691939;12814.679633009157;15290.235488225544;15570.766438503319;15605.921970390076;15705.921470392575;10692.46537673121;12664.493420263178;12875.806862897063;12895.67760805978;12897;9544.52277386128;10262.692119236435;10523.052925236689;10557.366558006468;10560.366378017343;3557.6086630470627;3568.964310356889;3594.3170797548382;3613.9638603614153;3812.618738126193;88303.67544486838;88894.11105888923;91623.54188229016;92168.53915730446;92404.61393079109;9717.368371055858;9745.025497450199;9827.11555959967;9862.112409883144;9898.356606820678;21119;21263.72417654946;21481.57036859254;21544.245951391626;21549.784502154776;7800.219978002155;7932.722354717557;8019.43863929531;8093.635786389626;8113.269805717396;3918.686505079587;4023.9537720192375;4293.763842988666;4331.177076355482;4439.178751930903;3736.9626303736613;3758.361078616587;3765.548134223911;3802.866899658554;3830.9616903830606;703.6059806508372;704.7744721689113;707.3139055116528;709.7090193020837;710.7796583059268;575.706389741235;614.1340709599443;619.0110679178925;625.8247690646626;648.6043513456788;7312.5246858954;8447.36644751646;8510.404271701045;8606.82786344282;8622.180892815173;569.6525119676994;616.7902913009598;621.4065567383138;637.1812221295705;641.887669657808;3165.9552347725194;3372.3086767212662;3683.9263214736093;4014.458048163519;4121.971195141922;96515.0348496506;97187.51406243065;97741;98284.01715982749;98948;80243;81263.18736812675;81449;82444;86347;69544.6522767383;69860.65069674619;71023.28976710167;71253.643731781;71421.6428917852;7741.806454838674;7913.129555748978;8034.317083048007;8109.270165685117;8211.753647390588;44673;52120.69698257574;52515;52641;54409.72795136157;51526.74236628943;54243.45756542384;70502;72606.63696681483;74073.92593407414;8709;9927.205823533955;10108.545115469675;10196.745081373025;10442.738931526772;11199.440027998404;11232.82055384173;11406.429678515875;11551.595694150665;11678.06575473977;10569.418681972566;10658.413787241776;10752.623658171926;11002.834957475805;11306.208565400342;9989.60041598328;10269.691909242734;11586.942065289619;11610.071194304604;11787.587434439753;11574.537018519164;11582.594609188638;11600.361980091177;11670.183087183816;11979.520819167135;9936.686774016536;9942.900570994198;10072.899271007196;10115.797684046425;10360.948195258976;9797.461139637388;9918.312787761655;9920.511923211576;9968.40189588627;9968.750781230237 11:15:06 INFO - PROCESS | 1675 | __end_tp_report 11:15:06 INFO - PROCESS | 1675 | __start_cc_report 11:15:06 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,397 11:15:06 INFO - PROCESS | 1675 | __end_cc_report 11:15:06 INFO - PROCESS | 1675 | __startTimestamp1466446506038__endTimestamp 11:15:06 INFO - PROCESS | 1675 | 11:15:06 INFO - PROCESS | 1675 | ------- Summary: start ------- 11:15:06 INFO - PROCESS | 1675 | Number of tests: 6 11:15:06 INFO - PROCESS | 1675 | 11:15:06 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5795.53 Median:6075.51 stddev:647.60 (10.7%) stddev-sans-first:610.01 11:15:06 INFO - PROCESS | 1675 | Values: 2953.8 3665.7 3678.7 3719.2 3725.2 5568.7 5784.9 5795.2 5797.4 5817.8 5791.0 5801.7 5812.9 5821.1 5824.6 5223.2 5285.8 5299.3 5316.4 5326.2 5231.6 5271.3 5287.8 5348.1 5355.9 5327.8 5329.5 5329.9 5330.8 5360.0 4292.3 5170.2 5273.8 5279.5 5359.0 5106.7 5222.1 5223.4 5261.0 5261.5 5569.3 5678.3 5701.0 5731.3 5749.8 6182.1 6196.8 6264.1 6270.3 6285.2 6207.1 6250.3 6251.6 6264.1 6266.6 5899.3 5909.9 5922.2 5958.5 5960.1 6214.3 6291.9 6299.4 6334.5 6334.6 6171.7 6220.5 6234.1 6241.8 6258.4 6249.2 6273.5 6285.8 6299.1 6306.0 6142.4 6181.5 6245.4 6268.0 6296.9 6236.2 6238.6 6258.8 6263.2 6393.7 5002.1 5072.0 5074.9 5087.2 5123.6 4477.8 4516.4 4526.9 4615.6 4689.1 5900.7 5967.3 5986.3 6066.3 6075.5 5198.8 6200.7 6205.5 6263.6 6292.1 5989.4 6072.5 6116.3 6143.1 6161.9 4715.4 4957.2 5154.6 5178.0 5511.1 5883.5 6420.6 6595.4 6606.0 6627.9 6166.6 6167.2 6217.3 6239.0 6270.7 5564.8 6625.2 6647.9 6655.4 6696.8 6112.9 6190.4 6199.1 6203.3 6213.4 6178.9 6204.5 6234.0 6265.4 6270.0 6021.8 6090.5 6176.5 6199.8 6210.8 5211.8 6030.4 6144.5 6178.7 6208.9 5802.0 6040.6 6076.3 6100.5 6108.6 4854.0 6218.6 6229.6 6237.2 6260.5 6012.1 6012.7 6094.6 6118.0 6137.2 11:15:06 INFO - PROCESS | 1675 | 11:15:06 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:66563.26 Median:3660.10 stddev:147126.82 (4019.8%) stddev-sans-first:147456.00 11:15:06 INFO - PROCESS | 1675 | Values: 524.7 531.1 562.2 571.9 601.1 35518.5 41147.4 41282.4 41417.2 41534.0 42006.6 42378.0 42546.0 42619.1 42621.0 8834.7 9604.4 9695.1 9923.7 9935.6 9984.0 9987.3 9996.7 9997.3 10020.2 10107.3 10123.3 10145.5 10170.4 10208.2 9833.3 10076.3 10144.1 10159.4 10170.2 9802.8 9828.5 9909.5 9916.4 9926.5 41207.8 41244.0 41936.2 41950.0 42395.6 2828.2 3104.3 3331.4 3357.6 3367.6 27050.6 27270.9 27552.6 27569.0 27787.7 2696.5 2719.2 2779.8 2819.9 2872.4 354948.2 354957.0 357450.0 358474.0 359105.0 37699.6 38375.6 65008.0 65693.0 65709.0 36724.8 36891.4 37018.3 37037.3 37048.0 16106.8 16585.2 16761.7 16859.8 16864.0 13884.2 13955.6 13970.9 14230.9 14350.1 8378.3 8596.2 8597.2 8613.7 8651.7 3414.1 3614.5 3654.4 3656.8 3663.4 889.4 969.4 978.8 1112.3 1175.4 26986.9 31199.2 31309.4 31877.0 31939.2 1126.8 1144.8 1159.7 1225.1 1253.2 15827.2 15981.3 16003.8 16226.6 16265.4 588237.0 664135.0 664353.0 671368.6 671433.0 52989.0 63008.4 63703.7 65911.7 65997.3 1530.2 1548.7 1554.7 1556.0 1563.5 29069.4 30503.8 31093.7 31553.1 31710.8 51996.0 52245.7 52322.0 52336.2 52396.2 585918.0 589645.0 593056.0 595951.0 597498.0 28519.1 28960.4 44867.8 45771.3 46866.1 45581.5 45753.3 46194.0 46286.1 47273.5 34869.8 35739.5 35795.3 36104.1 36219.3 37160.3 37331.6 37807.8 38053.9 38102.8 33379.0 34339.1 39711.8 41294.2 41920.0 32473.8 33978.5 34178.3 34317.5 34565.7 25428.4 26158.9 26258.9 26267.2 26270.3 11:15:06 INFO - PROCESS | 1675 | 11:15:06 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:36022.79 Median:12080.47 stddev:107410.67 (889.1%) stddev-sans-first:107678.66 11:15:06 INFO - PROCESS | 1675 | Values: 390.0 394.7 398.7 399.2 402.2 15860.6 20772.5 21339.1 21347.3 21412.4 20714.9 20986.5 21072.8 21087.7 21826.2 5356.3 5961.6 6179.1 6186.0 6228.5 6095.9 6144.7 6199.8 6224.0 6229.8 5938.5 6134.7 6154.7 6165.8 6211.3 5957.0 6006.3 6050.0 6057.7 6080.1 5276.9 5278.1 5278.8 5566.5 5588.2 12562.9 12786.4 12904.5 16428.5 26603.7 2183.5 2215.4 2299.6 2324.6 2343.0 7796.6 9374.8 9459.0 9534.3 9769.4 1781.5 1781.5 1781.7 1803.5 1807.0 118111.0 120093.4 123564.4 123665.0 124738.4 11077.9 11278.2 11299.4 11317.5 11515.2 11441.0 11479.8 13163.9 13791.4 13876.4 7387.1 8203.8 8986.1 9038.1 9104.5 7680.6 9402.9 9524.3 9552.6 9562.6 4313.6 4348.5 4349.2 4350.8 4384.7 1671.3 1828.5 1908.8 1909.5 1937.7 841.7 941.7 989.1 1026.4 1037.4 19732.8 21483.9 21543.7 21815.7 21945.6 996.1 1015.7 1020.1 1047.3 1067.9 8903.5 9303.6 11353.3 11408.7 11496.5 606155.0 640761.0 650196.0 661762.0 671406.0 96130.0 114939.4 119092.4 121885.0 130016.7 983.4 1017.5 1038.1 1038.3 1039.9 19071.8 19539.6 19583.7 19869.8 19901.9 51012.7 51440.5 52869.5 53346.0 53607.7 80982.0 82723.3 83072.0 83537.2 84160.0 7641.5 7832.4 7856.0 8003.8 8087.8 12366.9 12857.4 12903.4 12955.7 13014.9 11157.8 11223.0 11322.4 11430.1 11599.6 10512.6 10561.7 11184.7 11363.9 11414.3 8998.8 11704.0 11724.2 11929.9 11982.9 7765.8 7812.5 7934.0 8031.8 8060.4 11278.7 11295.0 11399.8 11641.6 11749.9 11:15:06 INFO - PROCESS | 1675 | 11:15:06 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:5803.40 Median:5043.92 stddev:3265.27 (64.7%) stddev-sans-first:3258.90 11:15:06 INFO - PROCESS | 1675 | Values: 1564.5 1583.6 1650.2 2042.3 2115.8 7954.5 8531.4 8640.4 8830.6 8848.4 8881.6 8894.3 8982.2 8995.6 9005.4 2388.2 2400.2 2408.0 2410.8 2417.6 2452.9 2461.4 2464.2 2497.5 2514.6 2418.2 2483.8 2490.0 2499.4 2502.4 2039.2 2492.6 2498.3 2504.2 2521.7 2491.2 2515.8 2526.6 2537.2 2537.4 8954.3 9129.3 9182.4 9200.6 9371.9 5575.9 5585.9 5598.0 5632.5 5737.8 3123.5 3526.5 3637.7 3662.0 3695.7 1000.3 1005.0 1010.1 1015.8 1026.6 12349.9 12357.6 12395.5 12404.0 12407.8 4910.6 4980.4 5037.2 5050.6 5055.3 10443.8 10519.6 10533.5 10567.0 10568.1 5532.2 5540.7 5565.7 5691.5 5726.1 4560.2 4983.7 5028.5 5105.7 5168.7 4176.0 4208.0 4221.8 4233.4 4260.0 1329.2 1341.2 1353.4 1353.9 1357.1 919.9 958.9 976.2 981.2 1012.0 5085.7 5945.2 6035.8 6206.2 6277.4 436.7 446.5 446.6 446.7 447.8 3732.9 3840.2 4063.2 4067.9 4152.6 10651.0 10724.0 11021.6 11082.3 11152.6 10911.3 10944.0 11009.5 11043.3 11050.4 8241.5 8261.3 8517.2 8582.6 8613.1 5755.7 5906.6 6056.2 6058.6 6141.0 9493.5 9583.9 9637.0 9716.0 9812.4 8243.5 9622.6 9702.7 9714.5 10052.2 6155.8 7043.8 7721.1 7748.2 7852.5 8457.7 8469.3 8507.4 8522.3 8535.1 6361.9 7581.5 7621.1 7742.2 7766.8 6267.0 7370.2 7391.1 7411.6 7556.4 6075.0 7101.4 7136.8 7173.9 7204.8 3665.6 4514.6 4905.8 5080.4 5080.6 5083.6 5118.9 5139.7 5177.4 5303.8 11:15:06 INFO - PROCESS | 1675 | 11:15:06 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:5874.00 Median:6715.96 stddev:1938.01 (28.9%) stddev-sans-first:1897.12 11:15:06 INFO - PROCESS | 1675 | Values: 262.3 321.1 324.1 332.3 336.3 5370.5 6700.6 6744.9 6786.4 6787.3 5860.8 6658.5 6712.0 6715.7 6716.3 4573.0 4748.0 4871.7 4878.2 4897.6 4993.9 4999.0 5033.3 5044.3 5066.3 4812.7 4877.3 4904.3 4943.2 4960.0 4926.0 4933.7 4934.8 4934.9 4953.7 3427.7 4169.0 4171.9 4176.2 4191.5 6080.3 6335.0 6356.3 6369.8 6396.7 5623.6 5661.3 5661.9 5662.3 5680.3 6146.8 6861.8 7190.1 7230.0 7253.0 4551.0 4557.6 4559.0 4561.3 4569.3 7518.9 7599.5 7601.5 7606.7 7624.8 4438.2 4604.0 4618.0 4622.0 4624.4 4648.0 4672.5 4688.5 4695.5 4712.4 5577.0 5612.2 5616.0 5617.6 5627.9 7200.3 7214.2 7222.5 7227.0 7228.4 1598.5 1618.7 1620.9 1621.6 1632.1 989.6 1016.0 1025.4 1033.0 1033.8 6962.3 6969.1 6997.7 7024.1 7026.5 7179.5 7441.3 7442.7 7458.1 7459.7 5588.4 6859.8 6929.3 6978.6 6996.7 3918.4 3922.2 3937.3 3985.6 3995.1 8026.3 8035.2 8083.2 8093.0 8094.4 7443.7 7744.4 7782.6 7790.5 7853.7 8011.3 8032.2 8044.2 8047.6 8112.3 6482.3 6555.8 7479.1 7510.9 7513.4 7431.9 7442.7 7452.6 7457.6 7464.3 7857.3 8060.1 8069.8 8079.3 8093.5 4566.1 4580.5 4623.1 4627.6 4648.6 7468.0 7516.2 7524.3 7541.7 7548.6 7195.1 7227.1 7231.7 7232.9 7268.2 6928.9 7186.5 7206.8 7209.6 7237.3 6846.0 6988.9 6999.8 7071.0 7129.6 7255.0 7255.6 7274.3 7294.9 7311.3 5018.6 5791.5 7066.4 7130.5 7134.4 11:15:06 INFO - PROCESS | 1675 | 11:15:06 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:18831.72 Median:645.25 stddev:27081.20 (4197.0%) stddev-sans-first:27123.03 11:15:06 INFO - PROCESS | 1675 | Values: 721.7 730.6 736.7 762.2 795.7 15219.5 15371.8 15429.9 15468.3 15605.2 14421.1 14447.3 14470.1 14484.9 16070.4 897.0 906.8 927.4 931.0 933.4 910.0 918.3 925.5 926.0 927.7 941.3 942.7 945.4 972.7 973.4 942.6 944.7 968.5 977.6 985.2 638.8 692.6 706.3 727.7 731.9 12814.7 15290.2 15570.8 15605.9 15705.9 10692.5 12664.5 12875.8 12895.7 12897.0 9544.5 10262.7 10523.1 10557.4 10560.4 3557.6 3569.0 3594.3 3614.0 3812.6 88303.7 88894.1 91623.5 92168.5 92404.6 9717.4 9745.0 9827.1 9862.1 9898.4 21119.0 21263.7 21481.6 21544.2 21549.8 7800.2 7932.7 8019.4 8093.6 8113.3 3918.7 4024.0 4293.8 4331.2 4439.2 3737.0 3758.4 3765.5 3802.9 3831.0 703.6 704.8 707.3 709.7 710.8 575.7 614.1 619.0 625.8 648.6 7312.5 8447.4 8510.4 8606.8 8622.2 569.7 616.8 621.4 637.2 641.9 3166.0 3372.3 3683.9 4014.5 4122.0 96515.0 97187.5 97741.0 98284.0 98948.0 80243.0 81263.2 81449.0 82444.0 86347.0 69544.7 69860.7 71023.3 71253.6 71421.6 7741.8 7913.1 8034.3 8109.3 8211.8 44673.0 52120.7 52515.0 52641.0 54409.7 51526.7 54243.5 70502.0 72606.6 74073.9 8709.0 9927.2 10108.5 10196.7 10442.7 11199.4 11232.8 11406.4 11551.6 11678.1 10569.4 10658.4 10752.6 11002.8 11306.2 9989.6 10269.7 11586.9 11610.1 11787.6 11574.5 11582.6 11600.4 11670.2 11979.5 9936.7 9942.9 10072.9 10115.8 10360.9 9797.5 9918.3 9920.5 9968.4 9968.8 11:15:06 INFO - PROCESS | 1675 | -------- Summary: end -------- 11:15:06 INFO - PROCESS | 1675 | 11:15:06 INFO - TEST-INFO | 1675: exit 0 11:15:06 INFO - TEST-OK | dromaeo_css | took 1109613ms 11:15:06 INFO - TEST-START | kraken 11:15:06 INFO - operating with platform_type : mac_ 11:15:06 INFO - Initialising browser for kraken test... 11:15:06 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmp3SJ7jp/profile http://localhost:49276/getInfo.html) 11:15:09 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 11:15:09 INFO - PROCESS | 1685 | colorDepth:24 11:15:09 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 11:15:09 INFO - PROCESS | 1685 | __metrics 11:15:09 ERROR - PROCESS | 1685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 11:15:09 INFO - TEST-INFO | 1685: exit 0 11:15:09 INFO - Browser initialized. 11:15:09 INFO - Running cycle 1/1 for kraken test... 11:15:09 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmp3SJ7jp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:21 INFO - PROCESS | 1689 | RSS: Main: 171368448 11:15:21 INFO - PROCESS | 1689 | 11:15:24 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 11:15:25 INFO - PROCESS | 1689 | RSS: Main: 183607296 11:15:25 INFO - PROCESS | 1689 | 11:15:27 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 11:15:28 INFO - PROCESS | 1689 | RSS: Main: 192393216 11:15:28 INFO - PROCESS | 1689 | 11:15:31 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 11:15:32 INFO - PROCESS | 1689 | RSS: Main: 196378624 11:15:32 INFO - PROCESS | 1689 | 11:15:34 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 11:15:34 INFO - PROCESS | 1689 | RSS: Main: 197697536 11:15:34 INFO - PROCESS | 1689 | 11:15:37 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:15:37 INFO - PROCESS | 1689 | RSS: Main: 197926912 11:15:37 INFO - PROCESS | 1689 | 11:15:40 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 11:15:41 INFO - PROCESS | 1689 | RSS: Main: 198213632 11:15:41 INFO - PROCESS | 1689 | 11:15:43 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 11:15:44 INFO - PROCESS | 1689 | RSS: Main: 197869568 11:15:44 INFO - PROCESS | 1689 | 11:15:47 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 11:15:47 INFO - PROCESS | 1689 | RSS: Main: 198025216 11:15:47 INFO - PROCESS | 1689 | 11:15:49 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:15:50 INFO - PROCESS | 1689 | RSS: Main: 197873664 11:15:50 INFO - PROCESS | 1689 | 11:15:51 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:15:52 INFO - PROCESS | 1689 | RSS: Main: 197705728 11:15:52 INFO - PROCESS | 1689 | 11:15:54 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:15:55 INFO - PROCESS | 1689 | RSS: Main: 198000640 11:15:55 INFO - PROCESS | 1689 | 11:15:58 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:15:58 INFO - PROCESS | 1689 | RSS: Main: 198225920 11:15:58 INFO - PROCESS | 1689 | 11:16:01 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:16:02 INFO - PROCESS | 1689 | RSS: Main: 198131712 11:16:02 INFO - PROCESS | 1689 | 11:16:03 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 11:16:04 INFO - PROCESS | 1689 | RSS: Main: 200089600 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | __start_tp_report 11:16:04 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 11:16:04 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 11:16:04 INFO - PROCESS | 1689 | |i|pagename|runs| 11:16:04 INFO - PROCESS | 1689 | |0;ai-astar;116;118;106;116;116;113;106;140;96;120 11:16:04 INFO - PROCESS | 1689 | |1;audio-beat-detection;158;121;140;155;121;137;125;171;188;125 11:16:04 INFO - PROCESS | 1689 | |2;audio-dft;198;198;198;204;190;196;200;198;197;198 11:16:04 INFO - PROCESS | 1689 | |3;audio-fft;64;68;78;143;57;60;70;90;160;57 11:16:04 INFO - PROCESS | 1689 | |4;audio-oscillator;78;84;106;114;112;119;144;76;79;115 11:16:04 INFO - PROCESS | 1689 | |5;imaging-gaussian-blur;87;87;86;85;103;120;88;85;87;86 11:16:04 INFO - PROCESS | 1689 | |6;imaging-darkroom;94;94;94;93;94;95;94;94;94;93 11:16:04 INFO - PROCESS | 1689 | |7;imaging-desaturate;91;91;91;91;90;97;113;114;90;91 11:16:04 INFO - PROCESS | 1689 | |8;json-parse-financial;58;61;62;63;62;65;64;79;63;59 11:16:04 INFO - PROCESS | 1689 | |9;json-stringify-tinderbox;60;66;67;64;66;73;69;66;63;66 11:16:04 INFO - PROCESS | 1689 | |10;stanford-crypto-aes;94;104;108;84;82;80;91;107;85;82 11:16:04 INFO - PROCESS | 1689 | |11;stanford-crypto-ccm;128;126;136;145;144;145;132;146;164;137 11:16:04 INFO - PROCESS | 1689 | |12;stanford-crypto-pbkdf2;166;165;164;163;161;165;165;179;165;163 11:16:04 INFO - PROCESS | 1689 | |13;stanford-crypto-sha256-iterative;70;69;68;70;67;68;65;67;69;67 11:16:04 INFO - PROCESS | 1689 | __end_tp_report 11:16:04 INFO - PROCESS | 1689 | __start_cc_report 11:16:04 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,1045 11:16:04 INFO - PROCESS | 1689 | __end_cc_report 11:16:04 INFO - PROCESS | 1689 | __startTimestamp1466446564050__endTimestamp 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | ------- Summary: start ------- 11:16:04 INFO - PROCESS | 1689 | Number of tests: 14 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#0] ai-astar Cycles:10 Average:114.70 Median:117.00 stddev:11.49 (9.8%) stddev-sans-first:12.18 11:16:04 INFO - PROCESS | 1689 | Values: 116.0 118.0 106.0 116.0 116.0 113.0 106.0 140.0 96.0 120.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:147.50 stddev:23.16 (15.7%) stddev-sans-first:24.01 11:16:04 INFO - PROCESS | 1689 | Values: 158.0 121.0 140.0 155.0 121.0 137.0 125.0 171.0 188.0 125.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#2] audio-dft Cycles:10 Average:197.70 Median:198.00 stddev:3.47 (1.8%) stddev-sans-first:3.67 11:16:04 INFO - PROCESS | 1689 | Values: 198.0 198.0 198.0 204.0 190.0 196.0 200.0 198.0 197.0 198.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#3] audio-fft Cycles:10 Average:84.70 Median:66.00 stddev:36.83 (55.8%) stddev-sans-first:38.30 11:16:04 INFO - PROCESS | 1689 | Values: 64.0 68.0 78.0 143.0 57.0 60.0 70.0 90.0 160.0 57.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:110.00 stddev:22.56 (20.5%) stddev-sans-first:22.09 11:16:04 INFO - PROCESS | 1689 | Values: 78.0 84.0 106.0 114.0 112.0 119.0 144.0 76.0 79.0 115.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:86.50 stddev:11.36 (13.1%) stddev-sans-first:11.94 11:16:04 INFO - PROCESS | 1689 | Values: 87.0 87.0 86.0 85.0 103.0 120.0 88.0 85.0 87.0 86.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 11:16:04 INFO - PROCESS | 1689 | Values: 94.0 94.0 94.0 93.0 94.0 95.0 94.0 94.0 94.0 93.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:91.00 stddev:9.49 (10.4%) stddev-sans-first:9.90 11:16:04 INFO - PROCESS | 1689 | Values: 91.0 91.0 91.0 91.0 90.0 97.0 113.0 114.0 90.0 91.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.00 stddev:5.82 (9.2%) stddev-sans-first:5.80 11:16:04 INFO - PROCESS | 1689 | Values: 58.0 61.0 62.0 63.0 62.0 65.0 64.0 79.0 63.0 59.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:3.46 (5.2%) stddev-sans-first:2.92 11:16:04 INFO - PROCESS | 1689 | Values: 60.0 66.0 67.0 64.0 66.0 73.0 69.0 66.0 63.0 66.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:83.00 stddev:10.99 (13.2%) stddev-sans-first:11.62 11:16:04 INFO - PROCESS | 1689 | Values: 94.0 104.0 108.0 84.0 82.0 80.0 91.0 107.0 85.0 82.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:144.50 stddev:11.09 (7.7%) stddev-sans-first:10.83 11:16:04 INFO - PROCESS | 1689 | Values: 128.0 126.0 136.0 145.0 144.0 145.0 132.0 146.0 164.0 137.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.00 stddev:4.93 (3.0%) stddev-sans-first:5.22 11:16:04 INFO - PROCESS | 1689 | Values: 166.0 165.0 164.0 163.0 161.0 165.0 165.0 179.0 165.0 163.0 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - PROCESS | 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.56 (2.3%) stddev-sans-first:1.48 11:16:04 INFO - PROCESS | 1689 | Values: 70.0 69.0 68.0 70.0 67.0 68.0 65.0 67.0 69.0 67.0 11:16:04 INFO - PROCESS | 1689 | -------- Summary: end -------- 11:16:04 INFO - PROCESS | 1689 | 11:16:04 INFO - TEST-INFO | 1689: exit 0 11:16:04 INFO - TEST-OK | kraken | took 58227ms 11:16:04 INFO - SUITE-END | took 1167s 11:16:05 INFO - Completed test suite (00:19:28) 11:16:05 INFO - javascript benchmark 11:16:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2953.763698904087, 3665.725070619704, 3678.6505281998234, 3719.2003719200366, 3725.1618385863176, 5568.693721845297, 5784.942150578493, 5795.2466179396615, 5797.449242321984, 5817.796377126801, 5791.0, 5801.680907550083, 5812.883742325151, 5821.097729851869, 5824.563157763174, 5223.216517522383, 5285.7885684572575, 5299.284596579451, 5316.3620365556, 5326.174442961328, 5231.633785634988, 5271.314729085233, 5287.762050707727, 5348.090824559834, 5355.919661205085, 5327.813526526573, 5329.546988505982, 5329.946700533003, 5330.840074797762, 5360.035193665139, 4292.33468812333, 5170.1986192140275, 5273.789048438058, 5279.472052794728, 5358.973205133969, 5106.66806657566, 5222.086134926372, 5223.37319521656, 5261.026710058613, 5261.500157485071, 5569.303837020372, 5678.290213723285, 5701.002324593221, 5731.254936858223, 5749.798757043525, 6182.072689096626, 6196.845078873019, 6264.123022776815, 6270.2789179244055, 6285.245770507523, 6207.068939659042, 6250.312465628777, 6251.624902505819, 6264.123022776815, 6266.624002559861, 5899.259718383088, 5909.940900590982, 5922.186961193442, 5958.493528050078, 5960.0761881908375, 6214.316425193225, 6291.905621415683, 6299.370062993664, 6334.5249106317215, 6334.619922804646, 6171.660558669317, 6220.471259942956, 6234.127222188807, 6241.781537646251, 6258.405451482102, 6249.156363890907, 6273.529485288622, 6285.811425657238, 6299.086632438362, 6305.96847015762, 6142.447179753844, 6181.505479561624, 6245.406686364788, 6268.0, 6296.905546416808, 6236.18929539157, 6238.625682459067, 6258.812235632939, 6263.154474145932, 6393.712282947278, 5002.1496345621335, 5071.96024814912, 5074.898502029939, 5087.211482220262, 5123.590112790967, 4477.7984990675495, 4516.435445569304, 4526.864194074183, 4615.630749540029, 4689.062187562433, 5900.675462849585, 5967.343592204854, 5986.311574169026, 6066.272047354346, 6075.513958883279, 5198.792048318101, 6200.720967556471, 6205.503559715212, 6263.561550691499, 6292.119103325538, 5989.431004054608, 6072.453479186895, 6116.274903966718, 6143.143438301211, 6161.907571386433, 4715.363425937455, 4957.182064959241, 5154.639175257771, 5178.0, 5511.145772405283, 5883.529317654577, 6420.6147631142285, 6595.4393876521035, 6606.042123892009, 6627.900581491282, 6166.568340216142, 6167.198264225622, 6217.347178546188, 6239.0, 6270.7491700331475, 5564.777408903598, 6625.204975402982, 6647.867042659023, 6655.367740064686, 6696.799096026932, 6112.908306375319, 6190.350013248544, 6199.132121503083, 6203.286622038523, 6213.440790328892, 6178.938210617836, 6204.472619827185, 6234.0, 6265.4361107500545, 6270.0, 6021.789237376671, 6090.543209259412, 6176.505879529537, 6199.845003874939, 6210.844728881814, 5211.827338848729, 6030.3668114847305, 6144.508439324933, 6178.691065446799, 6208.906866397098, 5802.0, 6040.577159598786, 6076.33160352352, 6100.511959043355, 6108.633481990917, 4853.95146048535, 6218.62688238689, 6229.595076320024, 6237.1891654084675, 6260.530460215593, 6012.098185272069, 6012.729427175875, 6094.573379863367, 6118.040554665137, 6137.202163718688], "value": 5757.429247512012, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.6720799500313, 531.1053115101766, 562.2381672833308, 571.9199312096307, 601.0653433910269, 35518.46722299165, 41147.38278925818, 41282.38076428856, 41417.171656566854, 41533.96165095871, 42006.57993420065, 42378.0, 42546.0, 42619.14761704772, 42621.0, 8834.718965749962, 9604.3757155785, 9695.127438530531, 9923.702288931343, 9935.552900119475, 9983.950080249588, 9987.300888937778, 9996.650117245897, 9997.250206234525, 10020.198384129251, 10107.343022703537, 10123.29136960413, 10145.543450544743, 10170.440625765617, 10208.234382421311, 9833.31166818323, 10076.345037572608, 10144.137748291405, 10159.390436573829, 10170.237232207613, 9802.803943921082, 9828.459434731087, 9909.454979976099, 9916.405015699009, 9926.45404502752, 41207.79396103, 41244.0, 41936.16127677429, 41950.0, 42395.576044239475, 2828.188306969432, 3104.30153215527, 3331.3670402623425, 3357.613874404426, 3367.5958884933966, 27050.594241086204, 27270.863645681646, 27552.586711199347, 27569.0, 27787.72212277892, 2696.4876673431986, 2719.184244726594, 2779.7915156363356, 2819.873105710248, 2872.4255148970287, 354948.22525887465, 354957.0, 357450.0, 358474.0, 359105.0, 37699.62300376961, 38375.616243837205, 65008.02487962684, 65693.0, 65709.0, 36724.81637591848, 36891.4466283006, 37018.25963480715, 37037.25925481475, 37048.0, 16106.838931610768, 16585.17074146288, 16761.7485737714, 16859.83140168607, 16864.0, 13884.166949983033, 13955.58133256004, 13970.860291397159, 14230.857691422952, 14350.067245629001, 8378.287845533076, 8596.183362580545, 8597.226249637437, 8613.741587752378, 8651.740447786577, 3414.1123307940115, 3614.493970844084, 3654.3604869147794, 3656.7805931643657, 3663.413853783435, 889.4040992535017, 969.3553786731885, 978.7944531648291, 1112.2547892911768, 1175.4122938530734, 26986.865065674938, 31199.22001949924, 31309.373812524078, 31877.0, 31939.201519962186, 1126.8028095083328, 1144.822552504363, 1159.7300955453766, 1225.0995518294046, 1253.1541209683428, 15827.208639568205, 15981.299114692085, 16003.839961600468, 16226.594335141715, 16265.443765792019, 588237.0, 664135.0, 664353.0, 671368.6431567811, 671433.0, 52989.0, 63008.424789379715, 63703.6814815923, 65911.6817663644, 65997.34002660008, 1530.2195880101451, 1548.6902619475925, 1554.7279226135606, 1556.0, 1563.491865143833, 29069.418611628073, 30503.847480762455, 31093.689063109985, 31553.053408396867, 31710.841445793547, 51996.0, 52245.69385765386, 52322.0, 52336.214956774915, 52396.21405678842, 585918.0, 589645.0, 593056.0, 595951.0, 597498.0, 28519.144425667262, 28960.42079158363, 44867.775661121486, 45771.31343029924, 46866.062678746915, 45581.54418455773, 45753.31370029385, 46194.0, 46286.07427851491, 47273.527264726916, 34869.825650871586, 35739.46390804192, 35795.284094317445, 36104.097397565274, 36219.27561448809, 37160.256794864494, 37331.626683732815, 37807.81096094612, 38053.85838424852, 38102.80948595239, 33379.0, 34339.14152146217, 39711.80144099261, 41294.1741165181, 41920.0, 32473.837630811693, 33978.49032264567, 34178.31643367169, 34317.48523772195, 34565.65434345624, 25428.364290892874, 26158.86920565461, 26258.86870565635, 26267.21198364052, 26270.34324141835], "value": 19149.00393799178, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.9571047184811, 394.731582523884, 398.6730880677844, 399.20956506117903, 402.17955371043064, 15860.603484912883, 20772.480687982807, 21339.146434142614, 21347.252846150386, 21412.357629271108, 20714.89642551785, 20986.475338116554, 21072.789272107275, 21087.68368474474, 21826.23608173714, 5356.276902618155, 5961.582689211757, 6179.134921111048, 6186.041163619624, 6228.532860035492, 6095.878082438348, 6144.692765361737, 6199.845003874894, 6223.968880155593, 6229.844253893666, 5938.524918006549, 6134.693265336738, 6154.692265386735, 6165.845853853644, 6211.285702144243, 5956.9873121569435, 6006.279246490405, 6049.969750151243, 6057.697115144269, 6080.0575910733905, 5276.92084618731, 5278.10272253714, 5278.81524146653, 5566.471185237437, 5588.189712491707, 12562.937185314106, 12786.360681965865, 12904.483820647256, 16428.507144785675, 26603.733962660513, 2183.4977955070262, 2215.3796936857543, 2299.5745787029455, 2324.569954558412, 2342.980803350548, 7796.571188584626, 9374.765630859214, 9459.0, 9534.250380725141, 9769.413835169842, 1781.5100847266976, 1781.5278951077976, 1781.732740088984, 1803.4950213940117, 1806.9819301806945, 118111.0, 120093.39953300265, 123564.38217808944, 123665.0, 124738.37630811878, 11077.889221107847, 11278.210525263154, 11299.435028248554, 11317.547298108148, 11515.19393642437, 11440.9703126719, 11479.827802582968, 13163.934180329037, 13791.379387927367, 13876.375563099684, 7387.113546374362, 8203.8359232815, 8986.14631609996, 9038.09619038091, 9104.543273076408, 7680.577568233689, 9402.905970940203, 9524.285678574135, 9552.57013434397, 9562.61749530011, 4313.568643135662, 4348.499922508889, 4349.217140914666, 4350.760708161081, 4384.693071484965, 1671.3314674130202, 1828.542864283929, 1908.7518622579253, 1909.5035290824485, 1937.7093435984716, 841.6717480182733, 941.6798288581915, 989.1345073061071, 1026.3790406803926, 1037.3568387599585, 19732.802671973383, 21483.851614838703, 21543.67684484734, 21815.67276490854, 21945.561088778137, 996.0537489384968, 1015.669907280137, 1020.0870221152028, 1047.2930771729204, 1067.8611780468489, 8903.465792052368, 9303.627854885865, 11353.318800871974, 11408.721271661361, 11496.482658280398, 606155.0, 640761.0, 650196.0, 661762.0, 671406.0, 96130.0, 114939.42530287294, 119092.40453797675, 121885.0, 130016.69983300235, 983.4099540275778, 1017.5065093429681, 1038.0709265207597, 1038.325088692356, 1039.9116075133547, 19071.809281907004, 19539.609207816047, 19583.70624440663, 19869.801301986794, 19901.947134987025, 51012.74493627508, 51440.48559514357, 52869.47130528645, 53346.0, 53607.731961339945, 80982.0, 82723.3455330902, 83072.0, 83537.16462835294, 84160.0, 7641.541507509567, 7832.412569057457, 7855.960720196591, 8003.839923201387, 8087.8382432349845, 12366.938165309115, 12857.357132143168, 12903.354832258537, 12955.740885182055, 13014.869851301744, 11157.832632510681, 11223.0, 11322.358258052702, 11430.085593152362, 11599.594014209462, 10512.632057877938, 10561.732592088998, 11184.664460066211, 11363.886361136614, 11414.258073225214, 8998.82002359936, 11704.005159561533, 11724.237924534878, 11929.880701193224, 11982.880171198176, 7765.805854853674, 7812.453128280966, 7934.0, 8031.83936321282, 8060.395470339865, 11278.661640150809, 11295.039921606756, 11399.829002564802, 11641.59254426091, 11749.941250293694], "value": 9501.84186555036, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1564.4837203722768, 1583.643680171961, 1650.2326418215528, 2042.2545770793665, 2115.8413119016077, 7954.5227286362715, 8531.445456045352, 8640.35197360198, 8830.558472076395, 8848.424852384598, 8881.60032798524, 8894.288456923447, 8982.19160275575, 8995.550222488882, 9005.414648047888, 2388.1880160745345, 2400.159944019588, 2407.987960060197, 2410.819188560856, 2417.6373543968457, 2452.852828830267, 2461.3723500507344, 2464.18681834994, 2497.4880149569294, 2514.6479492871013, 2418.1536462238164, 2483.7640424159677, 2490.0413340863806, 2499.4251322195814, 2502.399424138212, 2039.2149022626322, 2492.5762620354585, 2498.2879879234333, 2504.161106029482, 2521.697396312436, 2491.215267190847, 2515.7735803777746, 2526.608375701751, 2537.2134638262196, 2537.429078457351, 8954.2836573074, 9129.315301352359, 9182.403143795633, 9200.585973631203, 9371.906280937239, 5575.860603484945, 5585.888282234373, 5597.972010139964, 5632.493075623172, 5737.827865164052, 3123.5470856725874, 3526.5239192708914, 3637.727170462226, 3661.9816900915325, 3695.704343652528, 1000.2947921715173, 1004.9949750251202, 1010.1312870930993, 1015.827309357411, 1026.6406757634843, 12349.876501234963, 12357.629271121881, 12395.504179832797, 12404.0, 12407.813882791765, 4910.582600478928, 4980.427250866124, 5037.219231019198, 5050.621203409759, 5055.317532133188, 10443.791124177475, 10519.631812886511, 10533.473326333653, 10566.996135367128, 10568.101711354468, 5532.17017447378, 5540.722963851791, 5565.7217139143695, 5691.544676425876, 5726.112452569859, 4560.247559152703, 4983.651144419856, 5028.522290382408, 5105.744712764347, 5168.7415629218385, 4176.0, 4208.0, 4221.838994276599, 4233.364995250676, 4259.9574004260185, 1329.2489743295007, 1341.2354957674227, 1353.4315587453293, 1353.9255340956342, 1357.1382172320648, 919.8666193402053, 958.9232861371073, 976.2092704909046, 981.1562056631292, 1011.9627381933577, 5085.720285384339, 5945.16767652529, 6035.818925432244, 6206.224221972254, 6277.403646653561, 436.6681322195154, 446.51107037793565, 446.5869071109276, 446.7297285142507, 447.83653966302063, 3732.925341493155, 3840.1743625120175, 4063.187362527506, 4067.898302542401, 4152.626263636287, 10650.988156125155, 10723.981221783917, 11021.559137634566, 11082.335059896432, 11152.60965866207, 10911.345319280868, 10944.0, 11009.504572294267, 11043.337399756041, 11050.447477626087, 8241.464304820287, 8261.339092872557, 8517.190866867637, 8582.626779715216, 8613.138686131337, 5755.740991655469, 5906.586538942232, 6056.212692349966, 6058.57589968698, 6140.969295153495, 9493.477858717837, 9583.856242156513, 9637.0, 9716.028397160228, 9812.411255324703, 8243.546604936786, 9622.566984485855, 9702.660406885725, 9714.514274286399, 10052.246081543768, 6155.846103847261, 7043.823904402431, 7721.112072111779, 7748.186440423674, 7852.489588176751, 8457.661693532436, 8469.322454203771, 8507.404481686222, 8522.318214542945, 8535.06114327411, 6361.936380636134, 7581.469297149147, 7621.085469743666, 7742.187070357531, 7766.805829854299, 6267.0, 7370.189279179393, 7391.0761154855645, 7411.629418528944, 7556.395488360808, 6075.0, 7101.431885449048, 7136.785896423115, 7173.892391614026, 7204.783856484314, 3665.5601327839763, 4514.638828893615, 4905.754712264301, 5080.441151473261, 5080.568151707146, 5083.6187285952965, 5118.923216151687, 5139.743012849417, 5177.378714554277, 5303.7878484860175], "value": 4601.231610368848, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.34675657612553, 321.09131158820543, 324.13779346937145, 332.3369877095195, 336.3122414662016, 5370.462953704632, 6700.631465269408, 6744.898826517606, 6786.389224969752, 6787.28733482984, 5860.76556937723, 6658.500612454061, 6712.0, 6715.664216789153, 6716.261211266757, 4572.954270457294, 4748.0, 4871.658983871131, 4878.243872199797, 4897.579701886449, 4993.900121997558, 4999.0, 5033.270175824503, 5044.268581055745, 5066.341375621182, 4812.663113582051, 4877.268729511467, 4904.313396124546, 4943.233798761198, 4959.983203443286, 4925.965547235085, 4933.654644174909, 4934.753262336869, 4934.876628084291, 4953.678010929314, 3427.674370934757, 4168.979155104235, 4171.937420938689, 4176.206520761076, 4191.455110835572, 6080.30076541199, 6334.968325158345, 6356.269029061625, 6369.808905732835, 6396.680165991682, 5623.578231632644, 5661.264035675377, 5661.886762264731, 5662.320521537442, 5680.31836179657, 6146.78486252979, 6861.794146175573, 7190.101237345332, 7230.0239467672245, 7252.9637351813435, 4551.044280701057, 4557.567031132037, 4559.019810740673, 4561.338605902126, 4569.29175977724, 7518.887216691754, 7599.468037237396, 7601.5059021164, 7606.733764318277, 7624.771256862303, 4438.178936896685, 4603.976980115078, 4617.953820461819, 4621.95378046222, 4624.352590637313, 4647.953520464752, 4672.462666793294, 4688.507706690748, 4695.460022097503, 4712.387389639325, 5576.968260871752, 5612.158176273591, 5615.971920140455, 5617.550595952314, 5627.887442251132, 7200.315969982843, 7214.170370407365, 7222.458315626349, 7227.0, 7228.385587225145, 1598.5364244369234, 1618.7248167811501, 1620.9027458352537, 1621.6270257840763, 1632.0534090227638, 989.5794287427815, 1015.9542820573092, 1025.374521541859, 1032.9793404131876, 1033.7570670892335, 6962.338577835098, 6969.128858892638, 6997.685104170325, 7024.051753013277, 7026.473014523931, 7179.461540384492, 7441.330280274801, 7442.66508007141, 7458.105027396638, 7459.664315105833, 5588.385277619459, 6859.828504287433, 6929.272426395257, 6978.616176110363, 6996.6851491683, 3918.3730603103368, 3922.2155568886337, 3937.2912875682077, 3985.621365970286, 3995.10110225197, 8026.317762990095, 8035.196480352035, 8083.151269116775, 8093.028836539653, 8094.392920530984, 7443.739469118555, 7744.380449564022, 7782.571958542335, 7790.5325680459355, 7853.725119620786, 8011.316209069911, 8032.196780321921, 8044.195580442026, 8047.597620118971, 8112.3104536113915, 6482.254540727877, 6555.754406662719, 7479.102507699111, 7510.924890751023, 7513.39892808585, 7431.851362972819, 7442.7395041173295, 7452.627368631655, 7457.589832559044, 7464.253574642492, 7857.2928436441, 8060.11338752725, 8069.798255043671, 8079.313258372869, 8093.514389136671, 4566.13243483737, 4580.473245576802, 4623.144718227139, 4627.5603817637275, 4648.604868586208, 7467.962660186664, 7516.24837516244, 7524.2851929066655, 7541.680205963825, 7548.584827834522, 7195.13658361, 7227.1327440707455, 7231.674574644048, 7232.855342893218, 7268.164161121539, 6928.861422771617, 7186.496945213994, 7206.819829504095, 7209.639518023973, 7237.3486386225495, 6845.965770171118, 6988.8951665724035, 6999.790006299819, 7071.0, 7129.643517824192, 7254.96372518134, 7255.56466612005, 7274.272572742683, 7294.854102917806, 7311.341979221683, 5018.598512118949, 5791.478766910998, 7066.4346852250665, 7130.500864939612, 7134.357907788324], "value": 5214.442907976569, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.736566153354, 730.5616630021991, 736.7421402509126, 762.1692355332686, 795.6538905576075, 15219.543413697578, 15371.846281537195, 15429.919905606612, 15468.303926323328, 15605.219739013046, 14421.134731916092, 14447.277636118204, 14470.131792092456, 14484.927575362135, 16070.357185712586, 897.0446474504664, 906.7597086771995, 927.3879239701798, 930.9720708378726, 933.4446004627235, 909.9681511147111, 918.2837386838277, 925.4632313258294, 925.9953700231523, 927.6892241099206, 941.2611100286276, 942.6606421688186, 945.3713280668347, 972.659569150795, 973.352720440906, 942.6417961174744, 944.655200851691, 968.4818622037246, 977.5600979559226, 985.2216748768465, 638.7923924724437, 692.5913710910537, 706.3148745716646, 727.6507276507253, 731.9048523691939, 12814.679633009157, 15290.235488225544, 15570.766438503319, 15605.921970390076, 15705.921470392575, 10692.46537673121, 12664.493420263178, 12875.806862897063, 12895.67760805978, 12897.0, 9544.52277386128, 10262.692119236435, 10523.052925236689, 10557.366558006468, 10560.366378017343, 3557.6086630470627, 3568.964310356889, 3594.3170797548382, 3613.9638603614153, 3812.618738126193, 88303.67544486838, 88894.11105888923, 91623.54188229016, 92168.53915730446, 92404.61393079109, 9717.368371055858, 9745.025497450199, 9827.11555959967, 9862.112409883144, 9898.356606820678, 21119.0, 21263.72417654946, 21481.57036859254, 21544.245951391626, 21549.784502154776, 7800.219978002155, 7932.722354717557, 8019.43863929531, 8093.635786389626, 8113.269805717396, 3918.686505079587, 4023.9537720192375, 4293.763842988666, 4331.177076355482, 4439.178751930903, 3736.9626303736613, 3758.361078616587, 3765.548134223911, 3802.866899658554, 3830.9616903830606, 703.6059806508372, 704.7744721689113, 707.3139055116528, 709.7090193020837, 710.7796583059268, 575.706389741235, 614.1340709599443, 619.0110679178925, 625.8247690646626, 648.6043513456788, 7312.5246858954, 8447.36644751646, 8510.404271701045, 8606.82786344282, 8622.180892815173, 569.6525119676994, 616.7902913009598, 621.4065567383138, 637.1812221295705, 641.887669657808, 3165.9552347725194, 3372.3086767212662, 3683.9263214736093, 4014.458048163519, 4121.971195141922, 96515.0348496506, 97187.51406243065, 97741.0, 98284.01715982749, 98948.0, 80243.0, 81263.18736812675, 81449.0, 82444.0, 86347.0, 69544.6522767383, 69860.65069674619, 71023.28976710167, 71253.643731781, 71421.6428917852, 7741.806454838674, 7913.129555748978, 8034.317083048007, 8109.270165685117, 8211.753647390588, 44673.0, 52120.69698257574, 52515.0, 52641.0, 54409.72795136157, 51526.74236628943, 54243.45756542384, 70502.0, 72606.63696681483, 74073.92593407414, 8709.0, 9927.205823533955, 10108.545115469675, 10196.745081373025, 10442.738931526772, 11199.440027998404, 11232.82055384173, 11406.429678515875, 11551.595694150665, 11678.06575473977, 10569.418681972566, 10658.413787241776, 10752.623658171926, 11002.834957475805, 11306.208565400342, 9989.60041598328, 10269.691909242734, 11586.942065289619, 11610.071194304604, 11787.587434439753, 11574.537018519164, 11582.594609188638, 11600.361980091177, 11670.183087183816, 11979.520819167135, 9936.686774016536, 9942.900570994198, 10072.899271007196, 10115.797684046425, 10360.948195258976, 9797.461139637388, 9918.312787761655, 9920.511923211576, 9968.40189588627, 9968.750781230237], "value": 7029.047928493851, "unit": "score"}], "name": "dromaeo_css", "value": 7490.878512391158, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 106.0, 116.0, 116.0, 113.0, 106.0, 140.0, 96.0, 120.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 121.0, 140.0, 155.0, 121.0, 137.0, 125.0, 171.0, 188.0, 125.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 198.0, 198.0, 204.0, 190.0, 196.0, 200.0, 198.0, 197.0, 198.0], "value": 197.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 78.0, 143.0, 57.0, 60.0, 70.0, 90.0, 160.0, 57.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 106.0, 114.0, 112.0, 119.0, 144.0, 76.0, 79.0, 115.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 85.0, 103.0, 120.0, 88.0, 85.0, 87.0, 86.0], "value": 91.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0, 94.0, 94.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 91.0, 91.0, 90.0, 97.0, 113.0, 114.0, 90.0, 91.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 62.0, 63.0, 62.0, 65.0, 64.0, 79.0, 63.0, 59.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 66.0, 67.0, 64.0, 66.0, 73.0, 69.0, 66.0, 63.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 104.0, 108.0, 84.0, 82.0, 80.0, 91.0, 107.0, 85.0, 82.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 136.0, 145.0, 144.0, 145.0, 132.0, 146.0, 164.0, 137.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 164.0, 163.0, 161.0, 165.0, 165.0, 179.0, 165.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 70.0, 67.0, 68.0, 65.0, 67.0, 69.0, 67.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1520.3, "alertThreshold": 2.0}]} 11:16:05 INFO - Return code: 0 11:16:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:16:05 ERROR - # TBPL SUCCESS # 11:16:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:16:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:16:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:16:05 INFO - 2016-06-20 11:16:05.391 screenresolution[1694:11249] starting screenresolution argv=screenresolution get 11:16:05 INFO - 2016-06-20 11:16:05.394 screenresolution[1694:11249] Display 0: 1600x1200x32@60 11:16:05 INFO - 2016-06-20 11:16:05.400 screenresolution[1695:11252] starting screenresolution argv=screenresolution list 11:16:05 INFO - Available Modes on Display 0 11:16:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:16:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:16:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:16:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:16:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:16:05 INFO - Intel Iris: 11:16:05 INFO - Chipset Model: Intel Iris 11:16:05 INFO - Type: GPU 11:16:05 INFO - Bus: Built-In 11:16:05 INFO - VRAM (Dynamic, Max): 1536 MB 11:16:05 INFO - Vendor: Intel (0x8086) 11:16:05 INFO - Device ID: 0x0a2e 11:16:05 INFO - Revision ID: 0x0009 11:16:05 INFO - Displays: 11:16:05 INFO - Display: 11:16:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:16:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:16:05 INFO - Display Serial Number: 1600x1200 60 11:16:05 INFO - Main Display: Yes 11:16:05 INFO - Mirror: Off 11:16:05 INFO - Online: Yes 11:16:05 INFO - Rotation: Supported 11:16:05 INFO - Return code: 0 11:16:05 INFO - Running post-action listener: _resource_record_post_action 11:16:05 INFO - Running post-run listener: _resource_record_post_run 11:16:06 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 31849984; Write bytes: 497683968; Read time: 201; Write time: 1596 11:16:06 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194791936; Write bytes: 196540416; Read time: 17891; Write time: 446 11:16:06 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 30064128; Write bytes: 300135936; Read time: 186; Write time: 1147 11:16:06 INFO - Running post-run listener: _upload_blobber_files 11:16:06 INFO - Blob upload gear active. 11:16:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:16:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:16:07 INFO - (blobuploader) - INFO - Open directory for files ... 11:16:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:16:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:16:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:08 INFO - (blobuploader) - INFO - Done attempting. 11:16:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:16:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:16:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:09 INFO - (blobuploader) - INFO - Done attempting. 11:16:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:16:09 INFO - Return code: 0 11:16:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:16:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:16:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cbe8908ed39baed6158fd36f5ee2fd0e3b3d7c227a355624fdff0e9734466160baae00bf7353ae26b5e1a94ed6f1eb437bcf4c1931bedeeebb28c558f0dcbc90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a575956959f9fcd9c36bccc4cb1304e12ab2f8b198cf3e7ba11f1cfaae67f3fdeb0b3158b15a48a00a28a89d6cba0c6c06ab2817df531b1a9e85cae477a571c"} 11:16:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:16:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:16:09 INFO - Contents: 11:16:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cbe8908ed39baed6158fd36f5ee2fd0e3b3d7c227a355624fdff0e9734466160baae00bf7353ae26b5e1a94ed6f1eb437bcf4c1931bedeeebb28c558f0dcbc90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a575956959f9fcd9c36bccc4cb1304e12ab2f8b198cf3e7ba11f1cfaae67f3fdeb0b3158b15a48a00a28a89d6cba0c6c06ab2817df531b1a9e85cae477a571c"} 11:16:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:16:09 INFO - Copying logs to upload dir... 11:16:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:16:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1308.184563 ========= master_lag: 1.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2016-06-20 11:16:10.873146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 11:16:10.878263) ========= 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.xIaipgqVtk/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.lrazNGPIQQ/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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/cbe8908ed39baed6158fd36f5ee2fd0e3b3d7c227a355624fdff0e9734466160baae00bf7353ae26b5e1a94ed6f1eb437bcf4c1931bedeeebb28c558f0dcbc90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a575956959f9fcd9c36bccc4cb1304e12ab2f8b198cf3e7ba11f1cfaae67f3fdeb0b3158b15a48a00a28a89d6cba0c6c06ab2817df531b1a9e85cae477a571c"} build_url:https://queue.taskcluster.net/v1/task/PxTKtI7XT2OPLqp2CT2y9g/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011052 build_url: 'https://queue.taskcluster.net/v1/task/PxTKtI7XT2OPLqp2CT2y9g/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/cbe8908ed39baed6158fd36f5ee2fd0e3b3d7c227a355624fdff0e9734466160baae00bf7353ae26b5e1a94ed6f1eb437bcf4c1931bedeeebb28c558f0dcbc90", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a575956959f9fcd9c36bccc4cb1304e12ab2f8b198cf3e7ba11f1cfaae67f3fdeb0b3158b15a48a00a28a89d6cba0c6c06ab2817df531b1a9e85cae477a571c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 11:16:10.915530) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 11:16:10.918900) ========= 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.xIaipgqVtk/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.lrazNGPIQQ/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.005083 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 11:16:10.967348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 11:16:10.967665) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 11:16:10.971238) ========= ========= Total master_lag: 1.93 =========