builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0214 starttime: 1466036833.49 results: success (0) buildid: 20160615151425 builduid: d1e7ffbdfca6425a90d05c60a342a1cb revision: da4a9eed33bdbc5f5bd1002cc07f998a1eb037fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:13.492086) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:13.492453) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:13.492735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:13.831520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:13.831787) ========= 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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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-15 17:27:13-- 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% 65.8M=0s 2016-06-15 17:27:14 (65.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.528489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:14.384484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:14.384772) ========= 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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.019852 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:14.432275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 17:27:14.432614) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev da4a9eed33bdbc5f5bd1002cc07f998a1eb037fa --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 da4a9eed33bdbc5f5bd1002cc07f998a1eb037fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z1RvgDZWEV/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.Ej0qW8Dery/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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-15 17:27:14,511 truncating revision to first 12 chars 2016-06-15 17:27:14,511 Setting DEBUG logging. 2016-06-15 17:27:14,512 attempt 1/10 2016-06-15 17:27:14,512 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/da4a9eed33bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 17:27:15,295 unpacking tar archive at: mozilla-beta-da4a9eed33bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.034104 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 17:27:15.491795) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:15.492510) ========= script_repo_revision: da4a9eed33bdbc5f5bd1002cc07f998a1eb037fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:15.493502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:15.494218) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 17:27:15.517634) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-06-15 17:27:15.517965) ========= /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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 17:27:15 INFO - MultiFileLogger online at 20160615 17:27:15 in /builds/slave/test 17:27:15 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 17:27:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:27:15 INFO - {'append_to_log': False, 17:27:15 INFO - 'base_work_dir': '/builds/slave/test', 17:27:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:27:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:27:15 INFO - 'branch': 'Mozilla-Beta', 17:27:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:27:15 INFO - 'config_files': ('talos/mac_config.py',), 17:27:15 INFO - 'default_actions': ('clobber', 17:27:15 INFO - 'read-buildbot-config', 17:27:15 INFO - 'download-and-extract', 17:27:15 INFO - 'populate-webroot', 17:27:15 INFO - 'create-virtualenv', 17:27:15 INFO - 'install', 17:27:15 INFO - 'run-tests'), 17:27:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:27:15 INFO - 'download_minidump_stackwalk': True, 17:27:15 INFO - 'download_symbols': 'ondemand', 17:27:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:27:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:27:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:27:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:27:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:27:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:27:15 INFO - 'installer_path': 'installer.exe', 17:27:15 INFO - 'log_level': 'info', 17:27:15 INFO - 'log_name': 'talos', 17:27:15 INFO - 'log_to_console': True, 17:27:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:27:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:27:15 INFO - 'opt_config_files': (), 17:27:15 INFO - 'pip_index': False, 17:27:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:27:15 INFO - 'cmd': ('bash', 17:27:15 INFO - '-c', 17:27:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:27:15 INFO - 'enabled': True, 17:27:15 INFO - 'halt_on_failure': False, 17:27:15 INFO - 'name': 'check_screen_resolution'},), 17:27:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:27:15 INFO - 'cmd': ('bash', 17:27:15 INFO - '-c', 17:27:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:27:15 INFO - 'enabled': True, 17:27:15 INFO - 'halt_on_failure': False, 17:27:15 INFO - 'name': 'check_screen_resolution'},), 17:27:15 INFO - 'run_cmd_checks_enabled': True, 17:27:15 INFO - 'sps_profile': False, 17:27:15 INFO - 'sps_profile_interval': 0, 17:27:15 INFO - 'suite': 'dromaeojs-e10s', 17:27:15 INFO - 'system_bits': '32', 17:27:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:27:15 INFO - 'title': 't-yosemite-r7-0214', 17:27:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:27:15 INFO - 'use_talos_json': True, 17:27:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:27:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:27:15 INFO - 'work_dir': 'build'} 17:27:15 INFO - ##### 17:27:15 INFO - ##### Running clobber step. 17:27:15 INFO - ##### 17:27:15 INFO - Running pre-action listener: _resource_record_pre_action 17:27:15 INFO - Running main action method: clobber 17:27:15 INFO - rmtree: /builds/slave/test/build 17:27:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:27:17 INFO - Running post-action listener: _resource_record_post_action 17:27:17 INFO - ##### 17:27:17 INFO - ##### Running read-buildbot-config step. 17:27:17 INFO - ##### 17:27:17 INFO - Running pre-action listener: _resource_record_pre_action 17:27:17 INFO - Running main action method: read_buildbot_config 17:27:17 INFO - Using buildbot properties: 17:27:17 INFO - { 17:27:17 INFO - "project": "", 17:27:17 INFO - "product": "firefox", 17:27:17 INFO - "script_repo_revision": "production", 17:27:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 17:27:17 INFO - "repository": "", 17:27:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 17:27:17 INFO - "buildid": "20160615151425", 17:27:17 INFO - "pgo_build": "False", 17:27:17 INFO - "basedir": "/builds/slave/test", 17:27:17 INFO - "buildnumber": 24, 17:27:17 INFO - "slavename": "t-yosemite-r7-0214", 17:27:17 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 17:27:17 INFO - "platform": "yosemite_r7", 17:27:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:27:17 INFO - "branch": "mozilla-beta", 17:27:17 INFO - "repo_path": "releases/mozilla-beta", 17:27:17 INFO - "revision": "da4a9eed33bdbc5f5bd1002cc07f998a1eb037fa", 17:27:17 INFO - "stage_platform": "macosx64", 17:27:17 INFO - "builduid": "d1e7ffbdfca6425a90d05c60a342a1cb", 17:27:17 INFO - "slavebuilddir": "test" 17:27:17 INFO - } 17:27:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 17:27:17 INFO - Running post-action listener: _resource_record_post_action 17:27:17 INFO - ##### 17:27:17 INFO - ##### Running download-and-extract step. 17:27:17 INFO - ##### 17:27:17 INFO - Running pre-action listener: _resource_record_pre_action 17:27:17 INFO - Running main action method: download_and_extract 17:27:17 INFO - mkdir: /builds/slave/test/build/tests 17:27:17 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')]} 17:27:17 INFO - https://queue.taskcluster.net/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:27:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 17:27:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 17:27:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/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 17:27:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/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 17:27:33 INFO - Downloaded 1165 bytes. 17:27:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 17:27:33 INFO - Using the following test package requirements: 17:27:33 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 17:27:33 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:27:33 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 17:27:33 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:27:33 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 17:27:33 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:27:33 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:27:33 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 17:27:33 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 17:27:33 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:27:33 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 17:27:33 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:27:33 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 17:27:33 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:27:33 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 17:27:33 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 17:27:33 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 17:27:33 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 17:27: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')]} 17:27:33 INFO - https://queue.taskcluster.net/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:27:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:27:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:27:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/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 17:27:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/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 17:27:43 INFO - Downloaded 18300423 bytes. 17:27:43 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'] 17:27:43 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 17:27:46 INFO - Return code: 0 17:27:46 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 17: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')]} 17:27:46 INFO - https://queue.taskcluster.net/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:27:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:27:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 17:27:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/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 17:27:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/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 17:27:51 INFO - Downloaded 18300423 bytes. 17:27:51 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'] 17:27:51 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 17:27:54 INFO - Return code: 0 17:27: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')]} 17:27:54 INFO - https://queue.taskcluster.net/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:27:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 17:27:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 17:27:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/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 17:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/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 17:27:55 INFO - Downloaded 10840145 bytes. 17:27:55 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'] 17:27:55 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 17:27:56 INFO - Return code: 0 17:27:56 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')]} 17:27:56 INFO - https://queue.taskcluster.net/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 17:27:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:27:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:27:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 17:27:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/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 17:28:06 INFO - Downloaded 86245574 bytes. 17:28:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:28:06 INFO - mkdir: /builds/slave/test/properties 17:28:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:28:06 INFO - Writing to file /builds/slave/test/properties/build_url 17:28:06 INFO - Contents: 17:28:06 INFO - build_url:https://queue.taskcluster.net/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 17:28:07 INFO - Running post-action listener: _resource_record_post_action 17:28:07 INFO - Running post-action listener: set_extra_try_arguments 17:28:07 INFO - ##### 17:28:07 INFO - ##### Running populate-webroot step. 17:28:07 INFO - ##### 17:28:07 INFO - Running pre-action listener: _resource_record_pre_action 17:28:07 INFO - Running main action method: populate_webroot 17:28:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:28:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:28:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:28:07 INFO - '--tppagecycles', 17:28:07 INFO - '7'], 17:28:07 INFO - 'tests': ['tsvgm']}}, 17:28:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:28:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:28:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:28:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:28:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:28:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:28:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:07 INFO - 'talos_options': ['--disable-e10s'], 17:28:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:28:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:28:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:07 INFO - 'talos_options': ['--disable-e10s'], 17:28:07 INFO - 'tests': ['damp', 'tps']}, 17:28:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:07 INFO - 'tests': ['damp', 'tps']}, 17:28:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:28:07 INFO - 'tests': ['dromaeo_dom']}, 17:28:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:28:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:28:07 INFO - 'tests': ['a11yr', 17:28:07 INFO - 'ts_paint', 17:28:07 INFO - 'tpaint', 17:28:07 INFO - 'sessionrestore', 17:28:07 INFO - 'sessionrestore_no_auto_restore', 17:28:07 INFO - 'tabpaint']}, 17:28:07 INFO - 'other-e10s': {'tests': ['a11yr', 17:28:07 INFO - 'ts_paint', 17:28:07 INFO - 'tpaint', 17:28:07 INFO - 'sessionrestore', 17:28:07 INFO - 'sessionrestore_no_auto_restore', 17:28:07 INFO - 'tabpaint']}, 17:28:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:28:07 INFO - 'ts_paint', 17:28:07 INFO - 'tpaint', 17:28:07 INFO - 'sessionrestore', 17:28:07 INFO - 'sessionrestore_no_auto_restore', 17:28:07 INFO - 'tabpaint']}, 17:28:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:28:07 INFO - 'ts_paint', 17:28:07 INFO - 'tpaint', 17:28:07 INFO - 'sessionrestore', 17:28:07 INFO - 'sessionrestore_no_auto_restore', 17:28:07 INFO - 'tabpaint']}, 17:28:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:28:07 INFO - 'tests': ['a11yr', 17:28:07 INFO - 'ts_paint', 17:28:07 INFO - 'tpaint', 17:28:07 INFO - 'sessionrestore', 17:28:07 INFO - 'sessionrestore_no_auto_restore', 17:28:07 INFO - 'tabpaint']}, 17:28:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:28:07 INFO - 'tests': ['a11yr', 17:28:07 INFO - 'ts_paint', 17:28:07 INFO - 'tpaint', 17:28:07 INFO - 'sessionrestore', 17:28:07 INFO - 'sessionrestore_no_auto_restore', 17:28:07 INFO - 'tabpaint']}, 17:28:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:28:07 INFO - 'tests': ['tsvgx', 17:28:07 INFO - 'tsvgr_opacity', 17:28:07 INFO - 'tart', 17:28:07 INFO - 'tscrollx', 17:28:07 INFO - 'cart']}, 17:28:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:28:07 INFO - 'tsvgr_opacity', 17:28:07 INFO - 'tart', 17:28:07 INFO - 'tscrollx', 17:28:07 INFO - 'cart']}, 17:28:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:07 INFO - 'talos_options': ['--disable-e10s'], 17:28:07 INFO - 'tests': ['tp5o']}, 17:28:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:07 INFO - 'tests': ['tp5o']}, 17:28:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:07 INFO - 'talos_options': ['--disable-e10s', 17:28:07 INFO - '--xperf_path', 17:28:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:28:07 INFO - 'tests': ['tp5n']}, 17:28:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:07 INFO - 'talos_options': ['--xperf_path', 17:28:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:28:07 INFO - 'tests': ['tp5n']}}, 17:28:07 INFO - 'talos.zip': {'path': '', 17:28:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:28:07 INFO - Running post-action listener: _resource_record_post_action 17:28:07 INFO - ##### 17:28:07 INFO - ##### Running create-virtualenv step. 17:28:07 INFO - ##### 17:28:07 INFO - Running pre-action listener: _resource_record_pre_action 17:28:07 INFO - Running main action method: create_virtualenv 17:28:07 INFO - Creating virtualenv /builds/slave/test/build/venv 17:28:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:28:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:28:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:28:07 INFO - Using real prefix '/tools/python27' 17:28:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:28:08 INFO - Installing distribute.............................................................................................................................................................................................done. 17:28:11 INFO - Installing pip.................done. 17:28:11 INFO - Return code: 0 17:28:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:28: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')]} 17:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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')]} 17:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce23d6aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b780e00>, '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 0x10b5e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b77bb20>, '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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 17:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:28:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z1RvgDZWEV/Render', 17:28:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:11 INFO - 'HOME': '/Users/cltbld', 17:28:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:11 INFO - 'LOGNAME': 'cltbld', 17:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:11 INFO - 'MOZ_NO_REMOTE': '1', 17:28:11 INFO - 'NO_EM_RESTART': '1', 17:28:11 INFO - 'PAGER': '/bin/cat', 17:28:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:11 INFO - 'PWD': '/builds/slave/test', 17:28:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:11 INFO - 'SHELL': '/bin/bash', 17:28:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej0qW8Dery/Listeners', 17:28:11 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 17:28:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:11 INFO - 'USER': 'cltbld', 17:28:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:11 INFO - 'XPC_FLAGS': '0x0', 17:28:11 INFO - 'XPC_SERVICE_NAME': '0', 17:28:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:28:11 INFO - Cleaning up... 17:28:11 INFO - Return code: 0 17:28:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:28: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')]} 17:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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')]} 17:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce23d6aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b780e00>, '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 0x10b5e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b77bb20>, '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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 17:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:28:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z1RvgDZWEV/Render', 17:28:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:11 INFO - 'HOME': '/Users/cltbld', 17:28:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:11 INFO - 'LOGNAME': 'cltbld', 17:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:11 INFO - 'MOZ_NO_REMOTE': '1', 17:28:11 INFO - 'NO_EM_RESTART': '1', 17:28:11 INFO - 'PAGER': '/bin/cat', 17:28:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:11 INFO - 'PWD': '/builds/slave/test', 17:28:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:11 INFO - 'SHELL': '/bin/bash', 17:28:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej0qW8Dery/Listeners', 17:28:11 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 17:28:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:11 INFO - 'USER': 'cltbld', 17:28:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:11 INFO - 'XPC_FLAGS': '0x0', 17:28:11 INFO - 'XPC_SERVICE_NAME': '0', 17:28:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:11 INFO - Downloading/unpacking psutil>=0.7.1 17:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:28:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:28:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:28:14 INFO - Installing collected packages: psutil 17:28:14 INFO - Running setup.py install for psutil 17:28:14 INFO - building 'psutil._psutil_osx' extension 17:28:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:28:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:28:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:28:15 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 17:28:15 INFO - building 'psutil._psutil_posix' extension 17:28:15 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 17:28:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:28:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:28:15 INFO - ^ 17:28:15 INFO - 1 warning generated. 17:28:15 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 17:28:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:28:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:28:15 INFO - Successfully installed psutil 17:28:15 INFO - Cleaning up... 17:28:15 INFO - Return code: 0 17:28:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce23d6aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b780e00>, '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 0x10b5e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b77bb20>, '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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 17:28:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:28:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z1RvgDZWEV/Render', 17:28:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:15 INFO - 'HOME': '/Users/cltbld', 17:28:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:15 INFO - 'LOGNAME': 'cltbld', 17:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:15 INFO - 'MOZ_NO_REMOTE': '1', 17:28:15 INFO - 'NO_EM_RESTART': '1', 17:28:15 INFO - 'PAGER': '/bin/cat', 17:28:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:15 INFO - 'PWD': '/builds/slave/test', 17:28:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:15 INFO - 'SHELL': '/bin/bash', 17:28:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej0qW8Dery/Listeners', 17:28:15 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 17:28:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:15 INFO - 'USER': 'cltbld', 17:28:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:15 INFO - 'XPC_FLAGS': '0x0', 17:28:15 INFO - 'XPC_SERVICE_NAME': '0', 17:28:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:28:18 INFO - Installing collected packages: mozsystemmonitor 17:28:18 INFO - Running setup.py install for mozsystemmonitor 17:28:18 INFO - Successfully installed mozsystemmonitor 17:28:18 INFO - Cleaning up... 17:28:18 INFO - Return code: 0 17:28:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce23d6aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b780e00>, '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 0x10b5e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b77bb20>, '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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 17:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:28:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z1RvgDZWEV/Render', 17:28:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:18 INFO - 'HOME': '/Users/cltbld', 17:28:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:18 INFO - 'LOGNAME': 'cltbld', 17:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:18 INFO - 'MOZ_NO_REMOTE': '1', 17:28:18 INFO - 'NO_EM_RESTART': '1', 17:28:18 INFO - 'PAGER': '/bin/cat', 17:28:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:18 INFO - 'PWD': '/builds/slave/test', 17:28:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:18 INFO - 'SHELL': '/bin/bash', 17:28:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej0qW8Dery/Listeners', 17:28:18 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 17:28:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:18 INFO - 'USER': 'cltbld', 17:28:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:18 INFO - 'XPC_FLAGS': '0x0', 17:28:18 INFO - 'XPC_SERVICE_NAME': '0', 17:28:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:19 INFO - Downloading/unpacking blobuploader==1.2.4 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28:21 INFO - Downloading blobuploader-1.2.4.tar.gz 17:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:28:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:28:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28:22 INFO - Downloading docopt-0.6.1.tar.gz 17:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:28:22 INFO - Installing collected packages: blobuploader, requests, docopt 17:28:22 INFO - Running setup.py install for blobuploader 17:28:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:28:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:28:22 INFO - Running setup.py install for requests 17:28:23 INFO - Running setup.py install for docopt 17:28:23 INFO - Successfully installed blobuploader requests docopt 17:28:23 INFO - Cleaning up... 17:28:23 INFO - Return code: 0 17:28:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:23 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')]} 17:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:23 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')]} 17:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:23 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 0x10b8e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce23d6aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b780e00>, '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 0x10b5e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b77bb20>, '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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 17:28:23 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 17:28:23 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 17:28:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z1RvgDZWEV/Render', 17:28:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:23 INFO - 'HOME': '/Users/cltbld', 17:28:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:23 INFO - 'LOGNAME': 'cltbld', 17:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:23 INFO - 'MOZ_NO_REMOTE': '1', 17:28:23 INFO - 'NO_EM_RESTART': '1', 17:28:23 INFO - 'PAGER': '/bin/cat', 17:28:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:23 INFO - 'PWD': '/builds/slave/test', 17:28:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:23 INFO - 'SHELL': '/bin/bash', 17:28:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej0qW8Dery/Listeners', 17:28:23 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 17:28:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:23 INFO - 'USER': 'cltbld', 17:28:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:23 INFO - 'XPC_FLAGS': '0x0', 17:28:23 INFO - 'XPC_SERVICE_NAME': '0', 17:28:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:23 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-izN04Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-LmWMzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-GrAk93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-sFQvHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Wlwc2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-KCRDFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-dpvM6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-vvGrT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-XPsb3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-4J2X3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-FutbgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Qtdy3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-c0BwZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Zv_PvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-6mtkKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-_vIws2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-VmOarm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:28:25 INFO - Running setup.py install for manifestparser 17:28:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:28:25 INFO - Running setup.py install for mozcrash 17:28:26 INFO - Running setup.py install for mozdebug 17:28:26 INFO - Running setup.py install for mozdevice 17:28:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:28:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:28:26 INFO - Running setup.py install for mozfile 17:28:26 INFO - Running setup.py install for mozhttpd 17:28:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:28:26 INFO - Running setup.py install for mozinfo 17:28:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:28:26 INFO - Running setup.py install for mozInstall 17:28:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:28:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:28:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:28:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:28:26 INFO - Running setup.py install for mozleak 17:28:27 INFO - Running setup.py install for mozlog 17:28:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:28:27 INFO - Running setup.py install for moznetwork 17:28:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:28:27 INFO - Running setup.py install for mozprocess 17:28:27 INFO - Running setup.py install for mozprofile 17:28:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:28:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:28:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:28:27 INFO - Running setup.py install for mozrunner 17:28:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:28:27 INFO - Running setup.py install for mozscreenshot 17:28:28 INFO - Running setup.py install for moztest 17:28:28 INFO - Running setup.py install for mozversion 17:28:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:28:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:28:28 INFO - Cleaning up... 17:28:28 INFO - Return code: 0 17:28:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:28 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')]} 17:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:28 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')]} 17:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:28 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 0x10b8e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce23d6aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b780e00>, '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 0x10b5e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b77bb20>, '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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 17:28:28 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 17:28:28 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 17:28:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z1RvgDZWEV/Render', 17:28:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:28 INFO - 'HOME': '/Users/cltbld', 17:28:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:28 INFO - 'LOGNAME': 'cltbld', 17:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:28 INFO - 'MOZ_NO_REMOTE': '1', 17:28:28 INFO - 'NO_EM_RESTART': '1', 17:28:28 INFO - 'PAGER': '/bin/cat', 17:28:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:28 INFO - 'PWD': '/builds/slave/test', 17:28:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:28 INFO - 'SHELL': '/bin/bash', 17:28:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej0qW8Dery/Listeners', 17:28:28 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 17:28:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:28 INFO - 'USER': 'cltbld', 17:28:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:28 INFO - 'XPC_FLAGS': '0x0', 17:28:28 INFO - 'XPC_SERVICE_NAME': '0', 17:28:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-FoRmkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:28 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)) 17:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-TdAxla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:28 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)) 17:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-AjQx9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-uWkicc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-hYzKA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:29 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)) 17:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-W7IzpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:29 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)) 17:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-erKRU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:29 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)) 17:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-J1lIhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:29 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)) 17:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-foez4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:29 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)) 17:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-I2TOEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:29 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)) 17:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-1UYyNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:29 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)) 17:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-9GDxau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-uRNrbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-niYccJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:30 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)) 17:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-AzXY8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:30 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)) 17:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-sxzY_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:30 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)) 17:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-KRKCyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:30 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)) 17:28:30 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)) 17:28:30 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)) 17:28:30 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)) 17:28:30 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)) 17:28:30 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)) 17:28:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:28:30 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 17:28:30 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 17:28:30 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 17:28:30 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 17:28:30 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 17:28:30 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 17:28:32 INFO - Downloading blessings-1.6.tar.gz 17:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:28:32 INFO - Installing collected packages: blessings 17:28:32 INFO - Running setup.py install for blessings 17:28:33 INFO - Successfully installed blessings 17:28:33 INFO - Cleaning up... 17:28:33 INFO - Return code: 0 17:28:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:28:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:28:33 INFO - Reading from file tmpfile_stdout 17:28:33 INFO - Current package versions: 17:28:33 INFO - blessings == 1.6 17:28:33 INFO - blobuploader == 1.2.4 17:28:33 INFO - docopt == 0.6.1 17:28:33 INFO - manifestparser == 1.1 17:28:33 INFO - mozInstall == 1.12 17:28:33 INFO - mozcrash == 0.17 17:28:33 INFO - mozdebug == 0.1 17:28:33 INFO - mozdevice == 0.48 17:28:33 INFO - mozfile == 1.2 17:28:33 INFO - mozhttpd == 0.7 17:28:33 INFO - mozinfo == 0.9 17:28:33 INFO - mozleak == 0.1 17:28:33 INFO - mozlog == 3.1 17:28:33 INFO - moznetwork == 0.27 17:28:33 INFO - mozprocess == 0.22 17:28:33 INFO - mozprofile == 0.28 17:28:33 INFO - mozrunner == 6.11 17:28:33 INFO - mozscreenshot == 0.1 17:28:33 INFO - mozsystemmonitor == 0.0 17:28:33 INFO - moztest == 0.7 17:28:33 INFO - mozversion == 1.4 17:28:33 INFO - psutil == 3.1.1 17:28:33 INFO - requests == 1.2.3 17:28:33 INFO - wsgiref == 0.1.2 17:28:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28: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')]} 17:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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')]} 17:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:33 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 0x10b8e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce23d6aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b780e00>, '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 0x10b5e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b77bb20>, '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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 17:28:33 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 17:28:33 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 17:28:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z1RvgDZWEV/Render', 17:28:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:33 INFO - 'HOME': '/Users/cltbld', 17:28:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:33 INFO - 'LOGNAME': 'cltbld', 17:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:33 INFO - 'MOZ_NO_REMOTE': '1', 17:28:33 INFO - 'NO_EM_RESTART': '1', 17:28:33 INFO - 'PAGER': '/bin/cat', 17:28:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:33 INFO - 'PWD': '/builds/slave/test', 17:28:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:33 INFO - 'SHELL': '/bin/bash', 17:28:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej0qW8Dery/Listeners', 17:28:33 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 17:28:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:33 INFO - 'USER': 'cltbld', 17:28:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:33 INFO - 'XPC_FLAGS': '0x0', 17:28:33 INFO - 'XPC_SERVICE_NAME': '0', 17:28:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:33 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)) 17:28:33 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)) 17:28:33 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)) 17:28:33 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)) 17:28:33 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)) 17:28:33 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)) 17:28:33 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)) 17:28:33 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)) 17:28:33 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)) 17:28:33 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)) 17:28:33 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)) 17:28:33 INFO - Cleaning up... 17:28:33 INFO - Return code: 0 17:28:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:28: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')]} 17:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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')]} 17:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:33 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 0x10b8e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce23d6aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b780e00>, '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 0x10b5e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b77bb20>, '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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 17:28:33 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 17:28:33 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 17:28:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z1RvgDZWEV/Render', 17:28:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:33 INFO - 'HOME': '/Users/cltbld', 17:28:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:33 INFO - 'LOGNAME': 'cltbld', 17:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:33 INFO - 'MOZ_NO_REMOTE': '1', 17:28:33 INFO - 'NO_EM_RESTART': '1', 17:28:33 INFO - 'PAGER': '/bin/cat', 17:28:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:33 INFO - 'PWD': '/builds/slave/test', 17:28:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:33 INFO - 'SHELL': '/bin/bash', 17:28:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej0qW8Dery/Listeners', 17:28:33 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 17:28:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:33 INFO - 'USER': 'cltbld', 17:28:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:33 INFO - 'XPC_FLAGS': '0x0', 17:28:33 INFO - 'XPC_SERVICE_NAME': '0', 17:28:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:34 INFO - Downloading/unpacking jsonschema 17:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:28:36 INFO - Downloading/unpacking functools32 (from jsonschema) 17:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:36 INFO - Downloading functools32-3.2.3-2.tar.gz 17:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:28:36 INFO - warning: no files found matching '*.txt' 17:28:36 INFO - no previously-included directories found matching 'build' 17:28:36 INFO - no previously-included directories found matching 'dist' 17:28:36 INFO - no previously-included directories found matching '.git*' 17:28:36 INFO - Installing collected packages: jsonschema, functools32 17:28:36 INFO - Running setup.py install for functools32 17:28:37 INFO - warning: no files found matching '*.txt' 17:28:37 INFO - no previously-included directories found matching 'build' 17:28:37 INFO - no previously-included directories found matching 'dist' 17:28:37 INFO - no previously-included directories found matching '.git*' 17:28:37 INFO - Successfully installed jsonschema functools32 17:28:37 INFO - Cleaning up... 17:28:37 INFO - Return code: 0 17:28:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:28:37 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')]} 17:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:37 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')]} 17:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:37 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 0x10b8e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce23d6aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b780e00>, '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 0x10b5e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b77bb20>, '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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 17:28:37 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 17:28:37 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 17:28:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z1RvgDZWEV/Render', 17:28:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:37 INFO - 'HOME': '/Users/cltbld', 17:28:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:37 INFO - 'LOGNAME': 'cltbld', 17:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:37 INFO - 'MOZ_NO_REMOTE': '1', 17:28:37 INFO - 'NO_EM_RESTART': '1', 17:28:37 INFO - 'PAGER': '/bin/cat', 17:28:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:37 INFO - 'PWD': '/builds/slave/test', 17:28:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:37 INFO - 'SHELL': '/bin/bash', 17:28:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej0qW8Dery/Listeners', 17:28:37 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 17:28:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:37 INFO - 'USER': 'cltbld', 17:28:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:37 INFO - 'XPC_FLAGS': '0x0', 17:28:37 INFO - 'XPC_SERVICE_NAME': '0', 17:28:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:37 INFO - Downloading/unpacking flake8 17:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:28:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:28:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:28:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:28:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:28:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:28:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:28:41 INFO - no previously-included directories found matching 'docs/_build' 17:28:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:28:41 INFO - Running setup.py install for pep8 17:28:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:28:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:28:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:28:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:28:41 INFO - no previously-included directories found matching 'docs/_build' 17:28:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:28:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:28:41 INFO - Cleaning up... 17:28:41 INFO - Return code: 0 17:28:41 INFO - Running post-action listener: _resource_record_post_action 17:28:41 INFO - Running post-action listener: _start_resource_monitoring 17:28:41 INFO - Starting resource monitoring. 17:28:41 INFO - ##### 17:28:41 INFO - ##### Running install step. 17:28:41 INFO - ##### 17:28:41 INFO - Running pre-action listener: _resource_record_pre_action 17:28:41 INFO - Running main action method: install 17:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:28:41 INFO - Reading from file tmpfile_stdout 17:28:41 INFO - Detecting whether we're running mozinstall >=1.0... 17:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:28:41 INFO - Reading from file tmpfile_stdout 17:28:41 INFO - Output received: 17:28:41 INFO - Usage: mozinstall [options] installer 17:28:41 INFO - Options: 17:28:41 INFO - -h, --help show this help message and exit 17:28:41 INFO - -d DEST, --destination=DEST 17:28:41 INFO - Directory to install application into. [default: 17:28:41 INFO - "/builds/slave/test"] 17:28:41 INFO - --app=APP Application being installed. [default: firefox] 17:28:41 INFO - mkdir: /builds/slave/test/build/application 17:28:41 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'] 17:28:41 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 17:29:03 INFO - Reading from file tmpfile_stdout 17:29:03 INFO - Output received: 17:29:03 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:29:03 INFO - Running post-action listener: _resource_record_post_action 17:29:03 INFO - ##### 17:29:03 INFO - ##### Running run-tests step. 17:29:03 INFO - ##### 17:29:03 INFO - Running pre-action listener: _resource_record_pre_action 17:29:03 INFO - Running main action method: run_tests 17:29:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:29:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:29:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:29:03 INFO - 2016-06-15 17:29:03.643 screenresolution[1927:14137] starting screenresolution argv=screenresolution get 17:29:03 INFO - 2016-06-15 17:29:03.646 screenresolution[1927:14137] Display 0: 1600x1200x32@60 17:29:03 INFO - 2016-06-15 17:29:03.652 screenresolution[1928:14140] starting screenresolution argv=screenresolution list 17:29:03 INFO - Available Modes on Display 0 17:29:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:29:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:29:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:29:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:29:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:29:03 INFO - Intel Iris: 17:29:03 INFO - Chipset Model: Intel Iris 17:29:03 INFO - Type: GPU 17:29:03 INFO - Bus: Built-In 17:29:03 INFO - VRAM (Dynamic, Max): 1536 MB 17:29:03 INFO - Vendor: Intel (0x8086) 17:29:03 INFO - Device ID: 0x0a2e 17:29:03 INFO - Revision ID: 0x0009 17:29:03 INFO - Displays: 17:29:03 INFO - Display: 17:29:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:29:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:29:03 INFO - Display Serial Number: 1600x1200 60 17:29:03 INFO - Main Display: Yes 17:29:03 INFO - Mirror: Off 17:29:03 INFO - Online: Yes 17:29:03 INFO - Rotation: Supported 17:29:03 INFO - Return code: 0 17:29:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:29:03 INFO - Python 2.7.3 17:29:03 INFO - Return code: 0 17:29:03 INFO - grabbing minidump binary from tooltool 17:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:03 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 0x10b780e00>, '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 0x10b5e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b77bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:29:03 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 17:29:03 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 17:29:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:29:03 INFO - Return code: 0 17:29:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:29:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:29:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:29:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:29:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:29:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:29:05 INFO - Return code: 0 17:29:05 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/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 17:29:05 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/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0214 --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 17:29:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z1RvgDZWEV/Render', 17:29:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:05 INFO - 'HOME': '/Users/cltbld', 17:29:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:05 INFO - 'LOGNAME': 'cltbld', 17:29:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:29:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:05 INFO - 'MOZ_NO_REMOTE': '1', 17:29:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:29:05 INFO - 'NO_EM_RESTART': '1', 17:29:05 INFO - 'PAGER': '/bin/cat', 17:29:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:05 INFO - 'PWD': '/builds/slave/test', 17:29:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:29:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:05 INFO - 'SHELL': '/bin/bash', 17:29:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ej0qW8Dery/Listeners', 17:29:05 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 17:29:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:05 INFO - 'USER': 'cltbld', 17:29:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:05 INFO - 'XPC_FLAGS': '0x0', 17:29:05 INFO - 'XPC_SERVICE_NAME': '0', 17:29:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:05 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/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 17:29:05 INFO - mozversion application_buildid: 20160615151425 17:29:05 INFO - mozversion application_changeset: da4a9eed33bdbc5f5bd1002cc07f998a1eb037fa 17:29:05 INFO - mozversion application_display_name: Firefox 17:29:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:29:05 INFO - mozversion application_name: Firefox 17:29:05 INFO - mozversion application_remotingname: firefox 17:29:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:29:05 INFO - mozversion application_vendor: Mozilla 17:29:05 INFO - mozversion application_version: 48.0 17:29:05 INFO - mozversion platform_buildid: 20160615151425 17:29:05 INFO - mozversion platform_changeset: da4a9eed33bdbc5f5bd1002cc07f998a1eb037fa 17:29:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:29:05 INFO - mozversion platform_version: 48.0 17:29:05 INFO - using testdate: 1466036945 17:29:05 INFO - actual date: 1466036945 17:29:05 INFO - starting webserver on 'localhost:51434' 17:29:05 INFO - SUITE-START | Running 2 tests 17:29:05 INFO - TEST-START | dromaeo_css 17:29:05 INFO - operating with platform_type : mac_ 17:29:05 INFO - Initialising browser for dromaeo_css test... 17:29:05 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpkStsy_/profile http://localhost:51434/getInfo.html) 17:29:08 INFO - PROCESS | 1946 | __metrics Screen width/height:1600/1200 17:29:08 INFO - PROCESS | 1946 | colorDepth:24 17:29:08 INFO - PROCESS | 1946 | Browser inner width/height: 1024/689 17:29:08 INFO - PROCESS | 1946 | __metrics 17:29:08 ERROR - PROCESS | 1946 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 17:29:09 INFO - TEST-INFO | 1946: exit 0 17:29:09 INFO - Browser initialized. 17:29:09 INFO - Running cycle 1/1 for dromaeo_css test... 17:29:09 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpkStsy_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:21 INFO - PROCESS | 1950 | RSS: Main: 170946560 17:29:21 INFO - PROCESS | 1950 | 17:30:10 INFO - PROCESS | 1950 | 1466037010825 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] 17:32:20 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51434/tests/dromaeo/cssquery-ext.html) 17:32:22 INFO - PROCESS | 1950 | RSS: Main: 182022144 17:32:22 INFO - PROCESS | 1950 | 17:35:23 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-ext.html (next: http://localhost:51434/tests/dromaeo/cssquery-jquery.html) 17:35:24 INFO - PROCESS | 1950 | RSS: Main: 192675840 17:35:24 INFO - PROCESS | 1950 | 17:38:26 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51434/tests/dromaeo/cssquery-mootools.html) 17:38:26 INFO - PROCESS | 1950 | RSS: Main: 194924544 17:38:26 INFO - PROCESS | 1950 | 17:41:28 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51434/tests/dromaeo/cssquery-prototype.html) 17:41:29 INFO - PROCESS | 1950 | RSS: Main: 199069696 17:41:29 INFO - PROCESS | 1950 | 17:44:31 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51434/tests/dromaeo/cssquery-yui.html) 17:44:32 INFO - PROCESS | 1950 | RSS: Main: 197767168 17:44:32 INFO - PROCESS | 1950 | 17:47:34 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-yui.html (next: http://localhost:51434/tests/dromaeo/cssquery-dojo.html) 17:47:34 INFO - PROCESS | 1950 | RSS: Main: 202756096 17:47:34 INFO - PROCESS | 1950 | 17:47:34 INFO - PROCESS | 1950 | __start_tp_report 17:47:34 INFO - PROCESS | 1950 | _x_x_mozilla_page_load 17:47:34 INFO - PROCESS | 1950 | _x_x_mozilla_page_load_details 17:47:34 INFO - PROCESS | 1950 | |i|pagename|runs| 17:47:34 INFO - PROCESS | 1950 | |0;dojo.html;3626.6554677305653;3681.576618688851;3693.113652723347;3713.795741234231;3718.60954599767;5831.416858314166;5833.125031245316;5841.240638716971;5847.678377689225;5889.381614930429;5777.855553611162;5838.007538718418;5873.2658417697785;5887.85280367991;5890.998530249857;5280.260763493095;5287.788488460466;5341.1988201769855;5349.786008559653;5392.164214546751;4737.668363214576;5270.1040823060175;5320.1753728172;5419.83740487786;5441.2654291670515;5400.540954018894;5404.513593776559;5422.15956526739;5426.62013659044;5433.212184233284;4520.954790452102;5334.413214546396;5373.543248823855;5402;5418.485243901823;5224.451432599561;5291.576673866081;5301.045811753883;5349.224362467459;5349.251104845324;5591.496765291144;5667.291588551431;5709.714514274311;5710.571707121941;5710.65736055838;6312.747490100436;6335.208098987627;6354.046892966046;6366;6375.10748495211;6237.750489980395;6245.219347581552;6297.338779428185;6316.526260530479;6327.46216571592;5137.922931156036;5975.342712301644;5985.132155837423;5993.160957465958;6050.394960503959;6188.845278867974;6244.687765611792;6380.266269378988;6388.7125079371535;6398.776042838478;5146.6911985281;6090.451859332681;6184.783532576338;6247.219097612799;6321.810345689637;6325.209348831396;6347.777827776005;6351.110844481776;6357.904631430532;6395.968020159962;6303.905441418382;6333.334999825044;6344.365563443711;6347.714352854133;6358.491320694333;6171.876562468815;6269.592476489013;6281.214848143982;6311.1795466589965;6347.238331400262;5022.673526220784;5064.594832413398;5073.315102461121;5074.594032477393;5087.618428617794;4584.701994370355;4613.5847773700525;4628.837990670378;4653.930191047137;4663.720176789404;5963.642181469126;5968.343482216953;6095.939040609625;6121.4490695837585;6132.04958718918;6292.968535157295;6307.306196318401;6320.304766475684;6321.905171422432;6366.427021568081;6079.240094988127;6126.785562505291;6142.04798256271;6153.29237137726;6162.445379915739;5475.534579560703;5479.369872464637;5516.613837031369;5538.47384498472;5555.2222688823595;6584.407403333723;6587.044878492592;6624.635645039569;6634.104395906587;6654.367835055662;5696.373398926197;6229.1590635265475;6329.683515824098;6351.07909353132;6361.982082866719;6534.575252608565;6630.370114839083;6648.667566621746;6660;6691.698873550605;6275.717592708248;6332.651704156316;6343.016832390987;6359.332270111571;6371.872562548816;5285.630005899704;6234.625922444668;6259.405356491126;6337.207849018872;6353.7140828661895;4894.510548945077;6151.0773383992755;6226;6242.812715618538;6272.874542509033;6182.969085154546;6222;6239.625622462667;6250.4374606285655;6268.811935641938;5731.828045158652;5914.408559144051;6068.271807382966;6081.847953801191;6128.908066378919;5393.7033463159905;6245.6252624842655;6253.624782513064;6254;6255.843603909939;6019.51843852482;6093;6096;6160.353162917829;6160.537959652955 17:47:34 INFO - PROCESS | 1950 | |1;ext.html;559.8348487196276;587.5710731166248;590.949769269612;623.9220097487814;638.648743191245;40849.79575102124;41813.99999999996;41824.58175418245;41875;41885;42802;43040.35439468403;43461.7826910865;43528.56471435285;43674.68975930727;8978.371513994023;9303.76740581484;9776.022397760202;9912.653057143001;10008.449535275557;8778.122187781235;9835.45904975226;9975.052370024836;10095.495225238745;10105.797884042315;8628.482291062524;10089.848652270222;10090.14233790125;10106.646267380644;10137.290389672726;10019;10120;10120.139788118018;10129.442880641562;10130.746731331701;9951.701448956543;10062.79874402515;10067.496625168786;10101.797964040677;10236.43699596522;30056;41853.79073104615;42091.57908420907;42267.57732422667;42807.143857122996;3244.156519304974;3399.847006884696;3447.827608619584;3729.6083911189476;3852.9229415411537;29276.707232927823;29954.70045299541;30102.54846177309;30219.942302019324;30373.392532149453;2769.3353595137223;2786.7770578353684;2787.6515435570554;2793.3575277686245;2839.7870159738104;381681;383048;383300.08349958353;384025;384522;38227.42658860119;39349;64473.355266446735;64917;64932.35067649263;37655.05862353463;37715.434268485995;37817.43273850894;38062.61937380646;38093.80953095272;15139.924300378427;15260.389584416722;15685.372585096467;15797.289121989537;15806.525804225892;13241.801372979413;13283.734325313633;13302.467901284033;13332.533361332307;13350.198988060552;7177.354038136488;8507.489550626982;8608.827823443497;8668.566571671392;8683.782905427415;3582.373084710165;3600.5319308490252;3628.310620982005;3640.690541303966;3652.4521321801944;1014.300132908291;1035.6478797208986;1120.6021862238952;1168.363242033077;1201.9482952416636;28273.71726282752;29889.551656725165;31480.842595787333;31849.68150318467;31934.680653193634;1167.3579531257944;1167.3987896233446;1195.5875223048035;1228.6314105768413;1276.21512769646;16302.985698088569;16338.591535211715;16359.936604120694;16394.590135246715;16424.425145119865;651390;653351;654899;661370.6931465408;663445;64507;66313.67372652616;66327.66836165884;66442;66454;1531.1272574632576;1539.5073576455427;1541.029151634463;1554.860062594372;1560.9219539023231;30590.388192235587;31045.223869403446;31323.68676313208;31708.841455793496;31749.5237571432;56395;58034.7098264506;58431.12353314789;58561;58590.82818343695;567112;567308;569007;571944;574026;28215.57676634811;28398.716012839606;28971.275718107216;29330.120096397142;29352.706472935;49003;49643;49947.75026124846;49969;50360;40086.39870401888;40265.99335016648;41126.79436602798;41379.379309309785;41433;39677.60322396739;40084.997875053356;40093.59906401015;40927;41219.1756164881;40460.39309410303;40630.59369406268;41274.38088428616;42138.367924480546;42454.78772606117;25755;31429.528557071204;33735.15662108467;33822;34259.82870085733;25592.464452132932;25830.225093247234;25874.35314117162;25930.878933343738;26092.8695356522 17:47:34 INFO - PROCESS | 1950 | |2;jquery.html;362.55586906040094;368.68661637608034;423.1579157476622;423.2445085522343;434.3202887481092;20798.272060477888;21188.788112118895;21422;21938.341849744513;21943.451413714643;20785.688214676753;20849.270275540322;20906.895465522688;20940.267090651792;20998.26506072288;5778.768849246025;5869.8826023479505;5950.256217972754;6022.217111775463;6069.484093852028;5891.351951285355;5919.437653422918;5927.703614819264;5946.910796338058;6003.909941350883;5759.424057594228;5932.792352267671;5971.402859714038;5985.730642121115;5988.550858685594;5785.2189954356045;5842.707864606774;5853.7951171709;5867;5871.32479764824;5021.949780502221;5117.2068329409;5124.92312615311;5125.077486052509;5210.348706411699;12701.491940322376;13136.737265254736;13430.328483575782;26417.867910660516;26639.866800665874;2170.967435488469;2273.6703178039256;2273.920412785561;2394.7006624171977;2820.844853533055;9625.181859541948;10139.44233067181;10141.290109692325;10144.442055686934;10278;1799.208348326732;1816.7729033870767;1839.1539891649857;1901.9524511887175;1908.3797765726194;119810.40094799557;121667;126053;130215;138400.61599383978;10007;11430.657080287605;12208.511659533697;12297.200681955645;12297.56958506448;15384.538463846102;15435.614109647124;15605.453809116627;15644.452444164399;15662.295196716175;8898.777530561658;8965.686200982935;9057.275417966546;9063.728088157366;9086.318526110568;8793.824123517494;8913.688020919237;8955.865662015074;8972.147645973622;9000.684976025808;4671.416072990876;4736.621070314367;4809.326694262736;4813.638977076734;4846.588040016568;1994.4914046918234;2066.524699319165;2067.390119914629;2114.059243636567;2124.798144176301;988.2785566536469;999.84018538495;1046.853440518328;1081.1242893256488;1102.8400881872083;17702.203400846993;19973.800261997483;20031.198752050048;20432.080556375;20841.102955762504;977.237754551451;1001.4592120254981;1019.8776146862424;1033.2199189611795;1071.2287153249647;10826.296290741077;10962.890371096188;11006.119510439146;11074.134036897176;11099.778004440028;585747.0712646409;599588;624063;662843;684026;95814;108695;130457;135375.96936045968;136750;1020.6886899495726;1030.3663247102977;1036.3781730961364;1082.6210826210763;1082.7888561730388;14323.14061156334;17936.641267174844;18323;18413.723794142832;18609;43194.70415887528;47880;53511.732441337546;56058.439415605324;57503.42496574981;81736.18263817523;83770.16229837624;83869;84883.87790305291;86731.56634216789;8075.87886181696;8254.257116859511;8277.58612069406;8470.66117355299;8533.701320453754;9644.855327170239;10476.476176191007;11796.94101529487;12254.4485498151;12477.93761031189;11334.716632084264;11389.202755807013;11505.424728763695;11536.019438347834;11579.421028948687;10424.113950314006;10593.523291452057;11014.669559913216;11242.83135752948;11725.944664980192;8414.495130292202;10885.891141088488;11218.775624487627;11572.421378931189;11711.707207319885;8266.256036956704;8354.749357519284;8459.069502354612;8520.957395212985;8691.826163476822;11168.609098681507;11198.21612487118;11271.605493807678;11321.830172547254;11623.082191438656 17:47:34 INFO - PROCESS | 1950 | |3;mootools.html;1625.0655872873097;1662.717338052531;1704.8124706282315;2028.1785876719925;2077.200277893011;8249.46378485398;8879.112088791118;9032.50321232332;9292.395994260369;9317.860232096515;9004.774880627987;9044.095590440953;9134.680286189985;9144.177024067832;9167.083291670846;2543.4531575711217;2548.5412625727363;2577.85821779802;2586.469773696397;2589.262060312811;2517.1567524879188;2547.2867597072755;2552.8978840846344;2561.3852675357875;2582.4835032993383;2165.5993641176356;2514.8557406380055;2576.896924123042;2579.071534247669;2599.532084224839;2541.1233124571995;2541.606051062079;2556.3481312265344;2590.818642695012;2591.883365248568;2549.949001019988;2551.795856331489;2577.76800087993;2587.3790290330376;2592.1057235253807;9247.583858726373;9250.72247832566;9255.213306868856;9311.627534898664;9329.72010839676;5698.629589076697;5701.287339082614;5860.589758716891;5863.032599621058;5869.2369991901205;3682.429223470366;3762.5861155272896;3777.9811100944594;3849.961500384988;3852.9982204626717;914.4558987402485;1040.6929955663022;1064.7391389109641;1073.9731506712317;1078.417654466587;12153.270803751802;12351.073669474825;12432.564860229848;12628.989680825604;12651.873481265162;4993.800247990112;4998.225275082368;5090.490950904954;5110.66780659256;5125.89793194465;8961.955190224007;8970.102989700978;10499.842502362471;10565.788684226427;10586.99423554761;4868.464468908417;5672.688002159838;5701.973644743903;5717.656940583578;5750.942490575125;4197.24449599069;4518.43519560055;4614.723116613014;5158.561522270574;5173.0688476074665;4219.852305169305;4236.851710190129;4280.828766849353;4310.978445107754;4342.739435633872;1375.5529452927638;1389.4095009621074;1402.4880918464687;1402.6843960108895;1420.3537390487304;906.9909300907038;956.6747305916022;956.8803899512561;972.2805124208177;992.7369247149511;5567.526760225345;5925.111233314951;6006.489448396847;6065.059915713072;6153.661548614869;921.2583869984593;940.9341346105707;967.5597603090577;996.5415908681942;1030.0677886512717;3087.4133914556164;3930.194310166409;3969.0672691917375;3996.020974861178;4030;9688.740463739668;11039;11125.388103654377;11213.831792523119;11429.942850285695;10982;11004.449777511092;11006.174536909764;11046.33721976684;11189;8548.786280342916;8633.136686331442;8640.524771137647;8837.513936733412;8872.290216782641;5796.391378905154;5829.38791426911;5880.558958078247;6050.818475445743;6073.331933487401;9896.901030989886;9906.752331191778;10038.949805251219;10093.394396336244;10155.7461063474;9838.557264923238;10027.04743049409;10043.648472303434;10147.594096236067;10184.338018028804;7088.929110708827;7810.687572497037;7940.6426710796995;8151.5924203790755;8421.831563368822;8430.283425908621;8531.829363412573;8556.058833528432;8562.315014798925;8603.440776349516;6398;7471.290227428385;7534.0582427196605;7667.731629392944;7833.686652533835;7471.738489152854;7518.210587888193;7538.3969282458365;7610.429217808797;7692.846143076995;7177.892331614926;7222;7224.385927196037;7261.891071633824;7266.564006159648;4955.984023275292;4963.950360496348;5058.190689489664;5121.257417674342;5127.66670166438;4444.311131774451;5051.595872330278;5098.847034588968;5132.050570644443;5139.6145289102715 17:47:34 INFO - PROCESS | 1950 | |4;prototype.html;267.5411668987687;307.8368464713703;313.5030975903193;343.9948400773988;344.97757645753023;6620.569662971903;6729.7308107675635;6752.459803215743;6853.794386168411;6879.72481100756;6760.188777346713;6807.965960170192;6838.82902927427;6849.828754281146;6902.826519491686;4108.5686002969705;4584.243599806036;5087.6184286178495;5106.08090543702;5157.974210128963;4113.547509773937;5101.54086132248;5103.23451482277;5108.310378098965;5134.614903882224;3850;5022.773975171126;5027.673201241908;5047.141985862412;5067.974660126694;4754.78603462845;4919.7540122993705;5011.599072074226;5043.52086551777;5056.79772809089;4132.194222126686;4160.563140870226;4168.812403441852;4169.854055108057;4199.874003779892;6398.616083035033;6455.4835613150835;6470.4823614110755;6492.805215843532;6495.512836537231;5840.8247752567495;5853.560982926255;5874.7943821966455;5875.089361149029;5875.353711091777;7197.89203161953;7202.855942881113;7213.819654508627;7247.963760181218;7256.528325658868;4534.6372290216705;4667.719936803803;4669.43573902743;4684.36761037259;4687.906241875177;6211.627302361828;7543.396528277724;7649.732259370895;7656.349210317074;7719.343855772322;4736.242201247784;4742.762861856962;4765.260679851829;4765.594924431392;4833.927491087637;4836.153673107192;4843.128236917319;4845.685030473008;4850.102730994778;4865.9756701216265;5776.740046697909;5787.131930210502;5792.855178620568;5815.534757219412;5816.069428891357;6603.20761508622;7064.258252883476;7289.744858929912;7328.413726901835;7342.853142937111;1653.7271350227318;1669.1654172913543;1679.1184628070362;1679.865610751137;1683.2846040432767;996.8704068471052;1041.8228901086834;1043.0560342889696;1063.547992103353;1068.6206396729206;6898.2756810535175;7050.823729406703;7062.71749130029;7073.893891591631;7077.6461176941975;7647.655855486517;7656.578888161093;7673.424493163036;7674.462787604814;7719.729809456642;7034.296570343027;7047.577145371191;7052.365287124184;7058.047163632844;7076.32774886385;3866.7873266970587;3981.960180398217;4023.979880100639;4026.7583944963394;4047.6357127858632;8132.878006829902;8176.7955801105445;8177.6320065596;8184.468009579358;8188.754337369888;7786.805329866798;7800.765977020698;7804.3366313862825;7855.567943763148;7856.528608283521;8117.350611951029;8129.918700813035;8143.592820358958;8200.26197642215;8211.21993410637;7297.598632075074;7584.5070070445245;7590.354819840375;7591.240875912586;7609.032477333733;7423.703051877865;7448.9627551861895;7449.217832127549;7453.031105956191;7517.43619228571;6751.021101940093;8083.110857805519;8094;8114.83770324602;8117.147699491468;4518.932216016697;4747.14551380741;4754.548317909793;4760.428748550057;4784.473707892199;7131.572105673677;7484.363829074589;7520.247975202655;7548.018757561482;7592.886916364264;5851.561132914963;7272.309130632581;7310.817229569303;7327.926720732725;7337.376323012603;5831.825045248649;7273.9636301818155;7277.16312624055;7288;7303.817404564928;6870.896936546056;7098.964505177441;7102.538335008208;7106.467014973794;7123.252058533986;7279.980802687522;7286.271372862671;7294.416446684147;7302.0142280791415;7324.597147156957;6894.482913781587;6967.895481567882;7111.573305601681;7124.750633727795;7128.073350464407 17:47:34 INFO - PROCESS | 1950 | |5;yui.html;719.7588807749404;747.8616455955648;749.947503674743;775.1666958020129;788.026786918156;14071.592840715923;14684.41262349506;15393.846061539409;15493.22533873306;15702.764458533102;12548.811767823467;14343.64140896478;14374.712505749878;14481.420743170287;14518.927405362985;756.3457609168086;919.9724008279729;927.1238679447924;935.9438433694;940.2571968145157;938.3056538161779;946.4557879219442;947.0292949726551;949.6818565780437;950.8383574792302;954.2604481526838;993.7366597851538;995.2833959549113;996.9052939970691;997.6907158780765;971.961121555137;979.045430705064;996.3225006995241;1000.2748007694399;1002.9949850250702;719.4999475364624;726.3317747672154;735.8969744235811;735.91904890462;738.4978214813924;14700.970932034761;14785.556433307018;15125.319360628799;15173.696526069416;15181.848181518153;10862.293950893167;13068.542601009014;13163.539276125386;13229.801552976713;13269.270190139538;10172.186225102048;10306.7423314417;10337.173026157889;10486.213533984905;10491.79016419675;3577.141486043357;3577.3560759063616;3591.928161436783;3643.143861192618;3697.5378077740284;82645.58677206635;82766.58616706877;83248;85057;86542.99999999937;9568.47373394456;9572.56923438447;9611.471369074628;9631;9839.458829764431;21625.891870540545;21793.782062179176;21836.781632183793;21868;21877.453063673536;7807.336376408069;7813.843723125619;7917.247861453153;7935.801604959806;8076.596170191467;4250.766207858597;4262.786860656955;4297.699161058696;4306.827726890952;4320.848770293088;3753.49327840738;3768.566614839274;3816.6183381661613;3819.1979684266616;3833.6933045356304;592.3780030967467;687.089606271692;697.8848489999194;708.1183926012147;730.3864753606996;531.2482836785982;569.2457493820704;573.8880918220907;586.9882602348015;598.6617561077977;7765.378769698411;8502.234798868132;8515.957420212982;8623.698170564001;8800.911990880137;537.0976759044842;586.6656006076581;610.8472881779555;622.1197006236216;624.6158612453399;3965.2466031453932;4026.5570787213383;4044.9191016180102;4107.281225785536;4140.109876376593;87248;92058;100368;102041.48979255056;103778.4811075955;87206;87592;88611.55694221487;88957;90376;74127.88808167882;74990;76678.6166069166;77453.61273193598;79309;7458.73894413693;7642.350400216044;8000.879986800319;8278.751637450887;8316.958415207886;46327.76836115798;53579.7321013408;53842.923141536165;54471;54637.72681136569;70397.64801175961;70409.59180816253;71141.28858711553;76089.61955190188;76621;10277.486125693536;10295.897041029493;10369.481525923824;10453.32053416556;10520.473976301308;11572.884271157182;11623.244489108181;11820.704482387666;12090.15368924202;12383.938080309541;11713.531458741554;11750.118741094622;11826.231294965799;11850.703732406759;12232.694182645506;11501.079913607058;11539.596114135966;11637.418129093681;11706.414679266172;12215.328156951098;11149.609763658558;11629.59296424621;11769.705757356134;11802.291862488279;11858.76282474363;9869.802603947737;10140.239482038729;10167.440790756284;10194.643187488402;10378.117859981987;9802.705918822447;10227.284090113919;10273.9486302571;10378.532966016397;10384.37693738378 17:47:34 INFO - PROCESS | 1950 | __end_tp_report 17:47:34 INFO - PROCESS | 1950 | __start_cc_report 17:47:34 INFO - PROCESS | 1950 | _x_x_mozilla_cycle_collect,389 17:47:34 INFO - PROCESS | 1950 | __end_cc_report 17:47:34 INFO - PROCESS | 1950 | __startTimestamp1466038054611__endTimestamp 17:47:34 INFO - PROCESS | 1950 | 17:47:34 INFO - PROCESS | 1950 | ------- Summary: start ------- 17:47:34 INFO - PROCESS | 1950 | Number of tests: 6 17:47:34 INFO - PROCESS | 1950 | 17:47:34 INFO - PROCESS | 1950 | [#0] dojo.html Cycles:165 Average:5856.62 Median:6121.45 stddev:636.02 (10.4%) stddev-sans-first:613.45 17:47:34 INFO - PROCESS | 1950 | Values: 3626.7 3681.6 3693.1 3713.8 3718.6 5831.4 5833.1 5841.2 5847.7 5889.4 5777.9 5838.0 5873.3 5887.9 5891.0 5280.3 5287.8 5341.2 5349.8 5392.2 4737.7 5270.1 5320.2 5419.8 5441.3 5400.5 5404.5 5422.2 5426.6 5433.2 4521.0 5334.4 5373.5 5402.0 5418.5 5224.5 5291.6 5301.0 5349.2 5349.3 5591.5 5667.3 5709.7 5710.6 5710.7 6312.7 6335.2 6354.0 6366.0 6375.1 6237.8 6245.2 6297.3 6316.5 6327.5 5137.9 5975.3 5985.1 5993.2 6050.4 6188.8 6244.7 6380.3 6388.7 6398.8 5146.7 6090.5 6184.8 6247.2 6321.8 6325.2 6347.8 6351.1 6357.9 6396.0 6303.9 6333.3 6344.4 6347.7 6358.5 6171.9 6269.6 6281.2 6311.2 6347.2 5022.7 5064.6 5073.3 5074.6 5087.6 4584.7 4613.6 4628.8 4653.9 4663.7 5963.6 5968.3 6095.9 6121.4 6132.0 6293.0 6307.3 6320.3 6321.9 6366.4 6079.2 6126.8 6142.0 6153.3 6162.4 5475.5 5479.4 5516.6 5538.5 5555.2 6584.4 6587.0 6624.6 6634.1 6654.4 5696.4 6229.2 6329.7 6351.1 6362.0 6534.6 6630.4 6648.7 6660.0 6691.7 6275.7 6332.7 6343.0 6359.3 6371.9 5285.6 6234.6 6259.4 6337.2 6353.7 4894.5 6151.1 6226.0 6242.8 6272.9 6183.0 6222.0 6239.6 6250.4 6268.8 5731.8 5914.4 6068.3 6081.8 6128.9 5393.7 6245.6 6253.6 6254.0 6255.8 6019.5 6093.0 6096.0 6160.4 6160.5 17:47:34 INFO - PROCESS | 1950 | 17:47:34 INFO - PROCESS | 1950 | [#1] ext.html Cycles:180 Average:67203.27 Median:20692.33 stddev:146872.53 (709.8%) stddev-sans-first:147199.32 17:47:34 INFO - PROCESS | 1950 | Values: 559.8 587.6 590.9 623.9 638.6 40849.8 41814.0 41824.6 41875.0 41885.0 42802.0 43040.4 43461.8 43528.6 43674.7 8978.4 9303.8 9776.0 9912.7 10008.4 8778.1 9835.5 9975.1 10095.5 10105.8 8628.5 10089.8 10090.1 10106.6 10137.3 10019.0 10120.0 10120.1 10129.4 10130.7 9951.7 10062.8 10067.5 10101.8 10236.4 30056.0 41853.8 42091.6 42267.6 42807.1 3244.2 3399.8 3447.8 3729.6 3852.9 29276.7 29954.7 30102.5 30219.9 30373.4 2769.3 2786.8 2787.7 2793.4 2839.8 381681.0 383048.0 383300.1 384025.0 384522.0 38227.4 39349.0 64473.4 64917.0 64932.4 37655.1 37715.4 37817.4 38062.6 38093.8 15139.9 15260.4 15685.4 15797.3 15806.5 13241.8 13283.7 13302.5 13332.5 13350.2 7177.4 8507.5 8608.8 8668.6 8683.8 3582.4 3600.5 3628.3 3640.7 3652.5 1014.3 1035.6 1120.6 1168.4 1201.9 28273.7 29889.6 31480.8 31849.7 31934.7 1167.4 1167.4 1195.6 1228.6 1276.2 16303.0 16338.6 16359.9 16394.6 16424.4 651390.0 653351.0 654899.0 661370.7 663445.0 64507.0 66313.7 66327.7 66442.0 66454.0 1531.1 1539.5 1541.0 1554.9 1560.9 30590.4 31045.2 31323.7 31708.8 31749.5 56395.0 58034.7 58431.1 58561.0 58590.8 567112.0 567308.0 569007.0 571944.0 574026.0 28215.6 28398.7 28971.3 29330.1 29352.7 49003.0 49643.0 49947.8 49969.0 50360.0 40086.4 40266.0 41126.8 41379.4 41433.0 39677.6 40085.0 40093.6 40927.0 41219.2 40460.4 40630.6 41274.4 42138.4 42454.8 25755.0 31429.5 33735.2 33822.0 34259.8 25592.5 25830.2 25874.4 25930.9 26092.9 17:47:34 INFO - PROCESS | 1950 | 17:47:34 INFO - PROCESS | 1950 | [#2] jquery.html Cycles:180 Average:36002.57 Median:11651.42 stddev:105431.50 (904.9%) stddev-sans-first:105693.30 17:47:34 INFO - PROCESS | 1950 | Values: 362.6 368.7 423.2 423.2 434.3 20798.3 21188.8 21422.0 21938.3 21943.5 20785.7 20849.3 20906.9 20940.3 20998.3 5778.8 5869.9 5950.3 6022.2 6069.5 5891.4 5919.4 5927.7 5946.9 6003.9 5759.4 5932.8 5971.4 5985.7 5988.6 5785.2 5842.7 5853.8 5867.0 5871.3 5021.9 5117.2 5124.9 5125.1 5210.3 12701.5 13136.7 13430.3 26417.9 26639.9 2171.0 2273.7 2273.9 2394.7 2820.8 9625.2 10139.4 10141.3 10144.4 10278.0 1799.2 1816.8 1839.2 1902.0 1908.4 119810.4 121667.0 126053.0 130215.0 138400.6 10007.0 11430.7 12208.5 12297.2 12297.6 15384.5 15435.6 15605.5 15644.5 15662.3 8898.8 8965.7 9057.3 9063.7 9086.3 8793.8 8913.7 8955.9 8972.1 9000.7 4671.4 4736.6 4809.3 4813.6 4846.6 1994.5 2066.5 2067.4 2114.1 2124.8 988.3 999.8 1046.9 1081.1 1102.8 17702.2 19973.8 20031.2 20432.1 20841.1 977.2 1001.5 1019.9 1033.2 1071.2 10826.3 10962.9 11006.1 11074.1 11099.8 585747.1 599588.0 624063.0 662843.0 684026.0 95814.0 108695.0 130457.0 135376.0 136750.0 1020.7 1030.4 1036.4 1082.6 1082.8 14323.1 17936.6 18323.0 18413.7 18609.0 43194.7 47880.0 53511.7 56058.4 57503.4 81736.2 83770.2 83869.0 84883.9 86731.6 8075.9 8254.3 8277.6 8470.7 8533.7 9644.9 10476.5 11796.9 12254.4 12477.9 11334.7 11389.2 11505.4 11536.0 11579.4 10424.1 10593.5 11014.7 11242.8 11725.9 8414.5 10885.9 11218.8 11572.4 11711.7 8266.3 8354.7 8459.1 8521.0 8691.8 11168.6 11198.2 11271.6 11321.8 11623.1 17:47:34 INFO - PROCESS | 1950 | 17:47:34 INFO - PROCESS | 1950 | [#3] mootools.html Cycles:180 Average:5911.80 Median:5094.67 stddev:3275.64 (64.3%) stddev-sans-first:3268.99 17:47:34 INFO - PROCESS | 1950 | Values: 1625.1 1662.7 1704.8 2028.2 2077.2 8249.5 8879.1 9032.5 9292.4 9317.9 9004.8 9044.1 9134.7 9144.2 9167.1 2543.5 2548.5 2577.9 2586.5 2589.3 2517.2 2547.3 2552.9 2561.4 2582.5 2165.6 2514.9 2576.9 2579.1 2599.5 2541.1 2541.6 2556.3 2590.8 2591.9 2549.9 2551.8 2577.8 2587.4 2592.1 9247.6 9250.7 9255.2 9311.6 9329.7 5698.6 5701.3 5860.6 5863.0 5869.2 3682.4 3762.6 3778.0 3850.0 3853.0 914.5 1040.7 1064.7 1074.0 1078.4 12153.3 12351.1 12432.6 12629.0 12651.9 4993.8 4998.2 5090.5 5110.7 5125.9 8962.0 8970.1 10499.8 10565.8 10587.0 4868.5 5672.7 5702.0 5717.7 5750.9 4197.2 4518.4 4614.7 5158.6 5173.1 4219.9 4236.9 4280.8 4311.0 4342.7 1375.6 1389.4 1402.5 1402.7 1420.4 907.0 956.7 956.9 972.3 992.7 5567.5 5925.1 6006.5 6065.1 6153.7 921.3 940.9 967.6 996.5 1030.1 3087.4 3930.2 3969.1 3996.0 4030.0 9688.7 11039.0 11125.4 11213.8 11429.9 10982.0 11004.4 11006.2 11046.3 11189.0 8548.8 8633.1 8640.5 8837.5 8872.3 5796.4 5829.4 5880.6 6050.8 6073.3 9896.9 9906.8 10038.9 10093.4 10155.7 9838.6 10027.0 10043.6 10147.6 10184.3 7088.9 7810.7 7940.6 8151.6 8421.8 8430.3 8531.8 8556.1 8562.3 8603.4 6398.0 7471.3 7534.1 7667.7 7833.7 7471.7 7518.2 7538.4 7610.4 7692.8 7177.9 7222.0 7224.4 7261.9 7266.6 4956.0 4964.0 5058.2 5121.3 5127.7 4444.3 5051.6 5098.8 5132.1 5139.6 17:47:34 INFO - PROCESS | 1950 | 17:47:34 INFO - PROCESS | 1950 | [#4] prototype.html Cycles:180 Average:5963.59 Median:6851.81 stddev:1950.43 (28.5%) stddev-sans-first:1908.47 17:47:34 INFO - PROCESS | 1950 | Values: 267.5 307.8 313.5 344.0 345.0 6620.6 6729.7 6752.5 6853.8 6879.7 6760.2 6808.0 6838.8 6849.8 6902.8 4108.6 4584.2 5087.6 5106.1 5158.0 4113.5 5101.5 5103.2 5108.3 5134.6 3850.0 5022.8 5027.7 5047.1 5068.0 4754.8 4919.8 5011.6 5043.5 5056.8 4132.2 4160.6 4168.8 4169.9 4199.9 6398.6 6455.5 6470.5 6492.8 6495.5 5840.8 5853.6 5874.8 5875.1 5875.4 7197.9 7202.9 7213.8 7248.0 7256.5 4534.6 4667.7 4669.4 4684.4 4687.9 6211.6 7543.4 7649.7 7656.3 7719.3 4736.2 4742.8 4765.3 4765.6 4833.9 4836.2 4843.1 4845.7 4850.1 4866.0 5776.7 5787.1 5792.9 5815.5 5816.1 6603.2 7064.3 7289.7 7328.4 7342.9 1653.7 1669.2 1679.1 1679.9 1683.3 996.9 1041.8 1043.1 1063.5 1068.6 6898.3 7050.8 7062.7 7073.9 7077.6 7647.7 7656.6 7673.4 7674.5 7719.7 7034.3 7047.6 7052.4 7058.0 7076.3 3866.8 3982.0 4024.0 4026.8 4047.6 8132.9 8176.8 8177.6 8184.5 8188.8 7786.8 7800.8 7804.3 7855.6 7856.5 8117.4 8129.9 8143.6 8200.3 8211.2 7297.6 7584.5 7590.4 7591.2 7609.0 7423.7 7449.0 7449.2 7453.0 7517.4 6751.0 8083.1 8094.0 8114.8 8117.1 4518.9 4747.1 4754.5 4760.4 4784.5 7131.6 7484.4 7520.2 7548.0 7592.9 5851.6 7272.3 7310.8 7327.9 7337.4 5831.8 7274.0 7277.2 7288.0 7303.8 6870.9 7099.0 7102.5 7106.5 7123.3 7280.0 7286.3 7294.4 7302.0 7324.6 6894.5 6967.9 7111.6 7124.8 7128.1 17:47:34 INFO - PROCESS | 1950 | 17:47:34 INFO - PROCESS | 1950 | [#5] yui.html Cycles:180 Average:19317.93 Median:27058.41 stddev:27728.84 (102.5%) stddev-sans-first:27771.46 17:47:34 INFO - PROCESS | 1950 | Values: 719.8 747.9 749.9 775.2 788.0 14071.6 14684.4 15393.8 15493.2 15702.8 12548.8 14343.6 14374.7 14481.4 14518.9 756.3 920.0 927.1 935.9 940.3 938.3 946.5 947.0 949.7 950.8 954.3 993.7 995.3 996.9 997.7 972.0 979.0 996.3 1000.3 1003.0 719.5 726.3 735.9 735.9 738.5 14701.0 14785.6 15125.3 15173.7 15181.8 10862.3 13068.5 13163.5 13229.8 13269.3 10172.2 10306.7 10337.2 10486.2 10491.8 3577.1 3577.4 3591.9 3643.1 3697.5 82645.6 82766.6 83248.0 85057.0 86543.0 9568.5 9572.6 9611.5 9631.0 9839.5 21625.9 21793.8 21836.8 21868.0 21877.5 7807.3 7813.8 7917.2 7935.8 8076.6 4250.8 4262.8 4297.7 4306.8 4320.8 3753.5 3768.6 3816.6 3819.2 3833.7 592.4 687.1 697.9 708.1 730.4 531.2 569.2 573.9 587.0 598.7 7765.4 8502.2 8516.0 8623.7 8800.9 537.1 586.7 610.8 622.1 624.6 3965.2 4026.6 4044.9 4107.3 4140.1 87248.0 92058.0 100368.0 102041.5 103778.5 87206.0 87592.0 88611.6 88957.0 90376.0 74127.9 74990.0 76678.6 77453.6 79309.0 7458.7 7642.4 8000.9 8278.8 8317.0 46327.8 53579.7 53842.9 54471.0 54637.7 70397.6 70409.6 71141.3 76089.6 76621.0 10277.5 10295.9 10369.5 10453.3 10520.5 11572.9 11623.2 11820.7 12090.2 12383.9 11713.5 11750.1 11826.2 11850.7 12232.7 11501.1 11539.6 11637.4 11706.4 12215.3 11149.6 11629.6 11769.7 11802.3 11858.8 9869.8 10140.2 10167.4 10194.6 10378.1 9802.7 10227.3 10273.9 10378.5 10384.4 17:47:34 INFO - PROCESS | 1950 | -------- Summary: end -------- 17:47:34 INFO - PROCESS | 1950 | 17:47:35 INFO - TEST-INFO | 1950: exit 0 17:47:35 INFO - TEST-OK | dromaeo_css | took 1109858ms 17:47:35 INFO - TEST-START | kraken 17:47:35 INFO - operating with platform_type : mac_ 17:47:35 INFO - Initialising browser for kraken test... 17:47:35 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpn7l8WV/profile http://localhost:51434/getInfo.html) 17:47:37 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 17:47:37 INFO - PROCESS | 1958 | colorDepth:24 17:47:37 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 17:47:37 INFO - PROCESS | 1958 | __metrics 17:47:37 ERROR - PROCESS | 1958 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 17:47:38 INFO - TEST-INFO | 1958: exit 0 17:47:38 INFO - Browser initialized. 17:47:38 INFO - Running cycle 1/1 for kraken test... 17:47:38 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpn7l8WV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:50 INFO - PROCESS | 1962 | RSS: Main: 170762240 17:47:50 INFO - PROCESS | 1962 | 17:47:52 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-beat-detection) 17:47:53 INFO - PROCESS | 1962 | RSS: Main: 183361536 17:47:53 INFO - PROCESS | 1962 | 17:47:56 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-dft) 17:47:57 INFO - PROCESS | 1962 | RSS: Main: 192315392 17:47:57 INFO - PROCESS | 1962 | 17:48:00 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-fft) 17:48:01 INFO - PROCESS | 1962 | RSS: Main: 195764224 17:48:01 INFO - PROCESS | 1962 | 17:48:03 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-oscillator) 17:48:03 INFO - PROCESS | 1962 | RSS: Main: 196980736 17:48:03 INFO - PROCESS | 1962 | 17:48:05 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:48:06 INFO - PROCESS | 1962 | RSS: Main: 197218304 17:48:06 INFO - PROCESS | 1962 | 17:48:09 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51434/tests/kraken/driver.html?testName=imaging-darkroom) 17:48:09 INFO - PROCESS | 1962 | RSS: Main: 197926912 17:48:09 INFO - PROCESS | 1962 | 17:48:12 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51434/tests/kraken/driver.html?testName=imaging-desaturate) 17:48:13 INFO - PROCESS | 1962 | RSS: Main: 198033408 17:48:13 INFO - PROCESS | 1962 | 17:48:16 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51434/tests/kraken/driver.html?testName=json-parse-financial) 17:48:17 INFO - PROCESS | 1962 | RSS: Main: 198103040 17:48:17 INFO - PROCESS | 1962 | 17:48:18 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:48:19 INFO - PROCESS | 1962 | RSS: Main: 197640192 17:48:19 INFO - PROCESS | 1962 | 17:48:21 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:48:21 INFO - PROCESS | 1962 | RSS: Main: 197697536 17:48:21 INFO - PROCESS | 1962 | 17:48:24 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:48:24 INFO - PROCESS | 1962 | RSS: Main: 197832704 17:48:24 INFO - PROCESS | 1962 | 17:48:27 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:48:28 INFO - PROCESS | 1962 | RSS: Main: 198049792 17:48:28 INFO - PROCESS | 1962 | 17:48:30 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:48:31 INFO - PROCESS | 1962 | RSS: Main: 197976064 17:48:31 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51434/tests/kraken/driver.html?testName=ai-astar) 17:48:33 INFO - PROCESS | 1962 | RSS: Main: 199954432 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | __start_tp_report 17:48:33 INFO - PROCESS | 1962 | _x_x_mozilla_page_load 17:48:33 INFO - PROCESS | 1962 | _x_x_mozilla_page_load_details 17:48:33 INFO - PROCESS | 1962 | |i|pagename|runs| 17:48:33 INFO - PROCESS | 1962 | |0;ai-astar;112;118;108;115;119;119;107;121;95;168 17:48:33 INFO - PROCESS | 1962 | |1;audio-beat-detection;161;135;148;158;118;139;131;190;191;122 17:48:33 INFO - PROCESS | 1962 | |2;audio-dft;195;205;197;201;194;199;198;193;198;195 17:48:33 INFO - PROCESS | 1962 | |3;audio-fft;61;71;84;139;46;68;81;91;160;69 17:48:33 INFO - PROCESS | 1962 | |4;audio-oscillator;75;83;131;76;84;93;120;80;79;124 17:48:33 INFO - PROCESS | 1962 | |5;imaging-gaussian-blur;90;86;89;86;118;129;90;86;89;98 17:48:33 INFO - PROCESS | 1962 | |6;imaging-darkroom;110;149;94;120;94;90;90;150;90;151 17:48:33 INFO - PROCESS | 1962 | |7;imaging-desaturate;96;144;145;90;144;132;90;119;151;117 17:48:33 INFO - PROCESS | 1962 | |8;json-parse-financial;58;61;64;63;64;64;64;82;51;49 17:48:33 INFO - PROCESS | 1962 | |9;json-stringify-tinderbox;65;61;69;75;77;70;66;66;66;69 17:48:33 INFO - PROCESS | 1962 | |10;stanford-crypto-aes;82;82;81;79;86;87;80;78;84;82 17:48:33 INFO - PROCESS | 1962 | |11;stanford-crypto-ccm;129;122;124;125;128;126;126;146;139;166 17:48:33 INFO - PROCESS | 1962 | |12;stanford-crypto-pbkdf2;160;164;162;162;164;160;162;161;155;169 17:48:33 INFO - PROCESS | 1962 | |13;stanford-crypto-sha256-iterative;70;64;67;68;70;83;90;94;96;94 17:48:33 INFO - PROCESS | 1962 | __end_tp_report 17:48:33 INFO - PROCESS | 1962 | __start_cc_report 17:48:33 INFO - PROCESS | 1962 | _x_x_mozilla_cycle_collect,1042 17:48:33 INFO - PROCESS | 1962 | __end_cc_report 17:48:33 INFO - PROCESS | 1962 | __startTimestamp1466038113404__endTimestamp 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | ------- Summary: start ------- 17:48:33 INFO - PROCESS | 1962 | Number of tests: 14 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#0] ai-astar Cycles:10 Average:118.20 Median:119.00 stddev:19.16 (16.1%) stddev-sans-first:20.20 17:48:33 INFO - PROCESS | 1962 | Values: 112.0 118.0 108.0 115.0 119.0 119.0 107.0 121.0 95.0 168.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:153.00 stddev:25.78 (16.8%) stddev-sans-first:26.99 17:48:33 INFO - PROCESS | 1962 | Values: 161.0 135.0 148.0 158.0 118.0 139.0 131.0 190.0 191.0 122.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#2] audio-dft Cycles:10 Average:197.50 Median:198.00 stddev:3.60 (1.8%) stddev-sans-first:3.70 17:48:33 INFO - PROCESS | 1962 | Values: 195.0 205.0 197.0 201.0 194.0 199.0 198.0 193.0 198.0 195.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#3] audio-fft Cycles:10 Average:87.00 Median:70.00 stddev:35.58 (50.8%) stddev-sans-first:36.47 17:48:33 INFO - PROCESS | 1962 | Values: 61.0 71.0 84.0 139.0 46.0 68.0 81.0 91.0 160.0 69.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:79.50 stddev:21.78 (27.4%) stddev-sans-first:21.93 17:48:33 INFO - PROCESS | 1962 | Values: 75.0 83.0 131.0 76.0 84.0 93.0 120.0 80.0 79.0 124.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:89.00 stddev:15.08 (16.9%) stddev-sans-first:15.83 17:48:33 INFO - PROCESS | 1962 | Values: 90.0 86.0 89.0 86.0 118.0 129.0 90.0 86.0 89.0 98.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#6] imaging-darkroom Cycles:10 Average:113.80 Median:90.00 stddev:26.81 (29.8%) stddev-sans-first:28.40 17:48:33 INFO - PROCESS | 1962 | Values: 110.0 149.0 94.0 120.0 94.0 90.0 90.0 150.0 90.0 151.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#7] imaging-desaturate Cycles:10 Average:122.80 Median:148.00 stddev:24.01 (16.2%) stddev-sans-first:23.43 17:48:33 INFO - PROCESS | 1962 | Values: 96.0 144.0 145.0 90.0 144.0 132.0 90.0 119.0 151.0 117.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:64.00 stddev:8.97 (14.0%) stddev-sans-first:9.40 17:48:33 INFO - PROCESS | 1962 | Values: 58.0 61.0 64.0 63.0 64.0 64.0 64.0 82.0 51.0 49.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:4.77 (6.9%) stddev-sans-first:4.89 17:48:33 INFO - PROCESS | 1962 | Values: 65.0 61.0 69.0 75.0 77.0 70.0 66.0 66.0 66.0 69.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:2.88 (3.5%) stddev-sans-first:3.06 17:48:33 INFO - PROCESS | 1962 | Values: 82.0 82.0 81.0 79.0 86.0 87.0 80.0 78.0 84.0 82.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:128.50 stddev:13.74 (10.7%) stddev-sans-first:14.49 17:48:33 INFO - PROCESS | 1962 | Values: 129.0 122.0 124.0 125.0 128.0 126.0 126.0 146.0 139.0 166.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:3.57 (2.2%) stddev-sans-first:3.72 17:48:33 INFO - PROCESS | 1962 | Values: 160.0 164.0 162.0 162.0 164.0 160.0 162.0 161.0 155.0 169.0 17:48:33 INFO - PROCESS | 1962 | 17:48:33 INFO - PROCESS | 1962 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.60 Median:86.50 stddev:13.01 (15.0%) stddev-sans-first:13.33 17:48:33 INFO - PROCESS | 1962 | Values: 70.0 64.0 67.0 68.0 70.0 83.0 90.0 94.0 96.0 94.0 17:48:33 INFO - PROCESS | 1962 | -------- Summary: end -------- 17:48:33 INFO - PROCESS | 1962 | 17:48:34 INFO - TEST-INFO | 1962: exit 0 17:48:34 INFO - TEST-OK | kraken | took 58976ms 17:48:34 INFO - SUITE-END | took 1168s 17:48:34 INFO - Completed test suite (00:19:29) 17:48:34 INFO - javascript benchmark 17:48:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3626.6554677305653, 3681.576618688851, 3693.113652723347, 3713.795741234231, 3718.60954599767, 5831.416858314166, 5833.125031245316, 5841.240638716971, 5847.678377689225, 5889.381614930429, 5777.855553611162, 5838.007538718418, 5873.2658417697785, 5887.85280367991, 5890.998530249857, 5280.260763493095, 5287.788488460466, 5341.1988201769855, 5349.786008559653, 5392.164214546751, 4737.668363214576, 5270.1040823060175, 5320.1753728172, 5419.83740487786, 5441.2654291670515, 5400.540954018894, 5404.513593776559, 5422.15956526739, 5426.62013659044, 5433.212184233284, 4520.954790452102, 5334.413214546396, 5373.543248823855, 5402.0, 5418.485243901823, 5224.451432599561, 5291.576673866081, 5301.045811753883, 5349.224362467459, 5349.251104845324, 5591.496765291144, 5667.291588551431, 5709.714514274311, 5710.571707121941, 5710.65736055838, 6312.747490100436, 6335.208098987627, 6354.046892966046, 6366.0, 6375.10748495211, 6237.750489980395, 6245.219347581552, 6297.338779428185, 6316.526260530479, 6327.46216571592, 5137.922931156036, 5975.342712301644, 5985.132155837423, 5993.160957465958, 6050.394960503959, 6188.845278867974, 6244.687765611792, 6380.266269378988, 6388.7125079371535, 6398.776042838478, 5146.6911985281, 6090.451859332681, 6184.783532576338, 6247.219097612799, 6321.810345689637, 6325.209348831396, 6347.777827776005, 6351.110844481776, 6357.904631430532, 6395.968020159962, 6303.905441418382, 6333.334999825044, 6344.365563443711, 6347.714352854133, 6358.491320694333, 6171.876562468815, 6269.592476489013, 6281.214848143982, 6311.1795466589965, 6347.238331400262, 5022.673526220784, 5064.594832413398, 5073.315102461121, 5074.594032477393, 5087.618428617794, 4584.701994370355, 4613.5847773700525, 4628.837990670378, 4653.930191047137, 4663.720176789404, 5963.642181469126, 5968.343482216953, 6095.939040609625, 6121.4490695837585, 6132.04958718918, 6292.968535157295, 6307.306196318401, 6320.304766475684, 6321.905171422432, 6366.427021568081, 6079.240094988127, 6126.785562505291, 6142.04798256271, 6153.29237137726, 6162.445379915739, 5475.534579560703, 5479.369872464637, 5516.613837031369, 5538.47384498472, 5555.2222688823595, 6584.407403333723, 6587.044878492592, 6624.635645039569, 6634.104395906587, 6654.367835055662, 5696.373398926197, 6229.1590635265475, 6329.683515824098, 6351.07909353132, 6361.982082866719, 6534.575252608565, 6630.370114839083, 6648.667566621746, 6660.0, 6691.698873550605, 6275.717592708248, 6332.651704156316, 6343.016832390987, 6359.332270111571, 6371.872562548816, 5285.630005899704, 6234.625922444668, 6259.405356491126, 6337.207849018872, 6353.7140828661895, 4894.510548945077, 6151.0773383992755, 6226.0, 6242.812715618538, 6272.874542509033, 6182.969085154546, 6222.0, 6239.625622462667, 6250.4374606285655, 6268.811935641938, 5731.828045158652, 5914.408559144051, 6068.271807382966, 6081.847953801191, 6128.908066378919, 5393.7033463159905, 6245.6252624842655, 6253.624782513064, 6254.0, 6255.843603909939, 6019.51843852482, 6093.0, 6096.0, 6160.353162917829, 6160.537959652955], "value": 5820.676602584143, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.8348487196276, 587.5710731166248, 590.949769269612, 623.9220097487814, 638.648743191245, 40849.79575102124, 41813.99999999996, 41824.58175418245, 41875.0, 41885.0, 42802.0, 43040.35439468403, 43461.7826910865, 43528.56471435285, 43674.68975930727, 8978.371513994023, 9303.76740581484, 9776.022397760202, 9912.653057143001, 10008.449535275557, 8778.122187781235, 9835.45904975226, 9975.052370024836, 10095.495225238745, 10105.797884042315, 8628.482291062524, 10089.848652270222, 10090.14233790125, 10106.646267380644, 10137.290389672726, 10019.0, 10120.0, 10120.139788118018, 10129.442880641562, 10130.746731331701, 9951.701448956543, 10062.79874402515, 10067.496625168786, 10101.797964040677, 10236.43699596522, 30056.0, 41853.79073104615, 42091.57908420907, 42267.57732422667, 42807.143857122996, 3244.156519304974, 3399.847006884696, 3447.827608619584, 3729.6083911189476, 3852.9229415411537, 29276.707232927823, 29954.70045299541, 30102.54846177309, 30219.942302019324, 30373.392532149453, 2769.3353595137223, 2786.7770578353684, 2787.6515435570554, 2793.3575277686245, 2839.7870159738104, 381681.0, 383048.0, 383300.08349958353, 384025.0, 384522.0, 38227.42658860119, 39349.0, 64473.355266446735, 64917.0, 64932.35067649263, 37655.05862353463, 37715.434268485995, 37817.43273850894, 38062.61937380646, 38093.80953095272, 15139.924300378427, 15260.389584416722, 15685.372585096467, 15797.289121989537, 15806.525804225892, 13241.801372979413, 13283.734325313633, 13302.467901284033, 13332.533361332307, 13350.198988060552, 7177.354038136488, 8507.489550626982, 8608.827823443497, 8668.566571671392, 8683.782905427415, 3582.373084710165, 3600.5319308490252, 3628.310620982005, 3640.690541303966, 3652.4521321801944, 1014.300132908291, 1035.6478797208986, 1120.6021862238952, 1168.363242033077, 1201.9482952416636, 28273.71726282752, 29889.551656725165, 31480.842595787333, 31849.68150318467, 31934.680653193634, 1167.3579531257944, 1167.3987896233446, 1195.5875223048035, 1228.6314105768413, 1276.21512769646, 16302.985698088569, 16338.591535211715, 16359.936604120694, 16394.590135246715, 16424.425145119865, 651390.0, 653351.0, 654899.0, 661370.6931465408, 663445.0, 64507.0, 66313.67372652616, 66327.66836165884, 66442.0, 66454.0, 1531.1272574632576, 1539.5073576455427, 1541.029151634463, 1554.860062594372, 1560.9219539023231, 30590.388192235587, 31045.223869403446, 31323.68676313208, 31708.841455793496, 31749.5237571432, 56395.0, 58034.7098264506, 58431.12353314789, 58561.0, 58590.82818343695, 567112.0, 567308.0, 569007.0, 571944.0, 574026.0, 28215.57676634811, 28398.716012839606, 28971.275718107216, 29330.120096397142, 29352.706472935, 49003.0, 49643.0, 49947.75026124846, 49969.0, 50360.0, 40086.39870401888, 40265.99335016648, 41126.79436602798, 41379.379309309785, 41433.0, 39677.60322396739, 40084.997875053356, 40093.59906401015, 40927.0, 41219.1756164881, 40460.39309410303, 40630.59369406268, 41274.38088428616, 42138.367924480546, 42454.78772606117, 25755.0, 31429.528557071204, 33735.15662108467, 33822.0, 34259.82870085733, 25592.464452132932, 25830.225093247234, 25874.35314117162, 25930.878933343738, 26092.8695356522], "value": 19381.82674929134, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.55586906040094, 368.68661637608034, 423.1579157476622, 423.2445085522343, 434.3202887481092, 20798.272060477888, 21188.788112118895, 21422.0, 21938.341849744513, 21943.451413714643, 20785.688214676753, 20849.270275540322, 20906.895465522688, 20940.267090651792, 20998.26506072288, 5778.768849246025, 5869.8826023479505, 5950.256217972754, 6022.217111775463, 6069.484093852028, 5891.351951285355, 5919.437653422918, 5927.703614819264, 5946.910796338058, 6003.909941350883, 5759.424057594228, 5932.792352267671, 5971.402859714038, 5985.730642121115, 5988.550858685594, 5785.2189954356045, 5842.707864606774, 5853.7951171709, 5867.0, 5871.32479764824, 5021.949780502221, 5117.2068329409, 5124.92312615311, 5125.077486052509, 5210.348706411699, 12701.491940322376, 13136.737265254736, 13430.328483575782, 26417.867910660516, 26639.866800665874, 2170.967435488469, 2273.6703178039256, 2273.920412785561, 2394.7006624171977, 2820.844853533055, 9625.181859541948, 10139.44233067181, 10141.290109692325, 10144.442055686934, 10278.0, 1799.208348326732, 1816.7729033870767, 1839.1539891649857, 1901.9524511887175, 1908.3797765726194, 119810.40094799557, 121667.0, 126053.0, 130215.0, 138400.61599383978, 10007.0, 11430.657080287605, 12208.511659533697, 12297.200681955645, 12297.56958506448, 15384.538463846102, 15435.614109647124, 15605.453809116627, 15644.452444164399, 15662.295196716175, 8898.777530561658, 8965.686200982935, 9057.275417966546, 9063.728088157366, 9086.318526110568, 8793.824123517494, 8913.688020919237, 8955.865662015074, 8972.147645973622, 9000.684976025808, 4671.416072990876, 4736.621070314367, 4809.326694262736, 4813.638977076734, 4846.588040016568, 1994.4914046918234, 2066.524699319165, 2067.390119914629, 2114.059243636567, 2124.798144176301, 988.2785566536469, 999.84018538495, 1046.853440518328, 1081.1242893256488, 1102.8400881872083, 17702.203400846993, 19973.800261997483, 20031.198752050048, 20432.080556375, 20841.102955762504, 977.237754551451, 1001.4592120254981, 1019.8776146862424, 1033.2199189611795, 1071.2287153249647, 10826.296290741077, 10962.890371096188, 11006.119510439146, 11074.134036897176, 11099.778004440028, 585747.0712646409, 599588.0, 624063.0, 662843.0, 684026.0, 95814.0, 108695.0, 130457.0, 135375.96936045968, 136750.0, 1020.6886899495726, 1030.3663247102977, 1036.3781730961364, 1082.6210826210763, 1082.7888561730388, 14323.14061156334, 17936.641267174844, 18323.0, 18413.723794142832, 18609.0, 43194.70415887528, 47880.0, 53511.732441337546, 56058.439415605324, 57503.42496574981, 81736.18263817523, 83770.16229837624, 83869.0, 84883.87790305291, 86731.56634216789, 8075.87886181696, 8254.257116859511, 8277.58612069406, 8470.66117355299, 8533.701320453754, 9644.855327170239, 10476.476176191007, 11796.94101529487, 12254.4485498151, 12477.93761031189, 11334.716632084264, 11389.202755807013, 11505.424728763695, 11536.019438347834, 11579.421028948687, 10424.113950314006, 10593.523291452057, 11014.669559913216, 11242.83135752948, 11725.944664980192, 8414.495130292202, 10885.891141088488, 11218.775624487627, 11572.421378931189, 11711.707207319885, 8266.256036956704, 8354.749357519284, 8459.069502354612, 8520.957395212985, 8691.826163476822, 11168.609098681507, 11198.21612487118, 11271.605493807678, 11321.830172547254, 11623.082191438656], "value": 9669.67038436103, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1625.0655872873097, 1662.717338052531, 1704.8124706282315, 2028.1785876719925, 2077.200277893011, 8249.46378485398, 8879.112088791118, 9032.50321232332, 9292.395994260369, 9317.860232096515, 9004.774880627987, 9044.095590440953, 9134.680286189985, 9144.177024067832, 9167.083291670846, 2543.4531575711217, 2548.5412625727363, 2577.85821779802, 2586.469773696397, 2589.262060312811, 2517.1567524879188, 2547.2867597072755, 2552.8978840846344, 2561.3852675357875, 2582.4835032993383, 2165.5993641176356, 2514.8557406380055, 2576.896924123042, 2579.071534247669, 2599.532084224839, 2541.1233124571995, 2541.606051062079, 2556.3481312265344, 2590.818642695012, 2591.883365248568, 2549.949001019988, 2551.795856331489, 2577.76800087993, 2587.3790290330376, 2592.1057235253807, 9247.583858726373, 9250.72247832566, 9255.213306868856, 9311.627534898664, 9329.72010839676, 5698.629589076697, 5701.287339082614, 5860.589758716891, 5863.032599621058, 5869.2369991901205, 3682.429223470366, 3762.5861155272896, 3777.9811100944594, 3849.961500384988, 3852.9982204626717, 914.4558987402485, 1040.6929955663022, 1064.7391389109641, 1073.9731506712317, 1078.417654466587, 12153.270803751802, 12351.073669474825, 12432.564860229848, 12628.989680825604, 12651.873481265162, 4993.800247990112, 4998.225275082368, 5090.490950904954, 5110.66780659256, 5125.89793194465, 8961.955190224007, 8970.102989700978, 10499.842502362471, 10565.788684226427, 10586.99423554761, 4868.464468908417, 5672.688002159838, 5701.973644743903, 5717.656940583578, 5750.942490575125, 4197.24449599069, 4518.43519560055, 4614.723116613014, 5158.561522270574, 5173.0688476074665, 4219.852305169305, 4236.851710190129, 4280.828766849353, 4310.978445107754, 4342.739435633872, 1375.5529452927638, 1389.4095009621074, 1402.4880918464687, 1402.6843960108895, 1420.3537390487304, 906.9909300907038, 956.6747305916022, 956.8803899512561, 972.2805124208177, 992.7369247149511, 5567.526760225345, 5925.111233314951, 6006.489448396847, 6065.059915713072, 6153.661548614869, 921.2583869984593, 940.9341346105707, 967.5597603090577, 996.5415908681942, 1030.0677886512717, 3087.4133914556164, 3930.194310166409, 3969.0672691917375, 3996.020974861178, 4030.0, 9688.740463739668, 11039.0, 11125.388103654377, 11213.831792523119, 11429.942850285695, 10982.0, 11004.449777511092, 11006.174536909764, 11046.33721976684, 11189.0, 8548.786280342916, 8633.136686331442, 8640.524771137647, 8837.513936733412, 8872.290216782641, 5796.391378905154, 5829.38791426911, 5880.558958078247, 6050.818475445743, 6073.331933487401, 9896.901030989886, 9906.752331191778, 10038.949805251219, 10093.394396336244, 10155.7461063474, 9838.557264923238, 10027.04743049409, 10043.648472303434, 10147.594096236067, 10184.338018028804, 7088.929110708827, 7810.687572497037, 7940.6426710796995, 8151.5924203790755, 8421.831563368822, 8430.283425908621, 8531.829363412573, 8556.058833528432, 8562.315014798925, 8603.440776349516, 6398.0, 7471.290227428385, 7534.0582427196605, 7667.731629392944, 7833.686652533835, 7471.738489152854, 7518.210587888193, 7538.3969282458365, 7610.429217808797, 7692.846143076995, 7177.892331614926, 7222.0, 7224.385927196037, 7261.891071633824, 7266.564006159648, 4955.984023275292, 4963.950360496348, 5058.190689489664, 5121.257417674342, 5127.66670166438, 4444.311131774451, 5051.595872330278, 5098.847034588968, 5132.050570644443, 5139.6145289102715], "value": 4783.537533432855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.5411668987687, 307.8368464713703, 313.5030975903193, 343.9948400773988, 344.97757645753023, 6620.569662971903, 6729.7308107675635, 6752.459803215743, 6853.794386168411, 6879.72481100756, 6760.188777346713, 6807.965960170192, 6838.82902927427, 6849.828754281146, 6902.826519491686, 4108.5686002969705, 4584.243599806036, 5087.6184286178495, 5106.08090543702, 5157.974210128963, 4113.547509773937, 5101.54086132248, 5103.23451482277, 5108.310378098965, 5134.614903882224, 3850.0, 5022.773975171126, 5027.673201241908, 5047.141985862412, 5067.974660126694, 4754.78603462845, 4919.7540122993705, 5011.599072074226, 5043.52086551777, 5056.79772809089, 4132.194222126686, 4160.563140870226, 4168.812403441852, 4169.854055108057, 4199.874003779892, 6398.616083035033, 6455.4835613150835, 6470.4823614110755, 6492.805215843532, 6495.512836537231, 5840.8247752567495, 5853.560982926255, 5874.7943821966455, 5875.089361149029, 5875.353711091777, 7197.89203161953, 7202.855942881113, 7213.819654508627, 7247.963760181218, 7256.528325658868, 4534.6372290216705, 4667.719936803803, 4669.43573902743, 4684.36761037259, 4687.906241875177, 6211.627302361828, 7543.396528277724, 7649.732259370895, 7656.349210317074, 7719.343855772322, 4736.242201247784, 4742.762861856962, 4765.260679851829, 4765.594924431392, 4833.927491087637, 4836.153673107192, 4843.128236917319, 4845.685030473008, 4850.102730994778, 4865.9756701216265, 5776.740046697909, 5787.131930210502, 5792.855178620568, 5815.534757219412, 5816.069428891357, 6603.20761508622, 7064.258252883476, 7289.744858929912, 7328.413726901835, 7342.853142937111, 1653.7271350227318, 1669.1654172913543, 1679.1184628070362, 1679.865610751137, 1683.2846040432767, 996.8704068471052, 1041.8228901086834, 1043.0560342889696, 1063.547992103353, 1068.6206396729206, 6898.2756810535175, 7050.823729406703, 7062.71749130029, 7073.893891591631, 7077.6461176941975, 7647.655855486517, 7656.578888161093, 7673.424493163036, 7674.462787604814, 7719.729809456642, 7034.296570343027, 7047.577145371191, 7052.365287124184, 7058.047163632844, 7076.32774886385, 3866.7873266970587, 3981.960180398217, 4023.979880100639, 4026.7583944963394, 4047.6357127858632, 8132.878006829902, 8176.7955801105445, 8177.6320065596, 8184.468009579358, 8188.754337369888, 7786.805329866798, 7800.765977020698, 7804.3366313862825, 7855.567943763148, 7856.528608283521, 8117.350611951029, 8129.918700813035, 8143.592820358958, 8200.26197642215, 8211.21993410637, 7297.598632075074, 7584.5070070445245, 7590.354819840375, 7591.240875912586, 7609.032477333733, 7423.703051877865, 7448.9627551861895, 7449.217832127549, 7453.031105956191, 7517.43619228571, 6751.021101940093, 8083.110857805519, 8094.0, 8114.83770324602, 8117.147699491468, 4518.932216016697, 4747.14551380741, 4754.548317909793, 4760.428748550057, 4784.473707892199, 7131.572105673677, 7484.363829074589, 7520.247975202655, 7548.018757561482, 7592.886916364264, 5851.561132914963, 7272.309130632581, 7310.817229569303, 7327.926720732725, 7337.376323012603, 5831.825045248649, 7273.9636301818155, 7277.16312624055, 7288.0, 7303.817404564928, 6870.896936546056, 7098.964505177441, 7102.538335008208, 7106.467014973794, 7123.252058533986, 7279.980802687522, 7286.271372862671, 7294.416446684147, 7302.0142280791415, 7324.597147156957, 6894.482913781587, 6967.895481567882, 7111.573305601681, 7124.750633727795, 7128.073350464407], "value": 5297.862100922579, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.7588807749404, 747.8616455955648, 749.947503674743, 775.1666958020129, 788.026786918156, 14071.592840715923, 14684.41262349506, 15393.846061539409, 15493.22533873306, 15702.764458533102, 12548.811767823467, 14343.64140896478, 14374.712505749878, 14481.420743170287, 14518.927405362985, 756.3457609168086, 919.9724008279729, 927.1238679447924, 935.9438433694, 940.2571968145157, 938.3056538161779, 946.4557879219442, 947.0292949726551, 949.6818565780437, 950.8383574792302, 954.2604481526838, 993.7366597851538, 995.2833959549113, 996.9052939970691, 997.6907158780765, 971.961121555137, 979.045430705064, 996.3225006995241, 1000.2748007694399, 1002.9949850250702, 719.4999475364624, 726.3317747672154, 735.8969744235811, 735.91904890462, 738.4978214813924, 14700.970932034761, 14785.556433307018, 15125.319360628799, 15173.696526069416, 15181.848181518153, 10862.293950893167, 13068.542601009014, 13163.539276125386, 13229.801552976713, 13269.270190139538, 10172.186225102048, 10306.7423314417, 10337.173026157889, 10486.213533984905, 10491.79016419675, 3577.141486043357, 3577.3560759063616, 3591.928161436783, 3643.143861192618, 3697.5378077740284, 82645.58677206635, 82766.58616706877, 83248.0, 85057.0, 86542.99999999937, 9568.47373394456, 9572.56923438447, 9611.471369074628, 9631.0, 9839.458829764431, 21625.891870540545, 21793.782062179176, 21836.781632183793, 21868.0, 21877.453063673536, 7807.336376408069, 7813.843723125619, 7917.247861453153, 7935.801604959806, 8076.596170191467, 4250.766207858597, 4262.786860656955, 4297.699161058696, 4306.827726890952, 4320.848770293088, 3753.49327840738, 3768.566614839274, 3816.6183381661613, 3819.1979684266616, 3833.6933045356304, 592.3780030967467, 687.089606271692, 697.8848489999194, 708.1183926012147, 730.3864753606996, 531.2482836785982, 569.2457493820704, 573.8880918220907, 586.9882602348015, 598.6617561077977, 7765.378769698411, 8502.234798868132, 8515.957420212982, 8623.698170564001, 8800.911990880137, 537.0976759044842, 586.6656006076581, 610.8472881779555, 622.1197006236216, 624.6158612453399, 3965.2466031453932, 4026.5570787213383, 4044.9191016180102, 4107.281225785536, 4140.109876376593, 87248.0, 92058.0, 100368.0, 102041.48979255056, 103778.4811075955, 87206.0, 87592.0, 88611.55694221487, 88957.0, 90376.0, 74127.88808167882, 74990.0, 76678.6166069166, 77453.61273193598, 79309.0, 7458.73894413693, 7642.350400216044, 8000.879986800319, 8278.751637450887, 8316.958415207886, 46327.76836115798, 53579.7321013408, 53842.923141536165, 54471.0, 54637.72681136569, 70397.64801175961, 70409.59180816253, 71141.28858711553, 76089.61955190188, 76621.0, 10277.486125693536, 10295.897041029493, 10369.481525923824, 10453.32053416556, 10520.473976301308, 11572.884271157182, 11623.244489108181, 11820.704482387666, 12090.15368924202, 12383.938080309541, 11713.531458741554, 11750.118741094622, 11826.231294965799, 11850.703732406759, 12232.694182645506, 11501.079913607058, 11539.596114135966, 11637.418129093681, 11706.414679266172, 12215.328156951098, 11149.609763658558, 11629.59296424621, 11769.705757356134, 11802.291862488279, 11858.76282474363, 9869.802603947737, 10140.239482038729, 10167.440790756284, 10194.643187488402, 10378.117859981987, 9802.705918822447, 10227.284090113919, 10273.9486302571, 10378.532966016397, 10384.37693738378], "value": 7135.462602833043, "unit": "score"}], "name": "dromaeo_css", "value": 7629.820273017131, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 118.0, 108.0, 115.0, 119.0, 119.0, 107.0, 121.0, 95.0, 168.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 135.0, 148.0, 158.0, 118.0, 139.0, 131.0, 190.0, 191.0, 122.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 205.0, 197.0, 201.0, 194.0, 199.0, 198.0, 193.0, 198.0, 195.0], "value": 197.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 71.0, 84.0, 139.0, 46.0, 68.0, 81.0, 91.0, 160.0, 69.0], "value": 87.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 131.0, 76.0, 84.0, 93.0, 120.0, 80.0, 79.0, 124.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 89.0, 86.0, 118.0, 129.0, 90.0, 86.0, 89.0, 98.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 149.0, 94.0, 120.0, 94.0, 90.0, 90.0, 150.0, 90.0, 151.0], "value": 113.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 144.0, 145.0, 90.0, 144.0, 132.0, 90.0, 119.0, 151.0, 117.0], "value": 122.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 64.0, 63.0, 64.0, 64.0, 64.0, 82.0, 51.0, 49.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 69.0, 75.0, 77.0, 70.0, 66.0, 66.0, 66.0, 69.0], "value": 68.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 79.0, 86.0, 87.0, 80.0, 78.0, 84.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 122.0, 124.0, 125.0, 128.0, 126.0, 126.0, 146.0, 139.0, 166.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 162.0, 162.0, 164.0, 160.0, 162.0, 161.0, 155.0, 169.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 64.0, 67.0, 68.0, 70.0, 83.0, 90.0, 94.0, 96.0, 94.0], "value": 79.6, "unit": "score"}], "name": "kraken", "value": 1566.2999999999997, "alertThreshold": 2.0}]} 17:48:34 INFO - Return code: 0 17:48:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:48:34 ERROR - # TBPL SUCCESS # 17:48:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:48:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:48:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:48:34 INFO - 2016-06-15 17:48:34.712 screenresolution[1967:16797] starting screenresolution argv=screenresolution get 17:48:34 INFO - 2016-06-15 17:48:34.714 screenresolution[1967:16797] Display 0: 1600x1200x32@60 17:48:34 INFO - 2016-06-15 17:48:34.720 screenresolution[1968:16800] starting screenresolution argv=screenresolution list 17:48:34 INFO - Available Modes on Display 0 17:48:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:48:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:48:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:48:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:48:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:48:34 INFO - Intel Iris: 17:48:34 INFO - Chipset Model: Intel Iris 17:48:34 INFO - Type: GPU 17:48:34 INFO - Bus: Built-In 17:48:34 INFO - VRAM (Dynamic, Max): 1536 MB 17:48:34 INFO - Vendor: Intel (0x8086) 17:48:34 INFO - Device ID: 0x0a2e 17:48:34 INFO - Revision ID: 0x0009 17:48:34 INFO - Displays: 17:48:34 INFO - Display: 17:48:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:48:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:48:34 INFO - Display Serial Number: 1600x1200 60 17:48:34 INFO - Main Display: Yes 17:48:34 INFO - Mirror: Off 17:48:34 INFO - Online: Yes 17:48:34 INFO - Rotation: Supported 17:48:34 INFO - Return code: 0 17:48:34 INFO - Running post-action listener: _resource_record_post_action 17:48:34 INFO - Running post-run listener: _resource_record_post_run 17:48:36 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 692224; Write bytes: 496819200; Read time: 10; Write time: 1587 17:48:36 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194550272; Write bytes: 196425216; Read time: 17650; Write time: 434 17:48:36 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 692224; Write bytes: 299447808; Read time: 10; Write time: 1147 17:48:36 INFO - Running post-run listener: _upload_blobber_files 17:48:36 INFO - Blob upload gear active. 17:48:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:48:36 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 17:48:36 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'] 17:48:36 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 17:48:36 INFO - (blobuploader) - INFO - Open directory for files ... 17:48:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:48:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:48:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:37 INFO - (blobuploader) - INFO - Done attempting. 17:48:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:48:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:48:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:38 INFO - (blobuploader) - INFO - Done attempting. 17:48:38 INFO - (blobuploader) - INFO - Iteration through files over. 17:48:38 INFO - Return code: 0 17:48:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:48:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:48:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cf0808b70304d883919cea44ab2f15218b30b68a3cdc908dfd2c044b481c8748d1c05706951ed686b63b13ed2fb7f22ef599a0cb7c6f236a5fb9c9d1cda2f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/901771c2c5a3ab34ff8164a5b305cf487c893ae815586b7a672987c0e956188a702a0ee4a52373048505e7cabd2b6e91784967d7c83c45207624ea755246d3bc"} 17:48:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:48:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:48:38 INFO - Contents: 17:48:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cf0808b70304d883919cea44ab2f15218b30b68a3cdc908dfd2c044b481c8748d1c05706951ed686b63b13ed2fb7f22ef599a0cb7c6f236a5fb9c9d1cda2f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/901771c2c5a3ab34ff8164a5b305cf487c893ae815586b7a672987c0e956188a702a0ee4a52373048505e7cabd2b6e91784967d7c83c45207624ea755246d3bc"} 17:48:38 INFO - Running post-run listener: copy_logs_to_upload_dir 17:48:38 INFO - Copying logs to upload dir... 17:48:38 INFO - mkdir: /builds/slave/test/build/upload/logs 17:48:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.587320 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-06-15 17:48:38.153431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 17:48:38.157125) ========= 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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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/2cf0808b70304d883919cea44ab2f15218b30b68a3cdc908dfd2c044b481c8748d1c05706951ed686b63b13ed2fb7f22ef599a0cb7c6f236a5fb9c9d1cda2f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/901771c2c5a3ab34ff8164a5b305cf487c893ae815586b7a672987c0e956188a702a0ee4a52373048505e7cabd2b6e91784967d7c83c45207624ea755246d3bc"} build_url:https://queue.taskcluster.net/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/J-XoEt-FR3WAb2eKqoD1hQ/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/2cf0808b70304d883919cea44ab2f15218b30b68a3cdc908dfd2c044b481c8748d1c05706951ed686b63b13ed2fb7f22ef599a0cb7c6f236a5fb9c9d1cda2f0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/901771c2c5a3ab34ff8164a5b305cf487c893ae815586b7a672987c0e956188a702a0ee4a52373048505e7cabd2b6e91784967d7c83c45207624ea755246d3bc"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 17:48:38.193637) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:48:38.194471) ========= 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.z1RvgDZWEV/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.Ej0qW8Dery/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.005183 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:48:38.247103) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 17:48:38.247801) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 17:48:38.248550) ========= ========= Total master_lag: 0.20 =========