builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0130 starttime: 1467229817.94 results: success (0) buildid: 20160629104228 builduid: fddfdeed8ce640bc8a19331f3555eaf5 revision: b743fe6eabb8328430d91275462dc8e2a42eef81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:17.937615) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:17.938652) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:17.939380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:18.294413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:18.295177) ========= 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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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-29 12:50: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% 15.5M=0.001s 2016-06-29 12:50:18 (15.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124745 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:18.448875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:18.449662) ========= 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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.029393 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:18.503167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-29 12:50:18.503929) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b743fe6eabb8328430d91275462dc8e2a42eef81 --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 b743fe6eabb8328430d91275462dc8e2a42eef81 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WCXR2hzsUZ/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.E8ptozOTdx/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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-29 12:50:18,580 truncating revision to first 12 chars 2016-06-29 12:50:18,580 Setting DEBUG logging. 2016-06-29 12:50:18,580 attempt 1/10 2016-06-29 12:50:18,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b743fe6eabb8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 12:50:20,529 unpacking tar archive at: mozilla-beta-b743fe6eabb8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.210542 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-29 12:50:20.829259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:20.829574) ========= script_repo_revision: b743fe6eabb8328430d91275462dc8e2a42eef81 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:20.829986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:20.830249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 12:50:20.849880) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-29 12:50:20.850614) ========= /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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 12:50:21 INFO - MultiFileLogger online at 20160629 12:50:21 in /builds/slave/test 12:50: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 12:50:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:21 INFO - {'append_to_log': False, 12:50:21 INFO - 'base_work_dir': '/builds/slave/test', 12:50:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:50:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:21 INFO - 'branch': 'Mozilla-Beta', 12:50:21 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:21 INFO - 'config_files': ('talos/mac_config.py',), 12:50:21 INFO - 'default_actions': ('clobber', 12:50:21 INFO - 'read-buildbot-config', 12:50:21 INFO - 'download-and-extract', 12:50:21 INFO - 'populate-webroot', 12:50:21 INFO - 'create-virtualenv', 12:50:21 INFO - 'install', 12:50:21 INFO - 'run-tests'), 12:50:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:21 INFO - 'download_minidump_stackwalk': True, 12:50:21 INFO - 'download_symbols': 'ondemand', 12:50:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:50:21 INFO - 'tooltool.py': '/tools/tooltool.py', 12:50:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:50:21 INFO - '/tools/misc-python/virtualenv.py')}, 12:50:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:21 INFO - 'installer_path': 'installer.exe', 12:50:21 INFO - 'log_level': 'info', 12:50:21 INFO - 'log_name': 'talos', 12:50:21 INFO - 'log_to_console': True, 12:50:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:50:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:50:21 INFO - 'opt_config_files': (), 12:50:21 INFO - 'pip_index': False, 12:50:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:50:21 INFO - 'cmd': ('bash', 12:50:21 INFO - '-c', 12:50:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:50:21 INFO - 'enabled': True, 12:50:21 INFO - 'halt_on_failure': False, 12:50:21 INFO - 'name': 'check_screen_resolution'},), 12:50:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:50:21 INFO - 'cmd': ('bash', 12:50:21 INFO - '-c', 12:50:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:50:21 INFO - 'enabled': True, 12:50:21 INFO - 'halt_on_failure': False, 12:50:21 INFO - 'name': 'check_screen_resolution'},), 12:50:21 INFO - 'run_cmd_checks_enabled': True, 12:50:21 INFO - 'sps_profile': False, 12:50:21 INFO - 'sps_profile_interval': 0, 12:50:21 INFO - 'suite': 'dromaeojs-e10s', 12:50:21 INFO - 'system_bits': '32', 12:50:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:21 INFO - 'title': 't-yosemite-r7-0130', 12:50:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:21 INFO - 'use_talos_json': True, 12:50:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:21 INFO - 'work_dir': 'build'} 12:50:21 INFO - ##### 12:50:21 INFO - ##### Running clobber step. 12:50:21 INFO - ##### 12:50:21 INFO - Running pre-action listener: _resource_record_pre_action 12:50:21 INFO - Running main action method: clobber 12:50:21 INFO - rmtree: /builds/slave/test/build 12:50:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:22 INFO - Running post-action listener: _resource_record_post_action 12:50:22 INFO - ##### 12:50:22 INFO - ##### Running read-buildbot-config step. 12:50:22 INFO - ##### 12:50:22 INFO - Running pre-action listener: _resource_record_pre_action 12:50:22 INFO - Running main action method: read_buildbot_config 12:50:22 INFO - Using buildbot properties: 12:50:22 INFO - { 12:50:22 INFO - "project": "", 12:50:22 INFO - "product": "firefox", 12:50:22 INFO - "script_repo_revision": "production", 12:50:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 12:50:22 INFO - "repository": "", 12:50:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 12:50:22 INFO - "buildid": "20160629104228", 12:50:22 INFO - "pgo_build": "False", 12:50:22 INFO - "basedir": "/builds/slave/test", 12:50:22 INFO - "buildnumber": 8, 12:50:22 INFO - "slavename": "t-yosemite-r7-0130", 12:50:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:50:22 INFO - "platform": "yosemite_r7", 12:50:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:50:22 INFO - "branch": "mozilla-beta", 12:50:22 INFO - "repo_path": "releases/mozilla-beta", 12:50:22 INFO - "revision": "b743fe6eabb8328430d91275462dc8e2a42eef81", 12:50:22 INFO - "stage_platform": "macosx64", 12:50:22 INFO - "builduid": "fddfdeed8ce640bc8a19331f3555eaf5", 12:50:22 INFO - "slavebuilddir": "test" 12:50:22 INFO - } 12:50:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 12:50:22 INFO - Running post-action listener: _resource_record_post_action 12:50:22 INFO - ##### 12:50:22 INFO - ##### Running download-and-extract step. 12:50:22 INFO - ##### 12:50:22 INFO - Running pre-action listener: _resource_record_pre_action 12:50:22 INFO - Running main action method: download_and_extract 12:50:22 INFO - mkdir: /builds/slave/test/build/tests 12:50: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')]} 12:50:22 INFO - https://queue.taskcluster.net/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:50:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 12:50:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 12:50:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/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 12:50:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/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 12:50:30 INFO - Downloaded 1165 bytes. 12:50:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 12:50:30 INFO - Using the following test package requirements: 12:50:30 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 12:50:30 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:30 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 12:50:30 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:30 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 12:50:30 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:50:30 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:30 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 12:50:30 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 12:50:30 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:30 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 12:50:30 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:30 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 12:50:30 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:30 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 12:50:30 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 12:50:30 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 12:50:30 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 12:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:30 INFO - https://queue.taskcluster.net/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:50:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:50:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:50:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/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 12:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/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 12:50:33 INFO - Downloaded 18350417 bytes. 12:50:33 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'] 12:50:33 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 12:50:36 INFO - Return code: 0 12:50:36 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 12:50:36 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')]} 12:50:36 INFO - https://queue.taskcluster.net/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:50:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:50:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 12:50:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/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 12:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/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 12:50:40 INFO - Downloaded 18350417 bytes. 12:50:40 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'] 12:50:40 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 12:50:43 INFO - Return code: 0 12:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:43 INFO - https://queue.taskcluster.net/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 12:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 12:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/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 12:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/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 12:50:44 INFO - Downloaded 10840145 bytes. 12:50:44 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'] 12:50:44 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 12:50:45 INFO - Return code: 0 12:50:45 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')]} 12:50:45 INFO - https://queue.taskcluster.net/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 12:50:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:50:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:50:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 12:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ErahKSykSz6UV-BOOuHe_A/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 12:50:47 INFO - Downloaded 86200778 bytes. 12:50:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:50:47 INFO - mkdir: /builds/slave/test/properties 12:50:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:50:47 INFO - Writing to file /builds/slave/test/properties/build_url 12:50:47 INFO - Contents: 12:50:47 INFO - build_url:https://queue.taskcluster.net/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.dmg 12:50:48 INFO - Running post-action listener: _resource_record_post_action 12:50:48 INFO - Running post-action listener: set_extra_try_arguments 12:50:48 INFO - ##### 12:50:48 INFO - ##### Running populate-webroot step. 12:50:48 INFO - ##### 12:50:48 INFO - Running pre-action listener: _resource_record_pre_action 12:50:48 INFO - Running main action method: populate_webroot 12:50:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:50:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:50:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:50:48 INFO - '--tppagecycles', 12:50:48 INFO - '7'], 12:50:48 INFO - 'tests': ['tsvgm']}}, 12:50:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:50:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:50:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:50:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:50:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:50:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:50:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:48 INFO - 'talos_options': ['--disable-e10s'], 12:50:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:48 INFO - 'talos_options': ['--disable-e10s'], 12:50:48 INFO - 'tests': ['damp', 'tps']}, 12:50:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:48 INFO - 'tests': ['damp', 'tps']}, 12:50:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:50:48 INFO - 'tests': ['dromaeo_dom']}, 12:50:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:50:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:50:48 INFO - 'tests': ['a11yr', 12:50:48 INFO - 'ts_paint', 12:50:48 INFO - 'tpaint', 12:50:48 INFO - 'sessionrestore', 12:50:48 INFO - 'sessionrestore_no_auto_restore', 12:50:48 INFO - 'tabpaint']}, 12:50:48 INFO - 'other-e10s': {'tests': ['a11yr', 12:50:48 INFO - 'ts_paint', 12:50:48 INFO - 'tpaint', 12:50:48 INFO - 'sessionrestore', 12:50:48 INFO - 'sessionrestore_no_auto_restore', 12:50:48 INFO - 'tabpaint']}, 12:50:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:50:48 INFO - 'ts_paint', 12:50:48 INFO - 'tpaint', 12:50:48 INFO - 'sessionrestore', 12:50:48 INFO - 'sessionrestore_no_auto_restore', 12:50:48 INFO - 'tabpaint']}, 12:50:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:50:48 INFO - 'ts_paint', 12:50:48 INFO - 'tpaint', 12:50:48 INFO - 'sessionrestore', 12:50:48 INFO - 'sessionrestore_no_auto_restore', 12:50:48 INFO - 'tabpaint']}, 12:50:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:50:48 INFO - 'tests': ['a11yr', 12:50:48 INFO - 'ts_paint', 12:50:48 INFO - 'tpaint', 12:50:48 INFO - 'sessionrestore', 12:50:48 INFO - 'sessionrestore_no_auto_restore', 12:50:48 INFO - 'tabpaint']}, 12:50:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:50:48 INFO - 'tests': ['a11yr', 12:50:48 INFO - 'ts_paint', 12:50:48 INFO - 'tpaint', 12:50:48 INFO - 'sessionrestore', 12:50:48 INFO - 'sessionrestore_no_auto_restore', 12:50:48 INFO - 'tabpaint']}, 12:50:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:50:48 INFO - 'tests': ['tsvgx', 12:50:48 INFO - 'tsvgr_opacity', 12:50:48 INFO - 'tart', 12:50:48 INFO - 'tscrollx', 12:50:48 INFO - 'cart']}, 12:50:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:50:48 INFO - 'tsvgr_opacity', 12:50:48 INFO - 'tart', 12:50:48 INFO - 'tscrollx', 12:50:48 INFO - 'cart']}, 12:50:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:48 INFO - 'talos_options': ['--disable-e10s'], 12:50:48 INFO - 'tests': ['tp5o']}, 12:50:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:48 INFO - 'tests': ['tp5o']}, 12:50:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:48 INFO - 'talos_options': ['--disable-e10s', 12:50:48 INFO - '--xperf_path', 12:50:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:48 INFO - 'tests': ['tp5n']}, 12:50:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:48 INFO - 'talos_options': ['--xperf_path', 12:50:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:48 INFO - 'tests': ['tp5n']}}, 12:50:48 INFO - 'talos.zip': {'path': '', 12:50:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:50:48 INFO - Running post-action listener: _resource_record_post_action 12:50:48 INFO - ##### 12:50:48 INFO - ##### Running create-virtualenv step. 12:50:48 INFO - ##### 12:50:48 INFO - Running pre-action listener: _resource_record_pre_action 12:50:48 INFO - Running main action method: create_virtualenv 12:50:48 INFO - Creating virtualenv /builds/slave/test/build/venv 12:50:48 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 12:50:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:50:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:50:48 INFO - Using real prefix '/tools/python27' 12:50:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:50:49 INFO - Installing distribute.............................................................................................................................................................................................done. 12:50:51 INFO - Installing pip.................done. 12:50:51 INFO - Return code: 0 12:50:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:50:52 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')]} 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:52 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')]} 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:52 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 0x10284aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb590d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026e9e00>, '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 0x102552db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4b20>, '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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 12:50:52 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 12:50:52 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 12:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WCXR2hzsUZ/Render', 12:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:52 INFO - 'HOME': '/Users/cltbld', 12:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:52 INFO - 'LOGNAME': 'cltbld', 12:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:52 INFO - 'MOZ_NO_REMOTE': '1', 12:50:52 INFO - 'NO_EM_RESTART': '1', 12:50:52 INFO - 'PAGER': '/bin/cat', 12:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:52 INFO - 'PWD': '/builds/slave/test', 12:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:52 INFO - 'SHELL': '/bin/bash', 12:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E8ptozOTdx/Listeners', 12:50:52 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 12:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:52 INFO - 'USER': 'cltbld', 12:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:52 INFO - 'XPC_FLAGS': '0x0', 12:50:52 INFO - 'XPC_SERVICE_NAME': '0', 12:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:52 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 12:50:52 INFO - Cleaning up... 12:50:52 INFO - Return code: 0 12:50:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:50:52 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')]} 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:52 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')]} 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:52 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 0x10284aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb590d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026e9e00>, '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 0x102552db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4b20>, '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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 12:50:52 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 12:50:52 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 12:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WCXR2hzsUZ/Render', 12:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:52 INFO - 'HOME': '/Users/cltbld', 12:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:52 INFO - 'LOGNAME': 'cltbld', 12:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:52 INFO - 'MOZ_NO_REMOTE': '1', 12:50:52 INFO - 'NO_EM_RESTART': '1', 12:50:52 INFO - 'PAGER': '/bin/cat', 12:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:52 INFO - 'PWD': '/builds/slave/test', 12:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:52 INFO - 'SHELL': '/bin/bash', 12:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E8ptozOTdx/Listeners', 12:50:52 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 12:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:52 INFO - 'USER': 'cltbld', 12:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:52 INFO - 'XPC_FLAGS': '0x0', 12:50:52 INFO - 'XPC_SERVICE_NAME': '0', 12:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:52 INFO - Downloading/unpacking psutil>=0.7.1 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:50:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:55 INFO - Installing collected packages: psutil 12:50:55 INFO - Running setup.py install for psutil 12:50:55 INFO - building 'psutil._psutil_osx' extension 12:50:55 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 12:50:56 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 12:50:56 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 12:50:56 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 12:50:56 INFO - building 'psutil._psutil_posix' extension 12:50:56 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 12:50:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:50:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:50:56 INFO - ^ 12:50:56 INFO - 1 warning generated. 12:50:56 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 12:50:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:56 INFO - Successfully installed psutil 12:50:56 INFO - Cleaning up... 12:50:56 INFO - Return code: 0 12:50:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:50:56 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')]} 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:56 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')]} 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:56 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 0x10284aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb590d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026e9e00>, '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 0x102552db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4b20>, '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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 12:50:56 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 12:50:56 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 12:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WCXR2hzsUZ/Render', 12:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:56 INFO - 'HOME': '/Users/cltbld', 12:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:56 INFO - 'LOGNAME': 'cltbld', 12:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:56 INFO - 'MOZ_NO_REMOTE': '1', 12:50:56 INFO - 'NO_EM_RESTART': '1', 12:50:56 INFO - 'PAGER': '/bin/cat', 12:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:56 INFO - 'PWD': '/builds/slave/test', 12:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:56 INFO - 'SHELL': '/bin/bash', 12:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E8ptozOTdx/Listeners', 12:50:56 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 12:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:56 INFO - 'USER': 'cltbld', 12:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:56 INFO - 'XPC_FLAGS': '0x0', 12:50:56 INFO - 'XPC_SERVICE_NAME': '0', 12:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:50:59 INFO - Installing collected packages: mozsystemmonitor 12:50:59 INFO - Running setup.py install for mozsystemmonitor 12:50:59 INFO - Successfully installed mozsystemmonitor 12:50:59 INFO - Cleaning up... 12:50:59 INFO - Return code: 0 12:50:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:50: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')]} 12:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50: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')]} 12:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:59 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 0x10284aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb590d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026e9e00>, '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 0x102552db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4b20>, '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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 12:50:59 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 12:50:59 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 12:50:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WCXR2hzsUZ/Render', 12:50:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:50:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:50:59 INFO - 'HOME': '/Users/cltbld', 12:50:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:50:59 INFO - 'LOGNAME': 'cltbld', 12:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:59 INFO - 'MOZ_NO_REMOTE': '1', 12:50:59 INFO - 'NO_EM_RESTART': '1', 12:50:59 INFO - 'PAGER': '/bin/cat', 12:50:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:59 INFO - 'PWD': '/builds/slave/test', 12:50:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:50:59 INFO - 'SHELL': '/bin/bash', 12:50:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E8ptozOTdx/Listeners', 12:50:59 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 12:50:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:50:59 INFO - 'USER': 'cltbld', 12:50:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:50:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:59 INFO - 'XPC_FLAGS': '0x0', 12:50:59 INFO - 'XPC_SERVICE_NAME': '0', 12:50:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:00 INFO - Downloading/unpacking blobuploader==1.2.4 12:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:02 INFO - Downloading blobuploader-1.2.4.tar.gz 12:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:51:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:51:02 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 12:51:02 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 12:51:02 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 12:51:02 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 12:51:02 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 12:51:02 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 12:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:51:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:51:03 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 12:51:03 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 12:51:03 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 12:51:03 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 12:51:03 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 12:51:03 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 12:51:03 INFO - Downloading docopt-0.6.1.tar.gz 12:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:51:03 INFO - Installing collected packages: blobuploader, requests, docopt 12:51:03 INFO - Running setup.py install for blobuploader 12:51:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:51:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:51:04 INFO - Running setup.py install for requests 12:51:04 INFO - Running setup.py install for docopt 12:51:04 INFO - Successfully installed blobuploader requests docopt 12:51:04 INFO - Cleaning up... 12:51:04 INFO - Return code: 0 12:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:04 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 0x10284aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb590d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026e9e00>, '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 0x102552db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4b20>, '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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 12:51:04 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 12:51:04 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 12:51:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WCXR2hzsUZ/Render', 12:51:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:04 INFO - 'HOME': '/Users/cltbld', 12:51:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:04 INFO - 'LOGNAME': 'cltbld', 12:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:04 INFO - 'MOZ_NO_REMOTE': '1', 12:51:04 INFO - 'NO_EM_RESTART': '1', 12:51:04 INFO - 'PAGER': '/bin/cat', 12:51:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:04 INFO - 'PWD': '/builds/slave/test', 12:51:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:04 INFO - 'SHELL': '/bin/bash', 12:51:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E8ptozOTdx/Listeners', 12:51:04 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 12:51:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:04 INFO - 'USER': 'cltbld', 12:51:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:04 INFO - 'XPC_FLAGS': '0x0', 12:51:04 INFO - 'XPC_SERVICE_NAME': '0', 12:51:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:05 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-yudsYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:05 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-b6j40G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:05 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-bzWj9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:05 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-n8Jmqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:05 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-EYRacy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:05 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-ZKgoNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:05 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-5jccco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:05 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Xa7zOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:05 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-lqYsLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:05 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-JznkL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-MmRk1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-mUD9Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-0xUAAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-6VDn08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-E9pjn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-efJFeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-BI43FK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:51:06 INFO - Running setup.py install for manifestparser 12:51:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:51:06 INFO - Running setup.py install for mozcrash 12:51:07 INFO - Running setup.py install for mozdebug 12:51:07 INFO - Running setup.py install for mozdevice 12:51:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozfile 12:51:07 INFO - Running setup.py install for mozhttpd 12:51:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozinfo 12:51:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozInstall 12:51:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozleak 12:51:08 INFO - Running setup.py install for mozlog 12:51:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Running setup.py install for moznetwork 12:51:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Running setup.py install for mozprocess 12:51:08 INFO - Running setup.py install for mozprofile 12:51:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Running setup.py install for mozrunner 12:51:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Running setup.py install for mozscreenshot 12:51:09 INFO - Running setup.py install for moztest 12:51:09 INFO - Running setup.py install for mozversion 12:51:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:51:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:09 INFO - Cleaning up... 12:51:09 INFO - Return code: 0 12:51:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:09 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 0x10284aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb590d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026e9e00>, '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 0x102552db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4b20>, '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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 12:51:09 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 12:51:09 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 12:51:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WCXR2hzsUZ/Render', 12:51:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:09 INFO - 'HOME': '/Users/cltbld', 12:51:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:09 INFO - 'LOGNAME': 'cltbld', 12:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:09 INFO - 'MOZ_NO_REMOTE': '1', 12:51:09 INFO - 'NO_EM_RESTART': '1', 12:51:09 INFO - 'PAGER': '/bin/cat', 12:51:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:09 INFO - 'PWD': '/builds/slave/test', 12:51:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:09 INFO - 'SHELL': '/bin/bash', 12:51:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E8ptozOTdx/Listeners', 12:51:09 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 12:51:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:09 INFO - 'USER': 'cltbld', 12:51:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:09 INFO - 'XPC_FLAGS': '0x0', 12:51:09 INFO - 'XPC_SERVICE_NAME': '0', 12:51:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:09 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-0xeMpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:09 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-x7TUVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:09 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-0hfUXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:09 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-qWTW2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:10 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-2NEqPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:10 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-dIOvu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:10 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-tKEwXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:10 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-E3Nouu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:10 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-K1Oj8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:10 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-NwGa3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:10 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-y62S0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:10 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-lAY65X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:10 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-gc2MSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:11 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)) 12:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-rQjeIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:11 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)) 12:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-E5ChyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:11 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)) 12:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-YbtB1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:11 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)) 12:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-JuqoMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 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)) 12:51:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51:14 INFO - Downloading blessings-1.6.tar.gz 12:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:14 INFO - Installing collected packages: blessings 12:51:14 INFO - Running setup.py install for blessings 12:51:14 INFO - Successfully installed blessings 12:51:14 INFO - Cleaning up... 12:51:14 INFO - Return code: 0 12:51:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:14 INFO - Reading from file tmpfile_stdout 12:51:14 INFO - Current package versions: 12:51:14 INFO - blessings == 1.6 12:51:14 INFO - blobuploader == 1.2.4 12:51:14 INFO - docopt == 0.6.1 12:51:14 INFO - manifestparser == 1.1 12:51:14 INFO - mozInstall == 1.12 12:51:14 INFO - mozcrash == 0.17 12:51:14 INFO - mozdebug == 0.1 12:51:14 INFO - mozdevice == 0.48 12:51:14 INFO - mozfile == 1.2 12:51:14 INFO - mozhttpd == 0.7 12:51:14 INFO - mozinfo == 0.9 12:51:14 INFO - mozleak == 0.1 12:51:14 INFO - mozlog == 3.1 12:51:14 INFO - moznetwork == 0.27 12:51:14 INFO - mozprocess == 0.22 12:51:14 INFO - mozprofile == 0.28 12:51:14 INFO - mozrunner == 6.11 12:51:14 INFO - mozscreenshot == 0.1 12:51:14 INFO - mozsystemmonitor == 0.0 12:51:14 INFO - moztest == 0.7 12:51:14 INFO - mozversion == 1.4 12:51:14 INFO - psutil == 3.1.1 12:51:14 INFO - requests == 1.2.3 12:51:14 INFO - wsgiref == 0.1.2 12:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:15 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 0x10284aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb590d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026e9e00>, '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 0x102552db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4b20>, '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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 12:51:15 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 12:51:15 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 12:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WCXR2hzsUZ/Render', 12:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:15 INFO - 'HOME': '/Users/cltbld', 12:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:15 INFO - 'LOGNAME': 'cltbld', 12:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:15 INFO - 'MOZ_NO_REMOTE': '1', 12:51:15 INFO - 'NO_EM_RESTART': '1', 12:51:15 INFO - 'PAGER': '/bin/cat', 12:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:15 INFO - 'PWD': '/builds/slave/test', 12:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:15 INFO - 'SHELL': '/bin/bash', 12:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E8ptozOTdx/Listeners', 12:51:15 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 12:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:15 INFO - 'USER': 'cltbld', 12:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:15 INFO - 'XPC_FLAGS': '0x0', 12:51:15 INFO - 'XPC_SERVICE_NAME': '0', 12:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:15 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)) 12:51:15 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)) 12:51:15 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)) 12:51:15 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)) 12:51:15 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)) 12:51:15 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)) 12:51:15 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)) 12:51:15 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)) 12:51:15 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)) 12:51:15 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)) 12:51:15 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)) 12:51:15 INFO - Cleaning up... 12:51:15 INFO - Return code: 0 12:51:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10284aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb590d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026e9e00>, '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 0x102552db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4b20>, '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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 12:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WCXR2hzsUZ/Render', 12:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:15 INFO - 'HOME': '/Users/cltbld', 12:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:15 INFO - 'LOGNAME': 'cltbld', 12:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:15 INFO - 'MOZ_NO_REMOTE': '1', 12:51:15 INFO - 'NO_EM_RESTART': '1', 12:51:15 INFO - 'PAGER': '/bin/cat', 12:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:15 INFO - 'PWD': '/builds/slave/test', 12:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:15 INFO - 'SHELL': '/bin/bash', 12:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E8ptozOTdx/Listeners', 12:51:15 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 12:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:15 INFO - 'USER': 'cltbld', 12:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:15 INFO - 'XPC_FLAGS': '0x0', 12:51:15 INFO - 'XPC_SERVICE_NAME': '0', 12:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:15 INFO - Downloading/unpacking jsonschema 12:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:51:18 INFO - Downloading/unpacking functools32 (from jsonschema) 12:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:18 INFO - Downloading functools32-3.2.3-2.tar.gz 12:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:51:18 INFO - warning: no files found matching '*.txt' 12:51:18 INFO - no previously-included directories found matching 'build' 12:51:18 INFO - no previously-included directories found matching 'dist' 12:51:18 INFO - no previously-included directories found matching '.git*' 12:51:18 INFO - Installing collected packages: jsonschema, functools32 12:51:18 INFO - Running setup.py install for functools32 12:51:18 INFO - warning: no files found matching '*.txt' 12:51:18 INFO - no previously-included directories found matching 'build' 12:51:18 INFO - no previously-included directories found matching 'dist' 12:51:18 INFO - no previously-included directories found matching '.git*' 12:51:18 INFO - Successfully installed jsonschema functools32 12:51:18 INFO - Cleaning up... 12:51:19 INFO - Return code: 0 12:51:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:19 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 0x10284aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb590d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026e9e00>, '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 0x102552db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4b20>, '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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 12:51:19 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 12:51:19 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 12:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WCXR2hzsUZ/Render', 12:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:19 INFO - 'HOME': '/Users/cltbld', 12:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:19 INFO - 'LOGNAME': 'cltbld', 12:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:19 INFO - 'MOZ_NO_REMOTE': '1', 12:51:19 INFO - 'NO_EM_RESTART': '1', 12:51:19 INFO - 'PAGER': '/bin/cat', 12:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:19 INFO - 'PWD': '/builds/slave/test', 12:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:19 INFO - 'SHELL': '/bin/bash', 12:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E8ptozOTdx/Listeners', 12:51:19 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 12:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:19 INFO - 'USER': 'cltbld', 12:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:19 INFO - 'XPC_FLAGS': '0x0', 12:51:19 INFO - 'XPC_SERVICE_NAME': '0', 12:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:19 INFO - Downloading/unpacking flake8 12:51:19 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 12:51:19 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 12:51:19 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 12:51:19 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 12:51:19 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 12:51:19 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 12:51:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:51:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:51:21 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 12:51:21 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 12:51:21 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 12:51:21 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 12:51:21 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 12:51:21 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 12:51:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:51:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:51:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:23 INFO - no previously-included directories found matching 'docs/_build' 12:51:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:51:23 INFO - Running setup.py install for pep8 12:51:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:23 INFO - no previously-included directories found matching 'docs/_build' 12:51:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:51:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:51:23 INFO - Cleaning up... 12:51:23 INFO - Return code: 0 12:51:23 INFO - Running post-action listener: _resource_record_post_action 12:51:23 INFO - Running post-action listener: _start_resource_monitoring 12:51:23 INFO - Starting resource monitoring. 12:51:23 INFO - ##### 12:51:23 INFO - ##### Running install step. 12:51:23 INFO - ##### 12:51:23 INFO - Running pre-action listener: _resource_record_pre_action 12:51:23 INFO - Running main action method: install 12:51:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:23 INFO - Reading from file tmpfile_stdout 12:51:23 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:51:23 INFO - Reading from file tmpfile_stdout 12:51:23 INFO - Output received: 12:51:23 INFO - Usage: mozinstall [options] installer 12:51:23 INFO - Options: 12:51:23 INFO - -h, --help show this help message and exit 12:51:23 INFO - -d DEST, --destination=DEST 12:51:23 INFO - Directory to install application into. [default: 12:51:23 INFO - "/builds/slave/test"] 12:51:23 INFO - --app=APP Application being installed. [default: firefox] 12:51:23 INFO - mkdir: /builds/slave/test/build/application 12:51:23 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'] 12:51:23 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 12:51:45 INFO - Reading from file tmpfile_stdout 12:51:45 INFO - Output received: 12:51:45 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:51:45 INFO - Running post-action listener: _resource_record_post_action 12:51:45 INFO - ##### 12:51:45 INFO - ##### Running run-tests step. 12:51:45 INFO - ##### 12:51:45 INFO - Running pre-action listener: _resource_record_pre_action 12:51:45 INFO - Running main action method: run_tests 12:51:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:51:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:51:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:51:45 INFO - 2016-06-29 12:51:45.471 screenresolution[1638:7547] starting screenresolution argv=screenresolution get 12:51:45 INFO - 2016-06-29 12:51:45.474 screenresolution[1638:7547] Display 0: 1600x1200x32@60 12:51:45 INFO - 2016-06-29 12:51:45.480 screenresolution[1639:7550] starting screenresolution argv=screenresolution list 12:51:45 INFO - Available Modes on Display 0 12:51:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:51:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:51:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:51:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:51:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:51:45 INFO - Intel Iris: 12:51:45 INFO - Chipset Model: Intel Iris 12:51:45 INFO - Type: GPU 12:51:45 INFO - Bus: Built-In 12:51:45 INFO - VRAM (Dynamic, Max): 1536 MB 12:51:45 INFO - Vendor: Intel (0x8086) 12:51:45 INFO - Device ID: 0x0a2e 12:51:45 INFO - Revision ID: 0x0009 12:51:45 INFO - Displays: 12:51:45 INFO - Display: 12:51:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:51:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:51:45 INFO - Display Serial Number: 1600x1200 60 12:51:45 INFO - Main Display: Yes 12:51:45 INFO - Mirror: Off 12:51:45 INFO - Online: Yes 12:51:45 INFO - Rotation: Supported 12:51:45 INFO - Return code: 0 12:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:45 INFO - Python 2.7.3 12:51:45 INFO - Return code: 0 12:51:45 INFO - grabbing minidump binary from tooltool 12:51:45 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')]} 12:51:45 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 0x1026e9e00>, '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 0x102552db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:45 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 12:51:45 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 12:51:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:45 INFO - Return code: 0 12:51:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:51:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:51:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:51:46 INFO - Return code: 0 12:51:46 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/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 12:51:46 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/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0130 --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 12:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WCXR2hzsUZ/Render', 12:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:51:46 INFO - 'HOME': '/Users/cltbld', 12:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:51:46 INFO - 'LOGNAME': 'cltbld', 12:51:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:46 INFO - 'MOZ_NO_REMOTE': '1', 12:51:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:46 INFO - 'NO_EM_RESTART': '1', 12:51:46 INFO - 'PAGER': '/bin/cat', 12:51:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:46 INFO - 'PWD': '/builds/slave/test', 12:51:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:51:46 INFO - 'SHELL': '/bin/bash', 12:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E8ptozOTdx/Listeners', 12:51:46 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 12:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:51:46 INFO - 'USER': 'cltbld', 12:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:46 INFO - 'XPC_FLAGS': '0x0', 12:51:46 INFO - 'XPC_SERVICE_NAME': '0', 12:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:51:46 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/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 12:51:47 INFO - mozversion application_buildid: 20160629104228 12:51:47 INFO - mozversion application_changeset: b743fe6eabb8328430d91275462dc8e2a42eef81 12:51:47 INFO - mozversion application_display_name: Firefox 12:51:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:47 INFO - mozversion application_name: Firefox 12:51:47 INFO - mozversion application_remotingname: firefox 12:51:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:51:47 INFO - mozversion application_vendor: Mozilla 12:51:47 INFO - mozversion application_version: 48.0 12:51:47 INFO - mozversion platform_buildid: 20160629104228 12:51:47 INFO - mozversion platform_changeset: b743fe6eabb8328430d91275462dc8e2a42eef81 12:51:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:51:47 INFO - mozversion platform_version: 48.0 12:51:47 INFO - using testdate: 1467229907 12:51:47 INFO - actual date: 1467229907 12:51:47 INFO - starting webserver on 'localhost:49276' 12:51:47 INFO - SUITE-START | Running 2 tests 12:51:47 INFO - TEST-START | dromaeo_css 12:51:47 INFO - operating with platform_type : mac_ 12:51:47 INFO - Initialising browser for dromaeo_css test... 12:51:47 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpjJzq8l/profile http://localhost:49276/getInfo.html) 12:51:49 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 12:51:49 INFO - PROCESS | 1657 | colorDepth:24 12:51:49 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 12:51:49 INFO - PROCESS | 1657 | __metrics 12:51:50 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 12:51:50 INFO - TEST-INFO | 1657: exit 0 12:51:50 INFO - Browser initialized. 12:51:50 INFO - Running cycle 1/1 for dromaeo_css test... 12:51:50 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpjJzq8l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:52:02 INFO - PROCESS | 1661 | RSS: Main: 170942464 12:52:02 INFO - PROCESS | 1661 | 12:52:52 INFO - PROCESS | 1661 | 1467229972116 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] 12:55:02 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 12:55:03 INFO - PROCESS | 1661 | RSS: Main: 181710848 12:55:03 INFO - PROCESS | 1661 | 12:58:05 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 12:58:06 INFO - PROCESS | 1661 | RSS: Main: 192401408 12:58:06 INFO - PROCESS | 1661 | 13:01:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 13:01:08 INFO - PROCESS | 1661 | RSS: Main: 194572288 13:01:08 INFO - PROCESS | 1661 | 13:04:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 13:04:10 INFO - PROCESS | 1661 | RSS: Main: 198258688 13:04:10 INFO - PROCESS | 1661 | 13:07:13 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 13:07:13 INFO - PROCESS | 1661 | RSS: Main: 197447680 13:07:13 INFO - PROCESS | 1661 | 13:10:16 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 13:10:16 INFO - PROCESS | 1661 | RSS: Main: 202260480 13:10:16 INFO - PROCESS | 1661 | 13:10:16 INFO - PROCESS | 1661 | __start_tp_report 13:10:16 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 13:10:16 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 13:10:16 INFO - PROCESS | 1661 | |i|pagename|runs| 13:10:16 INFO - PROCESS | 1661 | |0;dojo.html;3665.1386924072845;3682.558093028835;3687.631236876311;3711.53605799275;3737.588865224825;5954.196183515224;5965.642061476309;6007.729652165652;6008.429199226067;6019.879602407955;5993.220881285438;5993.700314984255;6041;6044.184035155253;6047.637141771497;5338.492843179892;5393.406725260218;5428.4028756836715;5471.398146203915;5500.202470641754;5350.973245133769;5434.967356202329;5441.129419292914;5456.781728730846;5477.835664930059;5406.135018397057;5426.67439953604;5461.317335333083;5535.529479994185;5563.054280772279;5416.891662166754;5451.291332126838;5451.836444906659;5453.590980676426;5471.425500322488;5243.659162154448;5356.95539369823;5361.035013697533;5379.731013449312;5386;4730.574248317634;5697.857553561153;5775.422457754233;5831.737571809279;5840.853978650568;6271.937280627227;6295.338989406138;6297.527685423565;6314.179156709644;6332.525060620425;6231.096491008823;6261.7182226799905;6337.112804207414;6356.682165891733;6360.55476116672;5416.593755468356;6113.205283313186;6138.048602466625;6138.281281241259;6155.569110162291;6222.346653601307;6442.645654489048;6508;6509.665518568777;6577.34226577348;6212.347703491068;6226.875462490725;6228.408301211378;6293.779717709858;6310.337414571404;6329.936700633027;6338.334474880071;6338.524610654219;6340.270868850049;6348.206474190726;6268.937310626927;6276.623402595767;6283.59156654816;6284.968575157095;6311.684415779193;6174.66039367839;6226.128342032119;6240;6255.280642726145;6313.179286692793;4262.7016108872085;5036.471170527115;5093.2360145977655;5101.897962040738;5106.4382917879;4594.874255807348;4635.629149668086;4635.7450340230935;4642.16441040616;4644.9767751161025;4955.40535135786;5964.135200396005;6016.548758843017;6055.182550355734;6056.303525094582;6329.095026002104;6357.745690172342;6360.745570177233;6381.489480841522;6393.009083592051;5942.227510423617;6026.035834266497;6066.423689749467;6091.269047714302;6095.786647467317;5492.423295553909;5550.306211723535;5579.163125531121;5591.133374326986;5663.830085097454;6606.141201643755;6633.104530888461;6666.300038495888;6674.83312917181;6709.731610735614;6255.374462553708;6426.903596445964;6435.292117866938;6443.162388889415;6450.580712253689;6501.609903405811;6561.573497722633;6567.211934567691;6598.472122230114;6616.867662646817;6291.591046581958;6310.936890631035;6317.115603815378;6319;6344.27040890285;5723.856903577277;6177.567570270038;6390.201224846895;6391.9041214380895;6424.678766061585;4474.306482495218;6247.094171345038;6252.937470625236;6253.062040693932;6291.213598300213;6239.407256310643;6252.187215661935;6253.093301471352;6259.436650701458;6260.499160067275;6035.758569657341;6082.087686847009;6104.511639068775;6115.724792384264;6183.752649893954;6237.1891654084675;6250.406211409909;6260.843478912881;6264.843378915563;6277.30949595535;6141.324454309933;6148.44663980244;6152.846178845564;6166.167567378526;6169.136320915165 13:10:16 INFO - PROCESS | 1661 | |1;ext.html;541.3774159716326;547.9643473834453;584.8420926349888;600.6966481926627;611.8314020221376;38928.805355973214;39654.80172599133;39681.99999999996;39887.601123988825;39913;41250.38124428136;41739.37390939138;41774;41972.37041444373;41991.790041049826;9727.36772109814;9906.20750339971;9938.602455901755;9951.004899510028;9970;9873.456959867204;9881;9916;9958.153556947667;9978.251631127658;9928.6524971626;9960.501974901263;10004.549795259194;10009.949950250239;10014.849777253346;8619.6983105591;9929.205663546934;9982;10011.349262297963;10020.749481262954;7908.248716371993;8645.265152462049;9022.684206052756;9894.90105098947;9904.207663386911;33209;39909.80045099785;40171.393144274196;40261.798691006356;40361.99095022648;2886.7401933825845;3324.4680851063713;3357.78174418662;3494.196334842975;3516.296740651854;24174.51650966971;27269.500532412127;27408.45183096327;27783;29311.706882931325;2617.7827310300613;2779.2496026072845;2814.831110133378;2820.661520617539;2838.5600231964077;398841;434181;435161;437813;439070;37617.62382376196;65946.67026664836;66314;66382;66472.66763666151;30511.847440762653;35208;36916;37200;37203.62796372056;14432.422703091968;16167.676646467005;16226;16737.995720256822;16811.57971050709;13942.302884855717;13943.930280348533;13974.860251397356;14077.366518506691;14342.85657143436;8449.619767110495;8544.102869198769;8613.78465538354;8621.61202745878;8691.304695624334;3215.6141263048585;3532.4877892705413;3571.4642803579673;3572.303400836864;3588.1926566522325;990.3216296836546;1039.8024375368807;1061.3260579531898;1103.6137351926923;1165.2542372881362;29183;29288.560671589516;29668.961586344376;29965.550516742267;30190.547141792453;896.4038914122166;1054.8154073037188;1145.8395824584566;1173.1729130962651;1214.332117335462;15164.772528412082;15233.695326093637;15336.539903802905;15374.308156133;15557.45548905783;664578;671398;680546.5972670204;686290.8427289358;688739;61540;62600.68699656564;63249.05126423107;63448;63474.68262658749;1576.2985471465088;1577.9921100394424;1585.651156745514;1597.6485173262097;1603.7033148867497;25399;29518.262043449085;29934.850325749103;30162.54756178703;30259.848700756356;52703.73648131735;59925;60277;61592;61819.690901545204;557403;562962;569798;570619;571467;42549.5745042558;42923.92690182645;43377.783111084245;43976.34035489534;44695;35685.82157089198;47030.76484617555;47990.760046199546;48201.75899120482;49755.75122124366;38295.42556861594;38670;39224.62713805003;39314.410283845194;39582.604173957894;38393.4240986391;38446.615533844306;38930;39021.6097839018;39416.81749547518;38630;38894;39080.218395632495;39214.80392598133;39671.80164099161;29684.851575741985;31236.379630925596;32086.197845053128;35265.47101793424;35951.820240898625;25484.745152548236;25590.87204563965;25610.615840762777;25906.611400828624;26063.348416288987 13:10:16 INFO - PROCESS | 1661 | |2;jquery.html;373.20134911289847;410.09369293860567;415.9417681524585;416.62920001198927;421.5194678067004;20727.85996770177;21422.892885535588;21428.785712142893;21499.677504837422;22473;22316.884155792228;22497;22632.321030369076;22839.54320913581;23110.30669079926;5794.971025144879;6161.445469907708;6162.537809664271;6315.463185629227;6322.367763223687;6099.268087829467;6115.266168059817;6119.847003824895;6193.1020002099895;6246.531510136735;6023.427774361428;6196.535259855506;6207.317195108534;6233.127362169277;6251.781187658433;5683.3464151622675;6122.63264204147;6131.816045518619;6143.354947730469;6170.660613666247;5654.74553645087;5797.536197104264;5809.186713860063;5810.1865738796605;5810.767569297223;15138.848611513855;25427.61858572123;26131.82406791699;26337.341566460993;26528.87768978477;2142.2716276466076;2202.933911982643;2294.7475777664445;2438.000419827862;2602.5445547029385;10054.447005414699;10654.041136297692;11570.884291157065;14380.280985950661;15342.923285383613;1793.9641207175782;1806.2323512507132;1832.395309547846;1843.732658764485;1883.6421079994757;88036.55981720114;88924.55537722334;114583;118221.40889295585;118279;11864.110191735654;11981.101417393731;12015.639530814089;12022.27866328023;12025.579104731292;15325.23373831304;15411.61470963235;15432.38270469191;15439;15449;7841.490303130278;9347.953260233791;9386.85919711205;9456.905430945602;9575.856362154573;7731.38148948094;9523.476208808443;9523.57143928525;9594.472304023206;9655.275854310954;4778.354922085544;4852.126617208865;4863.659543831968;4873.805047798049;4894.2658601210105;2049.702793094993;2094.6334391481428;2109.4304537774715;2150.892455377225;2151.634222182233;935.4060171790961;981.6711401680374;997.1374760831828;1040.6565833275001;1095.9726006849733;19347.90326048389;19728.408147755592;21362.465938351666;21698;21803.454913627287;879.6657270237397;1007.2495990487134;1016.2936758952604;1023.1814548361281;1025.4257615735212;10982.341059536293;11515.309081454972;11564.42177891102;11572.76854462906;11608.709782255342;638586;651951;662111;665547;672047;102483.95032099316;128073.35963320124;131328.68671313356;136169.3191534036;136263.6373636271;1023.7952409517977;1060.7984482948216;1063.3088492479794;1064.3241541621126;1079.5735684404617;16646.16769161513;18266.721329506807;18702.812971870106;19061.332853350064;19222.327218547285;43248;54377.72811135919;55591.88816223572;57022;57242.42757572371;49858.75070624624;70549.64725176341;74815.62592187004;74977.62511187409;83743.5812820932;8174.877376839471;8465.98408191021;8539.359548034046;8572.314214862921;8812.51531165792;9420.293477989042;10097.798044038931;12753.362331883554;13285.269310188032;13910.374033168735;11490.138239632228;11613.012893904113;11747.647570572897;11938.940305298418;12008.819867702166;11413.201075924937;11426.48981506431;11428.71428214268;11585.594504192313;11696.532138714356;11855.466504007512;11917.284962902253;11936.4031798408;12174.513019479122;12348.629541113782;8699.91300086991;8846.690365837165;8896.86654700193;12088.15382923187;13424.127431716906;5666.405027472056;9014.414063085878;11738.178327517333;12068.456919438822;12212.145149839782 13:10:16 INFO - PROCESS | 1661 | |3;mootools.html;1593.187474388062;1646.1275523972295;1945.338584881141;2049.4876280929766;2051.9897400512996;8206.876896846552;8826.823463530742;8914.64341426343;9188.908110918888;9189.1729744323;8865.980412252593;8908.28733701304;8935.972363178236;8960.05919378464;9030.187283144516;2518.1690042286095;2526.2042456626195;2550.464402475473;2551.107112510625;2557.9872100639473;2486.490269494749;2543.6438898554125;2549.910753123641;2559.9744002560014;2565.7049439314533;2537.936551586207;2584.6898372195365;2585.017693276552;2585.4441295121546;2591.3521619595103;2537.2895589235045;2553.948921021588;2565.6921169459597;2572.3954870605394;2573.5367633825904;2537.099329737935;2546.0197823837957;2559.705633852094;2573.6782902137234;2575.7681808637312;7739.7678069658;8999.370044096915;9020.14308640678;9053.818923621557;9107.08929107084;5455.1271796512365;5550.77796888124;5601.635893666939;5636.549076073904;5693.459121383462;3595.406757884946;3645.562532496091;3709.6290370962956;3732.4774531565604;3745.513083299181;1061.7611037516574;1081.3619964221068;1083.9945800271028;1084.0352086642895;1084.1814430105298;11944.283342999448;12253.632391028283;12280.01759859209;12293.3238671873;12296.938515307456;4892.486288939681;4899.485554016848;4917.729524876167;4984.750762461862;5026.698398096126;10273.537690803932;10306.33008854422;10326.225533084898;10333.741656458498;10339.896601034045;5521.1442226454965;5638.210650508932;5654.491095801398;5666.235058267163;5667.603267771299;4549.840755573605;4943.752812359367;5022.974885125551;5034.993001399662;5046.1926091825135;4169.187008533307;4200.873973780792;4245.87262382129;4270.807813648394;4278.272693642089;1356.830396200475;1384.4462215114036;1395.4418232706998;1397.0569865340854;1408.9929550352183;811.7645882694071;911.6444586611227;964.1515466389533;983.6901376066517;984.675057231112;6111.755529778848;6136.110264011782;6171.6297022178815;6177.907331390033;6211.192544969125;413.86342506972625;479.77930152129716;480.79085597765084;486.20505473551;487.8341363936208;3968.0873399118364;3985;4118.814653340607;4147.875563733093;4151.813168407429;10735.355878647306;11132.554697811996;11140;11179.937905898927;11194;9259.842519685038;10280.485975701185;10384.792304153874;10546.314489558154;11034.282771619819;8364.205400486944;8415.158484151536;8434.578271086544;8551.74344769658;8732.301415886714;5508.228847961209;5806.767729290781;6128.356522565245;6139.2325959255095;6305.076951529827;8944.955275223581;9714.951425242829;9850.458224797705;9869.605215791575;9999.600015999278;10085.848712269468;10140.340877842917;10146.289759716748;10148.340357876714;10179.389236645826;7027.9297207027275;7611.124720656974;7661.502002369828;8171.182881711781;8372.120927302789;8377.623006964823;8397.496150231005;8405.621747021276;8431.40980131385;8477;7354.448416368687;7539.32146106853;7594.202608726005;7667.079950405764;7740.3420709240345;7277.636118194175;7433.628318583941;7473.663685134291;7601.239876012354;7656.502327348704;7048.330408611174;7123.85752284941;7180.7845764627145;7189.640517973976;7195.100612423447;4993.675411098267;5049.6465247432325;5100.158473851773;5141.357330333708;5161.251618515369;4997.075541024922;5155.819546316011;5168.173092305213;5244.475552444725;5377.220303056113 13:10:16 INFO - PROCESS | 1661 | |4;prototype.html;326.5999151039978;337.3910092283429;339.99320013599714;341.1539382331817;345.94810778383237;6505.609663420186;6967.268436814137;6978.33705797949;6982.9301706982915;7006.894896576556;6801.9659901700425;6871.312868713127;6875.762362774699;6937.306269373073;6949.305069493048;4035.374516949863;4843.273508973647;5094.949050509485;5122.8207012754565;5151.6136289778415;5062.670926389791;5119.206522988943;5139.845804625848;5144.25408315794;5151.613628977823;5113.233015047754;5126.436092029874;5131.589472842164;5132.97433512832;5148.716820574867;5123.077845987721;5126.846194614168;5140.511651393112;5154.252633368159;5159;3571.982140089309;4416.734995900256;4418.29307310832;4428;4429.42417485728;6309.5898766580485;6542.542022058457;6575.901361479581;6708.9664551677415;6772.69522871472;4868.975655121737;5894.911576326359;5962.1951036609935;5977.98374276374;6002.879942401171;7292.45306602007;7306.963465182694;7330.413566914634;7331.083614548182;7337.119545654556;4012.859549915768;4895.804167833282;4906.852794416138;4909.582685471703;4912.533309335608;7494.550326980344;7780.338671212954;7850.057993040871;7868.567228802413;7880.527168369917;4781.928271075936;4793.688410253322;4822.879428014257;4824.445188803263;4827.517248275215;4058.512978442606;4925.310456536088;4926.137925863031;4948.233023881304;4952.752362381939;5926.1999630049395;5933.406659334119;5935.881282374328;5938.8218353449465;5963.582549221513;7472.514286571355;7476.514026588255;7492.550446973199;7495.700171993169;7502.549847009197;1734.696428125073;1778.1376032624166;1820.2445984916112;1820.6176702892542;1821.7904940931699;1145.524607287966;1159.3275899977994;1166.9241499302518;1168.7545615420686;1171.5606647507184;5642.858928526737;6915.890653350676;7011.123609548807;7017.578945263301;7022.5435346703325;6666.566673166326;7626.046744156981;7634.465587408939;7635.198304177981;7691.077070751546;7120.038794762744;7123.18634139512;7135.179454362815;7155.89266161008;7178.882229742238;4112.239235741337;4149.419081328617;4162.063535704442;4162.438070860395;4170.812313445902;8186.099529051799;8214.671413143527;8219;8219.383546234056;8227.958860205661;6425.325340839145;7823.647935842901;8111.634976426075;8138.348932085419;8165.101838797727;8171.305439037629;8199.71301004462;8207.056188538276;8224.38317126206;8225.465344752572;6249.34381889895;7829.060512738508;7849.725259615886;7851.371890248881;7856.764297071097;7442.367398771165;7627.809304767426;7639.465237433326;7640.426967977535;7682.043747469946;8107.918920810716;8149.470284431493;8154.796130096795;8170.01959764832;8192.139825318256;5062.1141300271565;5099.515546023122;5102.056119617882;5104.897902042013;5113.974430127825;6264.780732674334;7753.612319383896;7787.06555213378;7800.336971357498;7812.414068944966;6703.698333575098;6826.453883689393;7222.494425390382;7393;7499.100107987077;6127.785527506516;7405.9629701851145;7417.703291868264;7492.662830172546;7494.5503269803985;7290.890636640561;7295.671694773641;7377.631118444164;7402.037735094404;7415.258474152542;7576.28025337592;7577.128630207597;7582.128055273714;7586.355159811478;7591;7189.1013623297085;7385;7391.96304018498;7403.14863790671;7436 13:10:16 INFO - PROCESS | 1661 | |5;yui.html;716.3194964783455;758.9013428254326;775.2480094308522;777.55290707843;794.3962588432789;12910.741785164291;15157.621059473506;15338.309776060076;15688.686226275468;15689.921550392246;14399.496017639385;14433.42266309349;14452.277386130703;14477.058991165566;14481.493147739831;764.8890910817928;913.2237598041678;913.342393476699;919.6045700348881;944.8393773058563;923.2567782934735;925.3337596930199;939.6570251858057;939.70399324213;940.666063547441;972.6692924405701;989.8317286061387;994.2592768387561;1003.3127307794148;1005.2711783956646;966.6665000574791;967.9564419601135;981.9214462842956;989.1295659819349;989.3618615992681;753.2693287511105;753.5403403923602;753.6457864803533;753.8605358008786;753.8643044252033;15291.464798732102;15334.769978450333;15519.379224831106;15543.533693989199;15602.609934751608;13090.47638094475;13106.2136271824;13123.737525249537;13260.53588124411;13339.466421343135;9990.250731195118;10211.234157438223;10236.43699596522;10262.230332725076;10438.79122417555;3244.610646722385;3544.8936531904083;3578.248567800765;3726;3872.535295764498;80635.38729225441;80930;81078;81462.59268703678;82194;9436.386634868848;9522.761930951781;9757.219422446187;9761;9905.20758339331;20860.895695521423;20927.68608470874;21533.89233053825;21546.56906861854;21561.460963475725;6899.310068993061;7588.317051465284;7652.540847549165;7671.5397076174495;7676.424268179909;4108.198901214294;4148.709590328708;4226.556211597799;4226.915461690749;4232.682548808852;3703.722220833394;3741.064733816546;3747.194353214072;3768.09565704229;3785.3186426443503;663.9800805975829;670.7987603718865;673.0879658063352;673.5756473421714;677.3971165662564;550.6751016900048;591.0065518150553;603.7011679218815;609.4819403507072;622.6606499457806;8189.836203276021;8459.238668519863;8510.234078932926;8543.060263371024;8582.914170858336;536.4367414215059;564.6273459516699;574.6465923457127;612.4334990134108;626.4768917953469;3844.8462061517785;3851.9022078707435;4198.979005104955;4278.379634952915;4311.50417701962;82212;83167.58416208;84182;93075.5346223278;95261.52369238249;74887;75668.62165689246;75781;76274;79113;65392.34607653958;65428.67285663637;68423.65788171127;68644.6567767168;72504.63747681228;8527.232549070613;8758.12418758119;8809.603567839335;8877.636625119856;8928.910710892807;50955.49044509508;51470;51476.742616286676;51552.22671660003;51915.740421297654;65267.67366163139;67662.66168669322;70314.64842675754;70519.58960820652;70590;9560.426374417557;11241.55033798639;11544.134189935621;11553.364564949008;11623.244489108181;10909.945450272699;11440.485178166837;12218.38908054576;12251.142420030512;12397.380130993233;11652.53389864396;11928;11956.641300760992;11987.22083064598;12209.267443953391;11784.646460606196;11859.703507412383;11862.82205766897;12105.515779368727;12233.938830305791;11020.5040773167;11513.42432878336;11532.538698451968;11535.596254131066;11946.641600751991;8009.519428834288;9835.16401105914;9959.05388988045;10299.485025748532;10366.688999330032;9879.456629885426;10183.592656293666;10233.334833235816;10269.691909242734;10281.640142595272 13:10:16 INFO - PROCESS | 1661 | __end_tp_report 13:10:16 INFO - PROCESS | 1661 | __start_cc_report 13:10:16 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,391 13:10:16 INFO - PROCESS | 1661 | __end_cc_report 13:10:16 INFO - PROCESS | 1661 | __startTimestamp1467231016297__endTimestamp 13:10:16 INFO - PROCESS | 1661 | 13:10:16 INFO - PROCESS | 1661 | ------- Summary: start ------- 13:10:16 INFO - PROCESS | 1661 | Number of tests: 6 13:10:16 INFO - PROCESS | 1661 | 13:10:16 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5902.50 Median:6152.85 stddev:638.32 (10.4%) stddev-sans-first:615.68 13:10:16 INFO - PROCESS | 1661 | Values: 3665.1 3682.6 3687.6 3711.5 3737.6 5954.2 5965.6 6007.7 6008.4 6019.9 5993.2 5993.7 6041.0 6044.2 6047.6 5338.5 5393.4 5428.4 5471.4 5500.2 5351.0 5435.0 5441.1 5456.8 5477.8 5406.1 5426.7 5461.3 5535.5 5563.1 5416.9 5451.3 5451.8 5453.6 5471.4 5243.7 5357.0 5361.0 5379.7 5386.0 4730.6 5697.9 5775.4 5831.7 5840.9 6271.9 6295.3 6297.5 6314.2 6332.5 6231.1 6261.7 6337.1 6356.7 6360.6 5416.6 6113.2 6138.0 6138.3 6155.6 6222.3 6442.6 6508.0 6509.7 6577.3 6212.3 6226.9 6228.4 6293.8 6310.3 6329.9 6338.3 6338.5 6340.3 6348.2 6268.9 6276.6 6283.6 6285.0 6311.7 6174.7 6226.1 6240.0 6255.3 6313.2 4262.7 5036.5 5093.2 5101.9 5106.4 4594.9 4635.6 4635.7 4642.2 4645.0 4955.4 5964.1 6016.5 6055.2 6056.3 6329.1 6357.7 6360.7 6381.5 6393.0 5942.2 6026.0 6066.4 6091.3 6095.8 5492.4 5550.3 5579.2 5591.1 5663.8 6606.1 6633.1 6666.3 6674.8 6709.7 6255.4 6426.9 6435.3 6443.2 6450.6 6501.6 6561.6 6567.2 6598.5 6616.9 6291.6 6310.9 6317.1 6319.0 6344.3 5723.9 6177.6 6390.2 6391.9 6424.7 4474.3 6247.1 6252.9 6253.1 6291.2 6239.4 6252.2 6253.1 6259.4 6260.5 6035.8 6082.1 6104.5 6115.7 6183.8 6237.2 6250.4 6260.8 6264.8 6277.3 6141.3 6148.4 6152.8 6166.2 6169.1 13:10:16 INFO - PROCESS | 1661 | 13:10:16 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:68867.53 Median:39147.51 stddev:151901.09 (388.0%) stddev-sans-first:152240.59 13:10:16 INFO - PROCESS | 1661 | Values: 541.4 548.0 584.8 600.7 611.8 38928.8 39654.8 39682.0 39887.6 39913.0 41250.4 41739.4 41774.0 41972.4 41991.8 9727.4 9906.2 9938.6 9951.0 9970.0 9873.5 9881.0 9916.0 9958.2 9978.3 9928.7 9960.5 10004.5 10009.9 10014.8 8619.7 9929.2 9982.0 10011.3 10020.7 7908.2 8645.3 9022.7 9894.9 9904.2 33209.0 39909.8 40171.4 40261.8 40362.0 2886.7 3324.5 3357.8 3494.2 3516.3 24174.5 27269.5 27408.5 27783.0 29311.7 2617.8 2779.2 2814.8 2820.7 2838.6 398841.0 434181.0 435161.0 437813.0 439070.0 37617.6 65946.7 66314.0 66382.0 66472.7 30511.8 35208.0 36916.0 37200.0 37203.6 14432.4 16167.7 16226.0 16738.0 16811.6 13942.3 13943.9 13974.9 14077.4 14342.9 8449.6 8544.1 8613.8 8621.6 8691.3 3215.6 3532.5 3571.5 3572.3 3588.2 990.3 1039.8 1061.3 1103.6 1165.3 29183.0 29288.6 29669.0 29965.6 30190.5 896.4 1054.8 1145.8 1173.2 1214.3 15164.8 15233.7 15336.5 15374.3 15557.5 664578.0 671398.0 680546.6 686290.8 688739.0 61540.0 62600.7 63249.1 63448.0 63474.7 1576.3 1578.0 1585.7 1597.6 1603.7 25399.0 29518.3 29934.9 30162.5 30259.8 52703.7 59925.0 60277.0 61592.0 61819.7 557403.0 562962.0 569798.0 570619.0 571467.0 42549.6 42923.9 43377.8 43976.3 44695.0 35685.8 47030.8 47990.8 48201.8 49755.8 38295.4 38670.0 39224.6 39314.4 39582.6 38393.4 38446.6 38930.0 39021.6 39416.8 38630.0 38894.0 39080.2 39214.8 39671.8 29684.9 31236.4 32086.2 35265.5 35951.8 25484.7 25590.9 25610.6 25906.6 26063.3 13:10:16 INFO - PROCESS | 1661 | 13:10:16 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:36467.06 Median:22394.94 stddev:108979.50 (486.6%) stddev-sans-first:109251.52 13:10:16 INFO - PROCESS | 1661 | Values: 373.2 410.1 415.9 416.6 421.5 20727.9 21422.9 21428.8 21499.7 22473.0 22316.9 22497.0 22632.3 22839.5 23110.3 5795.0 6161.4 6162.5 6315.5 6322.4 6099.3 6115.3 6119.8 6193.1 6246.5 6023.4 6196.5 6207.3 6233.1 6251.8 5683.3 6122.6 6131.8 6143.4 6170.7 5654.7 5797.5 5809.2 5810.2 5810.8 15138.8 25427.6 26131.8 26337.3 26528.9 2142.3 2202.9 2294.7 2438.0 2602.5 10054.4 10654.0 11570.9 14380.3 15342.9 1794.0 1806.2 1832.4 1843.7 1883.6 88036.6 88924.6 114583.0 118221.4 118279.0 11864.1 11981.1 12015.6 12022.3 12025.6 15325.2 15411.6 15432.4 15439.0 15449.0 7841.5 9348.0 9386.9 9456.9 9575.9 7731.4 9523.5 9523.6 9594.5 9655.3 4778.4 4852.1 4863.7 4873.8 4894.3 2049.7 2094.6 2109.4 2150.9 2151.6 935.4 981.7 997.1 1040.7 1096.0 19347.9 19728.4 21362.5 21698.0 21803.5 879.7 1007.2 1016.3 1023.2 1025.4 10982.3 11515.3 11564.4 11572.8 11608.7 638586.0 651951.0 662111.0 665547.0 672047.0 102484.0 128073.4 131328.7 136169.3 136263.6 1023.8 1060.8 1063.3 1064.3 1079.6 16646.2 18266.7 18702.8 19061.3 19222.3 43248.0 54377.7 55591.9 57022.0 57242.4 49858.8 70549.6 74815.6 74977.6 83743.6 8174.9 8466.0 8539.4 8572.3 8812.5 9420.3 10097.8 12753.4 13285.3 13910.4 11490.1 11613.0 11747.6 11938.9 12008.8 11413.2 11426.5 11428.7 11585.6 11696.5 11855.5 11917.3 11936.4 12174.5 12348.6 8699.9 8846.7 8896.9 12088.2 13424.1 5666.4 9014.4 11738.2 12068.5 12212.1 13:10:16 INFO - PROCESS | 1661 | 13:10:16 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5866.90 Median:4995.38 stddev:3229.27 (64.6%) stddev-sans-first:3222.35 13:10:16 INFO - PROCESS | 1661 | Values: 1593.2 1646.1 1945.3 2049.5 2052.0 8206.9 8826.8 8914.6 9188.9 9189.2 8866.0 8908.3 8936.0 8960.1 9030.2 2518.2 2526.2 2550.5 2551.1 2558.0 2486.5 2543.6 2549.9 2560.0 2565.7 2537.9 2584.7 2585.0 2585.4 2591.4 2537.3 2553.9 2565.7 2572.4 2573.5 2537.1 2546.0 2559.7 2573.7 2575.8 7739.8 8999.4 9020.1 9053.8 9107.1 5455.1 5550.8 5601.6 5636.5 5693.5 3595.4 3645.6 3709.6 3732.5 3745.5 1061.8 1081.4 1084.0 1084.0 1084.2 11944.3 12253.6 12280.0 12293.3 12296.9 4892.5 4899.5 4917.7 4984.8 5026.7 10273.5 10306.3 10326.2 10333.7 10339.9 5521.1 5638.2 5654.5 5666.2 5667.6 4549.8 4943.8 5023.0 5035.0 5046.2 4169.2 4200.9 4245.9 4270.8 4278.3 1356.8 1384.4 1395.4 1397.1 1409.0 811.8 911.6 964.2 983.7 984.7 6111.8 6136.1 6171.6 6177.9 6211.2 413.9 479.8 480.8 486.2 487.8 3968.1 3985.0 4118.8 4147.9 4151.8 10735.4 11132.6 11140.0 11179.9 11194.0 9259.8 10280.5 10384.8 10546.3 11034.3 8364.2 8415.2 8434.6 8551.7 8732.3 5508.2 5806.8 6128.4 6139.2 6305.1 8945.0 9715.0 9850.5 9869.6 9999.6 10085.8 10140.3 10146.3 10148.3 10179.4 7027.9 7611.1 7661.5 8171.2 8372.1 8377.6 8397.5 8405.6 8431.4 8477.0 7354.4 7539.3 7594.2 7667.1 7740.3 7277.6 7433.6 7473.7 7601.2 7656.5 7048.3 7123.9 7180.8 7189.6 7195.1 4993.7 5049.6 5100.2 5141.4 5161.3 4997.1 5155.8 5168.2 5244.5 5377.2 13:10:16 INFO - PROCESS | 1661 | 13:10:16 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:6078.26 Median:6873.54 stddev:1961.09 (28.5%) stddev-sans-first:1918.48 13:10:16 INFO - PROCESS | 1661 | Values: 326.6 337.4 340.0 341.2 345.9 6505.6 6967.3 6978.3 6982.9 7006.9 6802.0 6871.3 6875.8 6937.3 6949.3 4035.4 4843.3 5094.9 5122.8 5151.6 5062.7 5119.2 5139.8 5144.3 5151.6 5113.2 5126.4 5131.6 5133.0 5148.7 5123.1 5126.8 5140.5 5154.3 5159.0 3572.0 4416.7 4418.3 4428.0 4429.4 6309.6 6542.5 6575.9 6709.0 6772.7 4869.0 5894.9 5962.2 5978.0 6002.9 7292.5 7307.0 7330.4 7331.1 7337.1 4012.9 4895.8 4906.9 4909.6 4912.5 7494.6 7780.3 7850.1 7868.6 7880.5 4781.9 4793.7 4822.9 4824.4 4827.5 4058.5 4925.3 4926.1 4948.2 4952.8 5926.2 5933.4 5935.9 5938.8 5963.6 7472.5 7476.5 7492.6 7495.7 7502.5 1734.7 1778.1 1820.2 1820.6 1821.8 1145.5 1159.3 1166.9 1168.8 1171.6 5642.9 6915.9 7011.1 7017.6 7022.5 6666.6 7626.0 7634.5 7635.2 7691.1 7120.0 7123.2 7135.2 7155.9 7178.9 4112.2 4149.4 4162.1 4162.4 4170.8 8186.1 8214.7 8219.0 8219.4 8228.0 6425.3 7823.6 8111.6 8138.3 8165.1 8171.3 8199.7 8207.1 8224.4 8225.5 6249.3 7829.1 7849.7 7851.4 7856.8 7442.4 7627.8 7639.5 7640.4 7682.0 8107.9 8149.5 8154.8 8170.0 8192.1 5062.1 5099.5 5102.1 5104.9 5114.0 6264.8 7753.6 7787.1 7800.3 7812.4 6703.7 6826.5 7222.5 7393.0 7499.1 6127.8 7406.0 7417.7 7492.7 7494.6 7290.9 7295.7 7377.6 7402.0 7415.3 7576.3 7577.1 7582.1 7586.4 7591.0 7189.1 7385.0 7392.0 7403.1 7436.0 13:10:16 INFO - PROCESS | 1661 | 13:10:16 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:18294.79 Median:597.35 stddev:25222.62 (4222.4%) stddev-sans-first:25258.84 13:10:16 INFO - PROCESS | 1661 | Values: 716.3 758.9 775.2 777.6 794.4 12910.7 15157.6 15338.3 15688.7 15689.9 14399.5 14433.4 14452.3 14477.1 14481.5 764.9 913.2 913.3 919.6 944.8 923.3 925.3 939.7 939.7 940.7 972.7 989.8 994.3 1003.3 1005.3 966.7 968.0 981.9 989.1 989.4 753.3 753.5 753.6 753.9 753.9 15291.5 15334.8 15519.4 15543.5 15602.6 13090.5 13106.2 13123.7 13260.5 13339.5 9990.3 10211.2 10236.4 10262.2 10438.8 3244.6 3544.9 3578.2 3726.0 3872.5 80635.4 80930.0 81078.0 81462.6 82194.0 9436.4 9522.8 9757.2 9761.0 9905.2 20860.9 20927.7 21533.9 21546.6 21561.5 6899.3 7588.3 7652.5 7671.5 7676.4 4108.2 4148.7 4226.6 4226.9 4232.7 3703.7 3741.1 3747.2 3768.1 3785.3 664.0 670.8 673.1 673.6 677.4 550.7 591.0 603.7 609.5 622.7 8189.8 8459.2 8510.2 8543.1 8582.9 536.4 564.6 574.6 612.4 626.5 3844.8 3851.9 4199.0 4278.4 4311.5 82212.0 83167.6 84182.0 93075.5 95261.5 74887.0 75668.6 75781.0 76274.0 79113.0 65392.3 65428.7 68423.7 68644.7 72504.6 8527.2 8758.1 8809.6 8877.6 8928.9 50955.5 51470.0 51476.7 51552.2 51915.7 65267.7 67662.7 70314.6 70519.6 70590.0 9560.4 11241.6 11544.1 11553.4 11623.2 10909.9 11440.5 12218.4 12251.1 12397.4 11652.5 11928.0 11956.6 11987.2 12209.3 11784.6 11859.7 11862.8 12105.5 12233.9 11020.5 11513.4 11532.5 11535.6 11946.6 8009.5 9835.2 9959.1 10299.5 10366.7 9879.5 10183.6 10233.3 10269.7 10281.6 13:10:16 INFO - PROCESS | 1661 | -------- Summary: end -------- 13:10:16 INFO - PROCESS | 1661 | 13:10:16 INFO - TEST-INFO | 1661: exit 0 13:10:16 INFO - TEST-OK | dromaeo_css | took 1109737ms 13:10:16 INFO - TEST-START | kraken 13:10:16 INFO - operating with platform_type : mac_ 13:10:16 INFO - Initialising browser for kraken test... 13:10:16 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpi67phH/profile http://localhost:49276/getInfo.html) 13:10:19 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 13:10:19 INFO - PROCESS | 1673 | colorDepth:24 13:10:19 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 13:10:19 INFO - PROCESS | 1673 | __metrics 13:10:19 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 13:10:19 INFO - TEST-INFO | 1673: exit 0 13:10:19 INFO - Browser initialized. 13:10:19 INFO - Running cycle 1/1 for kraken test... 13:10:19 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpi67phH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:31 INFO - PROCESS | 1677 | RSS: Main: 171184128 13:10:31 INFO - PROCESS | 1677 | 13:10:34 INFO - PROCESS | 1677 | 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) 13:10:35 INFO - PROCESS | 1677 | RSS: Main: 183980032 13:10:35 INFO - PROCESS | 1677 | 13:10:38 INFO - PROCESS | 1677 | 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) 13:10:38 INFO - PROCESS | 1677 | RSS: Main: 192692224 13:10:38 INFO - PROCESS | 1677 | 13:10:42 INFO - PROCESS | 1677 | 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) 13:10:42 INFO - PROCESS | 1677 | RSS: Main: 196751360 13:10:42 INFO - PROCESS | 1677 | 13:10:44 INFO - PROCESS | 1677 | 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) 13:10:45 INFO - PROCESS | 1677 | RSS: Main: 196911104 13:10:45 INFO - PROCESS | 1677 | 13:10:47 INFO - PROCESS | 1677 | 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) 13:10:47 INFO - PROCESS | 1677 | RSS: Main: 198467584 13:10:47 INFO - PROCESS | 1677 | 13:10:50 INFO - PROCESS | 1677 | 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) 13:10:51 INFO - PROCESS | 1677 | RSS: Main: 198479872 13:10:51 INFO - PROCESS | 1677 | 13:10:54 INFO - PROCESS | 1677 | 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) 13:10:54 INFO - PROCESS | 1677 | RSS: Main: 198324224 13:10:54 INFO - PROCESS | 1677 | 13:10:57 INFO - PROCESS | 1677 | 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) 13:10:58 INFO - PROCESS | 1677 | RSS: Main: 198471680 13:10:58 INFO - PROCESS | 1677 | 13:11:00 INFO - PROCESS | 1677 | 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) 13:11:00 INFO - PROCESS | 1677 | RSS: Main: 198025216 13:11:00 INFO - PROCESS | 1677 | 13:11:02 INFO - PROCESS | 1677 | 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) 13:11:03 INFO - PROCESS | 1677 | RSS: Main: 198144000 13:11:03 INFO - PROCESS | 1677 | 13:11:05 INFO - PROCESS | 1677 | 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) 13:11:06 INFO - PROCESS | 1677 | RSS: Main: 198082560 13:11:06 INFO - PROCESS | 1677 | 13:11:08 INFO - PROCESS | 1677 | 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) 13:11:09 INFO - PROCESS | 1677 | RSS: Main: 198287360 13:11:09 INFO - PROCESS | 1677 | 13:11:12 INFO - PROCESS | 1677 | 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) 13:11:12 INFO - PROCESS | 1677 | RSS: Main: 198205440 13:11:12 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | 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) 13:11:14 INFO - PROCESS | 1677 | RSS: Main: 200257536 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | __start_tp_report 13:11:14 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 13:11:14 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 13:11:14 INFO - PROCESS | 1677 | |i|pagename|runs| 13:11:14 INFO - PROCESS | 1677 | |0;ai-astar;118;112;117;117;116;147;169;121;116;117 13:11:14 INFO - PROCESS | 1677 | |1;audio-beat-detection;154;121;138;159;120;174;165;149;164;126 13:11:14 INFO - PROCESS | 1677 | |2;audio-dft;218;270;218;200;192;227;268;200;199;195 13:11:14 INFO - PROCESS | 1677 | |3;audio-fft;65;83;74;136;57;55;59;67;129;56 13:11:14 INFO - PROCESS | 1677 | |4;audio-oscillator;78;82;122;78;81;85;122;81;80;122 13:11:14 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;88;86;88;89;89;110;114;85;88;86 13:11:14 INFO - PROCESS | 1677 | |6;imaging-darkroom;102;95;92;135;101;150;104;87;88;88 13:11:14 INFO - PROCESS | 1677 | |7;imaging-desaturate;98;146;109;102;92;100;93;93;93;88 13:11:14 INFO - PROCESS | 1677 | |8;json-parse-financial;59;60;62;63;62;71;91;70;58;64 13:11:14 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;60;70;92;101;93;72;69;64;65;66 13:11:14 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;74;79;80;83;79;79;79;103;106;92 13:11:14 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;124;128;127;126;123;126;128;127;147;139 13:11:14 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;165;166;203;157;146;212;217;165;165;161 13:11:14 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;56;90;94;69;66;67;66;70;72;96 13:11:14 INFO - PROCESS | 1677 | __end_tp_report 13:11:14 INFO - PROCESS | 1677 | __start_cc_report 13:11:14 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1052 13:11:14 INFO - PROCESS | 1677 | __end_cc_report 13:11:14 INFO - PROCESS | 1677 | __startTimestamp1467231074789__endTimestamp 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | ------- Summary: start ------- 13:11:14 INFO - PROCESS | 1677 | Number of tests: 14 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:125.00 Median:117.50 stddev:18.28 (15.6%) stddev-sans-first:19.21 13:11:14 INFO - PROCESS | 1677 | Values: 118.0 112.0 117.0 117.0 116.0 147.0 169.0 121.0 116.0 117.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:156.50 stddev:19.62 (12.5%) stddev-sans-first:20.65 13:11:14 INFO - PROCESS | 1677 | Values: 154.0 121.0 138.0 159.0 120.0 174.0 165.0 149.0 164.0 126.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:218.70 Median:218.00 stddev:28.86 (13.2%) stddev-sans-first:30.61 13:11:14 INFO - PROCESS | 1677 | Values: 218.0 270.0 218.0 200.0 192.0 227.0 268.0 200.0 199.0 195.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:78.10 Median:62.00 stddev:30.02 (48.4%) stddev-sans-first:31.46 13:11:14 INFO - PROCESS | 1677 | Values: 65.0 83.0 74.0 136.0 57.0 55.0 59.0 67.0 129.0 56.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:80.50 stddev:20.04 (24.9%) stddev-sans-first:20.50 13:11:14 INFO - PROCESS | 1677 | Values: 78.0 82.0 122.0 78.0 81.0 85.0 122.0 81.0 80.0 122.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:88.00 stddev:10.51 (11.9%) stddev-sans-first:11.03 13:11:14 INFO - PROCESS | 1677 | Values: 88.0 86.0 88.0 89.0 89.0 110.0 114.0 85.0 88.0 86.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:87.50 stddev:21.38 (24.4%) stddev-sans-first:22.67 13:11:14 INFO - PROCESS | 1677 | Values: 102.0 95.0 92.0 135.0 101.0 150.0 104.0 87.0 88.0 88.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:101.40 Median:92.50 stddev:16.80 (18.2%) stddev-sans-first:17.77 13:11:14 INFO - PROCESS | 1677 | Values: 98.0 146.0 109.0 102.0 92.0 100.0 93.0 93.0 93.0 88.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:63.50 stddev:9.78 (15.4%) stddev-sans-first:10.03 13:11:14 INFO - PROCESS | 1677 | Values: 59.0 60.0 62.0 63.0 62.0 71.0 91.0 70.0 58.0 64.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:75.20 Median:69.50 stddev:14.47 (20.8%) stddev-sans-first:14.27 13:11:14 INFO - PROCESS | 1677 | Values: 60.0 70.0 92.0 101.0 93.0 72.0 69.0 64.0 65.0 66.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:79.00 stddev:11.09 (14.0%) stddev-sans-first:10.97 13:11:14 INFO - PROCESS | 1677 | Values: 74.0 79.0 80.0 83.0 79.0 79.0 79.0 103.0 106.0 92.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:127.50 stddev:7.53 (5.9%) stddev-sans-first:7.72 13:11:14 INFO - PROCESS | 1677 | Values: 124.0 128.0 127.0 126.0 123.0 126.0 128.0 127.0 147.0 139.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:165.50 stddev:25.06 (15.1%) stddev-sans-first:26.28 13:11:14 INFO - PROCESS | 1677 | Values: 165.0 166.0 203.0 157.0 146.0 212.0 217.0 165.0 165.0 161.0 13:11:14 INFO - PROCESS | 1677 | 13:11:14 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:71.00 stddev:13.67 (19.3%) stddev-sans-first:12.74 13:11:14 INFO - PROCESS | 1677 | Values: 56.0 90.0 94.0 69.0 66.0 67.0 66.0 70.0 72.0 96.0 13:11:14 INFO - PROCESS | 1677 | -------- Summary: end -------- 13:11:14 INFO - PROCESS | 1677 | 13:11:15 INFO - TEST-INFO | 1677: exit 0 13:11:15 INFO - TEST-OK | kraken | took 58729ms 13:11:15 INFO - SUITE-END | took 1168s 13:11:15 INFO - Completed test suite (00:19:28) 13:11:15 INFO - javascript benchmark 13:11:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3665.1386924072845, 3682.558093028835, 3687.631236876311, 3711.53605799275, 3737.588865224825, 5954.196183515224, 5965.642061476309, 6007.729652165652, 6008.429199226067, 6019.879602407955, 5993.220881285438, 5993.700314984255, 6041.0, 6044.184035155253, 6047.637141771497, 5338.492843179892, 5393.406725260218, 5428.4028756836715, 5471.398146203915, 5500.202470641754, 5350.973245133769, 5434.967356202329, 5441.129419292914, 5456.781728730846, 5477.835664930059, 5406.135018397057, 5426.67439953604, 5461.317335333083, 5535.529479994185, 5563.054280772279, 5416.891662166754, 5451.291332126838, 5451.836444906659, 5453.590980676426, 5471.425500322488, 5243.659162154448, 5356.95539369823, 5361.035013697533, 5379.731013449312, 5386.0, 4730.574248317634, 5697.857553561153, 5775.422457754233, 5831.737571809279, 5840.853978650568, 6271.937280627227, 6295.338989406138, 6297.527685423565, 6314.179156709644, 6332.525060620425, 6231.096491008823, 6261.7182226799905, 6337.112804207414, 6356.682165891733, 6360.55476116672, 5416.593755468356, 6113.205283313186, 6138.048602466625, 6138.281281241259, 6155.569110162291, 6222.346653601307, 6442.645654489048, 6508.0, 6509.665518568777, 6577.34226577348, 6212.347703491068, 6226.875462490725, 6228.408301211378, 6293.779717709858, 6310.337414571404, 6329.936700633027, 6338.334474880071, 6338.524610654219, 6340.270868850049, 6348.206474190726, 6268.937310626927, 6276.623402595767, 6283.59156654816, 6284.968575157095, 6311.684415779193, 6174.66039367839, 6226.128342032119, 6240.0, 6255.280642726145, 6313.179286692793, 4262.7016108872085, 5036.471170527115, 5093.2360145977655, 5101.897962040738, 5106.4382917879, 4594.874255807348, 4635.629149668086, 4635.7450340230935, 4642.16441040616, 4644.9767751161025, 4955.40535135786, 5964.135200396005, 6016.548758843017, 6055.182550355734, 6056.303525094582, 6329.095026002104, 6357.745690172342, 6360.745570177233, 6381.489480841522, 6393.009083592051, 5942.227510423617, 6026.035834266497, 6066.423689749467, 6091.269047714302, 6095.786647467317, 5492.423295553909, 5550.306211723535, 5579.163125531121, 5591.133374326986, 5663.830085097454, 6606.141201643755, 6633.104530888461, 6666.300038495888, 6674.83312917181, 6709.731610735614, 6255.374462553708, 6426.903596445964, 6435.292117866938, 6443.162388889415, 6450.580712253689, 6501.609903405811, 6561.573497722633, 6567.211934567691, 6598.472122230114, 6616.867662646817, 6291.591046581958, 6310.936890631035, 6317.115603815378, 6319.0, 6344.27040890285, 5723.856903577277, 6177.567570270038, 6390.201224846895, 6391.9041214380895, 6424.678766061585, 4474.306482495218, 6247.094171345038, 6252.937470625236, 6253.062040693932, 6291.213598300213, 6239.407256310643, 6252.187215661935, 6253.093301471352, 6259.436650701458, 6260.499160067275, 6035.758569657341, 6082.087686847009, 6104.511639068775, 6115.724792384264, 6183.752649893954, 6237.1891654084675, 6250.406211409909, 6260.843478912881, 6264.843378915563, 6277.30949595535, 6141.324454309933, 6148.44663980244, 6152.846178845564, 6166.167567378526, 6169.136320915165], "value": 5866.242312314162, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.3774159716326, 547.9643473834453, 584.8420926349888, 600.6966481926627, 611.8314020221376, 38928.805355973214, 39654.80172599133, 39681.99999999996, 39887.601123988825, 39913.0, 41250.38124428136, 41739.37390939138, 41774.0, 41972.37041444373, 41991.790041049826, 9727.36772109814, 9906.20750339971, 9938.602455901755, 9951.004899510028, 9970.0, 9873.456959867204, 9881.0, 9916.0, 9958.153556947667, 9978.251631127658, 9928.6524971626, 9960.501974901263, 10004.549795259194, 10009.949950250239, 10014.849777253346, 8619.6983105591, 9929.205663546934, 9982.0, 10011.349262297963, 10020.749481262954, 7908.248716371993, 8645.265152462049, 9022.684206052756, 9894.90105098947, 9904.207663386911, 33209.0, 39909.80045099785, 40171.393144274196, 40261.798691006356, 40361.99095022648, 2886.7401933825845, 3324.4680851063713, 3357.78174418662, 3494.196334842975, 3516.296740651854, 24174.51650966971, 27269.500532412127, 27408.45183096327, 27783.0, 29311.706882931325, 2617.7827310300613, 2779.2496026072845, 2814.831110133378, 2820.661520617539, 2838.5600231964077, 398841.0, 434181.0, 435161.0, 437813.0, 439070.0, 37617.62382376196, 65946.67026664836, 66314.0, 66382.0, 66472.66763666151, 30511.847440762653, 35208.0, 36916.0, 37200.0, 37203.62796372056, 14432.422703091968, 16167.676646467005, 16226.0, 16737.995720256822, 16811.57971050709, 13942.302884855717, 13943.930280348533, 13974.860251397356, 14077.366518506691, 14342.85657143436, 8449.619767110495, 8544.102869198769, 8613.78465538354, 8621.61202745878, 8691.304695624334, 3215.6141263048585, 3532.4877892705413, 3571.4642803579673, 3572.303400836864, 3588.1926566522325, 990.3216296836546, 1039.8024375368807, 1061.3260579531898, 1103.6137351926923, 1165.2542372881362, 29183.0, 29288.560671589516, 29668.961586344376, 29965.550516742267, 30190.547141792453, 896.4038914122166, 1054.8154073037188, 1145.8395824584566, 1173.1729130962651, 1214.332117335462, 15164.772528412082, 15233.695326093637, 15336.539903802905, 15374.308156133, 15557.45548905783, 664578.0, 671398.0, 680546.5972670204, 686290.8427289358, 688739.0, 61540.0, 62600.68699656564, 63249.05126423107, 63448.0, 63474.68262658749, 1576.2985471465088, 1577.9921100394424, 1585.651156745514, 1597.6485173262097, 1603.7033148867497, 25399.0, 29518.262043449085, 29934.850325749103, 30162.54756178703, 30259.848700756356, 52703.73648131735, 59925.0, 60277.0, 61592.0, 61819.690901545204, 557403.0, 562962.0, 569798.0, 570619.0, 571467.0, 42549.5745042558, 42923.92690182645, 43377.783111084245, 43976.34035489534, 44695.0, 35685.82157089198, 47030.76484617555, 47990.760046199546, 48201.75899120482, 49755.75122124366, 38295.42556861594, 38670.0, 39224.62713805003, 39314.410283845194, 39582.604173957894, 38393.4240986391, 38446.615533844306, 38930.0, 39021.6097839018, 39416.81749547518, 38630.0, 38894.0, 39080.218395632495, 39214.80392598133, 39671.80164099161, 29684.851575741985, 31236.379630925596, 32086.197845053128, 35265.47101793424, 35951.820240898625, 25484.745152548236, 25590.87204563965, 25610.615840762777, 25906.611400828624, 26063.348416288987], "value": 19258.89670276236, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.20134911289847, 410.09369293860567, 415.9417681524585, 416.62920001198927, 421.5194678067004, 20727.85996770177, 21422.892885535588, 21428.785712142893, 21499.677504837422, 22473.0, 22316.884155792228, 22497.0, 22632.321030369076, 22839.54320913581, 23110.30669079926, 5794.971025144879, 6161.445469907708, 6162.537809664271, 6315.463185629227, 6322.367763223687, 6099.268087829467, 6115.266168059817, 6119.847003824895, 6193.1020002099895, 6246.531510136735, 6023.427774361428, 6196.535259855506, 6207.317195108534, 6233.127362169277, 6251.781187658433, 5683.3464151622675, 6122.63264204147, 6131.816045518619, 6143.354947730469, 6170.660613666247, 5654.74553645087, 5797.536197104264, 5809.186713860063, 5810.1865738796605, 5810.767569297223, 15138.848611513855, 25427.61858572123, 26131.82406791699, 26337.341566460993, 26528.87768978477, 2142.2716276466076, 2202.933911982643, 2294.7475777664445, 2438.000419827862, 2602.5445547029385, 10054.447005414699, 10654.041136297692, 11570.884291157065, 14380.280985950661, 15342.923285383613, 1793.9641207175782, 1806.2323512507132, 1832.395309547846, 1843.732658764485, 1883.6421079994757, 88036.55981720114, 88924.55537722334, 114583.0, 118221.40889295585, 118279.0, 11864.110191735654, 11981.101417393731, 12015.639530814089, 12022.27866328023, 12025.579104731292, 15325.23373831304, 15411.61470963235, 15432.38270469191, 15439.0, 15449.0, 7841.490303130278, 9347.953260233791, 9386.85919711205, 9456.905430945602, 9575.856362154573, 7731.38148948094, 9523.476208808443, 9523.57143928525, 9594.472304023206, 9655.275854310954, 4778.354922085544, 4852.126617208865, 4863.659543831968, 4873.805047798049, 4894.2658601210105, 2049.702793094993, 2094.6334391481428, 2109.4304537774715, 2150.892455377225, 2151.634222182233, 935.4060171790961, 981.6711401680374, 997.1374760831828, 1040.6565833275001, 1095.9726006849733, 19347.90326048389, 19728.408147755592, 21362.465938351666, 21698.0, 21803.454913627287, 879.6657270237397, 1007.2495990487134, 1016.2936758952604, 1023.1814548361281, 1025.4257615735212, 10982.341059536293, 11515.309081454972, 11564.42177891102, 11572.76854462906, 11608.709782255342, 638586.0, 651951.0, 662111.0, 665547.0, 672047.0, 102483.95032099316, 128073.35963320124, 131328.68671313356, 136169.3191534036, 136263.6373636271, 1023.7952409517977, 1060.7984482948216, 1063.3088492479794, 1064.3241541621126, 1079.5735684404617, 16646.16769161513, 18266.721329506807, 18702.812971870106, 19061.332853350064, 19222.327218547285, 43248.0, 54377.72811135919, 55591.88816223572, 57022.0, 57242.42757572371, 49858.75070624624, 70549.64725176341, 74815.62592187004, 74977.62511187409, 83743.5812820932, 8174.877376839471, 8465.98408191021, 8539.359548034046, 8572.314214862921, 8812.51531165792, 9420.293477989042, 10097.798044038931, 12753.362331883554, 13285.269310188032, 13910.374033168735, 11490.138239632228, 11613.012893904113, 11747.647570572897, 11938.940305298418, 12008.819867702166, 11413.201075924937, 11426.48981506431, 11428.71428214268, 11585.594504192313, 11696.532138714356, 11855.466504007512, 11917.284962902253, 11936.4031798408, 12174.513019479122, 12348.629541113782, 8699.91300086991, 8846.690365837165, 8896.86654700193, 12088.15382923187, 13424.127431716906, 5666.405027472056, 9014.414063085878, 11738.178327517333, 12068.456919438822, 12212.145149839782], "value": 9966.727123456474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1593.187474388062, 1646.1275523972295, 1945.338584881141, 2049.4876280929766, 2051.9897400512996, 8206.876896846552, 8826.823463530742, 8914.64341426343, 9188.908110918888, 9189.1729744323, 8865.980412252593, 8908.28733701304, 8935.972363178236, 8960.05919378464, 9030.187283144516, 2518.1690042286095, 2526.2042456626195, 2550.464402475473, 2551.107112510625, 2557.9872100639473, 2486.490269494749, 2543.6438898554125, 2549.910753123641, 2559.9744002560014, 2565.7049439314533, 2537.936551586207, 2584.6898372195365, 2585.017693276552, 2585.4441295121546, 2591.3521619595103, 2537.2895589235045, 2553.948921021588, 2565.6921169459597, 2572.3954870605394, 2573.5367633825904, 2537.099329737935, 2546.0197823837957, 2559.705633852094, 2573.6782902137234, 2575.7681808637312, 7739.7678069658, 8999.370044096915, 9020.14308640678, 9053.818923621557, 9107.08929107084, 5455.1271796512365, 5550.77796888124, 5601.635893666939, 5636.549076073904, 5693.459121383462, 3595.406757884946, 3645.562532496091, 3709.6290370962956, 3732.4774531565604, 3745.513083299181, 1061.7611037516574, 1081.3619964221068, 1083.9945800271028, 1084.0352086642895, 1084.1814430105298, 11944.283342999448, 12253.632391028283, 12280.01759859209, 12293.3238671873, 12296.938515307456, 4892.486288939681, 4899.485554016848, 4917.729524876167, 4984.750762461862, 5026.698398096126, 10273.537690803932, 10306.33008854422, 10326.225533084898, 10333.741656458498, 10339.896601034045, 5521.1442226454965, 5638.210650508932, 5654.491095801398, 5666.235058267163, 5667.603267771299, 4549.840755573605, 4943.752812359367, 5022.974885125551, 5034.993001399662, 5046.1926091825135, 4169.187008533307, 4200.873973780792, 4245.87262382129, 4270.807813648394, 4278.272693642089, 1356.830396200475, 1384.4462215114036, 1395.4418232706998, 1397.0569865340854, 1408.9929550352183, 811.7645882694071, 911.6444586611227, 964.1515466389533, 983.6901376066517, 984.675057231112, 6111.755529778848, 6136.110264011782, 6171.6297022178815, 6177.907331390033, 6211.192544969125, 413.86342506972625, 479.77930152129716, 480.79085597765084, 486.20505473551, 487.8341363936208, 3968.0873399118364, 3985.0, 4118.814653340607, 4147.875563733093, 4151.813168407429, 10735.355878647306, 11132.554697811996, 11140.0, 11179.937905898927, 11194.0, 9259.842519685038, 10280.485975701185, 10384.792304153874, 10546.314489558154, 11034.282771619819, 8364.205400486944, 8415.158484151536, 8434.578271086544, 8551.74344769658, 8732.301415886714, 5508.228847961209, 5806.767729290781, 6128.356522565245, 6139.2325959255095, 6305.076951529827, 8944.955275223581, 9714.951425242829, 9850.458224797705, 9869.605215791575, 9999.600015999278, 10085.848712269468, 10140.340877842917, 10146.289759716748, 10148.340357876714, 10179.389236645826, 7027.9297207027275, 7611.124720656974, 7661.502002369828, 8171.182881711781, 8372.120927302789, 8377.623006964823, 8397.496150231005, 8405.621747021276, 8431.40980131385, 8477.0, 7354.448416368687, 7539.32146106853, 7594.202608726005, 7667.079950405764, 7740.3420709240345, 7277.636118194175, 7433.628318583941, 7473.663685134291, 7601.239876012354, 7656.502327348704, 7048.330408611174, 7123.85752284941, 7180.7845764627145, 7189.640517973976, 7195.100612423447, 4993.675411098267, 5049.6465247432325, 5100.158473851773, 5141.357330333708, 5161.251618515369, 4997.075541024922, 5155.819546316011, 5168.173092305213, 5244.475552444725, 5377.220303056113], "value": 4684.646393901412, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5999151039978, 337.3910092283429, 339.99320013599714, 341.1539382331817, 345.94810778383237, 6505.609663420186, 6967.268436814137, 6978.33705797949, 6982.9301706982915, 7006.894896576556, 6801.9659901700425, 6871.312868713127, 6875.762362774699, 6937.306269373073, 6949.305069493048, 4035.374516949863, 4843.273508973647, 5094.949050509485, 5122.8207012754565, 5151.6136289778415, 5062.670926389791, 5119.206522988943, 5139.845804625848, 5144.25408315794, 5151.613628977823, 5113.233015047754, 5126.436092029874, 5131.589472842164, 5132.97433512832, 5148.716820574867, 5123.077845987721, 5126.846194614168, 5140.511651393112, 5154.252633368159, 5159.0, 3571.982140089309, 4416.734995900256, 4418.29307310832, 4428.0, 4429.42417485728, 6309.5898766580485, 6542.542022058457, 6575.901361479581, 6708.9664551677415, 6772.69522871472, 4868.975655121737, 5894.911576326359, 5962.1951036609935, 5977.98374276374, 6002.879942401171, 7292.45306602007, 7306.963465182694, 7330.413566914634, 7331.083614548182, 7337.119545654556, 4012.859549915768, 4895.804167833282, 4906.852794416138, 4909.582685471703, 4912.533309335608, 7494.550326980344, 7780.338671212954, 7850.057993040871, 7868.567228802413, 7880.527168369917, 4781.928271075936, 4793.688410253322, 4822.879428014257, 4824.445188803263, 4827.517248275215, 4058.512978442606, 4925.310456536088, 4926.137925863031, 4948.233023881304, 4952.752362381939, 5926.1999630049395, 5933.406659334119, 5935.881282374328, 5938.8218353449465, 5963.582549221513, 7472.514286571355, 7476.514026588255, 7492.550446973199, 7495.700171993169, 7502.549847009197, 1734.696428125073, 1778.1376032624166, 1820.2445984916112, 1820.6176702892542, 1821.7904940931699, 1145.524607287966, 1159.3275899977994, 1166.9241499302518, 1168.7545615420686, 1171.5606647507184, 5642.858928526737, 6915.890653350676, 7011.123609548807, 7017.578945263301, 7022.5435346703325, 6666.566673166326, 7626.046744156981, 7634.465587408939, 7635.198304177981, 7691.077070751546, 7120.038794762744, 7123.18634139512, 7135.179454362815, 7155.89266161008, 7178.882229742238, 4112.239235741337, 4149.419081328617, 4162.063535704442, 4162.438070860395, 4170.812313445902, 8186.099529051799, 8214.671413143527, 8219.0, 8219.383546234056, 8227.958860205661, 6425.325340839145, 7823.647935842901, 8111.634976426075, 8138.348932085419, 8165.101838797727, 8171.305439037629, 8199.71301004462, 8207.056188538276, 8224.38317126206, 8225.465344752572, 6249.34381889895, 7829.060512738508, 7849.725259615886, 7851.371890248881, 7856.764297071097, 7442.367398771165, 7627.809304767426, 7639.465237433326, 7640.426967977535, 7682.043747469946, 8107.918920810716, 8149.470284431493, 8154.796130096795, 8170.01959764832, 8192.139825318256, 5062.1141300271565, 5099.515546023122, 5102.056119617882, 5104.897902042013, 5113.974430127825, 6264.780732674334, 7753.612319383896, 7787.06555213378, 7800.336971357498, 7812.414068944966, 6703.698333575098, 6826.453883689393, 7222.494425390382, 7393.0, 7499.100107987077, 6127.785527506516, 7405.9629701851145, 7417.703291868264, 7492.662830172546, 7494.5503269803985, 7290.890636640561, 7295.671694773641, 7377.631118444164, 7402.037735094404, 7415.258474152542, 7576.28025337592, 7577.128630207597, 7582.128055273714, 7586.355159811478, 7591.0, 7189.1013623297085, 7385.0, 7391.96304018498, 7403.14863790671, 7436.0], "value": 5428.641913826222, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.3194964783455, 758.9013428254326, 775.2480094308522, 777.55290707843, 794.3962588432789, 12910.741785164291, 15157.621059473506, 15338.309776060076, 15688.686226275468, 15689.921550392246, 14399.496017639385, 14433.42266309349, 14452.277386130703, 14477.058991165566, 14481.493147739831, 764.8890910817928, 913.2237598041678, 913.342393476699, 919.6045700348881, 944.8393773058563, 923.2567782934735, 925.3337596930199, 939.6570251858057, 939.70399324213, 940.666063547441, 972.6692924405701, 989.8317286061387, 994.2592768387561, 1003.3127307794148, 1005.2711783956646, 966.6665000574791, 967.9564419601135, 981.9214462842956, 989.1295659819349, 989.3618615992681, 753.2693287511105, 753.5403403923602, 753.6457864803533, 753.8605358008786, 753.8643044252033, 15291.464798732102, 15334.769978450333, 15519.379224831106, 15543.533693989199, 15602.609934751608, 13090.47638094475, 13106.2136271824, 13123.737525249537, 13260.53588124411, 13339.466421343135, 9990.250731195118, 10211.234157438223, 10236.43699596522, 10262.230332725076, 10438.79122417555, 3244.610646722385, 3544.8936531904083, 3578.248567800765, 3726.0, 3872.535295764498, 80635.38729225441, 80930.0, 81078.0, 81462.59268703678, 82194.0, 9436.386634868848, 9522.761930951781, 9757.219422446187, 9761.0, 9905.20758339331, 20860.895695521423, 20927.68608470874, 21533.89233053825, 21546.56906861854, 21561.460963475725, 6899.310068993061, 7588.317051465284, 7652.540847549165, 7671.5397076174495, 7676.424268179909, 4108.198901214294, 4148.709590328708, 4226.556211597799, 4226.915461690749, 4232.682548808852, 3703.722220833394, 3741.064733816546, 3747.194353214072, 3768.09565704229, 3785.3186426443503, 663.9800805975829, 670.7987603718865, 673.0879658063352, 673.5756473421714, 677.3971165662564, 550.6751016900048, 591.0065518150553, 603.7011679218815, 609.4819403507072, 622.6606499457806, 8189.836203276021, 8459.238668519863, 8510.234078932926, 8543.060263371024, 8582.914170858336, 536.4367414215059, 564.6273459516699, 574.6465923457127, 612.4334990134108, 626.4768917953469, 3844.8462061517785, 3851.9022078707435, 4198.979005104955, 4278.379634952915, 4311.50417701962, 82212.0, 83167.58416208, 84182.0, 93075.5346223278, 95261.52369238249, 74887.0, 75668.62165689246, 75781.0, 76274.0, 79113.0, 65392.34607653958, 65428.67285663637, 68423.65788171127, 68644.6567767168, 72504.63747681228, 8527.232549070613, 8758.12418758119, 8809.603567839335, 8877.636625119856, 8928.910710892807, 50955.49044509508, 51470.0, 51476.742616286676, 51552.22671660003, 51915.740421297654, 65267.67366163139, 67662.66168669322, 70314.64842675754, 70519.58960820652, 70590.0, 9560.426374417557, 11241.55033798639, 11544.134189935621, 11553.364564949008, 11623.244489108181, 10909.945450272699, 11440.485178166837, 12218.38908054576, 12251.142420030512, 12397.380130993233, 11652.53389864396, 11928.0, 11956.641300760992, 11987.22083064598, 12209.267443953391, 11784.646460606196, 11859.703507412383, 11862.82205766897, 12105.515779368727, 12233.938830305791, 11020.5040773167, 11513.42432878336, 11532.538698451968, 11535.596254131066, 11946.641600751991, 8009.519428834288, 9835.16401105914, 9959.05388988045, 10299.485025748532, 10366.688999330032, 9879.456629885426, 10183.592656293666, 10233.334833235816, 10269.691909242734, 10281.640142595272], "value": 7063.259119575445, "unit": "score"}], "name": "dromaeo_css", "value": 7661.701474311786, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 112.0, 117.0, 117.0, 116.0, 147.0, 169.0, 121.0, 116.0, 117.0], "value": 125.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 138.0, 159.0, 120.0, 174.0, 165.0, 149.0, 164.0, 126.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [218.0, 270.0, 218.0, 200.0, 192.0, 227.0, 268.0, 200.0, 199.0, 195.0], "value": 218.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 83.0, 74.0, 136.0, 57.0, 55.0, 59.0, 67.0, 129.0, 56.0], "value": 78.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 122.0, 78.0, 81.0, 85.0, 122.0, 81.0, 80.0, 122.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 89.0, 89.0, 110.0, 114.0, 85.0, 88.0, 86.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 95.0, 92.0, 135.0, 101.0, 150.0, 104.0, 87.0, 88.0, 88.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 146.0, 109.0, 102.0, 92.0, 100.0, 93.0, 93.0, 93.0, 88.0], "value": 101.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 62.0, 63.0, 62.0, 71.0, 91.0, 70.0, 58.0, 64.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 70.0, 92.0, 101.0, 93.0, 72.0, 69.0, 64.0, 65.0, 66.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 80.0, 83.0, 79.0, 79.0, 79.0, 103.0, 106.0, 92.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 128.0, 127.0, 126.0, 123.0, 126.0, 128.0, 127.0, 147.0, 139.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 203.0, 157.0, 146.0, 212.0, 217.0, 165.0, 165.0, 161.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 90.0, 94.0, 69.0, 66.0, 67.0, 66.0, 70.0, 72.0, 96.0], "value": 74.6, "unit": "score"}], "name": "kraken", "value": 1566.2, "alertThreshold": 2.0}]} 13:11:16 INFO - Return code: 0 13:11:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:11:16 ERROR - # TBPL SUCCESS # 13:11:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:11:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:11:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:11:16 INFO - 2016-06-29 13:11:16.085 screenresolution[1682:10664] starting screenresolution argv=screenresolution get 13:11:16 INFO - 2016-06-29 13:11:16.088 screenresolution[1682:10664] Display 0: 1600x1200x32@60 13:11:16 INFO - 2016-06-29 13:11:16.094 screenresolution[1683:10667] starting screenresolution argv=screenresolution list 13:11:16 INFO - Available Modes on Display 0 13:11:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:11:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:11:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:11:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:11:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:11:16 INFO - Intel Iris: 13:11:16 INFO - Chipset Model: Intel Iris 13:11:16 INFO - Type: GPU 13:11:16 INFO - Bus: Built-In 13:11:16 INFO - VRAM (Dynamic, Max): 1536 MB 13:11:16 INFO - Vendor: Intel (0x8086) 13:11:16 INFO - Device ID: 0x0a2e 13:11:16 INFO - Revision ID: 0x0009 13:11:16 INFO - Displays: 13:11:16 INFO - Display: 13:11:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:11:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:11:16 INFO - Display Serial Number: 1600x1200 60 13:11:16 INFO - Main Display: Yes 13:11:16 INFO - Mirror: Off 13:11:16 INFO - Online: Yes 13:11:16 INFO - Rotation: Supported 13:11:16 INFO - Return code: 0 13:11:16 INFO - Running post-action listener: _resource_record_post_action 13:11:16 INFO - Running post-run listener: _resource_record_post_run 13:11:17 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 38028800; Write bytes: 496659968; Read time: 394; Write time: 1955 13:11:17 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194918912; Write bytes: 196253184; Read time: 17668; Write time: 453 13:11:17 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 36206080; Write bytes: 299558912; Read time: 373; Write time: 1500 13:11:17 INFO - Running post-run listener: _upload_blobber_files 13:11:17 INFO - Blob upload gear active. 13:11:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:11:17 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 13:11:17 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'] 13:11:17 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 13:11:17 INFO - (blobuploader) - INFO - Open directory for files ... 13:11:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:11:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:11:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:18 INFO - (blobuploader) - INFO - Done attempting. 13:11:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:11:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:11:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:19 INFO - (blobuploader) - INFO - Done attempting. 13:11:19 INFO - (blobuploader) - INFO - Iteration through files over. 13:11:19 INFO - Return code: 0 13:11:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:11:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:11:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11d03e91c74877ee824003fd5e80aae5b752e06ad59f1316a656194cb90684b8dcc94d1197ac47dfe37451f89adbf0f98bb357c9e277b638f2595ca1d262bfa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e151b7f683033f7707e6991d513e4774701cd5e1da7759520c7d241aed5028ae8a23c77fe845d2126f79120c0bdf88b7b700d167379361db9feebdda394a921"} 13:11:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:11:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:11:19 INFO - Contents: 13:11:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/11d03e91c74877ee824003fd5e80aae5b752e06ad59f1316a656194cb90684b8dcc94d1197ac47dfe37451f89adbf0f98bb357c9e277b638f2595ca1d262bfa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e151b7f683033f7707e6991d513e4774701cd5e1da7759520c7d241aed5028ae8a23c77fe845d2126f79120c0bdf88b7b700d167379361db9feebdda394a921"} 13:11:19 INFO - Running post-run listener: copy_logs_to_upload_dir 13:11:19 INFO - Copying logs to upload dir... 13:11:19 INFO - mkdir: /builds/slave/test/build/upload/logs 13:11:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.025162 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-29 13:11:19.922308) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 13:11:19.928127) ========= 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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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/11d03e91c74877ee824003fd5e80aae5b752e06ad59f1316a656194cb90684b8dcc94d1197ac47dfe37451f89adbf0f98bb357c9e277b638f2595ca1d262bfa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e151b7f683033f7707e6991d513e4774701cd5e1da7759520c7d241aed5028ae8a23c77fe845d2126f79120c0bdf88b7b700d167379361db9feebdda394a921"} build_url:https://queue.taskcluster.net/v1/task/ErahKSykSz6UV-BOOuHe_A/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/ErahKSykSz6UV-BOOuHe_A/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/11d03e91c74877ee824003fd5e80aae5b752e06ad59f1316a656194cb90684b8dcc94d1197ac47dfe37451f89adbf0f98bb357c9e277b638f2595ca1d262bfa2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e151b7f683033f7707e6991d513e4774701cd5e1da7759520c7d241aed5028ae8a23c77fe845d2126f79120c0bdf88b7b700d167379361db9feebdda394a921"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 13:11:19.963551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:11:19.964189) ========= 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.WCXR2hzsUZ/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.E8ptozOTdx/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005301 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 13:11:20.013484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 13:11:20.013817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 13:11:20.014154) ========= ========= Total master_lag: 0.28 =========