builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0126 starttime: 1462886628.53 results: success (0) buildid: 20160510031712 builduid: 86163a5b79e0486c9de34d5d04f80478 revision: 8b4e5ab50377a26e6610f21a0f8233467de19e9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:48.529870) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:48.530283) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:48.530569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:48.550416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:48.550687) ========= 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.NNDAbnhVhW/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.1125oA5XA1/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-05-10 06:23:48-- 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% 9.66M=0.001s 2016-05-10 06:23:48 (9.66 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:48.652697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:48.652982) ========= 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.NNDAbnhVhW/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.1125oA5XA1/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.027237 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:48.704313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 06:23:48.704618) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8b4e5ab50377a26e6610f21a0f8233467de19e9b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8b4e5ab50377a26e6610f21a0f8233467de19e9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NNDAbnhVhW/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.1125oA5XA1/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-05-10 06:23:48,850 truncating revision to first 12 chars 2016-05-10 06:23:48,851 Setting DEBUG logging. 2016-05-10 06:23:48,851 attempt 1/10 2016-05-10 06:23:48,851 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8b4e5ab50377?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 06:23:50,477 unpacking tar archive at: fx-team-8b4e5ab50377/testing/mozharness/ program finished with exit code 0 elapsedTime=1.870961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 06:23:50.595222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:50.595634) ========= script_repo_revision: 8b4e5ab50377a26e6610f21a0f8233467de19e9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:50.599085) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:50.599368) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 06:23:50.618505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-10 06:23:50.618803) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NNDAbnhVhW/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.1125oA5XA1/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 06:23:50 INFO - MultiFileLogger online at 20160510 06:23:50 in /builds/slave/test 06:23:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:23:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:23:50 INFO - {'append_to_log': False, 06:23:50 INFO - 'base_work_dir': '/builds/slave/test', 06:23:50 INFO - 'blob_upload_branch': 'Fx-Team', 06:23:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:23:50 INFO - 'branch': 'Fx-Team', 06:23:50 INFO - 'buildbot_json_path': 'buildprops.json', 06:23:50 INFO - 'config_files': ('talos/mac_config.py',), 06:23:50 INFO - 'default_actions': ('clobber', 06:23:50 INFO - 'read-buildbot-config', 06:23:50 INFO - 'download-and-extract', 06:23:50 INFO - 'populate-webroot', 06:23:50 INFO - 'create-virtualenv', 06:23:50 INFO - 'install', 06:23:50 INFO - 'run-tests'), 06:23:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:23:50 INFO - 'download_minidump_stackwalk': True, 06:23:50 INFO - 'download_symbols': 'ondemand', 06:23:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:23:50 INFO - 'tooltool.py': '/tools/tooltool.py', 06:23:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:23:50 INFO - '/tools/misc-python/virtualenv.py')}, 06:23:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:23:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:23:50 INFO - 'installer_path': 'installer.exe', 06:23:50 INFO - 'log_level': 'info', 06:23:50 INFO - 'log_name': 'talos', 06:23:50 INFO - 'log_to_console': True, 06:23:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:23:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:23:50 INFO - 'opt_config_files': (), 06:23:50 INFO - 'pip_index': False, 06:23:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:23:50 INFO - 'cmd': ('bash', 06:23:50 INFO - '-c', 06:23:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:23:50 INFO - 'enabled': True, 06:23:50 INFO - 'halt_on_failure': False, 06:23:50 INFO - 'name': 'check_screen_resolution'},), 06:23:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:23:50 INFO - 'cmd': ('bash', 06:23:50 INFO - '-c', 06:23:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:23:50 INFO - 'enabled': True, 06:23:50 INFO - 'halt_on_failure': False, 06:23:50 INFO - 'name': 'check_screen_resolution'},), 06:23:50 INFO - 'run_cmd_checks_enabled': True, 06:23:50 INFO - 'sps_profile': False, 06:23:50 INFO - 'sps_profile_interval': 0, 06:23:50 INFO - 'suite': 'dromaeojs-e10s', 06:23:50 INFO - 'system_bits': '32', 06:23:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:23:50 INFO - 'title': 't-yosemite-r7-0126', 06:23:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:23:50 INFO - 'use_talos_json': True, 06:23:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:23:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:23:50 INFO - 'work_dir': 'build'} 06:23:50 INFO - ##### 06:23:50 INFO - ##### Running clobber step. 06:23:50 INFO - ##### 06:23:50 INFO - Running pre-action listener: _resource_record_pre_action 06:23:50 INFO - Running main action method: clobber 06:23:50 INFO - rmtree: /builds/slave/test/build 06:23:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:23:52 INFO - Running post-action listener: _resource_record_post_action 06:23:52 INFO - ##### 06:23:52 INFO - ##### Finished clobber step (success) 06:23:52 INFO - ##### 06:23:52 INFO - ##### 06:23:52 INFO - ##### Running read-buildbot-config step. 06:23:52 INFO - ##### 06:23:52 INFO - Running pre-action listener: _resource_record_pre_action 06:23:52 INFO - Running main action method: read_buildbot_config 06:23:52 INFO - Using buildbot properties: 06:23:52 INFO - { 06:23:52 INFO - "project": "", 06:23:52 INFO - "product": "firefox", 06:23:52 INFO - "script_repo_revision": "production", 06:23:52 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:23:52 INFO - "repository": "", 06:23:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:23:52 INFO - "buildid": "20160510031712", 06:23:52 INFO - "pgo_build": "False", 06:23:52 INFO - "basedir": "/builds/slave/test", 06:23:52 INFO - "buildnumber": 754, 06:23:52 INFO - "slavename": "t-yosemite-r7-0126", 06:23:52 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:23:52 INFO - "platform": "yosemite_r7", 06:23:52 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 06:23:52 INFO - "branch": "fx-team", 06:23:52 INFO - "repo_path": "integration/fx-team", 06:23:52 INFO - "revision": "8b4e5ab50377a26e6610f21a0f8233467de19e9b", 06:23:52 INFO - "stage_platform": "macosx64", 06:23:52 INFO - "builduid": "86163a5b79e0486c9de34d5d04f80478", 06:23:52 INFO - "slavebuilddir": "test" 06:23:52 INFO - } 06:23:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 06:23:52 INFO - Running post-action listener: _resource_record_post_action 06:23:52 INFO - ##### 06:23:52 INFO - ##### Finished read-buildbot-config step (success) 06:23:52 INFO - ##### 06:23:52 INFO - ##### 06:23:52 INFO - ##### Running download-and-extract step. 06:23:52 INFO - ##### 06:23:52 INFO - Running pre-action listener: _resource_record_pre_action 06:23:52 INFO - Running main action method: download_and_extract 06:23:52 INFO - mkdir: /builds/slave/test/build/tests 06:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:52 INFO - https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:23:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:23:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:23:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:23:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 06:23:54 INFO - Downloaded 1199 bytes. 06:23:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:23:54 INFO - Using the following test package requirements: 06:23:54 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:23:54 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:23:54 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 06:23:54 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:23:54 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 06:23:54 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:23:54 INFO - u'jsshell-mac.zip'], 06:23:54 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:23:54 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 06:23:54 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:23:54 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:23:54 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 06:23:54 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:23:54 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 06:23:54 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:23:54 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 06:23:54 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:23:54 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 06:23:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:23: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:54 INFO - https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:23:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:23:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:23:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:23:55 INFO - Downloaded 18149663 bytes. 06:23:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:23:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:23:58 INFO - Return code: 0 06:23:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:58 INFO - https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:23:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:23:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:23:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:23:59 INFO - Downloaded 18149663 bytes. 06:23:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:23:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:24:03 INFO - Return code: 0 06:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:03 INFO - https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:24:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:24:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:24:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:24:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:24:04 INFO - Downloaded 10840152 bytes. 06:24:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:24:04 INFO - Return code: 0 06:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:04 INFO - https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:24:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:24:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:24:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 06:24:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 06:24:07 INFO - Downloaded 109793421 bytes. 06:24:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:24:07 INFO - mkdir: /builds/slave/test/properties 06:24:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:24:07 INFO - Writing to file /builds/slave/test/properties/build_url 06:24:07 INFO - Contents: 06:24:07 INFO - build_url:https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:24:08 INFO - Running post-action listener: _resource_record_post_action 06:24:08 INFO - Running post-action listener: set_extra_try_arguments 06:24:08 INFO - ##### 06:24:08 INFO - ##### Finished download-and-extract step (success) 06:24:08 INFO - ##### 06:24:08 INFO - ##### 06:24:08 INFO - ##### Running populate-webroot step. 06:24:08 INFO - ##### 06:24:08 INFO - Running pre-action listener: _resource_record_pre_action 06:24:08 INFO - Running main action method: populate_webroot 06:24:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:24:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:24:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:24:08 INFO - '--tppagecycles', 06:24:08 INFO - '7'], 06:24:08 INFO - 'tests': ['tsvgm']}}, 06:24:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:24:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:24:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:24:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:24:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:24:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:24:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:08 INFO - 'talos_options': ['--disable-e10s'], 06:24:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:08 INFO - 'talos_options': ['--disable-e10s'], 06:24:08 INFO - 'tests': ['damp', 'tps']}, 06:24:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:08 INFO - 'tests': ['damp', 'tps']}, 06:24:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:24:08 INFO - 'tests': ['dromaeo_dom']}, 06:24:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:24:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:24:08 INFO - 'tests': ['a11yr', 06:24:08 INFO - 'ts_paint', 06:24:08 INFO - 'tpaint', 06:24:08 INFO - 'sessionrestore', 06:24:08 INFO - 'sessionrestore_no_auto_restore', 06:24:08 INFO - 'tabpaint']}, 06:24:08 INFO - 'other-e10s': {'tests': ['a11yr', 06:24:08 INFO - 'ts_paint', 06:24:08 INFO - 'tpaint', 06:24:08 INFO - 'sessionrestore', 06:24:08 INFO - 'sessionrestore_no_auto_restore', 06:24:08 INFO - 'tabpaint']}, 06:24:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:24:08 INFO - 'ts_paint', 06:24:08 INFO - 'tpaint', 06:24:08 INFO - 'sessionrestore', 06:24:08 INFO - 'sessionrestore_no_auto_restore', 06:24:08 INFO - 'tabpaint']}, 06:24:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:24:08 INFO - 'ts_paint', 06:24:08 INFO - 'tpaint', 06:24:08 INFO - 'sessionrestore', 06:24:08 INFO - 'sessionrestore_no_auto_restore', 06:24:08 INFO - 'tabpaint']}, 06:24:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:24:08 INFO - 'tests': ['a11yr', 06:24:08 INFO - 'ts_paint', 06:24:08 INFO - 'tpaint', 06:24:08 INFO - 'sessionrestore', 06:24:08 INFO - 'sessionrestore_no_auto_restore', 06:24:08 INFO - 'tabpaint']}, 06:24:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:24:08 INFO - 'tests': ['a11yr', 06:24:08 INFO - 'ts_paint', 06:24:08 INFO - 'tpaint', 06:24:08 INFO - 'sessionrestore', 06:24:08 INFO - 'sessionrestore_no_auto_restore', 06:24:08 INFO - 'tabpaint']}, 06:24:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:24:08 INFO - 'tests': ['tsvgx', 06:24:08 INFO - 'tsvgr_opacity', 06:24:08 INFO - 'tart', 06:24:08 INFO - 'tscrollx', 06:24:08 INFO - 'cart']}, 06:24:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:24:08 INFO - 'tsvgr_opacity', 06:24:08 INFO - 'tart', 06:24:08 INFO - 'tscrollx', 06:24:08 INFO - 'cart']}, 06:24:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:08 INFO - 'talos_options': ['--disable-e10s'], 06:24:08 INFO - 'tests': ['tp5o']}, 06:24:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:08 INFO - 'tests': ['tp5o']}, 06:24:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:08 INFO - 'talos_options': ['--disable-e10s', 06:24:08 INFO - '--xperf_path', 06:24:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:08 INFO - 'tests': ['tp5n']}, 06:24:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:08 INFO - 'talos_options': ['--xperf_path', 06:24:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:08 INFO - 'tests': ['tp5n']}}, 06:24:08 INFO - 'talos.zip': {'path': '', 06:24:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:24:08 INFO - Running post-action listener: _resource_record_post_action 06:24:08 INFO - ##### 06:24:08 INFO - ##### Finished populate-webroot step (success) 06:24:08 INFO - ##### 06:24:08 INFO - ##### 06:24:08 INFO - ##### Running create-virtualenv step. 06:24:08 INFO - ##### 06:24:08 INFO - Running pre-action listener: _resource_record_pre_action 06:24:08 INFO - Running main action method: create_virtualenv 06:24:08 INFO - Creating virtualenv /builds/slave/test/build/venv 06:24:08 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 06:24:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:24:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:24:08 INFO - Using real prefix '/tools/python27' 06:24:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:24:09 INFO - Installing distribute.............................................................................................................................................................................................done. 06:24:12 INFO - Installing pip.................done. 06:24:12 INFO - Return code: 0 06:24:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:12 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 0x103641a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aaa46cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034e5d30>, '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 0x103309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034dcb20>, '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.NNDAbnhVhW/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.1125oA5XA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 06:24:12 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 06:24:12 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 06:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNDAbnhVhW/Render', 06:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:12 INFO - 'HOME': '/Users/cltbld', 06:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:12 INFO - 'LOGNAME': 'cltbld', 06:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:12 INFO - 'MOZ_NO_REMOTE': '1', 06:24:12 INFO - 'NO_EM_RESTART': '1', 06:24:12 INFO - 'PAGER': '/bin/cat', 06:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:12 INFO - 'PWD': '/builds/slave/test', 06:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:12 INFO - 'SHELL': '/bin/bash', 06:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1125oA5XA1/Listeners', 06:24:12 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 06:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:12 INFO - 'USER': 'cltbld', 06:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:12 INFO - 'XPC_FLAGS': '0x0', 06:24:12 INFO - 'XPC_SERVICE_NAME': '0', 06:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:12 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 06:24:12 INFO - Cleaning up... 06:24:12 INFO - Return code: 0 06:24:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103641a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aaa46cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034e5d30>, '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 0x103309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034dcb20>, '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.NNDAbnhVhW/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.1125oA5XA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 06:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNDAbnhVhW/Render', 06:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:12 INFO - 'HOME': '/Users/cltbld', 06:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:12 INFO - 'LOGNAME': 'cltbld', 06:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:12 INFO - 'MOZ_NO_REMOTE': '1', 06:24:12 INFO - 'NO_EM_RESTART': '1', 06:24:12 INFO - 'PAGER': '/bin/cat', 06:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:12 INFO - 'PWD': '/builds/slave/test', 06:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:12 INFO - 'SHELL': '/bin/bash', 06:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1125oA5XA1/Listeners', 06:24:12 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 06:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:12 INFO - 'USER': 'cltbld', 06:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:12 INFO - 'XPC_FLAGS': '0x0', 06:24:12 INFO - 'XPC_SERVICE_NAME': '0', 06:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:12 INFO - Downloading/unpacking psutil>=0.7.1 06:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:24:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:24:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:24:15 INFO - Installing collected packages: psutil 06:24:15 INFO - Running setup.py install for psutil 06:24:15 INFO - building 'psutil._psutil_osx' extension 06:24:15 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 06:24:16 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 06:24:16 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 06:24:16 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 06:24:16 INFO - building 'psutil._psutil_posix' extension 06:24:16 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 06:24:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:24:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:24:16 INFO - ^ 06:24:16 INFO - 1 warning generated. 06:24:16 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 06:24:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:24:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:24:16 INFO - Successfully installed psutil 06:24:16 INFO - Cleaning up... 06:24:16 INFO - Return code: 0 06:24:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103641a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aaa46cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034e5d30>, '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 0x103309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034dcb20>, '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.NNDAbnhVhW/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.1125oA5XA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 06:24:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNDAbnhVhW/Render', 06:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:16 INFO - 'HOME': '/Users/cltbld', 06:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:16 INFO - 'LOGNAME': 'cltbld', 06:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:16 INFO - 'MOZ_NO_REMOTE': '1', 06:24:16 INFO - 'NO_EM_RESTART': '1', 06:24:16 INFO - 'PAGER': '/bin/cat', 06:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:16 INFO - 'PWD': '/builds/slave/test', 06:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:16 INFO - 'SHELL': '/bin/bash', 06:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1125oA5XA1/Listeners', 06:24:16 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 06:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:16 INFO - 'USER': 'cltbld', 06:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:16 INFO - 'XPC_FLAGS': '0x0', 06:24:16 INFO - 'XPC_SERVICE_NAME': '0', 06:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:24:19 INFO - Installing collected packages: mozsystemmonitor 06:24:19 INFO - Running setup.py install for mozsystemmonitor 06:24:19 INFO - Successfully installed mozsystemmonitor 06:24:19 INFO - Cleaning up... 06:24:19 INFO - Return code: 0 06:24:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103641a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aaa46cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034e5d30>, '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 0x103309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034dcb20>, '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.NNDAbnhVhW/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.1125oA5XA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 06:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNDAbnhVhW/Render', 06:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:19 INFO - 'HOME': '/Users/cltbld', 06:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:19 INFO - 'LOGNAME': 'cltbld', 06:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:19 INFO - 'MOZ_NO_REMOTE': '1', 06:24:19 INFO - 'NO_EM_RESTART': '1', 06:24:19 INFO - 'PAGER': '/bin/cat', 06:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:19 INFO - 'PWD': '/builds/slave/test', 06:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:19 INFO - 'SHELL': '/bin/bash', 06:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1125oA5XA1/Listeners', 06:24:19 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 06:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:19 INFO - 'USER': 'cltbld', 06:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:19 INFO - 'XPC_FLAGS': '0x0', 06:24:19 INFO - 'XPC_SERVICE_NAME': '0', 06:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:20 INFO - Downloading/unpacking blobuploader==1.2.4 06:24:20 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 06:24:20 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 06:24:20 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 06:24:20 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 06:24:20 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 06:24:20 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 06:24:22 INFO - Downloading blobuploader-1.2.4.tar.gz 06:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:24:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:24:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:24:23 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 06:24:23 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 06:24:23 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 06:24:23 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 06:24:23 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 06:24:23 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 06:24:23 INFO - Downloading docopt-0.6.1.tar.gz 06:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:24:23 INFO - Installing collected packages: blobuploader, requests, docopt 06:24:23 INFO - Running setup.py install for blobuploader 06:24:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:24:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:24:23 INFO - Running setup.py install for requests 06:24:24 INFO - Running setup.py install for docopt 06:24:24 INFO - Successfully installed blobuploader requests docopt 06:24:24 INFO - Cleaning up... 06:24:24 INFO - Return code: 0 06:24:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:24 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 0x103641a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aaa46cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034e5d30>, '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 0x103309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034dcb20>, '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.NNDAbnhVhW/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.1125oA5XA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 06:24:24 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 06:24:24 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 06:24:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNDAbnhVhW/Render', 06:24:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:24 INFO - 'HOME': '/Users/cltbld', 06:24:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:24 INFO - 'LOGNAME': 'cltbld', 06:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:24 INFO - 'MOZ_NO_REMOTE': '1', 06:24:24 INFO - 'NO_EM_RESTART': '1', 06:24:24 INFO - 'PAGER': '/bin/cat', 06:24:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:24 INFO - 'PWD': '/builds/slave/test', 06:24:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:24 INFO - 'SHELL': '/bin/bash', 06:24:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1125oA5XA1/Listeners', 06:24:24 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 06:24:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:24 INFO - 'USER': 'cltbld', 06:24:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:24 INFO - 'XPC_FLAGS': '0x0', 06:24:24 INFO - 'XPC_SERVICE_NAME': '0', 06:24:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:24 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-L7trhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:25 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-8DWmtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:25 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-5GdyoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:25 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_QipHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:25 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-bVb8zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:25 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-taBWGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:25 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-4QpeEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:25 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-OtGiab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:25 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-vGAl0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:25 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-hqMPNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:25 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-9gPLxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:26 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-qwY4D3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:26 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-I7JYKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:26 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_OIeRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:26 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-4FSGN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:26 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-S1o6lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:26 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Lhscj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:24:26 INFO - Running setup.py install for manifestparser 06:24:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:24:26 INFO - Running setup.py install for mozcrash 06:24:27 INFO - Running setup.py install for mozdebug 06:24:27 INFO - Running setup.py install for mozdevice 06:24:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:24:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:24:27 INFO - Running setup.py install for mozfile 06:24:27 INFO - Running setup.py install for mozhttpd 06:24:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:24:27 INFO - Running setup.py install for mozinfo 06:24:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:24:27 INFO - Running setup.py install for mozInstall 06:24:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:24:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:24:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:24:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:24:27 INFO - Running setup.py install for mozleak 06:24:28 INFO - Running setup.py install for mozlog 06:24:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Running setup.py install for moznetwork 06:24:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Running setup.py install for mozprocess 06:24:28 INFO - Running setup.py install for mozprofile 06:24:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Running setup.py install for mozrunner 06:24:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:24:28 INFO - Running setup.py install for mozscreenshot 06:24:28 INFO - Running setup.py install for moztest 06:24:29 INFO - Running setup.py install for mozversion 06:24:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:24:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:24:29 INFO - Cleaning up... 06:24:29 INFO - Return code: 0 06:24:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:29 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 0x103641a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aaa46cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034e5d30>, '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 0x103309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034dcb20>, '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.NNDAbnhVhW/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.1125oA5XA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 06:24:29 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 06:24:29 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 06:24:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNDAbnhVhW/Render', 06:24:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:29 INFO - 'HOME': '/Users/cltbld', 06:24:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:29 INFO - 'LOGNAME': 'cltbld', 06:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:29 INFO - 'MOZ_NO_REMOTE': '1', 06:24:29 INFO - 'NO_EM_RESTART': '1', 06:24:29 INFO - 'PAGER': '/bin/cat', 06:24:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:29 INFO - 'PWD': '/builds/slave/test', 06:24:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:29 INFO - 'SHELL': '/bin/bash', 06:24:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1125oA5XA1/Listeners', 06:24:29 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 06:24:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:29 INFO - 'USER': 'cltbld', 06:24:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:29 INFO - 'XPC_FLAGS': '0x0', 06:24:29 INFO - 'XPC_SERVICE_NAME': '0', 06:24:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:29 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-o5TBlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:29 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)) 06:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:29 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Yuh1Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:29 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)) 06:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:29 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-jEki99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:29 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)) 06:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:29 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-hKZM5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:29 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)) 06:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:29 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-4e7HuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:30 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)) 06:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:30 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-kFOqYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:30 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)) 06:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:30 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-OcfjFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:30 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)) 06:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:30 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-OYqSsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:30 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)) 06:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:30 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-yu2r7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:30 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)) 06:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:30 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-WXVGbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:30 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-pzUSzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:30 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)) 06:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:30 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-1C4WRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:30 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Zt9pzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:30 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)) 06:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:30 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Wo5sXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:31 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-r2yOZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:31 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)) 06:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:31 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-26LSU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:31 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)) 06:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:31 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-V2iz_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:31 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)) 06:24:31 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)) 06:24:31 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)) 06:24:31 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)) 06:24:31 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)) 06:24:31 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)) 06:24:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24:31 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 06:24:31 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 06:24:31 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 06:24:31 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 06:24:31 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 06:24:31 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 06:24:33 INFO - Downloading blessings-1.6.tar.gz 06:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:24:33 INFO - Installing collected packages: blessings 06:24:33 INFO - Running setup.py install for blessings 06:24:34 INFO - Successfully installed blessings 06:24:34 INFO - Cleaning up... 06:24:34 INFO - Return code: 0 06:24:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:34 INFO - Reading from file tmpfile_stdout 06:24:34 INFO - Current package versions: 06:24:34 INFO - blessings == 1.6 06:24:34 INFO - blobuploader == 1.2.4 06:24:34 INFO - docopt == 0.6.1 06:24:34 INFO - manifestparser == 1.1 06:24:34 INFO - mozInstall == 1.12 06:24:34 INFO - mozcrash == 0.17 06:24:34 INFO - mozdebug == 0.1 06:24:34 INFO - mozdevice == 0.48 06:24:34 INFO - mozfile == 1.2 06:24:34 INFO - mozhttpd == 0.7 06:24:34 INFO - mozinfo == 0.9 06:24:34 INFO - mozleak == 0.1 06:24:34 INFO - mozlog == 3.1 06:24:34 INFO - moznetwork == 0.27 06:24:34 INFO - mozprocess == 0.22 06:24:34 INFO - mozprofile == 0.28 06:24:34 INFO - mozrunner == 6.11 06:24:34 INFO - mozscreenshot == 0.1 06:24:34 INFO - mozsystemmonitor == 0.0 06:24:34 INFO - moztest == 0.7 06:24:34 INFO - mozversion == 1.4 06:24:34 INFO - psutil == 3.1.1 06:24:34 INFO - requests == 1.2.3 06:24:34 INFO - wsgiref == 0.1.2 06:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:34 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 0x103641a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aaa46cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034e5d30>, '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 0x103309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034dcb20>, '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.NNDAbnhVhW/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.1125oA5XA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 06:24:34 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 06:24:34 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 06:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNDAbnhVhW/Render', 06:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:34 INFO - 'HOME': '/Users/cltbld', 06:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:34 INFO - 'LOGNAME': 'cltbld', 06:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:34 INFO - 'MOZ_NO_REMOTE': '1', 06:24:34 INFO - 'NO_EM_RESTART': '1', 06:24:34 INFO - 'PAGER': '/bin/cat', 06:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:34 INFO - 'PWD': '/builds/slave/test', 06:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:34 INFO - 'SHELL': '/bin/bash', 06:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1125oA5XA1/Listeners', 06:24:34 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 06:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:34 INFO - 'USER': 'cltbld', 06:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:34 INFO - 'XPC_FLAGS': '0x0', 06:24:34 INFO - 'XPC_SERVICE_NAME': '0', 06:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:34 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)) 06:24:34 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)) 06:24:34 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)) 06:24:34 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)) 06:24:34 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)) 06:24:34 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)) 06:24:34 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)) 06:24:34 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)) 06:24:34 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)) 06:24:34 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)) 06:24:34 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)) 06:24:34 INFO - Cleaning up... 06:24:34 INFO - Return code: 0 06:24:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:34 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 0x103641a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aaa46cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034e5d30>, '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 0x103309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034dcb20>, '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.NNDAbnhVhW/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.1125oA5XA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 06:24:34 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 06:24:34 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 06:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNDAbnhVhW/Render', 06:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:34 INFO - 'HOME': '/Users/cltbld', 06:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:34 INFO - 'LOGNAME': 'cltbld', 06:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:34 INFO - 'MOZ_NO_REMOTE': '1', 06:24:34 INFO - 'NO_EM_RESTART': '1', 06:24:34 INFO - 'PAGER': '/bin/cat', 06:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:34 INFO - 'PWD': '/builds/slave/test', 06:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:34 INFO - 'SHELL': '/bin/bash', 06:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1125oA5XA1/Listeners', 06:24:34 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 06:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:34 INFO - 'USER': 'cltbld', 06:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:34 INFO - 'XPC_FLAGS': '0x0', 06:24:34 INFO - 'XPC_SERVICE_NAME': '0', 06:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:34 INFO - Downloading/unpacking jsonschema 06:24:34 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 06:24:34 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 06:24:34 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 06:24:34 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 06:24:34 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 06:24:34 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 06:24:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:24:37 INFO - Downloading/unpacking functools32 (from jsonschema) 06:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:37 INFO - Downloading functools32-3.2.3-2.tar.gz 06:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:24:37 INFO - warning: no files found matching '*.txt' 06:24:37 INFO - no previously-included directories found matching 'build' 06:24:37 INFO - no previously-included directories found matching 'dist' 06:24:37 INFO - no previously-included directories found matching '.git*' 06:24:37 INFO - Installing collected packages: jsonschema, functools32 06:24:37 INFO - Running setup.py install for functools32 06:24:38 INFO - warning: no files found matching '*.txt' 06:24:38 INFO - no previously-included directories found matching 'build' 06:24:38 INFO - no previously-included directories found matching 'dist' 06:24:38 INFO - no previously-included directories found matching '.git*' 06:24:38 INFO - Successfully installed jsonschema functools32 06:24:38 INFO - Cleaning up... 06:24:38 INFO - Return code: 0 06:24:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103641a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103647570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aaa46cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034e5d30>, '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 0x103309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034dcb20>, '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.NNDAbnhVhW/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.1125oA5XA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 06:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:24:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNDAbnhVhW/Render', 06:24:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:38 INFO - 'HOME': '/Users/cltbld', 06:24:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:38 INFO - 'LOGNAME': 'cltbld', 06:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:38 INFO - 'MOZ_NO_REMOTE': '1', 06:24:38 INFO - 'NO_EM_RESTART': '1', 06:24:38 INFO - 'PAGER': '/bin/cat', 06:24:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:38 INFO - 'PWD': '/builds/slave/test', 06:24:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:38 INFO - 'SHELL': '/bin/bash', 06:24:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1125oA5XA1/Listeners', 06:24:38 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 06:24:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:38 INFO - 'USER': 'cltbld', 06:24:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:38 INFO - 'XPC_FLAGS': '0x0', 06:24:38 INFO - 'XPC_SERVICE_NAME': '0', 06:24:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:38 INFO - Downloading/unpacking flake8 06:24:38 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 06:24:38 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 06:24:38 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 06:24:38 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 06:24:38 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 06:24:38 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 06:24:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:24:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:24:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:24:41 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 06:24:41 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 06:24:41 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 06:24:41 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 06:24:41 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 06:24:41 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 06:24:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:24:41 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 06:24:41 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 06:24:41 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 06:24:41 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 06:24:41 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 06:24:41 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 06:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:24:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:24:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:24:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:24:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:24:42 INFO - no previously-included directories found matching 'docs/_build' 06:24:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:24:42 INFO - Running setup.py install for pep8 06:24:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:24:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:24:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:24:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:24:42 INFO - no previously-included directories found matching 'docs/_build' 06:24:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:24:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:24:42 INFO - Cleaning up... 06:24:42 INFO - Return code: 0 06:24:42 INFO - Running post-action listener: _resource_record_post_action 06:24:42 INFO - Running post-action listener: _start_resource_monitoring 06:24:42 INFO - Starting resource monitoring. 06:24:42 INFO - ##### 06:24:42 INFO - ##### Finished create-virtualenv step (success) 06:24:42 INFO - ##### 06:24:42 INFO - ##### 06:24:42 INFO - ##### Running install step. 06:24:42 INFO - ##### 06:24:42 INFO - Running pre-action listener: _resource_record_pre_action 06:24:42 INFO - Running main action method: install 06:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:42 INFO - Reading from file tmpfile_stdout 06:24:42 INFO - Detecting whether we're running mozinstall >=1.0... 06:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:24:42 INFO - Reading from file tmpfile_stdout 06:24:42 INFO - Output received: 06:24:42 INFO - Usage: mozinstall [options] installer 06:24:42 INFO - Options: 06:24:42 INFO - -h, --help show this help message and exit 06:24:42 INFO - -d DEST, --destination=DEST 06:24:42 INFO - Directory to install application into. [default: 06:24:42 INFO - "/builds/slave/test"] 06:24:42 INFO - --app=APP Application being installed. [default: firefox] 06:24:42 INFO - mkdir: /builds/slave/test/build/application 06:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:25:16 INFO - Reading from file tmpfile_stdout 06:25:16 INFO - Output received: 06:25:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:25:16 INFO - Running post-action listener: _resource_record_post_action 06:25:16 INFO - ##### 06:25:16 INFO - ##### Finished install step (success) 06:25:16 INFO - ##### 06:25:16 INFO - ##### 06:25:16 INFO - ##### Running run-tests step. 06:25:16 INFO - ##### 06:25:16 INFO - Running pre-action listener: _resource_record_pre_action 06:25:16 INFO - Running main action method: run_tests 06:25:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:25:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:25:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:25:16 INFO - 2016-05-10 06:25:16.128 screenresolution[1643:7441] starting screenresolution argv=screenresolution get 06:25:16 INFO - 2016-05-10 06:25:16.130 screenresolution[1643:7441] Display 0: 1600x1200x32@60 06:25:16 INFO - 2016-05-10 06:25:16.137 screenresolution[1644:7443] starting screenresolution argv=screenresolution list 06:25:16 INFO - Available Modes on Display 0 06:25:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:25:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:25:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:25:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:25:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:25:16 INFO - Intel Iris: 06:25:16 INFO - Chipset Model: Intel Iris 06:25:16 INFO - Type: GPU 06:25:16 INFO - Bus: Built-In 06:25:16 INFO - VRAM (Dynamic, Max): 1536 MB 06:25:16 INFO - Vendor: Intel (0x8086) 06:25:16 INFO - Device ID: 0x0a2e 06:25:16 INFO - Revision ID: 0x0009 06:25:16 INFO - Displays: 06:25:16 INFO - Display: 06:25:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:25:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:25:16 INFO - Display Serial Number: 1600x1200 60 06:25:16 INFO - Main Display: Yes 06:25:16 INFO - Mirror: Off 06:25:16 INFO - Online: Yes 06:25:16 INFO - Rotation: Supported 06:25:16 INFO - Return code: 0 06:25:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:25:16 INFO - Python 2.7.3 06:25:16 INFO - Return code: 0 06:25:16 INFO - grabbing minidump binary from tooltool 06:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034e5d30>, '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 0x103309db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034dcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:25:16 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 06:25:16 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 06:25:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:25:16 INFO - Return code: 0 06:25:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:25:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:25:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:25:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:25:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:25:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:25:17 INFO - Return code: 0 06:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 06:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --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 06:25:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NNDAbnhVhW/Render', 06:25:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:17 INFO - 'HOME': '/Users/cltbld', 06:25:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:17 INFO - 'LOGNAME': 'cltbld', 06:25:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:25:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:17 INFO - 'MOZ_NO_REMOTE': '1', 06:25:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:25:17 INFO - 'NO_EM_RESTART': '1', 06:25:17 INFO - 'PAGER': '/bin/cat', 06:25:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:17 INFO - 'PWD': '/builds/slave/test', 06:25:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:25:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:17 INFO - 'SHELL': '/bin/bash', 06:25:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1125oA5XA1/Listeners', 06:25:17 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 06:25:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:17 INFO - 'USER': 'cltbld', 06:25:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:17 INFO - 'XPC_FLAGS': '0x0', 06:25:17 INFO - 'XPC_SERVICE_NAME': '0', 06:25:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 06:25:17 INFO - mozversion application_buildid: 20160510031712 06:25:17 INFO - mozversion application_changeset: 8b4e5ab50377a26e6610f21a0f8233467de19e9b 06:25:17 INFO - mozversion application_display_name: Nightly 06:25:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:25:17 INFO - mozversion application_name: Firefox 06:25:17 INFO - mozversion application_remotingname: firefox 06:25:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:25:17 INFO - mozversion application_vendor: Mozilla 06:25:17 INFO - mozversion application_version: 49.0a1 06:25:17 INFO - mozversion platform_buildid: 20160510031712 06:25:17 INFO - mozversion platform_changeset: 8b4e5ab50377a26e6610f21a0f8233467de19e9b 06:25:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:25:17 INFO - mozversion platform_version: 49.0a1 06:25:17 INFO - using testdate: 1462886717 06:25:17 INFO - actual date: 1462886717 06:25:17 INFO - starting webserver on 'localhost:49278' 06:25:17 INFO - SUITE-START | Running 2 tests 06:25:17 INFO - TEST-START | dromaeo_css 06:25:17 INFO - operating with platform_type : mac_ 06:25:17 INFO - Initialising browser for dromaeo_css test... 06:25:17 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpTi71Qw/profile http://localhost:49278/getInfo.html) 06:25:20 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 06:25:20 INFO - PROCESS | 1662 | colorDepth:24 06:25:20 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 06:25:20 INFO - PROCESS | 1662 | __metrics 06:25:20 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 06:25:21 INFO - TEST-INFO | 1662: exit 0 06:25:21 INFO - Browser initialized. 06:25:21 INFO - Running cycle 1/1 for dromaeo_css test... 06:25:21 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpTi71Qw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:25:33 INFO - PROCESS | 1665 | RSS: Main: 249937920 06:25:33 INFO - PROCESS | 1665 | 06:26:23 INFO - PROCESS | 1665 | 1462886783087 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] 06:28:33 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 06:28:34 INFO - PROCESS | 1665 | RSS: Main: 263532544 06:28:34 INFO - PROCESS | 1665 | 06:31:36 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 06:31:37 INFO - PROCESS | 1665 | RSS: Main: 275361792 06:31:37 INFO - PROCESS | 1665 | 06:34:38 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 06:34:39 INFO - PROCESS | 1665 | RSS: Main: 277225472 06:34:39 INFO - PROCESS | 1665 | 06:37:41 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 06:37:42 INFO - PROCESS | 1665 | RSS: Main: 278872064 06:37:42 INFO - PROCESS | 1665 | 06:40:44 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 06:40:45 INFO - PROCESS | 1665 | RSS: Main: 281939968 06:40:45 INFO - PROCESS | 1665 | 06:43:47 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 06:43:48 INFO - PROCESS | 1665 | RSS: Main: 282877952 06:43:48 INFO - PROCESS | 1665 | 06:43:48 INFO - PROCESS | 1665 | __start_tp_report 06:43:48 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 06:43:48 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 06:43:48 INFO - PROCESS | 1665 | |i|pagename|runs| 06:43:48 INFO - PROCESS | 1665 | |0;dojo.html;2964.4960356739352;3497.772644778091;3560.163361610021;3571.464280357946;3581.98209008955;4626.884327891796;4869.123557759602;5789.102689083188;5812.505936995355;5815.447532484407;4709.434867815867;4723.763811809405;4733.763311834412;5331.813386531472;5890.82183563288;152.29039831330755;5188.584913206953;5290.074237008508;5394.514493695567;5434.972825135868;4879.585235255007;5218.112920803454;5234.424213336549;5258.6318957672975;5281.841544753664;5253.185756207794;5272.261883336336;5277.419483856811;5285.577153827685;5300.443453437391;5194.194899790538;5281.735913204325;5312.415634280226;5315.176147697074;5341.03861304965;5198.194279886624;5203.505666961632;5241.292425522543;5261.421243663194;5275.024120537674;4893.559579637814;5593.3847276799515;5826.708664566797;5882.911756323659;5934.6142500737315;6108.22065524731;6234.220722409699;6271.78048768291;6305.148804911324;6312.053192021233;5447.673139611636;6082.60463069899;6140.017597184429;6275.6548389838545;6322.399372059647;5236.293100431431;5886.381929897342;5892.234009578728;5899.233099697012;5903.114532820111;6218.906716399258;6328.7468501260355;6349.809505714836;6368.076628888785;6407.743690252338;6286.842828929313;6296.307406185316;6296.338884417162;6301.779437719658;6321.810345689637;6296.275928268308;6324.146240257506;6329.398707122816;6365.140706004723;6365.777197798055;6111.257501106225;6153.2000839890525;6213.689315534205;6314.71583778731;6329.715162817684;6297.937020629826;6299.275583307978;6301.96849015752;6309.810705678837;6316.30520642729;4932.482089380635;4982.078315511642;5014.373203349582;5021.347224860745;5058.570021548136;4005.2590270799415;4286.671131949043;4376.912461750747;4417.977910110429;4529.886752831206;5757.280339957505;5828.213191219216;5897.64614123154;5905.557083218776;5929.881402371929;6210.347913469021;6243.406876346739;6262;6271.27880293763;6291.905621415683;5961.314448838352;5965.970170149121;5969.068380901369;5998.130271110665;6017.939820601826;4075.735077219971;5072;5111.514406131411;5476.67139971603;5504.779808807683;6424.775132870327;6441.806745797634;6452.322506136788;6530.934690653033;6532.771353002717;5491.643043202179;5985.820425387245;6283.717232724447;6293.181886354744;6299.464545513682;5452.945470545244;6320.557560970872;6435.09908612804;6462.579932304385;6501.739930402731;6158.661273629814;6239.500839932885;6247.406496382836;6296.150019747459;6301.243850737941;5307.99148161848;6264.091706702411;6280.7487700491465;6290.811275661555;6299.748010079728;4998.625103117353;6091.60404573719;6145.10895920098;6186.752529898934;6236.594621349779;6261.530385221217;6270.561060725706;6277.058441233668;6301.243850737941;6319.6208227506495;5300.9359574013715;6152.569320147547;6168.475679567287;6183.196184496167;6185.938140618537;6000.369961154016;6143.112737013596;6167.599106058092;6207.286162091417;6209.316975132822;6076.409703073272;6137.41694539018;6143.8326717923455;6146.938530614815;6163.229596300463 06:43:48 INFO - PROCESS | 1665 | |1;ext.html;513.3147248423354;523.9528442440179;529.8066205834868;542.1623591551054;544.8283790605959;38726;42261;42316;42441.99999999996;42473.36289955653;43004.13991720164;43027;43190.78404607972;43237.91905202364;43256.78371608137;9597.424154550732;9678.322517423783;9702.563384647709;9745.171660408874;9803.460809655466;9607.183389411874;9609.423434593948;9678.16114938163;9688.951555242214;9723.854142187873;9642.325037247396;9717.757056073619;9734.853977190347;9737.853932191023;9753.122219000288;9684.51577421126;9704.95147524265;9716.417014979124;9732.659356922544;9769.560369783378;9597.616095356247;9700.563474643657;9701.417914925056;9709.757256068584;9722.465264410455;39562.802185989174;39624.60375396238;39885.80057099696;39973;39987;2941.7793665475174;3407.2743778492686;3430.1767575781882;3479.165000399911;3757.5490941087246;28708.856455717796;28881.133565993056;28896.98860539871;29577;30220.546691799642;2713.2945434187054;2771.9445611087867;2779.0134502251613;2880.5391137417914;2965.0363631819746;486931;491089.54455227853;491314;492325;492450;35519.64480355215;64488.67755661192;64712.352876471574;64846;65107.34892651108;33600.83199584035;36730.63269367326;38058.809705951295;38194;38235.80882095627;14964;15174.924125379302;15187.012844165094;15327.540173794803;15392.999455035611;12623.873761262454;12932.353382330846;12952.546660866825;13013.544525941546;13023.088383813041;8274.420790544604;8333.95833020831;8360.28937540316;8410.116937721452;8440.83118337642;2893.7846104636105;3361.546191264148;3383.509391138271;3385.39062968668;3395.2175108068463;922.3082687984012;936.513013233115;1016.8423894296247;1026.4252018869456;1053.4679986606714;22433.551328973655;26667.199984000123;30259;30406;30458.086257412313;1147.1511081799574;1167.6555416152255;1185.958491452795;1195.0260537661777;1247.1581682364367;13707.383167757474;15358.462453814287;15375.384984600714;15487.303071361815;15763.605909852116;639015;644562;648488;651596;651606;58621;60752.392476074674;60922.39077609167;61368;61558.69220653958;1439.6832696806687;1460.7297649934583;1475.5942115918208;1477.2613693153423;1477.6601381682274;27632;28943.855280723463;29757.70242297636;29939.80240790344;30131.397372051997;54443.183352248954;54484.91030179295;54987.72506137444;55045.9999999984;55095.449045509034;506521;523369;523519;524874;526316;27152;27244.182674519798;27426.725732743216;27595.896164153208;27660.308492287855;46067.539324607664;46194.53805461902;46362;47259.76370118128;48051.75974120107;38204.617953821216;38281.425778612786;38383.08234284407;38872;39245.01887452837;28551.714482854906;29837.10488685343;37045.51817927253;37242.25515489729;38087;29145.562816557343;32216.83891580621;37530.68642597496;37974.43038354482;38211.23577528489;31799.52300715445;33064.50403244001;33148;33176.83411582927;33643;19317.4204773857;21014.949252537008;21842.453938651026;23616.881915591;25205.369865753502 06:43:48 INFO - PROCESS | 1665 | |2;jquery.html;389.3361818100141;390.30525664317514;390.31889353078884;396.0830676982783;414.17992375097305;20201.696974545375;21301.573968520657;21444.57110857784;21564.784352156494;22362.66456003161;20816.47958801031;20956.68564971523;21524.89237553814;21602.56794864102;21639.45901352467;5825.417458254173;5908.350081491032;5922.082077278029;6013.879722405549;6027.246594175728;5170.9482905171035;5601.271834661488;5828.475437210672;5896.587238893279;5920.437558431942;4826.879328016793;5762.3949485304065;5769.076947688371;5770.653760774346;5785.450382213683;5392.99999999998;5393.406725260218;5419.105847535152;5677.063284558043;5748.597598168109;4746.691465054795;4794.832180873653;4808.591269742076;4809.903801923977;4820.68665536739;26112;26422.6036609451;26934.057307994128;27160.32099197516;27248.31879203016;2175.3582693105573;2453.129139155592;2462.9014839406404;2564.8332858364147;2568.961465578018;12161.51353945841;14497.92751036238;14958.177300248482;15135.318910649048;15242.923785381114;1682.2513981278337;1702.3956495444063;1714.2457318779698;1726.2577091850499;1739.939102131432;121859.39070304592;122322;123740;124420.37789810993;124603.13095303578;10888.292261003167;11262.774744505065;11509.25189862673;11518.712032199262;11721.355325457182;11929.642110736691;14390;14476.131432114107;14479.05886117399;14516.709665806624;8704.216620504185;8894.28845692343;8948.149925757043;8997.965233998044;9045.909540904508;7551.697932082765;8543.786405339917;8850.026497085315;8855.291576673852;9002.414843035182;6849.897251541231;6982.26686197952;6986.126734158231;7002.684879180449;7033.261507541737;1859.9349022784409;1893.5644801695687;1894.5642502224289;1897.8671492995359;1920.6926891697262;929.6699671616614;948.3598570964572;955.5317894231777;1011.7521207304111;1054.9578016879238;18474.722879156823;20580.58838823215;21359;21484.462888427603;22064.558708826054;909.072745799281;973.5980188528496;991.965281215154;996.2279233593878;1013.4122209118693;8884.911150888538;9134.314926380548;9457.574409151604;11247.887521124683;11512.712182195344;628624;635255;639590;645931.7703411453;653941;109350;122242;126079;136386;141737.58262417244;787.338635546144;1028.4960369418932;1035.3529044347283;1038.5793753529833;1071.839224116373;18889.527761806065;18915.71626425577;18969.810301896803;18974.766640168345;18981.525461863563;51382.743086285824;51701;51972.480275196765;54635;54964;73130;73202.63398682972;74094;74155;77293.2270677286;7830.41271904598;7857.685692572461;7931.762047138595;8171.632276547689;8305.294050005818;11539.596114135966;12038.75922481563;12087.81868271959;12374.443150058449;12396.132270741322;10502.632407865687;10667.786644266916;10685.626003090165;10828.837567436338;10860.348379097279;9025.638974440948;9876.703698889045;10433.634822781167;10499;10884.673459796219;5892.823215303548;6169.796889606484;7149.463790215858;10632;11098.334099954029;6927.995440660975;7880.014998125234;7955.24425179607;8029.678812847421;8240.258376746122;8123.75628731139;10026.097651211427;10645.733856653645;10742.73143171427;10982.286151400453 06:43:48 INFO - PROCESS | 1665 | |3;mootools.html;1605.8956167849085;1639.4016184092807;1900.2019151956176;1970.4187264756895;1973.2994786850677;8119.959400202991;8821.558922053888;8905.109489051092;9387.718368448941;9444.386114902534;9011.098890110985;9085.591148398322;9141.634334626608;9145.405548639334;9149.176574108329;2428.1501474483966;2444.8899799509063;2462.6059830427134;2466.5683505386487;2468.6543883856275;2398.8680622565753;2472.208893154191;2472.5796614575565;2474.6659201007906;2478.962815557759;2385.189035727852;2435.2815919303757;2460.2619214235656;2460.59400198967;2461.4953934443397;2403.8557686538866;2411.252511721372;2430.793382562484;2432.3675844280524;2450.987745061281;1916.3005502991448;2386.806596701649;2416.9395765105837;2432.990309021754;2434.160214725917;9121.863172052424;9146.451212927246;9220.953895230548;9237.769055773591;9240.399374040666;5434.864128396782;5532.5297349724915;5601.243832082658;5602.551795856362;5607.214989901417;3609.5848977367677;3613.7831730096277;3653.5798383185743;3656.1042544576485;3685.6130106338715;1013.164139584838;1026.768976980181;1030.8505266736356;1031.9380837149795;1035.9637412690595;11996.340201288926;12310.199837010565;12420.316882571455;12460.937695311555;12497.93751031239;3836.3286424875537;4125.566815484391;4125.989132662517;4461.219286624828;4580.1755683976535;10281.485925703684;10295.43375114361;10444.477776111164;10458.581656733797;10470.947645261725;4643.373144625432;5319.069162896555;5436.53789427903;5500.064988951888;5521.944780552223;4208.179405016053;4937.136001199776;5062.7468626568525;5072.087024335655;5091.949080509222;4125.66994640428;4133.91732165361;4141.171765646883;4152.231837110145;4176.373543968429;1305.1190446448609;1360.4694169273992;1365.5834970334145;1369.6438925879343;1377.4765589076287;774.7908064822466;777.312078810257;801.5431204213543;813.6541969662869;835.8787975743484;5859.707014649336;5959.255093113361;6107.328193898667;6135.815925522242;6145.016797312409;429.39884162173206;433.5880913132537;455.9475660299042;457.0721435485969;458.3056669146246;3995.9200815983518;4054.087830238173;4073.6130067643526;4103.9179216415505;4118.5057793065025;10399.84400233997;10936.56253749841;10938.507767150497;11140.941610546985;11159.051480624075;10631.84052239217;10838.945805271082;10990.17573681977;11097.667069987752;11132.276402033842;6790.660466976631;7379.667914943733;7513;8303.501789892747;8540.829183416297;5490.313710786152;5808.767649293981;5860.267466566679;5876.647401155944;6028.065649824284;8679.91320086791;10220.233482488695;10311.484425778832;10323.535440905027;10438.425886576008;8342.582870856311;10552.366857988545;10617.469126543796;10681.786364272826;10682.89317106819;6994.685239164148;7417.554946703215;7661.770146895602;7743.264389882952;7769.028871391076;8652.697155599524;8657.696980605648;8680.435771674822;8742.300615950835;8755.730419089068;6633.502487313374;7559.5464272143845;7776.339011184113;7841.5687137208;7856.685732570633;7532.832410976307;7566.848663026819;7592.39260859141;7653.693852245848;7715.57564333967;7117.181524124585;7202.423806095395;7214.639268036683;7226.168990566152;7226.4218862491925;4893.584045356185;5057.822976195963;5091.770870310771;5092.745362731923;5104.310918026019;4965.875853103556;5015;5100.872478188075;5126.2054381570915;5290.206469029677 06:43:48 INFO - PROCESS | 1665 | |4;prototype.html;260.3802948981424;315.1019594156653;320.97111259986605;321.71849631572377;324.77265913860276;4738.028704115656;4791.592714619262;5364.383095943967;5391.353037635485;5423.755930983105;4515.9548404515945;4870.975645121778;5163.812323165665;5327.844281460458;5334.839954801362;3859.517560304962;3937.4290727844445;4063.3904914262803;4076.7961601919787;4078.938815917764;3173.8413079346055;3864.8212295249937;4045.3325201341745;4053.391991201314;4105.3020986432375;3667.853285868562;3918.784466854322;3995.360742281221;4071.145059537501;4078.9592104079024;3825.5600605930395;4046.6731629312967;4081.5918408159246;4083.5508094109623;4086.9386959195635;3000.4599172149005;3278.9016329510155;3523.6300188480354;3525.5945566259697;3547.5210846535647;4004.2391945530258;4398.450193725785;4810;5017.247412888059;5130.281760553488;4261.007936389163;4291.605228300815;4628.305754136873;4672.649551283667;4723.551262630079;4664.463586687541;5119.360079990001;5119.900840655313;5494.890102197974;5665.291838520185;3641.198936234024;3908.2965066288057;3928.0376307804486;3940.2316548273097;3960.742551734128;5755.3381361143165;5893.322267939199;5923.229980102559;5944;5954.523638108941;3505.807180605091;3888.7083468739957;3962.821673024721;3988.4017397390044;3994.960050399517;3591.3894637911617;3846.9615303847163;4022.939655905164;4060.796960151981;4095.7917414362832;3940.9211815763524;3945.447637330776;4687.367205427224;4701.553352431513;4756.905911640342;4657.534246575383;4836.920124346565;5631.6902570359025;5731.971340143273;5740.339860916049;1290.5612091888802;1333.9799903001463;1357.8166947461966;1364;1364.0656150536715;801.9975031210986;805.7099444200084;808.623989844725;841.3185319890908;850.7787975126512;4653.837115700934;4664.953350466452;4683.2038553446;4859.469267180827;5125.205593133071;4789.377380940456;5421.83734487966;5740.42595740431;5928.466438020599;5934.584579079509;4279.721818081877;4598.965232822655;4800.35195248644;4945.826896058621;5359.169328754049;2493.875306234681;2557.7698007179442;2925.5611658251005;3114.5828647965573;3147.7578094562637;4943.8516844494725;5061.419415429043;5410.810621628224;6185.907211391833;6191.226096737908;5444.537214336747;5521.558275337963;5626.774929002794;6094.512439004869;6133.877322453526;5295.94081183757;6208.50331973441;6228.601988234472;6241.407066328691;6246.437820596168;4939.728314942569;4978.751062446936;5691.800786972436;5888.293404791452;6012.759489620541;4722.645801564965;5832.096025116114;5865.237519122486;5867.413258674099;5886.676232807236;5248.921266180934;5466.731306507755;6117.602355846856;6181.35095814933;6198.566100373111;3459.3773120837486;3597.4603809428795;3630.3646861799607;3942.5268967724055;3967.166894951977;4759.833405830779;5049.141645920276;5834.970825145847;5872.0898260769645;5885.3820348864465;4466.731996080245;4977.0792403405485;5211.348581427322;5503.614746967673;5732.856678583069;4990.4011518618;5243.951209757987;5375.274337964324;5685.914711279417;5696.515796157208;4629.629629629554;4903.926441103457;5116.616253780907;5578.442155784389;5623.831285061455;5286.383240296078;5479.76693750689;5629.014922388647;5689.971550142222;5697.803461273179;5301.973490132525;5583.581231407742;5609.261129050007;5613.270274864241;5653 06:43:48 INFO - PROCESS | 1665 | |5;yui.html;697.6686074114796;702.5714314268296;712.6223101756069;751.3913729878799;778.217891019526;14174.00781945263;14585.34365953532;14664.706705865876;14681.972261941668;14741.48404805832;13905.374258158381;14002;14057;14057.156570605744;14064;707.1690763353065;889.822035592884;895.7268033249873;910.744991402405;911.2800887299026;904.3082042237694;909.2135302962922;910.2990697163181;912.0560220172123;922.8431166701644;929.8930622978377;941.9576119074624;976.9951150244239;981.4798156976814;982.8230918434715;926.8239034583407;928.1043792740005;958.0611001218809;972.8589354543587;976.2287792643803;686.7115811359191;697.6442014572553;706.0785674694522;720.7009091227187;721.4985585018362;14253.857461425358;14496;14692.559223223321;14731.189784561844;14868.925655371653;9347.626094956193;12012.519499220021;12631.747365052739;12644.304563249018;12807.551735689207;9973.75065623358;10068.194544436428;10100.595976161017;10287.279890407675;10836;3539.4513850353237;3604.4232922732235;3611.422172452395;3694.5197124373926;3706.592274849764;79263;80345;80643;80983;81745.18254817494;9502.524873756285;9525.428474291564;9567.952160239154;9743.707688769347;9875.160611348116;15811.525654230392;21712.457188570097;21722.456938576346;21724;21789.782102178775;7444.925550744531;7523.360514356232;7592.050993625797;7667.961660191775;7743.7676869694;4039.6566291864933;4041.1715598302276;4085.4484644573195;4128.752274863517;4130.938035929464;3507.4212754895666;3581.3195492856794;3581.462780582933;3591.1381268495375;3598.442241452579;645.6674812471581;660.2868901586276;661.1075048684238;661.4047357378398;662.0367365483211;500.50200050949536;502.9371328583927;516;541.8970395624818;551.7710150287586;8040.8793868092025;8149.14433984435;8159.102498725136;8248.917510824815;8418.452800567944;489.87263311538544;493.39559040176215;494.3622726682611;500.7120905479364;508.4280184792109;3853.133045064838;3870.554886188068;3874.96125038746;3938.547067087264;4040.0505881117915;60034;81292.59353703311;85888;87017;87180;78810.21189788144;79885.80171297435;80195.19804801994;80283.59858200788;82741;64521.19309262189;65043.699126017214;65115;65713.67143164254;65743.99999999904;7016.6842492089;7473.925260747323;7700.961495192488;7723.652435640522;7857.410694197843;41736.79131604323;43121.92195195145;43523.69428917138;44451.33323000093;45229.54770452385;43838.684839454865;46795.76602116968;50463.74768126136;57690.846183076945;61133;9921.801563968824;10163.237757168094;10170.949145254226;10263.435511046964;10396;10753;11267.943660281646;11410.543578256777;11529.942350288195;11542.307461551998;8616.35377346714;10490.790184196427;10546.947265263625;10547.57809687604;10813.360543001752;10414.895851041392;10671.253012289066;10727.785444291227;11444.313341199555;11576.88423115758;10209.693709188736;10258.384496930208;10412.531436085243;10453.111485523816;10679.14566834667;8798.956005219932;8854.734357969272;8975.865362019706;9107.362484626012;9143.725688229364;8826.823463530822;8850.468971861708;8905.243054340453;8910.821783564163;8976.55117244122 06:43:48 INFO - PROCESS | 1665 | __end_tp_report 06:43:48 INFO - PROCESS | 1665 | __start_cc_report 06:43:48 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,423 06:43:48 INFO - PROCESS | 1665 | __end_cc_report 06:43:48 INFO - PROCESS | 1665 | __startTimestamp1462887828180__endTimestamp 06:43:48 INFO - PROCESS | 1665 | 06:43:48 INFO - PROCESS | 1665 | ------- Summary: start ------- 06:43:48 INFO - PROCESS | 1665 | Number of tests: 6 06:43:48 INFO - PROCESS | 1665 | 06:43:48 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5710.45 Median:6017.94 stddev:828.65 (13.8%) stddev-sans-first:802.70 06:43:48 INFO - PROCESS | 1665 | Values: 2964.5 3497.8 3560.2 3571.5 3582.0 4626.9 4869.1 5789.1 5812.5 5815.4 4709.4 4723.8 4733.8 5331.8 5890.8 152.3 5188.6 5290.1 5394.5 5435.0 4879.6 5218.1 5234.4 5258.6 5281.8 5253.2 5272.3 5277.4 5285.6 5300.4 5194.2 5281.7 5312.4 5315.2 5341.0 5198.2 5203.5 5241.3 5261.4 5275.0 4893.6 5593.4 5826.7 5882.9 5934.6 6108.2 6234.2 6271.8 6305.1 6312.1 5447.7 6082.6 6140.0 6275.7 6322.4 5236.3 5886.4 5892.2 5899.2 5903.1 6218.9 6328.7 6349.8 6368.1 6407.7 6286.8 6296.3 6296.3 6301.8 6321.8 6296.3 6324.1 6329.4 6365.1 6365.8 6111.3 6153.2 6213.7 6314.7 6329.7 6297.9 6299.3 6302.0 6309.8 6316.3 4932.5 4982.1 5014.4 5021.3 5058.6 4005.3 4286.7 4376.9 4418.0 4529.9 5757.3 5828.2 5897.6 5905.6 5929.9 6210.3 6243.4 6262.0 6271.3 6291.9 5961.3 5966.0 5969.1 5998.1 6017.9 4075.7 5072.0 5111.5 5476.7 5504.8 6424.8 6441.8 6452.3 6530.9 6532.8 5491.6 5985.8 6283.7 6293.2 6299.5 5452.9 6320.6 6435.1 6462.6 6501.7 6158.7 6239.5 6247.4 6296.2 6301.2 5308.0 6264.1 6280.7 6290.8 6299.7 4998.6 6091.6 6145.1 6186.8 6236.6 6261.5 6270.6 6277.1 6301.2 6319.6 5300.9 6152.6 6168.5 6183.2 6185.9 6000.4 6143.1 6167.6 6207.3 6209.3 6076.4 6137.4 6143.8 6146.9 6163.2 06:43:48 INFO - PROCESS | 1665 | 06:43:48 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:67562.75 Median:38332.25 stddev:149083.71 (388.9%) stddev-sans-first:149416.94 06:43:48 INFO - PROCESS | 1665 | Values: 513.3 524.0 529.8 542.2 544.8 38726.0 42261.0 42316.0 42442.0 42473.4 43004.1 43027.0 43190.8 43237.9 43256.8 9597.4 9678.3 9702.6 9745.2 9803.5 9607.2 9609.4 9678.2 9689.0 9723.9 9642.3 9717.8 9734.9 9737.9 9753.1 9684.5 9705.0 9716.4 9732.7 9769.6 9597.6 9700.6 9701.4 9709.8 9722.5 39562.8 39624.6 39885.8 39973.0 39987.0 2941.8 3407.3 3430.2 3479.2 3757.5 28708.9 28881.1 28897.0 29577.0 30220.5 2713.3 2771.9 2779.0 2880.5 2965.0 486931.0 491089.5 491314.0 492325.0 492450.0 35519.6 64488.7 64712.4 64846.0 65107.3 33600.8 36730.6 38058.8 38194.0 38235.8 14964.0 15174.9 15187.0 15327.5 15393.0 12623.9 12932.4 12952.5 13013.5 13023.1 8274.4 8334.0 8360.3 8410.1 8440.8 2893.8 3361.5 3383.5 3385.4 3395.2 922.3 936.5 1016.8 1026.4 1053.5 22433.6 26667.2 30259.0 30406.0 30458.1 1147.2 1167.7 1186.0 1195.0 1247.2 13707.4 15358.5 15375.4 15487.3 15763.6 639015.0 644562.0 648488.0 651596.0 651606.0 58621.0 60752.4 60922.4 61368.0 61558.7 1439.7 1460.7 1475.6 1477.3 1477.7 27632.0 28943.9 29757.7 29939.8 30131.4 54443.2 54484.9 54987.7 55046.0 55095.4 506521.0 523369.0 523519.0 524874.0 526316.0 27152.0 27244.2 27426.7 27595.9 27660.3 46067.5 46194.5 46362.0 47259.8 48051.8 38204.6 38281.4 38383.1 38872.0 39245.0 28551.7 29837.1 37045.5 37242.3 38087.0 29145.6 32216.8 37530.7 37974.4 38211.2 31799.5 33064.5 33148.0 33176.8 33643.0 19317.4 21014.9 21842.5 23616.9 25205.4 06:43:48 INFO - PROCESS | 1665 | 06:43:48 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:36276.06 Median:27047.19 stddev:106638.79 (394.3%) stddev-sans-first:106903.90 06:43:48 INFO - PROCESS | 1665 | Values: 389.3 390.3 390.3 396.1 414.2 20201.7 21301.6 21444.6 21564.8 22362.7 20816.5 20956.7 21524.9 21602.6 21639.5 5825.4 5908.4 5922.1 6013.9 6027.2 5170.9 5601.3 5828.5 5896.6 5920.4 4826.9 5762.4 5769.1 5770.7 5785.5 5393.0 5393.4 5419.1 5677.1 5748.6 4746.7 4794.8 4808.6 4809.9 4820.7 26112.0 26422.6 26934.1 27160.3 27248.3 2175.4 2453.1 2462.9 2564.8 2569.0 12161.5 14497.9 14958.2 15135.3 15242.9 1682.3 1702.4 1714.2 1726.3 1739.9 121859.4 122322.0 123740.0 124420.4 124603.1 10888.3 11262.8 11509.3 11518.7 11721.4 11929.6 14390.0 14476.1 14479.1 14516.7 8704.2 8894.3 8948.1 8998.0 9045.9 7551.7 8543.8 8850.0 8855.3 9002.4 6849.9 6982.3 6986.1 7002.7 7033.3 1859.9 1893.6 1894.6 1897.9 1920.7 929.7 948.4 955.5 1011.8 1055.0 18474.7 20580.6 21359.0 21484.5 22064.6 909.1 973.6 992.0 996.2 1013.4 8884.9 9134.3 9457.6 11247.9 11512.7 628624.0 635255.0 639590.0 645931.8 653941.0 109350.0 122242.0 126079.0 136386.0 141737.6 787.3 1028.5 1035.4 1038.6 1071.8 18889.5 18915.7 18969.8 18974.8 18981.5 51382.7 51701.0 51972.5 54635.0 54964.0 73130.0 73202.6 74094.0 74155.0 77293.2 7830.4 7857.7 7931.8 8171.6 8305.3 11539.6 12038.8 12087.8 12374.4 12396.1 10502.6 10667.8 10685.6 10828.8 10860.3 9025.6 9876.7 10433.6 10499.0 10884.7 5892.8 6169.8 7149.5 10632.0 11098.3 6928.0 7880.0 7955.2 8029.7 8240.3 8123.8 10026.1 10645.7 10742.7 10982.3 06:43:48 INFO - PROCESS | 1665 | 06:43:48 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5822.15 Median:456.51 stddev:3324.79 (728.3%) stddev-sans-first:3319.02 06:43:48 INFO - PROCESS | 1665 | Values: 1605.9 1639.4 1900.2 1970.4 1973.3 8120.0 8821.6 8905.1 9387.7 9444.4 9011.1 9085.6 9141.6 9145.4 9149.2 2428.2 2444.9 2462.6 2466.6 2468.7 2398.9 2472.2 2472.6 2474.7 2479.0 2385.2 2435.3 2460.3 2460.6 2461.5 2403.9 2411.3 2430.8 2432.4 2451.0 1916.3 2386.8 2416.9 2433.0 2434.2 9121.9 9146.5 9221.0 9237.8 9240.4 5434.9 5532.5 5601.2 5602.6 5607.2 3609.6 3613.8 3653.6 3656.1 3685.6 1013.2 1026.8 1030.9 1031.9 1036.0 11996.3 12310.2 12420.3 12460.9 12497.9 3836.3 4125.6 4126.0 4461.2 4580.2 10281.5 10295.4 10444.5 10458.6 10470.9 4643.4 5319.1 5436.5 5500.1 5521.9 4208.2 4937.1 5062.7 5072.1 5091.9 4125.7 4133.9 4141.2 4152.2 4176.4 1305.1 1360.5 1365.6 1369.6 1377.5 774.8 777.3 801.5 813.7 835.9 5859.7 5959.3 6107.3 6135.8 6145.0 429.4 433.6 455.9 457.1 458.3 3995.9 4054.1 4073.6 4103.9 4118.5 10399.8 10936.6 10938.5 11140.9 11159.1 10631.8 10838.9 10990.2 11097.7 11132.3 6790.7 7379.7 7513.0 8303.5 8540.8 5490.3 5808.8 5860.3 5876.6 6028.1 8679.9 10220.2 10311.5 10323.5 10438.4 8342.6 10552.4 10617.5 10681.8 10682.9 6994.7 7417.6 7661.8 7743.3 7769.0 8652.7 8657.7 8680.4 8742.3 8755.7 6633.5 7559.5 7776.3 7841.6 7856.7 7532.8 7566.8 7592.4 7653.7 7715.6 7117.2 7202.4 7214.6 7226.2 7226.4 4893.6 5057.8 5091.8 5092.7 5104.3 4965.9 5015.0 5100.9 5126.2 5290.2 06:43:48 INFO - PROCESS | 1665 | 06:43:48 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4498.62 Median:4865.22 stddev:1405.28 (28.9%) stddev-sans-first:1372.74 06:43:48 INFO - PROCESS | 1665 | Values: 260.4 315.1 321.0 321.7 324.8 4738.0 4791.6 5364.4 5391.4 5423.8 4516.0 4871.0 5163.8 5327.8 5334.8 3859.5 3937.4 4063.4 4076.8 4078.9 3173.8 3864.8 4045.3 4053.4 4105.3 3667.9 3918.8 3995.4 4071.1 4079.0 3825.6 4046.7 4081.6 4083.6 4086.9 3000.5 3278.9 3523.6 3525.6 3547.5 4004.2 4398.5 4810.0 5017.2 5130.3 4261.0 4291.6 4628.3 4672.6 4723.6 4664.5 5119.4 5119.9 5494.9 5665.3 3641.2 3908.3 3928.0 3940.2 3960.7 5755.3 5893.3 5923.2 5944.0 5954.5 3505.8 3888.7 3962.8 3988.4 3995.0 3591.4 3847.0 4022.9 4060.8 4095.8 3940.9 3945.4 4687.4 4701.6 4756.9 4657.5 4836.9 5631.7 5732.0 5740.3 1290.6 1334.0 1357.8 1364.0 1364.1 802.0 805.7 808.6 841.3 850.8 4653.8 4665.0 4683.2 4859.5 5125.2 4789.4 5421.8 5740.4 5928.5 5934.6 4279.7 4599.0 4800.4 4945.8 5359.2 2493.9 2557.8 2925.6 3114.6 3147.8 4943.9 5061.4 5410.8 6185.9 6191.2 5444.5 5521.6 5626.8 6094.5 6133.9 5295.9 6208.5 6228.6 6241.4 6246.4 4939.7 4978.8 5691.8 5888.3 6012.8 4722.6 5832.1 5865.2 5867.4 5886.7 5248.9 5466.7 6117.6 6181.4 6198.6 3459.4 3597.5 3630.4 3942.5 3967.2 4759.8 5049.1 5835.0 5872.1 5885.4 4466.7 4977.1 5211.3 5503.6 5732.9 4990.4 5244.0 5375.3 5685.9 5696.5 4629.6 4903.9 5116.6 5578.4 5623.8 5286.4 5479.8 5629.0 5690.0 5697.8 5302.0 5583.6 5609.3 5613.3 5653.0 06:43:48 INFO - PROCESS | 1665 | 06:43:48 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:17052.87 Median:60583.50 stddev:23817.14 (39.3%) stddev-sans-first:23852.29 06:43:48 INFO - PROCESS | 1665 | Values: 697.7 702.6 712.6 751.4 778.2 14174.0 14585.3 14664.7 14682.0 14741.5 13905.4 14002.0 14057.0 14057.2 14064.0 707.2 889.8 895.7 910.7 911.3 904.3 909.2 910.3 912.1 922.8 929.9 942.0 977.0 981.5 982.8 926.8 928.1 958.1 972.9 976.2 686.7 697.6 706.1 720.7 721.5 14253.9 14496.0 14692.6 14731.2 14868.9 9347.6 12012.5 12631.7 12644.3 12807.6 9973.8 10068.2 10100.6 10287.3 10836.0 3539.5 3604.4 3611.4 3694.5 3706.6 79263.0 80345.0 80643.0 80983.0 81745.2 9502.5 9525.4 9568.0 9743.7 9875.2 15811.5 21712.5 21722.5 21724.0 21789.8 7444.9 7523.4 7592.1 7668.0 7743.8 4039.7 4041.2 4085.4 4128.8 4130.9 3507.4 3581.3 3581.5 3591.1 3598.4 645.7 660.3 661.1 661.4 662.0 500.5 502.9 516.0 541.9 551.8 8040.9 8149.1 8159.1 8248.9 8418.5 489.9 493.4 494.4 500.7 508.4 3853.1 3870.6 3875.0 3938.5 4040.1 60034.0 81292.6 85888.0 87017.0 87180.0 78810.2 79885.8 80195.2 80283.6 82741.0 64521.2 65043.7 65115.0 65713.7 65744.0 7016.7 7473.9 7701.0 7723.7 7857.4 41736.8 43121.9 43523.7 44451.3 45229.5 43838.7 46795.8 50463.7 57690.8 61133.0 9921.8 10163.2 10170.9 10263.4 10396.0 10753.0 11267.9 11410.5 11529.9 11542.3 8616.4 10490.8 10546.9 10547.6 10813.4 10414.9 10671.3 10727.8 11444.3 11576.9 10209.7 10258.4 10412.5 10453.1 10679.1 8799.0 8854.7 8975.9 9107.4 9143.7 8826.8 8850.5 8905.2 8910.8 8976.6 06:43:48 INFO - PROCESS | 1665 | -------- Summary: end -------- 06:43:48 INFO - PROCESS | 1665 | 06:43:48 INFO - TEST-INFO | 1665: exit 0 06:43:48 INFO - TEST-OK | dromaeo_css | took 1110936ms 06:43:48 INFO - TEST-START | kraken 06:43:48 INFO - operating with platform_type : mac_ 06:43:48 INFO - Initialising browser for kraken test... 06:43:48 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp1hDjI3/profile http://localhost:49278/getInfo.html) 06:43:51 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 06:43:51 INFO - PROCESS | 1677 | colorDepth:24 06:43:51 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 06:43:51 INFO - PROCESS | 1677 | __metrics 06:43:51 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 06:43:52 INFO - TEST-INFO | 1677: exit 0 06:43:52 INFO - Browser initialized. 06:43:52 INFO - Running cycle 1/1 for kraken test... 06:43:52 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp1hDjI3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:44:04 INFO - PROCESS | 1680 | RSS: Main: 250200064 06:44:04 INFO - PROCESS | 1680 | 06:44:07 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 06:44:08 INFO - PROCESS | 1680 | RSS: Main: 261890048 06:44:08 INFO - PROCESS | 1680 | 06:44:10 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 06:44:11 INFO - PROCESS | 1680 | RSS: Main: 266731520 06:44:11 INFO - PROCESS | 1680 | 06:44:14 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 06:44:15 INFO - PROCESS | 1680 | RSS: Main: 266903552 06:44:15 INFO - PROCESS | 1680 | 06:44:17 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 06:44:18 INFO - PROCESS | 1680 | RSS: Main: 267563008 06:44:18 INFO - PROCESS | 1680 | 06:44:20 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:44:20 INFO - PROCESS | 1680 | RSS: Main: 269139968 06:44:20 INFO - PROCESS | 1680 | 06:44:24 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 06:44:24 INFO - PROCESS | 1680 | RSS: Main: 267980800 06:44:24 INFO - PROCESS | 1680 | 06:44:27 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 06:44:28 INFO - PROCESS | 1680 | RSS: Main: 268214272 06:44:28 INFO - PROCESS | 1680 | 06:44:31 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 06:44:32 INFO - PROCESS | 1680 | RSS: Main: 268517376 06:44:32 INFO - PROCESS | 1680 | 06:44:33 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:44:34 INFO - PROCESS | 1680 | RSS: Main: 268406784 06:44:34 INFO - PROCESS | 1680 | 06:44:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:44:37 INFO - PROCESS | 1680 | RSS: Main: 268939264 06:44:37 INFO - PROCESS | 1680 | 06:44:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:44:40 INFO - PROCESS | 1680 | RSS: Main: 268632064 06:44:40 INFO - PROCESS | 1680 | 06:44:43 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:44:43 INFO - PROCESS | 1680 | RSS: Main: 268652544 06:44:43 INFO - PROCESS | 1680 | 06:44:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:44:47 INFO - PROCESS | 1680 | RSS: Main: 268718080 06:44:47 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 06:44:49 INFO - PROCESS | 1680 | RSS: Main: 270499840 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | __start_tp_report 06:44:49 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 06:44:49 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 06:44:49 INFO - PROCESS | 1680 | |i|pagename|runs| 06:44:49 INFO - PROCESS | 1680 | |0;ai-astar;115;115;109;118;118;116;107;115;115;115 06:44:49 INFO - PROCESS | 1680 | |1;audio-beat-detection;195;148;151;198;121;141;139;126;165;121 06:44:49 INFO - PROCESS | 1680 | |2;audio-dft;196;203;211;209;195;202;198;197;196;199 06:44:49 INFO - PROCESS | 1680 | |3;audio-fft;74;82;76;174;57;58;58;71;140;74 06:44:49 INFO - PROCESS | 1680 | |4;audio-oscillator;81;83;148;78;81;88;120;83;83;120 06:44:49 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;136;129;88;85;89;85;89;92;134;114 06:44:49 INFO - PROCESS | 1680 | |6;imaging-darkroom;95;95;95;95;95;94;120;153;122;103 06:44:49 INFO - PROCESS | 1680 | |7;imaging-desaturate;93;96;95;94;95;94;94;96;76;147 06:44:49 INFO - PROCESS | 1680 | |8;json-parse-financial;62;62;61;62;62;60;63;133;54;51 06:44:49 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;66;67;66;74;76;65;94;59;89;57 06:44:49 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;85;85;89;91;87;87;86;85;89;86 06:44:49 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;137;131;168;156;157;155;159;154;253;156 06:44:49 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;169;175;163;179;179;161;212;232;173;165 06:44:49 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;65;68;66;68;67;65;67;65;68;82 06:44:49 INFO - PROCESS | 1680 | __end_tp_report 06:44:49 INFO - PROCESS | 1680 | __start_cc_report 06:44:49 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1067 06:44:49 INFO - PROCESS | 1680 | __end_cc_report 06:44:49 INFO - PROCESS | 1680 | __startTimestamp1462887889463__endTimestamp 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | ------- Summary: start ------- 06:44:49 INFO - PROCESS | 1680 | Number of tests: 14 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:3.56 (3.1%) stddev-sans-first:3.77 06:44:49 INFO - PROCESS | 1680 | Values: 115.0 115.0 109.0 118.0 118.0 116.0 107.0 115.0 115.0 115.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:149.50 stddev:27.92 (18.7%) stddev-sans-first:24.54 06:44:49 INFO - PROCESS | 1680 | Values: 195.0 148.0 151.0 198.0 121.0 141.0 139.0 126.0 165.0 121.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:200.60 Median:200.50 stddev:5.60 (2.8%) stddev-sans-first:5.69 06:44:49 INFO - PROCESS | 1680 | Values: 196.0 203.0 211.0 209.0 195.0 202.0 198.0 197.0 196.0 199.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:86.40 Median:72.50 stddev:39.01 (53.8%) stddev-sans-first:41.12 06:44:49 INFO - PROCESS | 1680 | Values: 74.0 82.0 76.0 174.0 57.0 58.0 58.0 71.0 140.0 74.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:82.00 stddev:24.03 (29.3%) stddev-sans-first:24.83 06:44:49 INFO - PROCESS | 1680 | Values: 81.0 83.0 148.0 78.0 81.0 88.0 120.0 83.0 83.0 120.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:104.10 Median:86.50 stddev:21.66 (25.0%) stddev-sans-first:19.65 06:44:49 INFO - PROCESS | 1680 | Values: 136.0 129.0 88.0 85.0 89.0 85.0 89.0 92.0 134.0 114.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:106.70 Median:95.00 stddev:19.48 (20.5%) stddev-sans-first:20.19 06:44:49 INFO - PROCESS | 1680 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 120.0 153.0 122.0 103.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:98.00 Median:94.50 stddev:18.21 (19.3%) stddev-sans-first:19.22 06:44:49 INFO - PROCESS | 1680 | Values: 93.0 96.0 95.0 94.0 95.0 94.0 94.0 96.0 76.0 147.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:62.00 stddev:23.53 (37.9%) stddev-sans-first:24.89 06:44:49 INFO - PROCESS | 1680 | Values: 62.0 62.0 61.0 62.0 62.0 60.0 63.0 133.0 54.0 51.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:70.50 stddev:12.15 (17.2%) stddev-sans-first:12.73 06:44:49 INFO - PROCESS | 1680 | Values: 66.0 67.0 66.0 74.0 76.0 65.0 94.0 59.0 89.0 57.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:2.05 (2.4%) stddev-sans-first:2.05 06:44:49 INFO - PROCESS | 1680 | Values: 85.0 85.0 89.0 91.0 87.0 87.0 86.0 85.0 89.0 86.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:162.60 Median:156.50 stddev:33.53 (21.4%) stddev-sans-first:34.26 06:44:49 INFO - PROCESS | 1680 | Values: 137.0 131.0 168.0 156.0 157.0 155.0 159.0 154.0 253.0 156.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:177.00 stddev:23.08 (13.0%) stddev-sans-first:24.08 06:44:49 INFO - PROCESS | 1680 | Values: 169.0 175.0 163.0 179.0 179.0 161.0 212.0 232.0 173.0 165.0 06:44:49 INFO - PROCESS | 1680 | 06:44:49 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.50 stddev:5.04 (7.5%) stddev-sans-first:5.22 06:44:49 INFO - PROCESS | 1680 | Values: 65.0 68.0 66.0 68.0 67.0 65.0 67.0 65.0 68.0 82.0 06:44:49 INFO - PROCESS | 1680 | -------- Summary: end -------- 06:44:49 INFO - PROCESS | 1680 | 06:44:50 INFO - TEST-INFO | 1680: exit 0 06:44:50 INFO - TEST-OK | kraken | took 61757ms 06:44:50 INFO - SUITE-END | took 1172s 06:44:50 INFO - Completed test suite (00:19:32) 06:44:50 INFO - javascript benchmark 06:44:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2964.4960356739352, 3497.772644778091, 3560.163361610021, 3571.464280357946, 3581.98209008955, 4626.884327891796, 4869.123557759602, 5789.102689083188, 5812.505936995355, 5815.447532484407, 4709.434867815867, 4723.763811809405, 4733.763311834412, 5331.813386531472, 5890.82183563288, 152.29039831330755, 5188.584913206953, 5290.074237008508, 5394.514493695567, 5434.972825135868, 4879.585235255007, 5218.112920803454, 5234.424213336549, 5258.6318957672975, 5281.841544753664, 5253.185756207794, 5272.261883336336, 5277.419483856811, 5285.577153827685, 5300.443453437391, 5194.194899790538, 5281.735913204325, 5312.415634280226, 5315.176147697074, 5341.03861304965, 5198.194279886624, 5203.505666961632, 5241.292425522543, 5261.421243663194, 5275.024120537674, 4893.559579637814, 5593.3847276799515, 5826.708664566797, 5882.911756323659, 5934.6142500737315, 6108.22065524731, 6234.220722409699, 6271.78048768291, 6305.148804911324, 6312.053192021233, 5447.673139611636, 6082.60463069899, 6140.017597184429, 6275.6548389838545, 6322.399372059647, 5236.293100431431, 5886.381929897342, 5892.234009578728, 5899.233099697012, 5903.114532820111, 6218.906716399258, 6328.7468501260355, 6349.809505714836, 6368.076628888785, 6407.743690252338, 6286.842828929313, 6296.307406185316, 6296.338884417162, 6301.779437719658, 6321.810345689637, 6296.275928268308, 6324.146240257506, 6329.398707122816, 6365.140706004723, 6365.777197798055, 6111.257501106225, 6153.2000839890525, 6213.689315534205, 6314.71583778731, 6329.715162817684, 6297.937020629826, 6299.275583307978, 6301.96849015752, 6309.810705678837, 6316.30520642729, 4932.482089380635, 4982.078315511642, 5014.373203349582, 5021.347224860745, 5058.570021548136, 4005.2590270799415, 4286.671131949043, 4376.912461750747, 4417.977910110429, 4529.886752831206, 5757.280339957505, 5828.213191219216, 5897.64614123154, 5905.557083218776, 5929.881402371929, 6210.347913469021, 6243.406876346739, 6262.0, 6271.27880293763, 6291.905621415683, 5961.314448838352, 5965.970170149121, 5969.068380901369, 5998.130271110665, 6017.939820601826, 4075.735077219971, 5072.0, 5111.514406131411, 5476.67139971603, 5504.779808807683, 6424.775132870327, 6441.806745797634, 6452.322506136788, 6530.934690653033, 6532.771353002717, 5491.643043202179, 5985.820425387245, 6283.717232724447, 6293.181886354744, 6299.464545513682, 5452.945470545244, 6320.557560970872, 6435.09908612804, 6462.579932304385, 6501.739930402731, 6158.661273629814, 6239.500839932885, 6247.406496382836, 6296.150019747459, 6301.243850737941, 5307.99148161848, 6264.091706702411, 6280.7487700491465, 6290.811275661555, 6299.748010079728, 4998.625103117353, 6091.60404573719, 6145.10895920098, 6186.752529898934, 6236.594621349779, 6261.530385221217, 6270.561060725706, 6277.058441233668, 6301.243850737941, 6319.6208227506495, 5300.9359574013715, 6152.569320147547, 6168.475679567287, 6183.196184496167, 6185.938140618537, 6000.369961154016, 6143.112737013596, 6167.599106058092, 6207.286162091417, 6209.316975132822, 6076.409703073272, 6137.41694539018, 6143.8326717923455, 6146.938530614815, 6163.229596300463], "value": 5660.508167034389, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.3147248423354, 523.9528442440179, 529.8066205834868, 542.1623591551054, 544.8283790605959, 38726.0, 42261.0, 42316.0, 42441.99999999996, 42473.36289955653, 43004.13991720164, 43027.0, 43190.78404607972, 43237.91905202364, 43256.78371608137, 9597.424154550732, 9678.322517423783, 9702.563384647709, 9745.171660408874, 9803.460809655466, 9607.183389411874, 9609.423434593948, 9678.16114938163, 9688.951555242214, 9723.854142187873, 9642.325037247396, 9717.757056073619, 9734.853977190347, 9737.853932191023, 9753.122219000288, 9684.51577421126, 9704.95147524265, 9716.417014979124, 9732.659356922544, 9769.560369783378, 9597.616095356247, 9700.563474643657, 9701.417914925056, 9709.757256068584, 9722.465264410455, 39562.802185989174, 39624.60375396238, 39885.80057099696, 39973.0, 39987.0, 2941.7793665475174, 3407.2743778492686, 3430.1767575781882, 3479.165000399911, 3757.5490941087246, 28708.856455717796, 28881.133565993056, 28896.98860539871, 29577.0, 30220.546691799642, 2713.2945434187054, 2771.9445611087867, 2779.0134502251613, 2880.5391137417914, 2965.0363631819746, 486931.0, 491089.54455227853, 491314.0, 492325.0, 492450.0, 35519.64480355215, 64488.67755661192, 64712.352876471574, 64846.0, 65107.34892651108, 33600.83199584035, 36730.63269367326, 38058.809705951295, 38194.0, 38235.80882095627, 14964.0, 15174.924125379302, 15187.012844165094, 15327.540173794803, 15392.999455035611, 12623.873761262454, 12932.353382330846, 12952.546660866825, 13013.544525941546, 13023.088383813041, 8274.420790544604, 8333.95833020831, 8360.28937540316, 8410.116937721452, 8440.83118337642, 2893.7846104636105, 3361.546191264148, 3383.509391138271, 3385.39062968668, 3395.2175108068463, 922.3082687984012, 936.513013233115, 1016.8423894296247, 1026.4252018869456, 1053.4679986606714, 22433.551328973655, 26667.199984000123, 30259.0, 30406.0, 30458.086257412313, 1147.1511081799574, 1167.6555416152255, 1185.958491452795, 1195.0260537661777, 1247.1581682364367, 13707.383167757474, 15358.462453814287, 15375.384984600714, 15487.303071361815, 15763.605909852116, 639015.0, 644562.0, 648488.0, 651596.0, 651606.0, 58621.0, 60752.392476074674, 60922.39077609167, 61368.0, 61558.69220653958, 1439.6832696806687, 1460.7297649934583, 1475.5942115918208, 1477.2613693153423, 1477.6601381682274, 27632.0, 28943.855280723463, 29757.70242297636, 29939.80240790344, 30131.397372051997, 54443.183352248954, 54484.91030179295, 54987.72506137444, 55045.9999999984, 55095.449045509034, 506521.0, 523369.0, 523519.0, 524874.0, 526316.0, 27152.0, 27244.182674519798, 27426.725732743216, 27595.896164153208, 27660.308492287855, 46067.539324607664, 46194.53805461902, 46362.0, 47259.76370118128, 48051.75974120107, 38204.617953821216, 38281.425778612786, 38383.08234284407, 38872.0, 39245.01887452837, 28551.714482854906, 29837.10488685343, 37045.51817927253, 37242.25515489729, 38087.0, 29145.562816557343, 32216.83891580621, 37530.68642597496, 37974.43038354482, 38211.23577528489, 31799.52300715445, 33064.50403244001, 33148.0, 33176.83411582927, 33643.0, 19317.4204773857, 21014.949252537008, 21842.453938651026, 23616.881915591, 25205.369865753502], "value": 18647.673946954772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.3361818100141, 390.30525664317514, 390.31889353078884, 396.0830676982783, 414.17992375097305, 20201.696974545375, 21301.573968520657, 21444.57110857784, 21564.784352156494, 22362.66456003161, 20816.47958801031, 20956.68564971523, 21524.89237553814, 21602.56794864102, 21639.45901352467, 5825.417458254173, 5908.350081491032, 5922.082077278029, 6013.879722405549, 6027.246594175728, 5170.9482905171035, 5601.271834661488, 5828.475437210672, 5896.587238893279, 5920.437558431942, 4826.879328016793, 5762.3949485304065, 5769.076947688371, 5770.653760774346, 5785.450382213683, 5392.99999999998, 5393.406725260218, 5419.105847535152, 5677.063284558043, 5748.597598168109, 4746.691465054795, 4794.832180873653, 4808.591269742076, 4809.903801923977, 4820.68665536739, 26112.0, 26422.6036609451, 26934.057307994128, 27160.32099197516, 27248.31879203016, 2175.3582693105573, 2453.129139155592, 2462.9014839406404, 2564.8332858364147, 2568.961465578018, 12161.51353945841, 14497.92751036238, 14958.177300248482, 15135.318910649048, 15242.923785381114, 1682.2513981278337, 1702.3956495444063, 1714.2457318779698, 1726.2577091850499, 1739.939102131432, 121859.39070304592, 122322.0, 123740.0, 124420.37789810993, 124603.13095303578, 10888.292261003167, 11262.774744505065, 11509.25189862673, 11518.712032199262, 11721.355325457182, 11929.642110736691, 14390.0, 14476.131432114107, 14479.05886117399, 14516.709665806624, 8704.216620504185, 8894.28845692343, 8948.149925757043, 8997.965233998044, 9045.909540904508, 7551.697932082765, 8543.786405339917, 8850.026497085315, 8855.291576673852, 9002.414843035182, 6849.897251541231, 6982.26686197952, 6986.126734158231, 7002.684879180449, 7033.261507541737, 1859.9349022784409, 1893.5644801695687, 1894.5642502224289, 1897.8671492995359, 1920.6926891697262, 929.6699671616614, 948.3598570964572, 955.5317894231777, 1011.7521207304111, 1054.9578016879238, 18474.722879156823, 20580.58838823215, 21359.0, 21484.462888427603, 22064.558708826054, 909.072745799281, 973.5980188528496, 991.965281215154, 996.2279233593878, 1013.4122209118693, 8884.911150888538, 9134.314926380548, 9457.574409151604, 11247.887521124683, 11512.712182195344, 628624.0, 635255.0, 639590.0, 645931.7703411453, 653941.0, 109350.0, 122242.0, 126079.0, 136386.0, 141737.58262417244, 787.338635546144, 1028.4960369418932, 1035.3529044347283, 1038.5793753529833, 1071.839224116373, 18889.527761806065, 18915.71626425577, 18969.810301896803, 18974.766640168345, 18981.525461863563, 51382.743086285824, 51701.0, 51972.480275196765, 54635.0, 54964.0, 73130.0, 73202.63398682972, 74094.0, 74155.0, 77293.2270677286, 7830.41271904598, 7857.685692572461, 7931.762047138595, 8171.632276547689, 8305.294050005818, 11539.596114135966, 12038.75922481563, 12087.81868271959, 12374.443150058449, 12396.132270741322, 10502.632407865687, 10667.786644266916, 10685.626003090165, 10828.837567436338, 10860.348379097279, 9025.638974440948, 9876.703698889045, 10433.634822781167, 10499.0, 10884.673459796219, 5892.823215303548, 6169.796889606484, 7149.463790215858, 10632.0, 11098.334099954029, 6927.995440660975, 7880.014998125234, 7955.24425179607, 8029.678812847421, 8240.258376746122, 8123.75628731139, 10026.097651211427, 10645.733856653645, 10742.73143171427, 10982.286151400453], "value": 9608.092592270728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1605.8956167849085, 1639.4016184092807, 1900.2019151956176, 1970.4187264756895, 1973.2994786850677, 8119.959400202991, 8821.558922053888, 8905.109489051092, 9387.718368448941, 9444.386114902534, 9011.098890110985, 9085.591148398322, 9141.634334626608, 9145.405548639334, 9149.176574108329, 2428.1501474483966, 2444.8899799509063, 2462.6059830427134, 2466.5683505386487, 2468.6543883856275, 2398.8680622565753, 2472.208893154191, 2472.5796614575565, 2474.6659201007906, 2478.962815557759, 2385.189035727852, 2435.2815919303757, 2460.2619214235656, 2460.59400198967, 2461.4953934443397, 2403.8557686538866, 2411.252511721372, 2430.793382562484, 2432.3675844280524, 2450.987745061281, 1916.3005502991448, 2386.806596701649, 2416.9395765105837, 2432.990309021754, 2434.160214725917, 9121.863172052424, 9146.451212927246, 9220.953895230548, 9237.769055773591, 9240.399374040666, 5434.864128396782, 5532.5297349724915, 5601.243832082658, 5602.551795856362, 5607.214989901417, 3609.5848977367677, 3613.7831730096277, 3653.5798383185743, 3656.1042544576485, 3685.6130106338715, 1013.164139584838, 1026.768976980181, 1030.8505266736356, 1031.9380837149795, 1035.9637412690595, 11996.340201288926, 12310.199837010565, 12420.316882571455, 12460.937695311555, 12497.93751031239, 3836.3286424875537, 4125.566815484391, 4125.989132662517, 4461.219286624828, 4580.1755683976535, 10281.485925703684, 10295.43375114361, 10444.477776111164, 10458.581656733797, 10470.947645261725, 4643.373144625432, 5319.069162896555, 5436.53789427903, 5500.064988951888, 5521.944780552223, 4208.179405016053, 4937.136001199776, 5062.7468626568525, 5072.087024335655, 5091.949080509222, 4125.66994640428, 4133.91732165361, 4141.171765646883, 4152.231837110145, 4176.373543968429, 1305.1190446448609, 1360.4694169273992, 1365.5834970334145, 1369.6438925879343, 1377.4765589076287, 774.7908064822466, 777.312078810257, 801.5431204213543, 813.6541969662869, 835.8787975743484, 5859.707014649336, 5959.255093113361, 6107.328193898667, 6135.815925522242, 6145.016797312409, 429.39884162173206, 433.5880913132537, 455.9475660299042, 457.0721435485969, 458.3056669146246, 3995.9200815983518, 4054.087830238173, 4073.6130067643526, 4103.9179216415505, 4118.5057793065025, 10399.84400233997, 10936.56253749841, 10938.507767150497, 11140.941610546985, 11159.051480624075, 10631.84052239217, 10838.945805271082, 10990.17573681977, 11097.667069987752, 11132.276402033842, 6790.660466976631, 7379.667914943733, 7513.0, 8303.501789892747, 8540.829183416297, 5490.313710786152, 5808.767649293981, 5860.267466566679, 5876.647401155944, 6028.065649824284, 8679.91320086791, 10220.233482488695, 10311.484425778832, 10323.535440905027, 10438.425886576008, 8342.582870856311, 10552.366857988545, 10617.469126543796, 10681.786364272826, 10682.89317106819, 6994.685239164148, 7417.554946703215, 7661.770146895602, 7743.264389882952, 7769.028871391076, 8652.697155599524, 8657.696980605648, 8680.435771674822, 8742.300615950835, 8755.730419089068, 6633.502487313374, 7559.5464272143845, 7776.339011184113, 7841.5687137208, 7856.685732570633, 7532.832410976307, 7566.848663026819, 7592.39260859141, 7653.693852245848, 7715.57564333967, 7117.181524124585, 7202.423806095395, 7214.639268036683, 7226.168990566152, 7226.4218862491925, 4893.584045356185, 5057.822976195963, 5091.770870310771, 5092.745362731923, 5104.310918026019, 4965.875853103556, 5015.0, 5100.872478188075, 5126.2054381570915, 5290.206469029677], "value": 4578.921529304603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.3802948981424, 315.1019594156653, 320.97111259986605, 321.71849631572377, 324.77265913860276, 4738.028704115656, 4791.592714619262, 5364.383095943967, 5391.353037635485, 5423.755930983105, 4515.9548404515945, 4870.975645121778, 5163.812323165665, 5327.844281460458, 5334.839954801362, 3859.517560304962, 3937.4290727844445, 4063.3904914262803, 4076.7961601919787, 4078.938815917764, 3173.8413079346055, 3864.8212295249937, 4045.3325201341745, 4053.391991201314, 4105.3020986432375, 3667.853285868562, 3918.784466854322, 3995.360742281221, 4071.145059537501, 4078.9592104079024, 3825.5600605930395, 4046.6731629312967, 4081.5918408159246, 4083.5508094109623, 4086.9386959195635, 3000.4599172149005, 3278.9016329510155, 3523.6300188480354, 3525.5945566259697, 3547.5210846535647, 4004.2391945530258, 4398.450193725785, 4810.0, 5017.247412888059, 5130.281760553488, 4261.007936389163, 4291.605228300815, 4628.305754136873, 4672.649551283667, 4723.551262630079, 4664.463586687541, 5119.360079990001, 5119.900840655313, 5494.890102197974, 5665.291838520185, 3641.198936234024, 3908.2965066288057, 3928.0376307804486, 3940.2316548273097, 3960.742551734128, 5755.3381361143165, 5893.322267939199, 5923.229980102559, 5944.0, 5954.523638108941, 3505.807180605091, 3888.7083468739957, 3962.821673024721, 3988.4017397390044, 3994.960050399517, 3591.3894637911617, 3846.9615303847163, 4022.939655905164, 4060.796960151981, 4095.7917414362832, 3940.9211815763524, 3945.447637330776, 4687.367205427224, 4701.553352431513, 4756.905911640342, 4657.534246575383, 4836.920124346565, 5631.6902570359025, 5731.971340143273, 5740.339860916049, 1290.5612091888802, 1333.9799903001463, 1357.8166947461966, 1364.0, 1364.0656150536715, 801.9975031210986, 805.7099444200084, 808.623989844725, 841.3185319890908, 850.7787975126512, 4653.837115700934, 4664.953350466452, 4683.2038553446, 4859.469267180827, 5125.205593133071, 4789.377380940456, 5421.83734487966, 5740.42595740431, 5928.466438020599, 5934.584579079509, 4279.721818081877, 4598.965232822655, 4800.35195248644, 4945.826896058621, 5359.169328754049, 2493.875306234681, 2557.7698007179442, 2925.5611658251005, 3114.5828647965573, 3147.7578094562637, 4943.8516844494725, 5061.419415429043, 5410.810621628224, 6185.907211391833, 6191.226096737908, 5444.537214336747, 5521.558275337963, 5626.774929002794, 6094.512439004869, 6133.877322453526, 5295.94081183757, 6208.50331973441, 6228.601988234472, 6241.407066328691, 6246.437820596168, 4939.728314942569, 4978.751062446936, 5691.800786972436, 5888.293404791452, 6012.759489620541, 4722.645801564965, 5832.096025116114, 5865.237519122486, 5867.413258674099, 5886.676232807236, 5248.921266180934, 5466.731306507755, 6117.602355846856, 6181.35095814933, 6198.566100373111, 3459.3773120837486, 3597.4603809428795, 3630.3646861799607, 3942.5268967724055, 3967.166894951977, 4759.833405830779, 5049.141645920276, 5834.970825145847, 5872.0898260769645, 5885.3820348864465, 4466.731996080245, 4977.0792403405485, 5211.348581427322, 5503.614746967673, 5732.856678583069, 4990.4011518618, 5243.951209757987, 5375.274337964324, 5685.914711279417, 5696.515796157208, 4629.629629629554, 4903.926441103457, 5116.616253780907, 5578.442155784389, 5623.831285061455, 5286.383240296078, 5479.76693750689, 5629.014922388647, 5689.971550142222, 5697.803461273179, 5301.973490132525, 5583.581231407742, 5609.261129050007, 5613.270274864241, 5653.0], "value": 4053.184725042749, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.6686074114796, 702.5714314268296, 712.6223101756069, 751.3913729878799, 778.217891019526, 14174.00781945263, 14585.34365953532, 14664.706705865876, 14681.972261941668, 14741.48404805832, 13905.374258158381, 14002.0, 14057.0, 14057.156570605744, 14064.0, 707.1690763353065, 889.822035592884, 895.7268033249873, 910.744991402405, 911.2800887299026, 904.3082042237694, 909.2135302962922, 910.2990697163181, 912.0560220172123, 922.8431166701644, 929.8930622978377, 941.9576119074624, 976.9951150244239, 981.4798156976814, 982.8230918434715, 926.8239034583407, 928.1043792740005, 958.0611001218809, 972.8589354543587, 976.2287792643803, 686.7115811359191, 697.6442014572553, 706.0785674694522, 720.7009091227187, 721.4985585018362, 14253.857461425358, 14496.0, 14692.559223223321, 14731.189784561844, 14868.925655371653, 9347.626094956193, 12012.519499220021, 12631.747365052739, 12644.304563249018, 12807.551735689207, 9973.75065623358, 10068.194544436428, 10100.595976161017, 10287.279890407675, 10836.0, 3539.4513850353237, 3604.4232922732235, 3611.422172452395, 3694.5197124373926, 3706.592274849764, 79263.0, 80345.0, 80643.0, 80983.0, 81745.18254817494, 9502.524873756285, 9525.428474291564, 9567.952160239154, 9743.707688769347, 9875.160611348116, 15811.525654230392, 21712.457188570097, 21722.456938576346, 21724.0, 21789.782102178775, 7444.925550744531, 7523.360514356232, 7592.050993625797, 7667.961660191775, 7743.7676869694, 4039.6566291864933, 4041.1715598302276, 4085.4484644573195, 4128.752274863517, 4130.938035929464, 3507.4212754895666, 3581.3195492856794, 3581.462780582933, 3591.1381268495375, 3598.442241452579, 645.6674812471581, 660.2868901586276, 661.1075048684238, 661.4047357378398, 662.0367365483211, 500.50200050949536, 502.9371328583927, 516.0, 541.8970395624818, 551.7710150287586, 8040.8793868092025, 8149.14433984435, 8159.102498725136, 8248.917510824815, 8418.452800567944, 489.87263311538544, 493.39559040176215, 494.3622726682611, 500.7120905479364, 508.4280184792109, 3853.133045064838, 3870.554886188068, 3874.96125038746, 3938.547067087264, 4040.0505881117915, 60034.0, 81292.59353703311, 85888.0, 87017.0, 87180.0, 78810.21189788144, 79885.80171297435, 80195.19804801994, 80283.59858200788, 82741.0, 64521.19309262189, 65043.699126017214, 65115.0, 65713.67143164254, 65743.99999999904, 7016.6842492089, 7473.925260747323, 7700.961495192488, 7723.652435640522, 7857.410694197843, 41736.79131604323, 43121.92195195145, 43523.69428917138, 44451.33323000093, 45229.54770452385, 43838.684839454865, 46795.76602116968, 50463.74768126136, 57690.846183076945, 61133.0, 9921.801563968824, 10163.237757168094, 10170.949145254226, 10263.435511046964, 10396.0, 10753.0, 11267.943660281646, 11410.543578256777, 11529.942350288195, 11542.307461551998, 8616.35377346714, 10490.790184196427, 10546.947265263625, 10547.57809687604, 10813.360543001752, 10414.895851041392, 10671.253012289066, 10727.785444291227, 11444.313341199555, 11576.88423115758, 10209.693709188736, 10258.384496930208, 10412.531436085243, 10453.111485523816, 10679.14566834667, 8798.956005219932, 8854.734357969272, 8975.865362019706, 9107.362484626012, 9143.725688229364, 8826.823463530822, 8850.468971861708, 8905.243054340453, 8910.821783564163, 8976.55117244122], "value": 6627.9744767899265, "unit": "score"}], "name": "dromaeo_css", "value": 7068.874939178333, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 109.0, 118.0, 118.0, 116.0, 107.0, 115.0, 115.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 148.0, 151.0, 198.0, 121.0, 141.0, 139.0, 126.0, 165.0, 121.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 203.0, 211.0, 209.0, 195.0, 202.0, 198.0, 197.0, 196.0, 199.0], "value": 200.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 76.0, 174.0, 57.0, 58.0, 58.0, 71.0, 140.0, 74.0], "value": 86.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 148.0, 78.0, 81.0, 88.0, 120.0, 83.0, 83.0, 120.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 129.0, 88.0, 85.0, 89.0, 85.0, 89.0, 92.0, 134.0, 114.0], "value": 104.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 120.0, 153.0, 122.0, 103.0], "value": 106.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 95.0, 94.0, 95.0, 94.0, 94.0, 96.0, 76.0, 147.0], "value": 98.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 60.0, 63.0, 133.0, 54.0, 51.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 74.0, 76.0, 65.0, 94.0, 59.0, 89.0, 57.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 89.0, 91.0, 87.0, 87.0, 86.0, 85.0, 89.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 168.0, 156.0, 157.0, 155.0, 159.0, 154.0, 253.0, 156.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 163.0, 179.0, 179.0, 161.0, 212.0, 232.0, 173.0, 165.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 68.0, 67.0, 65.0, 67.0, 65.0, 68.0, 82.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1593.8999999999996, "alertThreshold": 2.0}]} 06:44:50 INFO - Return code: 0 06:44:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:44:50 ERROR - # TBPL SUCCESS # 06:44:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:44:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:44:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:44:50 INFO - 2016-05-10 06:44:50.784 screenresolution[1685:10300] starting screenresolution argv=screenresolution get 06:44:50 INFO - 2016-05-10 06:44:50.786 screenresolution[1685:10300] Display 0: 1600x1200x32@60 06:44:50 INFO - 2016-05-10 06:44:50.793 screenresolution[1686:10303] starting screenresolution argv=screenresolution list 06:44:50 INFO - Available Modes on Display 0 06:44:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:44:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:44:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:44:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:44:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:44:51 INFO - Intel Iris: 06:44:51 INFO - Chipset Model: Intel Iris 06:44:51 INFO - Type: GPU 06:44:51 INFO - Bus: Built-In 06:44:51 INFO - VRAM (Dynamic, Max): 1536 MB 06:44:51 INFO - Vendor: Intel (0x8086) 06:44:51 INFO - Device ID: 0x0a2e 06:44:51 INFO - Revision ID: 0x0009 06:44:51 INFO - Displays: 06:44:51 INFO - Display: 06:44:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:44:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:44:51 INFO - Display Serial Number: 1600x1200 60 06:44:51 INFO - Main Display: Yes 06:44:51 INFO - Mirror: Off 06:44:51 INFO - Online: Yes 06:44:51 INFO - Rotation: Supported 06:44:51 INFO - Return code: 0 06:44:51 INFO - Running post-action listener: _resource_record_post_action 06:44:51 INFO - ##### 06:44:51 INFO - ##### Finished run-tests step (success) 06:44:51 INFO - ##### 06:44:51 INFO - Running post-run listener: _resource_record_post_run 06:44:52 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37889536; Write bytes: 694401536; Read time: 401; Write time: 2120 06:44:52 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 379845120; Write bytes: 373475328; Read time: 28316; Write time: 679 06:44:52 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 36935168; Write bytes: 298189312; Read time: 385; Write time: 1395 06:44:52 INFO - Running post-run listener: _upload_blobber_files 06:44:52 INFO - Blob upload gear active. 06:44:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:44:52 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 06:44:52 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:44:52 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:44:52 INFO - (blobuploader) - INFO - Open directory for files ... 06:44:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:44:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:44:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:53 INFO - (blobuploader) - INFO - Done attempting. 06:44:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:44:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:44:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:54 INFO - (blobuploader) - INFO - Done attempting. 06:44:54 INFO - (blobuploader) - INFO - Iteration through files over. 06:44:54 INFO - Return code: 0 06:44:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:44:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:44:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8babb1798ddce878a1caae45fa6cab5ac98e4e01f48feadffd6a5d2806ed993c6d3846d619d23c759cfa241c5050c104df649b999b7b6409e0826f1f3751876b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/203e909bfa14dbbad7f443c022601d6a455449eb47d736927cdc5e1be54e8577d1219d371f2ffd9dff16e7a6639c75bc828c2dcaae82016b5877f742118b083d"} 06:44:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:44:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:44:54 INFO - Contents: 06:44:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8babb1798ddce878a1caae45fa6cab5ac98e4e01f48feadffd6a5d2806ed993c6d3846d619d23c759cfa241c5050c104df649b999b7b6409e0826f1f3751876b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/203e909bfa14dbbad7f443c022601d6a455449eb47d736927cdc5e1be54e8577d1219d371f2ffd9dff16e7a6639c75bc828c2dcaae82016b5877f742118b083d"} 06:44:54 INFO - Running post-run listener: copy_logs_to_upload_dir 06:44:54 INFO - Copying logs to upload dir... 06:44:54 INFO - mkdir: /builds/slave/test/build/upload/logs 06:44:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.804612 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-10 06:44:54.487676) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 06:44:54.492157) ========= 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.NNDAbnhVhW/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.1125oA5XA1/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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/Fx-Team/sha512/8babb1798ddce878a1caae45fa6cab5ac98e4e01f48feadffd6a5d2806ed993c6d3846d619d23c759cfa241c5050c104df649b999b7b6409e0826f1f3751876b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/203e909bfa14dbbad7f443c022601d6a455449eb47d736927cdc5e1be54e8577d1219d371f2ffd9dff16e7a6639c75bc828c2dcaae82016b5877f742118b083d"} build_url:https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010948 build_url: 'https://queue.taskcluster.net/v1/task/AZ1Kd4ZlRgqIoHDMdK3DkQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8babb1798ddce878a1caae45fa6cab5ac98e4e01f48feadffd6a5d2806ed993c6d3846d619d23c759cfa241c5050c104df649b999b7b6409e0826f1f3751876b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/203e909bfa14dbbad7f443c022601d6a455449eb47d736927cdc5e1be54e8577d1219d371f2ffd9dff16e7a6639c75bc828c2dcaae82016b5877f742118b083d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 06:44:54.522472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:44:54.522834) ========= 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.NNDAbnhVhW/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.1125oA5XA1/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.004439 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:44:54.571569) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 06:44:54.573354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 06:44:54.573781) ========= ========= Total master_lag: 0.19 =========