builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0247 starttime: 1471061834.27 results: success (0) buildid: 20160812190718 builduid: baf979c42207445483fe649ac6d1e206 revision: 913802fd98ec25a7a36bb80253cbb1af108c70fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:14.268983) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:14.269457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:14.269754) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:14.294047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:14.294324) ========= 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.VVRYCdPctJ/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.YPgnbEutiw/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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-08-12 21:17:14-- 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% 73.3M=0s 2016-08-12 21:17:14 (73.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122213 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:14.442020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:14.442386) ========= 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.VVRYCdPctJ/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.YPgnbEutiw/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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.025177 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:14.491209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 21:17:14.491542) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 913802fd98ec25a7a36bb80253cbb1af108c70fb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 913802fd98ec25a7a36bb80253cbb1af108c70fb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VVRYCdPctJ/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.YPgnbEutiw/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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-08-12 21:17:14,577 truncating revision to first 12 chars 2016-08-12 21:17:14,577 Setting DEBUG logging. 2016-08-12 21:17:14,577 attempt 1/10 2016-08-12 21:17:14,577 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/913802fd98ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 21:17:15,671 unpacking tar archive at: autoland-913802fd98ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.376576 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 21:17:15.895432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:15.895765) ========= script_repo_revision: 913802fd98ec25a7a36bb80253cbb1af108c70fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:15.896153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:15.896459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 21:17:15.914236) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-12 21:17:15.914508) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VVRYCdPctJ/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.YPgnbEutiw/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 21:17:16 INFO - MultiFileLogger online at 20160812 21:17:16 in /builds/slave/test 21:17:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:17:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:17:16 INFO - {'append_to_log': False, 21:17:16 INFO - 'base_work_dir': '/builds/slave/test', 21:17:16 INFO - 'blob_upload_branch': 'Autoland', 21:17:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:17:16 INFO - 'branch': 'Autoland', 21:17:16 INFO - 'buildbot_json_path': 'buildprops.json', 21:17:16 INFO - 'config_files': ('talos/mac_config.py',), 21:17:16 INFO - 'default_actions': ('clobber', 21:17:16 INFO - 'read-buildbot-config', 21:17:16 INFO - 'download-and-extract', 21:17:16 INFO - 'populate-webroot', 21:17:16 INFO - 'create-virtualenv', 21:17:16 INFO - 'install', 21:17:16 INFO - 'run-tests'), 21:17:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:17:16 INFO - 'download_minidump_stackwalk': True, 21:17:16 INFO - 'download_symbols': 'ondemand', 21:17:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:17:16 INFO - 'tooltool.py': '/tools/tooltool.py', 21:17:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:17:16 INFO - '/tools/misc-python/virtualenv.py')}, 21:17:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:17:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:17:16 INFO - 'installer_path': 'installer.exe', 21:17:16 INFO - 'log_level': 'info', 21:17:16 INFO - 'log_name': 'talos', 21:17:16 INFO - 'log_to_console': True, 21:17:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:17:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:17:16 INFO - 'opt_config_files': (), 21:17:16 INFO - 'pip_index': False, 21:17:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:17:16 INFO - 'cmd': ('bash', 21:17:16 INFO - '-c', 21:17:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:17:16 INFO - 'enabled': True, 21:17:16 INFO - 'halt_on_failure': False, 21:17:16 INFO - 'name': 'check_screen_resolution'},), 21:17:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:17:16 INFO - 'cmd': ('bash', 21:17:16 INFO - '-c', 21:17:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:17:16 INFO - 'enabled': True, 21:17:16 INFO - 'halt_on_failure': False, 21:17:16 INFO - 'name': 'check_screen_resolution'},), 21:17:16 INFO - 'run_cmd_checks_enabled': True, 21:17:16 INFO - 'sps_profile': False, 21:17:16 INFO - 'sps_profile_interval': 0, 21:17:16 INFO - 'suite': 'dromaeojs-e10s', 21:17:16 INFO - 'system_bits': '32', 21:17:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:17:16 INFO - 'title': 't-yosemite-r7-0247', 21:17:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:17:16 INFO - 'use_talos_json': True, 21:17:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:17:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:17:16 INFO - 'work_dir': 'build'} 21:17:16 INFO - [mozharness: 2016-08-13 04:17:16.108786Z] Running clobber step. 21:17:16 INFO - Running pre-action listener: _resource_record_pre_action 21:17:16 INFO - Running main action method: clobber 21:17:16 INFO - rmtree: /builds/slave/test/build 21:17:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:17:18 INFO - Running post-action listener: _resource_record_post_action 21:17:18 INFO - [mozharness: 2016-08-13 04:17:18.087225Z] Finished clobber step (success) 21:17:18 INFO - [mozharness: 2016-08-13 04:17:18.087396Z] Running read-buildbot-config step. 21:17:18 INFO - Running pre-action listener: _resource_record_pre_action 21:17:18 INFO - Running main action method: read_buildbot_config 21:17:18 INFO - Using buildbot properties: 21:17:18 INFO - { 21:17:18 INFO - "project": "", 21:17:18 INFO - "product": "firefox", 21:17:18 INFO - "script_repo_revision": "production", 21:17:18 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 21:17:18 INFO - "repository": "", 21:17:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 21:17:18 INFO - "buildid": "20160812190718", 21:17:18 INFO - "pgo_build": "False", 21:17:18 INFO - "basedir": "/builds/slave/test", 21:17:18 INFO - "buildnumber": 134, 21:17:18 INFO - "slavename": "t-yosemite-r7-0247", 21:17:18 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:17:18 INFO - "platform": "yosemite_r7", 21:17:18 INFO - "scheduler": "tests-autoland-macosx64-talos", 21:17:18 INFO - "branch": "autoland", 21:17:18 INFO - "repo_path": "integration/autoland", 21:17:18 INFO - "revision": "913802fd98ec25a7a36bb80253cbb1af108c70fb", 21:17:18 INFO - "stage_platform": "macosx64", 21:17:18 INFO - "builduid": "baf979c42207445483fe649ac6d1e206", 21:17:18 INFO - "slavebuilddir": "test" 21:17:18 INFO - } 21:17:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 21:17:18 INFO - Running post-action listener: _resource_record_post_action 21:17:18 INFO - [mozharness: 2016-08-13 04:17:18.090713Z] Finished read-buildbot-config step (success) 21:17:18 INFO - [mozharness: 2016-08-13 04:17:18.090864Z] Running download-and-extract step. 21:17:18 INFO - Running pre-action listener: _resource_record_pre_action 21:17:18 INFO - Running main action method: download_and_extract 21:17:18 INFO - mkdir: /builds/slave/test/build/tests 21:17:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:18 INFO - trying https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 21:17:18 INFO - Downloading https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 21:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 21:17:19 INFO - Downloaded 1199 bytes. 21:17:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 21:17:19 INFO - Using the following test package requirements: 21:17:19 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:17:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:17:19 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 21:17:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:17:19 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 21:17:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:17:19 INFO - u'jsshell-mac.zip'], 21:17:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:17:19 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 21:17:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:17:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:17:19 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 21:17:19 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:17:19 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 21:17:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:17:19 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 21:17:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:17:19 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 21:17:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:19 INFO - trying https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:17:19 INFO - Downloading https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:17:19 INFO - Downloaded 16331507 bytes. 21:17:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:17:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:17:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:26 INFO - trying https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:17:26 INFO - Downloading https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:17:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:17:27 INFO - Downloaded 16331507 bytes. 21:17:27 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:34 INFO - trying https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 21:17:34 INFO - Downloading https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 21:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:17:34 INFO - Downloaded 14413719 bytes. 21:17:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 21:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:35 INFO - trying https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:17:35 INFO - Downloading https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 21:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 21:17:38 INFO - Downloaded 111032040 bytes. 21:17:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:17:38 INFO - mkdir: /builds/slave/test/properties 21:17:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:17:38 INFO - Writing to file /builds/slave/test/properties/build_url 21:17:38 INFO - Contents: 21:17:38 INFO - build_url:https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:17:39 INFO - Running post-action listener: _resource_record_post_action 21:17:39 INFO - Running post-action listener: set_extra_try_arguments 21:17:39 INFO - [mozharness: 2016-08-13 04:17:39.521073Z] Finished download-and-extract step (success) 21:17:39 INFO - [mozharness: 2016-08-13 04:17:39.521202Z] Running populate-webroot step. 21:17:39 INFO - Running pre-action listener: _resource_record_pre_action 21:17:39 INFO - Running main action method: populate_webroot 21:17:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:17:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:17:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:17:39 INFO - '--tppagecycles', 21:17:39 INFO - '7'], 21:17:39 INFO - 'tests': ['tsvgm']}}, 21:17:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:17:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:17:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:17:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:17:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:17:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:17:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:39 INFO - 'talos_options': ['--disable-e10s'], 21:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:17:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:17:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:39 INFO - 'talos_options': ['--disable-e10s'], 21:17:39 INFO - 'tests': ['damp', 'tps']}, 21:17:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:39 INFO - 'tests': ['damp', 'tps']}, 21:17:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:17:39 INFO - 'tests': ['dromaeo_dom']}, 21:17:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:17:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:17:39 INFO - 'tests': ['basic_compositor_video']}, 21:17:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:17:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:17:39 INFO - 'tests': ['a11yr', 21:17:39 INFO - 'ts_paint', 21:17:39 INFO - 'tpaint', 21:17:39 INFO - 'sessionrestore', 21:17:39 INFO - 'sessionrestore_no_auto_restore', 21:17:39 INFO - 'tabpaint']}, 21:17:39 INFO - 'other-e10s': {'tests': ['a11yr', 21:17:39 INFO - 'ts_paint', 21:17:39 INFO - 'tpaint', 21:17:39 INFO - 'sessionrestore', 21:17:39 INFO - 'sessionrestore_no_auto_restore', 21:17:39 INFO - 'tabpaint']}, 21:17:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:17:39 INFO - 'ts_paint', 21:17:39 INFO - 'tpaint', 21:17:39 INFO - 'sessionrestore', 21:17:39 INFO - 'sessionrestore_no_auto_restore', 21:17:39 INFO - 'tabpaint']}, 21:17:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:17:39 INFO - 'ts_paint', 21:17:39 INFO - 'tpaint', 21:17:39 INFO - 'sessionrestore', 21:17:39 INFO - 'sessionrestore_no_auto_restore', 21:17:39 INFO - 'tabpaint']}, 21:17:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:17:39 INFO - 'tests': ['a11yr', 21:17:39 INFO - 'ts_paint', 21:17:39 INFO - 'tpaint', 21:17:39 INFO - 'sessionrestore', 21:17:39 INFO - 'sessionrestore_no_auto_restore', 21:17:39 INFO - 'tabpaint']}, 21:17:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:17:39 INFO - 'tests': ['a11yr', 21:17:39 INFO - 'ts_paint', 21:17:39 INFO - 'tpaint', 21:17:39 INFO - 'sessionrestore', 21:17:39 INFO - 'sessionrestore_no_auto_restore', 21:17:39 INFO - 'tabpaint']}, 21:17:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:17:39 INFO - 'tests': ['tsvgx', 21:17:39 INFO - 'tsvgr_opacity', 21:17:39 INFO - 'tart', 21:17:39 INFO - 'tscrollx', 21:17:39 INFO - 'cart']}, 21:17:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:17:39 INFO - 'tsvgr_opacity', 21:17:39 INFO - 'tart', 21:17:39 INFO - 'tscrollx', 21:17:39 INFO - 'cart']}, 21:17:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:39 INFO - 'talos_options': ['--disable-e10s'], 21:17:39 INFO - 'tests': ['tp5o']}, 21:17:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:39 INFO - 'tests': ['tp5o']}, 21:17:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:39 INFO - 'talos_options': ['--disable-e10s', 21:17:39 INFO - '--xperf_path', 21:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:17:39 INFO - 'tests': ['tp5n']}, 21:17:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:39 INFO - 'talos_options': ['--xperf_path', 21:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:17:39 INFO - 'tests': ['tp5n']}}, 21:17:39 INFO - 'talos.zip': {'path': '', 21:17:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:17:39 INFO - Running post-action listener: _resource_record_post_action 21:17:39 INFO - [mozharness: 2016-08-13 04:17:39.540451Z] Finished populate-webroot step (success) 21:17:39 INFO - [mozharness: 2016-08-13 04:17:39.540562Z] Running create-virtualenv step. 21:17:39 INFO - Running pre-action listener: _resource_record_pre_action 21:17:39 INFO - Running main action method: create_virtualenv 21:17:39 INFO - Creating virtualenv /builds/slave/test/build/venv 21:17:39 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 21:17:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:17:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:17:39 INFO - Using real prefix '/tools/python27' 21:17:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:17:40 INFO - Installing distribute.............................................................................................................................................................................................done. 21:17:43 INFO - Installing pip.................done. 21:17:43 INFO - Return code: 0 21:17:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:43 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 0x107106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf924763c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106dcfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.VVRYCdPctJ/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.YPgnbEutiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 21:17:43 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 21:17:43 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 21:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVRYCdPctJ/Render', 21:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:43 INFO - 'HOME': '/Users/cltbld', 21:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:43 INFO - 'LOGNAME': 'cltbld', 21:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:43 INFO - 'MOZ_NO_REMOTE': '1', 21:17:43 INFO - 'NO_EM_RESTART': '1', 21:17:43 INFO - 'PAGER': '/bin/cat', 21:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:43 INFO - 'PWD': '/builds/slave/test', 21:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:43 INFO - 'SHELL': '/bin/bash', 21:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPgnbEutiw/Listeners', 21:17:43 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 21:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:43 INFO - 'USER': 'cltbld', 21:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:43 INFO - 'XPC_FLAGS': '0x0', 21:17:43 INFO - 'XPC_SERVICE_NAME': '0', 21:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:43 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 21:17:43 INFO - Cleaning up... 21:17:43 INFO - Return code: 0 21:17:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:43 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf924763c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106dcfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.VVRYCdPctJ/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.YPgnbEutiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 21:17:43 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>=3.1.1'] in /builds/slave/test/build 21:17:43 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>=3.1.1 21:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVRYCdPctJ/Render', 21:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:43 INFO - 'HOME': '/Users/cltbld', 21:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:43 INFO - 'LOGNAME': 'cltbld', 21:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:43 INFO - 'MOZ_NO_REMOTE': '1', 21:17:43 INFO - 'NO_EM_RESTART': '1', 21:17:43 INFO - 'PAGER': '/bin/cat', 21:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:43 INFO - 'PWD': '/builds/slave/test', 21:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:43 INFO - 'SHELL': '/bin/bash', 21:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPgnbEutiw/Listeners', 21:17:43 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 21:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:43 INFO - 'USER': 'cltbld', 21:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:43 INFO - 'XPC_FLAGS': '0x0', 21:17:43 INFO - 'XPC_SERVICE_NAME': '0', 21:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:43 INFO - Downloading/unpacking psutil>=3.1.1 21:17: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 21:17: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 21:17: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 21:17: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 21:17: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 21:17: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 21:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:17:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:17:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:17:47 INFO - Installing collected packages: psutil 21:17:47 INFO - Running setup.py install for psutil 21:17:47 INFO - building 'psutil._psutil_osx' extension 21:17:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:17:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:17:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:17:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 21:17:48 INFO - building 'psutil._psutil_posix' extension 21:17:48 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 21:17:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:17:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:17:48 INFO - ^ 21:17:48 INFO - 1 warning generated. 21:17:48 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 21:17:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:17:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:17:48 INFO - Successfully installed psutil 21:17:48 INFO - Cleaning up... 21:17:48 INFO - Return code: 0 21:17:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:48 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf924763c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106dcfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.VVRYCdPctJ/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.YPgnbEutiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 21:17:48 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.3'] in /builds/slave/test/build 21:17:48 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.3 21:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVRYCdPctJ/Render', 21:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:48 INFO - 'HOME': '/Users/cltbld', 21:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:48 INFO - 'LOGNAME': 'cltbld', 21:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:48 INFO - 'MOZ_NO_REMOTE': '1', 21:17:48 INFO - 'NO_EM_RESTART': '1', 21:17:48 INFO - 'PAGER': '/bin/cat', 21:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:48 INFO - 'PWD': '/builds/slave/test', 21:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:48 INFO - 'SHELL': '/bin/bash', 21:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPgnbEutiw/Listeners', 21:17:48 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 21:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:48 INFO - 'USER': 'cltbld', 21:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:48 INFO - 'XPC_FLAGS': '0x0', 21:17:48 INFO - 'XPC_SERVICE_NAME': '0', 21:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:17:48 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 21:17:48 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 21:17:48 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 21:17:48 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 21:17:48 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 21:17:48 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 21:17:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:17:51 INFO - Installing collected packages: mozsystemmonitor 21:17:51 INFO - Running setup.py install for mozsystemmonitor 21:17:51 INFO - Successfully installed mozsystemmonitor 21:17:51 INFO - Cleaning up... 21:17:51 INFO - Return code: 0 21:17:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:51 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf924763c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106dcfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.VVRYCdPctJ/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.YPgnbEutiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 21:17:51 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==2.5.1'] in /builds/slave/test/build 21:17:51 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==2.5.1 21:17:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVRYCdPctJ/Render', 21:17:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:51 INFO - 'HOME': '/Users/cltbld', 21:17:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:51 INFO - 'LOGNAME': 'cltbld', 21:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:51 INFO - 'MOZ_NO_REMOTE': '1', 21:17:51 INFO - 'NO_EM_RESTART': '1', 21:17:51 INFO - 'PAGER': '/bin/cat', 21:17:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:51 INFO - 'PWD': '/builds/slave/test', 21:17:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:51 INFO - 'SHELL': '/bin/bash', 21:17:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPgnbEutiw/Listeners', 21:17:51 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 21:17:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:51 INFO - 'USER': 'cltbld', 21:17:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:51 INFO - 'XPC_FLAGS': '0x0', 21:17:51 INFO - 'XPC_SERVICE_NAME': '0', 21:17:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:51 INFO - Downloading/unpacking jsonschema==2.5.1 21:17:51 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 21:17:51 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 21:17:51 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 21:17:51 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 21:17:51 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 21:17:51 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 21:17:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:17:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:54 INFO - Downloading functools32-3.2.3-2.tar.gz 21:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:17:54 INFO - warning: no files found matching '*.txt' 21:17:54 INFO - no previously-included directories found matching 'build' 21:17:54 INFO - no previously-included directories found matching 'dist' 21:17:54 INFO - no previously-included directories found matching '.git*' 21:17:54 INFO - Installing collected packages: jsonschema, functools32 21:17:54 INFO - Running setup.py install for functools32 21:17:54 INFO - warning: no files found matching '*.txt' 21:17:54 INFO - no previously-included directories found matching 'build' 21:17:54 INFO - no previously-included directories found matching 'dist' 21:17:54 INFO - no previously-included directories found matching '.git*' 21:17:54 INFO - Successfully installed jsonschema functools32 21:17:54 INFO - Cleaning up... 21:17:54 INFO - Return code: 0 21:17:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:54 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf924763c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106dcfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.VVRYCdPctJ/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.YPgnbEutiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 21:17:54 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:17:54 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 functools32==3.2.3-2 21:17:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVRYCdPctJ/Render', 21:17:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:54 INFO - 'HOME': '/Users/cltbld', 21:17:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:54 INFO - 'LOGNAME': 'cltbld', 21:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:54 INFO - 'MOZ_NO_REMOTE': '1', 21:17:54 INFO - 'NO_EM_RESTART': '1', 21:17:54 INFO - 'PAGER': '/bin/cat', 21:17:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:54 INFO - 'PWD': '/builds/slave/test', 21:17:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:54 INFO - 'SHELL': '/bin/bash', 21:17:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPgnbEutiw/Listeners', 21:17:54 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 21:17:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:54 INFO - 'USER': 'cltbld', 21:17:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:54 INFO - 'XPC_FLAGS': '0x0', 21:17:54 INFO - 'XPC_SERVICE_NAME': '0', 21:17:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:17:54 INFO - Cleaning up... 21:17:55 INFO - Return code: 0 21:17:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:55 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 0x107106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf924763c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106dcfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.VVRYCdPctJ/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.YPgnbEutiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 21:17:55 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 21:17:55 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 21:17:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVRYCdPctJ/Render', 21:17:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:55 INFO - 'HOME': '/Users/cltbld', 21:17:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:55 INFO - 'LOGNAME': 'cltbld', 21:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:55 INFO - 'MOZ_NO_REMOTE': '1', 21:17:55 INFO - 'NO_EM_RESTART': '1', 21:17:55 INFO - 'PAGER': '/bin/cat', 21:17:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:55 INFO - 'PWD': '/builds/slave/test', 21:17:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:55 INFO - 'SHELL': '/bin/bash', 21:17:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPgnbEutiw/Listeners', 21:17:55 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 21:17:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:55 INFO - 'USER': 'cltbld', 21:17:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:55 INFO - 'XPC_FLAGS': '0x0', 21:17:55 INFO - 'XPC_SERVICE_NAME': '0', 21:17:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:55 INFO - Downloading/unpacking blobuploader==1.2.4 21:17:55 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 21:17:55 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 21:17:55 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 21:17:55 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 21:17:55 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 21:17:55 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 21:17:57 INFO - Downloading blobuploader-1.2.4.tar.gz 21:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:17:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:17:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:17:58 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 21:17:58 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 21:17:58 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 21:17:58 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 21:17:58 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 21:17:58 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 21:17:58 INFO - Downloading docopt-0.6.1.tar.gz 21:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:17:58 INFO - Installing collected packages: blobuploader, requests, docopt 21:17:58 INFO - Running setup.py install for blobuploader 21:17:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:17:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:17:59 INFO - Running setup.py install for requests 21:17:59 INFO - Running setup.py install for docopt 21:17:59 INFO - Successfully installed blobuploader requests docopt 21:17:59 INFO - Cleaning up... 21:17:59 INFO - Return code: 0 21:17:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:59 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 0x107106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf924763c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106dcfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.VVRYCdPctJ/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.YPgnbEutiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 21:17:59 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 21:17:59 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 21:17:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVRYCdPctJ/Render', 21:17:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:17:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:17:59 INFO - 'HOME': '/Users/cltbld', 21:17:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:17:59 INFO - 'LOGNAME': 'cltbld', 21:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:59 INFO - 'MOZ_NO_REMOTE': '1', 21:17:59 INFO - 'NO_EM_RESTART': '1', 21:17:59 INFO - 'PAGER': '/bin/cat', 21:17:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:59 INFO - 'PWD': '/builds/slave/test', 21:17:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:17:59 INFO - 'SHELL': '/bin/bash', 21:17:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPgnbEutiw/Listeners', 21:17:59 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 21:17:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:17:59 INFO - 'USER': 'cltbld', 21:17:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:17:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:59 INFO - 'XPC_FLAGS': '0x0', 21:17:59 INFO - 'XPC_SERVICE_NAME': '0', 21:17:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:18:00 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-0zQiu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:18:00 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-vEsgBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:18:00 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-WvloD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:18:00 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-WrVPTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:18:00 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-HbT8b5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:18:00 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-9ia9a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:18:00 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-KXhzqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:18:00 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-SmT6wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:18:00 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-PSgAfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:18:01 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-20wQDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:18:01 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-eqH3SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:18:01 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-YQLg3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:18:01 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-ck6BAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:18:01 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-ANo_RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:01 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-MmHHkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:18:01 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-fNEQKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:18:01 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-OhQinZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:18:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:18:01 INFO - Running setup.py install for manifestparser 21:18:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:18:02 INFO - Running setup.py install for mozcrash 21:18:02 INFO - Running setup.py install for mozdebug 21:18:02 INFO - Running setup.py install for mozdevice 21:18:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:18:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:18:02 INFO - Running setup.py install for mozfile 21:18:02 INFO - Running setup.py install for mozhttpd 21:18:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:18:02 INFO - Running setup.py install for mozinfo 21:18:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:18:02 INFO - Running setup.py install for mozInstall 21:18:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:18:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:18:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:18:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:18:03 INFO - Running setup.py install for mozleak 21:18:03 INFO - Running setup.py install for mozlog 21:18:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:18:03 INFO - Running setup.py install for moznetwork 21:18:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:18:03 INFO - Running setup.py install for mozprocess 21:18:03 INFO - Running setup.py install for mozprofile 21:18:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:18:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:18:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:18:03 INFO - Running setup.py install for mozrunner 21:18:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:18:04 INFO - Running setup.py install for mozscreenshot 21:18:04 INFO - Running setup.py install for moztest 21:18:04 INFO - Running setup.py install for mozversion 21:18:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:18:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:18:04 INFO - Cleaning up... 21:18:04 INFO - Return code: 0 21:18:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:04 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 0x107106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf924763c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106dcfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.VVRYCdPctJ/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.YPgnbEutiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 21:18:04 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 21:18:04 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 21:18:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVRYCdPctJ/Render', 21:18:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:18:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:18:04 INFO - 'HOME': '/Users/cltbld', 21:18:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:18:04 INFO - 'LOGNAME': 'cltbld', 21:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:04 INFO - 'MOZ_NO_REMOTE': '1', 21:18:04 INFO - 'NO_EM_RESTART': '1', 21:18:04 INFO - 'PAGER': '/bin/cat', 21:18:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:04 INFO - 'PWD': '/builds/slave/test', 21:18:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:18:04 INFO - 'SHELL': '/bin/bash', 21:18:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPgnbEutiw/Listeners', 21:18:04 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 21:18:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:18:04 INFO - 'USER': 'cltbld', 21:18:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:18:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:04 INFO - 'XPC_FLAGS': '0x0', 21:18:04 INFO - 'XPC_SERVICE_NAME': '0', 21:18:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:18:04 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-1SwhBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:18:04 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)) 21:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:18:04 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-WqXdwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:18:04 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)) 21:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:18:04 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-CSARTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:18:05 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)) 21:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:18:05 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-dL7BaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:18:05 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)) 21:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:18:05 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-XTZOvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:18:05 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)) 21:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:18:05 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-BRQxhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:18:05 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)) 21:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:18:05 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-Vh5oLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:18:05 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)) 21:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:18:05 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-bhXpqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:18:05 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)) 21:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:18:05 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-L6zwG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:18:05 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)) 21:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:18:05 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-SF8KyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 21:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:18:05 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-0oViiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:18:05 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)) 21:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:18:05 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-o_JsM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:18:06 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-zsVO44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:18:06 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)) 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:18:06 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-HporDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:06 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-rte8sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:06 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)) 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:18:06 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-04pONO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:18:06 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)) 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:18:06 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-BL3vnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:18:06 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)) 21:18:06 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)) 21:18:06 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)) 21:18:06 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)) 21:18:06 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)) 21:18:06 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)) 21:18:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:08 INFO - Downloading blessings-1.6.tar.gz 21:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:18:09 INFO - Installing collected packages: blessings 21:18:09 INFO - Running setup.py install for blessings 21:18:09 INFO - Successfully installed blessings 21:18:09 INFO - Cleaning up... 21:18:09 INFO - Return code: 0 21:18:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:18:09 INFO - Reading from file tmpfile_stdout 21:18:09 INFO - Current package versions: 21:18:09 INFO - blessings == 1.6 21:18:09 INFO - blobuploader == 1.2.4 21:18:09 INFO - docopt == 0.6.1 21:18:09 INFO - functools32 == 3.2.3-2 21:18:09 INFO - jsonschema == 2.5.1 21:18:09 INFO - manifestparser == 1.1 21:18:09 INFO - mozInstall == 1.12 21:18:09 INFO - mozcrash == 0.17 21:18:09 INFO - mozdebug == 0.1 21:18:09 INFO - mozdevice == 0.48 21:18:09 INFO - mozfile == 1.2 21:18:09 INFO - mozhttpd == 0.7 21:18:09 INFO - mozinfo == 0.9 21:18:09 INFO - mozleak == 0.1 21:18:09 INFO - mozlog == 3.3 21:18:09 INFO - moznetwork == 0.27 21:18:09 INFO - mozprocess == 0.23 21:18:09 INFO - mozprofile == 0.28 21:18:09 INFO - mozrunner == 6.12 21:18:09 INFO - mozscreenshot == 0.1 21:18:09 INFO - mozsystemmonitor == 0.3 21:18:09 INFO - moztest == 0.7 21:18:09 INFO - mozversion == 1.4 21:18:09 INFO - psutil == 3.1.1 21:18:09 INFO - requests == 1.2.3 21:18:09 INFO - wsgiref == 0.1.2 21:18:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:09 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 0x107106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf924763c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106dcfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.VVRYCdPctJ/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.YPgnbEutiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 21:18:09 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 21:18:09 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 21:18:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVRYCdPctJ/Render', 21:18:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:18:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:18:09 INFO - 'HOME': '/Users/cltbld', 21:18:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:18:09 INFO - 'LOGNAME': 'cltbld', 21:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:09 INFO - 'MOZ_NO_REMOTE': '1', 21:18:09 INFO - 'NO_EM_RESTART': '1', 21:18:09 INFO - 'PAGER': '/bin/cat', 21:18:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:09 INFO - 'PWD': '/builds/slave/test', 21:18:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:18:09 INFO - 'SHELL': '/bin/bash', 21:18:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPgnbEutiw/Listeners', 21:18:09 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 21:18:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:18:09 INFO - 'USER': 'cltbld', 21:18:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:18:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:09 INFO - 'XPC_FLAGS': '0x0', 21:18:09 INFO - 'XPC_SERVICE_NAME': '0', 21:18:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:09 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)) 21:18:09 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)) 21:18:09 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)) 21:18:09 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)) 21:18:09 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)) 21:18:09 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)) 21:18:09 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)) 21:18:09 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)) 21:18:09 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)) 21:18:09 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)) 21:18:09 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)) 21:18:09 INFO - Cleaning up... 21:18:09 INFO - Return code: 0 21:18:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:09 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 0x107106a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf924763c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106dcfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, '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.VVRYCdPctJ/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.YPgnbEutiw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 21:18:09 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 21:18:09 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 21:18:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVRYCdPctJ/Render', 21:18:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:18:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:18:09 INFO - 'HOME': '/Users/cltbld', 21:18:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:18:09 INFO - 'LOGNAME': 'cltbld', 21:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:09 INFO - 'MOZ_NO_REMOTE': '1', 21:18:09 INFO - 'NO_EM_RESTART': '1', 21:18:09 INFO - 'PAGER': '/bin/cat', 21:18:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:09 INFO - 'PWD': '/builds/slave/test', 21:18:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:18:09 INFO - 'SHELL': '/bin/bash', 21:18:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPgnbEutiw/Listeners', 21:18:09 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 21:18:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:18:09 INFO - 'USER': 'cltbld', 21:18:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:18:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:09 INFO - 'XPC_FLAGS': '0x0', 21:18:09 INFO - 'XPC_SERVICE_NAME': '0', 21:18:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:18:10 INFO - Cleaning up... 21:18:10 INFO - Return code: 0 21:18:10 INFO - Running post-action listener: _resource_record_post_action 21:18:10 INFO - Running post-action listener: _start_resource_monitoring 21:18:10 INFO - Starting resource monitoring. 21:18:10 INFO - [mozharness: 2016-08-13 04:18:10.129668Z] Finished create-virtualenv step (success) 21:18:10 INFO - [mozharness: 2016-08-13 04:18:10.130700Z] Running install step. 21:18:10 INFO - Running pre-action listener: _resource_record_pre_action 21:18:10 INFO - Running main action method: install 21:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:18:10 INFO - Reading from file tmpfile_stdout 21:18:10 INFO - Detecting whether we're running mozinstall >=1.0... 21:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:18:10 INFO - Reading from file tmpfile_stdout 21:18:10 INFO - Output received: 21:18:10 INFO - Usage: mozinstall [options] installer 21:18:10 INFO - Options: 21:18:10 INFO - -h, --help show this help message and exit 21:18:10 INFO - -d DEST, --destination=DEST 21:18:10 INFO - Directory to install application into. [default: 21:18:10 INFO - "/builds/slave/test"] 21:18:10 INFO - --app=APP Application being installed. [default: firefox] 21:18:10 INFO - mkdir: /builds/slave/test/build/application 21:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:18:45 INFO - Reading from file tmpfile_stdout 21:18:45 INFO - Output received: 21:18:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:18:45 INFO - Running post-action listener: _resource_record_post_action 21:18:45 INFO - [mozharness: 2016-08-13 04:18:45.722173Z] Finished install step (success) 21:18:45 INFO - [mozharness: 2016-08-13 04:18:45.722321Z] Running run-tests step. 21:18:45 INFO - Running pre-action listener: _resource_record_pre_action 21:18:45 INFO - Running main action method: run_tests 21:18:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:18:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:18:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:18:45 INFO - 2016-08-12 21:18:45.737 screenresolution[1634:7443] starting screenresolution argv=screenresolution get 21:18:45 INFO - 2016-08-12 21:18:45.740 screenresolution[1634:7443] Display 0: 1600x1200x32@60 21:18:45 INFO - 2016-08-12 21:18:45.746 screenresolution[1635:7445] starting screenresolution argv=screenresolution list 21:18:45 INFO - Available Modes on Display 0 21:18:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:18:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:18:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:18:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:18:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:18:45 INFO - Intel Iris: 21:18:45 INFO - Chipset Model: Intel Iris 21:18:45 INFO - Type: GPU 21:18:45 INFO - Bus: Built-In 21:18:45 INFO - VRAM (Dynamic, Max): 1536 MB 21:18:45 INFO - Vendor: Intel (0x8086) 21:18:45 INFO - Device ID: 0x0a2e 21:18:45 INFO - Revision ID: 0x0009 21:18:45 INFO - Displays: 21:18:45 INFO - Display: 21:18:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:18:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:18:45 INFO - Display Serial Number: 1600x1200 60 21:18:45 INFO - Main Display: Yes 21:18:45 INFO - Mirror: Off 21:18:45 INFO - Online: Yes 21:18:45 INFO - Rotation: Supported 21:18:45 INFO - Return code: 0 21:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:18:45 INFO - Python 2.7.3 21:18:45 INFO - Return code: 0 21:18:45 INFO - grabbing minidump binary from tooltool 21:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:45 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10706ad30>, '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 0x106dcfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107062b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:18:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:18:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 21:18:45 INFO - Calling ['/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'] with output_timeout 600 21:18:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:18:46 INFO - Return code: 0 21:18:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:18:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:18:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:18:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:18:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 21:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0247 --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 21:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VVRYCdPctJ/Render', 21:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:18:46 INFO - 'HOME': '/Users/cltbld', 21:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:18:46 INFO - 'LOGNAME': 'cltbld', 21:18:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:18:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:46 INFO - 'MOZ_NO_REMOTE': '1', 21:18:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:18:46 INFO - 'NO_EM_RESTART': '1', 21:18:46 INFO - 'PAGER': '/bin/cat', 21:18:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:46 INFO - 'PWD': '/builds/slave/test', 21:18:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:18:46 INFO - 'SHELL': '/bin/bash', 21:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YPgnbEutiw/Listeners', 21:18:46 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 21:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:18:46 INFO - 'USER': 'cltbld', 21:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:46 INFO - 'XPC_FLAGS': '0x0', 21:18:46 INFO - 'XPC_SERVICE_NAME': '0', 21:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:18:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 21:18:46 INFO - mozversion application_buildid: 20160812190718 21:18:46 INFO - mozversion application_changeset: 913802fd98ec25a7a36bb80253cbb1af108c70fb 21:18:46 INFO - mozversion application_display_name: Nightly 21:18:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:18:46 INFO - mozversion application_name: Firefox 21:18:46 INFO - mozversion application_remotingname: firefox 21:18:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:18:46 INFO - mozversion application_vendor: Mozilla 21:18:46 INFO - mozversion application_version: 51.0a1 21:18:46 INFO - mozversion platform_buildid: 20160812190718 21:18:46 INFO - mozversion platform_changeset: 913802fd98ec25a7a36bb80253cbb1af108c70fb 21:18:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:18:46 INFO - mozversion platform_version: 51.0a1 21:18:46 INFO - using testdate: 1471061926 21:18:46 INFO - actual date: 1471061926 21:18:46 INFO - starting webserver on 'localhost:49271' 21:18:46 INFO - SUITE-START | Running 2 tests 21:18:46 INFO - TEST-START | dromaeo_css 21:18:46 INFO - operating with platform_type : mac_ 21:18:46 INFO - Initialising browser for dromaeo_css test... 21:18:46 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpuFla_e/profile http://localhost:49271/getInfo.html) 21:18:49 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 21:18:49 INFO - PROCESS | 1645 | colorDepth:24 21:18:49 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 21:18:49 INFO - PROCESS | 1645 | __metrics 21:18:49 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 21:18:49 INFO - TEST-INFO | 1645: exit 0 21:18:49 INFO - Browser initialized. 21:18:49 INFO - Running cycle 1/1 for dromaeo_css test... 21:18:49 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpuFla_e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:19:01 INFO - PROCESS | 1648 | RSS: Main: 239661056 21:19:01 INFO - PROCESS | 1648 | 21:19:51 INFO - PROCESS | 1648 | 1471061991602 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] 21:22:03 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 21:22:04 INFO - PROCESS | 1648 | RSS: Main: 254799872 21:22:04 INFO - PROCESS | 1648 | 21:25:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 21:25:07 INFO - PROCESS | 1648 | RSS: Main: 265043968 21:25:07 INFO - PROCESS | 1648 | 21:28:09 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 21:28:10 INFO - PROCESS | 1648 | RSS: Main: 271511552 21:28:10 INFO - PROCESS | 1648 | 21:31:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 21:31:12 INFO - PROCESS | 1648 | RSS: Main: 271532032 21:31:12 INFO - PROCESS | 1648 | 21:34:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 21:34:16 INFO - PROCESS | 1648 | RSS: Main: 277422080 21:34:16 INFO - PROCESS | 1648 | 21:37:19 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 21:37:19 INFO - PROCESS | 1648 | RSS: Main: 280182784 21:37:19 INFO - PROCESS | 1648 | 21:37:19 INFO - PROCESS | 1648 | __start_tp_report 21:37:19 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 21:37:19 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 21:37:19 INFO - PROCESS | 1648 | |i|pagename|runs| 21:37:19 INFO - PROCESS | 1648 | |0;dojo.html;3300.257442075532;3474.0620032591187;3474.947875781864;3475.131217195701;3498.825058747063;4877.0489754497885;5815;5856.180134781134;5918.34898161203;5936.673482958436;5688.4311568843095;5713.571482138846;5764.5676574256995;5936.079907614316;5992.28092628884;5165.096108181072;5232.7122008289525;5283.524482796547;5336.839894803162;5342.358916929955;4294.527601963781;5373.7581808818695;5427.945720542783;5431.2396264522995;5500.50495455409;5249.1338929076655;5276.762545685453;5314.787408503656;5333.973330133364;5368.4363141869935;5311.867203319909;5333.4399888011585;5357.08929481989;5369.5972802040005;5382;5232.843014709527;5285.709285989269;5288.867778305535;5314.787408503694;5379.193121031837;5556;5781.566382521328;5842.941570584282;5900.675462849542;5916.201312822757;6262.71817768197;6281.905771413432;6315.621062736251;6319;6347.460465860408;6260.874782504325;6292.244930608311;6296.370362963713;6303.117563541108;6321.462675672527;5805.867855768127;5849.268841394825;5857.472827445507;5915.497182739429;5928.614640048383;6315.715792789244;6337.144485494491;6351.237851457855;6404.871902561923;6421;6202.56582039262;6210.968945155245;6266.624002559861;6267.5299352548745;6297.086922396227;5165.638405311592;6310.495160387158;6311.0217916223055;6314.905276420857;6339.0808332791485;6168.352323006109;6265.404786545271;6281.654509002049;6304.369563043659;6337.588056776387;6293.748250070037;6312.621242725451;6313.5896166749935;6315.747370105236;6354.459870911024;4013.2575473536904;4264.7654379009455;4742.52574742523;4777.187878060738;5073.822416215415;3670.46778217157;4483.170613436525;4512.052468981485;4528.230200865861;4578.9771051144535;5718.942810571924;5829.912551311733;5846.7076646167525;5867.823965281048;5889;6238.095476156022;6241.96879015602;6252.030935205051;6266.404691554295;6296;5354.464553544614;5377.247185394048;5901.557383196277;5904.291485021825;5922.822315330547;5549.694766787785;5550.8057217997175;5576.553875689935;5591.8881622368135;5601.131824567117;4830.637702172281;6280.874382512416;6372.681365931592;6496.6426846522945;6501.414872661483;5190.8961820764125;5491;6294.024426213944;6316.589421687576;6316.905246421399;6495.350464953467;6503.967480162569;6527.379898909596;6540.8415222977255;6552.475801935739;6105.997654215468;6154.415330543591;6314.778982735582;6327.525435592257;6336.778212762531;6220.7511699533325;6302.464290535356;6309.400606942333;6329.588576742497;6346.714397852015;4502.819887204606;5273.34083239595;5303.628745987744;6002.549808764447;6186.381361863778;4586.541345865387;6129.417705317987;6145.385461453998;6265.4361107500545;6271.3728627136925;5781.653100813965;6058.454739073504;6130.754769809336;6141.486007784364;6162.506999440124;6224.813255602339;6234.220722409699;6243.188385509855;6252.593581417375;6263.749450021948;6022.1870047543025;6101.450869421773;6113.266408031065;6164.260288765377;6196.597221180609 21:37:19 INFO - PROCESS | 1648 | |1;ext.html;464.4496271917778;505.5298572327736;533.4318950317913;535.0502857428065;542.1596525385651;39388.606113938855;41838.37242441366;41856.37215441763;41901.742947711544;42016.57983420165;41935.79032104843;42229.15541689164;42436.57563424365;42683;42766.57233427665;9510.714678559638;9651.420914745102;9704.66033688821;9713.174380177694;9725.221982241439;9566.56950437232;9637.807243855119;9677.854832177523;9682.12860842524;9710.514474276293;9623.95188024059;9641.566129524188;9713.368631038995;9725.367851089657;9726.756831079245;9619;9637.469939153343;9645.614175433044;9650.03499650033;9679.580104973757;9593.47235902025;9593.760155996086;9637.566309516089;9657.661981830603;9665.516724163763;40760.98097547585;40890.795546022375;41037;41073.58926410728;41222.9694257646;2653.6284920111198;3287.8027318360737;3454.6199918008997;3717.2937141942944;4168.541460439349;29835.552466713016;30702.53946190809;31250.7499700014;32145.83927080373;32375.190620234447;2616.842989420641;3146.7482601391835;3152.479840826261;3165.6862402103097;3235.854386552611;446687;454406;457331;457666;458798;33584.664153358644;33834.66165338364;33957.32085358279;34093;34096.65903340935;34420.13949651279;35192.47211291832;35412.82293588515;35560;35698.8215058923;16849.326026958784;17040.31838726437;17055.573610659583;17058.402955896483;17071.658566828595;12957.481700732054;13006.959443244517;13023.544175953795;13060.281684507254;13069.607911762663;18785.624287514445;18801.965891875803;18803.435896923114;18850.434486965412;18852.52868678294;6593.538452308292;7858.214178582096;8013.879791803128;8068.878966815502;8083.070446898564;843.5318398289008;980.6224603527693;982.7641366072235;999.5152351109706;1064.297563608015;24643.753562464506;29374.55938160929;29836.552451712807;30212.09363719092;30428.239294017385;888.6045709659139;961.9470929098827;1056.060106505211;1148.6554033789996;1202.6331968749441;15744.92127539355;16681;16943.32226710918;17151.74272385915;17217.483475495756;644736;652875;655044;656304;660201;59247.703761480916;59563;59748;59784.40215597875;59804.803903921675;1236.8868018782987;1258.6853286678331;1315.6645055510783;1373.979390309146;1376.504458394977;27894.30264243329;28398.86404543795;29875;31299.68700312968;31686.68313316837;48484.515154848;53207;53213.20180197222;53325.666858328856;53403;598496;601285;601835;603105;603331;25493.98024079016;26507;26628.866855665598;26682.19953401401;26691;47529.76235118802;47576.286355704;48612.75693621651;48744.756276219814;48835;38512.42231366588;39528.40707389449;39682.60317396789;40561.78314650565;40908.795456022526;39097.60902391053;39373.21253574855;39674.801625991684;40852.795736022315;41160;38095.809520952214;39197.628083016956;39291.80354098211;39615.81152565427;39730.205395891346;29121.85439072791;31952.36095278035;35018.949431517096;35371.76198833028;35729;24112.51774964526;26153.869230653723;26364.472710546066;26555.468890621694;26666.600000999613 21:37:19 INFO - PROCESS | 1648 | |2;jquery.html;328.9736821054316;345.4938515075414;377.8923006943021;384.29481900712193;389.77998863557065;20116.89941550292;20223.59552808945;20323.59352812943;20793.68809467857;21084.789152108475;20112.396628101145;20394.89802550989;20886.582268354625;21145.471363215926;21386;5489.862753431176;5891.293044834626;6019.217501724792;6073.301570319426;6074.271087469509;5983.820485385445;6023.879522409549;6041.6375017499095;6049.425304596057;6054.334023257438;5857.941420585782;5907.6750778707155;5944.613600116;5951.166836642873;5979.103134529833;5066.468020857812;5808.390119037483;5829.358770535237;5922.763089476416;5944.108383742451;4990.201567749143;5110.4634013428795;5143.125668636303;5176.249443830623;5180.430152683201;18279.994600296977;19488.51278718029;19832;20418.5916281675;26251.73748262512;2408.662787209792;2503.7621425964503;2963.659179194399;3116.719495245416;3152.558641790128;14097.506587269396;14599.124052556774;14840.925795370955;16001.359945602162;16226.513204603882;1571.6385231396728;1847.815218478155;1863.9068046597752;1875.7186422036668;1920.6734855074671;108782.45608771905;119148.40425797903;123956.38021809833;125587;127758.3612081943;8882.378233523592;10346.53440595175;10461.215408844368;10973.3964631946;11225.989660930556;13485.797713034117;13621.863781362257;13643.863561364458;13673.726525469436;13713.588592342247;8168.591570421574;8559.116994261252;8588.65645374178;8641.395102342776;8770.736877893672;8686.044535101133;8688.695895643623;8719.476831390137;8823.735287941372;8874.245689116367;6571.934280657228;6659.800205993828;6701.932980670228;6719.764808231688;6819.624920629413;1834.715619079045;1842.2446796813242;1867.9825788148767;1868.271374164077;1868.9065546722609;918.4994178172911;976.838821594429;990.7473594233425;1039.9480025998669;1116.4585176189541;22039.559208815735;22326.218582349866;22500.637433069292;22608.886955565446;22614.773852261267;851.1871163039283;872.2672954718067;893.9240164586083;939.4175611121012;968.0271327316002;8856.64573417069;10859.2398532102;11292.887071129184;11535.365554894393;11578.015868651091;599911;608954;611900;612348;633555;100259;146464.26767866092;149421;151152;151759;904.941218774036;927.1655510040882;928.4614923344444;974.7173319737338;974.9268804839523;16349.937254078446;16440.917795410947;17496.737548936522;19613.313534026813;19640.607187856447;48943.75528122479;49719;53879;55612.443875560726;58586.828263435345;73116;86305;86412.1358786404;86948;87372.56313718391;8043.517388956681;8139.511629302261;8338.249557539608;8441.324694024586;8442.535660538484;11517.42412879336;11567.710807229887;11742.007717376133;12852.871471285167;13292.534761283308;8714.651413943624;11856.940715296369;11959.342236176746;12009.279443233434;12065.155439119177;10092.091711745978;10191.439470829175;11367.602133925273;11746;11788.587399440978;11663.358515281741;11665.533378664759;11675.241109327866;12064.75870482568;12107.576234832091;8131.471454355448;8131.576974029639;8324.25081742646;8364.079951205242;8464;8454.957725211581;8482.575871206538;11383;11669.207507560246;11778.705532361759 21:37:19 INFO - PROCESS | 1648 | |3;mootools.html;1517.2186324043116;1545.350952599908;1727.4558514068067;1820.881642693224;1839.0988415676313;8045.959770201155;8460.280876125522;8478;8988.101189881008;9015.639374425024;8465.53439560824;8662.783430414243;8684;8698.695545655903;8701.042885282613;2313.456337760629;2367.1241640593003;2373.0507796881298;2374.750651181627;2379.773921477457;2323.767623237671;2355.199232261031;2372.043064471809;2378.988105059472;2384.8092152627746;2341.7072865891764;2358.988205058972;2364.4679947011955;2368.0882860098814;2376.9049238030457;2334.463073493106;2343.5898717724417;2355.49356888269;2359.351178425938;2360.268316821791;1951.2097600471832;2334.568104900582;2350.5886469867874;2351.036075209156;2360.2565191964477;8694.434861733967;8716.215540601313;8716.912830871737;8747.16901894319;8774.517401542913;5167.431582525919;5194.6883187008525;5251;5326.680399176062;5331.067063263913;3528.964710352915;3639.253952939641;3707.6292370762976;3721.888343349704;3733.757305775143;979.5689896445541;1033.05991547692;1102.581019212694;1118.6755840806156;1124.7525544380223;10363.170946324275;11418.486168122454;11513.942430287878;11594.826077608926;11606.245594036445;4511.1654343946475;4661.114388266218;4824.324594556765;4824.396950381202;4874.4150701916;9832.31173817826;9942.15491683215;9984.051515106054;9991.550380232908;10002.599896004078;5352.785888564492;5354.036273470812;5354.759035843396;5371.4628537146755;5379.085555455582;4453.576910193527;4762.690425122356;4841.830535931225;4912.459629440758;4919.114559379346;3791.8055812419;3886.591907849635;3929.901752456154;3943.5662077171487;3998.4402183694306;1270.9491620335084;1273.2551457397342;1273.6688461000022;1281.9488019823655;1286.350393051503;712.337526100721;795.0300633227454;916.4730280088842;921.1198199404162;926.2682480840061;4650.232711602548;5222.903190329997;5934.37689042653;5962.85092872673;6164.599301045418;423.6485610901215;436.3236982676838;441.126569392598;441.3644352132918;442.6812694859696;3422.1102513346214;3848.3265428549894;4165.271077561415;4287.914241715148;4302.870913872589;10683.679489615324;10731.892681073245;10790.08284295828;10839.187060970458;10903.073238774792;9025.458472491671;10182.6253455784;10759.246852720235;10818.080463160562;10884.292520986111;6609.372109649672;7881.645325960346;8081.919180808234;8311.293540049042;8325.958370208231;5003.324551185543;5845.678487683218;5985.910211346746;5991.970040149771;6146.108814221823;9668.9033109668;9791.608335666493;9794.804103918024;9836.508174591385;10040.347377420445;8543.487390756574;8570.957145214483;9656.130948214695;9948.850767238353;10163.339382940085;6549.541532092708;7016.22821489646;7393.8151546211775;7557.6221188939235;7580.9620951894885;8424.4945303282;8494.36292278094;8494.53280069602;8508.914910850812;8527.317814574695;5737.569682273763;7514.211007844317;7516.135644400964;7576.924230757621;7615.238476152341;7401.7039318428815;7417.554946703215;7422.554646721214;7426.034615499951;7508.849823003618;7028.50800443964;7043.788686339418;7077.610731409616;7119.8932016020835;7129.643517824192;5002.499750024968;5044.772985215601;5072.188449848007;5095.719735414587;5103.566196873159;4946.600898564266;4970.5029497051455;5070.163423035306;5221.399539053057;5273.683578985119 21:37:19 INFO - PROCESS | 1648 | |4;prototype.html;253.45380704581626;292.19937371601804;302.06811985026195;304.55991092870806;309.48470796124457;5497.615166938316;5501.752421141048;5516.345096471057;5518.641288316257;5543.556515478767;4624.745638989854;5310.62825602208;5431.83704488865;5464.049413316804;5484.533814625762;3951.861684841031;4016.7389119707273;4085.673146148301;4140.792960351985;4148.5851414858425;3451.4822776583464;4097.692673049518;4146.834126634946;4155.317096575876;4167.812448439812;4130.256553820326;4136.524299705542;4138.358554424054;4169.541350451448;4173.373993900909;3414.5048967899515;4032.4152997815154;4121.670266378683;4130.896727581804;4172.582741725833;3559.60844307126;3567.2687099144614;3568.6966607838367;3573.4639804029343;3581.2837432513343;5030;5308.256844041837;5309.973450132763;5320.547753440962;5348.251244825728;4518.17014109283;4524.796384162721;4729.574338309534;4752.5485078917445;4777.450593181794;5729.427057294279;5774.942250577483;5790.7104644768015;5820.650760954356;5833.79581714638;3316.3533111043357;3785;3963.4253033310297;3969.3450580654444;3980.383040628707;5714.057220545034;6030.939690603125;6095.969520152371;6096.695165241765;6097.20736304282;3886.5336159660455;3909.7263191576317;3924.4309575111447;3934.803259836997;3935.5277366716177;3195.7283630891634;3842.6550707252795;3980.5621381647998;3989.4813674222164;4016.758994460342;3946.4474973503734;4263.211305908417;4696.38946936896;4702.623790096784;4713.95286047142;4482.9775851121185;5083.288339632454;5612.7754889803955;5780.306363236438;5881.852953676107;1223.9082068844693;1347.818044563991;1368.404743936371;1369.7123604043063;1372.663697394125;711.9786406407816;796;822.5393779483509;843.0768308701962;845.8435189489965;5114.079465696136;5404.567634589223;5426.945730542723;5432.402435732066;5464.699441530674;4703.623710103184;5183.637145399785;6009.694667932619;6019.307779605401;6060.090986352083;4447.488538818013;5096.541311282002;5375.892482150413;5421.186821976735;5447.972760136174;2634;3114.470540008204;3151.3697260547524;3156.4318422684137;3163.374399248618;4909.4780618008535;5508.925759476943;5848.473637372657;6231.688415579203;6247.71921756039;5252.054630166606;5557.944420555743;6077.513798896078;6125.356837532084;6145.125736650364;4953.529414705669;5636.408177141505;6166.660833654192;6207.503399728011;6221.564490485713;4963.883126296554;5247.606429517878;5559.527440167631;5600.927656767022;6012.9098063529955;4480.969377043363;5144.739538813014;5652.802151924663;5839;5848.093545500455;6196.81409557714;6204.069389591597;6207.479167603966;6236.844078898064;6248.5313601479165;3323.3353329333745;3535.62875898027;3895.8831235062994;3946;3947.9735268830887;4461.709988850715;5242.449542798104;5942.58401911862;5963.463288304073;5965.806838632204;4613.838515651936;4860.441049279237;5799.94200057994;5804.216430781959;5875.529957603467;5454.699991500505;5726.36375901314;5729.54163666914;5746.2529871116485;5803.82588522345;5028.642266587927;5184.507471790174;5555.583331250092;5675.509561619657;5690.77236910519;5221.929504451502;5519.889602207853;5618.904313658797;5807.631573687336;5811.198528456192;4882.414110306786;5248.396434409939;5695.829125126253;5703.686297253691;5726.74229659658 21:37:19 INFO - PROCESS | 1648 | |5;yui.html;665.876812789634;702.4275215699208;709.7196607340104;783.8628240057989;812.0580127052621;13175.077744557884;15177.317020734066;15563.92218038911;15588.844111558881;15725.056496610212;11586;14241.928790356034;14321.140731556114;14347.497837575687;14367.281635918189;662.5593980003292;823.3207603726919;827.9296259817908;846.6232526525698;850.6002178975872;854.0349405172178;855.6962278391175;856.0882659967147;857.1043259793499;859.6217664227751;888.7511496780879;905.8777065096193;908.4413085952125;908.954552272387;909.9363044586881;894.4946105450432;895.8387490251752;900.6622516556291;901.0178904993555;906.2025417632474;653.7417720000573;657.6284399314372;665.3280187011105;666.7699643622942;667.7963221217527;15063.322150503254;15086;15145.469908553148;15215.923920380437;15224.086554806636;14793.186374749384;14849.628759281104;14872.925635371754;14904.031237969606;15030.398784048624;12011.39943002855;12123.211991220542;12327.630171094881;12379.442925068304;12538.596990058299;3855.7108216883566;3862.0344913771555;4048.9595104048876;4086.346184610478;4095.8566450174103;99605;116082;116733.4163329178;117506.41246793797;117581;10127.139193168516;11433.828492572618;11482.942585287186;11603.419829008515;11609.30344179352;23838;23869;23895.446795958207;23899.641505377433;23933.401664958168;8175.63209655567;8218.753437396888;8320.79901909683;8324.70863519786;8345.165483451607;4446.221911165598;4524.253498172765;4526.253168227271;4526.411566496335;4663.696859704109;3574.463830425405;3675.7059435245114;3686.318031164243;3686.594474607791;3687.0966613179944;606.8361542383532;616.8457885528618;643.3791391307411;651.7360469010058;654.6137778710583;557.028652841538;636.0999186151636;665.7969319357643;677.678102901118;687.9724811007603;8271.379646526535;9339.626414943326;9551.64523317042;9673.129418352382;9728.61085556584;518.9506996835295;520.531521630528;532.7842223899327;561.898858205527;581.6393835821817;3978.3435733104293;4545.2954792007295;4746.881327966828;4788.401449818773;4804.6876952997945;108892.4555377218;139552;160510;169090;171738;116752.8324716759;143403;143672.66127701665;146528.80206796905;150322;116687;124235.89410264816;124331;126891.36554317354;127265.36367318104;9037.231835294073;9107.408018478778;9124.817503650023;9125.178733913714;9171.908280917105;63035.10894673167;63743.68128159329;69755.6512217456;70307.94538082035;70320.6483967577;83091;102598;104631.92100987377;105953;107642;12147.635570932885;12229.086791553284;12259;12328.81506777417;12849.486020559072;10918.890811091787;12386.876131238572;12468.940140088194;13257.535986240435;14022.439102436196;12358.876411235773;12363.071963704786;12365.690857728629;12560.497580097059;12933.805992910302;12454.074235894614;12502.812457813323;12596.811047834106;12619;12838.293893835555;12216.633500994983;12261.570845020382;12286.464849883334;12349;12510.374481276081;9969.202463802734;10412.219083568914;10441.738956526147;10562.31344962575;10986.066184374098;9754.658586949423;10180.338278011906;10786;10825.56697732082;10864.782704345711 21:37:19 INFO - PROCESS | 1648 | __end_tp_report 21:37:19 INFO - PROCESS | 1648 | __start_cc_report 21:37:19 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,416 21:37:19 INFO - PROCESS | 1648 | __end_cc_report 21:37:19 INFO - PROCESS | 1648 | __startTimestamp1471063039277__endTimestamp 21:37:19 INFO - PROCESS | 1648 | 21:37:19 INFO - PROCESS | 1648 | ------- Summary: start ------- 21:37:19 INFO - PROCESS | 1648 | Number of tests: 6 21:37:19 INFO - PROCESS | 1648 | 21:37:19 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5759.80 Median:5936.67 stddev:705.14 (11.9%) stddev-sans-first:680.40 21:37:19 INFO - PROCESS | 1648 | Values: 3300.3 3474.1 3474.9 3475.1 3498.8 4877.0 5815.0 5856.2 5918.3 5936.7 5688.4 5713.6 5764.6 5936.1 5992.3 5165.1 5232.7 5283.5 5336.8 5342.4 4294.5 5373.8 5427.9 5431.2 5500.5 5249.1 5276.8 5314.8 5334.0 5368.4 5311.9 5333.4 5357.1 5369.6 5382.0 5232.8 5285.7 5288.9 5314.8 5379.2 5556.0 5781.6 5842.9 5900.7 5916.2 6262.7 6281.9 6315.6 6319.0 6347.5 6260.9 6292.2 6296.4 6303.1 6321.5 5805.9 5849.3 5857.5 5915.5 5928.6 6315.7 6337.1 6351.2 6404.9 6421.0 6202.6 6211.0 6266.6 6267.5 6297.1 5165.6 6310.5 6311.0 6314.9 6339.1 6168.4 6265.4 6281.7 6304.4 6337.6 6293.7 6312.6 6313.6 6315.7 6354.5 4013.3 4264.8 4742.5 4777.2 5073.8 3670.5 4483.2 4512.1 4528.2 4579.0 5718.9 5829.9 5846.7 5867.8 5889.0 6238.1 6242.0 6252.0 6266.4 6296.0 5354.5 5377.2 5901.6 5904.3 5922.8 5549.7 5550.8 5576.6 5591.9 5601.1 4830.6 6280.9 6372.7 6496.6 6501.4 5190.9 5491.0 6294.0 6316.6 6316.9 6495.4 6504.0 6527.4 6540.8 6552.5 6106.0 6154.4 6314.8 6327.5 6336.8 6220.8 6302.5 6309.4 6329.6 6346.7 4502.8 5273.3 5303.6 6002.5 6186.4 4586.5 6129.4 6145.4 6265.4 6271.4 5781.7 6058.5 6130.8 6141.5 6162.5 6224.8 6234.2 6243.2 6252.6 6263.7 6022.2 6101.5 6113.3 6164.3 6196.6 21:37:19 INFO - PROCESS | 1648 | 21:37:19 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:69207.03 Median:40661.38 stddev:154255.60 (379.4%) stddev-sans-first:154601.98 21:37:19 INFO - PROCESS | 1648 | Values: 464.4 505.5 533.4 535.1 542.2 39388.6 41838.4 41856.4 41901.7 42016.6 41935.8 42229.2 42436.6 42683.0 42766.6 9510.7 9651.4 9704.7 9713.2 9725.2 9566.6 9637.8 9677.9 9682.1 9710.5 9624.0 9641.6 9713.4 9725.4 9726.8 9619.0 9637.5 9645.6 9650.0 9679.6 9593.5 9593.8 9637.6 9657.7 9665.5 40761.0 40890.8 41037.0 41073.6 41223.0 2653.6 3287.8 3454.6 3717.3 4168.5 29835.6 30702.5 31250.7 32145.8 32375.2 2616.8 3146.7 3152.5 3165.7 3235.9 446687.0 454406.0 457331.0 457666.0 458798.0 33584.7 33834.7 33957.3 34093.0 34096.7 34420.1 35192.5 35412.8 35560.0 35698.8 16849.3 17040.3 17055.6 17058.4 17071.7 12957.5 13007.0 13023.5 13060.3 13069.6 18785.6 18802.0 18803.4 18850.4 18852.5 6593.5 7858.2 8013.9 8068.9 8083.1 843.5 980.6 982.8 999.5 1064.3 24643.8 29374.6 29836.6 30212.1 30428.2 888.6 961.9 1056.1 1148.7 1202.6 15744.9 16681.0 16943.3 17151.7 17217.5 644736.0 652875.0 655044.0 656304.0 660201.0 59247.7 59563.0 59748.0 59784.4 59804.8 1236.9 1258.7 1315.7 1374.0 1376.5 27894.3 28398.9 29875.0 31299.7 31686.7 48484.5 53207.0 53213.2 53325.7 53403.0 598496.0 601285.0 601835.0 603105.0 603331.0 25494.0 26507.0 26628.9 26682.2 26691.0 47529.8 47576.3 48612.8 48744.8 48835.0 38512.4 39528.4 39682.6 40561.8 40908.8 39097.6 39373.2 39674.8 40852.8 41160.0 38095.8 39197.6 39291.8 39615.8 39730.2 29121.9 31952.4 35018.9 35371.8 35729.0 24112.5 26153.9 26364.5 26555.5 26666.6 21:37:19 INFO - PROCESS | 1648 | 21:37:19 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:36104.36 Median:3134.64 stddev:102740.80 (3277.6%) stddev-sans-first:102993.90 21:37:19 INFO - PROCESS | 1648 | Values: 329.0 345.5 377.9 384.3 389.8 20116.9 20223.6 20323.6 20793.7 21084.8 20112.4 20394.9 20886.6 21145.5 21386.0 5489.9 5891.3 6019.2 6073.3 6074.3 5983.8 6023.9 6041.6 6049.4 6054.3 5857.9 5907.7 5944.6 5951.2 5979.1 5066.5 5808.4 5829.4 5922.8 5944.1 4990.2 5110.5 5143.1 5176.2 5180.4 18280.0 19488.5 19832.0 20418.6 26251.7 2408.7 2503.8 2963.7 3116.7 3152.6 14097.5 14599.1 14840.9 16001.4 16226.5 1571.6 1847.8 1863.9 1875.7 1920.7 108782.5 119148.4 123956.4 125587.0 127758.4 8882.4 10346.5 10461.2 10973.4 11226.0 13485.8 13621.9 13643.9 13673.7 13713.6 8168.6 8559.1 8588.7 8641.4 8770.7 8686.0 8688.7 8719.5 8823.7 8874.2 6571.9 6659.8 6701.9 6719.8 6819.6 1834.7 1842.2 1868.0 1868.3 1868.9 918.5 976.8 990.7 1039.9 1116.5 22039.6 22326.2 22500.6 22608.9 22614.8 851.2 872.3 893.9 939.4 968.0 8856.6 10859.2 11292.9 11535.4 11578.0 599911.0 608954.0 611900.0 612348.0 633555.0 100259.0 146464.3 149421.0 151152.0 151759.0 904.9 927.2 928.5 974.7 974.9 16349.9 16440.9 17496.7 19613.3 19640.6 48943.8 49719.0 53879.0 55612.4 58586.8 73116.0 86305.0 86412.1 86948.0 87372.6 8043.5 8139.5 8338.2 8441.3 8442.5 11517.4 11567.7 11742.0 12852.9 13292.5 8714.7 11856.9 11959.3 12009.3 12065.2 10092.1 10191.4 11367.6 11746.0 11788.6 11663.4 11665.5 11675.2 12064.8 12107.6 8131.5 8131.6 8324.3 8364.1 8464.0 8455.0 8482.6 11383.0 11669.2 11778.7 21:37:19 INFO - PROCESS | 1648 | 21:37:19 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5641.64 Median:5024.05 stddev:3154.31 (62.8%) stddev-sans-first:3147.94 21:37:19 INFO - PROCESS | 1648 | Values: 1517.2 1545.4 1727.5 1820.9 1839.1 8046.0 8460.3 8478.0 8988.1 9015.6 8465.5 8662.8 8684.0 8698.7 8701.0 2313.5 2367.1 2373.1 2374.8 2379.8 2323.8 2355.2 2372.0 2379.0 2384.8 2341.7 2359.0 2364.5 2368.1 2376.9 2334.5 2343.6 2355.5 2359.4 2360.3 1951.2 2334.6 2350.6 2351.0 2360.3 8694.4 8716.2 8716.9 8747.2 8774.5 5167.4 5194.7 5251.0 5326.7 5331.1 3529.0 3639.3 3707.6 3721.9 3733.8 979.6 1033.1 1102.6 1118.7 1124.8 10363.2 11418.5 11513.9 11594.8 11606.2 4511.2 4661.1 4824.3 4824.4 4874.4 9832.3 9942.2 9984.1 9991.6 10002.6 5352.8 5354.0 5354.8 5371.5 5379.1 4453.6 4762.7 4841.8 4912.5 4919.1 3791.8 3886.6 3929.9 3943.6 3998.4 1270.9 1273.3 1273.7 1281.9 1286.4 712.3 795.0 916.5 921.1 926.3 4650.2 5222.9 5934.4 5962.9 6164.6 423.6 436.3 441.1 441.4 442.7 3422.1 3848.3 4165.3 4287.9 4302.9 10683.7 10731.9 10790.1 10839.2 10903.1 9025.5 10182.6 10759.2 10818.1 10884.3 6609.4 7881.6 8081.9 8311.3 8326.0 5003.3 5845.7 5985.9 5992.0 6146.1 9668.9 9791.6 9794.8 9836.5 10040.3 8543.5 8571.0 9656.1 9948.9 10163.3 6549.5 7016.2 7393.8 7557.6 7581.0 8424.5 8494.4 8494.5 8508.9 8527.3 5737.6 7514.2 7516.1 7576.9 7615.2 7401.7 7417.6 7422.6 7426.0 7508.8 7028.5 7043.8 7077.6 7119.9 7129.6 5002.5 5044.8 5072.2 5095.7 5103.6 4946.6 4970.5 5070.2 5221.4 5273.7 21:37:19 INFO - PROCESS | 1648 | 21:37:19 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4625.90 Median:5232.19 stddev:1449.35 (27.7%) stddev-sans-first:1415.77 21:37:19 INFO - PROCESS | 1648 | Values: 253.5 292.2 302.1 304.6 309.5 5497.6 5501.8 5516.3 5518.6 5543.6 4624.7 5310.6 5431.8 5464.0 5484.5 3951.9 4016.7 4085.7 4140.8 4148.6 3451.5 4097.7 4146.8 4155.3 4167.8 4130.3 4136.5 4138.4 4169.5 4173.4 3414.5 4032.4 4121.7 4130.9 4172.6 3559.6 3567.3 3568.7 3573.5 3581.3 5030.0 5308.3 5310.0 5320.5 5348.3 4518.2 4524.8 4729.6 4752.5 4777.5 5729.4 5774.9 5790.7 5820.7 5833.8 3316.4 3785.0 3963.4 3969.3 3980.4 5714.1 6030.9 6096.0 6096.7 6097.2 3886.5 3909.7 3924.4 3934.8 3935.5 3195.7 3842.7 3980.6 3989.5 4016.8 3946.4 4263.2 4696.4 4702.6 4714.0 4483.0 5083.3 5612.8 5780.3 5881.9 1223.9 1347.8 1368.4 1369.7 1372.7 712.0 796.0 822.5 843.1 845.8 5114.1 5404.6 5426.9 5432.4 5464.7 4703.6 5183.6 6009.7 6019.3 6060.1 4447.5 5096.5 5375.9 5421.2 5448.0 2634.0 3114.5 3151.4 3156.4 3163.4 4909.5 5508.9 5848.5 6231.7 6247.7 5252.1 5557.9 6077.5 6125.4 6145.1 4953.5 5636.4 6166.7 6207.5 6221.6 4963.9 5247.6 5559.5 5600.9 6012.9 4481.0 5144.7 5652.8 5839.0 5848.1 6196.8 6204.1 6207.5 6236.8 6248.5 3323.3 3535.6 3895.9 3946.0 3948.0 4461.7 5242.4 5942.6 5963.5 5965.8 4613.8 4860.4 5799.9 5804.2 5875.5 5454.7 5726.4 5729.5 5746.3 5803.8 5028.6 5184.5 5555.6 5675.5 5690.8 5221.9 5519.9 5618.9 5807.6 5811.2 4882.4 5248.4 5695.8 5703.7 5726.7 21:37:19 INFO - PROCESS | 1648 | 21:37:19 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:25985.65 Median:13753.93 stddev:42488.74 (308.9%) stddev-sans-first:42565.40 21:37:19 INFO - PROCESS | 1648 | Values: 665.9 702.4 709.7 783.9 812.1 13175.1 15177.3 15563.9 15588.8 15725.1 11586.0 14241.9 14321.1 14347.5 14367.3 662.6 823.3 827.9 846.6 850.6 854.0 855.7 856.1 857.1 859.6 888.8 905.9 908.4 909.0 909.9 894.5 895.8 900.7 901.0 906.2 653.7 657.6 665.3 666.8 667.8 15063.3 15086.0 15145.5 15215.9 15224.1 14793.2 14849.6 14872.9 14904.0 15030.4 12011.4 12123.2 12327.6 12379.4 12538.6 3855.7 3862.0 4049.0 4086.3 4095.9 99605.0 116082.0 116733.4 117506.4 117581.0 10127.1 11433.8 11482.9 11603.4 11609.3 23838.0 23869.0 23895.4 23899.6 23933.4 8175.6 8218.8 8320.8 8324.7 8345.2 4446.2 4524.3 4526.3 4526.4 4663.7 3574.5 3675.7 3686.3 3686.6 3687.1 606.8 616.8 643.4 651.7 654.6 557.0 636.1 665.8 677.7 688.0 8271.4 9339.6 9551.6 9673.1 9728.6 519.0 520.5 532.8 561.9 581.6 3978.3 4545.3 4746.9 4788.4 4804.7 108892.5 139552.0 160510.0 169090.0 171738.0 116752.8 143403.0 143672.7 146528.8 150322.0 116687.0 124235.9 124331.0 126891.4 127265.4 9037.2 9107.4 9124.8 9125.2 9171.9 63035.1 63743.7 69755.7 70307.9 70320.6 83091.0 102598.0 104631.9 105953.0 107642.0 12147.6 12229.1 12259.0 12328.8 12849.5 10918.9 12386.9 12468.9 13257.5 14022.4 12358.9 12363.1 12365.7 12560.5 12933.8 12454.1 12502.8 12596.8 12619.0 12838.3 12216.6 12261.6 12286.5 12349.0 12510.4 9969.2 10412.2 10441.7 10562.3 10986.1 9754.7 10180.3 10786.0 10825.6 10864.8 21:37:19 INFO - PROCESS | 1648 | -------- Summary: end -------- 21:37:19 INFO - PROCESS | 1648 | 21:37:19 INFO - TEST-INFO | 1648: exit 0 21:37:19 INFO - TEST-OK | dromaeo_css | took 1113634ms 21:37:19 INFO - TEST-START | kraken 21:37:19 INFO - operating with platform_type : mac_ 21:37:19 INFO - Initialising browser for kraken test... 21:37:19 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmp9FBqPY/profile http://localhost:49271/getInfo.html) 21:37:22 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 21:37:22 INFO - PROCESS | 1660 | colorDepth:24 21:37:22 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 21:37:22 INFO - PROCESS | 1660 | __metrics 21:37:23 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 21:37:23 INFO - TEST-INFO | 1660: exit 0 21:37:23 INFO - Browser initialized. 21:37:23 INFO - Running cycle 1/1 for kraken test... 21:37:23 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmp9FBqPY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:37:35 INFO - PROCESS | 1662 | RSS: Main: 239497216 21:37:35 INFO - PROCESS | 1662 | 21:37:38 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 21:37:39 INFO - PROCESS | 1662 | RSS: Main: 252510208 21:37:39 INFO - PROCESS | 1662 | 21:37:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 21:37:42 INFO - PROCESS | 1662 | RSS: Main: 261263360 21:37:42 INFO - PROCESS | 1662 | 21:37:46 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 21:37:47 INFO - PROCESS | 1662 | RSS: Main: 264110080 21:37:47 INFO - PROCESS | 1662 | 21:37:49 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 21:37:49 INFO - PROCESS | 1662 | RSS: Main: 266518528 21:37:49 INFO - PROCESS | 1662 | 21:37:51 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:37:52 INFO - PROCESS | 1662 | RSS: Main: 267182080 21:37:52 INFO - PROCESS | 1662 | 21:37:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 21:37:56 INFO - PROCESS | 1662 | RSS: Main: 267739136 21:37:56 INFO - PROCESS | 1662 | 21:37:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 21:37:59 INFO - PROCESS | 1662 | RSS: Main: 267984896 21:37:59 INFO - PROCESS | 1662 | 21:38:02 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 21:38:03 INFO - PROCESS | 1662 | RSS: Main: 268353536 21:38:03 INFO - PROCESS | 1662 | 21:38:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:38:05 INFO - PROCESS | 1662 | RSS: Main: 267894784 21:38:05 INFO - PROCESS | 1662 | 21:38:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:38:08 INFO - PROCESS | 1662 | RSS: Main: 267599872 21:38:08 INFO - PROCESS | 1662 | 21:38:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:38:11 INFO - PROCESS | 1662 | RSS: Main: 267923456 21:38:11 INFO - PROCESS | 1662 | 21:38:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:38:15 INFO - PROCESS | 1662 | RSS: Main: 268099584 21:38:15 INFO - PROCESS | 1662 | 21:38:18 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:38:18 INFO - PROCESS | 1662 | RSS: Main: 268103680 21:38:18 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 21:38:20 INFO - PROCESS | 1662 | RSS: Main: 269189120 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | __start_tp_report 21:38:20 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 21:38:20 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 21:38:20 INFO - PROCESS | 1662 | |i|pagename|runs| 21:38:20 INFO - PROCESS | 1662 | |0;ai-astar;145;173;139;118;113;115;117;113;113;120 21:38:20 INFO - PROCESS | 1662 | |1;audio-beat-detection;147;111;131;158;118;142;130;113;161;110 21:38:20 INFO - PROCESS | 1662 | |2;audio-dft;197;198;252;248;186;279;199;275;283;192 21:38:20 INFO - PROCESS | 1662 | |3;audio-fft;72;87;75;143;59;59;60;63;136;61 21:38:20 INFO - PROCESS | 1662 | |4;audio-oscillator;72;71;118;72;74;76;113;73;75;117 21:38:20 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;92;78;91;104;82;132;138;128;93;106 21:38:20 INFO - PROCESS | 1662 | |6;imaging-darkroom;97;93;96;100;151;108;93;151;99;97 21:38:20 INFO - PROCESS | 1662 | |7;imaging-desaturate;91;95;100;132;89;89;90;90;91;128 21:38:20 INFO - PROCESS | 1662 | |8;json-parse-financial;56;57;59;57;57;60;57;57;58;60 21:38:20 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;77;99;64;100;63;79;102;103;100;82 21:38:20 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;85;91;89;96;89;80;101;77;91;103 21:38:20 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;123;150;161;154;173;160;155;140;163;158 21:38:20 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;171;210;249;189;174;169;229;236;171;172 21:38:20 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;68;79;69;68;67;66;65;68;66;68 21:38:20 INFO - PROCESS | 1662 | __end_tp_report 21:38:20 INFO - PROCESS | 1662 | __start_cc_report 21:38:20 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1056 21:38:20 INFO - PROCESS | 1662 | __end_cc_report 21:38:20 INFO - PROCESS | 1662 | __startTimestamp1471063100718__endTimestamp 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | ------- Summary: start ------- 21:38:20 INFO - PROCESS | 1662 | Number of tests: 14 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:126.60 Median:119.00 stddev:19.84 (16.7%) stddev-sans-first:19.90 21:38:20 INFO - PROCESS | 1662 | Values: 145.0 173.0 139.0 118.0 113.0 115.0 117.0 113.0 113.0 120.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:136.50 stddev:19.23 (14.1%) stddev-sans-first:19.63 21:38:20 INFO - PROCESS | 1662 | Values: 147.0 111.0 131.0 158.0 118.0 142.0 130.0 113.0 161.0 110.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:230.90 Median:250.00 stddev:40.12 (16.0%) stddev-sans-first:40.64 21:38:20 INFO - PROCESS | 1662 | Values: 197.0 198.0 252.0 248.0 186.0 279.0 199.0 275.0 283.0 192.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:81.50 Median:62.00 stddev:31.89 (51.4%) stddev-sans-first:33.64 21:38:20 INFO - PROCESS | 1662 | Values: 72.0 87.0 75.0 143.0 59.0 59.0 60.0 63.0 136.0 61.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:86.10 Median:72.50 stddev:20.72 (28.6%) stddev-sans-first:21.34 21:38:20 INFO - PROCESS | 1662 | Values: 72.0 71.0 118.0 72.0 74.0 76.0 113.0 73.0 75.0 117.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:104.40 Median:80.00 stddev:21.38 (26.7%) stddev-sans-first:22.20 21:38:20 INFO - PROCESS | 1662 | Values: 92.0 78.0 91.0 104.0 82.0 132.0 138.0 128.0 93.0 106.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:108.50 Median:94.50 stddev:22.79 (24.1%) stddev-sans-first:23.79 21:38:20 INFO - PROCESS | 1662 | Values: 97.0 93.0 96.0 100.0 151.0 108.0 93.0 151.0 99.0 97.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:99.50 Median:90.00 stddev:16.45 (18.3%) stddev-sans-first:17.15 21:38:20 INFO - PROCESS | 1662 | Values: 91.0 95.0 100.0 132.0 89.0 89.0 90.0 90.0 91.0 128.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.50 stddev:1.40 (2.4%) stddev-sans-first:1.32 21:38:20 INFO - PROCESS | 1662 | Values: 56.0 57.0 59.0 57.0 57.0 60.0 57.0 57.0 58.0 60.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:86.90 Median:70.50 stddev:15.84 (22.5%) stddev-sans-first:16.39 21:38:20 INFO - PROCESS | 1662 | Values: 77.0 99.0 64.0 100.0 63.0 79.0 102.0 103.0 100.0 82.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:89.00 stddev:8.32 (9.4%) stddev-sans-first:8.61 21:38:20 INFO - PROCESS | 1662 | Values: 85.0 91.0 89.0 96.0 89.0 80.0 101.0 77.0 91.0 103.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:159.00 stddev:13.81 (8.7%) stddev-sans-first:9.14 21:38:20 INFO - PROCESS | 1662 | Values: 123.0 150.0 161.0 154.0 173.0 160.0 155.0 140.0 163.0 158.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.00 Median:199.50 stddev:31.22 (15.6%) stddev-sans-first:31.66 21:38:20 INFO - PROCESS | 1662 | Values: 171.0 210.0 249.0 189.0 174.0 169.0 229.0 236.0 171.0 172.0 21:38:20 INFO - PROCESS | 1662 | 21:38:20 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:3.92 (5.8%) stddev-sans-first:4.16 21:38:20 INFO - PROCESS | 1662 | Values: 68.0 79.0 69.0 68.0 67.0 66.0 65.0 68.0 66.0 68.0 21:38:20 INFO - PROCESS | 1662 | -------- Summary: end -------- 21:38:20 INFO - PROCESS | 1662 | 21:38:21 INFO - TEST-INFO | 1662: exit 0 21:38:21 INFO - TEST-OK | kraken | took 61607ms 21:38:21 INFO - SUITE-END | took 1175s 21:38:21 INFO - Completed test suite (00:19:35) 21:38:21 INFO - javascript benchmark 21:38:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7355.434226294932, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.257442075532, 3474.0620032591187, 3474.947875781864, 3475.131217195701, 3498.825058747063, 4877.0489754497885, 5815.0, 5856.180134781134, 5918.34898161203, 5936.673482958436, 5688.4311568843095, 5713.571482138846, 5764.5676574256995, 5936.079907614316, 5992.28092628884, 5165.096108181072, 5232.7122008289525, 5283.524482796547, 5336.839894803162, 5342.358916929955, 4294.527601963781, 5373.7581808818695, 5427.945720542783, 5431.2396264522995, 5500.50495455409, 5249.1338929076655, 5276.762545685453, 5314.787408503656, 5333.973330133364, 5368.4363141869935, 5311.867203319909, 5333.4399888011585, 5357.08929481989, 5369.5972802040005, 5382.0, 5232.843014709527, 5285.709285989269, 5288.867778305535, 5314.787408503694, 5379.193121031837, 5556.0, 5781.566382521328, 5842.941570584282, 5900.675462849542, 5916.201312822757, 6262.71817768197, 6281.905771413432, 6315.621062736251, 6319.0, 6347.460465860408, 6260.874782504325, 6292.244930608311, 6296.370362963713, 6303.117563541108, 6321.462675672527, 5805.867855768127, 5849.268841394825, 5857.472827445507, 5915.497182739429, 5928.614640048383, 6315.715792789244, 6337.144485494491, 6351.237851457855, 6404.871902561923, 6421.0, 6202.56582039262, 6210.968945155245, 6266.624002559861, 6267.5299352548745, 6297.086922396227, 5165.638405311592, 6310.495160387158, 6311.0217916223055, 6314.905276420857, 6339.0808332791485, 6168.352323006109, 6265.404786545271, 6281.654509002049, 6304.369563043659, 6337.588056776387, 6293.748250070037, 6312.621242725451, 6313.5896166749935, 6315.747370105236, 6354.459870911024, 4013.2575473536904, 4264.7654379009455, 4742.52574742523, 4777.187878060738, 5073.822416215415, 3670.46778217157, 4483.170613436525, 4512.052468981485, 4528.230200865861, 4578.9771051144535, 5718.942810571924, 5829.912551311733, 5846.7076646167525, 5867.823965281048, 5889.0, 6238.095476156022, 6241.96879015602, 6252.030935205051, 6266.404691554295, 6296.0, 5354.464553544614, 5377.247185394048, 5901.557383196277, 5904.291485021825, 5922.822315330547, 5549.694766787785, 5550.8057217997175, 5576.553875689935, 5591.8881622368135, 5601.131824567117, 4830.637702172281, 6280.874382512416, 6372.681365931592, 6496.6426846522945, 6501.414872661483, 5190.8961820764125, 5491.0, 6294.024426213944, 6316.589421687576, 6316.905246421399, 6495.350464953467, 6503.967480162569, 6527.379898909596, 6540.8415222977255, 6552.475801935739, 6105.997654215468, 6154.415330543591, 6314.778982735582, 6327.525435592257, 6336.778212762531, 6220.7511699533325, 6302.464290535356, 6309.400606942333, 6329.588576742497, 6346.714397852015, 4502.819887204606, 5273.34083239595, 5303.628745987744, 6002.549808764447, 6186.381361863778, 4586.541345865387, 6129.417705317987, 6145.385461453998, 6265.4361107500545, 6271.3728627136925, 5781.653100813965, 6058.454739073504, 6130.754769809336, 6141.486007784364, 6162.506999440124, 6224.813255602339, 6234.220722409699, 6243.188385509855, 6252.593581417375, 6263.749450021948, 6022.1870047543025, 6101.450869421773, 6113.266408031065, 6164.260288765377, 6196.597221180609], "value": 5716.772904507874, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.4496271917778, 505.5298572327736, 533.4318950317913, 535.0502857428065, 542.1596525385651, 39388.606113938855, 41838.37242441366, 41856.37215441763, 41901.742947711544, 42016.57983420165, 41935.79032104843, 42229.15541689164, 42436.57563424365, 42683.0, 42766.57233427665, 9510.714678559638, 9651.420914745102, 9704.66033688821, 9713.174380177694, 9725.221982241439, 9566.56950437232, 9637.807243855119, 9677.854832177523, 9682.12860842524, 9710.514474276293, 9623.95188024059, 9641.566129524188, 9713.368631038995, 9725.367851089657, 9726.756831079245, 9619.0, 9637.469939153343, 9645.614175433044, 9650.03499650033, 9679.580104973757, 9593.47235902025, 9593.760155996086, 9637.566309516089, 9657.661981830603, 9665.516724163763, 40760.98097547585, 40890.795546022375, 41037.0, 41073.58926410728, 41222.9694257646, 2653.6284920111198, 3287.8027318360737, 3454.6199918008997, 3717.2937141942944, 4168.541460439349, 29835.552466713016, 30702.53946190809, 31250.7499700014, 32145.83927080373, 32375.190620234447, 2616.842989420641, 3146.7482601391835, 3152.479840826261, 3165.6862402103097, 3235.854386552611, 446687.0, 454406.0, 457331.0, 457666.0, 458798.0, 33584.664153358644, 33834.66165338364, 33957.32085358279, 34093.0, 34096.65903340935, 34420.13949651279, 35192.47211291832, 35412.82293588515, 35560.0, 35698.8215058923, 16849.326026958784, 17040.31838726437, 17055.573610659583, 17058.402955896483, 17071.658566828595, 12957.481700732054, 13006.959443244517, 13023.544175953795, 13060.281684507254, 13069.607911762663, 18785.624287514445, 18801.965891875803, 18803.435896923114, 18850.434486965412, 18852.52868678294, 6593.538452308292, 7858.214178582096, 8013.879791803128, 8068.878966815502, 8083.070446898564, 843.5318398289008, 980.6224603527693, 982.7641366072235, 999.5152351109706, 1064.297563608015, 24643.753562464506, 29374.55938160929, 29836.552451712807, 30212.09363719092, 30428.239294017385, 888.6045709659139, 961.9470929098827, 1056.060106505211, 1148.6554033789996, 1202.6331968749441, 15744.92127539355, 16681.0, 16943.32226710918, 17151.74272385915, 17217.483475495756, 644736.0, 652875.0, 655044.0, 656304.0, 660201.0, 59247.703761480916, 59563.0, 59748.0, 59784.40215597875, 59804.803903921675, 1236.8868018782987, 1258.6853286678331, 1315.6645055510783, 1373.979390309146, 1376.504458394977, 27894.30264243329, 28398.86404543795, 29875.0, 31299.68700312968, 31686.68313316837, 48484.515154848, 53207.0, 53213.20180197222, 53325.666858328856, 53403.0, 598496.0, 601285.0, 601835.0, 603105.0, 603331.0, 25493.98024079016, 26507.0, 26628.866855665598, 26682.19953401401, 26691.0, 47529.76235118802, 47576.286355704, 48612.75693621651, 48744.756276219814, 48835.0, 38512.42231366588, 39528.40707389449, 39682.60317396789, 40561.78314650565, 40908.795456022526, 39097.60902391053, 39373.21253574855, 39674.801625991684, 40852.795736022315, 41160.0, 38095.809520952214, 39197.628083016956, 39291.80354098211, 39615.81152565427, 39730.205395891346, 29121.85439072791, 31952.36095278035, 35018.949431517096, 35371.76198833028, 35729.0, 24112.51774964526, 26153.869230653723, 26364.472710546066, 26555.468890621694, 26666.600000999613], "value": 19543.60098600109, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.9736821054316, 345.4938515075414, 377.8923006943021, 384.29481900712193, 389.77998863557065, 20116.89941550292, 20223.59552808945, 20323.59352812943, 20793.68809467857, 21084.789152108475, 20112.396628101145, 20394.89802550989, 20886.582268354625, 21145.471363215926, 21386.0, 5489.862753431176, 5891.293044834626, 6019.217501724792, 6073.301570319426, 6074.271087469509, 5983.820485385445, 6023.879522409549, 6041.6375017499095, 6049.425304596057, 6054.334023257438, 5857.941420585782, 5907.6750778707155, 5944.613600116, 5951.166836642873, 5979.103134529833, 5066.468020857812, 5808.390119037483, 5829.358770535237, 5922.763089476416, 5944.108383742451, 4990.201567749143, 5110.4634013428795, 5143.125668636303, 5176.249443830623, 5180.430152683201, 18279.994600296977, 19488.51278718029, 19832.0, 20418.5916281675, 26251.73748262512, 2408.662787209792, 2503.7621425964503, 2963.659179194399, 3116.719495245416, 3152.558641790128, 14097.506587269396, 14599.124052556774, 14840.925795370955, 16001.359945602162, 16226.513204603882, 1571.6385231396728, 1847.815218478155, 1863.9068046597752, 1875.7186422036668, 1920.6734855074671, 108782.45608771905, 119148.40425797903, 123956.38021809833, 125587.0, 127758.3612081943, 8882.378233523592, 10346.53440595175, 10461.215408844368, 10973.3964631946, 11225.989660930556, 13485.797713034117, 13621.863781362257, 13643.863561364458, 13673.726525469436, 13713.588592342247, 8168.591570421574, 8559.116994261252, 8588.65645374178, 8641.395102342776, 8770.736877893672, 8686.044535101133, 8688.695895643623, 8719.476831390137, 8823.735287941372, 8874.245689116367, 6571.934280657228, 6659.800205993828, 6701.932980670228, 6719.764808231688, 6819.624920629413, 1834.715619079045, 1842.2446796813242, 1867.9825788148767, 1868.271374164077, 1868.9065546722609, 918.4994178172911, 976.838821594429, 990.7473594233425, 1039.9480025998669, 1116.4585176189541, 22039.559208815735, 22326.218582349866, 22500.637433069292, 22608.886955565446, 22614.773852261267, 851.1871163039283, 872.2672954718067, 893.9240164586083, 939.4175611121012, 968.0271327316002, 8856.64573417069, 10859.2398532102, 11292.887071129184, 11535.365554894393, 11578.015868651091, 599911.0, 608954.0, 611900.0, 612348.0, 633555.0, 100259.0, 146464.26767866092, 149421.0, 151152.0, 151759.0, 904.941218774036, 927.1655510040882, 928.4614923344444, 974.7173319737338, 974.9268804839523, 16349.937254078446, 16440.917795410947, 17496.737548936522, 19613.313534026813, 19640.607187856447, 48943.75528122479, 49719.0, 53879.0, 55612.443875560726, 58586.828263435345, 73116.0, 86305.0, 86412.1358786404, 86948.0, 87372.56313718391, 8043.517388956681, 8139.511629302261, 8338.249557539608, 8441.324694024586, 8442.535660538484, 11517.42412879336, 11567.710807229887, 11742.007717376133, 12852.871471285167, 13292.534761283308, 8714.651413943624, 11856.940715296369, 11959.342236176746, 12009.279443233434, 12065.155439119177, 10092.091711745978, 10191.439470829175, 11367.602133925273, 11746.0, 11788.587399440978, 11663.358515281741, 11665.533378664759, 11675.241109327866, 12064.75870482568, 12107.576234832091, 8131.471454355448, 8131.576974029639, 8324.25081742646, 8364.079951205242, 8464.0, 8454.957725211581, 8482.575871206538, 11383.0, 11669.207507560246, 11778.705532361759], "value": 9786.935626008439, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.2186324043116, 1545.350952599908, 1727.4558514068067, 1820.881642693224, 1839.0988415676313, 8045.959770201155, 8460.280876125522, 8478.0, 8988.101189881008, 9015.639374425024, 8465.53439560824, 8662.783430414243, 8684.0, 8698.695545655903, 8701.042885282613, 2313.456337760629, 2367.1241640593003, 2373.0507796881298, 2374.750651181627, 2379.773921477457, 2323.767623237671, 2355.199232261031, 2372.043064471809, 2378.988105059472, 2384.8092152627746, 2341.7072865891764, 2358.988205058972, 2364.4679947011955, 2368.0882860098814, 2376.9049238030457, 2334.463073493106, 2343.5898717724417, 2355.49356888269, 2359.351178425938, 2360.268316821791, 1951.2097600471832, 2334.568104900582, 2350.5886469867874, 2351.036075209156, 2360.2565191964477, 8694.434861733967, 8716.215540601313, 8716.912830871737, 8747.16901894319, 8774.517401542913, 5167.431582525919, 5194.6883187008525, 5251.0, 5326.680399176062, 5331.067063263913, 3528.964710352915, 3639.253952939641, 3707.6292370762976, 3721.888343349704, 3733.757305775143, 979.5689896445541, 1033.05991547692, 1102.581019212694, 1118.6755840806156, 1124.7525544380223, 10363.170946324275, 11418.486168122454, 11513.942430287878, 11594.826077608926, 11606.245594036445, 4511.1654343946475, 4661.114388266218, 4824.324594556765, 4824.396950381202, 4874.4150701916, 9832.31173817826, 9942.15491683215, 9984.051515106054, 9991.550380232908, 10002.599896004078, 5352.785888564492, 5354.036273470812, 5354.759035843396, 5371.4628537146755, 5379.085555455582, 4453.576910193527, 4762.690425122356, 4841.830535931225, 4912.459629440758, 4919.114559379346, 3791.8055812419, 3886.591907849635, 3929.901752456154, 3943.5662077171487, 3998.4402183694306, 1270.9491620335084, 1273.2551457397342, 1273.6688461000022, 1281.9488019823655, 1286.350393051503, 712.337526100721, 795.0300633227454, 916.4730280088842, 921.1198199404162, 926.2682480840061, 4650.232711602548, 5222.903190329997, 5934.37689042653, 5962.85092872673, 6164.599301045418, 423.6485610901215, 436.3236982676838, 441.126569392598, 441.3644352132918, 442.6812694859696, 3422.1102513346214, 3848.3265428549894, 4165.271077561415, 4287.914241715148, 4302.870913872589, 10683.679489615324, 10731.892681073245, 10790.08284295828, 10839.187060970458, 10903.073238774792, 9025.458472491671, 10182.6253455784, 10759.246852720235, 10818.080463160562, 10884.292520986111, 6609.372109649672, 7881.645325960346, 8081.919180808234, 8311.293540049042, 8325.958370208231, 5003.324551185543, 5845.678487683218, 5985.910211346746, 5991.970040149771, 6146.108814221823, 9668.9033109668, 9791.608335666493, 9794.804103918024, 9836.508174591385, 10040.347377420445, 8543.487390756574, 8570.957145214483, 9656.130948214695, 9948.850767238353, 10163.339382940085, 6549.541532092708, 7016.22821489646, 7393.8151546211775, 7557.6221188939235, 7580.9620951894885, 8424.4945303282, 8494.36292278094, 8494.53280069602, 8508.914910850812, 8527.317814574695, 5737.569682273763, 7514.211007844317, 7516.135644400964, 7576.924230757621, 7615.238476152341, 7401.7039318428815, 7417.554946703215, 7422.554646721214, 7426.034615499951, 7508.849823003618, 7028.50800443964, 7043.788686339418, 7077.610731409616, 7119.8932016020835, 7129.643517824192, 5002.499750024968, 5044.772985215601, 5072.188449848007, 5095.719735414587, 5103.566196873159, 4946.600898564266, 4970.5029497051455, 5070.163423035306, 5221.399539053057, 5273.683578985119], "value": 4468.420463645672, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [253.45380704581626, 292.19937371601804, 302.06811985026195, 304.55991092870806, 309.48470796124457, 5497.615166938316, 5501.752421141048, 5516.345096471057, 5518.641288316257, 5543.556515478767, 4624.745638989854, 5310.62825602208, 5431.83704488865, 5464.049413316804, 5484.533814625762, 3951.861684841031, 4016.7389119707273, 4085.673146148301, 4140.792960351985, 4148.5851414858425, 3451.4822776583464, 4097.692673049518, 4146.834126634946, 4155.317096575876, 4167.812448439812, 4130.256553820326, 4136.524299705542, 4138.358554424054, 4169.541350451448, 4173.373993900909, 3414.5048967899515, 4032.4152997815154, 4121.670266378683, 4130.896727581804, 4172.582741725833, 3559.60844307126, 3567.2687099144614, 3568.6966607838367, 3573.4639804029343, 3581.2837432513343, 5030.0, 5308.256844041837, 5309.973450132763, 5320.547753440962, 5348.251244825728, 4518.17014109283, 4524.796384162721, 4729.574338309534, 4752.5485078917445, 4777.450593181794, 5729.427057294279, 5774.942250577483, 5790.7104644768015, 5820.650760954356, 5833.79581714638, 3316.3533111043357, 3785.0, 3963.4253033310297, 3969.3450580654444, 3980.383040628707, 5714.057220545034, 6030.939690603125, 6095.969520152371, 6096.695165241765, 6097.20736304282, 3886.5336159660455, 3909.7263191576317, 3924.4309575111447, 3934.803259836997, 3935.5277366716177, 3195.7283630891634, 3842.6550707252795, 3980.5621381647998, 3989.4813674222164, 4016.758994460342, 3946.4474973503734, 4263.211305908417, 4696.38946936896, 4702.623790096784, 4713.95286047142, 4482.9775851121185, 5083.288339632454, 5612.7754889803955, 5780.306363236438, 5881.852953676107, 1223.9082068844693, 1347.818044563991, 1368.404743936371, 1369.7123604043063, 1372.663697394125, 711.9786406407816, 796.0, 822.5393779483509, 843.0768308701962, 845.8435189489965, 5114.079465696136, 5404.567634589223, 5426.945730542723, 5432.402435732066, 5464.699441530674, 4703.623710103184, 5183.637145399785, 6009.694667932619, 6019.307779605401, 6060.090986352083, 4447.488538818013, 5096.541311282002, 5375.892482150413, 5421.186821976735, 5447.972760136174, 2634.0, 3114.470540008204, 3151.3697260547524, 3156.4318422684137, 3163.374399248618, 4909.4780618008535, 5508.925759476943, 5848.473637372657, 6231.688415579203, 6247.71921756039, 5252.054630166606, 5557.944420555743, 6077.513798896078, 6125.356837532084, 6145.125736650364, 4953.529414705669, 5636.408177141505, 6166.660833654192, 6207.503399728011, 6221.564490485713, 4963.883126296554, 5247.606429517878, 5559.527440167631, 5600.927656767022, 6012.9098063529955, 4480.969377043363, 5144.739538813014, 5652.802151924663, 5839.0, 5848.093545500455, 6196.81409557714, 6204.069389591597, 6207.479167603966, 6236.844078898064, 6248.5313601479165, 3323.3353329333745, 3535.62875898027, 3895.8831235062994, 3946.0, 3947.9735268830887, 4461.709988850715, 5242.449542798104, 5942.58401911862, 5963.463288304073, 5965.806838632204, 4613.838515651936, 4860.441049279237, 5799.94200057994, 5804.216430781959, 5875.529957603467, 5454.699991500505, 5726.36375901314, 5729.54163666914, 5746.2529871116485, 5803.82588522345, 5028.642266587927, 5184.507471790174, 5555.583331250092, 5675.509561619657, 5690.77236910519, 5221.929504451502, 5519.889602207853, 5618.904313658797, 5807.631573687336, 5811.198528456192, 4882.414110306786, 5248.396434409939, 5695.829125126253, 5703.686297253691, 5726.74229659658], "value": 4151.645916739911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.876812789634, 702.4275215699208, 709.7196607340104, 783.8628240057989, 812.0580127052621, 13175.077744557884, 15177.317020734066, 15563.92218038911, 15588.844111558881, 15725.056496610212, 11586.0, 14241.928790356034, 14321.140731556114, 14347.497837575687, 14367.281635918189, 662.5593980003292, 823.3207603726919, 827.9296259817908, 846.6232526525698, 850.6002178975872, 854.0349405172178, 855.6962278391175, 856.0882659967147, 857.1043259793499, 859.6217664227751, 888.7511496780879, 905.8777065096193, 908.4413085952125, 908.954552272387, 909.9363044586881, 894.4946105450432, 895.8387490251752, 900.6622516556291, 901.0178904993555, 906.2025417632474, 653.7417720000573, 657.6284399314372, 665.3280187011105, 666.7699643622942, 667.7963221217527, 15063.322150503254, 15086.0, 15145.469908553148, 15215.923920380437, 15224.086554806636, 14793.186374749384, 14849.628759281104, 14872.925635371754, 14904.031237969606, 15030.398784048624, 12011.39943002855, 12123.211991220542, 12327.630171094881, 12379.442925068304, 12538.596990058299, 3855.7108216883566, 3862.0344913771555, 4048.9595104048876, 4086.346184610478, 4095.8566450174103, 99605.0, 116082.0, 116733.4163329178, 117506.41246793797, 117581.0, 10127.139193168516, 11433.828492572618, 11482.942585287186, 11603.419829008515, 11609.30344179352, 23838.0, 23869.0, 23895.446795958207, 23899.641505377433, 23933.401664958168, 8175.63209655567, 8218.753437396888, 8320.79901909683, 8324.70863519786, 8345.165483451607, 4446.221911165598, 4524.253498172765, 4526.253168227271, 4526.411566496335, 4663.696859704109, 3574.463830425405, 3675.7059435245114, 3686.318031164243, 3686.594474607791, 3687.0966613179944, 606.8361542383532, 616.8457885528618, 643.3791391307411, 651.7360469010058, 654.6137778710583, 557.028652841538, 636.0999186151636, 665.7969319357643, 677.678102901118, 687.9724811007603, 8271.379646526535, 9339.626414943326, 9551.64523317042, 9673.129418352382, 9728.61085556584, 518.9506996835295, 520.531521630528, 532.7842223899327, 561.898858205527, 581.6393835821817, 3978.3435733104293, 4545.2954792007295, 4746.881327966828, 4788.401449818773, 4804.6876952997945, 108892.4555377218, 139552.0, 160510.0, 169090.0, 171738.0, 116752.8324716759, 143403.0, 143672.66127701665, 146528.80206796905, 150322.0, 116687.0, 124235.89410264816, 124331.0, 126891.36554317354, 127265.36367318104, 9037.231835294073, 9107.408018478778, 9124.817503650023, 9125.178733913714, 9171.908280917105, 63035.10894673167, 63743.68128159329, 69755.6512217456, 70307.94538082035, 70320.6483967577, 83091.0, 102598.0, 104631.92100987377, 105953.0, 107642.0, 12147.635570932885, 12229.086791553284, 12259.0, 12328.81506777417, 12849.486020559072, 10918.890811091787, 12386.876131238572, 12468.940140088194, 13257.535986240435, 14022.439102436196, 12358.876411235773, 12363.071963704786, 12365.690857728629, 12560.497580097059, 12933.805992910302, 12454.074235894614, 12502.812457813323, 12596.811047834106, 12619.0, 12838.293893835555, 12216.633500994983, 12261.570845020382, 12286.464849883334, 12349.0, 12510.374481276081, 9969.202463802734, 10412.219083568914, 10441.738956526147, 10562.31344962575, 10986.066184374098, 9754.658586949423, 10180.338278011906, 10786.0, 10825.56697732082, 10864.782704345711], "value": 7805.98253522071, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1623.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 173.0, 139.0, 118.0, 113.0, 115.0, 117.0, 113.0, 113.0, 120.0], "value": 126.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 111.0, 131.0, 158.0, 118.0, 142.0, 130.0, 113.0, 161.0, 110.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 198.0, 252.0, 248.0, 186.0, 279.0, 199.0, 275.0, 283.0, 192.0], "value": 230.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 87.0, 75.0, 143.0, 59.0, 59.0, 60.0, 63.0, 136.0, 61.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 118.0, 72.0, 74.0, 76.0, 113.0, 73.0, 75.0, 117.0], "value": 86.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 78.0, 91.0, 104.0, 82.0, 132.0, 138.0, 128.0, 93.0, 106.0], "value": 104.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 93.0, 96.0, 100.0, 151.0, 108.0, 93.0, 151.0, 99.0, 97.0], "value": 108.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 100.0, 132.0, 89.0, 89.0, 90.0, 90.0, 91.0, 128.0], "value": 99.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 59.0, 57.0, 57.0, 60.0, 57.0, 57.0, 58.0, 60.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 99.0, 64.0, 100.0, 63.0, 79.0, 102.0, 103.0, 100.0, 82.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 89.0, 96.0, 89.0, 80.0, 101.0, 77.0, 91.0, 103.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 150.0, 161.0, 154.0, 173.0, 160.0, 155.0, 140.0, 163.0, 158.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 210.0, 249.0, 189.0, 174.0, 169.0, 229.0, 236.0, 171.0, 172.0], "value": 197.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 79.0, 69.0, 68.0, 67.0, 66.0, 65.0, 68.0, 66.0, 68.0], "value": 68.4, "unit": "score"}]}]} 21:38:21 INFO - Return code: 0 21:38:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:38:22 ERROR - # TBPL SUCCESS # 21:38:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:38:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:38:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:38:22 INFO - 2016-08-12 21:38:22.041 screenresolution[1667:10585] starting screenresolution argv=screenresolution get 21:38:22 INFO - 2016-08-12 21:38:22.043 screenresolution[1667:10585] Display 0: 1600x1200x32@60 21:38:22 INFO - 2016-08-12 21:38:22.049 screenresolution[1668:10588] starting screenresolution argv=screenresolution list 21:38:22 INFO - Available Modes on Display 0 21:38:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:38:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:38:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:38:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:38:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:38:22 INFO - Intel Iris: 21:38:22 INFO - Chipset Model: Intel Iris 21:38:22 INFO - Type: GPU 21:38:22 INFO - Bus: Built-In 21:38:22 INFO - VRAM (Dynamic, Max): 1536 MB 21:38:22 INFO - Vendor: Intel (0x8086) 21:38:22 INFO - Device ID: 0x0a2e 21:38:22 INFO - Revision ID: 0x0009 21:38:22 INFO - Displays: 21:38:22 INFO - Display: 21:38:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:38:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:38:22 INFO - Display Serial Number: 1600x1200 60 21:38:22 INFO - Main Display: Yes 21:38:22 INFO - Mirror: Off 21:38:22 INFO - Online: Yes 21:38:22 INFO - Rotation: Supported 21:38:22 INFO - Return code: 0 21:38:22 INFO - Running post-action listener: _resource_record_post_action 21:38:22 INFO - [mozharness: 2016-08-13 04:38:22.296012Z] Finished run-tests step (success) 21:38:22 INFO - Running post-run listener: _resource_record_post_run 21:38:22 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 37192704; Write bytes: 706230784; Read time: 238; Write time: 1967 21:38:22 INFO - TinderboxPrint: CPU usage
54.1% 21:38:22 INFO - TinderboxPrint: I/O read bytes / time
37,192,704 / 238 21:38:22 INFO - TinderboxPrint: I/O write bytes / time
706,230,784 / 1,967 21:38:22 INFO - TinderboxPrint: CPU idle
2,223.1 (45.9%) 21:38:22 INFO - TinderboxPrint: CPU system
981.6 (20.3%) 21:38:22 INFO - TinderboxPrint: CPU user
1,641.1 (33.9%) 21:38:22 INFO - TinderboxPrint: Swap in / out
441,962,496 / 0 21:38:22 INFO - install - Wall time: 36s; CPU: 54.0%; Read bytes: 394197504; Write bytes: 388318720; Read time: 31068; Write time: 763 21:38:22 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35386368; Write bytes: 297919488; Read time: 222; Write time: 1152 21:38:22 INFO - Running post-run listener: _upload_blobber_files 21:38:22 INFO - Blob upload gear active. 21:38:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:38:22 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 21:38:22 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:38:22 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:38:23 INFO - (blobuploader) - INFO - Open directory for files ... 21:38:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:38:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:38:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:24 INFO - (blobuploader) - INFO - Done attempting. 21:38:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:38:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:38:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:25 INFO - (blobuploader) - INFO - Done attempting. 21:38:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:38:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:38:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:27 INFO - (blobuploader) - INFO - Done attempting. 21:38:27 INFO - (blobuploader) - INFO - Iteration through files over. 21:38:27 INFO - Return code: 0 21:38:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:38:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:38:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1a6f32ac796a12dccc96f2bd22a8c7998d901dd718b4bc991fd0897a265b0bcfb6f08e12a8118abb98104910e8d2b8161850e832030e573c41d8a2746dddcd60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/149687a769b4e5363cced31e172b03d1368c4eba40ff3850d9240c03613571ea680009ec855e2ab50e7b3ea9f17bf7d2b6c6bd08598a83dd0eb0f237b94cdc00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5f214bd4cd801d1e78c291203ca39b91997324b8a31726437d1795337536ce5fada749098355ba67d2948beef5e6316e90901c25cfce34cf28f0ad0c13994558"} 21:38:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:38:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:38:27 INFO - Contents: 21:38:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1a6f32ac796a12dccc96f2bd22a8c7998d901dd718b4bc991fd0897a265b0bcfb6f08e12a8118abb98104910e8d2b8161850e832030e573c41d8a2746dddcd60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/149687a769b4e5363cced31e172b03d1368c4eba40ff3850d9240c03613571ea680009ec855e2ab50e7b3ea9f17bf7d2b6c6bd08598a83dd0eb0f237b94cdc00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5f214bd4cd801d1e78c291203ca39b91997324b8a31726437d1795337536ce5fada749098355ba67d2948beef5e6316e90901c25cfce34cf28f0ad0c13994558"} 21:38:27 INFO - Running post-run listener: copy_logs_to_upload_dir 21:38:27 INFO - Copying logs to upload dir... 21:38:27 INFO - mkdir: /builds/slave/test/build/upload/logs 21:38:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.516655 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-12 21:38:27.475171) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 21:38:27.479115) ========= 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.VVRYCdPctJ/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.YPgnbEutiw/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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/Autoland/sha512/1a6f32ac796a12dccc96f2bd22a8c7998d901dd718b4bc991fd0897a265b0bcfb6f08e12a8118abb98104910e8d2b8161850e832030e573c41d8a2746dddcd60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/149687a769b4e5363cced31e172b03d1368c4eba40ff3850d9240c03613571ea680009ec855e2ab50e7b3ea9f17bf7d2b6c6bd08598a83dd0eb0f237b94cdc00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5f214bd4cd801d1e78c291203ca39b91997324b8a31726437d1795337536ce5fada749098355ba67d2948beef5e6316e90901c25cfce34cf28f0ad0c13994558"} build_url:https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011642 build_url: 'https://queue.taskcluster.net/v1/task/ShwI9hDwSAWHQ1W65FS1Rw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1a6f32ac796a12dccc96f2bd22a8c7998d901dd718b4bc991fd0897a265b0bcfb6f08e12a8118abb98104910e8d2b8161850e832030e573c41d8a2746dddcd60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/149687a769b4e5363cced31e172b03d1368c4eba40ff3850d9240c03613571ea680009ec855e2ab50e7b3ea9f17bf7d2b6c6bd08598a83dd0eb0f237b94cdc00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5f214bd4cd801d1e78c291203ca39b91997324b8a31726437d1795337536ce5fada749098355ba67d2948beef5e6316e90901c25cfce34cf28f0ad0c13994558"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 21:38:27.517096) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:38:27.517870) ========= 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.VVRYCdPctJ/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.YPgnbEutiw/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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.005160 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 21:38:27.570675) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 21:38:27.571406) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 21:38:27.572151) ========= ========= Total master_lag: 0.19 =========