builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0189 starttime: 1460752876.33 results: success (0) buildid: 20160415122040 builduid: b84a3658e1014dfbae3dae8c4354d197 revision: 355e9b83a662dd7e90a73b7c9cd556372c063ae9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:16.331298) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:16.331753) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:16.332057) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:16.540589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:16.540892) ========= 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.xvqpTuaqIE/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.wTukm9aL5i/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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-04-15 13:41:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.0M=0.001s 2016-04-15 13:41:16 (16.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134871 ========= master_lag: 0.84 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:17.511347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:17.511671) ========= 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.xvqpTuaqIE/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.wTukm9aL5i/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.026479 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:17.571800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 13:41:17.572147) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 355e9b83a662dd7e90a73b7c9cd556372c063ae9 --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 355e9b83a662dd7e90a73b7c9cd556372c063ae9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xvqpTuaqIE/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.wTukm9aL5i/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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-04-15 13:41:17,622 truncating revision to first 12 chars 2016-04-15 13:41:17,622 Setting DEBUG logging. 2016-04-15 13:41:17,622 attempt 1/10 2016-04-15 13:41:17,622 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/355e9b83a662?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 13:41:18,537 unpacking tar archive at: fx-team-355e9b83a662/testing/mozharness/ program finished with exit code 0 elapsedTime=1.157056 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 13:41:18.753048) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:18.753364) ========= script_repo_revision: 355e9b83a662dd7e90a73b7c9cd556372c063ae9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:18.753760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:18.754051) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 13:41:18.767383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-04-15 13:41:18.767661) ========= /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.xvqpTuaqIE/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.wTukm9aL5i/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 13:41:18 INFO - MultiFileLogger online at 20160415 13:41:18 in /builds/slave/test 13:41:18 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 13:41:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:41:18 INFO - {'append_to_log': False, 13:41:18 INFO - 'base_work_dir': '/builds/slave/test', 13:41:18 INFO - 'blob_upload_branch': 'Fx-Team', 13:41:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:41:18 INFO - 'branch': 'Fx-Team', 13:41:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:41:18 INFO - 'config_files': ('talos/mac_config.py',), 13:41:18 INFO - 'default_actions': ('clobber', 13:41:18 INFO - 'read-buildbot-config', 13:41:18 INFO - 'download-and-extract', 13:41:18 INFO - 'populate-webroot', 13:41:18 INFO - 'create-virtualenv', 13:41:18 INFO - 'install', 13:41:18 INFO - 'run-tests'), 13:41:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:41:18 INFO - 'download_minidump_stackwalk': True, 13:41:18 INFO - 'download_symbols': 'ondemand', 13:41:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:41:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:41:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:41:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:41:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:41:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:41:18 INFO - 'installer_path': 'installer.exe', 13:41:18 INFO - 'log_level': 'info', 13:41:18 INFO - 'log_name': 'talos', 13:41:18 INFO - 'log_to_console': True, 13:41:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:41:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:41:18 INFO - 'opt_config_files': (), 13:41:18 INFO - 'pip_index': False, 13:41:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:41:18 INFO - 'cmd': ('bash', 13:41:18 INFO - '-c', 13:41:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:41:18 INFO - 'enabled': True, 13:41:18 INFO - 'halt_on_failure': False, 13:41:18 INFO - 'name': 'check_screen_resolution'},), 13:41:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:41:18 INFO - 'cmd': ('bash', 13:41:18 INFO - '-c', 13:41:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:41:18 INFO - 'enabled': True, 13:41:18 INFO - 'halt_on_failure': False, 13:41:18 INFO - 'name': 'check_screen_resolution'},), 13:41:18 INFO - 'run_cmd_checks_enabled': True, 13:41:18 INFO - 'sps_profile': False, 13:41:18 INFO - 'sps_profile_interval': 0, 13:41:18 INFO - 'suite': 'dromaeojs-e10s', 13:41:18 INFO - 'system_bits': '32', 13:41:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:41:18 INFO - 'title': 't-yosemite-r7-0189', 13:41:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:41:18 INFO - 'use_talos_json': True, 13:41:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:41:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:41:18 INFO - 'work_dir': 'build'} 13:41:18 INFO - ##### 13:41:18 INFO - ##### Running clobber step. 13:41:18 INFO - ##### 13:41:18 INFO - Running pre-action listener: _resource_record_pre_action 13:41:18 INFO - Running main action method: clobber 13:41:18 INFO - rmtree: /builds/slave/test/build 13:41:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:41:20 INFO - Running post-action listener: _resource_record_post_action 13:41:20 INFO - ##### 13:41:20 INFO - ##### Running read-buildbot-config step. 13:41:20 INFO - ##### 13:41:20 INFO - Running pre-action listener: _resource_record_pre_action 13:41:20 INFO - Running main action method: read_buildbot_config 13:41:20 INFO - Using buildbot properties: 13:41:20 INFO - { 13:41:20 INFO - "project": "", 13:41:20 INFO - "product": "firefox", 13:41:20 INFO - "script_repo_revision": "production", 13:41:20 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 13:41:20 INFO - "repository": "", 13:41:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 13:41:20 INFO - "buildid": "20160415122040", 13:41:20 INFO - "pgo_build": "False", 13:41:20 INFO - "basedir": "/builds/slave/test", 13:41:20 INFO - "buildnumber": 697, 13:41:20 INFO - "slavename": "t-yosemite-r7-0189", 13:41:20 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:41:20 INFO - "platform": "yosemite_r7", 13:41:20 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 13:41:20 INFO - "branch": "fx-team", 13:41:20 INFO - "repo_path": "integration/fx-team", 13:41:20 INFO - "revision": "355e9b83a662dd7e90a73b7c9cd556372c063ae9", 13:41:20 INFO - "stage_platform": "macosx64", 13:41:20 INFO - "builduid": "b84a3658e1014dfbae3dae8c4354d197", 13:41:20 INFO - "slavebuilddir": "test" 13:41:20 INFO - } 13:41:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 13:41:20 INFO - Running post-action listener: _resource_record_post_action 13:41:20 INFO - ##### 13:41:20 INFO - ##### Running download-and-extract step. 13:41:20 INFO - ##### 13:41:20 INFO - Running pre-action listener: _resource_record_pre_action 13:41:20 INFO - Running main action method: download_and_extract 13:41:20 INFO - mkdir: /builds/slave/test/build/tests 13:41:20 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')]} 13:41:20 INFO - https://queue.taskcluster.net/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:41:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:41:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:41:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 13:41:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 13:41:22 INFO - Downloaded 1199 bytes. 13:41:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 13:41:22 INFO - Using the following test package requirements: 13:41:22 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:41:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:41:22 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 13:41:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:41:22 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 13:41:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:41:22 INFO - u'jsshell-mac.zip'], 13:41:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:41:22 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 13:41:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:41:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:41:22 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 13:41:22 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:41:22 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 13:41:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:41:22 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 13:41:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:41:22 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 13:41:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:22 INFO - https://queue.taskcluster.net/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:41:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:41:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:41:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:41:23 INFO - Downloaded 18033943 bytes. 13:41:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:41:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:41:26 INFO - Return code: 0 13:41:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:41:26 INFO - https://queue.taskcluster.net/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:41:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:41:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:41:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:41:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:41:28 INFO - Downloaded 18033943 bytes. 13:41:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:41:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:41:31 INFO - Return code: 0 13:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:31 INFO - https://queue.taskcluster.net/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:41:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:41:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:41:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:41:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:41:33 INFO - Downloaded 10841076 bytes. 13:41:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:41:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:41:33 INFO - Return code: 0 13:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:33 INFO - https://queue.taskcluster.net/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:41:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:41:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:41:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 13:41:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 13:41:41 INFO - Downloaded 109948379 bytes. 13:41:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:41:41 INFO - mkdir: /builds/slave/test/properties 13:41:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:41:41 INFO - Writing to file /builds/slave/test/properties/build_url 13:41:41 INFO - Contents: 13:41:41 INFO - build_url:https://queue.taskcluster.net/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:41:42 INFO - Running post-action listener: _resource_record_post_action 13:41:42 INFO - Running post-action listener: set_extra_try_arguments 13:41:42 INFO - ##### 13:41:42 INFO - ##### Running populate-webroot step. 13:41:42 INFO - ##### 13:41:42 INFO - Running pre-action listener: _resource_record_pre_action 13:41:42 INFO - Running main action method: populate_webroot 13:41:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:41:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:41:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:41:42 INFO - '--tppagecycles', 13:41:42 INFO - '7'], 13:41:42 INFO - 'tests': ['tsvgm']}}, 13:41:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:41:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:41:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:41:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:41:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:41:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:41:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:42 INFO - 'talos_options': ['--disable-e10s'], 13:41:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:41:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:41:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:42 INFO - 'talos_options': ['--disable-e10s'], 13:41:42 INFO - 'tests': ['damp', 'tps']}, 13:41:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:42 INFO - 'tests': ['damp', 'tps']}, 13:41:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:41:42 INFO - 'tests': ['dromaeo_dom']}, 13:41:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:41:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:41:42 INFO - 'tests': ['a11yr', 13:41:42 INFO - 'ts_paint', 13:41:42 INFO - 'tpaint', 13:41:42 INFO - 'sessionrestore', 13:41:42 INFO - 'sessionrestore_no_auto_restore', 13:41:42 INFO - 'tabpaint']}, 13:41:42 INFO - 'other-e10s': {'tests': ['a11yr', 13:41:42 INFO - 'ts_paint', 13:41:42 INFO - 'tpaint', 13:41:42 INFO - 'sessionrestore', 13:41:42 INFO - 'sessionrestore_no_auto_restore', 13:41:42 INFO - 'tabpaint']}, 13:41:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:41:42 INFO - 'ts_paint', 13:41:42 INFO - 'tpaint', 13:41:42 INFO - 'sessionrestore', 13:41:42 INFO - 'sessionrestore_no_auto_restore', 13:41:42 INFO - 'tabpaint']}, 13:41:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:41:42 INFO - 'ts_paint', 13:41:42 INFO - 'tpaint', 13:41:42 INFO - 'sessionrestore', 13:41:42 INFO - 'sessionrestore_no_auto_restore', 13:41:42 INFO - 'tabpaint']}, 13:41:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:41:42 INFO - 'tests': ['a11yr', 13:41:42 INFO - 'ts_paint', 13:41:42 INFO - 'tpaint', 13:41:42 INFO - 'sessionrestore', 13:41:42 INFO - 'sessionrestore_no_auto_restore', 13:41:42 INFO - 'tabpaint']}, 13:41:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:41:42 INFO - 'tests': ['a11yr', 13:41:42 INFO - 'ts_paint', 13:41:42 INFO - 'tpaint', 13:41:42 INFO - 'sessionrestore', 13:41:42 INFO - 'sessionrestore_no_auto_restore', 13:41:42 INFO - 'tabpaint']}, 13:41:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:41:42 INFO - 'tests': ['tsvgx', 13:41:42 INFO - 'tsvgr_opacity', 13:41:42 INFO - 'tart', 13:41:42 INFO - 'tscrollx', 13:41:42 INFO - 'cart']}, 13:41:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:41:42 INFO - 'tsvgr_opacity', 13:41:42 INFO - 'tart', 13:41:42 INFO - 'tscrollx', 13:41:42 INFO - 'cart']}, 13:41:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:42 INFO - 'talos_options': ['--disable-e10s'], 13:41:42 INFO - 'tests': ['tp5o']}, 13:41:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:42 INFO - 'tests': ['tp5o']}, 13:41:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:42 INFO - 'talos_options': ['--disable-e10s', 13:41:42 INFO - '--xperf_path', 13:41:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:41:42 INFO - 'tests': ['tp5n']}, 13:41:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:41:42 INFO - 'talos_options': ['--xperf_path', 13:41:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:41:42 INFO - 'tests': ['tp5n']}}, 13:41:42 INFO - 'talos.zip': {'path': '', 13:41:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:41:42 INFO - Running post-action listener: _resource_record_post_action 13:41:42 INFO - ##### 13:41:42 INFO - ##### Running create-virtualenv step. 13:41:42 INFO - ##### 13:41:42 INFO - Running pre-action listener: _resource_record_pre_action 13:41:42 INFO - Running main action method: create_virtualenv 13:41:42 INFO - Creating virtualenv /builds/slave/test/build/venv 13:41:42 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 13:41:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:41:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:41:42 INFO - Using real prefix '/tools/python27' 13:41:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:41:43 INFO - Installing distribute.............................................................................................................................................................................................done. 13:41:46 INFO - Installing pip.................done. 13:41:46 INFO - Return code: 0 13:41:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:41:46 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')]} 13:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:46 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')]} 13:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:46 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c574420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a582560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c403e00>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3feb20>, '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.xvqpTuaqIE/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.wTukm9aL5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 13:41:46 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 13:41:46 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 13:41:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xvqpTuaqIE/Render', 13:41:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:46 INFO - 'HOME': '/Users/cltbld', 13:41:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:46 INFO - 'LOGNAME': 'cltbld', 13:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:46 INFO - 'MOZ_NO_REMOTE': '1', 13:41:46 INFO - 'NO_EM_RESTART': '1', 13:41:46 INFO - 'PAGER': '/bin/cat', 13:41:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:46 INFO - 'PWD': '/builds/slave/test', 13:41:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:46 INFO - 'SHELL': '/bin/bash', 13:41:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTukm9aL5i/Listeners', 13:41:46 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 13:41:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:46 INFO - 'USER': 'cltbld', 13:41:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:46 INFO - 'XPC_FLAGS': '0x0', 13:41:46 INFO - 'XPC_SERVICE_NAME': '0', 13:41:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:46 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 13:41:46 INFO - Cleaning up... 13:41:46 INFO - Return code: 0 13:41:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:41:46 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')]} 13:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:46 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')]} 13:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:46 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c574420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a582560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c403e00>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3feb20>, '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.xvqpTuaqIE/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.wTukm9aL5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 13:41:46 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 13:41:46 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 13:41:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xvqpTuaqIE/Render', 13:41:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:46 INFO - 'HOME': '/Users/cltbld', 13:41:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:46 INFO - 'LOGNAME': 'cltbld', 13:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:46 INFO - 'MOZ_NO_REMOTE': '1', 13:41:46 INFO - 'NO_EM_RESTART': '1', 13:41:46 INFO - 'PAGER': '/bin/cat', 13:41:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:46 INFO - 'PWD': '/builds/slave/test', 13:41:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:46 INFO - 'SHELL': '/bin/bash', 13:41:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTukm9aL5i/Listeners', 13:41:46 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 13:41:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:46 INFO - 'USER': 'cltbld', 13:41:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:46 INFO - 'XPC_FLAGS': '0x0', 13:41:46 INFO - 'XPC_SERVICE_NAME': '0', 13:41:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:46 INFO - Downloading/unpacking psutil>=0.7.1 13:41:46 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 13:41:46 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 13:41:46 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 13:41:46 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 13:41:46 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 13:41:46 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 13:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:41:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:41:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:41:49 INFO - Installing collected packages: psutil 13:41:49 INFO - Running setup.py install for psutil 13:41:49 INFO - building 'psutil._psutil_osx' extension 13:41:49 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 13:41:50 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 13:41:50 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 13:41:50 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 13:41:50 INFO - building 'psutil._psutil_posix' extension 13:41:50 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 13:41:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:41:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:41:50 INFO - ^ 13:41:50 INFO - 1 warning generated. 13:41:50 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 13:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:41:50 INFO - Successfully installed psutil 13:41:50 INFO - Cleaning up... 13:41:51 INFO - Return code: 0 13:41:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c574420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a582560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c403e00>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3feb20>, '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.xvqpTuaqIE/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.wTukm9aL5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 13:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:41:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xvqpTuaqIE/Render', 13:41:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:51 INFO - 'HOME': '/Users/cltbld', 13:41:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:51 INFO - 'LOGNAME': 'cltbld', 13:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:51 INFO - 'MOZ_NO_REMOTE': '1', 13:41:51 INFO - 'NO_EM_RESTART': '1', 13:41:51 INFO - 'PAGER': '/bin/cat', 13:41:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:51 INFO - 'PWD': '/builds/slave/test', 13:41:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:51 INFO - 'SHELL': '/bin/bash', 13:41:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTukm9aL5i/Listeners', 13:41:51 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 13:41:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:51 INFO - 'USER': 'cltbld', 13:41:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:51 INFO - 'XPC_FLAGS': '0x0', 13:41:51 INFO - 'XPC_SERVICE_NAME': '0', 13:41:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:41:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:41:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:41:53 INFO - Installing collected packages: mozsystemmonitor 13:41:53 INFO - Running setup.py install for mozsystemmonitor 13:41:53 INFO - Successfully installed mozsystemmonitor 13:41:53 INFO - Cleaning up... 13:41:53 INFO - Return code: 0 13:41:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:41:53 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')]} 13:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:53 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')]} 13:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:53 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c574420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a582560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c403e00>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3feb20>, '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.xvqpTuaqIE/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.wTukm9aL5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 13:41:53 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 13:41:53 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 13:41:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xvqpTuaqIE/Render', 13:41:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:53 INFO - 'HOME': '/Users/cltbld', 13:41:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:53 INFO - 'LOGNAME': 'cltbld', 13:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:53 INFO - 'MOZ_NO_REMOTE': '1', 13:41:53 INFO - 'NO_EM_RESTART': '1', 13:41:53 INFO - 'PAGER': '/bin/cat', 13:41:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:53 INFO - 'PWD': '/builds/slave/test', 13:41:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:53 INFO - 'SHELL': '/bin/bash', 13:41:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTukm9aL5i/Listeners', 13:41:53 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 13:41:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:53 INFO - 'USER': 'cltbld', 13:41:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:53 INFO - 'XPC_FLAGS': '0x0', 13:41:53 INFO - 'XPC_SERVICE_NAME': '0', 13:41:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:41:54 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 13:41:54 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 13:41:54 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 13:41:54 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 13:41:54 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 13:41:54 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 13:41:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:41:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:41:56 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 13:41:56 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 13:41:56 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 13:41:56 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 13:41:56 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 13:41:56 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 13:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:41:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:41:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:57 INFO - Downloading docopt-0.6.1.tar.gz 13:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:41:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:41:57 INFO - Running setup.py install for blobuploader 13:41:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:41:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:41:58 INFO - Running setup.py install for requests 13:41:58 INFO - Running setup.py install for docopt 13:41:58 INFO - Successfully installed blobuploader requests docopt 13:41:58 INFO - Cleaning up... 13:41:58 INFO - Return code: 0 13:41:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:41: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')]} 13:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41: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')]} 13:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:58 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c574420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a582560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c403e00>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3feb20>, '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.xvqpTuaqIE/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.wTukm9aL5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 13:41:58 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 13:41:58 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 13:41:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xvqpTuaqIE/Render', 13:41:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:58 INFO - 'HOME': '/Users/cltbld', 13:41:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:58 INFO - 'LOGNAME': 'cltbld', 13:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:58 INFO - 'MOZ_NO_REMOTE': '1', 13:41:58 INFO - 'NO_EM_RESTART': '1', 13:41:58 INFO - 'PAGER': '/bin/cat', 13:41:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:58 INFO - 'PWD': '/builds/slave/test', 13:41:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:58 INFO - 'SHELL': '/bin/bash', 13:41:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTukm9aL5i/Listeners', 13:41:58 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 13:41:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:58 INFO - 'USER': 'cltbld', 13:41:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:58 INFO - 'XPC_FLAGS': '0x0', 13:41:58 INFO - 'XPC_SERVICE_NAME': '0', 13:41:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:41:59 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-sE8NVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:41:59 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-_R27Tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:41:59 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-KKmq_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:41:59 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-HLgrBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:41:59 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-5qlP6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:41:59 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-ES5MF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:41:59 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Iun1hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:41:59 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-PAM1bV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:41:59 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-JZYXrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:41:59 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-yUDCpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:42:00 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-0sxNCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:42:00 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-EFa2xO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:42:00 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-4qFDnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:42:00 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-3N4qfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:00 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Ib_RvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:42:00 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-fXpDbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:42:00 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-ACb0hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:42:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:42:00 INFO - Running setup.py install for manifestparser 13:42:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:42:00 INFO - Running setup.py install for mozcrash 13:42:01 INFO - Running setup.py install for mozdebug 13:42:01 INFO - Running setup.py install for mozdevice 13:42:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:42:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:42:01 INFO - Running setup.py install for mozfile 13:42:01 INFO - Running setup.py install for mozhttpd 13:42:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:42:01 INFO - Running setup.py install for mozinfo 13:42:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:42:01 INFO - Running setup.py install for mozInstall 13:42:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:42:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:42:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:42:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:42:01 INFO - Running setup.py install for mozleak 13:42:02 INFO - Running setup.py install for mozlog 13:42:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:42:02 INFO - Running setup.py install for moznetwork 13:42:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:42:02 INFO - Running setup.py install for mozprocess 13:42:02 INFO - Running setup.py install for mozprofile 13:42:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:42:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:42:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:42:02 INFO - Running setup.py install for mozrunner 13:42:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:42:02 INFO - Running setup.py install for mozscreenshot 13:42:03 INFO - Running setup.py install for moztest 13:42:03 INFO - Running setup.py install for mozversion 13:42:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:42:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:42:03 INFO - Cleaning up... 13:42:03 INFO - Return code: 0 13:42:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:03 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c574420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a582560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c403e00>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3feb20>, '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.xvqpTuaqIE/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.wTukm9aL5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 13:42:03 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 13:42:03 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 13:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xvqpTuaqIE/Render', 13:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:03 INFO - 'HOME': '/Users/cltbld', 13:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:03 INFO - 'LOGNAME': 'cltbld', 13:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:03 INFO - 'MOZ_NO_REMOTE': '1', 13:42:03 INFO - 'NO_EM_RESTART': '1', 13:42:03 INFO - 'PAGER': '/bin/cat', 13:42:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:03 INFO - 'PWD': '/builds/slave/test', 13:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:03 INFO - 'SHELL': '/bin/bash', 13:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTukm9aL5i/Listeners', 13:42:03 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 13:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:03 INFO - 'USER': 'cltbld', 13:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:03 INFO - 'XPC_FLAGS': '0x0', 13:42:03 INFO - 'XPC_SERVICE_NAME': '0', 13:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:42:03 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-8vIu1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:42:03 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)) 13:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:42:03 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-UO68jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:42:03 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)) 13:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:42:03 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-xNRx3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:42:03 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)) 13:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:42:03 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-4__s3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:42:04 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)) 13:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:42:04 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-cALU_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:42:04 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)) 13:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:42:04 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-6aPKb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:42:04 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)) 13:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:42:04 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-3trUQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:42:04 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)) 13:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:42:04 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-N2cWEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:42:04 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)) 13:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:42:04 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-tXVPWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:42:04 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)) 13:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:42:04 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-lBHzT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:42:04 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)) 13:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:42:04 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-dHyk1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:42:04 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)) 13:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:42:04 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-QRnoqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:42:04 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)) 13:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:42:04 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-oWBWeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:42:05 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)) 13:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:42:05 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-PFuJPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:42:05 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)) 13:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:05 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-LXsOHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:05 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)) 13:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:42:05 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-0PFmxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:42:05 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)) 13:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:42:05 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Ri0Ome-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:42:05 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)) 13:42:05 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)) 13:42:05 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)) 13:42:05 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)) 13:42:05 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)) 13:42:05 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)) 13:42:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:07 INFO - Downloading blessings-1.6.tar.gz 13:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:42:08 INFO - Installing collected packages: blessings 13:42:08 INFO - Running setup.py install for blessings 13:42:08 INFO - Successfully installed blessings 13:42:08 INFO - Cleaning up... 13:42:08 INFO - Return code: 0 13:42:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:42:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:42:08 INFO - Reading from file tmpfile_stdout 13:42:08 INFO - Current package versions: 13:42:08 INFO - blessings == 1.6 13:42:08 INFO - blobuploader == 1.2.4 13:42:08 INFO - docopt == 0.6.1 13:42:08 INFO - manifestparser == 1.1 13:42:08 INFO - mozInstall == 1.12 13:42:08 INFO - mozcrash == 0.17 13:42:08 INFO - mozdebug == 0.1 13:42:08 INFO - mozdevice == 0.48 13:42:08 INFO - mozfile == 1.2 13:42:08 INFO - mozhttpd == 0.7 13:42:08 INFO - mozinfo == 0.9 13:42:08 INFO - mozleak == 0.1 13:42:08 INFO - mozlog == 3.1 13:42:08 INFO - moznetwork == 0.27 13:42:08 INFO - mozprocess == 0.22 13:42:08 INFO - mozprofile == 0.28 13:42:08 INFO - mozrunner == 6.11 13:42:08 INFO - mozscreenshot == 0.1 13:42:08 INFO - mozsystemmonitor == 0.0 13:42:08 INFO - moztest == 0.7 13:42:08 INFO - mozversion == 1.4 13:42:08 INFO - psutil == 3.1.1 13:42:08 INFO - requests == 1.2.3 13:42:08 INFO - wsgiref == 0.1.2 13:42:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:08 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 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c574420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a582560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c403e00>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3feb20>, '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.xvqpTuaqIE/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.wTukm9aL5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 13:42:08 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 13:42:08 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 13:42:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xvqpTuaqIE/Render', 13:42:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:08 INFO - 'HOME': '/Users/cltbld', 13:42:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:08 INFO - 'LOGNAME': 'cltbld', 13:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:08 INFO - 'MOZ_NO_REMOTE': '1', 13:42:08 INFO - 'NO_EM_RESTART': '1', 13:42:08 INFO - 'PAGER': '/bin/cat', 13:42:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:08 INFO - 'PWD': '/builds/slave/test', 13:42:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:08 INFO - 'SHELL': '/bin/bash', 13:42:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTukm9aL5i/Listeners', 13:42:08 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 13:42:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:08 INFO - 'USER': 'cltbld', 13:42:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:08 INFO - 'XPC_FLAGS': '0x0', 13:42:08 INFO - 'XPC_SERVICE_NAME': '0', 13:42:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:08 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)) 13:42:08 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)) 13:42:08 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)) 13:42:08 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)) 13:42:08 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)) 13:42:08 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)) 13:42:08 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)) 13:42:08 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)) 13:42:08 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)) 13:42:08 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)) 13:42:08 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)) 13:42:08 INFO - Cleaning up... 13:42:08 INFO - Return code: 0 13:42:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c574420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a582560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c403e00>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3feb20>, '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.xvqpTuaqIE/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.wTukm9aL5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 13:42:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:42:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xvqpTuaqIE/Render', 13:42:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:08 INFO - 'HOME': '/Users/cltbld', 13:42:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:08 INFO - 'LOGNAME': 'cltbld', 13:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:08 INFO - 'MOZ_NO_REMOTE': '1', 13:42:08 INFO - 'NO_EM_RESTART': '1', 13:42:08 INFO - 'PAGER': '/bin/cat', 13:42:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:08 INFO - 'PWD': '/builds/slave/test', 13:42:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:08 INFO - 'SHELL': '/bin/bash', 13:42:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTukm9aL5i/Listeners', 13:42:08 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 13:42:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:08 INFO - 'USER': 'cltbld', 13:42:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:08 INFO - 'XPC_FLAGS': '0x0', 13:42:08 INFO - 'XPC_SERVICE_NAME': '0', 13:42:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:09 INFO - Downloading/unpacking jsonschema 13:42:09 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 13:42:09 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 13:42:09 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 13:42:09 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 13:42:09 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 13:42:09 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 13:42:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:42:11 INFO - Downloading/unpacking functools32 (from jsonschema) 13:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:11 INFO - Downloading functools32-3.2.3-2.tar.gz 13:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:42:11 INFO - warning: no files found matching '*.txt' 13:42:11 INFO - no previously-included directories found matching 'build' 13:42:11 INFO - no previously-included directories found matching 'dist' 13:42:11 INFO - no previously-included directories found matching '.git*' 13:42:11 INFO - Installing collected packages: jsonschema, functools32 13:42:12 INFO - Running setup.py install for functools32 13:42:12 INFO - warning: no files found matching '*.txt' 13:42:12 INFO - no previously-included directories found matching 'build' 13:42:12 INFO - no previously-included directories found matching 'dist' 13:42:12 INFO - no previously-included directories found matching '.git*' 13:42:12 INFO - Successfully installed jsonschema functools32 13:42:12 INFO - Cleaning up... 13:42:12 INFO - Return code: 0 13:42:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:42: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')]} 13:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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')]} 13:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c564a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c574420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc15a582560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c403e00>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3feb20>, '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.xvqpTuaqIE/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.wTukm9aL5i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 13:42: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', 'flake8'] in /builds/slave/test/build 13:42: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 flake8 13:42:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xvqpTuaqIE/Render', 13:42:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:12 INFO - 'HOME': '/Users/cltbld', 13:42:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:12 INFO - 'LOGNAME': 'cltbld', 13:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:12 INFO - 'MOZ_NO_REMOTE': '1', 13:42:12 INFO - 'NO_EM_RESTART': '1', 13:42:12 INFO - 'PAGER': '/bin/cat', 13:42:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:12 INFO - 'PWD': '/builds/slave/test', 13:42:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:12 INFO - 'SHELL': '/bin/bash', 13:42:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTukm9aL5i/Listeners', 13:42:12 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 13:42:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:12 INFO - 'USER': 'cltbld', 13:42:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:12 INFO - 'XPC_FLAGS': '0x0', 13:42:12 INFO - 'XPC_SERVICE_NAME': '0', 13:42:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:12 INFO - Downloading/unpacking flake8 13:42: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 13:42: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 13:42: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 13:42: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 13:42: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 13:42: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 13:42:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:42:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:42:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:42:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:42:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:42:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:42:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:42:16 INFO - no previously-included directories found matching 'docs/_build' 13:42:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:42:16 INFO - Running setup.py install for pep8 13:42:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:42:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:42:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:42:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:42:16 INFO - no previously-included directories found matching 'docs/_build' 13:42:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:42:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:42:16 INFO - Cleaning up... 13:42:16 INFO - Return code: 0 13:42:16 INFO - Running post-action listener: _resource_record_post_action 13:42:16 INFO - Running post-action listener: _start_resource_monitoring 13:42:16 INFO - Starting resource monitoring. 13:42:16 INFO - ##### 13:42:16 INFO - ##### Running install step. 13:42:16 INFO - ##### 13:42:16 INFO - Running pre-action listener: _resource_record_pre_action 13:42:16 INFO - Running main action method: install 13:42:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:42:16 INFO - Reading from file tmpfile_stdout 13:42:16 INFO - Detecting whether we're running mozinstall >=1.0... 13:42:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:42:17 INFO - Reading from file tmpfile_stdout 13:42:17 INFO - Output received: 13:42:17 INFO - Usage: mozinstall [options] installer 13:42:17 INFO - Options: 13:42:17 INFO - -h, --help show this help message and exit 13:42:17 INFO - -d DEST, --destination=DEST 13:42:17 INFO - Directory to install application into. [default: 13:42:17 INFO - "/builds/slave/test"] 13:42:17 INFO - --app=APP Application being installed. [default: firefox] 13:42:17 INFO - mkdir: /builds/slave/test/build/application 13:42:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:42:50 INFO - Reading from file tmpfile_stdout 13:42:50 INFO - Output received: 13:42:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:42:50 INFO - Running post-action listener: _resource_record_post_action 13:42:50 INFO - ##### 13:42:50 INFO - ##### Running run-tests step. 13:42:50 INFO - ##### 13:42:50 INFO - Running pre-action listener: _resource_record_pre_action 13:42:50 INFO - Running main action method: run_tests 13:42:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:42:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:42:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:42:50 INFO - 2016-04-15 13:42:50.165 screenresolution[1642:7797] starting screenresolution argv=screenresolution get 13:42:50 INFO - 2016-04-15 13:42:50.168 screenresolution[1642:7797] Display 0: 1600x1200x32@60 13:42:50 INFO - 2016-04-15 13:42:50.174 screenresolution[1643:7799] starting screenresolution argv=screenresolution list 13:42:50 INFO - Available Modes on Display 0 13:42:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:42:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:42:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:42:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:42:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:42:50 INFO - Intel Iris: 13:42:50 INFO - Chipset Model: Intel Iris 13:42:50 INFO - Type: GPU 13:42:50 INFO - Bus: Built-In 13:42:50 INFO - VRAM (Dynamic, Max): 1536 MB 13:42:50 INFO - Vendor: Intel (0x8086) 13:42:50 INFO - Device ID: 0x0a2e 13:42:50 INFO - Revision ID: 0x0009 13:42:50 INFO - Displays: 13:42:50 INFO - Display: 13:42:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:42:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:42:50 INFO - Display Serial Number: 1600x1200 60 13:42:50 INFO - Main Display: Yes 13:42:50 INFO - Mirror: Off 13:42:50 INFO - Online: Yes 13:42:50 INFO - Rotation: Supported 13:42:50 INFO - Return code: 0 13:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:42:50 INFO - Python 2.7.3 13:42:50 INFO - Return code: 0 13:42:50 INFO - grabbing minidump binary from tooltool 13:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:50 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 0x10c403e00>, '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 0x10c26cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3feb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:42:50 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 13:42:50 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 13:42:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:42:50 INFO - Return code: 0 13:42:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:42:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:42:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:42:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:42:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:42:51 INFO - Return code: 0 13:42:51 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/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--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 13:42:51 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/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0189 --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 13:42:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xvqpTuaqIE/Render', 13:42:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:42:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:42:51 INFO - 'HOME': '/Users/cltbld', 13:42:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:42:51 INFO - 'LOGNAME': 'cltbld', 13:42:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:42:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:51 INFO - 'MOZ_NO_REMOTE': '1', 13:42:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:42:51 INFO - 'NO_EM_RESTART': '1', 13:42:51 INFO - 'PAGER': '/bin/cat', 13:42:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:51 INFO - 'PWD': '/builds/slave/test', 13:42:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:42:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:42:51 INFO - 'SHELL': '/bin/bash', 13:42:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wTukm9aL5i/Listeners', 13:42:51 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 13:42:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:42:51 INFO - 'USER': 'cltbld', 13:42:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:42:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:51 INFO - 'XPC_FLAGS': '0x0', 13:42:51 INFO - 'XPC_SERVICE_NAME': '0', 13:42:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:42:51 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/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--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 13:42:51 INFO - mozversion application_buildid: 20160415122040 13:42:51 INFO - mozversion application_changeset: 355e9b83a662dd7e90a73b7c9cd556372c063ae9 13:42:51 INFO - mozversion application_display_name: Nightly 13:42:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:42:51 INFO - mozversion application_name: Firefox 13:42:51 INFO - mozversion application_remotingname: firefox 13:42:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:42:51 INFO - mozversion application_vendor: Mozilla 13:42:51 INFO - mozversion application_version: 48.0a1 13:42:51 INFO - mozversion platform_buildid: 20160415122040 13:42:51 INFO - mozversion platform_changeset: 355e9b83a662dd7e90a73b7c9cd556372c063ae9 13:42:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:42:51 INFO - mozversion platform_version: 48.0a1 13:42:51 INFO - using testdate: 1460752971 13:42:51 INFO - actual date: 1460752971 13:42:51 INFO - starting webserver on 'localhost:49275' 13:42:51 INFO - SUITE-START | Running 2 tests 13:42:51 INFO - TEST-START | dromaeo_css 13:42:51 INFO - operating with platform_type : mac_ 13:42:51 INFO - Initialising browser for dromaeo_css test... 13:42:51 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpCCHyz0/profile http://localhost:49275/getInfo.html) 13:42:54 INFO - PROCESS | 1661 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 13:42:55 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 13:42:55 INFO - PROCESS | 1661 | colorDepth:24 13:42:55 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 13:42:55 INFO - PROCESS | 1661 | __metrics 13:42:55 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:42:55 INFO - TEST-INFO | 1661: exit 0 13:42:55 INFO - Browser initialized. 13:42:55 INFO - Running cycle 1/1 for dromaeo_css test... 13:42:55 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpCCHyz0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:43:07 INFO - PROCESS | 1664 | RSS: Main: 248840192 13:43:07 INFO - PROCESS | 1664 | 13:43:57 INFO - PROCESS | 1664 | 1460753037417 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] 13:46:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 13:46:09 INFO - PROCESS | 1664 | RSS: Main: 261070848 13:46:09 INFO - PROCESS | 1664 | 13:49:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 13:49:12 INFO - PROCESS | 1664 | RSS: Main: 273137664 13:49:12 INFO - PROCESS | 1664 | 13:52:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 13:52:14 INFO - PROCESS | 1664 | RSS: Main: 275124224 13:52:14 INFO - PROCESS | 1664 | 13:55:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 13:55:17 INFO - PROCESS | 1664 | RSS: Main: 276680704 13:55:17 INFO - PROCESS | 1664 | 13:58:19 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 13:58:20 INFO - PROCESS | 1664 | RSS: Main: 279552000 13:58:20 INFO - PROCESS | 1664 | 14:01:22 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 14:01:23 INFO - PROCESS | 1664 | RSS: Main: 280715264 14:01:23 INFO - PROCESS | 1664 | 14:01:23 INFO - PROCESS | 1664 | __start_tp_report 14:01:23 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 14:01:23 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 14:01:23 INFO - PROCESS | 1664 | |i|pagename|runs| 14:01:23 INFO - PROCESS | 1664 | |0;dojo.html;3184.299454120093;3423.537822393976;3464.930701385972;3541.893743187704;3546.609872913979;4659.673822832403;5491.972540137293;5745.425457454257;5748.425157484249;5757.769689212437;5185.585153187745;5252.894942101156;5698.230738850254;5702.429757024306;5732.312122545301;4360.433143691315;4990.30135780991;5020.7489625518765;5293.391260005091;5403.837884863441;5112.156494178456;5118.564921981636;5138.177891537355;5262.92105618416;5284.841454756363;5216.165413533854;5236.973815130938;5246.527812496855;5256.159014557672;5263.105272103751;5253.763580638881;5254.842354729364;5260.736963151865;5267.3942496613;5292.52367286946;4830.227163653799;4860.392450943632;5108.821191258288;5262.368515778093;5273.077211488013;4958.87602809929;5416.458354164592;5471.179323101527;5655.66066036035;5708.372079071299;5074.568661663763;5415.025295446818;6071.605345652519;6199.969000154971;6222.253329600431;6145.310039739107;6169.5064394848305;6186.690665466754;6228.688565571703;6282.528810339197;4870.6103511718975;5934.139549765303;5939.406059394026;5942.197803296586;5951.880962380728;6403.455706265019;6405.48756099511;6408.391202835724;6414.903776443357;6426.646534440651;5259.973700131475;6014.0678194879865;6108.602940808833;6116.396640261158;6179.2584889812615;6188.133661287423;6247.0629405589525;6249.343818899041;6257.78097766576;6276.811695649138;6111.7132884518705;6206.3312775506065;6238.719257633417;6242.531810114259;6271.843203919939;6133.233345831771;6154.1999540059505;6157.138000679908;6232.0963460298;6278.30938596754;4892.363992680928;4948.752562371867;4953.7523123844385;4958.256261560795;4971.552560269521;4333.241682705514;4444.622207112432;4457.554244575581;4484.39460672805;4505.481869584974;5691.203231547586;5731.77072917087;5740.942590574041;5741.397153298927;5751.367349591542;4811.566958973709;5409.486098820606;5923.874463851855;6253.499720022387;6255.530835187288;5606.803761868315;5708.71456427177;5762.394948530427;5762.538996880239;5762.827115186551;4865.9756701216265;5214.165733482625;5442.482964118402;5447.346318441733;5490.286262785892;6455.709493072823;6467.353264673589;6483.967580162069;6491.902621460682;6494.285628580947;6108.038540470994;6141.977005061692;6211.13044173807;6228;6239.7504099837315;6430.356964303533;6463.612183269019;6475.870482590416;6489.286178520265;6522.05430212607;6156.984097624021;6171.382861713792;6201.689915504297;6215.96892015537;6229.688515574294;5238.371395432572;6125.418085281891;6126.395534290377;6136.969315153396;6236.34518375564;6136.32500424944;6153.293986281832;6162.845928851814;6198.597091189058;6209.161763161916;6152.907706384497;6172.660503672341;6173.84565385869;6179.258488981351;6198.132261483306;5783.942160578508;5910.586258962004;5937.524998000236;5940.346561878104;6049.546284028627;6124.908126378197;6139.877202455837;6163.476104531165;6181.598196117238;6206.379362063757;6046.697665116814;6058.0912863069125;6075.1191077294425;6077.4834139098675;6086.360932102066 14:01:23 INFO - PROCESS | 1664 | |1;ext.html;482.30066403714625;520.232656831174;531.2588938430889;538.8221886777362;552.715351593929;32025.519617205733;37281.25437491249;38205.61794382059;38271.85184444464;38357.04107397317;39225;39344.21311573767;39874.40188397176;39945.8002709986;39971.60028399715;9485.336026478166;9669.516524173798;9702.563384647672;9736.026397360243;9793.363431376938;9524.428534287965;9729.464879431629;9762.853557196648;9765.072318129767;9801.509924503782;9685.854712179324;9718.562664680107;9722.902770972305;9779.168770654504;9779.657711980082;9686.612535498572;9718.368306060083;9748.415095094282;9769.658061967868;9771.462569558671;9602.807943841084;9710;9713.805723885484;9745.415275083518;9749.220062395063;38674.41988370177;38826.02934926621;38875.611243887484;39136.608633913864;39188.60811391878;2709.092454027903;3151.416987857254;3212.6626704195955;3248.382807266612;3473.2358881046384;23392.496652075653;27769.86115069432;28841.134765957057;28995.855020724972;29717.405651886842;2736.8905243790223;2761.585762135676;2791.4975304445193;2858.456893190308;2905.694902035277;457088;460419;466311;468844;469226;36917.26165476676;37781.24437511234;68308;68976;69020.6548967262;36376.63623363733;36809;37190.8140459296;37199;37385;12758.80861787074;13226;15041.774373384407;15130.319135638923;15339.309731062129;10645.627403040857;10886.67339979802;12828.55100071493;12833.871661283454;12879.613611591667;8433.578321084044;8509.829803403898;8523.57382130891;8537.573121343908;8627.698030569025;3012.683668214806;3540.2034542227793;3567.7502574820032;3577.94633080504;3581.2658405026905;967.5645959318335;972.2610815780058;986.4475893499663;1006.597361055569;1101.911847052234;29758.40483190324;29932.40135197284;30017.549736753965;30174.698253017188;30231.848840755654;1064.3347907557777;1098.9395583243;1108.6729414822646;1133.2690414682484;1167.9065674746;15337;15425.922870385577;15479.5356139316;15794.36822527086;15824.60438489047;627138;637907;648677;651511;655485;50264.49735502671;59665.40334596685;60588;61092.69453652703;61290.693546531984;1355.9457621695021;1433.8852891768634;1498.4081287891222;1503.255888335281;1510.4411367793987;28993.13020609385;29275.56086658659;29524.409511810074;29984.25039374033;29990.550141747455;53926;54179.45820541744;54498.45501544934;54582.72708636431;54630.45369546254;548421;549358.2532087314;558877.2056139855;567800;575427;27032;27877;27900.72099278981;28156.43687126287;28231.858840705667;45987.77006114948;46162.538374617165;47218.29172562483;47885.28172077491;48638;37045.259094818495;38251;38310.80844595759;38675.6132438672;38742;37418.812905935294;37537.624623753414;37543.061423464635;38215;38506.229875402896;37413.25173496569;37992.430113547765;38127.42808857925;38498.422523661604;38729.225415492096;31678;33400.33199336048;33680.83159584186;33757.49363759496;34084.659153408145;23490.882545587163;24638;24760.13339533108;24999.50001000006;25066.71721378962 14:01:23 INFO - PROCESS | 1664 | |2;jquery.html;391.47933248779117;392.2096974596187;394.88153553933813;395.17605791923836;404.7814180342615;14635.19506427146;19968.400947971546;20650.586988260227;20682.793172068275;20720.378388648347;18695.532611684714;19692.507687307825;20269.898650506762;21354.145834166615;21467.6779848302;5737.684427356494;5894.557908156895;5927.170196172539;5952.70236488176;5974.133750606159;4737.697133288339;5001.299818025479;5583.994880921433;5833.066709326508;5916.556258280624;5231.372235331746;5730.05454100073;5899.380565040673;5919.437653422918;5930.762769489215;5492.956338295731;5500.724963751796;5673;5933.643981361132;5936.465718085371;5082.23766435034;5102.209157580581;5157.71632560209;5167.715775632339;5186.974065129651;11823.704407389798;25167.24498265055;25697.486050279076;26317.868410658015;26657.600135997975;2111.2399536166968;2124.915003399862;2183.7816218378193;2266.2861198722517;2371.324172610815;9000.189982901506;9443.291753118543;9681.031896810333;9737.707868763948;9792.657256996043;1630.5271471273315;1670.1315316035716;1675.9416641476446;1696.7285234362566;1744.5464179313342;86528.56735716344;104585.47707261491;109477;110276;111111.33333000011;10823.13414926804;11144.941230583081;11166.994970452535;11174.888251117547;11216.270942388719;14150.433982640785;14164.929175354264;14217.43130274798;14234;14337.92831035859;8393.874091888627;8516;8588.656453741905;8630.697925572575;8689.6524139035;7710.884336734954;8274.213949674771;8481.830363392697;8546.401751877309;8654.610542525475;4364.694471387036;4368.4321038264825;4453.554644535585;4517.5256598057385;4528.252838281713;1602.7275363188287;1897.3643829317057;1930.9613807723767;1937.321937321926;1944.270898413095;875.1991927386497;905.1536813079659;906.5784410249134;928.5635751197061;1017.811704834608;19872.60254794896;20358.083886225155;20593;20912;20999.895000525205;717.7631381644045;906.3021473465395;944.1927152284835;953.6709835107016;991.7520619845038;10451.425171615634;10888.891111088946;10936.289141205796;10945.562177512811;10949.616763413402;570338;603999.9800000972;617991;621672;622498;129078.70921290855;134032;136066.31966840103;136854;138774.3061284687;1011.8431643095332;1017.0541396501325;1030.8711411073616;1032.70051685012;1033.4625994482826;17786.5553361167;17950.39719240729;18183.909080454512;18203.908980455013;18471.90764046171;38756;42198.94502637459;44782;49568;49599.50400495949;71922;75416;75790.62104689442;76731.61634191794;77138.2286177131;6867.416269616939;7232.168300645493;7291.8541629168185;7891.092524359772;7970.721024764105;10842.186835987175;12134.453949572115;12248.632541023784;12493.312867792358;12510.124291299522;9768.97425770284;10790.784184316426;10826.133909287395;10826.56693732242;11125.721856953642;10770.569177232823;10869.130469562575;10921.180911431515;10941.945290273497;11010.889891100986;11260.493277802683;11294.830577541508;11389.829152562885;11596.130290228435;11632.767344653228;7334.596597186993;7345.55926644403;7381.11426628808;7394.742893707975;7473.850522989618;10272.435016073889;11092.556297748;11322.94338528302;11350.375729334966;11364.602238921598 14:01:23 INFO - PROCESS | 1664 | |3;mootools.html;1561.9609509762254;1603.1503303249276;1846;1937.8062193780615;1940.5536726552893;7871.80320491988;8434.156584341563;8437.66249350026;8691.261242794362;8711.477311361323;8431.03043150038;8503.064662887093;8519.91480085199;8569.928758905136;8580.39937204396;2364.4088977755605;2395.9161429349974;2397.06514459361;2397.988010059947;2401.171595799455;2356.646503024543;2369.2300002499255;2393.9760602394012;2398.7121545414575;2400.543896659629;2374.6438034294906;2377.785999260066;2388.128333158393;2407.6629271901948;2409.939751506218;2355.4464700795297;2374.7743964323363;2378.857268563892;2380.4762952150586;2381.8094552435764;1923.8653294269407;2250.88581152329;2351.247600767755;2365.8343915925893;2382.7736365045293;8706.738797836075;8712.782180445476;8733.519656418894;8736;8748.650053997833;5094.337736094284;5179.922301165486;5235.633505654606;5321.2284218788445;5335.67985920846;3243.140567749548;3351.346487434951;3390.2371966307383;3428.142964258935;3434.8797792077407;945.9432434053979;973.9610415583439;979.5298256836687;982.8869679986822;997.3866072365515;9808.46053467059;9971.501424928725;10751.709794824672;11202.943985280102;11223.38271395073;3895.6299151580556;4293.162833247549;4433.7561434121435;4557.134144512532;4591.17358875399;8729.170728780755;8793.516356600321;8859.778505537413;8863.778405539784;8917.152870477294;5072.213806859942;5109.029284436019;5130.9230361544605;5137.972405518911;5184.196449550326;4309.461317335333;4682.391289132391;4812.783424745895;4824.782884770124;4850.393700787402;3721.925561488755;3749.4750734897134;3773.1510410157493;3814.771113733185;3878.5733569307354;1185.4013723069795;1188.6731148933939;1198.5804968261214;1201.5253974679952;1208.3354155214597;805.1988271669609;826.1779529368317;899.7030979776658;901.4230892228978;935.3452583191657;5513.2005859150195;5552.972235138879;5782.2483077199695;5819.098039803837;5881.3530511643685;445.1097804391218;451.01903360191454;452.66050462153385;455.0126226089394;462.44737538641;3826.234753049401;3880.7865567394065;3883.514560679915;3900.6294402031763;3936.291467535814;10185.490725463696;10295.433751143759;10624.309419887682;10657.73355666099;10680;10426.426546540013;10515.579376824995;10589.894101059044;10640.308379955279;10647.094996925349;7896.447248692652;7933.127355990951;7982.800429989296;8031.237032481905;8038.236367545074;5577.2191893135805;5607.691576963143;5664.320281566238;5723.513501352431;5849.151872978479;9040.864387034067;9484.85772713396;9565.569549370155;9568.712938611852;9613.423194608346;9197.77005574866;9596.416591262363;9632.711018669452;9676.419414835133;9697.563609637724;7067.964660176666;7070.399016083485;7131.2512186221775;7184.317489838457;7226.927730722626;7959.164287749702;7991.360691144579;8008.519488830689;8010.239027292398;8023.558704271321;7146.428285737024;7302.217082702004;7345.55926644403;7362.153352364547;7382.187959324578;7115.466340024415;7142.928570714226;7190.6404679764755;7221.988921551092;7302.452316076209;6757.3242675732035;6764.458843292623;6775.695093720893;6799.422049125879;6822.249552549315;4363.2582460981075;4723.952760472489;4748.715077095385;4802.51974802517;4901.877453063702;3791.9810400947817;4706.364640773451;4786.521347865325;4799.616030717604;4860.73265970375 14:01:23 INFO - PROCESS | 1664 | |4;prototype.html;310.73742687429126;316.63745011961305;325.46623537398665;328.7402951668182;328.92599165187823;6011.475180424221;6162.84592885177;6200.472959798417;6269.749210031593;6275.748970041199;6156.969215153918;6197.752089916398;6215.564910456259;6231.844203894893;6266.216722909637;4449.332600109985;4663.440387153546;4664.300354946751;4675.7895894684825;4702.553257440538;3549.8402571884326;3759.360908645523;4440.023194897118;4565.908681826361;4694.788734506956;4459.108178364324;4480.103979204156;4492.438445194351;4515.412996310475;4515.4581450226015;4536.478304994935;4538.320821296125;4546.499885012646;4547.567981041796;4558.247889098295;3019.8037127586636;3719.367707489733;3804.9429258561145;3837.2371892237825;3840.6735427488697;5127.948720512822;5859.560532960045;5860.157823455664;5904.439078287556;5907.763689452459;5223.869403264911;5224.503672151178;5230.34620672416;5249.895002099975;5260.658057226268;5359.571234301286;5737.3688894221605;6362.586431881913;6459.192600924885;6506.54454188207;4216.786187251718;4244.405783190356;4253.340732186516;4257.893552661209;4281.743095414254;5345.331833520771;6595.406413422767;6862.691178896962;6949.93050069503;6977.372036516738;3766.5668448128267;3867.7872717000273;4151.481064866892;4198.160367926427;4287.742735435884;3887.8639247626197;4351.456067991501;4405.251107311765;4410.184115938498;4419.558044195554;4378.387025816388;4586.747728874877;5057.848264551996;5209.661372010807;5252.107141785906;5072.137736584789;5740.512056475246;6486.286508484063;6575.408213260829;6593.967030164818;1486.4351546412295;1511.4205655090457;1517.1352329172266;1520.4374381478924;1525.6872341170033;942.1520631431766;965.3435663748718;974.9220062394992;976.1019861727228;983.0709979069853;5557.861053473614;5925.140854576062;6049.758009679652;6106.267247930188;6115.449609535163;6762;6788.660566971632;6807.285235050347;6817.216020157646;6823.805833979034;5866.887920348671;5998.760049598054;6051.304100028465;6100.298465676416;6123.816285511352;3010.4581175388203;3031.9848400758297;3597.5143355647174;3618.9638103618627;3633.2006958469624;6763.864722705518;6885.380315771605;7120.893186602205;7123.43012558994;7176.174739904874;6993.825154371181;7014.508984371045;7025.770490164303;7040.295970402919;7045.084139061889;5819.592628516048;6891.1189505771845;7029.92970070303;7134.072570565793;7190.424766018706;5633.690147041788;6047.304559975659;6557.639329836905;6780.186377634715;6782;6215.720292586935;6386.457151142019;6395.872082558416;6689.698963546554;6863.347981941708;6744.369695818733;7042.753503627348;7203.8919416207755;7227.494075414881;7281.199068102399;3674.338619048597;4323.1137616787855;4340.9131817364105;4353.782310884507;4369.8587692031315;6604.405603495708;6909.965450172717;6910.343517365842;6917.13535808024;6918.0567076765765;6112.358202388685;6296.811095667137;6654.83362915931;6665.433438157811;6673.933260667525;6604.14146160996;6619.300296789141;6636.435902948304;6662.267150613526;6662.500312476681;4845.733484658378;5942.959982003219;6283;6456.483481321577;6509;6477.319881412383;6616.305287944697;6658;6688.163979502562;6718.529702920749;5764.481196692318;6377.96811015942;6449.677516124269;6538.803835884931;6547.443467305332 14:01:23 INFO - PROCESS | 1664 | |5;yui.html;666.2271764752886;707.9256678048805;727.051198186367;733.6221845749436;746.7274444827636;14703.41186352546;14937;14956.177410242432;15120.319585618647;15212.163331016804;14234.288285585732;14274.785878211835;14310.713785724305;14329.426822927071;14406.855931440683;750.1635676221001;885.3935054487664;899.0515006667979;917.9954100229489;920.4201353147541;884.1291328041906;927.8608208768671;934.0612684252317;934.9859752103724;937.9588656591178;961.3366776923936;981.6564202529129;987.4174237200051;989.3618615992681;990.1237404896647;954.4941181173954;968.6851773173747;978.2027647467327;980.9699815194089;981.543582234261;691.5435812363816;704.2886684448692;718.2924819053228;727.3998950865557;731.5610633619839;14720.852791472056;14867.776983345258;14962.775558366633;15109.848901510954;15162.09027458345;12759.872401276054;12768.936155319258;12853.550125745647;12903.22580645155;12984.675383115404;10032.799344013152;10841.13270938323;11040.889591104067;11561;11578.826317605242;3525.1715846775987;3534.2224710563637;3631.4371272452813;3635.1457407509215;3655.5796083450477;75368;76254;77489.22510774876;78490.82263766049;81982;9588.568514416867;9618.855717164248;9674.854877176847;9798.314118011813;9944.651937182163;21578.244761433274;22223;22356.217532386287;22367.888160559418;22662.320130396114;7528.5859277739155;7536.472446928772;7648.694052237959;7742.303192712683;7823.921760782433;4030.5364883038824;4056.3712624542654;4059.4925634295714;4060.878173654795;4064.878053658395;3458.4293591557616;3496.0735405117666;3514.6661067198575;3559.715222782171;3576.7675101118343;622.2812651387654;627.1345543150424;628.0986783965025;639.6354078175395;640.145405883142;520.625149892077;564.1903867949424;583.3437382944188;598.2432223237608;602.9306629737548;7687.884681729778;7720.452250757349;7965.561894095765;7992.960035199787;8000.4399692021;488.36024807502287;509.09381301283776;544.8561798423077;594.3787895381347;601.8224623736008;3684.742068055264;3732.197577520846;3752.981235093862;3798.5441746990537;3836.290286297044;88177;88207;91626.54186729157;92167;92479;58593.12110318348;75428.62285688646;76682.6165869167;77858;79390.41219175584;55853.7207313969;59798.70100649556;62882.68558657269;63309;67368;7788.260115289038;8065.072516660659;8080.232377924088;8124.7562573122905;8224.054233763194;38090.238195236496;38570;39546.209075817744;40101;41262.38106428346;49409.752951235016;51155.97688046293;57125.428745713674;57170;57281;10322.599988007483;10417.42704151279;10440.895591043993;10772.192085593455;10925.125989920629;11687.941560292484;11692.590759323382;11803.350815705218;11804.468798904241;12088.456019479321;10766.73083172927;11039.668809935714;11098.61154859576;11101.944490277498;11140.512176526094;10439.686809395731;10465.947670261905;10797.784044318912;11036.668899933014;11083;10570.41862697559;10770.946145269223;11278;12138.150329477205;12212.938935305267;9251.235613658837;9270.351075424926;9320.254379649476;9477.526123693926;9555.235581153353;9472.194863436685;9621.807563848544;9630.855537166808;9671.758206044906;9694 14:01:23 INFO - PROCESS | 1664 | __end_tp_report 14:01:23 INFO - PROCESS | 1664 | __start_cc_report 14:01:23 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,407 14:01:23 INFO - PROCESS | 1664 | __end_cc_report 14:01:23 INFO - PROCESS | 1664 | __startTimestamp1460754083005__endTimestamp 14:01:23 INFO - PROCESS | 1664 | 14:01:23 INFO - PROCESS | 1664 | ------- Summary: start ------- 14:01:23 INFO - PROCESS | 1664 | Number of tests: 6 14:01:23 INFO - PROCESS | 1664 | 14:01:23 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5698.29 Median:5939.41 stddev:674.61 (11.4%) stddev-sans-first:647.21 14:01:23 INFO - PROCESS | 1664 | Values: 3184.3 3423.5 3464.9 3541.9 3546.6 4659.7 5492.0 5745.4 5748.4 5757.8 5185.6 5252.9 5698.2 5702.4 5732.3 4360.4 4990.3 5020.7 5293.4 5403.8 5112.2 5118.6 5138.2 5262.9 5284.8 5216.2 5237.0 5246.5 5256.2 5263.1 5253.8 5254.8 5260.7 5267.4 5292.5 4830.2 4860.4 5108.8 5262.4 5273.1 4958.9 5416.5 5471.2 5655.7 5708.4 5074.6 5415.0 6071.6 6200.0 6222.3 6145.3 6169.5 6186.7 6228.7 6282.5 4870.6 5934.1 5939.4 5942.2 5951.9 6403.5 6405.5 6408.4 6414.9 6426.6 5260.0 6014.1 6108.6 6116.4 6179.3 6188.1 6247.1 6249.3 6257.8 6276.8 6111.7 6206.3 6238.7 6242.5 6271.8 6133.2 6154.2 6157.1 6232.1 6278.3 4892.4 4948.8 4953.8 4958.3 4971.6 4333.2 4444.6 4457.6 4484.4 4505.5 5691.2 5731.8 5740.9 5741.4 5751.4 4811.6 5409.5 5923.9 6253.5 6255.5 5606.8 5708.7 5762.4 5762.5 5762.8 4866.0 5214.2 5442.5 5447.3 5490.3 6455.7 6467.4 6484.0 6491.9 6494.3 6108.0 6142.0 6211.1 6228.0 6239.8 6430.4 6463.6 6475.9 6489.3 6522.1 6157.0 6171.4 6201.7 6216.0 6229.7 5238.4 6125.4 6126.4 6137.0 6236.3 6136.3 6153.3 6162.8 6198.6 6209.2 6152.9 6172.7 6173.8 6179.3 6198.1 5783.9 5910.6 5937.5 5940.3 6049.5 6124.9 6139.9 6163.5 6181.6 6206.4 6046.7 6058.1 6075.1 6077.5 6086.4 14:01:23 INFO - PROCESS | 1664 | 14:01:23 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:67695.71 Median:38261.43 stddev:150215.22 (392.6%) stddev-sans-first:150551.85 14:01:23 INFO - PROCESS | 1664 | Values: 482.3 520.2 531.3 538.8 552.7 32025.5 37281.3 38205.6 38271.9 38357.0 39225.0 39344.2 39874.4 39945.8 39971.6 9485.3 9669.5 9702.6 9736.0 9793.4 9524.4 9729.5 9762.9 9765.1 9801.5 9685.9 9718.6 9722.9 9779.2 9779.7 9686.6 9718.4 9748.4 9769.7 9771.5 9602.8 9710.0 9713.8 9745.4 9749.2 38674.4 38826.0 38875.6 39136.6 39188.6 2709.1 3151.4 3212.7 3248.4 3473.2 23392.5 27769.9 28841.1 28995.9 29717.4 2736.9 2761.6 2791.5 2858.5 2905.7 457088.0 460419.0 466311.0 468844.0 469226.0 36917.3 37781.2 68308.0 68976.0 69020.7 36376.6 36809.0 37190.8 37199.0 37385.0 12758.8 13226.0 15041.8 15130.3 15339.3 10645.6 10886.7 12828.6 12833.9 12879.6 8433.6 8509.8 8523.6 8537.6 8627.7 3012.7 3540.2 3567.8 3577.9 3581.3 967.6 972.3 986.4 1006.6 1101.9 29758.4 29932.4 30017.5 30174.7 30231.8 1064.3 1098.9 1108.7 1133.3 1167.9 15337.0 15425.9 15479.5 15794.4 15824.6 627138.0 637907.0 648677.0 651511.0 655485.0 50264.5 59665.4 60588.0 61092.7 61290.7 1355.9 1433.9 1498.4 1503.3 1510.4 28993.1 29275.6 29524.4 29984.3 29990.6 53926.0 54179.5 54498.5 54582.7 54630.5 548421.0 549358.3 558877.2 567800.0 575427.0 27032.0 27877.0 27900.7 28156.4 28231.9 45987.8 46162.5 47218.3 47885.3 48638.0 37045.3 38251.0 38310.8 38675.6 38742.0 37418.8 37537.6 37543.1 38215.0 38506.2 37413.3 37992.4 38127.4 38498.4 38729.2 31678.0 33400.3 33680.8 33757.5 34084.7 23490.9 24638.0 24760.1 24999.5 25066.7 14:01:23 INFO - PROCESS | 1664 | 14:01:23 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:34538.22 Median:25432.37 stddev:101237.20 (398.1%) stddev-sans-first:101488.73 14:01:23 INFO - PROCESS | 1664 | Values: 391.5 392.2 394.9 395.2 404.8 14635.2 19968.4 20650.6 20682.8 20720.4 18695.5 19692.5 20269.9 21354.1 21467.7 5737.7 5894.6 5927.2 5952.7 5974.1 4737.7 5001.3 5584.0 5833.1 5916.6 5231.4 5730.1 5899.4 5919.4 5930.8 5493.0 5500.7 5673.0 5933.6 5936.5 5082.2 5102.2 5157.7 5167.7 5187.0 11823.7 25167.2 25697.5 26317.9 26657.6 2111.2 2124.9 2183.8 2266.3 2371.3 9000.2 9443.3 9681.0 9737.7 9792.7 1630.5 1670.1 1675.9 1696.7 1744.5 86528.6 104585.5 109477.0 110276.0 111111.3 10823.1 11144.9 11167.0 11174.9 11216.3 14150.4 14164.9 14217.4 14234.0 14337.9 8393.9 8516.0 8588.7 8630.7 8689.7 7710.9 8274.2 8481.8 8546.4 8654.6 4364.7 4368.4 4453.6 4517.5 4528.3 1602.7 1897.4 1931.0 1937.3 1944.3 875.2 905.2 906.6 928.6 1017.8 19872.6 20358.1 20593.0 20912.0 20999.9 717.8 906.3 944.2 953.7 991.8 10451.4 10888.9 10936.3 10945.6 10949.6 570338.0 604000.0 617991.0 621672.0 622498.0 129078.7 134032.0 136066.3 136854.0 138774.3 1011.8 1017.1 1030.9 1032.7 1033.5 17786.6 17950.4 18183.9 18203.9 18471.9 38756.0 42198.9 44782.0 49568.0 49599.5 71922.0 75416.0 75790.6 76731.6 77138.2 6867.4 7232.2 7291.9 7891.1 7970.7 10842.2 12134.5 12248.6 12493.3 12510.1 9769.0 10790.8 10826.1 10826.6 11125.7 10770.6 10869.1 10921.2 10941.9 11010.9 11260.5 11294.8 11389.8 11596.1 11632.8 7334.6 7345.6 7381.1 7394.7 7473.9 10272.4 11092.6 11322.9 11350.4 11364.6 14:01:23 INFO - PROCESS | 1664 | 14:01:23 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5494.00 Median:5119.98 stddev:3056.71 (59.7%) stddev-sans-first:3051.00 14:01:23 INFO - PROCESS | 1664 | Values: 1562.0 1603.2 1846.0 1937.8 1940.6 7871.8 8434.2 8437.7 8691.3 8711.5 8431.0 8503.1 8519.9 8569.9 8580.4 2364.4 2395.9 2397.1 2398.0 2401.2 2356.6 2369.2 2394.0 2398.7 2400.5 2374.6 2377.8 2388.1 2407.7 2409.9 2355.4 2374.8 2378.9 2380.5 2381.8 1923.9 2250.9 2351.2 2365.8 2382.8 8706.7 8712.8 8733.5 8736.0 8748.7 5094.3 5179.9 5235.6 5321.2 5335.7 3243.1 3351.3 3390.2 3428.1 3434.9 945.9 974.0 979.5 982.9 997.4 9808.5 9971.5 10751.7 11202.9 11223.4 3895.6 4293.2 4433.8 4557.1 4591.2 8729.2 8793.5 8859.8 8863.8 8917.2 5072.2 5109.0 5130.9 5138.0 5184.2 4309.5 4682.4 4812.8 4824.8 4850.4 3721.9 3749.5 3773.2 3814.8 3878.6 1185.4 1188.7 1198.6 1201.5 1208.3 805.2 826.2 899.7 901.4 935.3 5513.2 5553.0 5782.2 5819.1 5881.4 445.1 451.0 452.7 455.0 462.4 3826.2 3880.8 3883.5 3900.6 3936.3 10185.5 10295.4 10624.3 10657.7 10680.0 10426.4 10515.6 10589.9 10640.3 10647.1 7896.4 7933.1 7982.8 8031.2 8038.2 5577.2 5607.7 5664.3 5723.5 5849.2 9040.9 9484.9 9565.6 9568.7 9613.4 9197.8 9596.4 9632.7 9676.4 9697.6 7068.0 7070.4 7131.3 7184.3 7226.9 7959.2 7991.4 8008.5 8010.2 8023.6 7146.4 7302.2 7345.6 7362.2 7382.2 7115.5 7142.9 7190.6 7222.0 7302.5 6757.3 6764.5 6775.7 6799.4 6822.2 4363.3 4724.0 4748.7 4802.5 4901.9 3792.0 4706.4 4786.5 4799.6 4860.7 14:01:23 INFO - PROCESS | 1664 | 14:01:23 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5278.96 Median:6048.53 stddev:1719.65 (28.4%) stddev-sans-first:1683.55 14:01:23 INFO - PROCESS | 1664 | Values: 310.7 316.6 325.5 328.7 328.9 6011.5 6162.8 6200.5 6269.7 6275.7 6157.0 6197.8 6215.6 6231.8 6266.2 4449.3 4663.4 4664.3 4675.8 4702.6 3549.8 3759.4 4440.0 4565.9 4694.8 4459.1 4480.1 4492.4 4515.4 4515.5 4536.5 4538.3 4546.5 4547.6 4558.2 3019.8 3719.4 3804.9 3837.2 3840.7 5127.9 5859.6 5860.2 5904.4 5907.8 5223.9 5224.5 5230.3 5249.9 5260.7 5359.6 5737.4 6362.6 6459.2 6506.5 4216.8 4244.4 4253.3 4257.9 4281.7 5345.3 6595.4 6862.7 6949.9 6977.4 3766.6 3867.8 4151.5 4198.2 4287.7 3887.9 4351.5 4405.3 4410.2 4419.6 4378.4 4586.7 5057.8 5209.7 5252.1 5072.1 5740.5 6486.3 6575.4 6594.0 1486.4 1511.4 1517.1 1520.4 1525.7 942.2 965.3 974.9 976.1 983.1 5557.9 5925.1 6049.8 6106.3 6115.4 6762.0 6788.7 6807.3 6817.2 6823.8 5866.9 5998.8 6051.3 6100.3 6123.8 3010.5 3032.0 3597.5 3619.0 3633.2 6763.9 6885.4 7120.9 7123.4 7176.2 6993.8 7014.5 7025.8 7040.3 7045.1 5819.6 6891.1 7029.9 7134.1 7190.4 5633.7 6047.3 6557.6 6780.2 6782.0 6215.7 6386.5 6395.9 6689.7 6863.3 6744.4 7042.8 7203.9 7227.5 7281.2 3674.3 4323.1 4340.9 4353.8 4369.9 6604.4 6910.0 6910.3 6917.1 6918.1 6112.4 6296.8 6654.8 6665.4 6673.9 6604.1 6619.3 6636.4 6662.3 6662.5 4845.7 5943.0 6283.0 6456.5 6509.0 6477.3 6616.3 6658.0 6688.2 6718.5 5764.5 6378.0 6449.7 6538.8 6547.4 14:01:23 INFO - PROCESS | 1664 | 14:01:23 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:17165.02 Median:28932.17 stddev:23691.98 (81.9%) stddev-sans-first:23726.05 14:01:23 INFO - PROCESS | 1664 | Values: 666.2 707.9 727.1 733.6 746.7 14703.4 14937.0 14956.2 15120.3 15212.2 14234.3 14274.8 14310.7 14329.4 14406.9 750.2 885.4 899.1 918.0 920.4 884.1 927.9 934.1 935.0 938.0 961.3 981.7 987.4 989.4 990.1 954.5 968.7 978.2 981.0 981.5 691.5 704.3 718.3 727.4 731.6 14720.9 14867.8 14962.8 15109.8 15162.1 12759.9 12768.9 12853.6 12903.2 12984.7 10032.8 10841.1 11040.9 11561.0 11578.8 3525.2 3534.2 3631.4 3635.1 3655.6 75368.0 76254.0 77489.2 78490.8 81982.0 9588.6 9618.9 9674.9 9798.3 9944.7 21578.2 22223.0 22356.2 22367.9 22662.3 7528.6 7536.5 7648.7 7742.3 7823.9 4030.5 4056.4 4059.5 4060.9 4064.9 3458.4 3496.1 3514.7 3559.7 3576.8 622.3 627.1 628.1 639.6 640.1 520.6 564.2 583.3 598.2 602.9 7687.9 7720.5 7965.6 7993.0 8000.4 488.4 509.1 544.9 594.4 601.8 3684.7 3732.2 3753.0 3798.5 3836.3 88177.0 88207.0 91626.5 92167.0 92479.0 58593.1 75428.6 76682.6 77858.0 79390.4 55853.7 59798.7 62882.7 63309.0 67368.0 7788.3 8065.1 8080.2 8124.8 8224.1 38090.2 38570.0 39546.2 40101.0 41262.4 49409.8 51156.0 57125.4 57170.0 57281.0 10322.6 10417.4 10440.9 10772.2 10925.1 11687.9 11692.6 11803.4 11804.5 12088.5 10766.7 11039.7 11098.6 11101.9 11140.5 10439.7 10465.9 10797.8 11036.7 11083.0 10570.4 10770.9 11278.0 12138.2 12212.9 9251.2 9270.4 9320.3 9477.5 9555.2 9472.2 9621.8 9630.9 9671.8 9694.0 14:01:23 INFO - PROCESS | 1664 | -------- Summary: end -------- 14:01:23 INFO - PROCESS | 1664 | 14:01:23 INFO - TEST-INFO | 1664: exit 0 14:01:23 INFO - TEST-OK | dromaeo_css | took 1111636ms 14:01:23 INFO - TEST-START | kraken 14:01:23 INFO - operating with platform_type : mac_ 14:01:23 INFO - Initialising browser for kraken test... 14:01:23 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpJoWcxo/profile http://localhost:49275/getInfo.html) 14:01:25 INFO - PROCESS | 1680 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 14:01:26 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 14:01:26 INFO - PROCESS | 1680 | colorDepth:24 14:01:26 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 14:01:26 INFO - PROCESS | 1680 | __metrics 14:01:26 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:01:27 INFO - TEST-INFO | 1680: exit 0 14:01:27 INFO - Browser initialized. 14:01:27 INFO - Running cycle 1/1 for kraken test... 14:01:27 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpJoWcxo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:38 INFO - PROCESS | 1683 | RSS: Main: 249352192 14:01:38 INFO - PROCESS | 1683 | 14:01:41 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 14:01:42 INFO - PROCESS | 1683 | RSS: Main: 261496832 14:01:42 INFO - PROCESS | 1683 | 14:01:45 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 14:01:45 INFO - PROCESS | 1683 | RSS: Main: 270282752 14:01:45 INFO - PROCESS | 1683 | 14:01:49 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 14:01:49 INFO - PROCESS | 1683 | RSS: Main: 273371136 14:01:49 INFO - PROCESS | 1683 | 14:01:51 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 14:01:52 INFO - PROCESS | 1683 | RSS: Main: 275312640 14:01:52 INFO - PROCESS | 1683 | 14:01:54 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:01:54 INFO - PROCESS | 1683 | RSS: Main: 275824640 14:01:54 INFO - PROCESS | 1683 | 14:01:57 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 14:01:58 INFO - PROCESS | 1683 | RSS: Main: 276324352 14:01:58 INFO - PROCESS | 1683 | 14:02:01 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 14:02:01 INFO - PROCESS | 1683 | RSS: Main: 276389888 14:02:01 INFO - PROCESS | 1683 | 14:02:04 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 14:02:05 INFO - PROCESS | 1683 | RSS: Main: 276566016 14:02:05 INFO - PROCESS | 1683 | 14:02:06 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:02:07 INFO - PROCESS | 1683 | RSS: Main: 276090880 14:02:07 INFO - PROCESS | 1683 | 14:02:09 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:02:10 INFO - PROCESS | 1683 | RSS: Main: 276246528 14:02:10 INFO - PROCESS | 1683 | 14:02:12 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:02:13 INFO - PROCESS | 1683 | RSS: Main: 276537344 14:02:13 INFO - PROCESS | 1683 | 14:02:15 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:02:16 INFO - PROCESS | 1683 | RSS: Main: 276697088 14:02:16 INFO - PROCESS | 1683 | 14:02:19 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:02:20 INFO - PROCESS | 1683 | RSS: Main: 276713472 14:02:20 INFO - PROCESS | 1683 | 14:02:21 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 14:02:22 INFO - PROCESS | 1683 | RSS: Main: 278355968 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | __start_tp_report 14:02:22 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 14:02:22 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 14:02:22 INFO - PROCESS | 1683 | |i|pagename|runs| 14:02:22 INFO - PROCESS | 1683 | |0;ai-astar;117;108;114;114;115;128;115;115;117;115 14:02:22 INFO - PROCESS | 1683 | |1;audio-beat-detection;155;117;146;163;123;139;143;121;171;152 14:02:22 INFO - PROCESS | 1683 | |2;audio-dft;199;203;195;212;234;197;199;188;200;197 14:02:22 INFO - PROCESS | 1683 | |3;audio-fft;65;61;69;103;56;58;57;58;127;77 14:02:22 INFO - PROCESS | 1683 | |4;audio-oscillator;76;81;128;78;82;117;156;84;83;118 14:02:22 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;89;87;88;85;89;98;136;86;88;86 14:02:22 INFO - PROCESS | 1683 | |6;imaging-darkroom;119;119;93;95;94;94;95;95;94;96 14:02:22 INFO - PROCESS | 1683 | |7;imaging-desaturate;82;144;153;90;89;92;90;91;91;90 14:02:22 INFO - PROCESS | 1683 | |8;json-parse-financial;63;62;63;62;62;62;63;80;63;61 14:02:22 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;65;77;106;98;70;62;86;60;65;80 14:02:22 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;85;86;82;86;83;84;82;88;84;84 14:02:22 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;136;142;138;139;176;136;142;166;249;175 14:02:22 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;169;175;168;169;173;169;170;171;169;188 14:02:22 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;67;71;71;70;70;69;65;70;72;68 14:02:22 INFO - PROCESS | 1683 | __end_tp_report 14:02:22 INFO - PROCESS | 1683 | __start_cc_report 14:02:22 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1039 14:02:22 INFO - PROCESS | 1683 | __end_cc_report 14:02:22 INFO - PROCESS | 1683 | __startTimestamp1460754142010__endTimestamp 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | ------- Summary: start ------- 14:02:22 INFO - PROCESS | 1683 | Number of tests: 14 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:115.80 Median:115.00 stddev:4.96 (4.3%) stddev-sans-first:5.24 14:02:22 INFO - PROCESS | 1683 | Values: 117.0 108.0 114.0 114.0 115.0 128.0 115.0 115.0 117.0 115.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:149.00 stddev:18.24 (12.2%) stddev-sans-first:18.82 14:02:22 INFO - PROCESS | 1683 | Values: 155.0 117.0 146.0 163.0 123.0 139.0 143.0 121.0 171.0 152.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:202.40 Median:199.50 stddev:12.65 (6.3%) stddev-sans-first:13.36 14:02:22 INFO - PROCESS | 1683 | Values: 199.0 203.0 195.0 212.0 234.0 197.0 199.0 188.0 200.0 197.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:73.10 Median:59.50 stddev:23.69 (39.8%) stddev-sans-first:24.94 14:02:22 INFO - PROCESS | 1683 | Values: 65.0 61.0 69.0 103.0 56.0 58.0 57.0 58.0 127.0 77.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:79.50 stddev:27.53 (34.6%) stddev-sans-first:27.76 14:02:22 INFO - PROCESS | 1683 | Values: 76.0 81.0 128.0 78.0 82.0 117.0 156.0 84.0 83.0 118.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:88.00 stddev:15.47 (17.6%) stddev-sans-first:16.33 14:02:22 INFO - PROCESS | 1683 | Values: 89.0 87.0 88.0 85.0 89.0 98.0 136.0 86.0 88.0 86.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:94.50 stddev:10.36 (11.0%) stddev-sans-first:8.21 14:02:22 INFO - PROCESS | 1683 | Values: 119.0 119.0 93.0 95.0 94.0 94.0 95.0 95.0 94.0 96.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:101.20 Median:90.00 stddev:25.17 (28.0%) stddev-sans-first:25.72 14:02:22 INFO - PROCESS | 1683 | Values: 82.0 144.0 153.0 90.0 89.0 92.0 90.0 91.0 91.0 90.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:63.00 stddev:5.63 (8.9%) stddev-sans-first:5.95 14:02:22 INFO - PROCESS | 1683 | Values: 63.0 62.0 63.0 62.0 62.0 62.0 63.0 80.0 63.0 61.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:73.50 stddev:15.72 (21.4%) stddev-sans-first:16.07 14:02:22 INFO - PROCESS | 1683 | Values: 65.0 77.0 106.0 98.0 70.0 62.0 86.0 60.0 65.0 80.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:1.90 (2.2%) stddev-sans-first:2.00 14:02:22 INFO - PROCESS | 1683 | Values: 85.0 86.0 82.0 86.0 83.0 84.0 82.0 88.0 84.0 84.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:159.90 Median:154.00 stddev:35.22 (22.9%) stddev-sans-first:36.28 14:02:22 INFO - PROCESS | 1683 | Values: 136.0 142.0 138.0 139.0 176.0 136.0 142.0 166.0 249.0 175.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:170.50 stddev:5.99 (3.5%) stddev-sans-first:6.25 14:02:22 INFO - PROCESS | 1683 | Values: 169.0 175.0 168.0 169.0 173.0 169.0 170.0 171.0 169.0 188.0 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:2.11 (3.0%) stddev-sans-first:2.07 14:02:22 INFO - PROCESS | 1683 | Values: 67.0 71.0 71.0 70.0 70.0 69.0 65.0 70.0 72.0 68.0 14:02:22 INFO - PROCESS | 1683 | -------- Summary: end -------- 14:02:22 INFO - PROCESS | 1683 | 14:02:22 INFO - TEST-INFO | 1683: exit 0 14:02:22 INFO - TEST-OK | kraken | took 59204ms 14:02:22 INFO - SUITE-END | took 1170s 14:02:23 INFO - Completed test suite (00:19:31) 14:02:23 INFO - javascript benchmark 14:02:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3184.299454120093, 3423.537822393976, 3464.930701385972, 3541.893743187704, 3546.609872913979, 4659.673822832403, 5491.972540137293, 5745.425457454257, 5748.425157484249, 5757.769689212437, 5185.585153187745, 5252.894942101156, 5698.230738850254, 5702.429757024306, 5732.312122545301, 4360.433143691315, 4990.30135780991, 5020.7489625518765, 5293.391260005091, 5403.837884863441, 5112.156494178456, 5118.564921981636, 5138.177891537355, 5262.92105618416, 5284.841454756363, 5216.165413533854, 5236.973815130938, 5246.527812496855, 5256.159014557672, 5263.105272103751, 5253.763580638881, 5254.842354729364, 5260.736963151865, 5267.3942496613, 5292.52367286946, 4830.227163653799, 4860.392450943632, 5108.821191258288, 5262.368515778093, 5273.077211488013, 4958.87602809929, 5416.458354164592, 5471.179323101527, 5655.66066036035, 5708.372079071299, 5074.568661663763, 5415.025295446818, 6071.605345652519, 6199.969000154971, 6222.253329600431, 6145.310039739107, 6169.5064394848305, 6186.690665466754, 6228.688565571703, 6282.528810339197, 4870.6103511718975, 5934.139549765303, 5939.406059394026, 5942.197803296586, 5951.880962380728, 6403.455706265019, 6405.48756099511, 6408.391202835724, 6414.903776443357, 6426.646534440651, 5259.973700131475, 6014.0678194879865, 6108.602940808833, 6116.396640261158, 6179.2584889812615, 6188.133661287423, 6247.0629405589525, 6249.343818899041, 6257.78097766576, 6276.811695649138, 6111.7132884518705, 6206.3312775506065, 6238.719257633417, 6242.531810114259, 6271.843203919939, 6133.233345831771, 6154.1999540059505, 6157.138000679908, 6232.0963460298, 6278.30938596754, 4892.363992680928, 4948.752562371867, 4953.7523123844385, 4958.256261560795, 4971.552560269521, 4333.241682705514, 4444.622207112432, 4457.554244575581, 4484.39460672805, 4505.481869584974, 5691.203231547586, 5731.77072917087, 5740.942590574041, 5741.397153298927, 5751.367349591542, 4811.566958973709, 5409.486098820606, 5923.874463851855, 6253.499720022387, 6255.530835187288, 5606.803761868315, 5708.71456427177, 5762.394948530427, 5762.538996880239, 5762.827115186551, 4865.9756701216265, 5214.165733482625, 5442.482964118402, 5447.346318441733, 5490.286262785892, 6455.709493072823, 6467.353264673589, 6483.967580162069, 6491.902621460682, 6494.285628580947, 6108.038540470994, 6141.977005061692, 6211.13044173807, 6228.0, 6239.7504099837315, 6430.356964303533, 6463.612183269019, 6475.870482590416, 6489.286178520265, 6522.05430212607, 6156.984097624021, 6171.382861713792, 6201.689915504297, 6215.96892015537, 6229.688515574294, 5238.371395432572, 6125.418085281891, 6126.395534290377, 6136.969315153396, 6236.34518375564, 6136.32500424944, 6153.293986281832, 6162.845928851814, 6198.597091189058, 6209.161763161916, 6152.907706384497, 6172.660503672341, 6173.84565385869, 6179.258488981351, 6198.132261483306, 5783.942160578508, 5910.586258962004, 5937.524998000236, 5940.346561878104, 6049.546284028627, 6124.908126378197, 6139.877202455837, 6163.476104531165, 6181.598196117238, 6206.379362063757, 6046.697665116814, 6058.0912863069125, 6075.1191077294425, 6077.4834139098675, 6086.360932102066], "value": 5657.156972155087, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.30066403714625, 520.232656831174, 531.2588938430889, 538.8221886777362, 552.715351593929, 32025.519617205733, 37281.25437491249, 38205.61794382059, 38271.85184444464, 38357.04107397317, 39225.0, 39344.21311573767, 39874.40188397176, 39945.8002709986, 39971.60028399715, 9485.336026478166, 9669.516524173798, 9702.563384647672, 9736.026397360243, 9793.363431376938, 9524.428534287965, 9729.464879431629, 9762.853557196648, 9765.072318129767, 9801.509924503782, 9685.854712179324, 9718.562664680107, 9722.902770972305, 9779.168770654504, 9779.657711980082, 9686.612535498572, 9718.368306060083, 9748.415095094282, 9769.658061967868, 9771.462569558671, 9602.807943841084, 9710.0, 9713.805723885484, 9745.415275083518, 9749.220062395063, 38674.41988370177, 38826.02934926621, 38875.611243887484, 39136.608633913864, 39188.60811391878, 2709.092454027903, 3151.416987857254, 3212.6626704195955, 3248.382807266612, 3473.2358881046384, 23392.496652075653, 27769.86115069432, 28841.134765957057, 28995.855020724972, 29717.405651886842, 2736.8905243790223, 2761.585762135676, 2791.4975304445193, 2858.456893190308, 2905.694902035277, 457088.0, 460419.0, 466311.0, 468844.0, 469226.0, 36917.26165476676, 37781.24437511234, 68308.0, 68976.0, 69020.6548967262, 36376.63623363733, 36809.0, 37190.8140459296, 37199.0, 37385.0, 12758.80861787074, 13226.0, 15041.774373384407, 15130.319135638923, 15339.309731062129, 10645.627403040857, 10886.67339979802, 12828.55100071493, 12833.871661283454, 12879.613611591667, 8433.578321084044, 8509.829803403898, 8523.57382130891, 8537.573121343908, 8627.698030569025, 3012.683668214806, 3540.2034542227793, 3567.7502574820032, 3577.94633080504, 3581.2658405026905, 967.5645959318335, 972.2610815780058, 986.4475893499663, 1006.597361055569, 1101.911847052234, 29758.40483190324, 29932.40135197284, 30017.549736753965, 30174.698253017188, 30231.848840755654, 1064.3347907557777, 1098.9395583243, 1108.6729414822646, 1133.2690414682484, 1167.9065674746, 15337.0, 15425.922870385577, 15479.5356139316, 15794.36822527086, 15824.60438489047, 627138.0, 637907.0, 648677.0, 651511.0, 655485.0, 50264.49735502671, 59665.40334596685, 60588.0, 61092.69453652703, 61290.693546531984, 1355.9457621695021, 1433.8852891768634, 1498.4081287891222, 1503.255888335281, 1510.4411367793987, 28993.13020609385, 29275.56086658659, 29524.409511810074, 29984.25039374033, 29990.550141747455, 53926.0, 54179.45820541744, 54498.45501544934, 54582.72708636431, 54630.45369546254, 548421.0, 549358.2532087314, 558877.2056139855, 567800.0, 575427.0, 27032.0, 27877.0, 27900.72099278981, 28156.43687126287, 28231.858840705667, 45987.77006114948, 46162.538374617165, 47218.29172562483, 47885.28172077491, 48638.0, 37045.259094818495, 38251.0, 38310.80844595759, 38675.6132438672, 38742.0, 37418.812905935294, 37537.624623753414, 37543.061423464635, 38215.0, 38506.229875402896, 37413.25173496569, 37992.430113547765, 38127.42808857925, 38498.422523661604, 38729.225415492096, 31678.0, 33400.33199336048, 33680.83159584186, 33757.49363759496, 34084.659153408145, 23490.882545587163, 24638.0, 24760.13339533108, 24999.50001000006, 25066.71721378962], "value": 18577.9824112674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.47933248779117, 392.2096974596187, 394.88153553933813, 395.17605791923836, 404.7814180342615, 14635.19506427146, 19968.400947971546, 20650.586988260227, 20682.793172068275, 20720.378388648347, 18695.532611684714, 19692.507687307825, 20269.898650506762, 21354.145834166615, 21467.6779848302, 5737.684427356494, 5894.557908156895, 5927.170196172539, 5952.70236488176, 5974.133750606159, 4737.697133288339, 5001.299818025479, 5583.994880921433, 5833.066709326508, 5916.556258280624, 5231.372235331746, 5730.05454100073, 5899.380565040673, 5919.437653422918, 5930.762769489215, 5492.956338295731, 5500.724963751796, 5673.0, 5933.643981361132, 5936.465718085371, 5082.23766435034, 5102.209157580581, 5157.71632560209, 5167.715775632339, 5186.974065129651, 11823.704407389798, 25167.24498265055, 25697.486050279076, 26317.868410658015, 26657.600135997975, 2111.2399536166968, 2124.915003399862, 2183.7816218378193, 2266.2861198722517, 2371.324172610815, 9000.189982901506, 9443.291753118543, 9681.031896810333, 9737.707868763948, 9792.657256996043, 1630.5271471273315, 1670.1315316035716, 1675.9416641476446, 1696.7285234362566, 1744.5464179313342, 86528.56735716344, 104585.47707261491, 109477.0, 110276.0, 111111.33333000011, 10823.13414926804, 11144.941230583081, 11166.994970452535, 11174.888251117547, 11216.270942388719, 14150.433982640785, 14164.929175354264, 14217.43130274798, 14234.0, 14337.92831035859, 8393.874091888627, 8516.0, 8588.656453741905, 8630.697925572575, 8689.6524139035, 7710.884336734954, 8274.213949674771, 8481.830363392697, 8546.401751877309, 8654.610542525475, 4364.694471387036, 4368.4321038264825, 4453.554644535585, 4517.5256598057385, 4528.252838281713, 1602.7275363188287, 1897.3643829317057, 1930.9613807723767, 1937.321937321926, 1944.270898413095, 875.1991927386497, 905.1536813079659, 906.5784410249134, 928.5635751197061, 1017.811704834608, 19872.60254794896, 20358.083886225155, 20593.0, 20912.0, 20999.895000525205, 717.7631381644045, 906.3021473465395, 944.1927152284835, 953.6709835107016, 991.7520619845038, 10451.425171615634, 10888.891111088946, 10936.289141205796, 10945.562177512811, 10949.616763413402, 570338.0, 603999.9800000972, 617991.0, 621672.0, 622498.0, 129078.70921290855, 134032.0, 136066.31966840103, 136854.0, 138774.3061284687, 1011.8431643095332, 1017.0541396501325, 1030.8711411073616, 1032.70051685012, 1033.4625994482826, 17786.5553361167, 17950.39719240729, 18183.909080454512, 18203.908980455013, 18471.90764046171, 38756.0, 42198.94502637459, 44782.0, 49568.0, 49599.50400495949, 71922.0, 75416.0, 75790.62104689442, 76731.61634191794, 77138.2286177131, 6867.416269616939, 7232.168300645493, 7291.8541629168185, 7891.092524359772, 7970.721024764105, 10842.186835987175, 12134.453949572115, 12248.632541023784, 12493.312867792358, 12510.124291299522, 9768.97425770284, 10790.784184316426, 10826.133909287395, 10826.56693732242, 11125.721856953642, 10770.569177232823, 10869.130469562575, 10921.180911431515, 10941.945290273497, 11010.889891100986, 11260.493277802683, 11294.830577541508, 11389.829152562885, 11596.130290228435, 11632.767344653228, 7334.596597186993, 7345.55926644403, 7381.11426628808, 7394.742893707975, 7473.850522989618, 10272.435016073889, 11092.556297748, 11322.94338528302, 11350.375729334966, 11364.602238921598], "value": 9261.306044918843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1561.9609509762254, 1603.1503303249276, 1846.0, 1937.8062193780615, 1940.5536726552893, 7871.80320491988, 8434.156584341563, 8437.66249350026, 8691.261242794362, 8711.477311361323, 8431.03043150038, 8503.064662887093, 8519.91480085199, 8569.928758905136, 8580.39937204396, 2364.4088977755605, 2395.9161429349974, 2397.06514459361, 2397.988010059947, 2401.171595799455, 2356.646503024543, 2369.2300002499255, 2393.9760602394012, 2398.7121545414575, 2400.543896659629, 2374.6438034294906, 2377.785999260066, 2388.128333158393, 2407.6629271901948, 2409.939751506218, 2355.4464700795297, 2374.7743964323363, 2378.857268563892, 2380.4762952150586, 2381.8094552435764, 1923.8653294269407, 2250.88581152329, 2351.247600767755, 2365.8343915925893, 2382.7736365045293, 8706.738797836075, 8712.782180445476, 8733.519656418894, 8736.0, 8748.650053997833, 5094.337736094284, 5179.922301165486, 5235.633505654606, 5321.2284218788445, 5335.67985920846, 3243.140567749548, 3351.346487434951, 3390.2371966307383, 3428.142964258935, 3434.8797792077407, 945.9432434053979, 973.9610415583439, 979.5298256836687, 982.8869679986822, 997.3866072365515, 9808.46053467059, 9971.501424928725, 10751.709794824672, 11202.943985280102, 11223.38271395073, 3895.6299151580556, 4293.162833247549, 4433.7561434121435, 4557.134144512532, 4591.17358875399, 8729.170728780755, 8793.516356600321, 8859.778505537413, 8863.778405539784, 8917.152870477294, 5072.213806859942, 5109.029284436019, 5130.9230361544605, 5137.972405518911, 5184.196449550326, 4309.461317335333, 4682.391289132391, 4812.783424745895, 4824.782884770124, 4850.393700787402, 3721.925561488755, 3749.4750734897134, 3773.1510410157493, 3814.771113733185, 3878.5733569307354, 1185.4013723069795, 1188.6731148933939, 1198.5804968261214, 1201.5253974679952, 1208.3354155214597, 805.1988271669609, 826.1779529368317, 899.7030979776658, 901.4230892228978, 935.3452583191657, 5513.2005859150195, 5552.972235138879, 5782.2483077199695, 5819.098039803837, 5881.3530511643685, 445.1097804391218, 451.01903360191454, 452.66050462153385, 455.0126226089394, 462.44737538641, 3826.234753049401, 3880.7865567394065, 3883.514560679915, 3900.6294402031763, 3936.291467535814, 10185.490725463696, 10295.433751143759, 10624.309419887682, 10657.73355666099, 10680.0, 10426.426546540013, 10515.579376824995, 10589.894101059044, 10640.308379955279, 10647.094996925349, 7896.447248692652, 7933.127355990951, 7982.800429989296, 8031.237032481905, 8038.236367545074, 5577.2191893135805, 5607.691576963143, 5664.320281566238, 5723.513501352431, 5849.151872978479, 9040.864387034067, 9484.85772713396, 9565.569549370155, 9568.712938611852, 9613.423194608346, 9197.77005574866, 9596.416591262363, 9632.711018669452, 9676.419414835133, 9697.563609637724, 7067.964660176666, 7070.399016083485, 7131.2512186221775, 7184.317489838457, 7226.927730722626, 7959.164287749702, 7991.360691144579, 8008.519488830689, 8010.239027292398, 8023.558704271321, 7146.428285737024, 7302.217082702004, 7345.55926644403, 7362.153352364547, 7382.187959324578, 7115.466340024415, 7142.928570714226, 7190.6404679764755, 7221.988921551092, 7302.452316076209, 6757.3242675732035, 6764.458843292623, 6775.695093720893, 6799.422049125879, 6822.249552549315, 4363.2582460981075, 4723.952760472489, 4748.715077095385, 4802.51974802517, 4901.877453063702, 3791.9810400947817, 4706.364640773451, 4786.521347865325, 4799.616030717604, 4860.73265970375], "value": 4365.087705438047, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.73742687429126, 316.63745011961305, 325.46623537398665, 328.7402951668182, 328.92599165187823, 6011.475180424221, 6162.84592885177, 6200.472959798417, 6269.749210031593, 6275.748970041199, 6156.969215153918, 6197.752089916398, 6215.564910456259, 6231.844203894893, 6266.216722909637, 4449.332600109985, 4663.440387153546, 4664.300354946751, 4675.7895894684825, 4702.553257440538, 3549.8402571884326, 3759.360908645523, 4440.023194897118, 4565.908681826361, 4694.788734506956, 4459.108178364324, 4480.103979204156, 4492.438445194351, 4515.412996310475, 4515.4581450226015, 4536.478304994935, 4538.320821296125, 4546.499885012646, 4547.567981041796, 4558.247889098295, 3019.8037127586636, 3719.367707489733, 3804.9429258561145, 3837.2371892237825, 3840.6735427488697, 5127.948720512822, 5859.560532960045, 5860.157823455664, 5904.439078287556, 5907.763689452459, 5223.869403264911, 5224.503672151178, 5230.34620672416, 5249.895002099975, 5260.658057226268, 5359.571234301286, 5737.3688894221605, 6362.586431881913, 6459.192600924885, 6506.54454188207, 4216.786187251718, 4244.405783190356, 4253.340732186516, 4257.893552661209, 4281.743095414254, 5345.331833520771, 6595.406413422767, 6862.691178896962, 6949.93050069503, 6977.372036516738, 3766.5668448128267, 3867.7872717000273, 4151.481064866892, 4198.160367926427, 4287.742735435884, 3887.8639247626197, 4351.456067991501, 4405.251107311765, 4410.184115938498, 4419.558044195554, 4378.387025816388, 4586.747728874877, 5057.848264551996, 5209.661372010807, 5252.107141785906, 5072.137736584789, 5740.512056475246, 6486.286508484063, 6575.408213260829, 6593.967030164818, 1486.4351546412295, 1511.4205655090457, 1517.1352329172266, 1520.4374381478924, 1525.6872341170033, 942.1520631431766, 965.3435663748718, 974.9220062394992, 976.1019861727228, 983.0709979069853, 5557.861053473614, 5925.140854576062, 6049.758009679652, 6106.267247930188, 6115.449609535163, 6762.0, 6788.660566971632, 6807.285235050347, 6817.216020157646, 6823.805833979034, 5866.887920348671, 5998.760049598054, 6051.304100028465, 6100.298465676416, 6123.816285511352, 3010.4581175388203, 3031.9848400758297, 3597.5143355647174, 3618.9638103618627, 3633.2006958469624, 6763.864722705518, 6885.380315771605, 7120.893186602205, 7123.43012558994, 7176.174739904874, 6993.825154371181, 7014.508984371045, 7025.770490164303, 7040.295970402919, 7045.084139061889, 5819.592628516048, 6891.1189505771845, 7029.92970070303, 7134.072570565793, 7190.424766018706, 5633.690147041788, 6047.304559975659, 6557.639329836905, 6780.186377634715, 6782.0, 6215.720292586935, 6386.457151142019, 6395.872082558416, 6689.698963546554, 6863.347981941708, 6744.369695818733, 7042.753503627348, 7203.8919416207755, 7227.494075414881, 7281.199068102399, 3674.338619048597, 4323.1137616787855, 4340.9131817364105, 4353.782310884507, 4369.8587692031315, 6604.405603495708, 6909.965450172717, 6910.343517365842, 6917.13535808024, 6918.0567076765765, 6112.358202388685, 6296.811095667137, 6654.83362915931, 6665.433438157811, 6673.933260667525, 6604.14146160996, 6619.300296789141, 6636.435902948304, 6662.267150613526, 6662.500312476681, 4845.733484658378, 5942.959982003219, 6283.0, 6456.483481321577, 6509.0, 6477.319881412383, 6616.305287944697, 6658.0, 6688.163979502562, 6718.529702920749, 5764.481196692318, 6377.96811015942, 6449.677516124269, 6538.803835884931, 6547.443467305332], "value": 4715.970056943642, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.2271764752886, 707.9256678048805, 727.051198186367, 733.6221845749436, 746.7274444827636, 14703.41186352546, 14937.0, 14956.177410242432, 15120.319585618647, 15212.163331016804, 14234.288285585732, 14274.785878211835, 14310.713785724305, 14329.426822927071, 14406.855931440683, 750.1635676221001, 885.3935054487664, 899.0515006667979, 917.9954100229489, 920.4201353147541, 884.1291328041906, 927.8608208768671, 934.0612684252317, 934.9859752103724, 937.9588656591178, 961.3366776923936, 981.6564202529129, 987.4174237200051, 989.3618615992681, 990.1237404896647, 954.4941181173954, 968.6851773173747, 978.2027647467327, 980.9699815194089, 981.543582234261, 691.5435812363816, 704.2886684448692, 718.2924819053228, 727.3998950865557, 731.5610633619839, 14720.852791472056, 14867.776983345258, 14962.775558366633, 15109.848901510954, 15162.09027458345, 12759.872401276054, 12768.936155319258, 12853.550125745647, 12903.22580645155, 12984.675383115404, 10032.799344013152, 10841.13270938323, 11040.889591104067, 11561.0, 11578.826317605242, 3525.1715846775987, 3534.2224710563637, 3631.4371272452813, 3635.1457407509215, 3655.5796083450477, 75368.0, 76254.0, 77489.22510774876, 78490.82263766049, 81982.0, 9588.568514416867, 9618.855717164248, 9674.854877176847, 9798.314118011813, 9944.651937182163, 21578.244761433274, 22223.0, 22356.217532386287, 22367.888160559418, 22662.320130396114, 7528.5859277739155, 7536.472446928772, 7648.694052237959, 7742.303192712683, 7823.921760782433, 4030.5364883038824, 4056.3712624542654, 4059.4925634295714, 4060.878173654795, 4064.878053658395, 3458.4293591557616, 3496.0735405117666, 3514.6661067198575, 3559.715222782171, 3576.7675101118343, 622.2812651387654, 627.1345543150424, 628.0986783965025, 639.6354078175395, 640.145405883142, 520.625149892077, 564.1903867949424, 583.3437382944188, 598.2432223237608, 602.9306629737548, 7687.884681729778, 7720.452250757349, 7965.561894095765, 7992.960035199787, 8000.4399692021, 488.36024807502287, 509.09381301283776, 544.8561798423077, 594.3787895381347, 601.8224623736008, 3684.742068055264, 3732.197577520846, 3752.981235093862, 3798.5441746990537, 3836.290286297044, 88177.0, 88207.0, 91626.54186729157, 92167.0, 92479.0, 58593.12110318348, 75428.62285688646, 76682.6165869167, 77858.0, 79390.41219175584, 55853.7207313969, 59798.70100649556, 62882.68558657269, 63309.0, 67368.0, 7788.260115289038, 8065.072516660659, 8080.232377924088, 8124.7562573122905, 8224.054233763194, 38090.238195236496, 38570.0, 39546.209075817744, 40101.0, 41262.38106428346, 49409.752951235016, 51155.97688046293, 57125.428745713674, 57170.0, 57281.0, 10322.599988007483, 10417.42704151279, 10440.895591043993, 10772.192085593455, 10925.125989920629, 11687.941560292484, 11692.590759323382, 11803.350815705218, 11804.468798904241, 12088.456019479321, 10766.73083172927, 11039.668809935714, 11098.61154859576, 11101.944490277498, 11140.512176526094, 10439.686809395731, 10465.947670261905, 10797.784044318912, 11036.668899933014, 11083.0, 10570.41862697559, 10770.946145269223, 11278.0, 12138.150329477205, 12212.938935305267, 9251.235613658837, 9270.351075424926, 9320.254379649476, 9477.526123693926, 9555.235581153353, 9472.194863436685, 9621.807563848544, 9630.855537166808, 9671.758206044906, 9694.0], "value": 6763.02131640412, "unit": "score"}], "name": "dromaeo_css", "value": 7166.968653727669, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 108.0, 114.0, 114.0, 115.0, 128.0, 115.0, 115.0, 117.0, 115.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 117.0, 146.0, 163.0, 123.0, 139.0, 143.0, 121.0, 171.0, 152.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 203.0, 195.0, 212.0, 234.0, 197.0, 199.0, 188.0, 200.0, 197.0], "value": 202.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 69.0, 103.0, 56.0, 58.0, 57.0, 58.0, 127.0, 77.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 128.0, 78.0, 82.0, 117.0, 156.0, 84.0, 83.0, 118.0], "value": 100.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 85.0, 89.0, 98.0, 136.0, 86.0, 88.0, 86.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 93.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 96.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 144.0, 153.0, 90.0, 89.0, 92.0, 90.0, 91.0, 91.0, 90.0], "value": 101.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0, 80.0, 63.0, 61.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 106.0, 98.0, 70.0, 62.0, 86.0, 60.0, 65.0, 80.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 82.0, 86.0, 83.0, 84.0, 82.0, 88.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 142.0, 138.0, 139.0, 176.0, 136.0, 142.0, 166.0, 249.0, 175.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 168.0, 169.0, 173.0, 169.0, 170.0, 171.0, 169.0, 188.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 71.0, 70.0, 70.0, 69.0, 65.0, 70.0, 72.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1555.1000000000001, "alertThreshold": 2.0}]} 14:02:23 INFO - Return code: 0 14:02:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:02:23 ERROR - # TBPL SUCCESS # 14:02:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:02:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:02:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:02:23 INFO - 2016-04-15 14:02:23.320 screenresolution[1688:10627] starting screenresolution argv=screenresolution get 14:02:23 INFO - 2016-04-15 14:02:23.322 screenresolution[1688:10627] Display 0: 1600x1200x32@60 14:02:23 INFO - 2016-04-15 14:02:23.328 screenresolution[1689:10630] starting screenresolution argv=screenresolution list 14:02:23 INFO - Available Modes on Display 0 14:02:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:02:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:02:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:02:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:02:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:02:23 INFO - Intel Iris: 14:02:23 INFO - Chipset Model: Intel Iris 14:02:23 INFO - Type: GPU 14:02:23 INFO - Bus: Built-In 14:02:23 INFO - VRAM (Dynamic, Max): 1536 MB 14:02:23 INFO - Vendor: Intel (0x8086) 14:02:23 INFO - Device ID: 0x0a2e 14:02:23 INFO - Revision ID: 0x0009 14:02:23 INFO - Displays: 14:02:23 INFO - Display: 14:02:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:02:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:02:23 INFO - Display Serial Number: 1600x1200 60 14:02:23 INFO - Main Display: Yes 14:02:23 INFO - Mirror: Off 14:02:23 INFO - Online: Yes 14:02:23 INFO - Rotation: Supported 14:02:23 INFO - Return code: 0 14:02:23 INFO - Running post-action listener: _resource_record_post_action 14:02:23 INFO - Running post-run listener: _resource_record_post_run 14:02:24 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 38341120; Write bytes: 699647488; Read time: 562; Write time: 2039 14:02:24 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 385917440; Write bytes: 381105664; Read time: 28706; Write time: 721 14:02:24 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 36547072; Write bytes: 300961792; Read time: 544; Write time: 1281 14:02:24 INFO - Running post-run listener: _upload_blobber_files 14:02:24 INFO - Blob upload gear active. 14:02:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:02:24 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 14:02:24 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'] 14:02:24 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 14:02:25 INFO - (blobuploader) - INFO - Open directory for files ... 14:02:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:02:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:02:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:02:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:02:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:02:26 INFO - (blobuploader) - INFO - Done attempting. 14:02:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:02:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:02:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:02:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:02:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:02:27 INFO - (blobuploader) - INFO - Done attempting. 14:02:27 INFO - (blobuploader) - INFO - Iteration through files over. 14:02:27 INFO - Return code: 0 14:02:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:02:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:02:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05a041d3c3e7e8e0afc8dabe6167697ef3b104bbb611dfb55898dc046edc177c45558646dfe853b2198c168c82196d5205c99f234ff5ec9ff6af1f0d574e96e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9501138517db6c4b26526c3c09ba54e70b36283fab1b0bac9fb3228df38c9c490a5be6edf667f675854c6c53084d2ce726c3f24ac8918d588e1ec8fec0856d24"} 14:02:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:02:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:02:27 INFO - Contents: 14:02:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05a041d3c3e7e8e0afc8dabe6167697ef3b104bbb611dfb55898dc046edc177c45558646dfe853b2198c168c82196d5205c99f234ff5ec9ff6af1f0d574e96e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9501138517db6c4b26526c3c09ba54e70b36283fab1b0bac9fb3228df38c9c490a5be6edf667f675854c6c53084d2ce726c3f24ac8918d588e1ec8fec0856d24"} 14:02:27 INFO - Running post-run listener: copy_logs_to_upload_dir 14:02:27 INFO - Copying logs to upload dir... 14:02:27 INFO - mkdir: /builds/slave/test/build/upload/logs 14:02:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.855174 ========= master_lag: 26.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-04-15 14:02:53.939397) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 14:02:53.947259) ========= 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.xvqpTuaqIE/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.wTukm9aL5i/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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/05a041d3c3e7e8e0afc8dabe6167697ef3b104bbb611dfb55898dc046edc177c45558646dfe853b2198c168c82196d5205c99f234ff5ec9ff6af1f0d574e96e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9501138517db6c4b26526c3c09ba54e70b36283fab1b0bac9fb3228df38c9c490a5be6edf667f675854c6c53084d2ce726c3f24ac8918d588e1ec8fec0856d24"} build_url:https://queue.taskcluster.net/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.012038 build_url: 'https://queue.taskcluster.net/v1/task/ekxJUFGQRouhYelxehikiQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05a041d3c3e7e8e0afc8dabe6167697ef3b104bbb611dfb55898dc046edc177c45558646dfe853b2198c168c82196d5205c99f234ff5ec9ff6af1f0d574e96e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9501138517db6c4b26526c3c09ba54e70b36283fab1b0bac9fb3228df38c9c490a5be6edf667f675854c6c53084d2ce726c3f24ac8918d588e1ec8fec0856d24"}' ========= master_lag: 0.54 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 14:02:54.503323) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-04-15 14:02:54.503631) ========= 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.xvqpTuaqIE/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.wTukm9aL5i/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.005105 ========= master_lag: 5.25 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-04-15 14:02:59.758243) ========= ========= Started reboot skipped (results: 3, elapsed: 1 mins, 14 secs) (at 2016-04-15 14:02:59.758520) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 mins, 14 secs) (at 2016-04-15 14:04:14.278298) ========= ========= Total master_lag: 33.00 =========