builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0059 starttime: 1466497590.28 results: success (0) buildid: 20160621000402 builduid: 78563c1f72ab4879add13462fea88926 revision: 634aedddd904cf6b9004590dbc2f5491fe4474ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:30.279087) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:30.279864) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:30.280366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:30.304608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:30.305118) ========= 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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-21 01:26:30-- 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% 148M=0s 2016-06-21 01:26:30 (148 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141805 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:30.471093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:30.471467) ========= 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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.027429 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:30.520978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 01:26:30.521368) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 634aedddd904cf6b9004590dbc2f5491fe4474ff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 634aedddd904cf6b9004590dbc2f5491fe4474ff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4ub3lQvKz4/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.VGISE3B2Q5/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-21 01:26:30,597 truncating revision to first 12 chars 2016-06-21 01:26:30,597 Setting DEBUG logging. 2016-06-21 01:26:30,597 attempt 1/10 2016-06-21 01:26:30,598 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/634aedddd904?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 01:26:31,624 unpacking tar archive at: mozilla-beta-634aedddd904/testing/mozharness/ program finished with exit code 0 elapsedTime=1.282365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 01:26:31.825419) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:31.825843) ========= script_repo_revision: 634aedddd904cf6b9004590dbc2f5491fe4474ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:31.826314) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:31.826622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 01:26:31.845885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-21 01:26:31.846604) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4ub3lQvKz4/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.VGISE3B2Q5/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:26:32 INFO - MultiFileLogger online at 20160621 01:26:32 in /builds/slave/test 01:26:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:26:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:26:32 INFO - {'append_to_log': False, 01:26:32 INFO - 'base_work_dir': '/builds/slave/test', 01:26:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:26:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:26:32 INFO - 'branch': 'Mozilla-Beta', 01:26:32 INFO - 'buildbot_json_path': 'buildprops.json', 01:26:32 INFO - 'config_files': ('talos/mac_config.py',), 01:26:32 INFO - 'default_actions': ('clobber', 01:26:32 INFO - 'read-buildbot-config', 01:26:32 INFO - 'download-and-extract', 01:26:32 INFO - 'populate-webroot', 01:26:32 INFO - 'create-virtualenv', 01:26:32 INFO - 'install', 01:26:32 INFO - 'run-tests'), 01:26:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:26:32 INFO - 'download_minidump_stackwalk': True, 01:26:32 INFO - 'download_symbols': 'ondemand', 01:26:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:26:32 INFO - 'tooltool.py': '/tools/tooltool.py', 01:26:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:26:32 INFO - '/tools/misc-python/virtualenv.py')}, 01:26:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:26:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:26:32 INFO - 'installer_path': 'installer.exe', 01:26:32 INFO - 'log_level': 'info', 01:26:32 INFO - 'log_name': 'talos', 01:26:32 INFO - 'log_to_console': True, 01:26:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:26:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:26:32 INFO - 'opt_config_files': (), 01:26:32 INFO - 'pip_index': False, 01:26:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:26:32 INFO - 'cmd': ('bash', 01:26:32 INFO - '-c', 01:26:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:26:32 INFO - 'enabled': True, 01:26:32 INFO - 'halt_on_failure': False, 01:26:32 INFO - 'name': 'check_screen_resolution'},), 01:26:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:26:32 INFO - 'cmd': ('bash', 01:26:32 INFO - '-c', 01:26:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:26:32 INFO - 'enabled': True, 01:26:32 INFO - 'halt_on_failure': False, 01:26:32 INFO - 'name': 'check_screen_resolution'},), 01:26:32 INFO - 'run_cmd_checks_enabled': True, 01:26:32 INFO - 'sps_profile': False, 01:26:32 INFO - 'sps_profile_interval': 0, 01:26:32 INFO - 'suite': 'dromaeojs-e10s', 01:26:32 INFO - 'system_bits': '32', 01:26:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:26:32 INFO - 'title': 't-yosemite-r7-0059', 01:26:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:26:32 INFO - 'use_talos_json': True, 01:26:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:26:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:26:32 INFO - 'work_dir': 'build'} 01:26:32 INFO - ##### 01:26:32 INFO - ##### Running clobber step. 01:26:32 INFO - ##### 01:26:32 INFO - Running pre-action listener: _resource_record_pre_action 01:26:32 INFO - Running main action method: clobber 01:26:32 INFO - rmtree: /builds/slave/test/build 01:26:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:26:33 INFO - Running post-action listener: _resource_record_post_action 01:26:33 INFO - ##### 01:26:33 INFO - ##### Running read-buildbot-config step. 01:26:33 INFO - ##### 01:26:33 INFO - Running pre-action listener: _resource_record_pre_action 01:26:33 INFO - Running main action method: read_buildbot_config 01:26:33 INFO - Using buildbot properties: 01:26:33 INFO - { 01:26:33 INFO - "project": "", 01:26:33 INFO - "product": "firefox", 01:26:33 INFO - "script_repo_revision": "production", 01:26:33 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 01:26:33 INFO - "repository": "", 01:26:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 01:26:33 INFO - "buildid": "20160621000402", 01:26:33 INFO - "pgo_build": "False", 01:26:33 INFO - "basedir": "/builds/slave/test", 01:26:33 INFO - "buildnumber": 7, 01:26:33 INFO - "slavename": "t-yosemite-r7-0059", 01:26:33 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:26:33 INFO - "platform": "yosemite_r7", 01:26:33 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:26:33 INFO - "branch": "mozilla-beta", 01:26:33 INFO - "repo_path": "releases/mozilla-beta", 01:26:33 INFO - "revision": "634aedddd904cf6b9004590dbc2f5491fe4474ff", 01:26:33 INFO - "stage_platform": "macosx64", 01:26:33 INFO - "builduid": "78563c1f72ab4879add13462fea88926", 01:26:33 INFO - "slavebuilddir": "test" 01:26:33 INFO - } 01:26:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 01:26:33 INFO - Running post-action listener: _resource_record_post_action 01:26:33 INFO - ##### 01:26:33 INFO - ##### Running download-and-extract step. 01:26:33 INFO - ##### 01:26:33 INFO - Running pre-action listener: _resource_record_pre_action 01:26:33 INFO - Running main action method: download_and_extract 01:26:33 INFO - mkdir: /builds/slave/test/build/tests 01:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:33 INFO - https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:26:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:26:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:26:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:26:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 01:26:35 INFO - Downloaded 1165 bytes. 01:26:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:26:35 INFO - Using the following test package requirements: 01:26:35 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:26:35 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:35 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 01:26:35 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:35 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 01:26:35 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:26:35 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:35 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 01:26:35 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:26:35 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:35 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 01:26:35 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:35 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 01:26:35 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:35 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 01:26:35 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:26:35 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 01:26:35 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 01:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:26:35 INFO - https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:26:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:26:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:26:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:26:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:26:36 INFO - Downloaded 18300395 bytes. 01:26:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:26:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:26:39 INFO - Return code: 0 01:26:39 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 01:26:39 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:26:39 INFO - https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:26:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:26:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:26:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:26:41 INFO - Downloaded 18300395 bytes. 01:26:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:26:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:26:44 INFO - Return code: 0 01:26:44 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:26:44 INFO - https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 01:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 01:26:46 INFO - Downloaded 10840145 bytes. 01:26:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:26:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:26:46 INFO - Return code: 0 01:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:46 INFO - https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 01:26:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:26:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:26:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 01:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 01:26:49 INFO - Downloaded 86251417 bytes. 01:26:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:26:49 INFO - mkdir: /builds/slave/test/properties 01:26:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:26:49 INFO - Writing to file /builds/slave/test/properties/build_url 01:26:49 INFO - Contents: 01:26:49 INFO - build_url:https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:26:50 INFO - Running post-action listener: _resource_record_post_action 01:26:50 INFO - Running post-action listener: set_extra_try_arguments 01:26:50 INFO - ##### 01:26:50 INFO - ##### Running populate-webroot step. 01:26:50 INFO - ##### 01:26:50 INFO - Running pre-action listener: _resource_record_pre_action 01:26:50 INFO - Running main action method: populate_webroot 01:26:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:26:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:26:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:26:50 INFO - '--tppagecycles', 01:26:50 INFO - '7'], 01:26:50 INFO - 'tests': ['tsvgm']}}, 01:26:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:26:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:26:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:26:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:26:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['damp', 'tps']}, 01:26:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'tests': ['damp', 'tps']}, 01:26:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['dromaeo_dom']}, 01:26:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:26:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'other-e10s': {'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['a11yr', 01:26:50 INFO - 'ts_paint', 01:26:50 INFO - 'tpaint', 01:26:50 INFO - 'sessionrestore', 01:26:50 INFO - 'sessionrestore_no_auto_restore', 01:26:50 INFO - 'tabpaint']}, 01:26:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['tsvgx', 01:26:50 INFO - 'tsvgr_opacity', 01:26:50 INFO - 'tart', 01:26:50 INFO - 'tscrollx', 01:26:50 INFO - 'cart']}, 01:26:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:26:50 INFO - 'tsvgr_opacity', 01:26:50 INFO - 'tart', 01:26:50 INFO - 'tscrollx', 01:26:50 INFO - 'cart']}, 01:26:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'talos_options': ['--disable-e10s'], 01:26:50 INFO - 'tests': ['tp5o']}, 01:26:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'tests': ['tp5o']}, 01:26:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'talos_options': ['--disable-e10s', 01:26:50 INFO - '--xperf_path', 01:26:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:50 INFO - 'tests': ['tp5n']}, 01:26:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:50 INFO - 'talos_options': ['--xperf_path', 01:26:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:50 INFO - 'tests': ['tp5n']}}, 01:26:50 INFO - 'talos.zip': {'path': '', 01:26:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:26:50 INFO - Running post-action listener: _resource_record_post_action 01:26:50 INFO - ##### 01:26:50 INFO - ##### Running create-virtualenv step. 01:26:50 INFO - ##### 01:26:50 INFO - Running pre-action listener: _resource_record_pre_action 01:26:50 INFO - Running main action method: create_virtualenv 01:26:50 INFO - Creating virtualenv /builds/slave/test/build/venv 01:26:50 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:26:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:26:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:26:50 INFO - Using real prefix '/tools/python27' 01:26:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:26:51 INFO - Installing distribute.............................................................................................................................................................................................done. 01:26:54 INFO - Installing pip.................done. 01:26:54 INFO - Return code: 0 01:26:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a73a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a83420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81784901f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100912e00>, '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 0x10077bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090db20>, '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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ub3lQvKz4/Render', 01:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:54 INFO - 'HOME': '/Users/cltbld', 01:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:54 INFO - 'LOGNAME': 'cltbld', 01:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:54 INFO - 'MOZ_NO_REMOTE': '1', 01:26:54 INFO - 'NO_EM_RESTART': '1', 01:26:54 INFO - 'PAGER': '/bin/cat', 01:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:54 INFO - 'PWD': '/builds/slave/test', 01:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:54 INFO - 'SHELL': '/bin/bash', 01:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGISE3B2Q5/Listeners', 01:26:54 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 01:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:54 INFO - 'USER': 'cltbld', 01:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:54 INFO - 'XPC_FLAGS': '0x0', 01:26:54 INFO - 'XPC_SERVICE_NAME': '0', 01:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:54 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:26:54 INFO - Cleaning up... 01:26:54 INFO - Return code: 0 01:26:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a73a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a83420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81784901f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100912e00>, '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 0x10077bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090db20>, '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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ub3lQvKz4/Render', 01:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:54 INFO - 'HOME': '/Users/cltbld', 01:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:54 INFO - 'LOGNAME': 'cltbld', 01:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:54 INFO - 'MOZ_NO_REMOTE': '1', 01:26:54 INFO - 'NO_EM_RESTART': '1', 01:26:54 INFO - 'PAGER': '/bin/cat', 01:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:54 INFO - 'PWD': '/builds/slave/test', 01:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:54 INFO - 'SHELL': '/bin/bash', 01:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGISE3B2Q5/Listeners', 01:26:54 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 01:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:54 INFO - 'USER': 'cltbld', 01:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:54 INFO - 'XPC_FLAGS': '0x0', 01:26:54 INFO - 'XPC_SERVICE_NAME': '0', 01:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:54 INFO - Downloading/unpacking psutil>=0.7.1 01:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:26:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:57 INFO - Installing collected packages: psutil 01:26:57 INFO - Running setup.py install for psutil 01:26:57 INFO - building 'psutil._psutil_osx' extension 01:26:57 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:26:58 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:26:58 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:26:58 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:26:58 INFO - building 'psutil._psutil_posix' extension 01:26:58 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:26:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:26:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:26:58 INFO - ^ 01:26:58 INFO - 1 warning generated. 01:26:58 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:26:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:58 INFO - Successfully installed psutil 01:26:58 INFO - Cleaning up... 01:26:58 INFO - Return code: 0 01:26:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:58 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 0x100a73a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a83420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81784901f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100912e00>, '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 0x10077bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090db20>, '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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:26:58 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:26:58 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:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ub3lQvKz4/Render', 01:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:26:58 INFO - 'HOME': '/Users/cltbld', 01:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:26:58 INFO - 'LOGNAME': 'cltbld', 01:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:58 INFO - 'MOZ_NO_REMOTE': '1', 01:26:58 INFO - 'NO_EM_RESTART': '1', 01:26:58 INFO - 'PAGER': '/bin/cat', 01:26:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:58 INFO - 'PWD': '/builds/slave/test', 01:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:26:58 INFO - 'SHELL': '/bin/bash', 01:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGISE3B2Q5/Listeners', 01:26:58 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 01:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:26:58 INFO - 'USER': 'cltbld', 01:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:58 INFO - 'XPC_FLAGS': '0x0', 01:26:58 INFO - 'XPC_SERVICE_NAME': '0', 01:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:27:01 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:27:01 INFO - Installing collected packages: mozsystemmonitor 01:27:01 INFO - Running setup.py install for mozsystemmonitor 01:27:01 INFO - Successfully installed mozsystemmonitor 01:27:01 INFO - Cleaning up... 01:27:01 INFO - Return code: 0 01:27:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:27: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:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:01 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 0x100a73a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a83420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81784901f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100912e00>, '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 0x10077bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090db20>, '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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:27:01 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:27:01 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:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ub3lQvKz4/Render', 01:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:27:01 INFO - 'HOME': '/Users/cltbld', 01:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:27:01 INFO - 'LOGNAME': 'cltbld', 01:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:01 INFO - 'MOZ_NO_REMOTE': '1', 01:27:01 INFO - 'NO_EM_RESTART': '1', 01:27:01 INFO - 'PAGER': '/bin/cat', 01:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:01 INFO - 'PWD': '/builds/slave/test', 01:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:27:01 INFO - 'SHELL': '/bin/bash', 01:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGISE3B2Q5/Listeners', 01:27:01 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 01:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:27:01 INFO - 'USER': 'cltbld', 01:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:01 INFO - 'XPC_FLAGS': '0x0', 01:27:01 INFO - 'XPC_SERVICE_NAME': '0', 01:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:01 INFO - Downloading/unpacking blobuploader==1.2.4 01:27:01 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:27:01 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:27:01 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:27:01 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:27:01 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:27:01 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:27:04 INFO - Downloading blobuploader-1.2.4.tar.gz 01:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:27:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:27:04 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:27:04 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:27:04 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:27:04 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:27:04 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:27:04 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:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:27:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:05 INFO - Downloading docopt-0.6.1.tar.gz 01:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:27:05 INFO - Installing collected packages: blobuploader, requests, docopt 01:27:05 INFO - Running setup.py install for blobuploader 01:27:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:27:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:27:05 INFO - Running setup.py install for requests 01:27:06 INFO - Running setup.py install for docopt 01:27:06 INFO - Successfully installed blobuploader requests docopt 01:27:06 INFO - Cleaning up... 01:27:06 INFO - Return code: 0 01:27:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:06 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 0x100a73a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a83420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81784901f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100912e00>, '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 0x10077bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090db20>, '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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:27:06 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:27:06 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:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ub3lQvKz4/Render', 01:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:27:06 INFO - 'HOME': '/Users/cltbld', 01:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:27:06 INFO - 'LOGNAME': 'cltbld', 01:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:06 INFO - 'MOZ_NO_REMOTE': '1', 01:27:06 INFO - 'NO_EM_RESTART': '1', 01:27:06 INFO - 'PAGER': '/bin/cat', 01:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:06 INFO - 'PWD': '/builds/slave/test', 01:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:27:06 INFO - 'SHELL': '/bin/bash', 01:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGISE3B2Q5/Listeners', 01:27:06 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 01:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:27:06 INFO - 'USER': 'cltbld', 01:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:06 INFO - 'XPC_FLAGS': '0x0', 01:27:06 INFO - 'XPC_SERVICE_NAME': '0', 01:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:27:06 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-uiWhxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:27:06 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-dQ9rGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:27:06 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-1Z2k5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:27:07 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-m6viZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:27:07 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-2q7efs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:27:07 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-u0qZoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:27:07 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-98Qsh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:27:07 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-YrYDCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:27:07 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-BCSJw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:27:07 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-jcI1mQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:27:07 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-02jv_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:27:07 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-b1fMTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:27:08 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-jWBbnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:27:08 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-xZCmtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:08 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-KRbLVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:27:08 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-5smkys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:27:08 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-4x9OT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:27:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:27:08 INFO - Running setup.py install for manifestparser 01:27:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:27:08 INFO - Running setup.py install for mozcrash 01:27:08 INFO - Running setup.py install for mozdebug 01:27:08 INFO - Running setup.py install for mozdevice 01:27:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Running setup.py install for mozfile 01:27:09 INFO - Running setup.py install for mozhttpd 01:27:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Running setup.py install for mozinfo 01:27:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Running setup.py install for mozInstall 01:27:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Running setup.py install for mozleak 01:27:09 INFO - Running setup.py install for mozlog 01:27:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:27:09 INFO - Running setup.py install for moznetwork 01:27:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:27:10 INFO - Running setup.py install for mozprocess 01:27:10 INFO - Running setup.py install for mozprofile 01:27:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:27:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:27:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:27:10 INFO - Running setup.py install for mozrunner 01:27:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:27:10 INFO - Running setup.py install for mozscreenshot 01:27:10 INFO - Running setup.py install for moztest 01:27:10 INFO - Running setup.py install for mozversion 01:27:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:27:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:27:11 INFO - Cleaning up... 01:27:11 INFO - Return code: 0 01:27:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:27: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:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:11 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 0x100a73a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a83420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81784901f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100912e00>, '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 0x10077bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090db20>, '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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:27:11 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:27:11 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:27:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ub3lQvKz4/Render', 01:27:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:27:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:27:11 INFO - 'HOME': '/Users/cltbld', 01:27:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:27:11 INFO - 'LOGNAME': 'cltbld', 01:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:11 INFO - 'MOZ_NO_REMOTE': '1', 01:27:11 INFO - 'NO_EM_RESTART': '1', 01:27:11 INFO - 'PAGER': '/bin/cat', 01:27:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:11 INFO - 'PWD': '/builds/slave/test', 01:27:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:27:11 INFO - 'SHELL': '/bin/bash', 01:27:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGISE3B2Q5/Listeners', 01:27:11 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 01:27:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:27:11 INFO - 'USER': 'cltbld', 01:27:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:27:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:11 INFO - 'XPC_FLAGS': '0x0', 01:27:11 INFO - 'XPC_SERVICE_NAME': '0', 01:27:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:27:11 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-zRY2hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:27:11 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-A4YM15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:27:11 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-8X9oGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:27:11 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-jfcLy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:27:11 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-GPJ5qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:27:11 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-lfpyxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:27:11 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-sH9fNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:27:12 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-h6aBd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:27:12 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-CNXOCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:27:12 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-M8jORE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:27:12 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-YRjhaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:27:12 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-mvhzKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:27:12 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-5g5P9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:27:12 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-EDSNWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:12 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-kbNxs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:27:12 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-GPLIdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:27:13 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:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:27:13 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-NPY2UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:27:13 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:27:13 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:27:13 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:27:13 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:27:13 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:27:13 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:27:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:27:13 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:27:13 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:27:13 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:27:13 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:27:13 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:27:13 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:27:15 INFO - Downloading blessings-1.6.tar.gz 01:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:27:15 INFO - Installing collected packages: blessings 01:27:15 INFO - Running setup.py install for blessings 01:27:15 INFO - Successfully installed blessings 01:27:15 INFO - Cleaning up... 01:27:15 INFO - Return code: 0 01:27:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:27:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:27:16 INFO - Reading from file tmpfile_stdout 01:27:16 INFO - Current package versions: 01:27:16 INFO - blessings == 1.6 01:27:16 INFO - blobuploader == 1.2.4 01:27:16 INFO - docopt == 0.6.1 01:27:16 INFO - manifestparser == 1.1 01:27:16 INFO - mozInstall == 1.12 01:27:16 INFO - mozcrash == 0.17 01:27:16 INFO - mozdebug == 0.1 01:27:16 INFO - mozdevice == 0.48 01:27:16 INFO - mozfile == 1.2 01:27:16 INFO - mozhttpd == 0.7 01:27:16 INFO - mozinfo == 0.9 01:27:16 INFO - mozleak == 0.1 01:27:16 INFO - mozlog == 3.1 01:27:16 INFO - moznetwork == 0.27 01:27:16 INFO - mozprocess == 0.22 01:27:16 INFO - mozprofile == 0.28 01:27:16 INFO - mozrunner == 6.11 01:27:16 INFO - mozscreenshot == 0.1 01:27:16 INFO - mozsystemmonitor == 0.0 01:27:16 INFO - moztest == 0.7 01:27:16 INFO - mozversion == 1.4 01:27:16 INFO - psutil == 3.1.1 01:27:16 INFO - requests == 1.2.3 01:27:16 INFO - wsgiref == 0.1.2 01:27:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:16 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 0x100a73a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a83420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81784901f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100912e00>, '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 0x10077bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090db20>, '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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:27:16 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:27:16 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:27:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ub3lQvKz4/Render', 01:27:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:27:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:27:16 INFO - 'HOME': '/Users/cltbld', 01:27:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:27:16 INFO - 'LOGNAME': 'cltbld', 01:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:16 INFO - 'MOZ_NO_REMOTE': '1', 01:27:16 INFO - 'NO_EM_RESTART': '1', 01:27:16 INFO - 'PAGER': '/bin/cat', 01:27:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:16 INFO - 'PWD': '/builds/slave/test', 01:27:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:27:16 INFO - 'SHELL': '/bin/bash', 01:27:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGISE3B2Q5/Listeners', 01:27:16 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 01:27:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:27:16 INFO - 'USER': 'cltbld', 01:27:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:27:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:16 INFO - 'XPC_FLAGS': '0x0', 01:27:16 INFO - 'XPC_SERVICE_NAME': '0', 01:27:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:16 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:27:16 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:27:16 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:27:16 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:27:16 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:27:16 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:27:16 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:27:16 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:27:16 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:27:16 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:27:16 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:27:16 INFO - Cleaning up... 01:27:16 INFO - Return code: 0 01:27:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a73a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a83420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81784901f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100912e00>, '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 0x10077bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090db20>, '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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:27:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:27:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ub3lQvKz4/Render', 01:27:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:27:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:27:16 INFO - 'HOME': '/Users/cltbld', 01:27:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:27:16 INFO - 'LOGNAME': 'cltbld', 01:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:16 INFO - 'MOZ_NO_REMOTE': '1', 01:27:16 INFO - 'NO_EM_RESTART': '1', 01:27:16 INFO - 'PAGER': '/bin/cat', 01:27:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:16 INFO - 'PWD': '/builds/slave/test', 01:27:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:27:16 INFO - 'SHELL': '/bin/bash', 01:27:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGISE3B2Q5/Listeners', 01:27:16 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 01:27:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:27:16 INFO - 'USER': 'cltbld', 01:27:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:27:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:16 INFO - 'XPC_FLAGS': '0x0', 01:27:16 INFO - 'XPC_SERVICE_NAME': '0', 01:27:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:16 INFO - Downloading/unpacking jsonschema 01:27:16 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:27:16 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:27:16 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:27:16 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:27:16 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:27:16 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:27:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:27:19 INFO - Downloading/unpacking functools32 (from jsonschema) 01:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:19 INFO - Downloading functools32-3.2.3-2.tar.gz 01:27:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:27:19 INFO - warning: no files found matching '*.txt' 01:27:19 INFO - no previously-included directories found matching 'build' 01:27:19 INFO - no previously-included directories found matching 'dist' 01:27:19 INFO - no previously-included directories found matching '.git*' 01:27:19 INFO - Installing collected packages: jsonschema, functools32 01:27:19 INFO - Running setup.py install for functools32 01:27:19 INFO - warning: no files found matching '*.txt' 01:27:19 INFO - no previously-included directories found matching 'build' 01:27:19 INFO - no previously-included directories found matching 'dist' 01:27:19 INFO - no previously-included directories found matching '.git*' 01:27:19 INFO - Successfully installed jsonschema functools32 01:27:19 INFO - Cleaning up... 01:27:19 INFO - Return code: 0 01:27:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a73a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a83420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81784901f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100912e00>, '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 0x10077bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090db20>, '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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:27:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:27:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ub3lQvKz4/Render', 01:27:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:27:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:27:19 INFO - 'HOME': '/Users/cltbld', 01:27:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:27:19 INFO - 'LOGNAME': 'cltbld', 01:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:19 INFO - 'MOZ_NO_REMOTE': '1', 01:27:19 INFO - 'NO_EM_RESTART': '1', 01:27:19 INFO - 'PAGER': '/bin/cat', 01:27:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:19 INFO - 'PWD': '/builds/slave/test', 01:27:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:27:19 INFO - 'SHELL': '/bin/bash', 01:27:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGISE3B2Q5/Listeners', 01:27:19 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 01:27:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:27:19 INFO - 'USER': 'cltbld', 01:27:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:27:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:19 INFO - 'XPC_FLAGS': '0x0', 01:27:19 INFO - 'XPC_SERVICE_NAME': '0', 01:27:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:20 INFO - Downloading/unpacking flake8 01:27: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:27: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:27: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:27: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:27: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:27: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:27:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:27:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:27:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:27:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:27:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:27:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:27:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:27:23 INFO - no previously-included directories found matching 'docs/_build' 01:27:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:27:23 INFO - Running setup.py install for pep8 01:27:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:27:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:27:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:27:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:27:23 INFO - no previously-included directories found matching 'docs/_build' 01:27:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:27:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:27:24 INFO - Cleaning up... 01:27:24 INFO - Return code: 0 01:27:24 INFO - Running post-action listener: _resource_record_post_action 01:27:24 INFO - Running post-action listener: _start_resource_monitoring 01:27:24 INFO - Starting resource monitoring. 01:27:24 INFO - ##### 01:27:24 INFO - ##### Running install step. 01:27:24 INFO - ##### 01:27:24 INFO - Running pre-action listener: _resource_record_pre_action 01:27:24 INFO - Running main action method: install 01:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:27:24 INFO - Reading from file tmpfile_stdout 01:27:24 INFO - Detecting whether we're running mozinstall >=1.0... 01:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:27:24 INFO - Reading from file tmpfile_stdout 01:27:24 INFO - Output received: 01:27:24 INFO - Usage: mozinstall [options] installer 01:27:24 INFO - Options: 01:27:24 INFO - -h, --help show this help message and exit 01:27:24 INFO - -d DEST, --destination=DEST 01:27:24 INFO - Directory to install application into. [default: 01:27:24 INFO - "/builds/slave/test"] 01:27:24 INFO - --app=APP Application being installed. [default: firefox] 01:27:24 INFO - mkdir: /builds/slave/test/build/application 01:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 01:27:46 INFO - Reading from file tmpfile_stdout 01:27:46 INFO - Output received: 01:27:46 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:27:46 INFO - Running post-action listener: _resource_record_post_action 01:27:46 INFO - ##### 01:27:46 INFO - ##### Running run-tests step. 01:27:46 INFO - ##### 01:27:46 INFO - Running pre-action listener: _resource_record_pre_action 01:27:46 INFO - Running main action method: run_tests 01:27:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:27:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:27:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:27:46 INFO - 2016-06-21 01:27:46.207 screenresolution[1641:7423] starting screenresolution argv=screenresolution get 01:27:46 INFO - 2016-06-21 01:27:46.210 screenresolution[1641:7423] Display 0: 1600x1200x32@60 01:27:46 INFO - 2016-06-21 01:27:46.216 screenresolution[1642:7426] starting screenresolution argv=screenresolution list 01:27:46 INFO - Available Modes on Display 0 01:27:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:27:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:27:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:27:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:27:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:27:46 INFO - Intel Iris: 01:27:46 INFO - Chipset Model: Intel Iris 01:27:46 INFO - Type: GPU 01:27:46 INFO - Bus: Built-In 01:27:46 INFO - VRAM (Dynamic, Max): 1536 MB 01:27:46 INFO - Vendor: Intel (0x8086) 01:27:46 INFO - Device ID: 0x0a2e 01:27:46 INFO - Revision ID: 0x0009 01:27:46 INFO - Displays: 01:27:46 INFO - Display: 01:27:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:27:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:27:46 INFO - Display Serial Number: 1600x1200 60 01:27:46 INFO - Main Display: Yes 01:27:46 INFO - Mirror: Off 01:27:46 INFO - Online: Yes 01:27:46 INFO - Rotation: Supported 01:27:46 INFO - Return code: 0 01:27:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:27:46 INFO - Python 2.7.3 01:27:46 INFO - Return code: 0 01:27:46 INFO - grabbing minidump binary from tooltool 01:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:46 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 0x100912e00>, '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 0x10077bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:27:46 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:27:46 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:27:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:27:46 INFO - Return code: 0 01:27:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:27:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:27:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:27:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:27:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:27:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:27:47 INFO - Return code: 0 01:27:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0059 --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:27:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ub3lQvKz4/Render', 01:27:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:27:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:27:47 INFO - 'HOME': '/Users/cltbld', 01:27:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:27:47 INFO - 'LOGNAME': 'cltbld', 01:27:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:27:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:47 INFO - 'MOZ_NO_REMOTE': '1', 01:27:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:27:47 INFO - 'NO_EM_RESTART': '1', 01:27:47 INFO - 'PAGER': '/bin/cat', 01:27:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:47 INFO - 'PWD': '/builds/slave/test', 01:27:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:27:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:27:47 INFO - 'SHELL': '/bin/bash', 01:27:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGISE3B2Q5/Listeners', 01:27:47 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 01:27:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:27:47 INFO - 'USER': 'cltbld', 01:27:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:27:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:47 INFO - 'XPC_FLAGS': '0x0', 01:27:47 INFO - 'XPC_SERVICE_NAME': '0', 01:27:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:27:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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:27:47 INFO - mozversion application_buildid: 20160621000402 01:27:47 INFO - mozversion application_changeset: 634aedddd904cf6b9004590dbc2f5491fe4474ff 01:27:47 INFO - mozversion application_display_name: Firefox 01:27:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:27:47 INFO - mozversion application_name: Firefox 01:27:47 INFO - mozversion application_remotingname: firefox 01:27:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:27:47 INFO - mozversion application_vendor: Mozilla 01:27:47 INFO - mozversion application_version: 48.0 01:27:47 INFO - mozversion platform_buildid: 20160621000402 01:27:47 INFO - mozversion platform_changeset: 634aedddd904cf6b9004590dbc2f5491fe4474ff 01:27:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:27:47 INFO - mozversion platform_version: 48.0 01:27:47 INFO - using testdate: 1466497667 01:27:47 INFO - actual date: 1466497667 01:27:47 INFO - starting webserver on 'localhost:49277' 01:27:47 INFO - SUITE-START | Running 2 tests 01:27:47 INFO - TEST-START | dromaeo_css 01:27:47 INFO - operating with platform_type : mac_ 01:27:47 INFO - Initialising browser for dromaeo_css test... 01:27:48 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpnfU2mP/profile http://localhost:49277/getInfo.html) 01:27:50 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 01:27:50 INFO - PROCESS | 1660 | colorDepth:24 01:27:50 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 01:27:50 INFO - PROCESS | 1660 | __metrics 01:27:51 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 01:27:51 INFO - TEST-INFO | 1660: exit 0 01:27:51 INFO - Browser initialized. 01:27:51 INFO - Running cycle 1/1 for dromaeo_css test... 01:27:51 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpnfU2mP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:28:03 INFO - PROCESS | 1664 | RSS: Main: 170737664 01:28:03 INFO - PROCESS | 1664 | 01:28:53 INFO - PROCESS | 1664 | 1466497733252 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:31:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 01:31:04 INFO - PROCESS | 1664 | RSS: Main: 182730752 01:31:04 INFO - PROCESS | 1664 | 01:34:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 01:34:07 INFO - PROCESS | 1664 | RSS: Main: 192446464 01:34:07 INFO - PROCESS | 1664 | 01:37:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 01:37:09 INFO - PROCESS | 1664 | RSS: Main: 194564096 01:37:09 INFO - PROCESS | 1664 | 01:40:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 01:40:11 INFO - PROCESS | 1664 | RSS: Main: 198262784 01:40:11 INFO - PROCESS | 1664 | 01:43:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 01:43:14 INFO - PROCESS | 1664 | RSS: Main: 197431296 01:43:14 INFO - PROCESS | 1664 | 01:46:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 01:46:17 INFO - PROCESS | 1664 | RSS: Main: 202244096 01:46:17 INFO - PROCESS | 1664 | 01:46:17 INFO - PROCESS | 1664 | __start_tp_report 01:46:17 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 01:46:17 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 01:46:17 INFO - PROCESS | 1664 | |i|pagename|runs| 01:46:17 INFO - PROCESS | 1664 | |0;dojo.html;3058.296591783891;3590.874319398821;3663.1025398777306;3706.9073273168174;3729.73891827572;5692.743826527806;5700.543956483477;5725.427457254273;5733.426657334269;5734.397888221739;5711.571632127597;5752.28096487939;5772.711364431782;5774.422557744224;5788.594798364116;4801.783919723621;5140.563052140563;5225.738713064351;5251.133562962106;5260.605454590902;5144.279800827887;5207.427183009866;5245.527902488775;5284.2866213061125;5331.920021199685;5257.921131183035;5264.842054738364;5269.394019687727;5301.946980530184;5305;5105.617078719111;5245.108331583621;5253.343332083489;5260.815871444481;5299.125644268691;5081.898362032739;5102.591792656615;5112.130937740593;5162.535371816554;5169.966006798618;5532.972335138298;5601.935632229864;5629.9437005629825;5650.067738823089;5691.971540142315;6131.284916201108;6157.107219453199;6287.937120628781;6295.811125666191;6296.464800491918;5395.78416863325;6006.339302676702;6138.357744607947;6218.160548325964;6251.624902505819;5811.88376232473;5870.412958704138;5881.500072493843;5916.0238560637445;5928.87351403232;6211.3167551569295;6221.875562488724;6224.221972253468;6230.563860529719;6275.466585340206;6176.907346389808;6203.131561581382;6212.254529456494;6237.1891654084675;6251.093591429218;6242.15730876335;6254.8123556293385;6263.185785847902;6278.686065696788;6282.528810339243;6052.878942421127;6113.57204995655;6170.012797952306;6182.969085154546;6232.220972378453;6155.507559395238;6216.378362163748;6242.375762423812;6250.718717657716;6253.781117660951;4442.911486685783;4974.303597496353;4976.701397916064;5000.1749711297225;5011.4236862761245;4379.364992076131;4401.581849724271;4417.580329868657;4493.415855938707;4547.590716835501;4851.611871050308;5898.764049437975;5899.557533185029;5946.762129514857;6076.75692972285;5662;6253.593516421418;6255.812325630239;6258.843528911813;6275.654838983808;4904.6321525885705;5842.503387212049;5943.821685349447;6077.270727512727;6104.2064531611495;5373.489518495737;5424.864378390493;5425.891482170414;5427.891442171134;5438.15708565173;6290.528210384148;6410.1987251593555;6421.422072013541;6433.324500927335;6438.356164383524;6172.938270617236;6231.906521402092;6236.126942228001;6247.406496382836;6249.531285153541;5435.945640543544;6462.224533056064;6480.189976252968;6504.837379065561;6578.539502234989;6013.488853447506;6113.050656958906;6221.564490485623;6237.656928868956;6265.373462653698;6210.627362358273;6264.655443950444;6271.122042913905;6272.968635156795;6294.055891616111;5183;6065.272167339947;6096.756129754937;6161.630302181883;6197.442230199304;5979.372165922689;6035.698215089315;6090.634561926298;6125.17440701618;6159;5845.386234445322;5946.910796338145;5978.043513037893;6013.969930150496;6019.939800601938;5999.760009599567;6156.661383623944;6159.72281247336;6167.383261673796;6178.752849885954;5965.194698715792;6022.126791615104;6022.1870047543025;6023.397660233942;6070.969645151746 01:46:17 INFO - PROCESS | 1664 | |1;ext.html;524.5410266017235;552.6131707804537;563.2143160291391;598.9548238324123;614.3978900677336;40777;41726.37410438842;41897.16205675885;41919.580804192025;41927.37108943365;43001.56998430015;43706;43711.68864934049;43714.78142609283;43818.56181438185;9604.039596040393;9730.805383892319;9771.75570610737;9850.753731156707;9859.852102218472;9870.259730520203;9934.105930466256;9960.05379488951;9991.550380232908;10007.649732259373;8919.509426981513;9934.35426697266;9961.850572241387;9987.201023918105;9991.150752186073;8868.600912958933;9984;9987.35082219657;10017.098461138532;10041.548130334153;8389.454685445487;9764.462954537497;9788.168005719523;9872.062154095349;9879.357841740335;41469;41942.58057419448;42102;42469.93825154365;42710.57289427097;3052.435299469605;3272.885449009297;3351.6983471487683;3425.2635683328203;3504.211552400715;29835.95574154894;30280.394392112034;30457.69542304571;30845.845770771004;32454;2825.6044153818275;2826.025021367625;2851.871665775045;2872.310645445099;2907.651081870168;428882;430890;431182;431424;433918.8304058491;37963.62036379656;69220.3077969224;69390;69506.65246673735;69709.99999999898;37664.81167594199;37835.432468513;37888;37894.62105378966;37938.62061379351;16847.41034063802;16985.23566439513;16993.32026718942;17163.485095447155;17233.827661723473;14105;14489.420423183166;14542.927285363505;14568.198749068692;14693;8426.115257897955;8684.696035638723;8750.781230469289;8798.988116366572;8811;3177.253345463814;3576.0523461282783;3600.98199509006;3605.4952306677087;3651.653092956165;968.7674958010168;1041.557338131291;1091.8198497248025;1128.5542210826677;1143.4854315558032;27222.319442014108;29994.25014374658;31114.68885311118;31152.844235778677;31784.36431271408;1140.503880811833;1176.394157009141;1252.8263462891875;1278.8401449818773;1286.601153642374;15693.921530392276;15788.447404340794;15936.840631593535;16394;16509.504714858333;585506;621115;636568.8171559112;640155;640836.7958160179;66426.66786666133;66876.6656166716;66889.66555167291;67574.66212668906;67752;1546.621077835915;1612.258361153859;1623.0342945947143;1640.6554623528955;1646.802383713938;31058.53412198864;31245.531317029807;31481.8425907869;31898.043058708277;32099;59026.11460828177;64350.67824660847;65655.67172164109;66013;66267.66866165638;596607;602292;605909;606497;608635;44874.87812804706;45495.54504454913;47622.28566571573;47729.28406073842;47824.282635761185;49917.50082499274;49970.500294996586;50498.49501505085;51185.23222151745;52264;37951.86144415672;38081.61918380781;38421.6157838418;38713.612863871;40240;39538.80230598828;39925;39994.20011599694;40184.39723404093;40188.99527511836;35283.11792205215;38953.610463895;40213.798931005156;40274.993125170935;40500.98747531218;34446.13884652904;36476.45285320669;37031.444528332635;37036.074098147765;37107.07232319214;25342;26073.73926260713;27160.72839271582;27347.58978615362;27486.725132749216 01:46:17 INFO - PROCESS | 1664 | |2;jquery.html;416.88535652695504;418.19080080045103;419.96640268778503;426.0817937345022;426.7375564028122;16142.83857161428;16531.586710332234;20638.17447302108;21482.92585370731;22041;11993.100517461204;12038.036957043416;12491.625251242454;21111.68332475014;21520.569588608218;5580.832575022756;5629.831105066854;5732.0542110551705;5792.420757924195;5797.478226959573;5996;6328.177336946191;6330.556861019731;6332.936670633281;6339.04914262862;5651.095824668054;6160.969195154018;6282.52881033922;6303.369663033705;6308.621482711029;5643.887122257553;5644.745986430579;5646.971765141189;5724.313082430093;5778.191053252548;5364.953834002371;5632.155176723483;5636;5639.915401268984;5666.121751128581;14182;16701.749473757904;22197.334079977627;22202.555948881094;23509.294721158392;2095.3609149209483;2215.579039982414;2227.5878962392007;2291.3698732848434;2798.8460634665084;8573.571321433903;9967.252456065824;10293.228007899363;10393.116585090276;10433.739156521071;1594.7528133139383;1821.3625231168985;1827.7075667893073;1857.182839550607;1901.0494752623688;113755;115142.84857151406;127020;128464;129243;10604.522796474177;12032.81950770739;12123.33321667299;12417.875821241672;12453.25280483174;15563.455279065178;15585.68828623444;15606.219689015505;16114.516564503083;16204.59488512773;7711.305982461606;9034.503102329434;9528.142467177848;9557.952210238904;9561.426314421156;7836.686532538634;9462.384944978554;9477;9548.331616786758;9650.179734722487;4901.36282283308;4934.407871055496;4948.628852836052;4953.8018479261145;5017.197248440232;1816.9454916352265;2022.5247066939257;2116.915323387078;2132.3709505695856;2160.60028894655;940.8870935487786;963.9373440726471;1007.2345017786535;1008.7679833638305;1060.824963880951;21190.19883309936;21217.363479095653;21281.255156069463;21798.891005544872;21925.561488770134;987.8172538080478;1032.1226957086417;1043.6034306963306;1096.736783172033;1117.804384232756;11381.260218085798;11744.471498782576;11765.647030589096;11783.293002419883;11790.292582445081;497712;505272;506484;512076;518909;88323;110506;117906.41046794882;124438.13342799865;130792;1016.8169729448771;1025.9692209233735;1044.6291566493785;1045.2056437107854;1050.417018554694;19273.807261927202;19679.31122410709;19835.702464463335;19838.603227935073;20042;53340;53860.46139538711;54411.72794136004;54416.82332706647;54506;64057;72678.63660681662;76259.47481050459;80092.79860802209;82049;8446.66213351459;8573.61418736146;8631.007434144902;8738.257248133725;8901.97627272846;8873.378863479753;12351.961926282063;12946.676333091747;13108.672283192996;13361.331933403097;11009.724756881142;11229.091054520915;11239.13000218895;11240.213185076966;11470.942645286721;11159.721006974565;11291.548338066385;11480.081593472669;11566.016888564229;11656.365576985267;11664.708382290512;11817.763644726885;11841.703957401134;11917.76164476723;12057.191421286878;8505.404621676424;8606.78483037929;8617.353698472514;8623.827523449621;8730.388872778845;11193.216474846682;11721.941390292994;11742.647720568397;11906.404679765803;12016.759664806481 01:46:17 INFO - PROCESS | 1664 | |3;mootools.html;1658.0880515716353;1683.7137686593283;2002.2991952816517;2053.9178432862695;2155.946101347467;8218.753437396872;8577.957110214456;8983.775405614862;9196.95401522993;9219.262459003281;8887;8894.377393582452;8907.643694252238;9022.323325750562;9031.142041506062;2499.0503608628696;2503.899844006242;2521.2562294123277;2533.898644054236;2535.1887396033276;2520.6471094046847;2559.1298958354155;2567.3068271566667;2575.060103062378;2575.613657951313;2519.433127546306;2528.759767822063;2531.556977528934;2535.987320063397;2563.2566555698827;2111.9366419007456;2494.625806129086;2529.810264230181;2544.7836933860644;2556.4759224358963;2189.3541405285478;2484.813638977084;2507.987460062688;2509.0716434919013;2574.124797568817;8708.21626053652;8736.912630873738;8792.076831932683;8800.515971621558;8822.11778822119;5315.760790764425;5496.928099020693;5535.833924982257;5623.381428042912;5758.6544807311275;3161.3203161320425;3246.2209069823307;3479.408500554912;3678.786000619789;3791.620837916214;1080.9621663241749;1081.1999120650742;1097.0620119797618;1100.3617901617042;1104.4808939798363;11967.982721468685;12162.51349946001;12208.938955305166;12231.021518278516;12265.754684906342;4956;5037.319961805183;5057.848264552069;5085.898282034339;5124.9743751281;10527.21045921559;10549.630762923261;10600.469976501145;10654.414007229676;10666.94666526678;5620.1569764534825;5697.886042279214;5733.054046082433;5764.13537969308;5793.188953546507;4659.254519276968;5042.218456139304;5084.7966081356335;5118.206677964921;5194.32473778414;4254.234237837157;4296.957030429656;4319.308910574293;4329.978350108229;4400.69195156336;1390.1867407566688;1420.4815242436437;1422.459465403161;1427.357689039936;1429.9499517516838;951.923846092311;992.6525715999343;994.080475560104;994.5226291380178;1009.9848502272472;5958.761649534057;5981.641101533922;6034.63792172471;6080.8783824324155;6157.415045570664;483.1713611156883;489.9902001959941;490.977905994224;496.9204927211629;500.96743711658627;3923.489946306962;3967.285888540033;4020.0954785173103;4041.0503531670033;4079.02103495159;10504.894951050392;10842.96991785779;10861.13110951122;10893.564257429614;10951.945240273906;10510.159187265;10547.947260263649;10678.145748340114;10698.839517407245;10808.405537695502;8166.020077590727;8347.248747612866;8450.154984501502;8507.404481686346;8540.957295213608;5331.280277162534;5932.851678708067;5944.87047460981;6096.634201947897;6121.326654068138;9264.166225039779;9576.712698619052;9710.417374957526;9748.610055597697;9875.901240987498;9223.677171298972;9813.509324533887;9820.214382849212;9969.700908972742;9991.950040249752;6873.831448653841;7100.573965562083;7252.129744430491;7295.598742069237;7944.205579442009;7253.673584688807;7576.711958966878;8388.245057944814;8465.449745766506;8478.957605211934;7414.740484083031;7486.438517111347;7574.356179724785;7599.430042746705;7670.232976702285;7380.520266182681;7421.888671670037;7489.737859174903;7497.550146991198;7552.471327007276;7096.361327480345;7099.964500177466;7127.928720712726;7140.178879428724;7156.355927966508;4907.312976183266;4978.601711863114;5064.215046667772;5073.7716802743225;5106.897862042664;5055.87360315995;5109.897802044013;5111.5910727141;5184;5322.38792538863 01:46:17 INFO - PROCESS | 1664 | |4;prototype.html;335.95800524934384;337.8294458106664;338.46860429126275;345.2404709638794;346.68451708944866;5792.275965504312;6328.557001009925;6576.243731970825;6684.5989240645595;6758.560693554916;5712.8857422851515;5852.67810270435;6664.700088496017;6676.799696009115;6703.698333574988;5002.724850133251;5026;5027.472115427864;5030.220315851049;5034.219695947134;4351.934720979188;5033.823816166435;5045;5060.5951523878;5071.568916642072;4993.650444468889;4996.200607902736;5001.524855138774;5005.474425185358;5033.748312584375;3997.940030899553;4839.419269687624;4980.676256043345;4985.950140498585;5014.799408023675;3889.572147063821;3899.005753532859;4238.660907127422;4262.531121576624;4280.700350975433;6394.328595497453;6427.807165785034;6432.614043157426;6436.356364363526;6442.871142577169;5844.357120716718;5903.0555111182;5909.23179986599;5913.7930172444185;5928.7628494860155;7195.712171513185;7196.1724401693955;7197.172325182619;7197.208307086216;7232.638368081575;4630.305454181866;4796.832110876137;4800.735959522225;4803.207470767319;4821.0357928414105;6887.793366199022;7566.205548417447;7578.052743407075;7619.199984001655;7635.732749353746;4872.926906096412;4882.316475693406;4887.560119589254;4887.682300650446;4894.975525122351;4954.653174277838;4969.850904472872;4980.5019498049905;4982.8754281143265;4993.17612593918;5887.646741195456;5904.1734157218025;5911.201987731687;5912.349641539513;5926;5563.860903477445;5967.820965370959;7178.820529486805;7263.656223598651;7296.562206267535;1689.0456891856063;1703.897766134036;1722.8707846911532;1724.1896308734874;1726.4475367882408;1080.2168427889717;1101.6419663609358;1108.1190453589415;1124.9550017999188;1128.5937062657438;5167.534921857051;6497.635496545779;6818.522703410813;6850.828729281709;6889.724411023603;7497.775066748006;7519.8496030079095;7522.887156692654;7524.774256772305;7548.509346892434;5617.43825617435;5620.213170156181;6928.722851086001;6934.826629334206;6948.895766563505;3019.531972544259;3420.452727563578;3678.889633311005;3908.413737939332;3917.764934103963;7713.6914523419555;7969.083555391088;7998.3201427879285;8019.438639295194;8088.595570221465;7627.847443051219;7655.425843061793;7672.65473053714;7688.077430708351;7695.461317707706;7914.604269786488;7940.880886786703;7968.083670377865;7968.681252749825;7986.480878742863;7200.8919866201;7424.628768561658;7429.702811887464;7457.701691932479;7489.550626962399;5861.9413805861395;7220.133583969957;7292.650859590993;7304.233055529306;7324.121105467378;7944.6822127114265;7947.284744373034;7977;7978.640961156878;7989.760307190793;4784.258439941815;4784.425868895755;4792.496787837227;4794.376731024944;4806.543378379049;7219.494635375473;7326.9267307326245;7402.518836275625;7430.591317477374;7450.8882366763455;7130.322619351154;7146.857062858818;7163.31948464895;7185.353318201387;7188.173360063451;6831.316868313328;7162.856742865009;7169.139703235645;7187.820304492429;7209.531380460253;5101.821436249714;6992.1259842519685;6994.160700715743;7014.403775679124;7016.36852683261;6932.341427564374;7114.253003434565;7134.286571342825;7159.498835081703;7195.8920616191845;6758.357955994173;6831.658417079226;7043;7043.788686339418;7069.858602828018 01:46:17 INFO - PROCESS | 1664 | |5;yui.html;724.9166345870226;773.6479901644752;782.7573452229807;788.7633709887033;797.4577287444539;15169.317380717866;15443.768343474829;15494.147821869807;15494.225288735575;15517.068975861455;14411.495597654084;14417.990740648158;14458.349374278156;14467.131972081683;14469.638259043502;786.4887822915093;934.1125930366145;935.4153653966271;942.9057094290584;956.8756061711968;910.8360495110877;948.2556193388192;951.8762560867112;958.8849338079406;978.1685567267801;963.3545524498603;997.3666721631744;1011.9949400252989;1012.7366884610018;1023.9846402303934;957.3585697582602;958;959.6641175588558;960.8798900137483;1024.0578667625764;727.1891840597748;771.7684694591657;771.7761849063764;771.8301973565807;773.6402572803617;15054.473093441786;15064.397424103023;15165.090094594249;15267.923660381739;15320.540383788504;13282.3358832058;13287.20276783396;13412.530561430303;13422.127561708458;13574.321283935862;9929.602815887356;9942.254330925209;9957.203423726085;10361.015703508154;10379;3600.1899572596217;3645.2527231917657;3647.689946354563;3671;3713.851445942159;79458.60270698667;81491.7776233357;83022;83178;83205;8239.887615171876;9741.610335586638;9789.825495711018;9846.113849753556;10246.48767561619;18455;19180.040997950047;21588.56822863534;22379.440513986956;22463.775362246495;6461.321561236096;7886.44794864354;7898.2891539761695;8010.439269251213;8207.302379297707;4020.7587544747407;4032.4556184915245;4042.15114825884;4072.9592704073175;4321.567843215653;3247.464168412233;3774.9056273592832;3782.2813665403487;3808.485854409619;3848.692104631623;690.5338896245115;724.4928550015011;728.6830228850467;753.5290443472829;759.9164091949881;521.4681025354193;533.906566350887;577.336063526939;606.2512796696077;622.5548732656082;7927.841443171104;8452.408331416742;8601.139886011473;8620.00869899957;8747.868781968276;592.2301008688687;605.9303180134253;621.1304174156127;632.4940047961612;638.090720722968;4078.6737061035046;4305.526392096866;4307.612314891675;4426.15902978433;4435.645148388121;96286;97327.51336243273;97531.51234243784;98014;100330;78106.04734881673;78394.60802696065;78549.60725196337;79005.60497197477;79024.60487697525;66004.66997665077;66320.66839665867;71307;73753.26246737571;75569.11077223004;7943.887855700091;8145.67417303325;8581.399302049047;8761.649534018823;8935.061818508962;45465.09069818651;45862.541374585824;46734;48209;52026.21960670668;47584.52415475801;64887.67556162189;68877.65561172162;69048.6547567259;70354.29645703477;11101.444927753419;11242.100631949588;11439;11532.827007594726;11546.364949927834;11890.10824188172;11991.340476273888;12174.086943479097;12182.208156470155;12481.063920206203;11573;11704.590339338423;11715.707107322385;11800.822987655363;11997.520099195934;11629.418529073682;11667.35829529384;11786.410679466164;11979.580714674945;12030;9948.651797187063;10105.343152695052;11604.30374177552;11667.941660291644;12186.878131218575;9762.17021553176;10123.64567240143;10200.591976320864;10278.640247591298;10313.74215644615;8767.736967890718;9869.654562090293;10100.444475553915;10195.23535734808;10238 01:46:17 INFO - PROCESS | 1664 | __end_tp_report 01:46:17 INFO - PROCESS | 1664 | __start_cc_report 01:46:17 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,397 01:46:17 INFO - PROCESS | 1664 | __end_cc_report 01:46:17 INFO - PROCESS | 1664 | __startTimestamp1466498777198__endTimestamp 01:46:17 INFO - PROCESS | 1664 | 01:46:17 INFO - PROCESS | 1664 | ------- Summary: start ------- 01:46:17 INFO - PROCESS | 1664 | Number of tests: 6 01:46:17 INFO - PROCESS | 1664 | 01:46:17 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5750.06 Median:6006.34 stddev:638.56 (10.6%) stddev-sans-first:604.60 01:46:17 INFO - PROCESS | 1664 | Values: 3058.3 3590.9 3663.1 3706.9 3729.7 5692.7 5700.5 5725.4 5733.4 5734.4 5711.6 5752.3 5772.7 5774.4 5788.6 4801.8 5140.6 5225.7 5251.1 5260.6 5144.3 5207.4 5245.5 5284.3 5331.9 5257.9 5264.8 5269.4 5301.9 5305.0 5105.6 5245.1 5253.3 5260.8 5299.1 5081.9 5102.6 5112.1 5162.5 5170.0 5533.0 5601.9 5629.9 5650.1 5692.0 6131.3 6157.1 6287.9 6295.8 6296.5 5395.8 6006.3 6138.4 6218.2 6251.6 5811.9 5870.4 5881.5 5916.0 5928.9 6211.3 6221.9 6224.2 6230.6 6275.5 6176.9 6203.1 6212.3 6237.2 6251.1 6242.2 6254.8 6263.2 6278.7 6282.5 6052.9 6113.6 6170.0 6183.0 6232.2 6155.5 6216.4 6242.4 6250.7 6253.8 4442.9 4974.3 4976.7 5000.2 5011.4 4379.4 4401.6 4417.6 4493.4 4547.6 4851.6 5898.8 5899.6 5946.8 6076.8 5662.0 6253.6 6255.8 6258.8 6275.7 4904.6 5842.5 5943.8 6077.3 6104.2 5373.5 5424.9 5425.9 5427.9 5438.2 6290.5 6410.2 6421.4 6433.3 6438.4 6172.9 6231.9 6236.1 6247.4 6249.5 5435.9 6462.2 6480.2 6504.8 6578.5 6013.5 6113.1 6221.6 6237.7 6265.4 6210.6 6264.7 6271.1 6273.0 6294.1 5183.0 6065.3 6096.8 6161.6 6197.4 5979.4 6035.7 6090.6 6125.2 6159.0 5845.4 5946.9 5978.0 6014.0 6019.9 5999.8 6156.7 6159.7 6167.4 6178.8 5965.2 6022.1 6022.2 6023.4 6071.0 01:46:17 INFO - PROCESS | 1664 | 01:46:17 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:69720.87 Median:40257.50 stddev:149667.59 (371.8%) stddev-sans-first:149997.28 01:46:17 INFO - PROCESS | 1664 | Values: 524.5 552.6 563.2 599.0 614.4 40777.0 41726.4 41897.2 41919.6 41927.4 43001.6 43706.0 43711.7 43714.8 43818.6 9604.0 9730.8 9771.8 9850.8 9859.9 9870.3 9934.1 9960.1 9991.6 10007.6 8919.5 9934.4 9961.9 9987.2 9991.2 8868.6 9984.0 9987.4 10017.1 10041.5 8389.5 9764.5 9788.2 9872.1 9879.4 41469.0 41942.6 42102.0 42469.9 42710.6 3052.4 3272.9 3351.7 3425.3 3504.2 29836.0 30280.4 30457.7 30845.8 32454.0 2825.6 2826.0 2851.9 2872.3 2907.7 428882.0 430890.0 431182.0 431424.0 433918.8 37963.6 69220.3 69390.0 69506.7 69710.0 37664.8 37835.4 37888.0 37894.6 37938.6 16847.4 16985.2 16993.3 17163.5 17233.8 14105.0 14489.4 14542.9 14568.2 14693.0 8426.1 8684.7 8750.8 8799.0 8811.0 3177.3 3576.1 3601.0 3605.5 3651.7 968.8 1041.6 1091.8 1128.6 1143.5 27222.3 29994.3 31114.7 31152.8 31784.4 1140.5 1176.4 1252.8 1278.8 1286.6 15693.9 15788.4 15936.8 16394.0 16509.5 585506.0 621115.0 636568.8 640155.0 640836.8 66426.7 66876.7 66889.7 67574.7 67752.0 1546.6 1612.3 1623.0 1640.7 1646.8 31058.5 31245.5 31481.8 31898.0 32099.0 59026.1 64350.7 65655.7 66013.0 66267.7 596607.0 602292.0 605909.0 606497.0 608635.0 44874.9 45495.5 47622.3 47729.3 47824.3 49917.5 49970.5 50498.5 51185.2 52264.0 37951.9 38081.6 38421.6 38713.6 40240.0 39538.8 39925.0 39994.2 40184.4 40189.0 35283.1 38953.6 40213.8 40275.0 40501.0 34446.1 36476.5 37031.4 37036.1 37107.1 25342.0 26073.7 27160.7 27347.6 27486.7 01:46:17 INFO - PROCESS | 1664 | 01:46:17 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:32161.96 Median:21501.75 stddev:85503.16 (397.7%) stddev-sans-first:85709.80 01:46:17 INFO - PROCESS | 1664 | Values: 416.9 418.2 420.0 426.1 426.7 16142.8 16531.6 20638.2 21482.9 22041.0 11993.1 12038.0 12491.6 21111.7 21520.6 5580.8 5629.8 5732.1 5792.4 5797.5 5996.0 6328.2 6330.6 6332.9 6339.0 5651.1 6161.0 6282.5 6303.4 6308.6 5643.9 5644.7 5647.0 5724.3 5778.2 5365.0 5632.2 5636.0 5639.9 5666.1 14182.0 16701.7 22197.3 22202.6 23509.3 2095.4 2215.6 2227.6 2291.4 2798.8 8573.6 9967.3 10293.2 10393.1 10433.7 1594.8 1821.4 1827.7 1857.2 1901.0 113755.0 115142.8 127020.0 128464.0 129243.0 10604.5 12032.8 12123.3 12417.9 12453.3 15563.5 15585.7 15606.2 16114.5 16204.6 7711.3 9034.5 9528.1 9558.0 9561.4 7836.7 9462.4 9477.0 9548.3 9650.2 4901.4 4934.4 4948.6 4953.8 5017.2 1816.9 2022.5 2116.9 2132.4 2160.6 940.9 963.9 1007.2 1008.8 1060.8 21190.2 21217.4 21281.3 21798.9 21925.6 987.8 1032.1 1043.6 1096.7 1117.8 11381.3 11744.5 11765.6 11783.3 11790.3 497712.0 505272.0 506484.0 512076.0 518909.0 88323.0 110506.0 117906.4 124438.1 130792.0 1016.8 1026.0 1044.6 1045.2 1050.4 19273.8 19679.3 19835.7 19838.6 20042.0 53340.0 53860.5 54411.7 54416.8 54506.0 64057.0 72678.6 76259.5 80092.8 82049.0 8446.7 8573.6 8631.0 8738.3 8902.0 8873.4 12352.0 12946.7 13108.7 13361.3 11009.7 11229.1 11239.1 11240.2 11470.9 11159.7 11291.5 11480.1 11566.0 11656.4 11664.7 11817.8 11841.7 11917.8 12057.2 8505.4 8606.8 8617.4 8623.8 8730.4 11193.2 11721.9 11742.6 11906.4 12016.8 01:46:17 INFO - PROCESS | 1664 | 01:46:17 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5825.59 Median:5079.28 stddev:3208.51 (63.2%) stddev-sans-first:3202.23 01:46:17 INFO - PROCESS | 1664 | Values: 1658.1 1683.7 2002.3 2053.9 2155.9 8218.8 8578.0 8983.8 9197.0 9219.3 8887.0 8894.4 8907.6 9022.3 9031.1 2499.1 2503.9 2521.3 2533.9 2535.2 2520.6 2559.1 2567.3 2575.1 2575.6 2519.4 2528.8 2531.6 2536.0 2563.3 2111.9 2494.6 2529.8 2544.8 2556.5 2189.4 2484.8 2508.0 2509.1 2574.1 8708.2 8736.9 8792.1 8800.5 8822.1 5315.8 5496.9 5535.8 5623.4 5758.7 3161.3 3246.2 3479.4 3678.8 3791.6 1081.0 1081.2 1097.1 1100.4 1104.5 11968.0 12162.5 12208.9 12231.0 12265.8 4956.0 5037.3 5057.8 5085.9 5125.0 10527.2 10549.6 10600.5 10654.4 10666.9 5620.2 5697.9 5733.1 5764.1 5793.2 4659.3 5042.2 5084.8 5118.2 5194.3 4254.2 4297.0 4319.3 4330.0 4400.7 1390.2 1420.5 1422.5 1427.4 1429.9 951.9 992.7 994.1 994.5 1010.0 5958.8 5981.6 6034.6 6080.9 6157.4 483.2 490.0 491.0 496.9 501.0 3923.5 3967.3 4020.1 4041.1 4079.0 10504.9 10843.0 10861.1 10893.6 10951.9 10510.2 10547.9 10678.1 10698.8 10808.4 8166.0 8347.2 8450.2 8507.4 8541.0 5331.3 5932.9 5944.9 6096.6 6121.3 9264.2 9576.7 9710.4 9748.6 9875.9 9223.7 9813.5 9820.2 9969.7 9992.0 6873.8 7100.6 7252.1 7295.6 7944.2 7253.7 7576.7 8388.2 8465.4 8479.0 7414.7 7486.4 7574.4 7599.4 7670.2 7380.5 7421.9 7489.7 7497.6 7552.5 7096.4 7100.0 7127.9 7140.2 7156.4 4907.3 4978.6 5064.2 5073.8 5106.9 5055.9 5109.9 5111.6 5184.0 5322.4 01:46:17 INFO - PROCESS | 1664 | 01:46:17 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5859.62 Median:6470.25 stddev:1887.00 (29.2%) stddev-sans-first:1846.18 01:46:17 INFO - PROCESS | 1664 | Values: 336.0 337.8 338.5 345.2 346.7 5792.3 6328.6 6576.2 6684.6 6758.6 5712.9 5852.7 6664.7 6676.8 6703.7 5002.7 5026.0 5027.5 5030.2 5034.2 4351.9 5033.8 5045.0 5060.6 5071.6 4993.7 4996.2 5001.5 5005.5 5033.7 3997.9 4839.4 4980.7 4986.0 5014.8 3889.6 3899.0 4238.7 4262.5 4280.7 6394.3 6427.8 6432.6 6436.4 6442.9 5844.4 5903.1 5909.2 5913.8 5928.8 7195.7 7196.2 7197.2 7197.2 7232.6 4630.3 4796.8 4800.7 4803.2 4821.0 6887.8 7566.2 7578.1 7619.2 7635.7 4872.9 4882.3 4887.6 4887.7 4895.0 4954.7 4969.9 4980.5 4982.9 4993.2 5887.6 5904.2 5911.2 5912.3 5926.0 5563.9 5967.8 7178.8 7263.7 7296.6 1689.0 1703.9 1722.9 1724.2 1726.4 1080.2 1101.6 1108.1 1125.0 1128.6 5167.5 6497.6 6818.5 6850.8 6889.7 7497.8 7519.8 7522.9 7524.8 7548.5 5617.4 5620.2 6928.7 6934.8 6948.9 3019.5 3420.5 3678.9 3908.4 3917.8 7713.7 7969.1 7998.3 8019.4 8088.6 7627.8 7655.4 7672.7 7688.1 7695.5 7914.6 7940.9 7968.1 7968.7 7986.5 7200.9 7424.6 7429.7 7457.7 7489.6 5861.9 7220.1 7292.7 7304.2 7324.1 7944.7 7947.3 7977.0 7978.6 7989.8 4784.3 4784.4 4792.5 4794.4 4806.5 7219.5 7326.9 7402.5 7430.6 7450.9 7130.3 7146.9 7163.3 7185.4 7188.2 6831.3 7162.9 7169.1 7187.8 7209.5 5101.8 6992.1 6994.2 7014.4 7016.4 6932.3 7114.3 7134.3 7159.5 7195.9 6758.4 6831.7 7043.0 7043.8 7069.9 01:46:17 INFO - PROCESS | 1664 | 01:46:17 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18493.78 Median:527.69 stddev:26048.48 (4936.3%) stddev-sans-first:26087.38 01:46:17 INFO - PROCESS | 1664 | Values: 724.9 773.6 782.8 788.8 797.5 15169.3 15443.8 15494.1 15494.2 15517.1 14411.5 14418.0 14458.3 14467.1 14469.6 786.5 934.1 935.4 942.9 956.9 910.8 948.3 951.9 958.9 978.2 963.4 997.4 1012.0 1012.7 1024.0 957.4 958.0 959.7 960.9 1024.1 727.2 771.8 771.8 771.8 773.6 15054.5 15064.4 15165.1 15267.9 15320.5 13282.3 13287.2 13412.5 13422.1 13574.3 9929.6 9942.3 9957.2 10361.0 10379.0 3600.2 3645.3 3647.7 3671.0 3713.9 79458.6 81491.8 83022.0 83178.0 83205.0 8239.9 9741.6 9789.8 9846.1 10246.5 18455.0 19180.0 21588.6 22379.4 22463.8 6461.3 7886.4 7898.3 8010.4 8207.3 4020.8 4032.5 4042.2 4073.0 4321.6 3247.5 3774.9 3782.3 3808.5 3848.7 690.5 724.5 728.7 753.5 759.9 521.5 533.9 577.3 606.3 622.6 7927.8 8452.4 8601.1 8620.0 8747.9 592.2 605.9 621.1 632.5 638.1 4078.7 4305.5 4307.6 4426.2 4435.6 96286.0 97327.5 97531.5 98014.0 100330.0 78106.0 78394.6 78549.6 79005.6 79024.6 66004.7 66320.7 71307.0 73753.3 75569.1 7943.9 8145.7 8581.4 8761.6 8935.1 45465.1 45862.5 46734.0 48209.0 52026.2 47584.5 64887.7 68877.7 69048.7 70354.3 11101.4 11242.1 11439.0 11532.8 11546.4 11890.1 11991.3 12174.1 12182.2 12481.1 11573.0 11704.6 11715.7 11800.8 11997.5 11629.4 11667.4 11786.4 11979.6 12030.0 9948.7 10105.3 11604.3 11667.9 12186.9 9762.2 10123.6 10200.6 10278.6 10313.7 8767.7 9869.7 10100.4 10195.2 10238.0 01:46:17 INFO - PROCESS | 1664 | -------- Summary: end -------- 01:46:17 INFO - PROCESS | 1664 | 01:46:17 INFO - TEST-INFO | 1664: exit 0 01:46:17 INFO - TEST-OK | dromaeo_css | took 1109884ms 01:46:17 INFO - TEST-START | kraken 01:46:17 INFO - operating with platform_type : mac_ 01:46:17 INFO - Initialising browser for kraken test... 01:46:17 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpyEjmYi/profile http://localhost:49277/getInfo.html) 01:46:20 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 01:46:20 INFO - PROCESS | 1676 | colorDepth:24 01:46:20 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 01:46:20 INFO - PROCESS | 1676 | __metrics 01:46:20 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 01:46:21 INFO - TEST-INFO | 1676: exit 0 01:46:21 INFO - Browser initialized. 01:46:21 INFO - Running cycle 1/1 for kraken test... 01:46:21 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpyEjmYi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:46:33 INFO - PROCESS | 1680 | RSS: Main: 171208704 01:46:33 INFO - PROCESS | 1680 | 01:46:35 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 01:46:36 INFO - PROCESS | 1680 | RSS: Main: 183627776 01:46:36 INFO - PROCESS | 1680 | 01:46:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 01:46:39 INFO - PROCESS | 1680 | RSS: Main: 192249856 01:46:39 INFO - PROCESS | 1680 | 01:46:42 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 01:46:43 INFO - PROCESS | 1680 | RSS: Main: 196313088 01:46:43 INFO - PROCESS | 1680 | 01:46:45 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 01:46:46 INFO - PROCESS | 1680 | RSS: Main: 197599232 01:46:46 INFO - PROCESS | 1680 | 01:46:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:46:48 INFO - PROCESS | 1680 | RSS: Main: 197902336 01:46:48 INFO - PROCESS | 1680 | 01:46:51 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 01:46:52 INFO - PROCESS | 1680 | RSS: Main: 197660672 01:46:52 INFO - PROCESS | 1680 | 01:46:55 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 01:46:56 INFO - PROCESS | 1680 | RSS: Main: 197447680 01:46:56 INFO - PROCESS | 1680 | 01:46:58 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 01:46:59 INFO - PROCESS | 1680 | RSS: Main: 197980160 01:46:59 INFO - PROCESS | 1680 | 01:47:01 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:47:01 INFO - PROCESS | 1680 | RSS: Main: 197783552 01:47:01 INFO - PROCESS | 1680 | 01:47:03 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:47:04 INFO - PROCESS | 1680 | RSS: Main: 197799936 01:47:04 INFO - PROCESS | 1680 | 01:47:06 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:47:07 INFO - PROCESS | 1680 | RSS: Main: 197783552 01:47:07 INFO - PROCESS | 1680 | 01:47:10 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:47:10 INFO - PROCESS | 1680 | RSS: Main: 197976064 01:47:10 INFO - PROCESS | 1680 | 01:47:13 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:47:14 INFO - PROCESS | 1680 | RSS: Main: 197869568 01:47:14 INFO - PROCESS | 1680 | 01:47:15 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 01:47:16 INFO - PROCESS | 1680 | RSS: Main: 199921664 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | __start_tp_report 01:47:16 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 01:47:16 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 01:47:16 INFO - PROCESS | 1680 | |i|pagename|runs| 01:47:16 INFO - PROCESS | 1680 | |0;ai-astar;116;110;117;117;121;130;115;114;120;132 01:47:16 INFO - PROCESS | 1680 | |1;audio-beat-detection;153;119;138;167;123;172;153;185;153;118 01:47:16 INFO - PROCESS | 1680 | |2;audio-dft;195;194;194;197;195;198;197;196;203;188 01:47:16 INFO - PROCESS | 1680 | |3;audio-fft;66;76;73;164;54;61;84;100;154;56 01:47:16 INFO - PROCESS | 1680 | |4;audio-oscillator;79;81;124;77;81;126;119;79;80;127 01:47:16 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;111;78;134;88;88;84;89;87;88;85 01:47:16 INFO - PROCESS | 1680 | |6;imaging-darkroom;94;119;149;148;94;94;104;93;108;148 01:47:16 INFO - PROCESS | 1680 | |7;imaging-desaturate;92;93;90;92;101;136;92;90;89;110 01:47:16 INFO - PROCESS | 1680 | |8;json-parse-financial;57;61;63;65;64;65;63;95;94;87 01:47:16 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;73;95;96;102;61;95;101;82;94;93 01:47:16 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;99;104;74;100;108;105;102;70;93;107 01:47:16 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;127;124;130;117;128;126;123;131;178;166 01:47:16 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;164;166;157;164;160;165;163;169;161;167 01:47:16 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;68;67;68;66;67;69;84;100;97;101 01:47:16 INFO - PROCESS | 1680 | __end_tp_report 01:47:16 INFO - PROCESS | 1680 | __start_cc_report 01:47:16 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1040 01:47:16 INFO - PROCESS | 1680 | __end_cc_report 01:47:16 INFO - PROCESS | 1680 | __startTimestamp1466498836178__endTimestamp 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | ------- Summary: start ------- 01:47:16 INFO - PROCESS | 1680 | Number of tests: 14 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:119.20 Median:118.50 stddev:6.94 (5.9%) stddev-sans-first:7.26 01:47:16 INFO - PROCESS | 1680 | Values: 116.0 110.0 117.0 117.0 121.0 130.0 115.0 114.0 120.0 132.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:153.00 stddev:23.21 (15.2%) stddev-sans-first:24.55 01:47:16 INFO - PROCESS | 1680 | Values: 153.0 119.0 138.0 167.0 123.0 172.0 153.0 185.0 153.0 118.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:195.70 Median:196.50 stddev:3.77 (1.9%) stddev-sans-first:3.99 01:47:16 INFO - PROCESS | 1680 | Values: 195.0 194.0 194.0 197.0 195.0 198.0 197.0 196.0 203.0 188.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:88.80 Median:63.50 stddev:39.51 (62.2%) stddev-sans-first:41.03 01:47:16 INFO - PROCESS | 1680 | Values: 66.0 76.0 73.0 164.0 54.0 61.0 84.0 100.0 154.0 56.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:79.00 stddev:23.10 (29.2%) stddev-sans-first:23.53 01:47:16 INFO - PROCESS | 1680 | Values: 79.0 81.0 124.0 77.0 81.0 126.0 119.0 79.0 80.0 127.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:87.50 stddev:16.67 (19.1%) stddev-sans-first:16.39 01:47:16 INFO - PROCESS | 1680 | Values: 111.0 78.0 134.0 88.0 88.0 84.0 89.0 87.0 88.0 85.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:115.10 Median:121.00 stddev:24.33 (20.1%) stddev-sans-first:24.58 01:47:16 INFO - PROCESS | 1680 | Values: 94.0 119.0 149.0 148.0 94.0 94.0 104.0 93.0 108.0 148.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:98.50 Median:91.00 stddev:14.67 (16.1%) stddev-sans-first:15.37 01:47:16 INFO - PROCESS | 1680 | Values: 92.0 93.0 90.0 92.0 101.0 136.0 92.0 90.0 89.0 110.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:71.40 Median:65.00 stddev:14.55 (22.4%) stddev-sans-first:14.47 01:47:16 INFO - PROCESS | 1680 | Values: 57.0 61.0 63.0 65.0 64.0 65.0 63.0 95.0 94.0 87.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:89.20 Median:93.50 stddev:13.18 (14.1%) stddev-sans-first:12.61 01:47:16 INFO - PROCESS | 1680 | Values: 73.0 95.0 96.0 102.0 61.0 95.0 101.0 82.0 94.0 93.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:96.20 Median:89.00 stddev:13.50 (15.2%) stddev-sans-first:14.28 01:47:16 INFO - PROCESS | 1680 | Values: 99.0 104.0 74.0 100.0 108.0 105.0 102.0 70.0 93.0 107.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:129.00 stddev:20.09 (15.6%) stddev-sans-first:21.10 01:47:16 INFO - PROCESS | 1680 | Values: 127.0 124.0 130.0 117.0 128.0 126.0 123.0 131.0 178.0 166.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:164.50 stddev:3.53 (2.1%) stddev-sans-first:3.75 01:47:16 INFO - PROCESS | 1680 | Values: 164.0 166.0 157.0 164.0 160.0 165.0 163.0 169.0 161.0 167.0 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.70 Median:68.00 stddev:15.17 (22.3%) stddev-sans-first:15.59 01:47:16 INFO - PROCESS | 1680 | Values: 68.0 67.0 68.0 66.0 67.0 69.0 84.0 100.0 97.0 101.0 01:47:16 INFO - PROCESS | 1680 | -------- Summary: end -------- 01:47:16 INFO - PROCESS | 1680 | 01:47:16 INFO - TEST-INFO | 1680: exit 0 01:47:16 INFO - TEST-OK | kraken | took 59170ms 01:47:16 INFO - SUITE-END | took 1169s 01:47:17 INFO - Completed test suite (00:19:29) 01:47:17 INFO - javascript benchmark 01:47:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.296591783891, 3590.874319398821, 3663.1025398777306, 3706.9073273168174, 3729.73891827572, 5692.743826527806, 5700.543956483477, 5725.427457254273, 5733.426657334269, 5734.397888221739, 5711.571632127597, 5752.28096487939, 5772.711364431782, 5774.422557744224, 5788.594798364116, 4801.783919723621, 5140.563052140563, 5225.738713064351, 5251.133562962106, 5260.605454590902, 5144.279800827887, 5207.427183009866, 5245.527902488775, 5284.2866213061125, 5331.920021199685, 5257.921131183035, 5264.842054738364, 5269.394019687727, 5301.946980530184, 5305.0, 5105.617078719111, 5245.108331583621, 5253.343332083489, 5260.815871444481, 5299.125644268691, 5081.898362032739, 5102.591792656615, 5112.130937740593, 5162.535371816554, 5169.966006798618, 5532.972335138298, 5601.935632229864, 5629.9437005629825, 5650.067738823089, 5691.971540142315, 6131.284916201108, 6157.107219453199, 6287.937120628781, 6295.811125666191, 6296.464800491918, 5395.78416863325, 6006.339302676702, 6138.357744607947, 6218.160548325964, 6251.624902505819, 5811.88376232473, 5870.412958704138, 5881.500072493843, 5916.0238560637445, 5928.87351403232, 6211.3167551569295, 6221.875562488724, 6224.221972253468, 6230.563860529719, 6275.466585340206, 6176.907346389808, 6203.131561581382, 6212.254529456494, 6237.1891654084675, 6251.093591429218, 6242.15730876335, 6254.8123556293385, 6263.185785847902, 6278.686065696788, 6282.528810339243, 6052.878942421127, 6113.57204995655, 6170.012797952306, 6182.969085154546, 6232.220972378453, 6155.507559395238, 6216.378362163748, 6242.375762423812, 6250.718717657716, 6253.781117660951, 4442.911486685783, 4974.303597496353, 4976.701397916064, 5000.1749711297225, 5011.4236862761245, 4379.364992076131, 4401.581849724271, 4417.580329868657, 4493.415855938707, 4547.590716835501, 4851.611871050308, 5898.764049437975, 5899.557533185029, 5946.762129514857, 6076.75692972285, 5662.0, 6253.593516421418, 6255.812325630239, 6258.843528911813, 6275.654838983808, 4904.6321525885705, 5842.503387212049, 5943.821685349447, 6077.270727512727, 6104.2064531611495, 5373.489518495737, 5424.864378390493, 5425.891482170414, 5427.891442171134, 5438.15708565173, 6290.528210384148, 6410.1987251593555, 6421.422072013541, 6433.324500927335, 6438.356164383524, 6172.938270617236, 6231.906521402092, 6236.126942228001, 6247.406496382836, 6249.531285153541, 5435.945640543544, 6462.224533056064, 6480.189976252968, 6504.837379065561, 6578.539502234989, 6013.488853447506, 6113.050656958906, 6221.564490485623, 6237.656928868956, 6265.373462653698, 6210.627362358273, 6264.655443950444, 6271.122042913905, 6272.968635156795, 6294.055891616111, 5183.0, 6065.272167339947, 6096.756129754937, 6161.630302181883, 6197.442230199304, 5979.372165922689, 6035.698215089315, 6090.634561926298, 6125.17440701618, 6159.0, 5845.386234445322, 5946.910796338145, 5978.043513037893, 6013.969930150496, 6019.939800601938, 5999.760009599567, 6156.661383623944, 6159.72281247336, 6167.383261673796, 6178.752849885954, 5965.194698715792, 6022.126791615104, 6022.1870047543025, 6023.397660233942, 6070.969645151746], "value": 5712.3216877971745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.5410266017235, 552.6131707804537, 563.2143160291391, 598.9548238324123, 614.3978900677336, 40777.0, 41726.37410438842, 41897.16205675885, 41919.580804192025, 41927.37108943365, 43001.56998430015, 43706.0, 43711.68864934049, 43714.78142609283, 43818.56181438185, 9604.039596040393, 9730.805383892319, 9771.75570610737, 9850.753731156707, 9859.852102218472, 9870.259730520203, 9934.105930466256, 9960.05379488951, 9991.550380232908, 10007.649732259373, 8919.509426981513, 9934.35426697266, 9961.850572241387, 9987.201023918105, 9991.150752186073, 8868.600912958933, 9984.0, 9987.35082219657, 10017.098461138532, 10041.548130334153, 8389.454685445487, 9764.462954537497, 9788.168005719523, 9872.062154095349, 9879.357841740335, 41469.0, 41942.58057419448, 42102.0, 42469.93825154365, 42710.57289427097, 3052.435299469605, 3272.885449009297, 3351.6983471487683, 3425.2635683328203, 3504.211552400715, 29835.95574154894, 30280.394392112034, 30457.69542304571, 30845.845770771004, 32454.0, 2825.6044153818275, 2826.025021367625, 2851.871665775045, 2872.310645445099, 2907.651081870168, 428882.0, 430890.0, 431182.0, 431424.0, 433918.8304058491, 37963.62036379656, 69220.3077969224, 69390.0, 69506.65246673735, 69709.99999999898, 37664.81167594199, 37835.432468513, 37888.0, 37894.62105378966, 37938.62061379351, 16847.41034063802, 16985.23566439513, 16993.32026718942, 17163.485095447155, 17233.827661723473, 14105.0, 14489.420423183166, 14542.927285363505, 14568.198749068692, 14693.0, 8426.115257897955, 8684.696035638723, 8750.781230469289, 8798.988116366572, 8811.0, 3177.253345463814, 3576.0523461282783, 3600.98199509006, 3605.4952306677087, 3651.653092956165, 968.7674958010168, 1041.557338131291, 1091.8198497248025, 1128.5542210826677, 1143.4854315558032, 27222.319442014108, 29994.25014374658, 31114.68885311118, 31152.844235778677, 31784.36431271408, 1140.503880811833, 1176.394157009141, 1252.8263462891875, 1278.8401449818773, 1286.601153642374, 15693.921530392276, 15788.447404340794, 15936.840631593535, 16394.0, 16509.504714858333, 585506.0, 621115.0, 636568.8171559112, 640155.0, 640836.7958160179, 66426.66786666133, 66876.6656166716, 66889.66555167291, 67574.66212668906, 67752.0, 1546.621077835915, 1612.258361153859, 1623.0342945947143, 1640.6554623528955, 1646.802383713938, 31058.53412198864, 31245.531317029807, 31481.8425907869, 31898.043058708277, 32099.0, 59026.11460828177, 64350.67824660847, 65655.67172164109, 66013.0, 66267.66866165638, 596607.0, 602292.0, 605909.0, 606497.0, 608635.0, 44874.87812804706, 45495.54504454913, 47622.28566571573, 47729.28406073842, 47824.282635761185, 49917.50082499274, 49970.500294996586, 50498.49501505085, 51185.23222151745, 52264.0, 37951.86144415672, 38081.61918380781, 38421.6157838418, 38713.612863871, 40240.0, 39538.80230598828, 39925.0, 39994.20011599694, 40184.39723404093, 40188.99527511836, 35283.11792205215, 38953.610463895, 40213.798931005156, 40274.993125170935, 40500.98747531218, 34446.13884652904, 36476.45285320669, 37031.444528332635, 37036.074098147765, 37107.07232319214, 25342.0, 26073.73926260713, 27160.72839271582, 27347.58978615362, 27486.725132749216], "value": 19970.99863277704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.88535652695504, 418.19080080045103, 419.96640268778503, 426.0817937345022, 426.7375564028122, 16142.83857161428, 16531.586710332234, 20638.17447302108, 21482.92585370731, 22041.0, 11993.100517461204, 12038.036957043416, 12491.625251242454, 21111.68332475014, 21520.569588608218, 5580.832575022756, 5629.831105066854, 5732.0542110551705, 5792.420757924195, 5797.478226959573, 5996.0, 6328.177336946191, 6330.556861019731, 6332.936670633281, 6339.04914262862, 5651.095824668054, 6160.969195154018, 6282.52881033922, 6303.369663033705, 6308.621482711029, 5643.887122257553, 5644.745986430579, 5646.971765141189, 5724.313082430093, 5778.191053252548, 5364.953834002371, 5632.155176723483, 5636.0, 5639.915401268984, 5666.121751128581, 14182.0, 16701.749473757904, 22197.334079977627, 22202.555948881094, 23509.294721158392, 2095.3609149209483, 2215.579039982414, 2227.5878962392007, 2291.3698732848434, 2798.8460634665084, 8573.571321433903, 9967.252456065824, 10293.228007899363, 10393.116585090276, 10433.739156521071, 1594.7528133139383, 1821.3625231168985, 1827.7075667893073, 1857.182839550607, 1901.0494752623688, 113755.0, 115142.84857151406, 127020.0, 128464.0, 129243.0, 10604.522796474177, 12032.81950770739, 12123.33321667299, 12417.875821241672, 12453.25280483174, 15563.455279065178, 15585.68828623444, 15606.219689015505, 16114.516564503083, 16204.59488512773, 7711.305982461606, 9034.503102329434, 9528.142467177848, 9557.952210238904, 9561.426314421156, 7836.686532538634, 9462.384944978554, 9477.0, 9548.331616786758, 9650.179734722487, 4901.36282283308, 4934.407871055496, 4948.628852836052, 4953.8018479261145, 5017.197248440232, 1816.9454916352265, 2022.5247066939257, 2116.915323387078, 2132.3709505695856, 2160.60028894655, 940.8870935487786, 963.9373440726471, 1007.2345017786535, 1008.7679833638305, 1060.824963880951, 21190.19883309936, 21217.363479095653, 21281.255156069463, 21798.891005544872, 21925.561488770134, 987.8172538080478, 1032.1226957086417, 1043.6034306963306, 1096.736783172033, 1117.804384232756, 11381.260218085798, 11744.471498782576, 11765.647030589096, 11783.293002419883, 11790.292582445081, 497712.0, 505272.0, 506484.0, 512076.0, 518909.0, 88323.0, 110506.0, 117906.41046794882, 124438.13342799865, 130792.0, 1016.8169729448771, 1025.9692209233735, 1044.6291566493785, 1045.2056437107854, 1050.417018554694, 19273.807261927202, 19679.31122410709, 19835.702464463335, 19838.603227935073, 20042.0, 53340.0, 53860.46139538711, 54411.72794136004, 54416.82332706647, 54506.0, 64057.0, 72678.63660681662, 76259.47481050459, 80092.79860802209, 82049.0, 8446.66213351459, 8573.61418736146, 8631.007434144902, 8738.257248133725, 8901.97627272846, 8873.378863479753, 12351.961926282063, 12946.676333091747, 13108.672283192996, 13361.331933403097, 11009.724756881142, 11229.091054520915, 11239.13000218895, 11240.213185076966, 11470.942645286721, 11159.721006974565, 11291.548338066385, 11480.081593472669, 11566.016888564229, 11656.365576985267, 11664.708382290512, 11817.763644726885, 11841.703957401134, 11917.76164476723, 12057.191421286878, 8505.404621676424, 8606.78483037929, 8617.353698472514, 8623.827523449621, 8730.388872778845, 11193.216474846682, 11721.941390292994, 11742.647720568397, 11906.404679765803, 12016.759664806481], "value": 9672.036096260019, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1658.0880515716353, 1683.7137686593283, 2002.2991952816517, 2053.9178432862695, 2155.946101347467, 8218.753437396872, 8577.957110214456, 8983.775405614862, 9196.95401522993, 9219.262459003281, 8887.0, 8894.377393582452, 8907.643694252238, 9022.323325750562, 9031.142041506062, 2499.0503608628696, 2503.899844006242, 2521.2562294123277, 2533.898644054236, 2535.1887396033276, 2520.6471094046847, 2559.1298958354155, 2567.3068271566667, 2575.060103062378, 2575.613657951313, 2519.433127546306, 2528.759767822063, 2531.556977528934, 2535.987320063397, 2563.2566555698827, 2111.9366419007456, 2494.625806129086, 2529.810264230181, 2544.7836933860644, 2556.4759224358963, 2189.3541405285478, 2484.813638977084, 2507.987460062688, 2509.0716434919013, 2574.124797568817, 8708.21626053652, 8736.912630873738, 8792.076831932683, 8800.515971621558, 8822.11778822119, 5315.760790764425, 5496.928099020693, 5535.833924982257, 5623.381428042912, 5758.6544807311275, 3161.3203161320425, 3246.2209069823307, 3479.408500554912, 3678.786000619789, 3791.620837916214, 1080.9621663241749, 1081.1999120650742, 1097.0620119797618, 1100.3617901617042, 1104.4808939798363, 11967.982721468685, 12162.51349946001, 12208.938955305166, 12231.021518278516, 12265.754684906342, 4956.0, 5037.319961805183, 5057.848264552069, 5085.898282034339, 5124.9743751281, 10527.21045921559, 10549.630762923261, 10600.469976501145, 10654.414007229676, 10666.94666526678, 5620.1569764534825, 5697.886042279214, 5733.054046082433, 5764.13537969308, 5793.188953546507, 4659.254519276968, 5042.218456139304, 5084.7966081356335, 5118.206677964921, 5194.32473778414, 4254.234237837157, 4296.957030429656, 4319.308910574293, 4329.978350108229, 4400.69195156336, 1390.1867407566688, 1420.4815242436437, 1422.459465403161, 1427.357689039936, 1429.9499517516838, 951.923846092311, 992.6525715999343, 994.080475560104, 994.5226291380178, 1009.9848502272472, 5958.761649534057, 5981.641101533922, 6034.63792172471, 6080.8783824324155, 6157.415045570664, 483.1713611156883, 489.9902001959941, 490.977905994224, 496.9204927211629, 500.96743711658627, 3923.489946306962, 3967.285888540033, 4020.0954785173103, 4041.0503531670033, 4079.02103495159, 10504.894951050392, 10842.96991785779, 10861.13110951122, 10893.564257429614, 10951.945240273906, 10510.159187265, 10547.947260263649, 10678.145748340114, 10698.839517407245, 10808.405537695502, 8166.020077590727, 8347.248747612866, 8450.154984501502, 8507.404481686346, 8540.957295213608, 5331.280277162534, 5932.851678708067, 5944.87047460981, 6096.634201947897, 6121.326654068138, 9264.166225039779, 9576.712698619052, 9710.417374957526, 9748.610055597697, 9875.901240987498, 9223.677171298972, 9813.509324533887, 9820.214382849212, 9969.700908972742, 9991.950040249752, 6873.831448653841, 7100.573965562083, 7252.129744430491, 7295.598742069237, 7944.205579442009, 7253.673584688807, 7576.711958966878, 8388.245057944814, 8465.449745766506, 8478.957605211934, 7414.740484083031, 7486.438517111347, 7574.356179724785, 7599.430042746705, 7670.232976702285, 7380.520266182681, 7421.888671670037, 7489.737859174903, 7497.550146991198, 7552.471327007276, 7096.361327480345, 7099.964500177466, 7127.928720712726, 7140.178879428724, 7156.355927966508, 4907.312976183266, 4978.601711863114, 5064.215046667772, 5073.7716802743225, 5106.897862042664, 5055.87360315995, 5109.897802044013, 5111.5910727141, 5184.0, 5322.38792538863], "value": 4666.496976742784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.95800524934384, 337.8294458106664, 338.46860429126275, 345.2404709638794, 346.68451708944866, 5792.275965504312, 6328.557001009925, 6576.243731970825, 6684.5989240645595, 6758.560693554916, 5712.8857422851515, 5852.67810270435, 6664.700088496017, 6676.799696009115, 6703.698333574988, 5002.724850133251, 5026.0, 5027.472115427864, 5030.220315851049, 5034.219695947134, 4351.934720979188, 5033.823816166435, 5045.0, 5060.5951523878, 5071.568916642072, 4993.650444468889, 4996.200607902736, 5001.524855138774, 5005.474425185358, 5033.748312584375, 3997.940030899553, 4839.419269687624, 4980.676256043345, 4985.950140498585, 5014.799408023675, 3889.572147063821, 3899.005753532859, 4238.660907127422, 4262.531121576624, 4280.700350975433, 6394.328595497453, 6427.807165785034, 6432.614043157426, 6436.356364363526, 6442.871142577169, 5844.357120716718, 5903.0555111182, 5909.23179986599, 5913.7930172444185, 5928.7628494860155, 7195.712171513185, 7196.1724401693955, 7197.172325182619, 7197.208307086216, 7232.638368081575, 4630.305454181866, 4796.832110876137, 4800.735959522225, 4803.207470767319, 4821.0357928414105, 6887.793366199022, 7566.205548417447, 7578.052743407075, 7619.199984001655, 7635.732749353746, 4872.926906096412, 4882.316475693406, 4887.560119589254, 4887.682300650446, 4894.975525122351, 4954.653174277838, 4969.850904472872, 4980.5019498049905, 4982.8754281143265, 4993.17612593918, 5887.646741195456, 5904.1734157218025, 5911.201987731687, 5912.349641539513, 5926.0, 5563.860903477445, 5967.820965370959, 7178.820529486805, 7263.656223598651, 7296.562206267535, 1689.0456891856063, 1703.897766134036, 1722.8707846911532, 1724.1896308734874, 1726.4475367882408, 1080.2168427889717, 1101.6419663609358, 1108.1190453589415, 1124.9550017999188, 1128.5937062657438, 5167.534921857051, 6497.635496545779, 6818.522703410813, 6850.828729281709, 6889.724411023603, 7497.775066748006, 7519.8496030079095, 7522.887156692654, 7524.774256772305, 7548.509346892434, 5617.43825617435, 5620.213170156181, 6928.722851086001, 6934.826629334206, 6948.895766563505, 3019.531972544259, 3420.452727563578, 3678.889633311005, 3908.413737939332, 3917.764934103963, 7713.6914523419555, 7969.083555391088, 7998.3201427879285, 8019.438639295194, 8088.595570221465, 7627.847443051219, 7655.425843061793, 7672.65473053714, 7688.077430708351, 7695.461317707706, 7914.604269786488, 7940.880886786703, 7968.083670377865, 7968.681252749825, 7986.480878742863, 7200.8919866201, 7424.628768561658, 7429.702811887464, 7457.701691932479, 7489.550626962399, 5861.9413805861395, 7220.133583969957, 7292.650859590993, 7304.233055529306, 7324.121105467378, 7944.6822127114265, 7947.284744373034, 7977.0, 7978.640961156878, 7989.760307190793, 4784.258439941815, 4784.425868895755, 4792.496787837227, 4794.376731024944, 4806.543378379049, 7219.494635375473, 7326.9267307326245, 7402.518836275625, 7430.591317477374, 7450.8882366763455, 7130.322619351154, 7146.857062858818, 7163.31948464895, 7185.353318201387, 7188.173360063451, 6831.316868313328, 7162.856742865009, 7169.139703235645, 7187.820304492429, 7209.531380460253, 5101.821436249714, 6992.1259842519685, 6994.160700715743, 7014.403775679124, 7016.36852683261, 6932.341427564374, 7114.253003434565, 7134.286571342825, 7159.498835081703, 7195.8920616191845, 6758.357955994173, 6831.658417079226, 7043.0, 7043.788686339418, 7069.858602828018], "value": 5238.792556739978, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.9166345870226, 773.6479901644752, 782.7573452229807, 788.7633709887033, 797.4577287444539, 15169.317380717866, 15443.768343474829, 15494.147821869807, 15494.225288735575, 15517.068975861455, 14411.495597654084, 14417.990740648158, 14458.349374278156, 14467.131972081683, 14469.638259043502, 786.4887822915093, 934.1125930366145, 935.4153653966271, 942.9057094290584, 956.8756061711968, 910.8360495110877, 948.2556193388192, 951.8762560867112, 958.8849338079406, 978.1685567267801, 963.3545524498603, 997.3666721631744, 1011.9949400252989, 1012.7366884610018, 1023.9846402303934, 957.3585697582602, 958.0, 959.6641175588558, 960.8798900137483, 1024.0578667625764, 727.1891840597748, 771.7684694591657, 771.7761849063764, 771.8301973565807, 773.6402572803617, 15054.473093441786, 15064.397424103023, 15165.090094594249, 15267.923660381739, 15320.540383788504, 13282.3358832058, 13287.20276783396, 13412.530561430303, 13422.127561708458, 13574.321283935862, 9929.602815887356, 9942.254330925209, 9957.203423726085, 10361.015703508154, 10379.0, 3600.1899572596217, 3645.2527231917657, 3647.689946354563, 3671.0, 3713.851445942159, 79458.60270698667, 81491.7776233357, 83022.0, 83178.0, 83205.0, 8239.887615171876, 9741.610335586638, 9789.825495711018, 9846.113849753556, 10246.48767561619, 18455.0, 19180.040997950047, 21588.56822863534, 22379.440513986956, 22463.775362246495, 6461.321561236096, 7886.44794864354, 7898.2891539761695, 8010.439269251213, 8207.302379297707, 4020.7587544747407, 4032.4556184915245, 4042.15114825884, 4072.9592704073175, 4321.567843215653, 3247.464168412233, 3774.9056273592832, 3782.2813665403487, 3808.485854409619, 3848.692104631623, 690.5338896245115, 724.4928550015011, 728.6830228850467, 753.5290443472829, 759.9164091949881, 521.4681025354193, 533.906566350887, 577.336063526939, 606.2512796696077, 622.5548732656082, 7927.841443171104, 8452.408331416742, 8601.139886011473, 8620.00869899957, 8747.868781968276, 592.2301008688687, 605.9303180134253, 621.1304174156127, 632.4940047961612, 638.090720722968, 4078.6737061035046, 4305.526392096866, 4307.612314891675, 4426.15902978433, 4435.645148388121, 96286.0, 97327.51336243273, 97531.51234243784, 98014.0, 100330.0, 78106.04734881673, 78394.60802696065, 78549.60725196337, 79005.60497197477, 79024.60487697525, 66004.66997665077, 66320.66839665867, 71307.0, 73753.26246737571, 75569.11077223004, 7943.887855700091, 8145.67417303325, 8581.399302049047, 8761.649534018823, 8935.061818508962, 45465.09069818651, 45862.541374585824, 46734.0, 48209.0, 52026.21960670668, 47584.52415475801, 64887.67556162189, 68877.65561172162, 69048.6547567259, 70354.29645703477, 11101.444927753419, 11242.100631949588, 11439.0, 11532.827007594726, 11546.364949927834, 11890.10824188172, 11991.340476273888, 12174.086943479097, 12182.208156470155, 12481.063920206203, 11573.0, 11704.590339338423, 11715.707107322385, 11800.822987655363, 11997.520099195934, 11629.418529073682, 11667.35829529384, 11786.410679466164, 11979.580714674945, 12030.0, 9948.651797187063, 10105.343152695052, 11604.30374177552, 11667.941660291644, 12186.878131218575, 9762.17021553176, 10123.64567240143, 10200.591976320864, 10278.640247591298, 10313.74215644615, 8767.736967890718, 9869.654562090293, 10100.444475553915, 10195.23535734808, 10238.0], "value": 7104.335948980667, "unit": "score"}], "name": "dromaeo_css", "value": 7593.0938777338015, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 117.0, 117.0, 121.0, 130.0, 115.0, 114.0, 120.0, 132.0], "value": 119.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 119.0, 138.0, 167.0, 123.0, 172.0, 153.0, 185.0, 153.0, 118.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 194.0, 194.0, 197.0, 195.0, 198.0, 197.0, 196.0, 203.0, 188.0], "value": 195.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 76.0, 73.0, 164.0, 54.0, 61.0, 84.0, 100.0, 154.0, 56.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 124.0, 77.0, 81.0, 126.0, 119.0, 79.0, 80.0, 127.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 78.0, 134.0, 88.0, 88.0, 84.0, 89.0, 87.0, 88.0, 85.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 119.0, 149.0, 148.0, 94.0, 94.0, 104.0, 93.0, 108.0, 148.0], "value": 115.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 90.0, 92.0, 101.0, 136.0, 92.0, 90.0, 89.0, 110.0], "value": 98.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 63.0, 65.0, 64.0, 65.0, 63.0, 95.0, 94.0, 87.0], "value": 71.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 95.0, 96.0, 102.0, 61.0, 95.0, 101.0, 82.0, 94.0, 93.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 104.0, 74.0, 100.0, 108.0, 105.0, 102.0, 70.0, 93.0, 107.0], "value": 96.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 130.0, 117.0, 128.0, 126.0, 123.0, 131.0, 178.0, 166.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 157.0, 164.0, 160.0, 165.0, 163.0, 169.0, 161.0, 167.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 67.0, 69.0, 84.0, 100.0, 97.0, 101.0], "value": 78.7, "unit": "score"}], "name": "kraken", "value": 1590.0, "alertThreshold": 2.0}]} 01:47:17 INFO - Return code: 0 01:47:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:47:17 ERROR - # TBPL SUCCESS # 01:47:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:47:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:47:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:47:17 INFO - 2016-06-21 01:47:17.462 screenresolution[1685:10240] starting screenresolution argv=screenresolution get 01:47:17 INFO - 2016-06-21 01:47:17.465 screenresolution[1685:10240] Display 0: 1600x1200x32@60 01:47:17 INFO - 2016-06-21 01:47:17.471 screenresolution[1686:10243] starting screenresolution argv=screenresolution list 01:47:17 INFO - Available Modes on Display 0 01:47:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:47:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:47:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:47:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:47:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:47:17 INFO - Intel Iris: 01:47:17 INFO - Chipset Model: Intel Iris 01:47:17 INFO - Type: GPU 01:47:17 INFO - Bus: Built-In 01:47:17 INFO - VRAM (Dynamic, Max): 1536 MB 01:47:17 INFO - Vendor: Intel (0x8086) 01:47:17 INFO - Device ID: 0x0a2e 01:47:17 INFO - Revision ID: 0x0009 01:47:17 INFO - Displays: 01:47:17 INFO - Display: 01:47:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:47:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:47:17 INFO - Display Serial Number: 1600x1200 60 01:47:17 INFO - Main Display: Yes 01:47:17 INFO - Mirror: Off 01:47:17 INFO - Online: Yes 01:47:17 INFO - Rotation: Supported 01:47:17 INFO - Return code: 0 01:47:17 INFO - Running post-action listener: _resource_record_post_action 01:47:17 INFO - Running post-run listener: _resource_record_post_run 01:47:18 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 38057472; Write bytes: 494479872; Read time: 388; Write time: 1536 01:47:18 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 278528; Write bytes: 195573248; Read time: 5; Write time: 395 01:47:18 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 36234752; Write bytes: 298058752; Read time: 368; Write time: 1139 01:47:18 INFO - Running post-run listener: _upload_blobber_files 01:47:18 INFO - Blob upload gear active. 01:47:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:47:18 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:47:18 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:47:18 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:47:19 INFO - (blobuploader) - INFO - Open directory for files ... 01:47:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:47:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:47:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:47:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:47:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:47:19 INFO - (blobuploader) - INFO - Done attempting. 01:47:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:47:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:47:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:47:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:47:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:47:21 INFO - (blobuploader) - INFO - Done attempting. 01:47:21 INFO - (blobuploader) - INFO - Iteration through files over. 01:47:21 INFO - Return code: 0 01:47:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:47:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:47:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f65dcbdd5cf7eccb99e608e5359f484c490f4216f57983cec8c1ecb9e20323a70644ece1503d70884c2dffd568e4f42796710ab109d5c2444d5a0cf8c30e9d99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae5e777e4a4687cba205bc3c438de53d9c3b37b3f0ab71999f1f407c0d53ed0531f045e373be6e6afa8a1c6ba08217fe2113f21a9d855213074669ea85a0931b"} 01:47:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:47:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:47:21 INFO - Contents: 01:47:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f65dcbdd5cf7eccb99e608e5359f484c490f4216f57983cec8c1ecb9e20323a70644ece1503d70884c2dffd568e4f42796710ab109d5c2444d5a0cf8c30e9d99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae5e777e4a4687cba205bc3c438de53d9c3b37b3f0ab71999f1f407c0d53ed0531f045e373be6e6afa8a1c6ba08217fe2113f21a9d855213074669ea85a0931b"} 01:47:21 INFO - Running post-run listener: copy_logs_to_upload_dir 01:47:21 INFO - Copying logs to upload dir... 01:47:21 INFO - mkdir: /builds/slave/test/build/upload/logs 01:47:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.613435 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-21 01:47:21.505787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 01:47:21.510475) ========= 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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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/Mozilla-Beta/sha512/f65dcbdd5cf7eccb99e608e5359f484c490f4216f57983cec8c1ecb9e20323a70644ece1503d70884c2dffd568e4f42796710ab109d5c2444d5a0cf8c30e9d99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae5e777e4a4687cba205bc3c438de53d9c3b37b3f0ab71999f1f407c0d53ed0531f045e373be6e6afa8a1c6ba08217fe2113f21a9d855213074669ea85a0931b"} build_url:https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010953 build_url: 'https://queue.taskcluster.net/v1/task/GXHMd--YTjOKyt7o2H8C-A/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f65dcbdd5cf7eccb99e608e5359f484c490f4216f57983cec8c1ecb9e20323a70644ece1503d70884c2dffd568e4f42796710ab109d5c2444d5a0cf8c30e9d99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae5e777e4a4687cba205bc3c438de53d9c3b37b3f0ab71999f1f407c0d53ed0531f045e373be6e6afa8a1c6ba08217fe2113f21a9d855213074669ea85a0931b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 01:47:21.542809) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:47:21.543161) ========= 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.4ub3lQvKz4/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.VGISE3B2Q5/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005287 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:47:21.591895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 01:47:21.592232) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 01:47:21.592574) ========= ========= Total master_lag: 0.18 =========