builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0136 starttime: 1461139824.78 results: success (0) buildid: 20160419233542 builduid: 39deb8105d9f4fd493257beeca9fe7a4 revision: f9fc0c367d89188d01677da6cf85bb2097e85605 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 01:10:24.783295) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 01:10:24.783724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 12 secs) (at 2016-04-20 01:10:24.783997) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 12 secs) (at 2016-04-20 01:10:37.510657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-20 01:10:37.510965) ========= 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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-20 01:10:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 156M=0s 2016-04-20 01:10:37 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120660 ========= master_lag: 4.53 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-20 01:10:42.165531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 01:10:42.165876) ========= 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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.020468 ========= master_lag: 2.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 01:10:44.297784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 01:10:44.298151) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f9fc0c367d89188d01677da6cf85bb2097e85605 --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 f9fc0c367d89188d01677da6cf85bb2097e85605 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qPVAFpCFpf/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.3rrHmUFr8M/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-20 01:10:44,383 truncating revision to first 12 chars 2016-04-20 01:10:44,383 Setting DEBUG logging. 2016-04-20 01:10:44,383 attempt 1/10 2016-04-20 01:10:44,383 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f9fc0c367d89?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 01:10:45,573 unpacking tar archive at: fx-team-f9fc0c367d89/testing/mozharness/ program finished with exit code 0 elapsedTime=1.437990 ========= master_lag: 0.91 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 01:10:46.649753) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 01:10:46.650043) ========= script_repo_revision: f9fc0c367d89188d01677da6cf85bb2097e85605 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 01:10:46.650412) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 01:10:46.650727) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 01:10:47.578149) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-20 01:10:47.578411) ========= /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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 01:10:47 INFO - MultiFileLogger online at 20160420 01:10:47 in /builds/slave/test 01:10:47 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 01:10:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:10:47 INFO - {'append_to_log': False, 01:10:47 INFO - 'base_work_dir': '/builds/slave/test', 01:10:47 INFO - 'blob_upload_branch': 'Fx-Team', 01:10:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:10:47 INFO - 'branch': 'Fx-Team', 01:10:47 INFO - 'buildbot_json_path': 'buildprops.json', 01:10:47 INFO - 'config_files': ('talos/mac_config.py',), 01:10:47 INFO - 'default_actions': ('clobber', 01:10:47 INFO - 'read-buildbot-config', 01:10:47 INFO - 'download-and-extract', 01:10:47 INFO - 'populate-webroot', 01:10:47 INFO - 'create-virtualenv', 01:10:47 INFO - 'install', 01:10:47 INFO - 'run-tests'), 01:10:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:10:47 INFO - 'download_minidump_stackwalk': True, 01:10:47 INFO - 'download_symbols': 'ondemand', 01:10:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:10:47 INFO - 'tooltool.py': '/tools/tooltool.py', 01:10:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:10:47 INFO - '/tools/misc-python/virtualenv.py')}, 01:10:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:10:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:10:47 INFO - 'installer_path': 'installer.exe', 01:10:47 INFO - 'log_level': 'info', 01:10:47 INFO - 'log_name': 'talos', 01:10:47 INFO - 'log_to_console': True, 01:10:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:10:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:10:47 INFO - 'opt_config_files': (), 01:10:47 INFO - 'pip_index': False, 01:10:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:10:47 INFO - 'cmd': ('bash', 01:10:47 INFO - '-c', 01:10:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:10:47 INFO - 'enabled': True, 01:10:47 INFO - 'halt_on_failure': False, 01:10:47 INFO - 'name': 'check_screen_resolution'},), 01:10:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:10:47 INFO - 'cmd': ('bash', 01:10:47 INFO - '-c', 01:10:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:10:47 INFO - 'enabled': True, 01:10:47 INFO - 'halt_on_failure': False, 01:10:47 INFO - 'name': 'check_screen_resolution'},), 01:10:47 INFO - 'run_cmd_checks_enabled': True, 01:10:47 INFO - 'sps_profile': False, 01:10:47 INFO - 'sps_profile_interval': 0, 01:10:47 INFO - 'suite': 'dromaeojs-e10s', 01:10:47 INFO - 'system_bits': '32', 01:10:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:10:47 INFO - 'title': 't-yosemite-r7-0136', 01:10:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:10:47 INFO - 'use_talos_json': True, 01:10:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:10:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:10:47 INFO - 'work_dir': 'build'} 01:10:47 INFO - ##### 01:10:47 INFO - ##### Running clobber step. 01:10:47 INFO - ##### 01:10:47 INFO - Running pre-action listener: _resource_record_pre_action 01:10:47 INFO - Running main action method: clobber 01:10:47 INFO - rmtree: /builds/slave/test/build 01:10:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:10:49 INFO - Running post-action listener: _resource_record_post_action 01:10:49 INFO - ##### 01:10:49 INFO - ##### Running read-buildbot-config step. 01:10:49 INFO - ##### 01:10:49 INFO - Running pre-action listener: _resource_record_pre_action 01:10:49 INFO - Running main action method: read_buildbot_config 01:10:49 INFO - Using buildbot properties: 01:10:49 INFO - { 01:10:49 INFO - "project": "", 01:10:49 INFO - "product": "firefox", 01:10:49 INFO - "script_repo_revision": "production", 01:10:49 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 01:10:49 INFO - "repository": "", 01:10:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 01:10:49 INFO - "buildid": "20160419233542", 01:10:49 INFO - "pgo_build": "False", 01:10:49 INFO - "basedir": "/builds/slave/test", 01:10:49 INFO - "buildnumber": 626, 01:10:49 INFO - "slavename": "t-yosemite-r7-0136", 01:10:49 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:10:49 INFO - "platform": "yosemite_r7", 01:10:49 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 01:10:49 INFO - "branch": "fx-team", 01:10:49 INFO - "repo_path": "integration/fx-team", 01:10:49 INFO - "revision": "f9fc0c367d89188d01677da6cf85bb2097e85605", 01:10:49 INFO - "stage_platform": "macosx64", 01:10:49 INFO - "builduid": "39deb8105d9f4fd493257beeca9fe7a4", 01:10:49 INFO - "slavebuilddir": "test" 01:10:49 INFO - } 01:10:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 01:10:49 INFO - Running post-action listener: _resource_record_post_action 01:10:49 INFO - ##### 01:10:49 INFO - ##### Running download-and-extract step. 01:10:49 INFO - ##### 01:10:49 INFO - Running pre-action listener: _resource_record_pre_action 01:10:49 INFO - Running main action method: download_and_extract 01:10:49 INFO - mkdir: /builds/slave/test/build/tests 01:10:49 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')]} 01:10:49 INFO - https://queue.taskcluster.net/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:10:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:10:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:10:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/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 01:10:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/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 01:10:51 INFO - Downloaded 1199 bytes. 01:10:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 01:10:51 INFO - Using the following test package requirements: 01:10:51 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:10:51 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:10:51 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 01:10:51 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:10:51 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 01:10:51 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:10:51 INFO - u'jsshell-mac.zip'], 01:10:51 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:10:51 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 01:10:51 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:10:51 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:10:51 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 01:10:51 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:10:51 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 01:10:51 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:10:51 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 01:10:51 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:10:51 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 01:10:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:10: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')]} 01:10:51 INFO - https://queue.taskcluster.net/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:10:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:10:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:10:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/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 01:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/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 01:10:52 INFO - Downloaded 18095482 bytes. 01:10:52 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'] 01:10:52 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 01:10:55 INFO - Return code: 0 01:10:55 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 01:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:55 INFO - https://queue.taskcluster.net/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:10:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:10:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:10:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/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 01:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/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 01:10:57 INFO - Downloaded 18095482 bytes. 01:10:57 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'] 01:10:57 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 01:11:01 INFO - Return code: 0 01:11:01 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')]} 01:11:01 INFO - https://queue.taskcluster.net/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:11:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:11:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:11:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/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 01:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/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 01:11:02 INFO - Downloaded 10845952 bytes. 01:11:02 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'] 01:11:02 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 01:11:02 INFO - Return code: 0 01:11:02 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')]} 01:11:02 INFO - https://queue.taskcluster.net/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 01:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JdNX3Gn6R064WjbdDhtLWQ/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 01:11:06 INFO - Downloaded 110053732 bytes. 01:11:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:11:06 INFO - mkdir: /builds/slave/test/properties 01:11:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:11:06 INFO - Writing to file /builds/slave/test/properties/build_url 01:11:06 INFO - Contents: 01:11:06 INFO - build_url:https://queue.taskcluster.net/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:11:07 INFO - Running post-action listener: _resource_record_post_action 01:11:07 INFO - Running post-action listener: set_extra_try_arguments 01:11:07 INFO - ##### 01:11:07 INFO - ##### Running populate-webroot step. 01:11:07 INFO - ##### 01:11:07 INFO - Running pre-action listener: _resource_record_pre_action 01:11:07 INFO - Running main action method: populate_webroot 01:11:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:11:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:11:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:11:07 INFO - '--tppagecycles', 01:11:07 INFO - '7'], 01:11:07 INFO - 'tests': ['tsvgm']}}, 01:11:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:11:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:11:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:11:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:11:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:11:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:11:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:07 INFO - 'talos_options': ['--disable-e10s'], 01:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:11:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:11:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:07 INFO - 'talos_options': ['--disable-e10s'], 01:11:07 INFO - 'tests': ['damp', 'tps']}, 01:11:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:07 INFO - 'tests': ['damp', 'tps']}, 01:11:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:11:07 INFO - 'tests': ['dromaeo_dom']}, 01:11:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:11:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:11:07 INFO - 'tests': ['a11yr', 01:11:07 INFO - 'ts_paint', 01:11:07 INFO - 'tpaint', 01:11:07 INFO - 'sessionrestore', 01:11:07 INFO - 'sessionrestore_no_auto_restore', 01:11:07 INFO - 'tabpaint']}, 01:11:07 INFO - 'other-e10s': {'tests': ['a11yr', 01:11:07 INFO - 'ts_paint', 01:11:07 INFO - 'tpaint', 01:11:07 INFO - 'sessionrestore', 01:11:07 INFO - 'sessionrestore_no_auto_restore', 01:11:07 INFO - 'tabpaint']}, 01:11:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:11:07 INFO - 'ts_paint', 01:11:07 INFO - 'tpaint', 01:11:07 INFO - 'sessionrestore', 01:11:07 INFO - 'sessionrestore_no_auto_restore', 01:11:07 INFO - 'tabpaint']}, 01:11:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:11:07 INFO - 'ts_paint', 01:11:07 INFO - 'tpaint', 01:11:07 INFO - 'sessionrestore', 01:11:07 INFO - 'sessionrestore_no_auto_restore', 01:11:07 INFO - 'tabpaint']}, 01:11:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:11:07 INFO - 'tests': ['a11yr', 01:11:07 INFO - 'ts_paint', 01:11:07 INFO - 'tpaint', 01:11:07 INFO - 'sessionrestore', 01:11:07 INFO - 'sessionrestore_no_auto_restore', 01:11:07 INFO - 'tabpaint']}, 01:11:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:11:07 INFO - 'tests': ['a11yr', 01:11:07 INFO - 'ts_paint', 01:11:07 INFO - 'tpaint', 01:11:07 INFO - 'sessionrestore', 01:11:07 INFO - 'sessionrestore_no_auto_restore', 01:11:07 INFO - 'tabpaint']}, 01:11:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:11:07 INFO - 'tests': ['tsvgx', 01:11:07 INFO - 'tsvgr_opacity', 01:11:07 INFO - 'tart', 01:11:07 INFO - 'tscrollx', 01:11:07 INFO - 'cart']}, 01:11:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:11:07 INFO - 'tsvgr_opacity', 01:11:07 INFO - 'tart', 01:11:07 INFO - 'tscrollx', 01:11:07 INFO - 'cart']}, 01:11:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:07 INFO - 'talos_options': ['--disable-e10s'], 01:11:07 INFO - 'tests': ['tp5o']}, 01:11:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:07 INFO - 'tests': ['tp5o']}, 01:11:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:07 INFO - 'talos_options': ['--disable-e10s', 01:11:07 INFO - '--xperf_path', 01:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:11:07 INFO - 'tests': ['tp5n']}, 01:11:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:07 INFO - 'talos_options': ['--xperf_path', 01:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:11:07 INFO - 'tests': ['tp5n']}}, 01:11:07 INFO - 'talos.zip': {'path': '', 01:11:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:11:07 INFO - Running post-action listener: _resource_record_post_action 01:11:07 INFO - ##### 01:11:07 INFO - ##### Running create-virtualenv step. 01:11:07 INFO - ##### 01:11:07 INFO - Running pre-action listener: _resource_record_pre_action 01:11:07 INFO - Running main action method: create_virtualenv 01:11:07 INFO - Creating virtualenv /builds/slave/test/build/venv 01:11:07 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 01:11:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:11:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:11:07 INFO - Using real prefix '/tools/python27' 01:11:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:11:07 INFO - Installing distribute.............................................................................................................................................................................................done. 01:11:10 INFO - Installing pip.................done. 01:11:10 INFO - Return code: 0 01:11:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:11:10 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')]} 01:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:10 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')]} 01:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:10 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 0x10e41aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e42a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8bbd95e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b9e00>, '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 0x10e122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b4b20>, '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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 01:11:10 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 01:11:10 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 01:11:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qPVAFpCFpf/Render', 01:11:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:11:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:11:10 INFO - 'HOME': '/Users/cltbld', 01:11:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:11:10 INFO - 'LOGNAME': 'cltbld', 01:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:10 INFO - 'MOZ_NO_REMOTE': '1', 01:11:10 INFO - 'NO_EM_RESTART': '1', 01:11:10 INFO - 'PAGER': '/bin/cat', 01:11:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:10 INFO - 'PWD': '/builds/slave/test', 01:11:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:11:10 INFO - 'SHELL': '/bin/bash', 01:11:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3rrHmUFr8M/Listeners', 01:11:10 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 01:11:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:11:10 INFO - 'USER': 'cltbld', 01:11:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:11:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:10 INFO - 'XPC_FLAGS': '0x0', 01:11:10 INFO - 'XPC_SERVICE_NAME': '0', 01:11:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:11 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 01:11:11 INFO - Cleaning up... 01:11:11 INFO - Return code: 0 01:11:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:11:11 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')]} 01:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:11 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')]} 01:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:11 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 0x10e41aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e42a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8bbd95e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b9e00>, '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 0x10e122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b4b20>, '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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 01:11:11 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 01:11:11 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 01:11:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qPVAFpCFpf/Render', 01:11:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:11:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:11:11 INFO - 'HOME': '/Users/cltbld', 01:11:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:11:11 INFO - 'LOGNAME': 'cltbld', 01:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:11 INFO - 'MOZ_NO_REMOTE': '1', 01:11:11 INFO - 'NO_EM_RESTART': '1', 01:11:11 INFO - 'PAGER': '/bin/cat', 01:11:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:11 INFO - 'PWD': '/builds/slave/test', 01:11:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:11:11 INFO - 'SHELL': '/bin/bash', 01:11:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3rrHmUFr8M/Listeners', 01:11:11 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 01:11:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:11:11 INFO - 'USER': 'cltbld', 01:11:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:11:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:11 INFO - 'XPC_FLAGS': '0x0', 01:11:11 INFO - 'XPC_SERVICE_NAME': '0', 01:11:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:11 INFO - Downloading/unpacking psutil>=0.7.1 01:11: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 01:11: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 01:11: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 01:11: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 01:11: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 01:11: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 01:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:11:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:11:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:11:14 INFO - Installing collected packages: psutil 01:11:14 INFO - Running setup.py install for psutil 01:11:14 INFO - building 'psutil._psutil_osx' extension 01:11:14 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 01:11:14 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 01:11:14 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 01:11:14 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 01:11:14 INFO - building 'psutil._psutil_posix' extension 01:11:14 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 01:11:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:11:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:11:14 INFO - ^ 01:11:14 INFO - 1 warning generated. 01:11:14 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 01:11:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:11:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:11:15 INFO - Successfully installed psutil 01:11:15 INFO - Cleaning up... 01:11:15 INFO - Return code: 0 01:11:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e41aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e42a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8bbd95e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b9e00>, '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 0x10e122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b4b20>, '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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 01:11:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:11:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qPVAFpCFpf/Render', 01:11:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:11:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:11:15 INFO - 'HOME': '/Users/cltbld', 01:11:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:11:15 INFO - 'LOGNAME': 'cltbld', 01:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:15 INFO - 'MOZ_NO_REMOTE': '1', 01:11:15 INFO - 'NO_EM_RESTART': '1', 01:11:15 INFO - 'PAGER': '/bin/cat', 01:11:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:15 INFO - 'PWD': '/builds/slave/test', 01:11:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:11:15 INFO - 'SHELL': '/bin/bash', 01:11:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3rrHmUFr8M/Listeners', 01:11:15 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 01:11:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:11:15 INFO - 'USER': 'cltbld', 01:11:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:11:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:15 INFO - 'XPC_FLAGS': '0x0', 01:11:15 INFO - 'XPC_SERVICE_NAME': '0', 01:11:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:11: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 01:11: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 01:11: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 01:11: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 01:11: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 01:11: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 01:11:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:11:17 INFO - Installing collected packages: mozsystemmonitor 01:11:17 INFO - Running setup.py install for mozsystemmonitor 01:11:17 INFO - Successfully installed mozsystemmonitor 01:11:17 INFO - Cleaning up... 01:11:18 INFO - Return code: 0 01:11:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:18 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 0x10e41aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e42a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8bbd95e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b9e00>, '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 0x10e122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b4b20>, '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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 01:11:18 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 01:11:18 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 01:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qPVAFpCFpf/Render', 01:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:11:18 INFO - 'HOME': '/Users/cltbld', 01:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:11:18 INFO - 'LOGNAME': 'cltbld', 01:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:18 INFO - 'MOZ_NO_REMOTE': '1', 01:11:18 INFO - 'NO_EM_RESTART': '1', 01:11:18 INFO - 'PAGER': '/bin/cat', 01:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:18 INFO - 'PWD': '/builds/slave/test', 01:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:11:18 INFO - 'SHELL': '/bin/bash', 01:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3rrHmUFr8M/Listeners', 01:11:18 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 01:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:11:18 INFO - 'USER': 'cltbld', 01:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:18 INFO - 'XPC_FLAGS': '0x0', 01:11:18 INFO - 'XPC_SERVICE_NAME': '0', 01:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:18 INFO - Downloading/unpacking blobuploader==1.2.4 01:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:20 INFO - Downloading blobuploader-1.2.4.tar.gz 01:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:11:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:11:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:21 INFO - Downloading docopt-0.6.1.tar.gz 01:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:11:22 INFO - Installing collected packages: blobuploader, requests, docopt 01:11:22 INFO - Running setup.py install for blobuploader 01:11:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:11:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:11:22 INFO - Running setup.py install for requests 01:11:22 INFO - Running setup.py install for docopt 01:11:22 INFO - Successfully installed blobuploader requests docopt 01:11:22 INFO - Cleaning up... 01:11:22 INFO - Return code: 0 01:11:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:11: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')]} 01:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11: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')]} 01:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:22 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 0x10e41aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e42a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8bbd95e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b9e00>, '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 0x10e122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b4b20>, '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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 01:11:22 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 01:11:22 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 01:11:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qPVAFpCFpf/Render', 01:11:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:11:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:11:22 INFO - 'HOME': '/Users/cltbld', 01:11:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:11:22 INFO - 'LOGNAME': 'cltbld', 01:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:22 INFO - 'MOZ_NO_REMOTE': '1', 01:11:22 INFO - 'NO_EM_RESTART': '1', 01:11:22 INFO - 'PAGER': '/bin/cat', 01:11:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:22 INFO - 'PWD': '/builds/slave/test', 01:11:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:11:22 INFO - 'SHELL': '/bin/bash', 01:11:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3rrHmUFr8M/Listeners', 01:11:22 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 01:11:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:11:22 INFO - 'USER': 'cltbld', 01:11:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:11:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:22 INFO - 'XPC_FLAGS': '0x0', 01:11:22 INFO - 'XPC_SERVICE_NAME': '0', 01:11:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:11:23 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-ynbKts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:11:23 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-8LhB0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:11:23 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-38bLMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:11:23 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-0p235F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:11:23 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-fE_1vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:11:23 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-viZmke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:11:23 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-fhI8RD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:11:23 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-qQvbvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:11:23 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-sr7Ub7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:11:24 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-zUWqU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:11:24 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-qGka7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:11:24 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Kbmxrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:11:24 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-czgKS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:11:24 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-OnRYpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:11:24 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-iF3WEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:11:24 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-6b6oKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:11:24 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-0NRTP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:11:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:11:24 INFO - Running setup.py install for manifestparser 01:11:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:11:25 INFO - Running setup.py install for mozcrash 01:11:25 INFO - Running setup.py install for mozdebug 01:11:25 INFO - Running setup.py install for mozdevice 01:11:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:11:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:11:25 INFO - Running setup.py install for mozfile 01:11:25 INFO - Running setup.py install for mozhttpd 01:11:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:11:25 INFO - Running setup.py install for mozinfo 01:11:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:11:25 INFO - Running setup.py install for mozInstall 01:11:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:11:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:11:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:11:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:11:26 INFO - Running setup.py install for mozleak 01:11:26 INFO - Running setup.py install for mozlog 01:11:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:11:26 INFO - Running setup.py install for moznetwork 01:11:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:11:26 INFO - Running setup.py install for mozprocess 01:11:26 INFO - Running setup.py install for mozprofile 01:11:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:11:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:11:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:11:26 INFO - Running setup.py install for mozrunner 01:11:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:11:27 INFO - Running setup.py install for mozscreenshot 01:11:27 INFO - Running setup.py install for moztest 01:11:27 INFO - Running setup.py install for mozversion 01:11:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:11:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:11:27 INFO - Cleaning up... 01:11:27 INFO - Return code: 0 01:11:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:27 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 0x10e41aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e42a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8bbd95e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b9e00>, '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 0x10e122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b4b20>, '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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 01:11:27 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 01:11:27 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 01:11:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qPVAFpCFpf/Render', 01:11:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:11:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:11:27 INFO - 'HOME': '/Users/cltbld', 01:11:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:11:27 INFO - 'LOGNAME': 'cltbld', 01:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:27 INFO - 'MOZ_NO_REMOTE': '1', 01:11:27 INFO - 'NO_EM_RESTART': '1', 01:11:27 INFO - 'PAGER': '/bin/cat', 01:11:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:27 INFO - 'PWD': '/builds/slave/test', 01:11:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:11:27 INFO - 'SHELL': '/bin/bash', 01:11:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3rrHmUFr8M/Listeners', 01:11:27 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 01:11:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:11:27 INFO - 'USER': 'cltbld', 01:11:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:11:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:27 INFO - 'XPC_FLAGS': '0x0', 01:11:27 INFO - 'XPC_SERVICE_NAME': '0', 01:11:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:11:27 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-JHWuGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:11:27 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)) 01:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:11:27 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-AZORHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:11:27 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)) 01:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:11:27 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-72EKFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:11:28 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)) 01:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:11:28 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-UFowpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:11:28 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)) 01:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:11:28 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-7lQcZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:11:28 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)) 01:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:11:28 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-NiN4Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:11:28 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)) 01:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:11:28 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-jIUIH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:11:28 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)) 01:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:11:28 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-vYXxvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:11:28 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)) 01:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:11:28 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-gQ2iYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:11:28 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)) 01:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:11:28 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Efr_WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:11:28 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)) 01:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:11:28 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-z6nCFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:11:28 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)) 01:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:11:28 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-NFMEpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:11:29 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)) 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:11:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-7N6_1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:11:29 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)) 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:11:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-2daFSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:11:29 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)) 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:11:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-_PQI8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:11:29 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)) 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:11:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-uUg7Ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:11:29 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)) 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:11:29 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-adTjOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:11:29 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)) 01:11:29 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)) 01:11:29 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)) 01:11:29 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)) 01:11:29 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)) 01:11:29 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)) 01:11:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:11:29 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 01:11:29 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 01:11:29 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 01:11:29 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 01:11:29 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 01:11:29 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 01:11:31 INFO - Downloading blessings-1.6.tar.gz 01:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:11:32 INFO - Installing collected packages: blessings 01:11:32 INFO - Running setup.py install for blessings 01:11:32 INFO - Successfully installed blessings 01:11:32 INFO - Cleaning up... 01:11:32 INFO - Return code: 0 01:11:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:11:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:11:32 INFO - Reading from file tmpfile_stdout 01:11:32 INFO - Current package versions: 01:11:32 INFO - blessings == 1.6 01:11:32 INFO - blobuploader == 1.2.4 01:11:32 INFO - docopt == 0.6.1 01:11:32 INFO - manifestparser == 1.1 01:11:32 INFO - mozInstall == 1.12 01:11:32 INFO - mozcrash == 0.17 01:11:32 INFO - mozdebug == 0.1 01:11:32 INFO - mozdevice == 0.48 01:11:32 INFO - mozfile == 1.2 01:11:32 INFO - mozhttpd == 0.7 01:11:32 INFO - mozinfo == 0.9 01:11:32 INFO - mozleak == 0.1 01:11:32 INFO - mozlog == 3.1 01:11:32 INFO - moznetwork == 0.27 01:11:32 INFO - mozprocess == 0.22 01:11:32 INFO - mozprofile == 0.28 01:11:32 INFO - mozrunner == 6.11 01:11:32 INFO - mozscreenshot == 0.1 01:11:32 INFO - mozsystemmonitor == 0.0 01:11:32 INFO - moztest == 0.7 01:11:32 INFO - mozversion == 1.4 01:11:32 INFO - psutil == 3.1.1 01:11:32 INFO - requests == 1.2.3 01:11:32 INFO - wsgiref == 0.1.2 01:11:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:11:32 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')]} 01:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:32 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')]} 01:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:32 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 0x10e41aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e42a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8bbd95e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b9e00>, '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 0x10e122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b4b20>, '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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 01:11:32 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 01:11:32 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 01:11:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qPVAFpCFpf/Render', 01:11:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:11:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:11:32 INFO - 'HOME': '/Users/cltbld', 01:11:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:11:32 INFO - 'LOGNAME': 'cltbld', 01:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:32 INFO - 'MOZ_NO_REMOTE': '1', 01:11:32 INFO - 'NO_EM_RESTART': '1', 01:11:32 INFO - 'PAGER': '/bin/cat', 01:11:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:32 INFO - 'PWD': '/builds/slave/test', 01:11:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:11:32 INFO - 'SHELL': '/bin/bash', 01:11:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3rrHmUFr8M/Listeners', 01:11:32 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 01:11:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:11:32 INFO - 'USER': 'cltbld', 01:11:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:11:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:32 INFO - 'XPC_FLAGS': '0x0', 01:11:32 INFO - 'XPC_SERVICE_NAME': '0', 01:11:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:32 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)) 01:11:32 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)) 01:11:32 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)) 01:11:32 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)) 01:11:32 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)) 01:11:32 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)) 01:11:32 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)) 01:11:32 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)) 01:11:32 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)) 01:11:32 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)) 01:11:32 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)) 01:11:32 INFO - Cleaning up... 01:11:32 INFO - Return code: 0 01:11:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:11:32 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')]} 01:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:32 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')]} 01:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:32 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 0x10e41aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e42a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8bbd95e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b9e00>, '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 0x10e122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b4b20>, '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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 01:11:32 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 01:11:32 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 01:11:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qPVAFpCFpf/Render', 01:11:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:11:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:11:32 INFO - 'HOME': '/Users/cltbld', 01:11:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:11:32 INFO - 'LOGNAME': 'cltbld', 01:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:32 INFO - 'MOZ_NO_REMOTE': '1', 01:11:32 INFO - 'NO_EM_RESTART': '1', 01:11:32 INFO - 'PAGER': '/bin/cat', 01:11:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:32 INFO - 'PWD': '/builds/slave/test', 01:11:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:11:32 INFO - 'SHELL': '/bin/bash', 01:11:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3rrHmUFr8M/Listeners', 01:11:32 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 01:11:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:11:32 INFO - 'USER': 'cltbld', 01:11:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:11:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:32 INFO - 'XPC_FLAGS': '0x0', 01:11:32 INFO - 'XPC_SERVICE_NAME': '0', 01:11:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:33 INFO - Downloading/unpacking jsonschema 01:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:11:35 INFO - Downloading/unpacking functools32 (from jsonschema) 01:11:35 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 01:11:35 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 01:11:35 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 01:11:35 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 01:11:35 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 01:11:35 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 01:11:35 INFO - Downloading functools32-3.2.3-2.tar.gz 01:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:11:35 INFO - warning: no files found matching '*.txt' 01:11:35 INFO - no previously-included directories found matching 'build' 01:11:35 INFO - no previously-included directories found matching 'dist' 01:11:35 INFO - no previously-included directories found matching '.git*' 01:11:35 INFO - Installing collected packages: jsonschema, functools32 01:11:36 INFO - Running setup.py install for functools32 01:11:36 INFO - warning: no files found matching '*.txt' 01:11:36 INFO - no previously-included directories found matching 'build' 01:11:36 INFO - no previously-included directories found matching 'dist' 01:11:36 INFO - no previously-included directories found matching '.git*' 01:11:36 INFO - Successfully installed jsonschema functools32 01:11:36 INFO - Cleaning up... 01:11:36 INFO - Return code: 0 01:11:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:36 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 0x10e41aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e42a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8bbd95e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b9e00>, '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 0x10e122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b4b20>, '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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 01:11:36 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 01:11:36 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 01:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qPVAFpCFpf/Render', 01:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:11:36 INFO - 'HOME': '/Users/cltbld', 01:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:11:36 INFO - 'LOGNAME': 'cltbld', 01:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:36 INFO - 'MOZ_NO_REMOTE': '1', 01:11:36 INFO - 'NO_EM_RESTART': '1', 01:11:36 INFO - 'PAGER': '/bin/cat', 01:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:36 INFO - 'PWD': '/builds/slave/test', 01:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:11:36 INFO - 'SHELL': '/bin/bash', 01:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3rrHmUFr8M/Listeners', 01:11:36 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 01:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:11:36 INFO - 'USER': 'cltbld', 01:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:36 INFO - 'XPC_FLAGS': '0x0', 01:11:36 INFO - 'XPC_SERVICE_NAME': '0', 01:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:36 INFO - Downloading/unpacking flake8 01:11:36 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 01:11:36 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 01:11:36 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 01:11:36 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 01:11:36 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 01:11:36 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 01:11:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:11:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:11:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:11:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:11:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:11:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:11:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:11:40 INFO - no previously-included directories found matching 'docs/_build' 01:11:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:11:40 INFO - Running setup.py install for pep8 01:11:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:11:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:11:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:11:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:11:40 INFO - no previously-included directories found matching 'docs/_build' 01:11:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:11:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:11:40 INFO - Cleaning up... 01:11:40 INFO - Return code: 0 01:11:40 INFO - Running post-action listener: _resource_record_post_action 01:11:40 INFO - Running post-action listener: _start_resource_monitoring 01:11:40 INFO - Starting resource monitoring. 01:11:40 INFO - ##### 01:11:40 INFO - ##### Running install step. 01:11:40 INFO - ##### 01:11:40 INFO - Running pre-action listener: _resource_record_pre_action 01:11:40 INFO - Running main action method: install 01:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:11:40 INFO - Reading from file tmpfile_stdout 01:11:40 INFO - Detecting whether we're running mozinstall >=1.0... 01:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:11:40 INFO - Reading from file tmpfile_stdout 01:11:40 INFO - Output received: 01:11:40 INFO - Usage: mozinstall [options] installer 01:11:40 INFO - Options: 01:11:40 INFO - -h, --help show this help message and exit 01:11:40 INFO - -d DEST, --destination=DEST 01:11:40 INFO - Directory to install application into. [default: 01:11:40 INFO - "/builds/slave/test"] 01:11:40 INFO - --app=APP Application being installed. [default: firefox] 01:11:40 INFO - mkdir: /builds/slave/test/build/application 01:11:40 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'] 01:11:40 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 01:12:14 INFO - Reading from file tmpfile_stdout 01:12:14 INFO - Output received: 01:12:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:12:14 INFO - Running post-action listener: _resource_record_post_action 01:12:14 INFO - ##### 01:12:14 INFO - ##### Running run-tests step. 01:12:14 INFO - ##### 01:12:14 INFO - Running pre-action listener: _resource_record_pre_action 01:12:14 INFO - Running main action method: run_tests 01:12:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:12:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:12:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:12:14 INFO - 2016-04-20 01:12:14.597 screenresolution[1929:13604] starting screenresolution argv=screenresolution get 01:12:14 INFO - 2016-04-20 01:12:14.599 screenresolution[1929:13604] Display 0: 1600x1200x32@60 01:12:14 INFO - 2016-04-20 01:12:14.606 screenresolution[1930:13606] starting screenresolution argv=screenresolution list 01:12:14 INFO - Available Modes on Display 0 01:12:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:12:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:12:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:12:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:12:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:12:14 INFO - Intel Iris: 01:12:14 INFO - Chipset Model: Intel Iris 01:12:14 INFO - Type: GPU 01:12:14 INFO - Bus: Built-In 01:12:14 INFO - VRAM (Dynamic, Max): 1536 MB 01:12:14 INFO - Vendor: Intel (0x8086) 01:12:14 INFO - Device ID: 0x0a2e 01:12:14 INFO - Revision ID: 0x0009 01:12:14 INFO - Displays: 01:12:14 INFO - Display: 01:12:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:12:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:12:14 INFO - Display Serial Number: 1600x1200 60 01:12:14 INFO - Main Display: Yes 01:12:14 INFO - Mirror: Off 01:12:14 INFO - Online: Yes 01:12:14 INFO - Rotation: Supported 01:12:14 INFO - Return code: 0 01:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:12:14 INFO - Python 2.7.3 01:12:14 INFO - Return code: 0 01:12:14 INFO - grabbing minidump binary from tooltool 01:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:14 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 0x10e2b9e00>, '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 0x10e122db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:12:14 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 01:12:14 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 01:12:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:12:14 INFO - Return code: 0 01:12:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:12:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:12:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:12:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:12:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:12:16 INFO - Return code: 0 01:12:16 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/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 01:12:16 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/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0136 --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 01:12:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qPVAFpCFpf/Render', 01:12:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:16 INFO - 'HOME': '/Users/cltbld', 01:12:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:16 INFO - 'LOGNAME': 'cltbld', 01:12:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:12:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:16 INFO - 'MOZ_NO_REMOTE': '1', 01:12:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:12:16 INFO - 'NO_EM_RESTART': '1', 01:12:16 INFO - 'PAGER': '/bin/cat', 01:12:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:16 INFO - 'PWD': '/builds/slave/test', 01:12:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:12:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:16 INFO - 'SHELL': '/bin/bash', 01:12:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3rrHmUFr8M/Listeners', 01:12:16 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 01:12:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:16 INFO - 'USER': 'cltbld', 01:12:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:16 INFO - 'XPC_FLAGS': '0x0', 01:12:16 INFO - 'XPC_SERVICE_NAME': '0', 01:12:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:16 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/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 01:12:16 INFO - mozversion application_buildid: 20160419233542 01:12:16 INFO - mozversion application_changeset: f9fc0c367d89188d01677da6cf85bb2097e85605 01:12:16 INFO - mozversion application_display_name: Nightly 01:12:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:12:16 INFO - mozversion application_name: Firefox 01:12:16 INFO - mozversion application_remotingname: firefox 01:12:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:12:16 INFO - mozversion application_vendor: Mozilla 01:12:16 INFO - mozversion application_version: 48.0a1 01:12:16 INFO - mozversion platform_buildid: 20160419233542 01:12:16 INFO - mozversion platform_changeset: f9fc0c367d89188d01677da6cf85bb2097e85605 01:12:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:12:16 INFO - mozversion platform_version: 48.0a1 01:12:16 INFO - using testdate: 1461139936 01:12:16 INFO - actual date: 1461139936 01:12:16 INFO - starting webserver on 'localhost:51144' 01:12:16 INFO - SUITE-START | Running 2 tests 01:12:16 INFO - TEST-START | dromaeo_css 01:12:16 INFO - operating with platform_type : mac_ 01:12:16 INFO - Initialising browser for dromaeo_css test... 01:12:16 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpjsfDY1/profile http://localhost:51144/getInfo.html) 01:12:19 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 01:12:19 INFO - PROCESS | 1948 | colorDepth:24 01:12:19 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 01:12:19 INFO - PROCESS | 1948 | __metrics 01:12:19 ERROR - PROCESS | 1948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 01:12:19 INFO - TEST-INFO | 1948: exit 0 01:12:19 INFO - Browser initialized. 01:12:19 INFO - Running cycle 1/1 for dromaeo_css test... 01:12:19 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpjsfDY1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:12:31 INFO - PROCESS | 1951 | RSS: Main: 247488512 01:12:31 INFO - PROCESS | 1951 | 01:13:21 INFO - PROCESS | 1951 | 1461140001338 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] 01:15:32 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51144/tests/dromaeo/cssquery-ext.html) 01:15:33 INFO - PROCESS | 1951 | RSS: Main: 259485696 01:15:33 INFO - PROCESS | 1951 | 01:18:36 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51144/tests/dromaeo/cssquery-ext.html (next: http://localhost:51144/tests/dromaeo/cssquery-jquery.html) 01:18:36 INFO - PROCESS | 1951 | RSS: Main: 271273984 01:18:36 INFO - PROCESS | 1951 | 01:21:38 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51144/tests/dromaeo/cssquery-mootools.html) 01:21:39 INFO - PROCESS | 1951 | RSS: Main: 273567744 01:21:39 INFO - PROCESS | 1951 | 01:24:40 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51144/tests/dromaeo/cssquery-prototype.html) 01:24:41 INFO - PROCESS | 1951 | RSS: Main: 275116032 01:24:41 INFO - PROCESS | 1951 | 01:27:44 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51144/tests/dromaeo/cssquery-yui.html) 01:27:44 INFO - PROCESS | 1951 | RSS: Main: 278487040 01:27:44 INFO - PROCESS | 1951 | 01:30:47 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51144/tests/dromaeo/cssquery-yui.html (next: http://localhost:51144/tests/dromaeo/cssquery-dojo.html) 01:30:47 INFO - PROCESS | 1951 | RSS: Main: 279212032 01:30:47 INFO - PROCESS | 1951 | 01:30:47 INFO - PROCESS | 1951 | __start_tp_report 01:30:47 INFO - PROCESS | 1951 | _x_x_mozilla_page_load 01:30:47 INFO - PROCESS | 1951 | _x_x_mozilla_page_load_details 01:30:47 INFO - PROCESS | 1951 | |i|pagename|runs| 01:30:47 INFO - PROCESS | 1951 | |0;dojo.html;3204.487282034874;3478.7738796978197;3518.542589463371;3528.6294939031386;3557.679808817206;5810.389909059551;5869.413058694128;5886.676232807194;5890.823275301748;5924.466797988181;5758.193852860592;5904.675242861641;5914.763409463627;5958.49352805011;6046.395360463951;4453.688241823073;4453.84411545596;5244.527992480676;5270.49930256625;5312.787488500456;455.04008411092127;5148.279240906276;5263.473652634725;5281.2342210379475;5290.709011004393;4195.475565554306;5250.133727934905;5251.317328747238;5261.210818377236;5329.653572517794;5266.210068489719;5281.392639846428;5300.390455097675;5317.601179911483;5355.062863998824;5161;5172.534471897509;5284;5296.285001524783;5299.920501192485;5632.464915832989;5753.971230143822;5776.133579962997;5782.88434231313;5800.4489573490455;6108.129596501663;6177.66022868742;6239.282482514478;6244.843878903063;6251.249850018027;6228.408301211378;6291.087792270096;6297.4962003039645;6347.238331400215;6358.300586935434;5082.949170508322;6012.248468941382;6018.247719035121;6022.337542870281;6055.485283750886;6213.1922850029205;6324.367563243639;6382.84042898922;6408.551401401857;6416.230052393649;6165.475934545524;6170.475509581735;6245;6259.6870156492;6275.184226050585;6242.843928901813;6248.218972628421;6254.655993920287;6284.37156284377;6288.308286088527;6172.938270617236;6211.782587609412;6213.316535181127;6247.375262473716;6254.15568898202;6199.628022318675;6213.409726076015;6225.875482490324;6253.96873015632;6260.311365749764;4963.57809586182;5013.674111182761;5021.874453138701;5023.6985780853265;5024.748762561857;4414.911701765946;4437.400950871655;4481.305397663367;4570.497245303014;4611.861644150681;5979.342272350038;6028.457438830526;6037.275526936795;6039.909401358983;6100.490342048281;5278.736063196825;6272.153259309935;6281.968590157111;6289.308176100625;6294.213223347082;5841.88316233673;5907.675077870673;5919.4080591940465;6006.849828754316;6056.727447264883;5479.945200547943;5524.972375138179;5532.197831314437;5549.556035517149;5567.66594004361;6512.251091124486;6521.087047813215;6522.510811689048;6530.510211734139;6530.967345163339;6151.0773383992755;6151.861905547488;6263.749450021948;6269.31037585856;6276.686165691788;5301.4168441472175;5525.723713814374;6453.741850326122;6500.479961602966;6532.314107018695;6130.52043589939;6230.50155987529;6254.718537665907;6281.277653069956;6293.905591416224;6149.294310503365;6253.37466253371;6253.405926436982;6321.96839015802;6329.810105696836;5300.3639563252655;6160.907586386118;6240.12638230639;6241.251049874044;6272.278687950944;6156.891759483336;6174.629522228681;6192.81421557354;6195.96902015487;6271.4669253114;5224.869378265422;5301.284326615858;6061.909071363845;6150.677604315094;6169.198004259418;4568.634509239187;5878.823635290948;6199.845003874939;6210.378962103934;6252;5130.743462826769;5972.492338151305;6114.814446323713;6178.104174894705;6180.505559555135 01:30:47 INFO - PROCESS | 1951 | |1;ext.html;522.5584381197889;540.2214719146224;551.0962022283455;593.6022864680664;645.3062957320881;37104.25791484172;38065.04837379067;38069.23861522768;38116.618833811655;38135.42796858046;29070.418591628153;38469.61530384696;38877.41683874744;39190;39196.412053819215;7181.497295189339;9422.670206542773;9529.285303602222;9567.425954442755;9605.183559397425;9446.85829712555;9517.904820951771;9570.47362395068;9585.80828383432;9618.615255389775;9554.856677149848;9605.18355939746;9667.75830604237;9672.322937394385;9705.029497050275;9530.809383812355;9546.427214367126;9596.088371604686;9626.181774549172;9660.565274562661;9378.718638440858;9422.387544809566;9463;9588.376755510939;9590;31384.686153138406;38205.85382438531;38468.038299042746;38526.80736596299;38532.22935541273;3086.672730725787;3216.2763378239943;3258.185453636591;3380.256343604403;3490.0053484756722;27546.586801198;27629.30926726848;27807.860960695067;28383.716162838522;28638.284042898886;2711.810173287871;2716.334498047971;2729.353233830846;2738.5070687276284;2923.8684259208385;648929.5107048916;650702;660672;667667;670267;66912.33087669061;66930;67515.98726019113;67754.66122669356;67859.32140678629;61493.69253153795;72677.6366118166;74159;74350;74382;16877.15614219284;17097.743533847002;17118.315267389415;17144.39994600183;17156.742648860276;12517.374131293582;12833.230006199658;12874.935625321814;12953.481860725466;12967.481300748053;20719.756814591172;20808.647437916487;20976.580468390854;21035.317174625994;21349.57300853974;7755.2632499912415;7862.253085956825;9028.277737780962;9300.53497325131;9304;903.3270213690843;960.519740129935;973.6689525561343;1065.046783129095;1135.8012347839094;23242.7675723244;23263.53472930532;29245.561316580268;29362.706372936424;29963.700362996526;1059.5814653212092;1095.118429664128;1104.7569534702352;1180.5690922813112;1205.9155859089956;14772.892033097562;14867.628309292355;14937.402503899722;15011.924940375227;15375.000624959343;596698;610254;620150;625101;626279;56815;56896.715516422155;57622;57622.42377576171;57654.711726441936;1453.9200343981183;1475.57606909333;1507.8416766239825;1516.2721893491187;1517.9316930738144;23325.833708314178;28610.284742881595;29041;29112.854435727684;29566.556501652063;48589.02821943612;48804.51195488;49170.508294916595;49285;49324;560610;560890;561125;562233;570746;26855.731442685323;27266.454670906074;27284.181474555797;40995;42351.36472952847;40669.18661626692;41065.178696426505;41590;41801.16397671969;42299;35922.8203858979;38171.42742858804;38232.42651360288;38649.6135038646;38824;35800.64199357973;36644.81677591595;37159.81420092882;37230.51077956851;38711.806440967615;34950.12624684403;37811.432828507044;38654;39139.804300978314;39540.2091958165;28562.714372856004;30287.394252115275;31017.91437299684;31147.688523114477;31281.217969550034;21290.36128916135;22870.199543015915;23557.411064723517;24194.51610967806;24393.634095488225 01:30:47 INFO - PROCESS | 1951 | |2;jquery.html;354.32324260662125;390.84561598168716;392.8546437818008;399.8900302416835;406.06199678742087;18255.908720456413;19456;19820.99999999998;20243.797562024374;20354.389368318956;19797.604047919034;20279.290224842134;20610;21165.365039048815;21229.787702123012;5196.8700782480555;5696.629719068268;5916.408359164071;5946;5948.643081415129;5907.852303692399;5943.4056594340655;5952.166696662471;5955.791547295846;5970.522358211333;5356.54469370102;5732.856678583027;5733.140028995643;5743.138529220609;5890.087036509348;4665.603423708989;5274.551663108621;5613.326400831886;6489.772857949949;6512.902306465359;5187.792488300463;5706.229658996024;5733.426657334275;5747.59766816323;5768.97115514424;12629.328560419674;12971.935140324238;13391.196528208338;13435.865641343558;13450.923926085987;2058.289889987952;2113.7146485224453;2212.7565967743535;2485.2420011896365;2498.2380373985925;9528.714138575853;9973.650922217688;10430;10904;15064.774028389584;1670.5072003758921;1693.1618848669864;1711.4437807712418;1734.7397890316427;1764.7617571627795;111719;117005;117043.4147829264;117530;118667.406662967;11556.711082222844;11638.1271404645;11680.123990700731;11692.141593274198;11876.218567214813;14949.327280272413;14959.476418325525;14987;15013.399464021317;15037;8471.95764021176;8673.306135509145;8700.912990870136;8803.955980220058;8818.559072046372;8519.914800851911;8573.614187361583;8598.742037738877;8613.483191008434;8680.913190868137;4556.681032327771;4623.144718227139;4643.976780116145;4670.673052886334;4690;1943.0381960929149;1999.640064788323;2003.1486618187503;2017.404865564662;2043.2439997200834;941.275218082073;959.7312752429331;980.0346658541331;991.2961797123978;1003.9201639703125;20223.696644550342;20241.696374554394;20349.880756558236;20606.690899636516;20737.688934665992;974.8976357482362;983.1446641421866;996.8803743550675;1035.6892932120334;1037.6523864505475;10348.172146228284;10493.422861742525;10565.101966332948;10567.101796347242;10760.461976901124;476034;586974;604319;611613;612007;126033;128135;129331.47339843061;131453;134553;888.9466632001971;991.2317953586029;998.801438274074;1019.1744686803713;1021.3514418344405;13206.537771177962;15428.382864685287;17823.287068517115;17849.929004259786;18115.81884181141;36265.27469450649;40178.799106004284;42188.78905605452;51294.717632059495;51516;53568.19647705209;66303;72443;73922;74448;7802.339403262261;8011.469050429913;8053.110977494366;8183.058948221031;8217.917820821714;8828.646854125764;10579.682609521727;10585.788284234426;12286.877131228573;12844.678883027998;9240.861387079334;9241;10914.563417463212;11035;11064.662191683026;10595.841062384225;10814.783704326026;10841.728956776144;10853.620123295646;11164.385958772345;10779.892201078203;11275.816039315754;11448.713782155513;11453.541858325574;11455.770884582429;8000.239977202156;8037.7588672339925;8179.877301840358;8214.58927053633;8383.832323353621;8134.75595732129;9987.950060249652;10995.725106872393;10999.560017599206;11353.978141967262 01:30:47 INFO - PROCESS | 1951 | |3;mootools.html;1623.0586259969216;1655.0483472003598;1918.5779128591714;1963.9607207855843;1967.8720883142585;8074.91925080749;8587.14128587141;8679.47923124613;8944.329175311845;8969.103089691036;8580;8659.523726195057;8745.562721863913;8745.825083498343;8836.983746869111;2262.558801033799;2287.2452090809993;2289.301762962296;2291.175176936302;2295.8737269450176;2170.6092903277404;2404.6272827711646;2427.1383658801137;2448.742881997391;2475.282168171228;2434.3427274635837;2446.0704932125855;2446.425090103833;2446.8409553378974;2468.2101727447225;2081.4588207066195;2410.80713542917;2411.6623672685837;2447.816413768957;2463.187148241094;2429.0648100481444;2429.10123254397;2442.3771938155833;2447.2046584859813;2448.2532827487607;7684.692612295557;8813.515256660881;8870.73387798367;8892.932848058274;8893.155150260714;5246.632735708502;5459.07195776715;5465.562754979592;5483.314585676791;5501.587380946405;3610.151614370621;3618.3667858124722;3618.819059047037;3639.5814481334455;3658.707303415747;945.4516380499294;1052.6210564196883;1054.5149231353587;1068.6633710381284;1073.9570417183304;11714.648560543197;11798;11814.88185118155;11866.881331186663;11870.88129118715;4642.651801114863;4688.71867687933;4840.249761287007;4902.632302577321;4903.656744027955;9939.552720127467;10001.79996400068;10006.599736010623;10007.799844003224;10060.24548158891;5064.82273120439;5163.941392014628;5388.407275199725;5422.7017514036315;5464.836054918359;4435.401220835211;4811.374521312207;4954.256861470736;4955.776990035457;4979.053979743837;4062.268791617478;4070.7354021988476;4074.2230813765364;4080.489938757655;4115.0741083256025;1261.3756190685485;1326.6418067121824;1351.7228968061524;1377.0704774277324;1386.1752257406827;818.8976377952756;860;916.134253130785;920.8572671235969;941.9529023548795;5107.463716309734;5796.246487956539;5883.470487656132;5954.732037058343;5987.700614969234;432.9870103896888;435.92589259825905;445.2097526889732;454.78170478170665;454.9818007279672;3890.1636148228267;3926.1755031443718;3986.621270979252;4019.658329042006;4063.79681015948;9925.30522863407;10455.84316235242;10504.789904201873;10753.83869241962;10997.61508347204;10775.515101820436;10877;10914.23600347968;10921.344719316867;10940.726481838017;8058.637361318754;8169.754907352789;8312.085670576233;8313.83372332562;8344.41589088758;5777.884442311214;5794.1308803679785;5875.118732190205;5884.176215329771;5896.056630939029;9770.462624555717;9922.652707155215;10011.899881001096;10031.398116113056;10049.949750251495;9838.950805246215;10027.949860250945;10262.384256944608;10319.94840025795;10380.740481488023;6884.896726549206;7252.746153884589;7523.510971786816;7526.360259378014;7603.505772124794;8356.164383561596;8370.916290837258;8456.069832318317;8458.788530286793;8473.872891906749;7267.200607933229;7376.631168441664;7384.224656411215;7530.472866899265;7547.698092076255;7250.818729531804;7408.777736667908;7427.591482468516;7432.814179645336;7512.286332798375;5844.883102337844;5873.5594830388745;6860.03959445668;6950.582965022115;6962.268961759145;4809.95190048109;4863.270509423614;4928.8767780805765;4953.900921981613;5081.136206844772;4819.783109759999;4890.975545122394;4952.752362381939;5009.624278179224;5177.948220517897 01:30:47 INFO - PROCESS | 1951 | |4;prototype.html;283.7162837162837;311.282493851672;329.2427416941036;330.7271501011666;331.1010606204155;5178.870528236796;5230.372355317362;6159.8768024639485;6161.537884658652;6287.842803929899;5658.349289831671;6205.658688772116;6277.874442511158;6278.9372106278925;6343.714532846021;4659.510751371108;4660.440747110351;4668.883277918046;4682.859514214579;4687.460941991663;3956.9208615827665;4516.616087632555;4614.284785858197;4690.671652984292;4700.623950083985;3951.68386529077;4500.639948804104;4604.562566556188;4611.377464042345;4615.192341340269;3859.2860320840455;4079.776067179849;4125.009997600584;4272.893177670552;4477.507474177871;3509.7016753575977;3697.500837386945;3714.2014466889477;3727.366347720894;4020.7386519876113;5931.911021334683;5955.493783028448;5962.582619216657;5979.701014949279;5989.191459153002;4669.579737823612;5459.153831156177;5474.39781624021;5492.642978206404;5509.504144626962;5573.944260557383;5652.773889044433;6366.745330186787;6633.734650613969;6706.899396509057;3885.911944655473;4442.644588432918;4490.046829629122;4494.4606647202545;4500.549945005473;5816.272965879265;6480.125183100268;6670.566413183176;6843.7604683835825;6971.233164351917;4461.263891457873;4497.785597888552;4515.480719717209;4531.116432295737;4533.9319910201375;4094.2630326541507;4418.138462999685;4586.88532786683;4615.9076818463445;4622.4684161321875;4789.281607758794;5012.273220383024;5433.809816656398;5438.782448702087;5456.454354564512;5221.55616772571;6319.210098737658;6502.382273683992;6677;6728.596284222962;1256.2211428914131;1378.8896888248917;1419.864108713046;1528.533797191845;1548.4580396861008;971.6404930175739;991.3308516751164;1002.1381611813835;1006.2453160129902;1006.642641862143;5455.754491047913;5943.900378430004;6186.505079593621;6203.7828675996125;6249.750009999549;6872.728545219151;6888.41448476875;6899.517033807585;6925.688344024531;6951.2353641099435;5458.099413596712;5938.970305148447;6195.81412557624;6218.284897236786;6218.689065546704;3334.966160490256;3363.789035947057;3443.9164305594754;3592.497050412944;3640.4357324614725;6005.327629204962;6066.514678825683;6298.275698294755;7118.786436406916;7202.783916482514;6811.421029212573;7055.343473307592;7087.681054352566;7101.325374089453;7116.359527642537;6891.069705589782;7151.747199632099;7178.784636460915;7184.533005354635;7204.3155900189395;5523.7238138093735;5740;6874.896876546756;6900.135923882642;6927.718372101177;6425.228972523327;6700.195976482853;6732.427743641845;6791.796246112624;6811.250762416229;7147.321004504772;7176.677049532888;7183.389411900047;7197.820054498679;7198.74804381865;4410.6030457259;4417.757023363746;4422.889427764331;4423.491298500714;4428.446444194476;6565.048068030204;6647.169103862017;6796.150481189851;6850.314968503109;6870.931290687029;6304.401081897213;6326.493880489642;6433.908979581748;6725.495587830835;6727;6036.547258955508;6234.721882014267;6695.163104611924;6727.26000139994;6767.988245231022;5136.897262054813;5846.853828654318;6444.871102578016;6529.542931994714;6603.504737144637;6513.1532900722605;6656.5340426169705;6704.229013663491;6725.9663701681175;6736.6968486417245;5780.421957804186;6266.310705822447;6535.117759102461;6589;6606.141201643755 01:30:47 INFO - PROCESS | 1951 | |5;yui.html;644.432899048837;715.9679698539804;724.1816747075806;724.7244849065643;760.5170716594961;10768.192385571074;15095.773563396559;15124.395024199019;15162.545123646294;16596.246241746838;12582.496700132007;15219.619509512268;16053.518394448156;16136.112513811735;16177.272022758974;817.4604760857835;856.5246288309985;870.634333579898;893.1693525021727;902.801383695586;709.5600727548926;890.9376343655947;903.453410686535;923.0907556057278;925.2413021322518;940.2900809888558;963.9325247232697;967.5936106835146;973.537569654412;973.7468258252834;952.4570994533119;952.8189643967659;954.0078318548701;954.885413750351;955.2310390135938;685.6537448588481;686.1560280854527;690.002945743401;690.5856486108345;718.992810071903;15029.323680434407;15060.397584096623;15296.923515382463;15331.926765126445;15574.844251557453;12638.241705497607;12665.683357916127;12682.429290681941;12695.93652031734;12789.61631151067;10152.187824974058;10168.94915525425;10357.067863892285;10394.946279347349;10617.787644247072;3458.4120699480895;3463.3073385323037;3472.409690352646;3502.7898326100517;3579.2304654499408;79835.8024629631;79963.80054299248;80390.5980470094;80569;83040.16959830385;9170.724878253663;9279.304052196112;9321.114494123047;9377.671781487616;9421.293402994803;21166;21430.678539821914;21432.357029289145;21445.78554214438;21463.89268053681;7471.887921681179;7535.54786712799;7549.0941087069905;7579.052618422697;7809.765707028798;4116.794160292034;4168.8332466701595;4177.561356057631;4185.100203456272;4287.249731297011;3590.1563132663805;3690.686291665185;3691;3709.221063576679;3899.7855117968784;698.8532408194235;705.6119134476018;706.198464742521;713.454207531239;717.2074857282731;526.242211215848;562.1736048009419;567.5743192605546;573.52970564137;583.5302581421996;7667.386609071261;7707.306342429209;7774.844503109906;7890.605469726491;8239.711610093738;569.5557465177169;575;589.5578316262803;595.2529575382953;595.264847912836;3765.3034188675183;3795.3927371620407;3821.5032045833864;3940;3996.162724465604;96471.51764241135;99399.50900736495;99848;100107.49838752425;101603;87922;88408.11591884127;88751;88887.11112888789;89349.55325223332;74389;74842.62578687181;76293;76312.61843690857;77054.22945770582;6424.357564243538;7526;7587.734429294948;7629.618519073913;7722.884156737766;39961.20271580962;44990;45180.548194518946;45235.54764452313;46586;55532.444675552724;56646.43353566412;58664.413355867604;58869.23392298238;59953.10070348861;10858.07706344938;10870.510827012646;10937.905172242115;11204.943975280397;11347.886521134684;12037.45831437605;12367.381630918599;12470.064745143969;12796.36018199105;13313.33433328349;9681.70954871355;10523.526441310007;11500.769984600429;11962.521499139937;12050.156489046034;9416.300653854594;10185.439800811026;11514.712132196762;11737.591489021372;11906.166568340133;9489.545079071171;11210.66368008961;11248.606298779503;11407.714807129889;11472.942635287103;9300.571610034996;9457.858132127885;9550.235981121632;10070.345427547187;10590.947045264724;9597.856032159383;9723.677513995783;9999.400035997864;10022.749431264278;10052.849207262043 01:30:47 INFO - PROCESS | 1951 | __end_tp_report 01:30:47 INFO - PROCESS | 1951 | __start_cc_report 01:30:47 INFO - PROCESS | 1951 | _x_x_mozilla_cycle_collect,396 01:30:47 INFO - PROCESS | 1951 | __end_cc_report 01:30:47 INFO - PROCESS | 1951 | __startTimestamp1461141047770__endTimestamp 01:30:47 INFO - PROCESS | 1951 | 01:30:47 INFO - PROCESS | 1951 | ------- Summary: start ------- 01:30:47 INFO - PROCESS | 1951 | Number of tests: 6 01:30:47 INFO - PROCESS | 1951 | 01:30:47 INFO - PROCESS | 1951 | [#0] dojo.html Cycles:165 Average:5747.01 Median:6055.49 stddev:791.39 (13.1%) stddev-sans-first:768.28 01:30:47 INFO - PROCESS | 1951 | Values: 3204.5 3478.8 3518.5 3528.6 3557.7 5810.4 5869.4 5886.7 5890.8 5924.5 5758.2 5904.7 5914.8 5958.5 6046.4 4453.7 4453.8 5244.5 5270.5 5312.8 455.0 5148.3 5263.5 5281.2 5290.7 4195.5 5250.1 5251.3 5261.2 5329.7 5266.2 5281.4 5300.4 5317.6 5355.1 5161.0 5172.5 5284.0 5296.3 5299.9 5632.5 5754.0 5776.1 5782.9 5800.4 6108.1 6177.7 6239.3 6244.8 6251.2 6228.4 6291.1 6297.5 6347.2 6358.3 5082.9 6012.2 6018.2 6022.3 6055.5 6213.2 6324.4 6382.8 6408.6 6416.2 6165.5 6170.5 6245.0 6259.7 6275.2 6242.8 6248.2 6254.7 6284.4 6288.3 6172.9 6211.8 6213.3 6247.4 6254.2 6199.6 6213.4 6225.9 6254.0 6260.3 4963.6 5013.7 5021.9 5023.7 5024.7 4414.9 4437.4 4481.3 4570.5 4611.9 5979.3 6028.5 6037.3 6039.9 6100.5 5278.7 6272.2 6282.0 6289.3 6294.2 5841.9 5907.7 5919.4 6006.8 6056.7 5479.9 5525.0 5532.2 5549.6 5567.7 6512.3 6521.1 6522.5 6530.5 6531.0 6151.1 6151.9 6263.7 6269.3 6276.7 5301.4 5525.7 6453.7 6500.5 6532.3 6130.5 6230.5 6254.7 6281.3 6293.9 6149.3 6253.4 6253.4 6322.0 6329.8 5300.4 6160.9 6240.1 6241.3 6272.3 6156.9 6174.6 6192.8 6196.0 6271.5 5224.9 5301.3 6061.9 6150.7 6169.2 4568.6 5878.8 6199.8 6210.4 6252.0 5130.7 5972.5 6114.8 6178.1 6180.5 01:30:47 INFO - PROCESS | 1951 | 01:30:47 INFO - PROCESS | 1951 | [#1] ext.html Cycles:180 Average:73661.54 Median:38590.92 stddev:164463.45 (426.2%) stddev-sans-first:164833.13 01:30:47 INFO - PROCESS | 1951 | Values: 522.6 540.2 551.1 593.6 645.3 37104.3 38065.0 38069.2 38116.6 38135.4 29070.4 38469.6 38877.4 39190.0 39196.4 7181.5 9422.7 9529.3 9567.4 9605.2 9446.9 9517.9 9570.5 9585.8 9618.6 9554.9 9605.2 9667.8 9672.3 9705.0 9530.8 9546.4 9596.1 9626.2 9660.6 9378.7 9422.4 9463.0 9588.4 9590.0 31384.7 38205.9 38468.0 38526.8 38532.2 3086.7 3216.3 3258.2 3380.3 3490.0 27546.6 27629.3 27807.9 28383.7 28638.3 2711.8 2716.3 2729.4 2738.5 2923.9 648929.5 650702.0 660672.0 667667.0 670267.0 66912.3 66930.0 67516.0 67754.7 67859.3 61493.7 72677.6 74159.0 74350.0 74382.0 16877.2 17097.7 17118.3 17144.4 17156.7 12517.4 12833.2 12874.9 12953.5 12967.5 20719.8 20808.6 20976.6 21035.3 21349.6 7755.3 7862.3 9028.3 9300.5 9304.0 903.3 960.5 973.7 1065.0 1135.8 23242.8 23263.5 29245.6 29362.7 29963.7 1059.6 1095.1 1104.8 1180.6 1205.9 14772.9 14867.6 14937.4 15011.9 15375.0 596698.0 610254.0 620150.0 625101.0 626279.0 56815.0 56896.7 57622.0 57622.4 57654.7 1453.9 1475.6 1507.8 1516.3 1517.9 23325.8 28610.3 29041.0 29112.9 29566.6 48589.0 48804.5 49170.5 49285.0 49324.0 560610.0 560890.0 561125.0 562233.0 570746.0 26855.7 27266.5 27284.2 40995.0 42351.4 40669.2 41065.2 41590.0 41801.2 42299.0 35922.8 38171.4 38232.4 38649.6 38824.0 35800.6 36644.8 37159.8 37230.5 38711.8 34950.1 37811.4 38654.0 39139.8 39540.2 28562.7 30287.4 31017.9 31147.7 31281.2 21290.4 22870.2 23557.4 24194.5 24393.6 01:30:47 INFO - PROCESS | 1951 | 01:30:47 INFO - PROCESS | 1951 | [#2] jquery.html Cycles:180 Average:33489.20 Median:2349.00 stddev:97037.68 (4131.0%) stddev-sans-first:97278.00 01:30:47 INFO - PROCESS | 1951 | Values: 354.3 390.8 392.9 399.9 406.1 18255.9 19456.0 19821.0 20243.8 20354.4 19797.6 20279.3 20610.0 21165.4 21229.8 5196.9 5696.6 5916.4 5946.0 5948.6 5907.9 5943.4 5952.2 5955.8 5970.5 5356.5 5732.9 5733.1 5743.1 5890.1 4665.6 5274.6 5613.3 6489.8 6512.9 5187.8 5706.2 5733.4 5747.6 5769.0 12629.3 12971.9 13391.2 13435.9 13450.9 2058.3 2113.7 2212.8 2485.2 2498.2 9528.7 9973.7 10430.0 10904.0 15064.8 1670.5 1693.2 1711.4 1734.7 1764.8 111719.0 117005.0 117043.4 117530.0 118667.4 11556.7 11638.1 11680.1 11692.1 11876.2 14949.3 14959.5 14987.0 15013.4 15037.0 8472.0 8673.3 8700.9 8804.0 8818.6 8519.9 8573.6 8598.7 8613.5 8680.9 4556.7 4623.1 4644.0 4670.7 4690.0 1943.0 1999.6 2003.1 2017.4 2043.2 941.3 959.7 980.0 991.3 1003.9 20223.7 20241.7 20349.9 20606.7 20737.7 974.9 983.1 996.9 1035.7 1037.7 10348.2 10493.4 10565.1 10567.1 10760.5 476034.0 586974.0 604319.0 611613.0 612007.0 126033.0 128135.0 129331.5 131453.0 134553.0 888.9 991.2 998.8 1019.2 1021.4 13206.5 15428.4 17823.3 17849.9 18115.8 36265.3 40178.8 42188.8 51294.7 51516.0 53568.2 66303.0 72443.0 73922.0 74448.0 7802.3 8011.5 8053.1 8183.1 8217.9 8828.6 10579.7 10585.8 12286.9 12844.7 9240.9 9241.0 10914.6 11035.0 11064.7 10595.8 10814.8 10841.7 10853.6 11164.4 10779.9 11275.8 11448.7 11453.5 11455.8 8000.2 8037.8 8179.9 8214.6 8383.8 8134.8 9988.0 10995.7 10999.6 11354.0 01:30:47 INFO - PROCESS | 1951 | 01:30:47 INFO - PROCESS | 1951 | [#3] mootools.html Cycles:180 Average:5713.59 Median:4851.76 stddev:3211.16 (66.2%) stddev-sans-first:3205.45 01:30:47 INFO - PROCESS | 1951 | Values: 1623.1 1655.0 1918.6 1964.0 1967.9 8074.9 8587.1 8679.5 8944.3 8969.1 8580.0 8659.5 8745.6 8745.8 8837.0 2262.6 2287.2 2289.3 2291.2 2295.9 2170.6 2404.6 2427.1 2448.7 2475.3 2434.3 2446.1 2446.4 2446.8 2468.2 2081.5 2410.8 2411.7 2447.8 2463.2 2429.1 2429.1 2442.4 2447.2 2448.3 7684.7 8813.5 8870.7 8892.9 8893.2 5246.6 5459.1 5465.6 5483.3 5501.6 3610.2 3618.4 3618.8 3639.6 3658.7 945.5 1052.6 1054.5 1068.7 1074.0 11714.6 11798.0 11814.9 11866.9 11870.9 4642.7 4688.7 4840.2 4902.6 4903.7 9939.6 10001.8 10006.6 10007.8 10060.2 5064.8 5163.9 5388.4 5422.7 5464.8 4435.4 4811.4 4954.3 4955.8 4979.1 4062.3 4070.7 4074.2 4080.5 4115.1 1261.4 1326.6 1351.7 1377.1 1386.2 818.9 860.0 916.1 920.9 942.0 5107.5 5796.2 5883.5 5954.7 5987.7 433.0 435.9 445.2 454.8 455.0 3890.2 3926.2 3986.6 4019.7 4063.8 9925.3 10455.8 10504.8 10753.8 10997.6 10775.5 10877.0 10914.2 10921.3 10940.7 8058.6 8169.8 8312.1 8313.8 8344.4 5777.9 5794.1 5875.1 5884.2 5896.1 9770.5 9922.7 10011.9 10031.4 10049.9 9839.0 10027.9 10262.4 10319.9 10380.7 6884.9 7252.7 7523.5 7526.4 7603.5 8356.2 8370.9 8456.1 8458.8 8473.9 7267.2 7376.6 7384.2 7530.5 7547.7 7250.8 7408.8 7427.6 7432.8 7512.3 5844.9 5873.6 6860.0 6950.6 6962.3 4810.0 4863.3 4928.9 4953.9 5081.1 4819.8 4891.0 4952.8 5009.6 5177.9 01:30:47 INFO - PROCESS | 1951 | 01:30:47 INFO - PROCESS | 1951 | [#4] prototype.html Cycles:180 Average:5326.50 Median:5959.04 stddev:1709.23 (28.7%) stddev-sans-first:1671.59 01:30:47 INFO - PROCESS | 1951 | Values: 283.7 311.3 329.2 330.7 331.1 5178.9 5230.4 6159.9 6161.5 6287.8 5658.3 6205.7 6277.9 6278.9 6343.7 4659.5 4660.4 4668.9 4682.9 4687.5 3956.9 4516.6 4614.3 4690.7 4700.6 3951.7 4500.6 4604.6 4611.4 4615.2 3859.3 4079.8 4125.0 4272.9 4477.5 3509.7 3697.5 3714.2 3727.4 4020.7 5931.9 5955.5 5962.6 5979.7 5989.2 4669.6 5459.2 5474.4 5492.6 5509.5 5573.9 5652.8 6366.7 6633.7 6706.9 3885.9 4442.6 4490.0 4494.5 4500.5 5816.3 6480.1 6670.6 6843.8 6971.2 4461.3 4497.8 4515.5 4531.1 4533.9 4094.3 4418.1 4586.9 4615.9 4622.5 4789.3 5012.3 5433.8 5438.8 5456.5 5221.6 6319.2 6502.4 6677.0 6728.6 1256.2 1378.9 1419.9 1528.5 1548.5 971.6 991.3 1002.1 1006.2 1006.6 5455.8 5943.9 6186.5 6203.8 6249.8 6872.7 6888.4 6899.5 6925.7 6951.2 5458.1 5939.0 6195.8 6218.3 6218.7 3335.0 3363.8 3443.9 3592.5 3640.4 6005.3 6066.5 6298.3 7118.8 7202.8 6811.4 7055.3 7087.7 7101.3 7116.4 6891.1 7151.7 7178.8 7184.5 7204.3 5523.7 5740.0 6874.9 6900.1 6927.7 6425.2 6700.2 6732.4 6791.8 6811.3 7147.3 7176.7 7183.4 7197.8 7198.7 4410.6 4417.8 4422.9 4423.5 4428.4 6565.0 6647.2 6796.2 6850.3 6870.9 6304.4 6326.5 6433.9 6725.5 6727.0 6036.5 6234.7 6695.2 6727.3 6768.0 5136.9 5846.9 6444.9 6529.5 6603.5 6513.2 6656.5 6704.2 6726.0 6736.7 5780.4 6266.3 6535.1 6589.0 6606.1 01:30:47 INFO - PROCESS | 1951 | 01:30:47 INFO - PROCESS | 1951 | [#5] yui.html Cycles:180 Average:18532.47 Median:579.27 stddev:26726.94 (4613.9%) stddev-sans-first:26768.17 01:30:47 INFO - PROCESS | 1951 | Values: 644.4 716.0 724.2 724.7 760.5 10768.2 15095.8 15124.4 15162.5 16596.2 12582.5 15219.6 16053.5 16136.1 16177.3 817.5 856.5 870.6 893.2 902.8 709.6 890.9 903.5 923.1 925.2 940.3 963.9 967.6 973.5 973.7 952.5 952.8 954.0 954.9 955.2 685.7 686.2 690.0 690.6 719.0 15029.3 15060.4 15296.9 15331.9 15574.8 12638.2 12665.7 12682.4 12695.9 12789.6 10152.2 10168.9 10357.1 10394.9 10617.8 3458.4 3463.3 3472.4 3502.8 3579.2 79835.8 79963.8 80390.6 80569.0 83040.2 9170.7 9279.3 9321.1 9377.7 9421.3 21166.0 21430.7 21432.4 21445.8 21463.9 7471.9 7535.5 7549.1 7579.1 7809.8 4116.8 4168.8 4177.6 4185.1 4287.2 3590.2 3690.7 3691.0 3709.2 3899.8 698.9 705.6 706.2 713.5 717.2 526.2 562.2 567.6 573.5 583.5 7667.4 7707.3 7774.8 7890.6 8239.7 569.6 575.0 589.6 595.3 595.3 3765.3 3795.4 3821.5 3940.0 3996.2 96471.5 99399.5 99848.0 100107.5 101603.0 87922.0 88408.1 88751.0 88887.1 89349.6 74389.0 74842.6 76293.0 76312.6 77054.2 6424.4 7526.0 7587.7 7629.6 7722.9 39961.2 44990.0 45180.5 45235.5 46586.0 55532.4 56646.4 58664.4 58869.2 59953.1 10858.1 10870.5 10937.9 11204.9 11347.9 12037.5 12367.4 12470.1 12796.4 13313.3 9681.7 10523.5 11500.8 11962.5 12050.2 9416.3 10185.4 11514.7 11737.6 11906.2 9489.5 11210.7 11248.6 11407.7 11472.9 9300.6 9457.9 9550.2 10070.3 10590.9 9597.9 9723.7 9999.4 10022.7 10052.8 01:30:47 INFO - PROCESS | 1951 | -------- Summary: end -------- 01:30:47 INFO - PROCESS | 1951 | 01:30:48 INFO - TEST-INFO | 1951: exit 0 01:30:48 INFO - TEST-OK | dromaeo_css | took 1112034ms 01:30:48 INFO - TEST-START | kraken 01:30:48 INFO - operating with platform_type : mac_ 01:30:48 INFO - Initialising browser for kraken test... 01:30:48 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpinLpkn/profile http://localhost:51144/getInfo.html) 01:30:51 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 01:30:51 INFO - PROCESS | 1956 | colorDepth:24 01:30:51 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 01:30:51 INFO - PROCESS | 1956 | __metrics 01:30:51 ERROR - PROCESS | 1956 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 01:30:52 INFO - TEST-INFO | 1956: exit 0 01:30:52 INFO - Browser initialized. 01:30:52 INFO - Running cycle 1/1 for kraken test... 01:30:52 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpinLpkn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:31:04 INFO - PROCESS | 1959 | RSS: Main: 247963648 01:31:04 INFO - PROCESS | 1959 | 01:31:07 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51144/tests/kraken/driver.html?testName=audio-beat-detection) 01:31:08 INFO - PROCESS | 1959 | RSS: Main: 259985408 01:31:08 INFO - PROCESS | 1959 | 01:31:10 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51144/tests/kraken/driver.html?testName=audio-dft) 01:31:11 INFO - PROCESS | 1959 | RSS: Main: 268910592 01:31:11 INFO - PROCESS | 1959 | 01:31:14 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51144/tests/kraken/driver.html?testName=audio-fft) 01:31:15 INFO - PROCESS | 1959 | RSS: Main: 272789504 01:31:15 INFO - PROCESS | 1959 | 01:31:17 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51144/tests/kraken/driver.html?testName=audio-oscillator) 01:31:17 INFO - PROCESS | 1959 | RSS: Main: 273772544 01:31:17 INFO - PROCESS | 1959 | 01:31:19 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:31:20 INFO - PROCESS | 1959 | RSS: Main: 274534400 01:31:20 INFO - PROCESS | 1959 | 01:31:23 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51144/tests/kraken/driver.html?testName=imaging-darkroom) 01:31:23 INFO - PROCESS | 1959 | RSS: Main: 274948096 01:31:23 INFO - PROCESS | 1959 | 01:31:26 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51144/tests/kraken/driver.html?testName=imaging-desaturate) 01:31:27 INFO - PROCESS | 1959 | RSS: Main: 275132416 01:31:27 INFO - PROCESS | 1959 | 01:31:30 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51144/tests/kraken/driver.html?testName=json-parse-financial) 01:31:30 INFO - PROCESS | 1959 | RSS: Main: 275144704 01:31:30 INFO - PROCESS | 1959 | 01:31:32 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:31:33 INFO - PROCESS | 1959 | RSS: Main: 274821120 01:31:33 INFO - PROCESS | 1959 | 01:31:34 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51144/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:31:35 INFO - PROCESS | 1959 | RSS: Main: 275468288 01:31:35 INFO - PROCESS | 1959 | 01:31:37 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:31:38 INFO - PROCESS | 1959 | RSS: Main: 275222528 01:31:38 INFO - PROCESS | 1959 | 01:31:41 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:31:41 INFO - PROCESS | 1959 | RSS: Main: 275243008 01:31:41 INFO - PROCESS | 1959 | 01:31:44 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:31:45 INFO - PROCESS | 1959 | RSS: Main: 275275776 01:31:45 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51144/tests/kraken/driver.html?testName=ai-astar) 01:31:47 INFO - PROCESS | 1959 | RSS: Main: 277049344 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | __start_tp_report 01:31:47 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 01:31:47 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 01:31:47 INFO - PROCESS | 1959 | |i|pagename|runs| 01:31:47 INFO - PROCESS | 1959 | |0;ai-astar;127;112;117;117;116;126;116;113;121;171 01:31:47 INFO - PROCESS | 1959 | |1;audio-beat-detection;155;126;146;163;123;144;124;162;161;116 01:31:47 INFO - PROCESS | 1959 | |2;audio-dft;196;216;215;202;196;199;199;196;198;197 01:31:47 INFO - PROCESS | 1959 | |3;audio-fft;63;79;77;145;57;57;55;62;132;56 01:31:47 INFO - PROCESS | 1959 | |4;audio-oscillator;78;79;132;79;77;82;124;101;87;119 01:31:47 INFO - PROCESS | 1959 | |5;imaging-gaussian-blur;89;88;101;126;90;103;132;110;88;86 01:31:47 INFO - PROCESS | 1959 | |6;imaging-darkroom;95;95;95;95;95;94;105;140;95;95 01:31:47 INFO - PROCESS | 1959 | |7;imaging-desaturate;87;92;89;91;91;89;90;92;90;97 01:31:47 INFO - PROCESS | 1959 | |8;json-parse-financial;62;62;62;61;62;63;62;78;63;61 01:31:47 INFO - PROCESS | 1959 | |9;json-stringify-tinderbox;64;68;66;83;95;95;95;68;68;66 01:31:47 INFO - PROCESS | 1959 | |10;stanford-crypto-aes;82;84;85;82;85;84;84;86;85;80 01:31:47 INFO - PROCESS | 1959 | |11;stanford-crypto-ccm;127;141;155;127;135;158;127;147;166;163 01:31:47 INFO - PROCESS | 1959 | |12;stanford-crypto-pbkdf2;214;190;176;190;215;157;219;161;220;153 01:31:47 INFO - PROCESS | 1959 | |13;stanford-crypto-sha256-iterative;69;69;67;62;81;96;91;77;61;100 01:31:47 INFO - PROCESS | 1959 | __end_tp_report 01:31:47 INFO - PROCESS | 1959 | __start_cc_report 01:31:47 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,1016 01:31:47 INFO - PROCESS | 1959 | __end_cc_report 01:31:47 INFO - PROCESS | 1959 | __startTimestamp1461141107645__endTimestamp 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | ------- Summary: start ------- 01:31:47 INFO - PROCESS | 1959 | Number of tests: 14 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#0] ai-astar Cycles:10 Average:123.60 Median:119.00 stddev:17.39 (14.6%) stddev-sans-first:18.40 01:31:47 INFO - PROCESS | 1959 | Values: 127.0 112.0 117.0 117.0 116.0 126.0 116.0 113.0 121.0 171.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:150.50 stddev:18.28 (12.1%) stddev-sans-first:18.78 01:31:47 INFO - PROCESS | 1959 | Values: 155.0 126.0 146.0 163.0 123.0 144.0 124.0 162.0 161.0 116.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#2] audio-dft Cycles:10 Average:201.40 Median:199.00 stddev:7.66 (3.9%) stddev-sans-first:7.87 01:31:47 INFO - PROCESS | 1959 | Values: 196.0 216.0 215.0 202.0 196.0 199.0 199.0 196.0 198.0 197.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#3] audio-fft Cycles:10 Average:78.30 Median:59.50 stddev:32.97 (55.4%) stddev-sans-first:34.50 01:31:47 INFO - PROCESS | 1959 | Values: 63.0 79.0 77.0 145.0 57.0 57.0 55.0 62.0 132.0 56.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:78.50 stddev:21.53 (27.4%) stddev-sans-first:21.86 01:31:47 INFO - PROCESS | 1959 | Values: 78.0 79.0 132.0 79.0 77.0 82.0 124.0 101.0 87.0 119.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#5] imaging-gaussian-blur Cycles:10 Average:101.30 Median:87.00 stddev:16.66 (19.1%) stddev-sans-first:17.07 01:31:47 INFO - PROCESS | 1959 | Values: 89.0 88.0 101.0 126.0 90.0 103.0 132.0 110.0 88.0 86.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#6] imaging-darkroom Cycles:10 Average:100.40 Median:95.00 stddev:14.28 (15.0%) stddev-sans-first:15.01 01:31:47 INFO - PROCESS | 1959 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 105.0 140.0 95.0 95.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#7] imaging-desaturate Cycles:10 Average:90.80 Median:91.00 stddev:2.66 (2.9%) stddev-sans-first:2.44 01:31:47 INFO - PROCESS | 1959 | Values: 87.0 92.0 89.0 91.0 91.0 89.0 90.0 92.0 90.0 97.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:62.00 stddev:5.10 (8.2%) stddev-sans-first:5.38 01:31:47 INFO - PROCESS | 1959 | Values: 62.0 62.0 62.0 61.0 62.0 63.0 62.0 78.0 63.0 61.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#9] json-stringify-tinderbox Cycles:10 Average:76.80 Median:75.50 stddev:13.59 (18.0%) stddev-sans-first:13.60 01:31:47 INFO - PROCESS | 1959 | Values: 64.0 68.0 66.0 83.0 95.0 95.0 95.0 68.0 68.0 66.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.50 stddev:1.83 (2.2%) stddev-sans-first:1.83 01:31:47 INFO - PROCESS | 1959 | Values: 82.0 84.0 85.0 82.0 85.0 84.0 84.0 86.0 85.0 80.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:151.00 stddev:15.36 (10.2%) stddev-sans-first:14.92 01:31:47 INFO - PROCESS | 1959 | Values: 127.0 141.0 155.0 127.0 135.0 158.0 127.0 147.0 166.0 163.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.50 Median:202.00 stddev:26.74 (13.2%) stddev-sans-first:26.85 01:31:47 INFO - PROCESS | 1959 | Values: 214.0 190.0 176.0 190.0 215.0 157.0 219.0 161.0 220.0 153.0 01:31:47 INFO - PROCESS | 1959 | 01:31:47 INFO - PROCESS | 1959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.30 Median:73.00 stddev:14.18 (19.4%) stddev-sans-first:14.72 01:31:47 INFO - PROCESS | 1959 | Values: 69.0 69.0 67.0 62.0 81.0 96.0 91.0 77.0 61.0 100.0 01:31:47 INFO - PROCESS | 1959 | -------- Summary: end -------- 01:31:47 INFO - PROCESS | 1959 | 01:31:48 INFO - TEST-INFO | 1959: exit 0 01:31:48 INFO - TEST-OK | kraken | took 60039ms 01:31:48 INFO - SUITE-END | took 1172s 01:31:48 INFO - Completed test suite (00:19:32) 01:31:48 INFO - javascript benchmark 01:31:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3204.487282034874, 3478.7738796978197, 3518.542589463371, 3528.6294939031386, 3557.679808817206, 5810.389909059551, 5869.413058694128, 5886.676232807194, 5890.823275301748, 5924.466797988181, 5758.193852860592, 5904.675242861641, 5914.763409463627, 5958.49352805011, 6046.395360463951, 4453.688241823073, 4453.84411545596, 5244.527992480676, 5270.49930256625, 5312.787488500456, 455.04008411092127, 5148.279240906276, 5263.473652634725, 5281.2342210379475, 5290.709011004393, 4195.475565554306, 5250.133727934905, 5251.317328747238, 5261.210818377236, 5329.653572517794, 5266.210068489719, 5281.392639846428, 5300.390455097675, 5317.601179911483, 5355.062863998824, 5161.0, 5172.534471897509, 5284.0, 5296.285001524783, 5299.920501192485, 5632.464915832989, 5753.971230143822, 5776.133579962997, 5782.88434231313, 5800.4489573490455, 6108.129596501663, 6177.66022868742, 6239.282482514478, 6244.843878903063, 6251.249850018027, 6228.408301211378, 6291.087792270096, 6297.4962003039645, 6347.238331400215, 6358.300586935434, 5082.949170508322, 6012.248468941382, 6018.247719035121, 6022.337542870281, 6055.485283750886, 6213.1922850029205, 6324.367563243639, 6382.84042898922, 6408.551401401857, 6416.230052393649, 6165.475934545524, 6170.475509581735, 6245.0, 6259.6870156492, 6275.184226050585, 6242.843928901813, 6248.218972628421, 6254.655993920287, 6284.37156284377, 6288.308286088527, 6172.938270617236, 6211.782587609412, 6213.316535181127, 6247.375262473716, 6254.15568898202, 6199.628022318675, 6213.409726076015, 6225.875482490324, 6253.96873015632, 6260.311365749764, 4963.57809586182, 5013.674111182761, 5021.874453138701, 5023.6985780853265, 5024.748762561857, 4414.911701765946, 4437.400950871655, 4481.305397663367, 4570.497245303014, 4611.861644150681, 5979.342272350038, 6028.457438830526, 6037.275526936795, 6039.909401358983, 6100.490342048281, 5278.736063196825, 6272.153259309935, 6281.968590157111, 6289.308176100625, 6294.213223347082, 5841.88316233673, 5907.675077870673, 5919.4080591940465, 6006.849828754316, 6056.727447264883, 5479.945200547943, 5524.972375138179, 5532.197831314437, 5549.556035517149, 5567.66594004361, 6512.251091124486, 6521.087047813215, 6522.510811689048, 6530.510211734139, 6530.967345163339, 6151.0773383992755, 6151.861905547488, 6263.749450021948, 6269.31037585856, 6276.686165691788, 5301.4168441472175, 5525.723713814374, 6453.741850326122, 6500.479961602966, 6532.314107018695, 6130.52043589939, 6230.50155987529, 6254.718537665907, 6281.277653069956, 6293.905591416224, 6149.294310503365, 6253.37466253371, 6253.405926436982, 6321.96839015802, 6329.810105696836, 5300.3639563252655, 6160.907586386118, 6240.12638230639, 6241.251049874044, 6272.278687950944, 6156.891759483336, 6174.629522228681, 6192.81421557354, 6195.96902015487, 6271.4669253114, 5224.869378265422, 5301.284326615858, 6061.909071363845, 6150.677604315094, 6169.198004259418, 4568.634509239187, 5878.823635290948, 6199.845003874939, 6210.378962103934, 6252.0, 5130.743462826769, 5972.492338151305, 6114.814446323713, 6178.104174894705, 6180.505559555135], "value": 5700.678090162798, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.5584381197889, 540.2214719146224, 551.0962022283455, 593.6022864680664, 645.3062957320881, 37104.25791484172, 38065.04837379067, 38069.23861522768, 38116.618833811655, 38135.42796858046, 29070.418591628153, 38469.61530384696, 38877.41683874744, 39190.0, 39196.412053819215, 7181.497295189339, 9422.670206542773, 9529.285303602222, 9567.425954442755, 9605.183559397425, 9446.85829712555, 9517.904820951771, 9570.47362395068, 9585.80828383432, 9618.615255389775, 9554.856677149848, 9605.18355939746, 9667.75830604237, 9672.322937394385, 9705.029497050275, 9530.809383812355, 9546.427214367126, 9596.088371604686, 9626.181774549172, 9660.565274562661, 9378.718638440858, 9422.387544809566, 9463.0, 9588.376755510939, 9590.0, 31384.686153138406, 38205.85382438531, 38468.038299042746, 38526.80736596299, 38532.22935541273, 3086.672730725787, 3216.2763378239943, 3258.185453636591, 3380.256343604403, 3490.0053484756722, 27546.586801198, 27629.30926726848, 27807.860960695067, 28383.716162838522, 28638.284042898886, 2711.810173287871, 2716.334498047971, 2729.353233830846, 2738.5070687276284, 2923.8684259208385, 648929.5107048916, 650702.0, 660672.0, 667667.0, 670267.0, 66912.33087669061, 66930.0, 67515.98726019113, 67754.66122669356, 67859.32140678629, 61493.69253153795, 72677.6366118166, 74159.0, 74350.0, 74382.0, 16877.15614219284, 17097.743533847002, 17118.315267389415, 17144.39994600183, 17156.742648860276, 12517.374131293582, 12833.230006199658, 12874.935625321814, 12953.481860725466, 12967.481300748053, 20719.756814591172, 20808.647437916487, 20976.580468390854, 21035.317174625994, 21349.57300853974, 7755.2632499912415, 7862.253085956825, 9028.277737780962, 9300.53497325131, 9304.0, 903.3270213690843, 960.519740129935, 973.6689525561343, 1065.046783129095, 1135.8012347839094, 23242.7675723244, 23263.53472930532, 29245.561316580268, 29362.706372936424, 29963.700362996526, 1059.5814653212092, 1095.118429664128, 1104.7569534702352, 1180.5690922813112, 1205.9155859089956, 14772.892033097562, 14867.628309292355, 14937.402503899722, 15011.924940375227, 15375.000624959343, 596698.0, 610254.0, 620150.0, 625101.0, 626279.0, 56815.0, 56896.715516422155, 57622.0, 57622.42377576171, 57654.711726441936, 1453.9200343981183, 1475.57606909333, 1507.8416766239825, 1516.2721893491187, 1517.9316930738144, 23325.833708314178, 28610.284742881595, 29041.0, 29112.854435727684, 29566.556501652063, 48589.02821943612, 48804.51195488, 49170.508294916595, 49285.0, 49324.0, 560610.0, 560890.0, 561125.0, 562233.0, 570746.0, 26855.731442685323, 27266.454670906074, 27284.181474555797, 40995.0, 42351.36472952847, 40669.18661626692, 41065.178696426505, 41590.0, 41801.16397671969, 42299.0, 35922.8203858979, 38171.42742858804, 38232.42651360288, 38649.6135038646, 38824.0, 35800.64199357973, 36644.81677591595, 37159.81420092882, 37230.51077956851, 38711.806440967615, 34950.12624684403, 37811.432828507044, 38654.0, 39139.804300978314, 39540.2091958165, 28562.714372856004, 30287.394252115275, 31017.91437299684, 31147.688523114477, 31281.217969550034, 21290.36128916135, 22870.199543015915, 23557.411064723517, 24194.51610967806, 24393.634095488225], "value": 20013.760742216462, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.32324260662125, 390.84561598168716, 392.8546437818008, 399.8900302416835, 406.06199678742087, 18255.908720456413, 19456.0, 19820.99999999998, 20243.797562024374, 20354.389368318956, 19797.604047919034, 20279.290224842134, 20610.0, 21165.365039048815, 21229.787702123012, 5196.8700782480555, 5696.629719068268, 5916.408359164071, 5946.0, 5948.643081415129, 5907.852303692399, 5943.4056594340655, 5952.166696662471, 5955.791547295846, 5970.522358211333, 5356.54469370102, 5732.856678583027, 5733.140028995643, 5743.138529220609, 5890.087036509348, 4665.603423708989, 5274.551663108621, 5613.326400831886, 6489.772857949949, 6512.902306465359, 5187.792488300463, 5706.229658996024, 5733.426657334275, 5747.59766816323, 5768.97115514424, 12629.328560419674, 12971.935140324238, 13391.196528208338, 13435.865641343558, 13450.923926085987, 2058.289889987952, 2113.7146485224453, 2212.7565967743535, 2485.2420011896365, 2498.2380373985925, 9528.714138575853, 9973.650922217688, 10430.0, 10904.0, 15064.774028389584, 1670.5072003758921, 1693.1618848669864, 1711.4437807712418, 1734.7397890316427, 1764.7617571627795, 111719.0, 117005.0, 117043.4147829264, 117530.0, 118667.406662967, 11556.711082222844, 11638.1271404645, 11680.123990700731, 11692.141593274198, 11876.218567214813, 14949.327280272413, 14959.476418325525, 14987.0, 15013.399464021317, 15037.0, 8471.95764021176, 8673.306135509145, 8700.912990870136, 8803.955980220058, 8818.559072046372, 8519.914800851911, 8573.614187361583, 8598.742037738877, 8613.483191008434, 8680.913190868137, 4556.681032327771, 4623.144718227139, 4643.976780116145, 4670.673052886334, 4690.0, 1943.0381960929149, 1999.640064788323, 2003.1486618187503, 2017.404865564662, 2043.2439997200834, 941.275218082073, 959.7312752429331, 980.0346658541331, 991.2961797123978, 1003.9201639703125, 20223.696644550342, 20241.696374554394, 20349.880756558236, 20606.690899636516, 20737.688934665992, 974.8976357482362, 983.1446641421866, 996.8803743550675, 1035.6892932120334, 1037.6523864505475, 10348.172146228284, 10493.422861742525, 10565.101966332948, 10567.101796347242, 10760.461976901124, 476034.0, 586974.0, 604319.0, 611613.0, 612007.0, 126033.0, 128135.0, 129331.47339843061, 131453.0, 134553.0, 888.9466632001971, 991.2317953586029, 998.801438274074, 1019.1744686803713, 1021.3514418344405, 13206.537771177962, 15428.382864685287, 17823.287068517115, 17849.929004259786, 18115.81884181141, 36265.27469450649, 40178.799106004284, 42188.78905605452, 51294.717632059495, 51516.0, 53568.19647705209, 66303.0, 72443.0, 73922.0, 74448.0, 7802.339403262261, 8011.469050429913, 8053.110977494366, 8183.058948221031, 8217.917820821714, 8828.646854125764, 10579.682609521727, 10585.788284234426, 12286.877131228573, 12844.678883027998, 9240.861387079334, 9241.0, 10914.563417463212, 11035.0, 11064.662191683026, 10595.841062384225, 10814.783704326026, 10841.728956776144, 10853.620123295646, 11164.385958772345, 10779.892201078203, 11275.816039315754, 11448.713782155513, 11453.541858325574, 11455.770884582429, 8000.239977202156, 8037.7588672339925, 8179.877301840358, 8214.58927053633, 8383.832323353621, 8134.75595732129, 9987.950060249652, 10995.725106872393, 10999.560017599206, 11353.978141967262], "value": 9242.673005771532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1623.0586259969216, 1655.0483472003598, 1918.5779128591714, 1963.9607207855843, 1967.8720883142585, 8074.91925080749, 8587.14128587141, 8679.47923124613, 8944.329175311845, 8969.103089691036, 8580.0, 8659.523726195057, 8745.562721863913, 8745.825083498343, 8836.983746869111, 2262.558801033799, 2287.2452090809993, 2289.301762962296, 2291.175176936302, 2295.8737269450176, 2170.6092903277404, 2404.6272827711646, 2427.1383658801137, 2448.742881997391, 2475.282168171228, 2434.3427274635837, 2446.0704932125855, 2446.425090103833, 2446.8409553378974, 2468.2101727447225, 2081.4588207066195, 2410.80713542917, 2411.6623672685837, 2447.816413768957, 2463.187148241094, 2429.0648100481444, 2429.10123254397, 2442.3771938155833, 2447.2046584859813, 2448.2532827487607, 7684.692612295557, 8813.515256660881, 8870.73387798367, 8892.932848058274, 8893.155150260714, 5246.632735708502, 5459.07195776715, 5465.562754979592, 5483.314585676791, 5501.587380946405, 3610.151614370621, 3618.3667858124722, 3618.819059047037, 3639.5814481334455, 3658.707303415747, 945.4516380499294, 1052.6210564196883, 1054.5149231353587, 1068.6633710381284, 1073.9570417183304, 11714.648560543197, 11798.0, 11814.88185118155, 11866.881331186663, 11870.88129118715, 4642.651801114863, 4688.71867687933, 4840.249761287007, 4902.632302577321, 4903.656744027955, 9939.552720127467, 10001.79996400068, 10006.599736010623, 10007.799844003224, 10060.24548158891, 5064.82273120439, 5163.941392014628, 5388.407275199725, 5422.7017514036315, 5464.836054918359, 4435.401220835211, 4811.374521312207, 4954.256861470736, 4955.776990035457, 4979.053979743837, 4062.268791617478, 4070.7354021988476, 4074.2230813765364, 4080.489938757655, 4115.0741083256025, 1261.3756190685485, 1326.6418067121824, 1351.7228968061524, 1377.0704774277324, 1386.1752257406827, 818.8976377952756, 860.0, 916.134253130785, 920.8572671235969, 941.9529023548795, 5107.463716309734, 5796.246487956539, 5883.470487656132, 5954.732037058343, 5987.700614969234, 432.9870103896888, 435.92589259825905, 445.2097526889732, 454.78170478170665, 454.9818007279672, 3890.1636148228267, 3926.1755031443718, 3986.621270979252, 4019.658329042006, 4063.79681015948, 9925.30522863407, 10455.84316235242, 10504.789904201873, 10753.83869241962, 10997.61508347204, 10775.515101820436, 10877.0, 10914.23600347968, 10921.344719316867, 10940.726481838017, 8058.637361318754, 8169.754907352789, 8312.085670576233, 8313.83372332562, 8344.41589088758, 5777.884442311214, 5794.1308803679785, 5875.118732190205, 5884.176215329771, 5896.056630939029, 9770.462624555717, 9922.652707155215, 10011.899881001096, 10031.398116113056, 10049.949750251495, 9838.950805246215, 10027.949860250945, 10262.384256944608, 10319.94840025795, 10380.740481488023, 6884.896726549206, 7252.746153884589, 7523.510971786816, 7526.360259378014, 7603.505772124794, 8356.164383561596, 8370.916290837258, 8456.069832318317, 8458.788530286793, 8473.872891906749, 7267.200607933229, 7376.631168441664, 7384.224656411215, 7530.472866899265, 7547.698092076255, 7250.818729531804, 7408.777736667908, 7427.591482468516, 7432.814179645336, 7512.286332798375, 5844.883102337844, 5873.5594830388745, 6860.03959445668, 6950.582965022115, 6962.268961759145, 4809.95190048109, 4863.270509423614, 4928.8767780805765, 4953.900921981613, 5081.136206844772, 4819.783109759999, 4890.975545122394, 4952.752362381939, 5009.624278179224, 5177.948220517897], "value": 4527.752644280822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.7162837162837, 311.282493851672, 329.2427416941036, 330.7271501011666, 331.1010606204155, 5178.870528236796, 5230.372355317362, 6159.8768024639485, 6161.537884658652, 6287.842803929899, 5658.349289831671, 6205.658688772116, 6277.874442511158, 6278.9372106278925, 6343.714532846021, 4659.510751371108, 4660.440747110351, 4668.883277918046, 4682.859514214579, 4687.460941991663, 3956.9208615827665, 4516.616087632555, 4614.284785858197, 4690.671652984292, 4700.623950083985, 3951.68386529077, 4500.639948804104, 4604.562566556188, 4611.377464042345, 4615.192341340269, 3859.2860320840455, 4079.776067179849, 4125.009997600584, 4272.893177670552, 4477.507474177871, 3509.7016753575977, 3697.500837386945, 3714.2014466889477, 3727.366347720894, 4020.7386519876113, 5931.911021334683, 5955.493783028448, 5962.582619216657, 5979.701014949279, 5989.191459153002, 4669.579737823612, 5459.153831156177, 5474.39781624021, 5492.642978206404, 5509.504144626962, 5573.944260557383, 5652.773889044433, 6366.745330186787, 6633.734650613969, 6706.899396509057, 3885.911944655473, 4442.644588432918, 4490.046829629122, 4494.4606647202545, 4500.549945005473, 5816.272965879265, 6480.125183100268, 6670.566413183176, 6843.7604683835825, 6971.233164351917, 4461.263891457873, 4497.785597888552, 4515.480719717209, 4531.116432295737, 4533.9319910201375, 4094.2630326541507, 4418.138462999685, 4586.88532786683, 4615.9076818463445, 4622.4684161321875, 4789.281607758794, 5012.273220383024, 5433.809816656398, 5438.782448702087, 5456.454354564512, 5221.55616772571, 6319.210098737658, 6502.382273683992, 6677.0, 6728.596284222962, 1256.2211428914131, 1378.8896888248917, 1419.864108713046, 1528.533797191845, 1548.4580396861008, 971.6404930175739, 991.3308516751164, 1002.1381611813835, 1006.2453160129902, 1006.642641862143, 5455.754491047913, 5943.900378430004, 6186.505079593621, 6203.7828675996125, 6249.750009999549, 6872.728545219151, 6888.41448476875, 6899.517033807585, 6925.688344024531, 6951.2353641099435, 5458.099413596712, 5938.970305148447, 6195.81412557624, 6218.284897236786, 6218.689065546704, 3334.966160490256, 3363.789035947057, 3443.9164305594754, 3592.497050412944, 3640.4357324614725, 6005.327629204962, 6066.514678825683, 6298.275698294755, 7118.786436406916, 7202.783916482514, 6811.421029212573, 7055.343473307592, 7087.681054352566, 7101.325374089453, 7116.359527642537, 6891.069705589782, 7151.747199632099, 7178.784636460915, 7184.533005354635, 7204.3155900189395, 5523.7238138093735, 5740.0, 6874.896876546756, 6900.135923882642, 6927.718372101177, 6425.228972523327, 6700.195976482853, 6732.427743641845, 6791.796246112624, 6811.250762416229, 7147.321004504772, 7176.677049532888, 7183.389411900047, 7197.820054498679, 7198.74804381865, 4410.6030457259, 4417.757023363746, 4422.889427764331, 4423.491298500714, 4428.446444194476, 6565.048068030204, 6647.169103862017, 6796.150481189851, 6850.314968503109, 6870.931290687029, 6304.401081897213, 6326.493880489642, 6433.908979581748, 6725.495587830835, 6727.0, 6036.547258955508, 6234.721882014267, 6695.163104611924, 6727.26000139994, 6767.988245231022, 5136.897262054813, 5846.853828654318, 6444.871102578016, 6529.542931994714, 6603.504737144637, 6513.1532900722605, 6656.5340426169705, 6704.229013663491, 6725.9663701681175, 6736.6968486417245, 5780.421957804186, 6266.310705822447, 6535.117759102461, 6589.0, 6606.141201643755], "value": 4760.277982259589, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.432899048837, 715.9679698539804, 724.1816747075806, 724.7244849065643, 760.5170716594961, 10768.192385571074, 15095.773563396559, 15124.395024199019, 15162.545123646294, 16596.246241746838, 12582.496700132007, 15219.619509512268, 16053.518394448156, 16136.112513811735, 16177.272022758974, 817.4604760857835, 856.5246288309985, 870.634333579898, 893.1693525021727, 902.801383695586, 709.5600727548926, 890.9376343655947, 903.453410686535, 923.0907556057278, 925.2413021322518, 940.2900809888558, 963.9325247232697, 967.5936106835146, 973.537569654412, 973.7468258252834, 952.4570994533119, 952.8189643967659, 954.0078318548701, 954.885413750351, 955.2310390135938, 685.6537448588481, 686.1560280854527, 690.002945743401, 690.5856486108345, 718.992810071903, 15029.323680434407, 15060.397584096623, 15296.923515382463, 15331.926765126445, 15574.844251557453, 12638.241705497607, 12665.683357916127, 12682.429290681941, 12695.93652031734, 12789.61631151067, 10152.187824974058, 10168.94915525425, 10357.067863892285, 10394.946279347349, 10617.787644247072, 3458.4120699480895, 3463.3073385323037, 3472.409690352646, 3502.7898326100517, 3579.2304654499408, 79835.8024629631, 79963.80054299248, 80390.5980470094, 80569.0, 83040.16959830385, 9170.724878253663, 9279.304052196112, 9321.114494123047, 9377.671781487616, 9421.293402994803, 21166.0, 21430.678539821914, 21432.357029289145, 21445.78554214438, 21463.89268053681, 7471.887921681179, 7535.54786712799, 7549.0941087069905, 7579.052618422697, 7809.765707028798, 4116.794160292034, 4168.8332466701595, 4177.561356057631, 4185.100203456272, 4287.249731297011, 3590.1563132663805, 3690.686291665185, 3691.0, 3709.221063576679, 3899.7855117968784, 698.8532408194235, 705.6119134476018, 706.198464742521, 713.454207531239, 717.2074857282731, 526.242211215848, 562.1736048009419, 567.5743192605546, 573.52970564137, 583.5302581421996, 7667.386609071261, 7707.306342429209, 7774.844503109906, 7890.605469726491, 8239.711610093738, 569.5557465177169, 575.0, 589.5578316262803, 595.2529575382953, 595.264847912836, 3765.3034188675183, 3795.3927371620407, 3821.5032045833864, 3940.0, 3996.162724465604, 96471.51764241135, 99399.50900736495, 99848.0, 100107.49838752425, 101603.0, 87922.0, 88408.11591884127, 88751.0, 88887.11112888789, 89349.55325223332, 74389.0, 74842.62578687181, 76293.0, 76312.61843690857, 77054.22945770582, 6424.357564243538, 7526.0, 7587.734429294948, 7629.618519073913, 7722.884156737766, 39961.20271580962, 44990.0, 45180.548194518946, 45235.54764452313, 46586.0, 55532.444675552724, 56646.43353566412, 58664.413355867604, 58869.23392298238, 59953.10070348861, 10858.07706344938, 10870.510827012646, 10937.905172242115, 11204.943975280397, 11347.886521134684, 12037.45831437605, 12367.381630918599, 12470.064745143969, 12796.36018199105, 13313.33433328349, 9681.70954871355, 10523.526441310007, 11500.769984600429, 11962.521499139937, 12050.156489046034, 9416.300653854594, 10185.439800811026, 11514.712132196762, 11737.591489021372, 11906.166568340133, 9489.545079071171, 11210.66368008961, 11248.606298779503, 11407.714807129889, 11472.942635287103, 9300.571610034996, 9457.858132127885, 9550.235981121632, 10070.345427547187, 10590.947045264724, 9597.856032159383, 9723.677513995783, 9999.400035997864, 10022.749431264278, 10052.849207262043], "value": 6909.095807781764, "unit": "score"}], "name": "dromaeo_css", "value": 7345.22083784051, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 112.0, 117.0, 117.0, 116.0, 126.0, 116.0, 113.0, 121.0, 171.0], "value": 123.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 146.0, 163.0, 123.0, 144.0, 124.0, 162.0, 161.0, 116.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 216.0, 215.0, 202.0, 196.0, 199.0, 199.0, 196.0, 198.0, 197.0], "value": 201.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 79.0, 77.0, 145.0, 57.0, 57.0, 55.0, 62.0, 132.0, 56.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 132.0, 79.0, 77.0, 82.0, 124.0, 101.0, 87.0, 119.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 101.0, 126.0, 90.0, 103.0, 132.0, 110.0, 88.0, 86.0], "value": 101.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 105.0, 140.0, 95.0, 95.0], "value": 100.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 92.0, 89.0, 91.0, 91.0, 89.0, 90.0, 92.0, 90.0, 97.0], "value": 90.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 62.0, 63.0, 62.0, 78.0, 63.0, 61.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 66.0, 83.0, 95.0, 95.0, 95.0, 68.0, 68.0, 66.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 85.0, 82.0, 85.0, 84.0, 84.0, 86.0, 85.0, 80.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 141.0, 155.0, 127.0, 135.0, 158.0, 127.0, 147.0, 166.0, 163.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 190.0, 176.0, 190.0, 215.0, 157.0, 219.0, 161.0, 220.0, 153.0], "value": 189.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 62.0, 81.0, 96.0, 91.0, 77.0, 61.0, 100.0], "value": 77.3, "unit": "score"}], "name": "kraken", "value": 1569.0999999999997, "alertThreshold": 2.0}]} 01:31:48 INFO - Return code: 0 01:31:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:31:48 ERROR - # TBPL SUCCESS # 01:31:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:31:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:31:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:31:48 INFO - 2016-04-20 01:31:48.924 screenresolution[1964:16081] starting screenresolution argv=screenresolution get 01:31:48 INFO - 2016-04-20 01:31:48.926 screenresolution[1964:16081] Display 0: 1600x1200x32@60 01:31:48 INFO - 2016-04-20 01:31:48.932 screenresolution[1965:16084] starting screenresolution argv=screenresolution list 01:31:48 INFO - Available Modes on Display 0 01:31:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:31:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:31:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:31:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:31:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:31:49 INFO - Intel Iris: 01:31:49 INFO - Chipset Model: Intel Iris 01:31:49 INFO - Type: GPU 01:31:49 INFO - Bus: Built-In 01:31:49 INFO - VRAM (Dynamic, Max): 1536 MB 01:31:49 INFO - Vendor: Intel (0x8086) 01:31:49 INFO - Device ID: 0x0a2e 01:31:49 INFO - Revision ID: 0x0009 01:31:49 INFO - Displays: 01:31:49 INFO - Display: 01:31:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:31:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:31:49 INFO - Display Serial Number: 1600x1200 60 01:31:49 INFO - Main Display: Yes 01:31:49 INFO - Mirror: Off 01:31:49 INFO - Online: Yes 01:31:49 INFO - Rotation: Supported 01:31:49 INFO - Return code: 0 01:31:49 INFO - Running post-action listener: _resource_record_post_action 01:31:49 INFO - Running post-run listener: _resource_record_post_run 01:31:50 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 1437696; Write bytes: 695308800; Read time: 12; Write time: 2159 01:31:50 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395188736; Write bytes: 396305920; Read time: 29905; Write time: 761 01:31:50 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 1433600; Write bytes: 298155008; Read time: 12; Write time: 1396 01:31:50 INFO - Running post-run listener: _upload_blobber_files 01:31:50 INFO - Blob upload gear active. 01:31:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:31:50 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 01:31:50 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'] 01:31:50 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 01:31:50 INFO - (blobuploader) - INFO - Open directory for files ... 01:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:31:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:31:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:31:51 INFO - (blobuploader) - INFO - Done attempting. 01:31:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:31:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:31:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:31:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:31:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:31:52 INFO - (blobuploader) - INFO - Done attempting. 01:31:52 INFO - (blobuploader) - INFO - Iteration through files over. 01:31:52 INFO - Return code: 0 01:31:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:31:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:31:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21cc5d2b329fdf6e9d90833d78c377b1f8b86b4f248ab5e0c42501e70cda565279e4c3c3c5d6d926a413cec1b36c0242cb9d3c9e8b03b558dcd246ac737e8a37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2dce35436bb9ad6523d4ffe1cfc10934417fec776998d863b3de80df1b72575e777e0a9510408d3abdddabc4d5e4f6f0bb791cb47c7c33a43dfad4725d620989"} 01:31:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:31:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:31:52 INFO - Contents: 01:31:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21cc5d2b329fdf6e9d90833d78c377b1f8b86b4f248ab5e0c42501e70cda565279e4c3c3c5d6d926a413cec1b36c0242cb9d3c9e8b03b558dcd246ac737e8a37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2dce35436bb9ad6523d4ffe1cfc10934417fec776998d863b3de80df1b72575e777e0a9510408d3abdddabc4d5e4f6f0bb791cb47c7c33a43dfad4725d620989"} 01:31:52 INFO - Running post-run listener: copy_logs_to_upload_dir 01:31:52 INFO - Copying logs to upload dir... 01:31:52 INFO - mkdir: /builds/slave/test/build/upload/logs 01:31:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.944966 ========= master_lag: 4.67 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-20 01:31:57.190823) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 01:31:57.192008) ========= 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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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/21cc5d2b329fdf6e9d90833d78c377b1f8b86b4f248ab5e0c42501e70cda565279e4c3c3c5d6d926a413cec1b36c0242cb9d3c9e8b03b558dcd246ac737e8a37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2dce35436bb9ad6523d4ffe1cfc10934417fec776998d863b3de80df1b72575e777e0a9510408d3abdddabc4d5e4f6f0bb791cb47c7c33a43dfad4725d620989"} build_url:https://queue.taskcluster.net/v1/task/JdNX3Gn6R064WjbdDhtLWQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011496 build_url: 'https://queue.taskcluster.net/v1/task/JdNX3Gn6R064WjbdDhtLWQ/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/21cc5d2b329fdf6e9d90833d78c377b1f8b86b4f248ab5e0c42501e70cda565279e4c3c3c5d6d926a413cec1b36c0242cb9d3c9e8b03b558dcd246ac737e8a37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2dce35436bb9ad6523d4ffe1cfc10934417fec776998d863b3de80df1b72575e777e0a9510408d3abdddabc4d5e4f6f0bb791cb47c7c33a43dfad4725d620989"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 01:31:57.235846) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 01:31:57.236170) ========= 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.qPVAFpCFpf/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.3rrHmUFr8M/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005121 ========= master_lag: 0.18 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 01:31:57.421122) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 01:31:57.421430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 01:31:57.423126) ========= ========= Total master_lag: 12.44 =========