builder: larch_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0309 starttime: 1467329686.01 results: success (0) buildid: 20160630142223 builduid: 4844506a8c974ba9b059bf0782fd6d3f revision: 153145e35ec01ceb3d139910bcc70cf421ee4ce8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:46.010090) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:46.010496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:46.010785) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:46.035360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:46.035732) ========= 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.YxGTWUjyer/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.HjTwcEAGe7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-30 16:34:46-- 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% 19.0M=0.001s 2016-06-30 16:34:46 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:46.142239) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:46.142547) ========= 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.YxGTWUjyer/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.HjTwcEAGe7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.025893 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:46.191457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 16:34:46.191998) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 153145e35ec01ceb3d139910bcc70cf421ee4ce8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 153145e35ec01ceb3d139910bcc70cf421ee4ce8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YxGTWUjyer/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.HjTwcEAGe7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-30 16:34:46,275 truncating revision to first 12 chars 2016-06-30 16:34:46,275 Setting DEBUG logging. 2016-06-30 16:34:46,275 attempt 1/10 2016-06-30 16:34:46,275 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/153145e35ec0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 16:34:47,358 unpacking tar archive at: larch-153145e35ec0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.342203 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 16:34:47.555968) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:47.556322) ========= script_repo_revision: 153145e35ec01ceb3d139910bcc70cf421ee4ce8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:47.556779) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:47.557045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 16:34:47.576460) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-06-30 16:34:47.576869) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YxGTWUjyer/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.HjTwcEAGe7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 16:34:47 INFO - MultiFileLogger online at 20160630 16:34:47 in /builds/slave/test 16:34:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 16:34:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:34:47 INFO - {'append_to_log': False, 16:34:47 INFO - 'base_work_dir': '/builds/slave/test', 16:34:47 INFO - 'blob_upload_branch': 'Larch', 16:34:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:34:47 INFO - 'branch': 'Larch', 16:34:47 INFO - 'buildbot_json_path': 'buildprops.json', 16:34:47 INFO - 'config_files': ('talos/mac_config.py',), 16:34:47 INFO - 'default_actions': ('clobber', 16:34:47 INFO - 'read-buildbot-config', 16:34:47 INFO - 'download-and-extract', 16:34:47 INFO - 'populate-webroot', 16:34:47 INFO - 'create-virtualenv', 16:34:47 INFO - 'install', 16:34:47 INFO - 'run-tests'), 16:34:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:34:47 INFO - 'download_minidump_stackwalk': True, 16:34:47 INFO - 'download_symbols': 'ondemand', 16:34:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:34:47 INFO - 'tooltool.py': '/tools/tooltool.py', 16:34:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:34:47 INFO - '/tools/misc-python/virtualenv.py')}, 16:34:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:34:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:34:47 INFO - 'installer_path': 'installer.exe', 16:34:47 INFO - 'log_level': 'info', 16:34:47 INFO - 'log_name': 'talos', 16:34:47 INFO - 'log_to_console': True, 16:34:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:34:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:34:47 INFO - 'opt_config_files': (), 16:34:47 INFO - 'pip_index': False, 16:34:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:47 INFO - 'cmd': ('bash', 16:34:47 INFO - '-c', 16:34:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:47 INFO - 'enabled': True, 16:34:47 INFO - 'halt_on_failure': False, 16:34:47 INFO - 'name': 'check_screen_resolution'},), 16:34:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:47 INFO - 'cmd': ('bash', 16:34:47 INFO - '-c', 16:34:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:47 INFO - 'enabled': True, 16:34:47 INFO - 'halt_on_failure': False, 16:34:47 INFO - 'name': 'check_screen_resolution'},), 16:34:47 INFO - 'run_cmd_checks_enabled': True, 16:34:47 INFO - 'sps_profile': False, 16:34:47 INFO - 'sps_profile_interval': 0, 16:34:47 INFO - 'suite': 'dromaeojs-e10s', 16:34:47 INFO - 'system_bits': '32', 16:34:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:34:47 INFO - 'title': 't-yosemite-r7-0309', 16:34:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:34:47 INFO - 'use_talos_json': True, 16:34:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:34:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:34:47 INFO - 'work_dir': 'build'} 16:34:47 INFO - ##### 16:34:47 INFO - ##### Running clobber step. 16:34:47 INFO - ##### 16:34:47 INFO - Running pre-action listener: _resource_record_pre_action 16:34:47 INFO - Running main action method: clobber 16:34:47 INFO - rmtree: /builds/slave/test/build 16:34:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:34:50 INFO - Running post-action listener: _resource_record_post_action 16:34:50 INFO - ##### 16:34:50 INFO - ##### Running read-buildbot-config step. 16:34:50 INFO - ##### 16:34:50 INFO - Running pre-action listener: _resource_record_pre_action 16:34:50 INFO - Running main action method: read_buildbot_config 16:34:50 INFO - Using buildbot properties: 16:34:50 INFO - { 16:34:50 INFO - "project": "", 16:34:50 INFO - "product": "firefox", 16:34:50 INFO - "script_repo_revision": "production", 16:34:50 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs-e10s", 16:34:50 INFO - "repository": "", 16:34:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs-e10s", 16:34:50 INFO - "buildid": "20160630142223", 16:34:50 INFO - "pgo_build": "False", 16:34:50 INFO - "basedir": "/builds/slave/test", 16:34:50 INFO - "buildnumber": 0, 16:34:50 INFO - "slavename": "t-yosemite-r7-0309", 16:34:50 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:34:50 INFO - "platform": "yosemite_r7", 16:34:50 INFO - "scheduler": "tests-larch-macosx64-talos", 16:34:50 INFO - "branch": "larch", 16:34:50 INFO - "repo_path": "projects/larch", 16:34:50 INFO - "revision": "153145e35ec01ceb3d139910bcc70cf421ee4ce8", 16:34:50 INFO - "stage_platform": "macosx64", 16:34:50 INFO - "builduid": "4844506a8c974ba9b059bf0782fd6d3f", 16:34:50 INFO - "slavebuilddir": "test" 16:34:50 INFO - } 16:34:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg. 16:34:50 INFO - Running post-action listener: _resource_record_post_action 16:34:50 INFO - ##### 16:34:50 INFO - ##### Running download-and-extract step. 16:34:50 INFO - ##### 16:34:50 INFO - Running pre-action listener: _resource_record_pre_action 16:34:50 INFO - Running main action method: download_and_extract 16:34:50 INFO - mkdir: /builds/slave/test/build/tests 16:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:50 INFO - https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:34:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json 16:34:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json 16:34:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.2.en-US.mac.test_packages.json 16:34:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.mac.test_packages.json'}, attempt #1 16:34:51 INFO - Downloaded 1277 bytes. 16:34:51 INFO - Reading from file /builds/slave/test/build/firefox-47.0.2.en-US.mac.test_packages.json 16:34:51 INFO - Using the following test package requirements: 16:34:51 INFO - {u'common': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 16:34:51 INFO - u'cppunittest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:34:51 INFO - u'firefox-47.0.2.en-US.mac.cppunittest.tests.zip'], 16:34:51 INFO - u'gtest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:34:51 INFO - u'firefox-47.0.2.en-US.mac.gtest.tests.zip'], 16:34:51 INFO - u'jittest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:34:51 INFO - u'jsshell-mac.zip'], 16:34:51 INFO - u'mochitest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:34:51 INFO - u'firefox-47.0.2.en-US.mac.mochitest.tests.zip'], 16:34:51 INFO - u'mozbase': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 16:34:51 INFO - u'reftest': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:34:51 INFO - u'firefox-47.0.2.en-US.mac.reftest.tests.zip'], 16:34:51 INFO - u'talos': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:34:51 INFO - u'firefox-47.0.2.en-US.mac.talos.tests.zip'], 16:34:51 INFO - u'web-platform': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:34:51 INFO - u'firefox-47.0.2.en-US.mac.web-platform.tests.zip'], 16:34:51 INFO - u'webapprt': [u'firefox-47.0.2.en-US.mac.common.tests.zip'], 16:34:51 INFO - u'xpcshell': [u'firefox-47.0.2.en-US.mac.common.tests.zip', 16:34:51 INFO - u'firefox-47.0.2.en-US.mac.xpcshell.tests.zip']} 16:34:51 INFO - Downloading packages: [u'firefox-47.0.2.en-US.mac.common.tests.zip'] for test suite category: common 16:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:51 INFO - https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:34:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:34:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:34:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip'}, attempt #1 16:34:52 INFO - Downloaded 17990203 bytes. 16:34:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:34:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:34:55 INFO - Return code: 0 16:34:55 INFO - Downloading packages: [u'firefox-47.0.2.en-US.mac.common.tests.zip', u'firefox-47.0.2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:55 INFO - https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:34:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:34:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:34:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip 16:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip'}, attempt #1 16:35:01 INFO - Downloaded 17990203 bytes. 16:35:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:35:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:35:04 INFO - Return code: 0 16:35: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')]} 16:35:04 INFO - https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:35:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip 16:35:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip 16:35:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip 16:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip'}, attempt #1 16:35:05 INFO - Downloaded 10845194 bytes. 16:35:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:35:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:35:06 INFO - Return code: 0 16:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:06 INFO - https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg matches https://queue.taskcluster.net 16:35:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 16:35:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 16:35:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg 16:35:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg'}, attempt #1 16:35:09 INFO - Downloaded 115397489 bytes. 16:35:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 16:35:09 INFO - mkdir: /builds/slave/test/properties 16:35:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:35:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:35:09 INFO - Contents: 16:35:09 INFO - build_url:https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg 16:35:10 INFO - Running post-action listener: _resource_record_post_action 16:35:10 INFO - Running post-action listener: set_extra_try_arguments 16:35:10 INFO - ##### 16:35:10 INFO - ##### Running populate-webroot step. 16:35:10 INFO - ##### 16:35:10 INFO - Running pre-action listener: _resource_record_pre_action 16:35:10 INFO - Running main action method: populate_webroot 16:35:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:35:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:35:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:35:10 INFO - '--tppagecycles', 16:35:10 INFO - '7'], 16:35:10 INFO - 'tests': ['tsvgm']}}, 16:35:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:35:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:35:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:35:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:35:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:35:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:35:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:10 INFO - 'talos_options': ['--e10s'], 16:35:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:10 INFO - 'tests': ['damp', 'tps']}, 16:35:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:10 INFO - 'talos_options': ['--e10s'], 16:35:10 INFO - 'tests': ['damp', 'tps']}, 16:35:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:35:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:35:10 INFO - 'other': {'tests': ['a11yr', 16:35:10 INFO - 'ts_paint', 16:35:10 INFO - 'tpaint', 16:35:10 INFO - 'sessionrestore', 16:35:10 INFO - 'sessionrestore_no_auto_restore', 16:35:10 INFO - 'tabpaint']}, 16:35:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:35:10 INFO - 'tests': ['a11yr', 16:35:10 INFO - 'ts_paint', 16:35:10 INFO - 'tpaint', 16:35:10 INFO - 'sessionrestore', 16:35:10 INFO - 'sessionrestore_no_auto_restore', 16:35:10 INFO - 'tabpaint']}, 16:35:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:35:10 INFO - 'tests': ['a11yr', 16:35:10 INFO - 'ts_paint', 16:35:10 INFO - 'tpaint', 16:35:10 INFO - 'sessionrestore', 16:35:10 INFO - 'sessionrestore_no_auto_restore', 16:35:10 INFO - 'tabpaint']}, 16:35:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:35:10 INFO - 'tests': ['a11yr', 16:35:10 INFO - 'ts_paint', 16:35:10 INFO - 'tpaint', 16:35:10 INFO - 'sessionrestore', 16:35:10 INFO - 'sessionrestore_no_auto_restore', 16:35:10 INFO - 'tabpaint']}, 16:35:10 INFO - 'other_l64': {'tests': ['a11yr', 16:35:10 INFO - 'ts_paint', 16:35:10 INFO - 'tpaint', 16:35:10 INFO - 'sessionrestore', 16:35:10 INFO - 'sessionrestore_no_auto_restore', 16:35:10 INFO - 'tabpaint']}, 16:35:10 INFO - 'other_nol64': {'tests': ['a11yr', 16:35:10 INFO - 'ts_paint', 16:35:10 INFO - 'tpaint', 16:35:10 INFO - 'sessionrestore', 16:35:10 INFO - 'sessionrestore_no_auto_restore', 16:35:10 INFO - 'tabpaint']}, 16:35:10 INFO - 'svgr': {'tests': ['tsvgx', 16:35:10 INFO - 'tsvgr_opacity', 16:35:10 INFO - 'tart', 16:35:10 INFO - 'tscrollx', 16:35:10 INFO - 'cart']}, 16:35:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:35:10 INFO - 'tests': ['tsvgx', 16:35:10 INFO - 'tsvgr_opacity', 16:35:10 INFO - 'tart', 16:35:10 INFO - 'tscrollx', 16:35:10 INFO - 'cart']}, 16:35:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:10 INFO - 'tests': ['tp5o']}, 16:35:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:10 INFO - 'talos_options': ['--e10s'], 16:35:10 INFO - 'tests': ['tp5o']}, 16:35:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:10 INFO - 'talos_options': ['--xperf_path', 16:35:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:10 INFO - 'tests': ['tp5n']}, 16:35:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:10 INFO - 'talos_options': ['--e10s', 16:35:10 INFO - '--xperf_path', 16:35:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:10 INFO - 'tests': ['tp5n']}}, 16:35:10 INFO - 'talos.zip': {'path': '', 16:35:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:35:10 INFO - Running post-action listener: _resource_record_post_action 16:35:10 INFO - ##### 16:35:10 INFO - ##### Running create-virtualenv step. 16:35:10 INFO - ##### 16:35:10 INFO - Running pre-action listener: _resource_record_pre_action 16:35:10 INFO - Running main action method: create_virtualenv 16:35:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:35:10 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 16:35:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:35:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:35:10 INFO - Using real prefix '/tools/python27' 16:35:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:35:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:35:14 INFO - Installing pip.................done. 16:35:14 INFO - Return code: 0 16:35:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc359571ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10749fd30>, '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 0x1072c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107496b20>, '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.YxGTWUjyer/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.HjTwcEAGe7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 16:35:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:35:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxGTWUjyer/Render', 16:35:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:14 INFO - 'HOME': '/Users/cltbld', 16:35:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:14 INFO - 'LOGNAME': 'cltbld', 16:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:14 INFO - 'MOZ_NO_REMOTE': '1', 16:35:14 INFO - 'NO_EM_RESTART': '1', 16:35:14 INFO - 'PAGER': '/bin/cat', 16:35:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:14 INFO - 'PWD': '/builds/slave/test', 16:35:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:14 INFO - 'SHELL': '/bin/bash', 16:35:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HjTwcEAGe7/Listeners', 16:35:14 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 16:35:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:14 INFO - 'USER': 'cltbld', 16:35:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:14 INFO - 'XPC_FLAGS': '0x0', 16:35:14 INFO - 'XPC_SERVICE_NAME': '0', 16:35:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:14 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 16:35:14 INFO - Cleaning up... 16:35:14 INFO - Return code: 0 16:35:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1075fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc359571ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10749fd30>, '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 0x1072c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107496b20>, '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.YxGTWUjyer/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.HjTwcEAGe7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 16:35:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:35:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxGTWUjyer/Render', 16:35:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:14 INFO - 'HOME': '/Users/cltbld', 16:35:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:14 INFO - 'LOGNAME': 'cltbld', 16:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:14 INFO - 'MOZ_NO_REMOTE': '1', 16:35:14 INFO - 'NO_EM_RESTART': '1', 16:35:14 INFO - 'PAGER': '/bin/cat', 16:35:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:14 INFO - 'PWD': '/builds/slave/test', 16:35:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:14 INFO - 'SHELL': '/bin/bash', 16:35:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HjTwcEAGe7/Listeners', 16:35:14 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 16:35:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:14 INFO - 'USER': 'cltbld', 16:35:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:14 INFO - 'XPC_FLAGS': '0x0', 16:35:14 INFO - 'XPC_SERVICE_NAME': '0', 16:35:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:15 INFO - Downloading/unpacking psutil>=0.7.1 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:35:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:18 INFO - Installing collected packages: psutil 16:35:18 INFO - Running setup.py install for psutil 16:35:18 INFO - building 'psutil._psutil_osx' extension 16:35:18 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 16:35:18 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 16:35:18 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 16:35:18 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 16:35:18 INFO - building 'psutil._psutil_posix' extension 16:35:18 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 16:35:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:35:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:35:19 INFO - ^ 16:35:19 INFO - 1 warning generated. 16:35:19 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 16:35:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:19 INFO - Successfully installed psutil 16:35:19 INFO - Cleaning up... 16:35:19 INFO - Return code: 0 16:35:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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', '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 0x1075fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc359571ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10749fd30>, '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 0x1072c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107496b20>, '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.YxGTWUjyer/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.HjTwcEAGe7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 16:35: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:35: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 mozsystemmonitor==0.0.0 16:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxGTWUjyer/Render', 16:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:19 INFO - 'HOME': '/Users/cltbld', 16:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:19 INFO - 'LOGNAME': 'cltbld', 16:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:19 INFO - 'MOZ_NO_REMOTE': '1', 16:35:19 INFO - 'NO_EM_RESTART': '1', 16:35:19 INFO - 'PAGER': '/bin/cat', 16:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:19 INFO - 'PWD': '/builds/slave/test', 16:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:19 INFO - 'SHELL': '/bin/bash', 16:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HjTwcEAGe7/Listeners', 16:35:19 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 16:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:19 INFO - 'USER': 'cltbld', 16:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:19 INFO - 'XPC_FLAGS': '0x0', 16:35:19 INFO - 'XPC_SERVICE_NAME': '0', 16:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:35:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:35:22 INFO - Installing collected packages: mozsystemmonitor 16:35:22 INFO - Running setup.py install for mozsystemmonitor 16:35:22 INFO - Successfully installed mozsystemmonitor 16:35:22 INFO - Cleaning up... 16:35:22 INFO - Return code: 0 16:35:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:22 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 0x1075fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc359571ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10749fd30>, '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 0x1072c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107496b20>, '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.YxGTWUjyer/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.HjTwcEAGe7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 16:35:22 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 16:35:22 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 16:35:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxGTWUjyer/Render', 16:35:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:22 INFO - 'HOME': '/Users/cltbld', 16:35:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:22 INFO - 'LOGNAME': 'cltbld', 16:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:22 INFO - 'MOZ_NO_REMOTE': '1', 16:35:22 INFO - 'NO_EM_RESTART': '1', 16:35:22 INFO - 'PAGER': '/bin/cat', 16:35:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:22 INFO - 'PWD': '/builds/slave/test', 16:35:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:22 INFO - 'SHELL': '/bin/bash', 16:35:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HjTwcEAGe7/Listeners', 16:35:22 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 16:35:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:22 INFO - 'USER': 'cltbld', 16:35:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:22 INFO - 'XPC_FLAGS': '0x0', 16:35:22 INFO - 'XPC_SERVICE_NAME': '0', 16:35:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:22 INFO - Downloading/unpacking blobuploader==1.2.4 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35:25 INFO - Downloading blobuploader-1.2.4.tar.gz 16:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:35:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:35:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:26 INFO - Downloading docopt-0.6.1.tar.gz 16:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:35:26 INFO - Installing collected packages: blobuploader, requests, docopt 16:35:26 INFO - Running setup.py install for blobuploader 16:35:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:35:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:35:26 INFO - Running setup.py install for requests 16:35:26 INFO - Running setup.py install for docopt 16:35:27 INFO - Successfully installed blobuploader requests docopt 16:35:27 INFO - Cleaning up... 16:35:27 INFO - Return code: 0 16:35:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:27 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 0x1075fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc359571ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10749fd30>, '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 0x1072c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107496b20>, '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.YxGTWUjyer/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.HjTwcEAGe7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 16:35:27 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 16:35:27 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 16:35:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxGTWUjyer/Render', 16:35:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:27 INFO - 'HOME': '/Users/cltbld', 16:35:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:27 INFO - 'LOGNAME': 'cltbld', 16:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:27 INFO - 'MOZ_NO_REMOTE': '1', 16:35:27 INFO - 'NO_EM_RESTART': '1', 16:35:27 INFO - 'PAGER': '/bin/cat', 16:35:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:27 INFO - 'PWD': '/builds/slave/test', 16:35:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:27 INFO - 'SHELL': '/bin/bash', 16:35:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HjTwcEAGe7/Listeners', 16:35:27 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 16:35:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:27 INFO - 'USER': 'cltbld', 16:35:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:27 INFO - 'XPC_FLAGS': '0x0', 16:35:27 INFO - 'XPC_SERVICE_NAME': '0', 16:35:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:27 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-yQJr7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:27 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-mkw16w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:27 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-E5I0Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:27 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-dqenZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:27 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-oHPJW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:27 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-befFAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:28 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-s4IBKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:28 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Svd31H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:28 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-dDpAjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:28 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-bHAN01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:28 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-cBZCoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:28 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-1IufJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:28 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-yR_19O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:28 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-dcPCzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:28 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-JiF5tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:29 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-bDJX2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:29 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-mPQ92m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:35:29 INFO - Running setup.py install for manifestparser 16:35:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:35:29 INFO - Running setup.py install for mozcrash 16:35:29 INFO - Running setup.py install for mozdebug 16:35:29 INFO - Running setup.py install for mozdevice 16:35:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:35:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:35:29 INFO - Running setup.py install for mozfile 16:35:29 INFO - Running setup.py install for mozhttpd 16:35:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:35:30 INFO - Running setup.py install for mozinfo 16:35:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:35:30 INFO - Running setup.py install for mozInstall 16:35:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:35:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:35:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:35:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:35:30 INFO - Running setup.py install for mozleak 16:35:30 INFO - Running setup.py install for mozlog 16:35:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:35:30 INFO - Running setup.py install for moznetwork 16:35:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:35:30 INFO - Running setup.py install for mozprocess 16:35:30 INFO - Running setup.py install for mozprofile 16:35:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:35:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:35:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:35:31 INFO - Running setup.py install for mozrunner 16:35:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:35:31 INFO - Running setup.py install for mozscreenshot 16:35:31 INFO - Running setup.py install for moztest 16:35:31 INFO - Running setup.py install for mozversion 16:35:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:35:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:35:31 INFO - Cleaning up... 16:35:31 INFO - Return code: 0 16:35:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:31 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')]} 16:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:31 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')]} 16:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:31 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 0x1075fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc359571ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10749fd30>, '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 0x1072c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107496b20>, '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.YxGTWUjyer/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.HjTwcEAGe7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 16:35:31 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 16:35:31 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 16:35:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxGTWUjyer/Render', 16:35:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:31 INFO - 'HOME': '/Users/cltbld', 16:35:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:31 INFO - 'LOGNAME': 'cltbld', 16:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:31 INFO - 'MOZ_NO_REMOTE': '1', 16:35:31 INFO - 'NO_EM_RESTART': '1', 16:35:31 INFO - 'PAGER': '/bin/cat', 16:35:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:31 INFO - 'PWD': '/builds/slave/test', 16:35:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:31 INFO - 'SHELL': '/bin/bash', 16:35:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HjTwcEAGe7/Listeners', 16:35:31 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 16:35:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:31 INFO - 'USER': 'cltbld', 16:35:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:31 INFO - 'XPC_FLAGS': '0x0', 16:35:31 INFO - 'XPC_SERVICE_NAME': '0', 16:35:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:32 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Tw6rfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:32 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)) 16:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:32 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-4Qx259-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:32 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)) 16:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:32 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-dDVfIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:32 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)) 16:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:32 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-luqRZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:32 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)) 16:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:32 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-UOyN2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:32 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)) 16:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:32 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-E2tZoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:32 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)) 16:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:32 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-6tfYL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:32 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)) 16:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:32 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-tliZPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:32 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)) 16:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:32 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-mzXI4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:32 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)) 16:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:33 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Xc2BOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:33 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)) 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:33 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-vFpuU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:33 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)) 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:33 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-raiDGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:33 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)) 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:33 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-I_270r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:33 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)) 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:33 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ehodTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:33 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)) 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:33 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-oAYzwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:33 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)) 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:33 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-W7J7II-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:33 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)) 16:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:33 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-YjoFCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:33 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)) 16:35:33 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)) 16:35:33 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)) 16:35:33 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)) 16:35:33 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)) 16:35:33 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)) 16:35:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:36 INFO - Downloading blessings-1.6.tar.gz 16:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:35:36 INFO - Installing collected packages: blessings 16:35:36 INFO - Running setup.py install for blessings 16:35:36 INFO - Successfully installed blessings 16:35:36 INFO - Cleaning up... 16:35:36 INFO - Return code: 0 16:35:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:36 INFO - Reading from file tmpfile_stdout 16:35:36 INFO - Current package versions: 16:35:36 INFO - blessings == 1.6 16:35:36 INFO - blobuploader == 1.2.4 16:35:36 INFO - docopt == 0.6.1 16:35:36 INFO - manifestparser == 1.1 16:35:36 INFO - mozInstall == 1.12 16:35:36 INFO - mozcrash == 0.17 16:35:36 INFO - mozdebug == 0.1 16:35:36 INFO - mozdevice == 0.48 16:35:36 INFO - mozfile == 1.2 16:35:36 INFO - mozhttpd == 0.7 16:35:36 INFO - mozinfo == 0.9 16:35:36 INFO - mozleak == 0.1 16:35:36 INFO - mozlog == 3.1 16:35:36 INFO - moznetwork == 0.27 16:35:36 INFO - mozprocess == 0.22 16:35:36 INFO - mozprofile == 0.28 16:35:36 INFO - mozrunner == 6.11 16:35:36 INFO - mozscreenshot == 0.1 16:35:36 INFO - mozsystemmonitor == 0.0 16:35:36 INFO - moztest == 0.7 16:35:36 INFO - mozversion == 1.4 16:35:36 INFO - psutil == 3.1.1 16:35:36 INFO - requests == 1.2.3 16:35:36 INFO - wsgiref == 0.1.2 16:35:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35: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')]} 16:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35: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')]} 16:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:36 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 0x1075fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc359571ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10749fd30>, '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 0x1072c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107496b20>, '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.YxGTWUjyer/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.HjTwcEAGe7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 16:35:36 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 16:35:36 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 16:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxGTWUjyer/Render', 16:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:36 INFO - 'HOME': '/Users/cltbld', 16:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:36 INFO - 'LOGNAME': 'cltbld', 16:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:36 INFO - 'MOZ_NO_REMOTE': '1', 16:35:36 INFO - 'NO_EM_RESTART': '1', 16:35:36 INFO - 'PAGER': '/bin/cat', 16:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:36 INFO - 'PWD': '/builds/slave/test', 16:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:36 INFO - 'SHELL': '/bin/bash', 16:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HjTwcEAGe7/Listeners', 16:35:36 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 16:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:36 INFO - 'USER': 'cltbld', 16:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:36 INFO - 'XPC_FLAGS': '0x0', 16:35:36 INFO - 'XPC_SERVICE_NAME': '0', 16:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:37 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)) 16:35:37 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)) 16:35:37 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)) 16:35:37 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)) 16:35:37 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)) 16:35:37 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)) 16:35:37 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)) 16:35:37 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)) 16:35:37 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)) 16:35:37 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)) 16:35:37 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)) 16:35:37 INFO - Cleaning up... 16:35:37 INFO - Return code: 0 16:35:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:37 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 0x1075fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc359571ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10749fd30>, '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 0x1072c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107496b20>, '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.YxGTWUjyer/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.HjTwcEAGe7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 16:35:37 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 16:35:37 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 16:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxGTWUjyer/Render', 16:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:37 INFO - 'HOME': '/Users/cltbld', 16:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:37 INFO - 'LOGNAME': 'cltbld', 16:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:37 INFO - 'MOZ_NO_REMOTE': '1', 16:35:37 INFO - 'NO_EM_RESTART': '1', 16:35:37 INFO - 'PAGER': '/bin/cat', 16:35:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:37 INFO - 'PWD': '/builds/slave/test', 16:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:37 INFO - 'SHELL': '/bin/bash', 16:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HjTwcEAGe7/Listeners', 16:35:37 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 16:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:37 INFO - 'USER': 'cltbld', 16:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:37 INFO - 'XPC_FLAGS': '0x0', 16:35:37 INFO - 'XPC_SERVICE_NAME': '0', 16:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:37 INFO - Downloading/unpacking jsonschema 16:35:37 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 16:35:37 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 16:35:37 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 16:35:37 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 16:35:37 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 16:35:37 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 16:35:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:35:39 INFO - Downloading/unpacking functools32 (from jsonschema) 16:35:39 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 16:35:39 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 16:35:39 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 16:35:39 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 16:35:39 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 16:35:39 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 16:35:40 INFO - Downloading functools32-3.2.3-2.tar.gz 16:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:35:40 INFO - warning: no files found matching '*.txt' 16:35:40 INFO - no previously-included directories found matching 'build' 16:35:40 INFO - no previously-included directories found matching 'dist' 16:35:40 INFO - no previously-included directories found matching '.git*' 16:35:40 INFO - Installing collected packages: jsonschema, functools32 16:35:40 INFO - Running setup.py install for functools32 16:35:40 INFO - warning: no files found matching '*.txt' 16:35:40 INFO - no previously-included directories found matching 'build' 16:35:40 INFO - no previously-included directories found matching 'dist' 16:35:40 INFO - no previously-included directories found matching '.git*' 16:35:40 INFO - Successfully installed jsonschema functools32 16:35:40 INFO - Cleaning up... 16:35:40 INFO - Return code: 0 16:35:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:35:40 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')]} 16:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:40 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')]} 16:35:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:40 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 0x1075fba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076024c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc359571ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10749fd30>, '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 0x1072c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107496b20>, '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.YxGTWUjyer/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.HjTwcEAGe7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 16:35:40 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 16:35:40 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 16:35:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxGTWUjyer/Render', 16:35:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:40 INFO - 'HOME': '/Users/cltbld', 16:35:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:40 INFO - 'LOGNAME': 'cltbld', 16:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:40 INFO - 'MOZ_NO_REMOTE': '1', 16:35:40 INFO - 'NO_EM_RESTART': '1', 16:35:40 INFO - 'PAGER': '/bin/cat', 16:35:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:40 INFO - 'PWD': '/builds/slave/test', 16:35:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:40 INFO - 'SHELL': '/bin/bash', 16:35:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HjTwcEAGe7/Listeners', 16:35:40 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 16:35:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:40 INFO - 'USER': 'cltbld', 16:35:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:40 INFO - 'XPC_FLAGS': '0x0', 16:35:40 INFO - 'XPC_SERVICE_NAME': '0', 16:35:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:40 INFO - Downloading/unpacking flake8 16:35:40 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 16:35:40 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 16:35:40 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 16:35:40 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 16:35:40 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 16:35:40 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 16:35:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:35:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:35:43 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 16:35:43 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 16:35:43 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 16:35:43 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 16:35:43 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 16:35:43 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 16:35:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:35:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:35:43 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 16:35:43 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 16:35:43 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 16:35:43 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 16:35:43 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 16:35:43 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 16:35:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:35:44 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 16:35:44 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 16:35:44 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 16:35:44 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 16:35:44 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 16:35:44 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 16:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:35:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:35:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:35:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:35:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:35:44 INFO - no previously-included directories found matching 'docs/_build' 16:35:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:35:44 INFO - Running setup.py install for pep8 16:35:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:35:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:35:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:35:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:35:44 INFO - no previously-included directories found matching 'docs/_build' 16:35:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:35:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:35:44 INFO - Cleaning up... 16:35:44 INFO - Return code: 0 16:35:44 INFO - Running post-action listener: _resource_record_post_action 16:35:44 INFO - Running post-action listener: _start_resource_monitoring 16:35:45 INFO - Starting resource monitoring. 16:35:45 INFO - ##### 16:35:45 INFO - ##### Running install step. 16:35:45 INFO - ##### 16:35:45 INFO - Running pre-action listener: _resource_record_pre_action 16:35:45 INFO - Running main action method: install 16:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:45 INFO - Reading from file tmpfile_stdout 16:35:45 INFO - Detecting whether we're running mozinstall >=1.0... 16:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:35:45 INFO - Reading from file tmpfile_stdout 16:35:45 INFO - Output received: 16:35:45 INFO - Usage: mozinstall [options] installer 16:35:45 INFO - Options: 16:35:45 INFO - -h, --help show this help message and exit 16:35:45 INFO - -d DEST, --destination=DEST 16:35:45 INFO - Directory to install application into. [default: 16:35:45 INFO - "/builds/slave/test"] 16:35:45 INFO - --app=APP Application being installed. [default: firefox] 16:35:45 INFO - mkdir: /builds/slave/test/build/application 16:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:36:17 INFO - Reading from file tmpfile_stdout 16:36:17 INFO - Output received: 16:36:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:36:17 INFO - Running post-action listener: _resource_record_post_action 16:36:17 INFO - ##### 16:36:17 INFO - ##### Running run-tests step. 16:36:17 INFO - ##### 16:36:17 INFO - Running pre-action listener: _resource_record_pre_action 16:36:17 INFO - Running main action method: run_tests 16:36:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:36:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:36:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:36:17 INFO - 2016-06-30 16:36:17.404 screenresolution[1647:7561] starting screenresolution argv=screenresolution get 16:36:17 INFO - 2016-06-30 16:36:17.407 screenresolution[1647:7561] Display 0: 1600x1200x32@60 16:36:17 INFO - 2016-06-30 16:36:17.413 screenresolution[1648:7563] starting screenresolution argv=screenresolution list 16:36:17 INFO - Available Modes on Display 0 16:36:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:36:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:36:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:36:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:36:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:36:17 INFO - Intel Iris: 16:36:17 INFO - Chipset Model: Intel Iris 16:36:17 INFO - Type: GPU 16:36:17 INFO - Bus: Built-In 16:36:17 INFO - VRAM (Dynamic, Max): 1536 MB 16:36:17 INFO - Vendor: Intel (0x8086) 16:36:17 INFO - Device ID: 0x0a2e 16:36:17 INFO - Revision ID: 0x0009 16:36:17 INFO - Displays: 16:36:17 INFO - Display: 16:36:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:36:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:36:17 INFO - Display Serial Number: 1600x1200 60 16:36:17 INFO - Main Display: Yes 16:36:17 INFO - Mirror: Off 16:36:17 INFO - Online: Yes 16:36:17 INFO - Rotation: Supported 16:36:17 INFO - Return code: 0 16:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:36:17 INFO - Python 2.7.3 16:36:17 INFO - Return code: 0 16:36:17 INFO - grabbing minidump binary from tooltool 16:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:17 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 0x10749fd30>, '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 0x1072c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107496b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:36:17 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 16:36:17 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 16:36:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:36:17 INFO - Return code: 0 16:36:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:36:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:36:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:36:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:36:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:36:18 INFO - Return code: 0 16:36:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--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 16:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0309 --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 16:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxGTWUjyer/Render', 16:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:18 INFO - 'HOME': '/Users/cltbld', 16:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:18 INFO - 'LOGNAME': 'cltbld', 16:36:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:36:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:18 INFO - 'MOZ_NO_REMOTE': '1', 16:36:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:36:18 INFO - 'NO_EM_RESTART': '1', 16:36:18 INFO - 'PAGER': '/bin/cat', 16:36:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:18 INFO - 'PWD': '/builds/slave/test', 16:36:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:18 INFO - 'SHELL': '/bin/bash', 16:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HjTwcEAGe7/Listeners', 16:36:18 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 16:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:18 INFO - 'USER': 'cltbld', 16:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:18 INFO - 'XPC_FLAGS': '0x0', 16:36:18 INFO - 'XPC_SERVICE_NAME': '0', 16:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--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 16:36:19 INFO - mozversion application_buildid: 20160630142223 16:36:19 INFO - mozversion application_changeset: 153145e35ec01ceb3d139910bcc70cf421ee4ce8 16:36:19 INFO - mozversion application_display_name: Nightly 16:36:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:36:19 INFO - mozversion application_name: Firefox 16:36:19 INFO - mozversion application_remotingname: firefox 16:36:19 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 16:36:19 INFO - mozversion application_vendor: Mozilla 16:36:19 INFO - mozversion application_version: 47.0.2 16:36:19 INFO - mozversion platform_buildid: 20160630142223 16:36:19 INFO - mozversion platform_changeset: 153145e35ec01ceb3d139910bcc70cf421ee4ce8 16:36:19 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 16:36:19 INFO - mozversion platform_version: 47.0.2 16:36:19 INFO - using testdate: 1467329779 16:36:19 INFO - actual date: 1467329779 16:36:19 INFO - starting webserver on 'localhost:49275' 16:36:19 INFO - SUITE-START | Running 2 tests 16:36:19 INFO - TEST-START | dromaeo_css 16:36:19 INFO - operating with platform_type : mac_ 16:36:19 INFO - Initialising browser for dromaeo_css test... 16:36:19 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpqXEJKU/profile http://localhost:49275/getInfo.html) 16:36:21 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 16:36:21 INFO - PROCESS | 1666 | colorDepth:24 16:36:21 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 16:36:21 INFO - PROCESS | 1666 | __metrics 16:36:21 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 16:36:22 INFO - TEST-INFO | 1666: exit 0 16:36:22 INFO - Browser initialized. 16:36:22 INFO - Running cycle 1/1 for dromaeo_css test... 16:36:22 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpqXEJKU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:34 INFO - PROCESS | 1669 | RSS: Main: 195461120 16:36:34 INFO - PROCESS | 1669 | 16:37:23 INFO - PROCESS | 1669 | 1467329843822 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] 16:39:35 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 16:39:36 INFO - PROCESS | 1669 | RSS: Main: 205447168 16:39:36 INFO - PROCESS | 1669 | 16:42:38 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 16:42:39 INFO - PROCESS | 1669 | RSS: Main: 217456640 16:42:39 INFO - PROCESS | 1669 | 16:45:40 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 16:45:41 INFO - PROCESS | 1669 | RSS: Main: 219586560 16:45:41 INFO - PROCESS | 1669 | 16:48:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 16:48:43 INFO - PROCESS | 1669 | RSS: Main: 222593024 16:48:43 INFO - PROCESS | 1669 | 16:51:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 16:51:46 INFO - PROCESS | 1669 | RSS: Main: 221753344 16:51:46 INFO - PROCESS | 1669 | 16:54:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 16:54:49 INFO - PROCESS | 1669 | RSS: Main: 225767424 16:54:49 INFO - PROCESS | 1669 | 16:54:49 INFO - PROCESS | 1669 | __start_tp_report 16:54:49 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 16:54:49 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 16:54:49 INFO - PROCESS | 1669 | |i|pagename|runs| 16:54:49 INFO - PROCESS | 1669 | |0;dojo.html;3423.1613254752588;3560.3769340365448;3587.1928816016416;3594.2452085062137;3604.765690230134;5749.281339832521;5755.51078158356;5756.942430575693;5776.451237132476;5790.652560846353;5715.971420142893;5724.7137643117785;5780.1907732917425;5786.103154011124;5801;5206.791728330872;5273.34083239595;5290.973545132269;5328.333958255218;5330.493603107718;4052.00725822174;5141.948580514203;5274.5780337572905;5300.231466437364;5300.708461034642;4661.976690116545;5249.976254630348;5271.973640131794;5295.735213239342;5317.042932272189;4089.2434899543678;5199.324087868572;5340.839774806723;5345.064613692608;5351.785928562892;4529.139463501924;4792.9281060784115;4810.759462026919;5153.742312884341;5280.762365693553;5499.175123731432;5611.186377975171;5628.577856660726;5690.146478028288;5715.828525144252;5256.92114618281;6137.232845894263;6149;6169.938300616981;6181.938180618226;4859.708417494961;6121.3572574879445;6194.163787888668;6208.627482351073;6221;4832.613390928753;5772.913406298909;5827.125931110282;5908.320543137508;5956.731947062306;6272;6308.022256550242;6310.905336419957;6318.147050148263;6327.430531252209;6239.282482514569;6249.750009999549;6285.151504546828;6285.402886725754;6290.496760259169;6164.5684802064325;6257.7184026718905;6290.874182516324;6340.524460665376;6362.141110949962;6283.6858157091965;6285.59143655661;6331.430171284606;6348.396902294275;6379.425851673372;4812.639052071108;6151.938480615226;6311;6315.336889626615;6321.96839015802;4858.222684370484;4874.707517548958;4924.8276310328965;4926.088673595396;4955.776990035457;4070.57258987802;4083.9183216335505;4415.2935530315;4466.129104824528;4487.798049087799;5676.347220069745;5706.201131841545;5814.912776308359;5855.531557475391;5860.2967643883;6236.376362363818;6271.184745983084;6306.842328941813;6321.146645202931;6321.273053598803;5865.853353666193;5888.116782482576;5894.086416605433;5911.201987731602;5926.970365148147;5360.731963401814;5378.704171270618;5419.945800541944;5429.837104886859;5445.618806683573;6264.906026409608;6365.745370185234;6437.195350581177;6442.516811239269;6467.450266727381;6303.180586523723;6323.462505687068;6324.873502529832;6331.461825744863;6334.461570766536;6284.5600807943;6322.33615470369;6365.554411191172;6400.967995159995;6469.773557925639;6217.782377616762;6301.306856245717;6307.842303942438;6341.460975817107;6346.90479642815;6302.464290535172;6305.464035557029;6311.873762524816;6312.810615681537;6341.556091073765;5002.374703162105;6109.938900610937;6131.356207598138;6134.650895842656;6140.785072522441;6127.509799216141;6136.233543216801;6162.753489860355;6180.227471566054;6189.783357582463;5917.615355001911;6005.699715014319;6005.879882402415;6014.578979471395;6028.668423236764;6018.247719035121;6143.539234557336;6150.938490615036;6179.134921110958;6220.471259942775;6032.75868965254;6037.758489660365;6047.425494578008;6055.818325450244;6068 16:54:49 INFO - PROCESS | 1669 | |1;ext.html;437.51872939766264;582.2314544800862;594.9707006878103;615.7598536570737;624.5784095735379;32120.839395803017;38089.047773805665;38660.80669596655;38766.03084922878;38897.027574310654;33047.33905321892;40441.39337909927;40620;40846.795766021205;41116.177676446525;9552.18806401455;9572.186364159055;9710.805783884318;9711.611535538605;9730.026997300249;7717.768466946;9854.950725246399;9865.901340986606;9876;9879;9803;9810.362326448758;9859.507024648774;9882.456464894429;9905.90094099057;9774.902250977506;9815.018498150128;9819.361741486851;9912.801743965152;9929.801403971916;9668.75828104296;9775.31572789905;9777.804443911153;9802.313838031341;9815.411075335503;34011;39879.80060099681;39925.60074399248;40145.39781903274;40193;3158.3683263347193;3287.9506807397906;3312.5362449257123;3511.7892926424497;3647.708183345326;24831.751682483125;26513.734862651512;27799.722002779916;28020.719792802014;28092.43815123686;2807.2420446479337;2824.6186764786903;2833.093410108766;2836.262571731344;2909.1272618214452;374052;376912;379326;380481;448899.75550122367;48256;69698.65150674316;70254.9461758074;70278;70307.64846175736;46866;47040.7647961758;47042.52957470382;47252.7637361811;47348.28977565339;16278.75581866273;16626.916865415595;16640.6671866562;16921.323147074225;16980;13348.799768003488;13381.330933453288;13403.128796628189;13460.663483412993;13467.797983030263;15469.767953480707;15572.377104915902;15578.766318505232;15593;15693.058416495047;6706.899396509057;6787.423069039187;6813.216480104851;6830.863382732317;6836.623985680736;927.1099744245599;997.3118548201718;1040.7658276887792;1151.176908510419;1178.8231765235284;28766.424671506873;28814.42371152565;29384.85307573491;29506.55740163899;29540.556891646644;991.7867658453467;1054.6658477026567;1077.4451157653814;1167.7664467106442;1248.775220460326;14968.401263949538;15001.624959376102;15013.399464021535;15241.466548670965;15332.463363782437;536374;651897;661966;668966;673060;65593;65718;66411.33588664148;66462.33537664561;66666.66666666737;1502.894797364196;1512.8714059304862;1527.2287494815048;1553.207863989351;1555.4633651390252;24227.75772242255;28965.85517072401;29284.267893302836;30153.698463015087;30203.395932081676;52345.47654523406;52981;53038.2044269344;53063.73468132634;53089.203661945874;484322;485171;487434;489648;490138;34440.655593444746;45249.86875328143;45721.54278457173;47560.76219619018;47570.524294758;36754.8162259187;45546;45644;45957.77021114873;46225.537744622125;36423.27153456969;36781.816090920445;37589;37960.43059354167;38225.61774382221;30138.84930575333;37245.813770930974;37292.44061339028;37339.81330093441;37729.2454150921;36587;39275.803620981715;39386.80306598449;40055.59944400635;40992.59007409888;32374.514382284757;32522.02433926986;33074.5038824413;33942;34817;25806.61290080613;26039.73960260373;26179.083732069284;26399.73600263973;26414 16:54:49 INFO - PROCESS | 1669 | |2;jquery.html;341.74539967724036;357.46737361331617;366.10122150121435;374.76202611341796;380.3951716770335;19581.902090489544;20048.799512004876;21300.46748831278;21311.893440532775;21460.356189314305;20895.791042089575;21332.253371132014;21447.463813404673;21717.565648687018;21730;5791.7972870949525;6015.578909476339;6043.576949613529;6059.6364218147055;6070.332263451017;5592.944070559303;5913.053911374181;5921.082232254007;5929.377415371388;5947.85130371742;5793.594448388614;5835.883282334351;5848.2689663792025;5856.824295271149;5877.70611469427;5603.551715862721;5859.4140585941495;5868.618539794942;5904.586678932476;5913.822585322448;5108.106081435771;5108.897822043576;5121.4110377306715;5144.639875208737;5148.253503242009;24687.50624987508;24912.875435622886;25076.247712568653;25167;25416.491670166677;2264.060414927803;2287.5081857400737;2302.056156975632;2353.705786776653;2708.471847989643;14735.336909839083;14958.326875290639;15053.397864085533;15370.615734606725;15457.613559660986;1683.503366506871;1774.8757586968788;1797.4607617714632;1830.0758117150754;1832.4777438429983;111551.44224278827;112238.31642525368;112442;115003.699926001;116894;9074.909250907538;11315.660530184108;11668.766624667629;11769.705757355963;11779.763124871937;14357.210353430453;14383.496577619733;14409.78385324221;14424.711505769827;14428.350724217435;8659.09079546651;9065.048169942193;9068.365214435058;9072.593747969075;9115.498647574446;6659.267480577133;9211.263098952068;9236.8614470783;9256.537173141316;9525.57134928916;4483.730976141442;4597.08058388317;4601.976990115095;4632.027274272373;4684.297355396649;1589.7297459431925;1727.369510128794;1922.2599299269602;1965.9803401965796;1974.8123928226796;924.7410724997012;975.6000039983572;1001.9129244769362;1088.2219213262397;1092.819684752023;16532;20363.389098327072;20462.897685511776;20631.935114693617;20719.689204661943;977.6822532676908;988.9802203956025;1001.8547310639916;1027.6454623155;1055.055725126008;10848.78302433947;10982;11039.503222355013;11054.723631909266;11067.335959842436;653126;667627;668507;682174;682526;122673;122925.77074229321;124583;125880;126284;1056.5984925728173;1059.5126241928645;1060.8302671572665;1061.5859814672438;1071.994640026795;17859.553511162325;17945.730814038063;17952.012639304965;18107.54731131732;18527.888326699904;53636;54211;55022.72488637691;55213.44786552083;55344.44655553393;75947.62026189834;77344.61327693326;79274.20725792668;79417.60291198739;79988.60005700168;7902.170272121344;8152.225538573826;8153.55155466455;8165.632546535539;8388.58057097155;9607.759806004906;13485.730285394433;13564.982626303265;13835.654108647364;14065.648358791112;8884.466931984101;10260.384376937407;10350.741231469274;11783.351915644378;12145.514179432723;11706.473208705798;11723.824142637697;11737.295762254293;11851.644450666494;12121.454534546143;11233.55065797359;11819.290842549475;12038.398080096134;12139.21095128849;12264.080193985308;8333.2916702081;8380.748577542683;8413.789655258668;8463.873041904499;8558.82882342362;5660.405657405913;8290.917090829256;8697.652093916173;9363.361411753052;12014.879851201726 16:54:49 INFO - PROCESS | 1669 | |3;mootools.html;1600.2398860541243;1609.935602575897;1762.6562820250056;1940.3790786948173;2052.897355132244;8273.37949653777;8926.330525210602;9034;9267.953660231698;9267.980522142567;8251.834963300731;8338.874251975982;8970.551472426385;8978.147076027783;9134.451932884014;2534.5184414961145;2540.6062060380577;2566.6278389633494;2569.897204111833;2573.7040240372316;2524.7222805491383;2528.2415275417393;2546.401595625027;2560.142352311978;2579.5356835769553;2551.8979240830436;2570.807189460789;2578.968412634942;2592.701839288487;2594.844309341436;2568.8844002020046;2585.1856665150417;2589.054994926857;2589.378549148191;2591.313301974978;2557.514072326252;2586.896524139032;2589.974100258992;2591.857447840368;2591.9481610367875;7719.884201736979;9133.954330228373;9203.861942070875;9208.987011428737;9242.445453272825;5583;5745.770169193227;5781.306243250837;5800.100984347433;5802.274715660543;3656.4149736042104;3716.2195938852874;3732.5147730795093;3787.412950992573;3790.3556395412847;1040.7398150462384;1071.5071067309048;1077.9245452818307;1108.0692218536387;1110.7500812317244;12181.208221465666;12193.39033048344;12201.267923924594;12228;12509.249445033236;5021.648484606042;5091.490850914879;5185.481451854785;5201.08980928336;5205.24523944026;10555.26113172086;10579.735506612242;10671.19966002553;10701.143908487302;10702.946485267525;5639;5755.309362876482;5775.94224057754;5801.9129713054335;5812.82561523155;4636.79134438951;5033.395992480926;5110.386753589593;5130.640855140105;5149.948500514947;3839.347310957144;3960.980195099006;4034.4755181826763;4152.750834949913;4193.433886425293;1093.294824837991;1316.947322107105;1370.1915869636762;1381.2196109198471;1384.3977869626744;1410.1045835894076;1419.0846903747026;1431.119861285323;1453.571196497036;1460.488828909873;8309.37679674027;8370.539620320818;8391.076981532027;8402.915970840335;8474.27968622674;407.9143379890197;525.4272842601582;527.7702952121548;530.4854291337474;530.6285600079959;6337.524685648595;6342.270638876496;6361.332060133712;6381.074744162071;6444.677766111676;10796.244262901679;11184.888151118548;11188.888111118784;11243.212975091828;11308.830367544493;9432.264643253517;10505.369677819355;10633.734156646145;11035.172362072877;11108.944455277671;8701.607742761254;8755.124487551195;8772.429792063496;8811.823763524822;8892.555372231363;7936.801579960547;8127.390445716476;8130.4308698392915;8141.5522146280155;8219.424640275123;9780.85328720084;9935.65225217114;9956.55195516218;10088.192944564564;10105.343152695052;9936.354136981074;10139.84790228162;10275.794484110127;10463.738406539898;10487.423191724529;6808.761693340709;7662.578558179131;7668.348190403655;7764.767056988299;7813.1405545388825;8356.832863342821;8453.36599755033;8469.364797640324;8512.446690965067;8583.442076265272;7447.441441891771;7630.427717921067;7638.50349727266;7736.961315193388;7761.650725717243;7460.664270107966;7521.548707077593;7529.585872776831;7627.275408836152;7647.961760191386;7959.164287749702;8045.83908321842;8063.233992770677;8111.837763244584;8117.715879944174;7266.636668166465;7297.781066568012;7347.412207023533;7403.444741644291;7424.220456852169;7455.440841936985;7502.287282708134;7503.5497870127965;7506.512076714996;7560.8487830244185 16:54:49 INFO - PROCESS | 1669 | |4;prototype.html;344.29763282902877;344.73455439311726;345.31455061702525;346.5304512385719;346.93061387722463;6801.523893327463;6867.278935711754;6868.793936181923;6946.652667366624;6952.548084374512;6747.898781518281;6773.458123350132;6775.830604234897;6776.661166941658;6784.49116316277;4903.215485522317;4919.335889654886;5032.396112466491;5047.31861198739;5059.898802023967;5008.524190201925;5030.446650868402;5045.84862454127;5056.671316364443;5061.266116413118;3615.8192090395373;4928.9507104929025;4968.080905032562;4984.202527595586;4990.700557966516;4986.87532811679;4999.32509111269;5007.2489126630935;5009.774560144784;5019.799208031674;3547.450145227468;4328.5022222444195;4343.587359200871;4345.369921361416;4354.760488173181;6259;6536.77121300757;6561.671916404161;6575.934240657628;6585.571937824074;4983.476734942815;5805;5849.181114643953;5867.589268751189;5879.647221166743;6558.967205163991;6606.834829129262;7269.89095163573;7271.563706177646;7276.163241227274;4683.672142949995;4704.882377940545;4715.905681886343;4719.4100737407825;4721.268203428474;7222.783316500513;7621.17091897946;7652.617369131577;7654.808629784245;7671.309582137578;4579.267317229227;4640.164770341304;4728.929066064012;4752.14461396945;4759.4764575896625;4831.685940413862;4838.250071238964;4856.247281671346;4856.4415092264135;4861.29511220871;5247.737613119405;5277.709725965032;5819.836032793458;5822.214001109881;5823;7252.528585641917;7266.564006159541;7273.9636301818155;7277.053982982178;7280.490365674352;1594.5296137639193;1630.7146249406308;1651.0753977772486;1674.631581052191;1680.3362671744837;1062.7608788022633;1066.0512144191675;1076.6070384309671;1080.83270068326;1084.9403282819521;6622.801315960529;6645.368689974444;6645.906539440061;6679.398854103154;6703.363180497845;7155.926611008286;7403.629818509053;7441.367483763941;7480.139783924809;7502.099748030162;6672.633005184664;6715.429188518933;6716.865662686719;6736.955771855371;6738.966305168443;3870.3807390817897;3972.860949866799;3994.400839874042;4005.8798236052967;4012;7783.922160778433;7796.961015194887;7988.6804527819395;7989.480683755537;8223.629936652866;7889.8816517752275;7899.183187866823;7924.088729796147;7931.722389716332;7938.6427610757655;8037.437379383387;8037.919620803951;8038.035435747748;8046.557439340775;8068.636911339004;7353.558786472829;7626.58053807046;7629.198934111839;7658.157602663814;7660.5403675779635;6052.636841789506;7454.776356709307;7505.236269476778;7531.284527969834;7546.66040028189;8006.279434850891;8033.598320084089;8043.678252870054;8045;8074.273315401407;4773.641976851681;4779.330893674819;4781.880452988564;4798.352222449925;4800.66395352322;7241.855162896607;7578.621068946641;7583.58290294017;7587.089549253904;7604.391648668204;7292.307230813064;7302.634868256672;7330.303621155982;7339.6330183489545;7339.926600733925;7320.780376588711;7345.926540734525;7352.632368381666;7359.1169059713175;7360.66876990526;6322.0200868865395;6717.529772915849;6878.931210687829;7110.85778284421;7146.32109949554;7303.634818259172;7335.083114610674;7335.376492998155;7336.37640800538;7361.079865016873;7134.60759658203;7136.393406560501;7141.071660684078;7157.463190260647;7170.2471240519 16:54:49 INFO - PROCESS | 1669 | |5;yui.html;708.5996412027205;720.9927900720991;755.6599530211406;785.516907102132;786.2173712345697;15030.774538381933;15121.84878151218;15214.163221022853;15254.161021143833;15301.2349382531;14072.929635351835;14207.71584568308;14232.501862434818;14246.572602821932;14250.002499825016;909.9454032758056;931.790347171886;950.4534892436842;953.2135987810084;953.5565961827749;839.9207018980611;896.1620884473039;939.6476321379482;942.797298580805;953.8950715421298;968.2737946540095;978.6868202175307;997.3766396002499;1004.6483730694235;1007.098646711193;980.083621813603;989.1542730964993;989.3371441134457;991.0584944302905;995.8356871116257;735.5145603901453;737.3106145753737;748.0350348051007;749.2919191364163;749.5165618176301;13285.3357332133;13385.933070334684;13549.119307244997;13577.864221357759;13579.796303055462;10814.675559733221;11388.829167562493;11577.710557236052;11677.29936203822;11738.647840564796;11173.944130279297;11193.776124477547;11202.887971120348;11213.327200368005;11405.714857128554;3460.3425349183576;3463.1688394785324;3476;3486.0761898097026;3691.7600355976774;63961.680191598745;77711.44577108427;80307;80489.99999999942;82636.58681706613;9034.683786067588;9200.355975081813;9335.159835614828;9419.387739796892;9445.338826282094;17188.570285742706;19961;20003.299884504264;20009.299674511323;20071.29750458727;7529.4729368943645;7644.388448924184;7657.234276572298;7692.730754423568;7727.613619319124;4135.255653982312;4149.958500415018;4209.768462734579;4213.199492096492;4291.463567054118;3121.9687803122133;3799.3920972644246;3799.696024318048;3812.504374431306;3829.7319187656594;622.6388694557237;677.972881084761;679.6771533521538;694.5797792335666;697.400235797214;526.9869100037819;544.768473398804;614.2812908896602;614.5882258886556;625.2340882419;8069.193080691884;8406.537640429713;8490.15098490146;8654;8705.869411958825;504.64674727690766;541.1990254423475;590.144290778373;599.1192946368831;634.8571571396399;3278.9016329510155;3738.420544815558;3797.4493698413576;3811.6760075393904;3916;96604.51697741466;97478.51260743651;97583;98966.05169741483;99074;86082.56958715167;86985;86993.56503217443;88178;88395.67406488908;69196.65401672959;74006.8898966516;74179.62910185415;74344.25655743481;74450.8832367515;7506.399488041053;7528.698852046076;7710.151883292721;7714.842773584007;7763.184865589032;51134.74432627813;52625.210621839935;52934;53174.734126329124;56035.15947260713;72858;76839.23160768545;80968;81223;82299.5885020571;11312.786859244545;11622.18644694897;12002.699932501757;12128.332941688292;12298.83161099694;12114.454849531616;12263.93868030654;12336.81494777561;12387.256764594153;12736.490540378281;11117.76674372894;11299.548018079186;11392.202545821712;11563.421828908353;11698;11710.12174086964;11865.288082715064;12005.519779208735;12011.219270747373;12595.992320614512;11017.83473247918;11317.886821131684;11368.204225704121;11781.175317727677;11996.160268781101;9375.34372593912;9484.051594840737;9630.27772917048;9659;9760.316777825485;9710.778795094478;9771.218302535923;9779.119879210904;9783.51082445889;9877.357971731815 16:54:49 INFO - PROCESS | 1669 | __end_tp_report 16:54:49 INFO - PROCESS | 1669 | __start_cc_report 16:54:49 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,338 16:54:49 INFO - PROCESS | 1669 | __end_cc_report 16:54:49 INFO - PROCESS | 1669 | __startTimestamp1467330889225__endTimestamp 16:54:49 INFO - PROCESS | 1669 | 16:54:49 INFO - PROCESS | 1669 | ------- Summary: start ------- 16:54:49 INFO - PROCESS | 1669 | Number of tests: 6 16:54:49 INFO - PROCESS | 1669 | 16:54:49 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5740.04 Median:6014.58 stddev:693.22 (11.5%) stddev-sans-first:671.10 16:54:49 INFO - PROCESS | 1669 | Values: 3423.2 3560.4 3587.2 3594.2 3604.8 5749.3 5755.5 5756.9 5776.5 5790.7 5716.0 5724.7 5780.2 5786.1 5801.0 5206.8 5273.3 5291.0 5328.3 5330.5 4052.0 5141.9 5274.6 5300.2 5300.7 4662.0 5250.0 5272.0 5295.7 5317.0 4089.2 5199.3 5340.8 5345.1 5351.8 4529.1 4792.9 4810.8 5153.7 5280.8 5499.2 5611.2 5628.6 5690.1 5715.8 5256.9 6137.2 6149.0 6169.9 6181.9 4859.7 6121.4 6194.2 6208.6 6221.0 4832.6 5772.9 5827.1 5908.3 5956.7 6272.0 6308.0 6310.9 6318.1 6327.4 6239.3 6249.8 6285.2 6285.4 6290.5 6164.6 6257.7 6290.9 6340.5 6362.1 6283.7 6285.6 6331.4 6348.4 6379.4 4812.6 6151.9 6311.0 6315.3 6322.0 4858.2 4874.7 4924.8 4926.1 4955.8 4070.6 4083.9 4415.3 4466.1 4487.8 5676.3 5706.2 5814.9 5855.5 5860.3 6236.4 6271.2 6306.8 6321.1 6321.3 5865.9 5888.1 5894.1 5911.2 5927.0 5360.7 5378.7 5419.9 5429.8 5445.6 6264.9 6365.7 6437.2 6442.5 6467.5 6303.2 6323.5 6324.9 6331.5 6334.5 6284.6 6322.3 6365.6 6401.0 6469.8 6217.8 6301.3 6307.8 6341.5 6346.9 6302.5 6305.5 6311.9 6312.8 6341.6 5002.4 6109.9 6131.4 6134.7 6140.8 6127.5 6136.2 6162.8 6180.2 6189.8 5917.6 6005.7 6005.9 6014.6 6028.7 6018.2 6143.5 6150.9 6179.1 6220.5 6032.8 6037.8 6047.4 6055.8 6068.0 16:54:49 INFO - PROCESS | 1669 | 16:54:49 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:64909.64 Median:39086.42 stddev:138087.23 (353.3%) stddev-sans-first:138389.76 16:54:49 INFO - PROCESS | 1669 | Values: 437.5 582.2 595.0 615.8 624.6 32120.8 38089.0 38660.8 38766.0 38897.0 33047.3 40441.4 40620.0 40846.8 41116.2 9552.2 9572.2 9710.8 9711.6 9730.0 7717.8 9855.0 9865.9 9876.0 9879.0 9803.0 9810.4 9859.5 9882.5 9905.9 9774.9 9815.0 9819.4 9912.8 9929.8 9668.8 9775.3 9777.8 9802.3 9815.4 34011.0 39879.8 39925.6 40145.4 40193.0 3158.4 3288.0 3312.5 3511.8 3647.7 24831.8 26513.7 27799.7 28020.7 28092.4 2807.2 2824.6 2833.1 2836.3 2909.1 374052.0 376912.0 379326.0 380481.0 448899.8 48256.0 69698.7 70254.9 70278.0 70307.6 46866.0 47040.8 47042.5 47252.8 47348.3 16278.8 16626.9 16640.7 16921.3 16980.0 13348.8 13381.3 13403.1 13460.7 13467.8 15469.8 15572.4 15578.8 15593.0 15693.1 6706.9 6787.4 6813.2 6830.9 6836.6 927.1 997.3 1040.8 1151.2 1178.8 28766.4 28814.4 29384.9 29506.6 29540.6 991.8 1054.7 1077.4 1167.8 1248.8 14968.4 15001.6 15013.4 15241.5 15332.5 536374.0 651897.0 661966.0 668966.0 673060.0 65593.0 65718.0 66411.3 66462.3 66666.7 1502.9 1512.9 1527.2 1553.2 1555.5 24227.8 28965.9 29284.3 30153.7 30203.4 52345.5 52981.0 53038.2 53063.7 53089.2 484322.0 485171.0 487434.0 489648.0 490138.0 34440.7 45249.9 45721.5 47560.8 47570.5 36754.8 45546.0 45644.0 45957.8 46225.5 36423.3 36781.8 37589.0 37960.4 38225.6 30138.8 37245.8 37292.4 37339.8 37729.2 36587.0 39275.8 39386.8 40055.6 40992.6 32374.5 32522.0 33074.5 33942.0 34817.0 25806.6 26039.7 26179.1 26399.7 26414.0 16:54:49 INFO - PROCESS | 1669 | 16:54:49 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:36995.51 Median:2294.78 stddev:111167.29 (4844.4%) stddev-sans-first:111445.07 16:54:49 INFO - PROCESS | 1669 | Values: 341.7 357.5 366.1 374.8 380.4 19581.9 20048.8 21300.5 21311.9 21460.4 20895.8 21332.3 21447.5 21717.6 21730.0 5791.8 6015.6 6043.6 6059.6 6070.3 5592.9 5913.1 5921.1 5929.4 5947.9 5793.6 5835.9 5848.3 5856.8 5877.7 5603.6 5859.4 5868.6 5904.6 5913.8 5108.1 5108.9 5121.4 5144.6 5148.3 24687.5 24912.9 25076.2 25167.0 25416.5 2264.1 2287.5 2302.1 2353.7 2708.5 14735.3 14958.3 15053.4 15370.6 15457.6 1683.5 1774.9 1797.5 1830.1 1832.5 111551.4 112238.3 112442.0 115003.7 116894.0 9074.9 11315.7 11668.8 11769.7 11779.8 14357.2 14383.5 14409.8 14424.7 14428.4 8659.1 9065.0 9068.4 9072.6 9115.5 6659.3 9211.3 9236.9 9256.5 9525.6 4483.7 4597.1 4602.0 4632.0 4684.3 1589.7 1727.4 1922.3 1966.0 1974.8 924.7 975.6 1001.9 1088.2 1092.8 16532.0 20363.4 20462.9 20631.9 20719.7 977.7 989.0 1001.9 1027.6 1055.1 10848.8 10982.0 11039.5 11054.7 11067.3 653126.0 667627.0 668507.0 682174.0 682526.0 122673.0 122925.8 124583.0 125880.0 126284.0 1056.6 1059.5 1060.8 1061.6 1072.0 17859.6 17945.7 17952.0 18107.5 18527.9 53636.0 54211.0 55022.7 55213.4 55344.4 75947.6 77344.6 79274.2 79417.6 79988.6 7902.2 8152.2 8153.6 8165.6 8388.6 9607.8 13485.7 13565.0 13835.7 14065.6 8884.5 10260.4 10350.7 11783.4 12145.5 11706.5 11723.8 11737.3 11851.6 12121.5 11233.6 11819.3 12038.4 12139.2 12264.1 8333.3 8380.7 8413.8 8463.9 8558.8 5660.4 8290.9 8697.7 9363.4 12014.9 16:54:49 INFO - PROCESS | 1669 | 16:54:49 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:6266.94 Median:2865.34 stddev:3300.02 (115.2%) stddev-sans-first:3290.63 16:54:49 INFO - PROCESS | 1669 | Values: 1600.2 1609.9 1762.7 1940.4 2052.9 8273.4 8926.3 9034.0 9268.0 9268.0 8251.8 8338.9 8970.6 8978.1 9134.5 2534.5 2540.6 2566.6 2569.9 2573.7 2524.7 2528.2 2546.4 2560.1 2579.5 2551.9 2570.8 2579.0 2592.7 2594.8 2568.9 2585.2 2589.1 2589.4 2591.3 2557.5 2586.9 2590.0 2591.9 2591.9 7719.9 9134.0 9203.9 9209.0 9242.4 5583.0 5745.8 5781.3 5800.1 5802.3 3656.4 3716.2 3732.5 3787.4 3790.4 1040.7 1071.5 1077.9 1108.1 1110.8 12181.2 12193.4 12201.3 12228.0 12509.2 5021.6 5091.5 5185.5 5201.1 5205.2 10555.3 10579.7 10671.2 10701.1 10702.9 5639.0 5755.3 5775.9 5801.9 5812.8 4636.8 5033.4 5110.4 5130.6 5149.9 3839.3 3961.0 4034.5 4152.8 4193.4 1093.3 1316.9 1370.2 1381.2 1384.4 1410.1 1419.1 1431.1 1453.6 1460.5 8309.4 8370.5 8391.1 8402.9 8474.3 407.9 525.4 527.8 530.5 530.6 6337.5 6342.3 6361.3 6381.1 6444.7 10796.2 11184.9 11188.9 11243.2 11308.8 9432.3 10505.4 10633.7 11035.2 11108.9 8701.6 8755.1 8772.4 8811.8 8892.6 7936.8 8127.4 8130.4 8141.6 8219.4 9780.9 9935.7 9956.6 10088.2 10105.3 9936.4 10139.8 10275.8 10463.7 10487.4 6808.8 7662.6 7668.3 7764.8 7813.1 8356.8 8453.4 8469.4 8512.4 8583.4 7447.4 7630.4 7638.5 7737.0 7761.7 7460.7 7521.5 7529.6 7627.3 7648.0 7959.2 8045.8 8063.2 8111.8 8117.7 7266.6 7297.8 7347.4 7403.4 7424.2 7455.4 7502.3 7503.5 7506.5 7560.8 16:54:49 INFO - PROCESS | 1669 | 16:54:49 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5952.85 Median:6716.15 stddev:1934.45 (28.8%) stddev-sans-first:1893.52 16:54:49 INFO - PROCESS | 1669 | Values: 344.3 344.7 345.3 346.5 346.9 6801.5 6867.3 6868.8 6946.7 6952.5 6747.9 6773.5 6775.8 6776.7 6784.5 4903.2 4919.3 5032.4 5047.3 5059.9 5008.5 5030.4 5045.8 5056.7 5061.3 3615.8 4929.0 4968.1 4984.2 4990.7 4986.9 4999.3 5007.2 5009.8 5019.8 3547.5 4328.5 4343.6 4345.4 4354.8 6259.0 6536.8 6561.7 6575.9 6585.6 4983.5 5805.0 5849.2 5867.6 5879.6 6559.0 6606.8 7269.9 7271.6 7276.2 4683.7 4704.9 4715.9 4719.4 4721.3 7222.8 7621.2 7652.6 7654.8 7671.3 4579.3 4640.2 4728.9 4752.1 4759.5 4831.7 4838.3 4856.2 4856.4 4861.3 5247.7 5277.7 5819.8 5822.2 5823.0 7252.5 7266.6 7274.0 7277.1 7280.5 1594.5 1630.7 1651.1 1674.6 1680.3 1062.8 1066.1 1076.6 1080.8 1084.9 6622.8 6645.4 6645.9 6679.4 6703.4 7155.9 7403.6 7441.4 7480.1 7502.1 6672.6 6715.4 6716.9 6737.0 6739.0 3870.4 3972.9 3994.4 4005.9 4012.0 7783.9 7797.0 7988.7 7989.5 8223.6 7889.9 7899.2 7924.1 7931.7 7938.6 8037.4 8037.9 8038.0 8046.6 8068.6 7353.6 7626.6 7629.2 7658.2 7660.5 6052.6 7454.8 7505.2 7531.3 7546.7 8006.3 8033.6 8043.7 8045.0 8074.3 4773.6 4779.3 4781.9 4798.4 4800.7 7241.9 7578.6 7583.6 7587.1 7604.4 7292.3 7302.6 7330.3 7339.6 7339.9 7320.8 7345.9 7352.6 7359.1 7360.7 6322.0 6717.5 6878.9 7110.9 7146.3 7303.6 7335.1 7335.4 7336.4 7361.1 7134.6 7136.4 7141.1 7157.5 7170.2 16:54:49 INFO - PROCESS | 1669 | 16:54:49 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:19066.44 Median:623.94 stddev:27469.95 (4402.7%) stddev-sans-first:27512.43 16:54:49 INFO - PROCESS | 1669 | Values: 708.6 721.0 755.7 785.5 786.2 15030.8 15121.8 15214.2 15254.2 15301.2 14072.9 14207.7 14232.5 14246.6 14250.0 909.9 931.8 950.5 953.2 953.6 839.9 896.2 939.6 942.8 953.9 968.3 978.7 997.4 1004.6 1007.1 980.1 989.2 989.3 991.1 995.8 735.5 737.3 748.0 749.3 749.5 13285.3 13385.9 13549.1 13577.9 13579.8 10814.7 11388.8 11577.7 11677.3 11738.6 11173.9 11193.8 11202.9 11213.3 11405.7 3460.3 3463.2 3476.0 3486.1 3691.8 63961.7 77711.4 80307.0 80490.0 82636.6 9034.7 9200.4 9335.2 9419.4 9445.3 17188.6 19961.0 20003.3 20009.3 20071.3 7529.5 7644.4 7657.2 7692.7 7727.6 4135.3 4150.0 4209.8 4213.2 4291.5 3122.0 3799.4 3799.7 3812.5 3829.7 622.6 678.0 679.7 694.6 697.4 527.0 544.8 614.3 614.6 625.2 8069.2 8406.5 8490.2 8654.0 8705.9 504.6 541.2 590.1 599.1 634.9 3278.9 3738.4 3797.4 3811.7 3916.0 96604.5 97478.5 97583.0 98966.1 99074.0 86082.6 86985.0 86993.6 88178.0 88395.7 69196.7 74006.9 74179.6 74344.3 74450.9 7506.4 7528.7 7710.2 7714.8 7763.2 51134.7 52625.2 52934.0 53174.7 56035.2 72858.0 76839.2 80968.0 81223.0 82299.6 11312.8 11622.2 12002.7 12128.3 12298.8 12114.5 12263.9 12336.8 12387.3 12736.5 11117.8 11299.5 11392.2 11563.4 11698.0 11710.1 11865.3 12005.5 12011.2 12596.0 11017.8 11317.9 11368.2 11781.2 11996.2 9375.3 9484.1 9630.3 9659.0 9760.3 9710.8 9771.2 9779.1 9783.5 9877.4 16:54:49 INFO - PROCESS | 1669 | -------- Summary: end -------- 16:54:49 INFO - PROCESS | 1669 | 16:54:49 INFO - TEST-INFO | 1669: exit 0 16:54:49 INFO - TEST-OK | dromaeo_css | took 1110423ms 16:54:49 INFO - TEST-START | kraken 16:54:49 INFO - operating with platform_type : mac_ 16:54:49 INFO - Initialising browser for kraken test... 16:54:49 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmptI8JOT/profile http://localhost:49275/getInfo.html) 16:54:52 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 16:54:52 INFO - PROCESS | 1681 | colorDepth:24 16:54:52 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 16:54:52 INFO - PROCESS | 1681 | __metrics 16:54:52 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 16:54:52 INFO - TEST-INFO | 1681: exit 0 16:54:52 INFO - Browser initialized. 16:54:52 INFO - Running cycle 1/1 for kraken test... 16:54:52 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmptI8JOT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:04 INFO - PROCESS | 1684 | RSS: Main: 195620864 16:55:04 INFO - PROCESS | 1684 | 16:55:07 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 16:55:07 INFO - PROCESS | 1684 | RSS: Main: 207949824 16:55:07 INFO - PROCESS | 1684 | 16:55:10 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 16:55:11 INFO - PROCESS | 1684 | RSS: Main: 217444352 16:55:11 INFO - PROCESS | 1684 | 16:55:14 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 16:55:15 INFO - PROCESS | 1684 | RSS: Main: 220631040 16:55:15 INFO - PROCESS | 1684 | 16:55:17 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 16:55:17 INFO - PROCESS | 1684 | RSS: Main: 221429760 16:55:17 INFO - PROCESS | 1684 | 16:55:19 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:55:20 INFO - PROCESS | 1684 | RSS: Main: 222683136 16:55:20 INFO - PROCESS | 1684 | 16:55:23 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 16:55:23 INFO - PROCESS | 1684 | RSS: Main: 222842880 16:55:23 INFO - PROCESS | 1684 | 16:55:26 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 16:55:27 INFO - PROCESS | 1684 | RSS: Main: 222072832 16:55:27 INFO - PROCESS | 1684 | 16:55:29 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 16:55:30 INFO - PROCESS | 1684 | RSS: Main: 222674944 16:55:30 INFO - PROCESS | 1684 | 16:55:32 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:55:32 INFO - PROCESS | 1684 | RSS: Main: 222441472 16:55:32 INFO - PROCESS | 1684 | 16:55:34 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:55:35 INFO - PROCESS | 1684 | RSS: Main: 221913088 16:55:35 INFO - PROCESS | 1684 | 16:55:37 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:55:38 INFO - PROCESS | 1684 | RSS: Main: 221650944 16:55:38 INFO - PROCESS | 1684 | 16:55:40 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:55:41 INFO - PROCESS | 1684 | RSS: Main: 222236672 16:55:41 INFO - PROCESS | 1684 | 16:55:43 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:55:44 INFO - PROCESS | 1684 | RSS: Main: 222552064 16:55:44 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 16:55:46 INFO - PROCESS | 1684 | RSS: Main: 223461376 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | __start_tp_report 16:55:46 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 16:55:46 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 16:55:46 INFO - PROCESS | 1684 | |i|pagename|runs| 16:55:46 INFO - PROCESS | 1684 | |0;ai-astar;116;110;111;103;151;128;115;116;113;115 16:55:46 INFO - PROCESS | 1684 | |1;audio-beat-detection;150;119;159;192;119;140;124;190;184;121 16:55:46 INFO - PROCESS | 1684 | |2;audio-dft;193;202;235;201;194;198;196;195;195;198 16:55:46 INFO - PROCESS | 1684 | |3;audio-fft;61;79;69;104;59;83;83;83;153;57 16:55:46 INFO - PROCESS | 1684 | |4;audio-oscillator;86;79;124;78;84;81;117;81;78;116 16:55:46 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;89;89;92;87;88;85;109;87;89;87 16:55:46 INFO - PROCESS | 1684 | |6;imaging-darkroom;96;96;96;96;95;96;97;97;95;95 16:55:46 INFO - PROCESS | 1684 | |7;imaging-desaturate;100;150;143;121;91;91;91;97;90;93 16:55:46 INFO - PROCESS | 1684 | |8;json-parse-financial;55;61;57;60;60;60;68;89;88;67 16:55:46 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;62;64;94;72;78;95;94;94;100;84 16:55:46 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;82;84;98;103;108;93;81;83;80;87 16:55:46 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;149;133;124;120;137;136;120;135;137;131 16:55:46 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;127;136;134;139;120;155;173;169;179;169 16:55:46 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;68;66;65;67;63;68;65;69;68;67 16:55:46 INFO - PROCESS | 1684 | __end_tp_report 16:55:46 INFO - PROCESS | 1684 | __start_cc_report 16:55:46 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,932 16:55:46 INFO - PROCESS | 1684 | __end_cc_report 16:55:46 INFO - PROCESS | 1684 | __startTimestamp1467330946467__endTimestamp 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | ------- Summary: start ------- 16:55:46 INFO - PROCESS | 1684 | Number of tests: 14 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:117.80 Median:115.50 stddev:13.24 (11.5%) stddev-sans-first:14.03 16:55:46 INFO - PROCESS | 1684 | Values: 116.0 110.0 111.0 103.0 151.0 128.0 115.0 116.0 113.0 115.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:154.50 stddev:30.07 (19.5%) stddev-sans-first:31.90 16:55:46 INFO - PROCESS | 1684 | Values: 150.0 119.0 159.0 192.0 119.0 140.0 124.0 190.0 184.0 121.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:200.70 Median:198.00 stddev:12.40 (6.3%) stddev-sans-first:12.84 16:55:46 INFO - PROCESS | 1684 | Values: 193.0 202.0 235.0 201.0 194.0 198.0 196.0 195.0 195.0 198.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:83.10 Median:74.00 stddev:28.46 (38.5%) stddev-sans-first:29.04 16:55:46 INFO - PROCESS | 1684 | Values: 61.0 79.0 69.0 104.0 59.0 83.0 83.0 83.0 153.0 57.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:80.00 stddev:18.64 (23.3%) stddev-sans-first:19.62 16:55:46 INFO - PROCESS | 1684 | Values: 86.0 79.0 124.0 78.0 84.0 81.0 117.0 81.0 78.0 116.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:88.50 stddev:6.86 (7.8%) stddev-sans-first:7.26 16:55:46 INFO - PROCESS | 1684 | Values: 89.0 89.0 92.0 87.0 88.0 85.0 109.0 87.0 89.0 87.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 16:55:46 INFO - PROCESS | 1684 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 97.0 97.0 95.0 95.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:106.70 Median:91.00 stddev:22.95 (25.2%) stddev-sans-first:24.22 16:55:46 INFO - PROCESS | 1684 | Values: 100.0 150.0 143.0 121.0 91.0 91.0 91.0 97.0 90.0 93.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:64.00 stddev:12.25 (19.1%) stddev-sans-first:12.27 16:55:46 INFO - PROCESS | 1684 | Values: 55.0 61.0 57.0 60.0 60.0 60.0 68.0 89.0 88.0 67.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:83.70 Median:89.00 stddev:13.90 (15.6%) stddev-sans-first:12.33 16:55:46 INFO - PROCESS | 1684 | Values: 62.0 64.0 94.0 72.0 78.0 95.0 94.0 94.0 100.0 84.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:83.50 stddev:10.03 (12.0%) stddev-sans-first:10.22 16:55:46 INFO - PROCESS | 1684 | Values: 82.0 84.0 98.0 103.0 108.0 93.0 81.0 83.0 80.0 87.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:135.50 stddev:8.93 (6.6%) stddev-sans-first:7.11 16:55:46 INFO - PROCESS | 1684 | Values: 149.0 133.0 124.0 120.0 137.0 136.0 120.0 135.0 137.0 131.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:162.00 stddev:21.39 (13.2%) stddev-sans-first:20.99 16:55:46 INFO - PROCESS | 1684 | Values: 127.0 136.0 134.0 139.0 120.0 155.0 173.0 169.0 179.0 169.0 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.50 stddev:1.84 (2.7%) stddev-sans-first:1.88 16:55:46 INFO - PROCESS | 1684 | Values: 68.0 66.0 65.0 67.0 63.0 68.0 65.0 69.0 68.0 67.0 16:55:46 INFO - PROCESS | 1684 | -------- Summary: end -------- 16:55:46 INFO - PROCESS | 1684 | 16:55:46 INFO - TEST-INFO | 1684: exit 0 16:55:47 INFO - TEST-OK | kraken | took 57416ms 16:55:47 INFO - SUITE-END | took 1167s 16:55:47 INFO - Completed test suite (00:19:27) 16:55:47 INFO - javascript benchmark 16:55:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3423.1613254752588, 3560.3769340365448, 3587.1928816016416, 3594.2452085062137, 3604.765690230134, 5749.281339832521, 5755.51078158356, 5756.942430575693, 5776.451237132476, 5790.652560846353, 5715.971420142893, 5724.7137643117785, 5780.1907732917425, 5786.103154011124, 5801.0, 5206.791728330872, 5273.34083239595, 5290.973545132269, 5328.333958255218, 5330.493603107718, 4052.00725822174, 5141.948580514203, 5274.5780337572905, 5300.231466437364, 5300.708461034642, 4661.976690116545, 5249.976254630348, 5271.973640131794, 5295.735213239342, 5317.042932272189, 4089.2434899543678, 5199.324087868572, 5340.839774806723, 5345.064613692608, 5351.785928562892, 4529.139463501924, 4792.9281060784115, 4810.759462026919, 5153.742312884341, 5280.762365693553, 5499.175123731432, 5611.186377975171, 5628.577856660726, 5690.146478028288, 5715.828525144252, 5256.92114618281, 6137.232845894263, 6149.0, 6169.938300616981, 6181.938180618226, 4859.708417494961, 6121.3572574879445, 6194.163787888668, 6208.627482351073, 6221.0, 4832.613390928753, 5772.913406298909, 5827.125931110282, 5908.320543137508, 5956.731947062306, 6272.0, 6308.022256550242, 6310.905336419957, 6318.147050148263, 6327.430531252209, 6239.282482514569, 6249.750009999549, 6285.151504546828, 6285.402886725754, 6290.496760259169, 6164.5684802064325, 6257.7184026718905, 6290.874182516324, 6340.524460665376, 6362.141110949962, 6283.6858157091965, 6285.59143655661, 6331.430171284606, 6348.396902294275, 6379.425851673372, 4812.639052071108, 6151.938480615226, 6311.0, 6315.336889626615, 6321.96839015802, 4858.222684370484, 4874.707517548958, 4924.8276310328965, 4926.088673595396, 4955.776990035457, 4070.57258987802, 4083.9183216335505, 4415.2935530315, 4466.129104824528, 4487.798049087799, 5676.347220069745, 5706.201131841545, 5814.912776308359, 5855.531557475391, 5860.2967643883, 6236.376362363818, 6271.184745983084, 6306.842328941813, 6321.146645202931, 6321.273053598803, 5865.853353666193, 5888.116782482576, 5894.086416605433, 5911.201987731602, 5926.970365148147, 5360.731963401814, 5378.704171270618, 5419.945800541944, 5429.837104886859, 5445.618806683573, 6264.906026409608, 6365.745370185234, 6437.195350581177, 6442.516811239269, 6467.450266727381, 6303.180586523723, 6323.462505687068, 6324.873502529832, 6331.461825744863, 6334.461570766536, 6284.5600807943, 6322.33615470369, 6365.554411191172, 6400.967995159995, 6469.773557925639, 6217.782377616762, 6301.306856245717, 6307.842303942438, 6341.460975817107, 6346.90479642815, 6302.464290535172, 6305.464035557029, 6311.873762524816, 6312.810615681537, 6341.556091073765, 5002.374703162105, 6109.938900610937, 6131.356207598138, 6134.650895842656, 6140.785072522441, 6127.509799216141, 6136.233543216801, 6162.753489860355, 6180.227471566054, 6189.783357582463, 5917.615355001911, 6005.699715014319, 6005.879882402415, 6014.578979471395, 6028.668423236764, 6018.247719035121, 6143.539234557336, 6150.938490615036, 6179.134921110958, 6220.471259942775, 6032.75868965254, 6037.758489660365, 6047.425494578008, 6055.818325450244, 6068.0], "unit": "score", "name": "dojo.html", "value": 5697.686066507746}, {"lowerIsBetter": false, "replicates": [437.51872939766264, 582.2314544800862, 594.9707006878103, 615.7598536570737, 624.5784095735379, 32120.839395803017, 38089.047773805665, 38660.80669596655, 38766.03084922878, 38897.027574310654, 33047.33905321892, 40441.39337909927, 40620.0, 40846.795766021205, 41116.177676446525, 9552.18806401455, 9572.186364159055, 9710.805783884318, 9711.611535538605, 9730.026997300249, 7717.768466946, 9854.950725246399, 9865.901340986606, 9876.0, 9879.0, 9803.0, 9810.362326448758, 9859.507024648774, 9882.456464894429, 9905.90094099057, 9774.902250977506, 9815.018498150128, 9819.361741486851, 9912.801743965152, 9929.801403971916, 9668.75828104296, 9775.31572789905, 9777.804443911153, 9802.313838031341, 9815.411075335503, 34011.0, 39879.80060099681, 39925.60074399248, 40145.39781903274, 40193.0, 3158.3683263347193, 3287.9506807397906, 3312.5362449257123, 3511.7892926424497, 3647.708183345326, 24831.751682483125, 26513.734862651512, 27799.722002779916, 28020.719792802014, 28092.43815123686, 2807.2420446479337, 2824.6186764786903, 2833.093410108766, 2836.262571731344, 2909.1272618214452, 374052.0, 376912.0, 379326.0, 380481.0, 448899.75550122367, 48256.0, 69698.65150674316, 70254.9461758074, 70278.0, 70307.64846175736, 46866.0, 47040.7647961758, 47042.52957470382, 47252.7637361811, 47348.28977565339, 16278.75581866273, 16626.916865415595, 16640.6671866562, 16921.323147074225, 16980.0, 13348.799768003488, 13381.330933453288, 13403.128796628189, 13460.663483412993, 13467.797983030263, 15469.767953480707, 15572.377104915902, 15578.766318505232, 15593.0, 15693.058416495047, 6706.899396509057, 6787.423069039187, 6813.216480104851, 6830.863382732317, 6836.623985680736, 927.1099744245599, 997.3118548201718, 1040.7658276887792, 1151.176908510419, 1178.8231765235284, 28766.424671506873, 28814.42371152565, 29384.85307573491, 29506.55740163899, 29540.556891646644, 991.7867658453467, 1054.6658477026567, 1077.4451157653814, 1167.7664467106442, 1248.775220460326, 14968.401263949538, 15001.624959376102, 15013.399464021535, 15241.466548670965, 15332.463363782437, 536374.0, 651897.0, 661966.0, 668966.0, 673060.0, 65593.0, 65718.0, 66411.33588664148, 66462.33537664561, 66666.66666666737, 1502.894797364196, 1512.8714059304862, 1527.2287494815048, 1553.207863989351, 1555.4633651390252, 24227.75772242255, 28965.85517072401, 29284.267893302836, 30153.698463015087, 30203.395932081676, 52345.47654523406, 52981.0, 53038.2044269344, 53063.73468132634, 53089.203661945874, 484322.0, 485171.0, 487434.0, 489648.0, 490138.0, 34440.655593444746, 45249.86875328143, 45721.54278457173, 47560.76219619018, 47570.524294758, 36754.8162259187, 45546.0, 45644.0, 45957.77021114873, 46225.537744622125, 36423.27153456969, 36781.816090920445, 37589.0, 37960.43059354167, 38225.61774382221, 30138.84930575333, 37245.813770930974, 37292.44061339028, 37339.81330093441, 37729.2454150921, 36587.0, 39275.803620981715, 39386.80306598449, 40055.59944400635, 40992.59007409888, 32374.514382284757, 32522.02433926986, 33074.5038824413, 33942.0, 34817.0, 25806.61290080613, 26039.73960260373, 26179.083732069284, 26399.73600263973, 26414.0], "unit": "score", "name": "ext.html", "value": 19783.843321681506}, {"lowerIsBetter": false, "replicates": [341.74539967724036, 357.46737361331617, 366.10122150121435, 374.76202611341796, 380.3951716770335, 19581.902090489544, 20048.799512004876, 21300.46748831278, 21311.893440532775, 21460.356189314305, 20895.791042089575, 21332.253371132014, 21447.463813404673, 21717.565648687018, 21730.0, 5791.7972870949525, 6015.578909476339, 6043.576949613529, 6059.6364218147055, 6070.332263451017, 5592.944070559303, 5913.053911374181, 5921.082232254007, 5929.377415371388, 5947.85130371742, 5793.594448388614, 5835.883282334351, 5848.2689663792025, 5856.824295271149, 5877.70611469427, 5603.551715862721, 5859.4140585941495, 5868.618539794942, 5904.586678932476, 5913.822585322448, 5108.106081435771, 5108.897822043576, 5121.4110377306715, 5144.639875208737, 5148.253503242009, 24687.50624987508, 24912.875435622886, 25076.247712568653, 25167.0, 25416.491670166677, 2264.060414927803, 2287.5081857400737, 2302.056156975632, 2353.705786776653, 2708.471847989643, 14735.336909839083, 14958.326875290639, 15053.397864085533, 15370.615734606725, 15457.613559660986, 1683.503366506871, 1774.8757586968788, 1797.4607617714632, 1830.0758117150754, 1832.4777438429983, 111551.44224278827, 112238.31642525368, 112442.0, 115003.699926001, 116894.0, 9074.909250907538, 11315.660530184108, 11668.766624667629, 11769.705757355963, 11779.763124871937, 14357.210353430453, 14383.496577619733, 14409.78385324221, 14424.711505769827, 14428.350724217435, 8659.09079546651, 9065.048169942193, 9068.365214435058, 9072.593747969075, 9115.498647574446, 6659.267480577133, 9211.263098952068, 9236.8614470783, 9256.537173141316, 9525.57134928916, 4483.730976141442, 4597.08058388317, 4601.976990115095, 4632.027274272373, 4684.297355396649, 1589.7297459431925, 1727.369510128794, 1922.2599299269602, 1965.9803401965796, 1974.8123928226796, 924.7410724997012, 975.6000039983572, 1001.9129244769362, 1088.2219213262397, 1092.819684752023, 16532.0, 20363.389098327072, 20462.897685511776, 20631.935114693617, 20719.689204661943, 977.6822532676908, 988.9802203956025, 1001.8547310639916, 1027.6454623155, 1055.055725126008, 10848.78302433947, 10982.0, 11039.503222355013, 11054.723631909266, 11067.335959842436, 653126.0, 667627.0, 668507.0, 682174.0, 682526.0, 122673.0, 122925.77074229321, 124583.0, 125880.0, 126284.0, 1056.5984925728173, 1059.5126241928645, 1060.8302671572665, 1061.5859814672438, 1071.994640026795, 17859.553511162325, 17945.730814038063, 17952.012639304965, 18107.54731131732, 18527.888326699904, 53636.0, 54211.0, 55022.72488637691, 55213.44786552083, 55344.44655553393, 75947.62026189834, 77344.61327693326, 79274.20725792668, 79417.60291198739, 79988.60005700168, 7902.170272121344, 8152.225538573826, 8153.55155466455, 8165.632546535539, 8388.58057097155, 9607.759806004906, 13485.730285394433, 13564.982626303265, 13835.654108647364, 14065.648358791112, 8884.466931984101, 10260.384376937407, 10350.741231469274, 11783.351915644378, 12145.514179432723, 11706.473208705798, 11723.824142637697, 11737.295762254293, 11851.644450666494, 12121.454534546143, 11233.55065797359, 11819.290842549475, 12038.398080096134, 12139.21095128849, 12264.080193985308, 8333.2916702081, 8380.748577542683, 8413.789655258668, 8463.873041904499, 8558.82882342362, 5660.405657405913, 8290.917090829256, 8697.652093916173, 9363.361411753052, 12014.879851201726], "unit": "score", "name": "jquery.html", "value": 9713.695511811791}, {"lowerIsBetter": false, "replicates": [1600.2398860541243, 1609.935602575897, 1762.6562820250056, 1940.3790786948173, 2052.897355132244, 8273.37949653777, 8926.330525210602, 9034.0, 9267.953660231698, 9267.980522142567, 8251.834963300731, 8338.874251975982, 8970.551472426385, 8978.147076027783, 9134.451932884014, 2534.5184414961145, 2540.6062060380577, 2566.6278389633494, 2569.897204111833, 2573.7040240372316, 2524.7222805491383, 2528.2415275417393, 2546.401595625027, 2560.142352311978, 2579.5356835769553, 2551.8979240830436, 2570.807189460789, 2578.968412634942, 2592.701839288487, 2594.844309341436, 2568.8844002020046, 2585.1856665150417, 2589.054994926857, 2589.378549148191, 2591.313301974978, 2557.514072326252, 2586.896524139032, 2589.974100258992, 2591.857447840368, 2591.9481610367875, 7719.884201736979, 9133.954330228373, 9203.861942070875, 9208.987011428737, 9242.445453272825, 5583.0, 5745.770169193227, 5781.306243250837, 5800.100984347433, 5802.274715660543, 3656.4149736042104, 3716.2195938852874, 3732.5147730795093, 3787.412950992573, 3790.3556395412847, 1040.7398150462384, 1071.5071067309048, 1077.9245452818307, 1108.0692218536387, 1110.7500812317244, 12181.208221465666, 12193.39033048344, 12201.267923924594, 12228.0, 12509.249445033236, 5021.648484606042, 5091.490850914879, 5185.481451854785, 5201.08980928336, 5205.24523944026, 10555.26113172086, 10579.735506612242, 10671.19966002553, 10701.143908487302, 10702.946485267525, 5639.0, 5755.309362876482, 5775.94224057754, 5801.9129713054335, 5812.82561523155, 4636.79134438951, 5033.395992480926, 5110.386753589593, 5130.640855140105, 5149.948500514947, 3839.347310957144, 3960.980195099006, 4034.4755181826763, 4152.750834949913, 4193.433886425293, 1093.294824837991, 1316.947322107105, 1370.1915869636762, 1381.2196109198471, 1384.3977869626744, 1410.1045835894076, 1419.0846903747026, 1431.119861285323, 1453.571196497036, 1460.488828909873, 8309.37679674027, 8370.539620320818, 8391.076981532027, 8402.915970840335, 8474.27968622674, 407.9143379890197, 525.4272842601582, 527.7702952121548, 530.4854291337474, 530.6285600079959, 6337.524685648595, 6342.270638876496, 6361.332060133712, 6381.074744162071, 6444.677766111676, 10796.244262901679, 11184.888151118548, 11188.888111118784, 11243.212975091828, 11308.830367544493, 9432.264643253517, 10505.369677819355, 10633.734156646145, 11035.172362072877, 11108.944455277671, 8701.607742761254, 8755.124487551195, 8772.429792063496, 8811.823763524822, 8892.555372231363, 7936.801579960547, 8127.390445716476, 8130.4308698392915, 8141.5522146280155, 8219.424640275123, 9780.85328720084, 9935.65225217114, 9956.55195516218, 10088.192944564564, 10105.343152695052, 9936.354136981074, 10139.84790228162, 10275.794484110127, 10463.738406539898, 10487.423191724529, 6808.761693340709, 7662.578558179131, 7668.348190403655, 7764.767056988299, 7813.1405545388825, 8356.832863342821, 8453.36599755033, 8469.364797640324, 8512.446690965067, 8583.442076265272, 7447.441441891771, 7630.427717921067, 7638.50349727266, 7736.961315193388, 7761.650725717243, 7460.664270107966, 7521.548707077593, 7529.585872776831, 7627.275408836152, 7647.961760191386, 7959.164287749702, 8045.83908321842, 8063.233992770677, 8111.837763244584, 8117.715879944174, 7266.636668166465, 7297.781066568012, 7347.412207023533, 7403.444741644291, 7424.220456852169, 7455.440841936985, 7502.287282708134, 7503.5497870127965, 7506.512076714996, 7560.8487830244185], "unit": "score", "name": "mootools.html", "value": 5030.85949664978}, {"lowerIsBetter": false, "replicates": [344.29763282902877, 344.73455439311726, 345.31455061702525, 346.5304512385719, 346.93061387722463, 6801.523893327463, 6867.278935711754, 6868.793936181923, 6946.652667366624, 6952.548084374512, 6747.898781518281, 6773.458123350132, 6775.830604234897, 6776.661166941658, 6784.49116316277, 4903.215485522317, 4919.335889654886, 5032.396112466491, 5047.31861198739, 5059.898802023967, 5008.524190201925, 5030.446650868402, 5045.84862454127, 5056.671316364443, 5061.266116413118, 3615.8192090395373, 4928.9507104929025, 4968.080905032562, 4984.202527595586, 4990.700557966516, 4986.87532811679, 4999.32509111269, 5007.2489126630935, 5009.774560144784, 5019.799208031674, 3547.450145227468, 4328.5022222444195, 4343.587359200871, 4345.369921361416, 4354.760488173181, 6259.0, 6536.77121300757, 6561.671916404161, 6575.934240657628, 6585.571937824074, 4983.476734942815, 5805.0, 5849.181114643953, 5867.589268751189, 5879.647221166743, 6558.967205163991, 6606.834829129262, 7269.89095163573, 7271.563706177646, 7276.163241227274, 4683.672142949995, 4704.882377940545, 4715.905681886343, 4719.4100737407825, 4721.268203428474, 7222.783316500513, 7621.17091897946, 7652.617369131577, 7654.808629784245, 7671.309582137578, 4579.267317229227, 4640.164770341304, 4728.929066064012, 4752.14461396945, 4759.4764575896625, 4831.685940413862, 4838.250071238964, 4856.247281671346, 4856.4415092264135, 4861.29511220871, 5247.737613119405, 5277.709725965032, 5819.836032793458, 5822.214001109881, 5823.0, 7252.528585641917, 7266.564006159541, 7273.9636301818155, 7277.053982982178, 7280.490365674352, 1594.5296137639193, 1630.7146249406308, 1651.0753977772486, 1674.631581052191, 1680.3362671744837, 1062.7608788022633, 1066.0512144191675, 1076.6070384309671, 1080.83270068326, 1084.9403282819521, 6622.801315960529, 6645.368689974444, 6645.906539440061, 6679.398854103154, 6703.363180497845, 7155.926611008286, 7403.629818509053, 7441.367483763941, 7480.139783924809, 7502.099748030162, 6672.633005184664, 6715.429188518933, 6716.865662686719, 6736.955771855371, 6738.966305168443, 3870.3807390817897, 3972.860949866799, 3994.400839874042, 4005.8798236052967, 4012.0, 7783.922160778433, 7796.961015194887, 7988.6804527819395, 7989.480683755537, 8223.629936652866, 7889.8816517752275, 7899.183187866823, 7924.088729796147, 7931.722389716332, 7938.6427610757655, 8037.437379383387, 8037.919620803951, 8038.035435747748, 8046.557439340775, 8068.636911339004, 7353.558786472829, 7626.58053807046, 7629.198934111839, 7658.157602663814, 7660.5403675779635, 6052.636841789506, 7454.776356709307, 7505.236269476778, 7531.284527969834, 7546.66040028189, 8006.279434850891, 8033.598320084089, 8043.678252870054, 8045.0, 8074.273315401407, 4773.641976851681, 4779.330893674819, 4781.880452988564, 4798.352222449925, 4800.66395352322, 7241.855162896607, 7578.621068946641, 7583.58290294017, 7587.089549253904, 7604.391648668204, 7292.307230813064, 7302.634868256672, 7330.303621155982, 7339.6330183489545, 7339.926600733925, 7320.780376588711, 7345.926540734525, 7352.632368381666, 7359.1169059713175, 7360.66876990526, 6322.0200868865395, 6717.529772915849, 6878.931210687829, 7110.85778284421, 7146.32109949554, 7303.634818259172, 7335.083114610674, 7335.376492998155, 7336.37640800538, 7361.079865016873, 7134.60759658203, 7136.393406560501, 7141.071660684078, 7157.463190260647, 7170.2471240519], "unit": "score", "name": "prototype.html", "value": 5304.949851426978}, {"lowerIsBetter": false, "replicates": [708.5996412027205, 720.9927900720991, 755.6599530211406, 785.516907102132, 786.2173712345697, 15030.774538381933, 15121.84878151218, 15214.163221022853, 15254.161021143833, 15301.2349382531, 14072.929635351835, 14207.71584568308, 14232.501862434818, 14246.572602821932, 14250.002499825016, 909.9454032758056, 931.790347171886, 950.4534892436842, 953.2135987810084, 953.5565961827749, 839.9207018980611, 896.1620884473039, 939.6476321379482, 942.797298580805, 953.8950715421298, 968.2737946540095, 978.6868202175307, 997.3766396002499, 1004.6483730694235, 1007.098646711193, 980.083621813603, 989.1542730964993, 989.3371441134457, 991.0584944302905, 995.8356871116257, 735.5145603901453, 737.3106145753737, 748.0350348051007, 749.2919191364163, 749.5165618176301, 13285.3357332133, 13385.933070334684, 13549.119307244997, 13577.864221357759, 13579.796303055462, 10814.675559733221, 11388.829167562493, 11577.710557236052, 11677.29936203822, 11738.647840564796, 11173.944130279297, 11193.776124477547, 11202.887971120348, 11213.327200368005, 11405.714857128554, 3460.3425349183576, 3463.1688394785324, 3476.0, 3486.0761898097026, 3691.7600355976774, 63961.680191598745, 77711.44577108427, 80307.0, 80489.99999999942, 82636.58681706613, 9034.683786067588, 9200.355975081813, 9335.159835614828, 9419.387739796892, 9445.338826282094, 17188.570285742706, 19961.0, 20003.299884504264, 20009.299674511323, 20071.29750458727, 7529.4729368943645, 7644.388448924184, 7657.234276572298, 7692.730754423568, 7727.613619319124, 4135.255653982312, 4149.958500415018, 4209.768462734579, 4213.199492096492, 4291.463567054118, 3121.9687803122133, 3799.3920972644246, 3799.696024318048, 3812.504374431306, 3829.7319187656594, 622.6388694557237, 677.972881084761, 679.6771533521538, 694.5797792335666, 697.400235797214, 526.9869100037819, 544.768473398804, 614.2812908896602, 614.5882258886556, 625.2340882419, 8069.193080691884, 8406.537640429713, 8490.15098490146, 8654.0, 8705.869411958825, 504.64674727690766, 541.1990254423475, 590.144290778373, 599.1192946368831, 634.8571571396399, 3278.9016329510155, 3738.420544815558, 3797.4493698413576, 3811.6760075393904, 3916.0, 96604.51697741466, 97478.51260743651, 97583.0, 98966.05169741483, 99074.0, 86082.56958715167, 86985.0, 86993.56503217443, 88178.0, 88395.67406488908, 69196.65401672959, 74006.8898966516, 74179.62910185415, 74344.25655743481, 74450.8832367515, 7506.399488041053, 7528.698852046076, 7710.151883292721, 7714.842773584007, 7763.184865589032, 51134.74432627813, 52625.210621839935, 52934.0, 53174.734126329124, 56035.15947260713, 72858.0, 76839.23160768545, 80968.0, 81223.0, 82299.5885020571, 11312.786859244545, 11622.18644694897, 12002.699932501757, 12128.332941688292, 12298.83161099694, 12114.454849531616, 12263.93868030654, 12336.81494777561, 12387.256764594153, 12736.490540378281, 11117.76674372894, 11299.548018079186, 11392.202545821712, 11563.421828908353, 11698.0, 11710.12174086964, 11865.288082715064, 12005.519779208735, 12011.219270747373, 12595.992320614512, 11017.83473247918, 11317.886821131684, 11368.204225704121, 11781.175317727677, 11996.160268781101, 9375.34372593912, 9484.051594840737, 9630.27772917048, 9659.0, 9760.316777825485, 9710.778795094478, 9771.218302535923, 9779.119879210904, 9783.51082445889, 9877.357971731815], "unit": "score", "name": "yui.html", "value": 7035.543506852282}], "name": "dromaeo_css", "value": 7682.597281980306}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 110.0, 111.0, 103.0, 151.0, 128.0, 115.0, 116.0, 113.0, 115.0], "unit": "score", "name": "ai-astar", "value": 117.8}, {"lowerIsBetter": true, "replicates": [150.0, 119.0, 159.0, 192.0, 119.0, 140.0, 124.0, 190.0, 184.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [193.0, 202.0, 235.0, 201.0, 194.0, 198.0, 196.0, 195.0, 195.0, 198.0], "unit": "score", "name": "audio-dft", "value": 200.7}, {"lowerIsBetter": true, "replicates": [61.0, 79.0, 69.0, 104.0, 59.0, 83.0, 83.0, 83.0, 153.0, 57.0], "unit": "score", "name": "audio-fft", "value": 83.1}, {"lowerIsBetter": true, "replicates": [86.0, 79.0, 124.0, 78.0, 84.0, 81.0, 117.0, 81.0, 78.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 92.4}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 92.0, 87.0, 88.0, 85.0, 109.0, 87.0, 89.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.9}, {"lowerIsBetter": true, "replicates": [100.0, 150.0, 143.0, 121.0, 91.0, 91.0, 91.0, 97.0, 90.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 106.7}, {"lowerIsBetter": true, "replicates": [55.0, 61.0, 57.0, 60.0, 60.0, 60.0, 68.0, 89.0, 88.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 66.5}, {"lowerIsBetter": true, "replicates": [62.0, 64.0, 94.0, 72.0, 78.0, 95.0, 94.0, 94.0, 100.0, 84.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 83.7}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 98.0, 103.0, 108.0, 93.0, 81.0, 83.0, 80.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.9}, {"lowerIsBetter": true, "replicates": [149.0, 133.0, 124.0, 120.0, 137.0, 136.0, 120.0, 135.0, 137.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.2}, {"lowerIsBetter": true, "replicates": [127.0, 136.0, 134.0, 139.0, 120.0, 155.0, 173.0, 169.0, 179.0, 169.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.1}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 65.0, 67.0, 63.0, 68.0, 65.0, 69.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1525.6}]} 16:55:47 INFO - Return code: 0 16:55:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:55:47 ERROR - # TBPL SUCCESS # 16:55:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:47 INFO - 2016-06-30 16:55:47.267 screenresolution[1689:10712] starting screenresolution argv=screenresolution get 16:55:47 INFO - 2016-06-30 16:55:47.270 screenresolution[1689:10712] Display 0: 1600x1200x32@60 16:55:47 INFO - 2016-06-30 16:55:47.277 screenresolution[1690:10715] starting screenresolution argv=screenresolution list 16:55:47 INFO - Available Modes on Display 0 16:55:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:47 INFO - Intel Iris: 16:55:47 INFO - Chipset Model: Intel Iris 16:55:47 INFO - Type: GPU 16:55:47 INFO - Bus: Built-In 16:55:47 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:47 INFO - Vendor: Intel (0x8086) 16:55:47 INFO - Device ID: 0x0a2e 16:55:47 INFO - Revision ID: 0x0009 16:55:47 INFO - Displays: 16:55:47 INFO - Display: 16:55:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:47 INFO - Display Serial Number: 1600x1200 60 16:55:47 INFO - Main Display: Yes 16:55:47 INFO - Mirror: Off 16:55:47 INFO - Online: Yes 16:55:47 INFO - Rotation: Supported 16:55:47 INFO - Return code: 0 16:55:47 INFO - Running post-action listener: _resource_record_post_action 16:55:47 INFO - Running post-run listener: _resource_record_post_run 16:55:48 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 37025280; Write bytes: 666971648; Read time: 241; Write time: 1878 16:55:48 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358275584; Write bytes: 354596352; Read time: 27984; Write time: 708 16:55:48 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 35210752; Write bytes: 301209600; Read time: 225; Write time: 1134 16:55:48 INFO - Running post-run listener: _upload_blobber_files 16:55:48 INFO - Blob upload gear active. 16:55:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:55:48 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 16:55:48 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:55:48 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:55:49 INFO - (blobuploader) - INFO - Open directory for files ... 16:55:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:55:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:55:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:49 INFO - (blobuploader) - INFO - Done attempting. 16:55:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:55:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:55:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:51 INFO - (blobuploader) - INFO - Done attempting. 16:55:51 INFO - (blobuploader) - INFO - Iteration through files over. 16:55:51 INFO - Return code: 0 16:55:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:55:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:55:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/d1586493719e9b81e6b8600b61e3cefe1322a144040dadc881800db4bec9d510cc267d400cb1912f120bd3be477f79dd5ca98c2f64e104d66778170516c27f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/2f85603d846da3f6b0c7414a562178efdd6b4811dd5232713f068a7a367bdeeaa0c4c40752cab44f9cd9cfe93a161370a53741dea4086982f57dd9e34cb898f7"} 16:55:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:55:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:55:51 INFO - Contents: 16:55:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/d1586493719e9b81e6b8600b61e3cefe1322a144040dadc881800db4bec9d510cc267d400cb1912f120bd3be477f79dd5ca98c2f64e104d66778170516c27f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/2f85603d846da3f6b0c7414a562178efdd6b4811dd5232713f068a7a367bdeeaa0c4c40752cab44f9cd9cfe93a161370a53741dea4086982f57dd9e34cb898f7"} 16:55:51 INFO - Running post-run listener: copy_logs_to_upload_dir 16:55:51 INFO - Copying logs to upload dir... 16:55:51 INFO - mkdir: /builds/slave/test/build/upload/logs 16:55:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.466755 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-06-30 16:55:51.091090) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:55:51.096493) ========= 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.YxGTWUjyer/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.HjTwcEAGe7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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/Larch/sha512/d1586493719e9b81e6b8600b61e3cefe1322a144040dadc881800db4bec9d510cc267d400cb1912f120bd3be477f79dd5ca98c2f64e104d66778170516c27f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/2f85603d846da3f6b0c7414a562178efdd6b4811dd5232713f068a7a367bdeeaa0c4c40752cab44f9cd9cfe93a161370a53741dea4086982f57dd9e34cb898f7"} build_url:https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/HAXsIKIzTHu2omdaidhCLw/artifacts/public/build/firefox-47.0.2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/d1586493719e9b81e6b8600b61e3cefe1322a144040dadc881800db4bec9d510cc267d400cb1912f120bd3be477f79dd5ca98c2f64e104d66778170516c27f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/2f85603d846da3f6b0c7414a562178efdd6b4811dd5232713f068a7a367bdeeaa0c4c40752cab44f9cd9cfe93a161370a53741dea4086982f57dd9e34cb898f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:55:51.129813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:55:51.130141) ========= 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.YxGTWUjyer/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.HjTwcEAGe7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.005140 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:55:51.178432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:55:51.179256) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:55:51.179594) ========= ========= Total master_lag: 0.18 =========