builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0030 starttime: 1464430027.28 results: success (0) buildid: 20160525152143 builduid: 8654ccbbea454f27b451ee4808dca30e revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:07.278466) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:07.278831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:07.279096) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:07.381163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:07.381436) ========= 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.TPxa1xFwMI/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.V9qAineymd/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-28 03:07:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-05-28 03:07:07 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.515831 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:07.931282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:07.931569) ========= 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.TPxa1xFwMI/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.V9qAineymd/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.020341 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:07.981230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:07:07.981563) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --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-aurora --rev 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TPxa1xFwMI/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.V9qAineymd/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-28 03:07:08,058 truncating revision to first 12 chars 2016-05-28 03:07:08,058 Setting DEBUG logging. 2016-05-28 03:07:08,058 attempt 1/10 2016-05-28 03:07:08,058 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4f7c3a2567f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:07:08,887 unpacking tar archive at: mozilla-aurora-4f7c3a2567f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.080298 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:07:09.080998) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:09.081287) ========= script_repo_revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:09.081650) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:09.081909) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:07:09.097941) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-05-28 03:07:09.098218) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TPxa1xFwMI/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.V9qAineymd/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 03:07:09 INFO - MultiFileLogger online at 20160528 03:07:09 in /builds/slave/test 03:07:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:07:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:07:09 INFO - {'append_to_log': False, 03:07:09 INFO - 'base_work_dir': '/builds/slave/test', 03:07:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:07:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:07:09 INFO - 'branch': 'Mozilla-Aurora', 03:07:09 INFO - 'buildbot_json_path': 'buildprops.json', 03:07:09 INFO - 'config_files': ('talos/mac_config.py',), 03:07:09 INFO - 'default_actions': ('clobber', 03:07:09 INFO - 'read-buildbot-config', 03:07:09 INFO - 'download-and-extract', 03:07:09 INFO - 'populate-webroot', 03:07:09 INFO - 'create-virtualenv', 03:07:09 INFO - 'install', 03:07:09 INFO - 'run-tests'), 03:07:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:07:09 INFO - 'download_minidump_stackwalk': True, 03:07:09 INFO - 'download_symbols': 'ondemand', 03:07:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:07:09 INFO - 'tooltool.py': '/tools/tooltool.py', 03:07:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:07:09 INFO - '/tools/misc-python/virtualenv.py')}, 03:07:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:07:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:07:09 INFO - 'installer_path': 'installer.exe', 03:07:09 INFO - 'log_level': 'info', 03:07:09 INFO - 'log_name': 'talos', 03:07:09 INFO - 'log_to_console': True, 03:07:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:07:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:07:09 INFO - 'opt_config_files': (), 03:07:09 INFO - 'pip_index': False, 03:07:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:07:09 INFO - 'cmd': ('bash', 03:07:09 INFO - '-c', 03:07:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:07:09 INFO - 'enabled': True, 03:07:09 INFO - 'halt_on_failure': False, 03:07:09 INFO - 'name': 'check_screen_resolution'},), 03:07:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:07:09 INFO - 'cmd': ('bash', 03:07:09 INFO - '-c', 03:07:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:07:09 INFO - 'enabled': True, 03:07:09 INFO - 'halt_on_failure': False, 03:07:09 INFO - 'name': 'check_screen_resolution'},), 03:07:09 INFO - 'run_cmd_checks_enabled': True, 03:07:09 INFO - 'sps_profile': False, 03:07:09 INFO - 'sps_profile_interval': 0, 03:07:09 INFO - 'suite': 'dromaeojs', 03:07:09 INFO - 'system_bits': '32', 03:07:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:07:09 INFO - 'title': 't-yosemite-r7-0030', 03:07:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:07:09 INFO - 'use_talos_json': True, 03:07:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:07:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:07:09 INFO - 'work_dir': 'build'} 03:07:09 INFO - ##### 03:07:09 INFO - ##### Running clobber step. 03:07:09 INFO - ##### 03:07:09 INFO - Running pre-action listener: _resource_record_pre_action 03:07:09 INFO - Running main action method: clobber 03:07:09 INFO - rmtree: /builds/slave/test/build 03:07:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:07:10 INFO - Running post-action listener: _resource_record_post_action 03:07:10 INFO - ##### 03:07:10 INFO - ##### Running read-buildbot-config step. 03:07:10 INFO - ##### 03:07:10 INFO - Running pre-action listener: _resource_record_pre_action 03:07:10 INFO - Running main action method: read_buildbot_config 03:07:10 INFO - Using buildbot properties: 03:07:10 INFO - { 03:07:10 INFO - "project": "", 03:07:10 INFO - "product": "firefox", 03:07:10 INFO - "script_repo_revision": "production", 03:07:10 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:07:10 INFO - "repository": "", 03:07:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:07:10 INFO - "buildid": "20160525152143", 03:07:10 INFO - "pgo_build": "False", 03:07:10 INFO - "basedir": "/builds/slave/test", 03:07:10 INFO - "buildnumber": 12, 03:07:10 INFO - "slavename": "t-yosemite-r7-0030", 03:07:10 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 03:07:10 INFO - "platform": "yosemite_r7", 03:07:10 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:07:10 INFO - "branch": "mozilla-aurora", 03:07:10 INFO - "repo_path": "releases/mozilla-aurora", 03:07:10 INFO - "revision": "4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3", 03:07:10 INFO - "stage_platform": "macosx64", 03:07:10 INFO - "builduid": "8654ccbbea454f27b451ee4808dca30e", 03:07:10 INFO - "slavebuilddir": "test" 03:07:10 INFO - } 03:07:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 03:07:10 INFO - Running post-action listener: _resource_record_post_action 03:07:10 INFO - ##### 03:07:10 INFO - ##### Running download-and-extract step. 03:07:10 INFO - ##### 03:07:10 INFO - Running pre-action listener: _resource_record_pre_action 03:07:10 INFO - Running main action method: download_and_extract 03:07:10 INFO - mkdir: /builds/slave/test/build/tests 03:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:10 INFO - https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:07:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 03:07:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 03:07:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 03:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 03:07:12 INFO - Downloaded 1199 bytes. 03:07:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 03:07:12 INFO - Using the following test package requirements: 03:07:12 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 03:07:12 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 03:07:12 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 03:07:12 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:07:12 INFO - u'jsshell-mac.zip'], 03:07:12 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 03:07:12 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 03:07:12 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 03:07:12 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 03:07:12 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 03:07:12 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:07:12 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 03:07:12 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:12 INFO - https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:07:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:07:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:07:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:07:13 INFO - Downloaded 18425352 bytes. 03:07:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:07:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:07:16 INFO - Return code: 0 03:07:16 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:16 INFO - https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:07:19 INFO - Downloaded 18425352 bytes. 03:07:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:07:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:07:23 INFO - Return code: 0 03:07: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')]} 03:07:23 INFO - https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:07:24 INFO - Downloaded 10840145 bytes. 03:07:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:07:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:07:24 INFO - Return code: 0 03:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:24 INFO - https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 03:07:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:07:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:07:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 03:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 03:07:32 INFO - Downloaded 114138629 bytes. 03:07:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:07:32 INFO - mkdir: /builds/slave/test/properties 03:07:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:07:32 INFO - Writing to file /builds/slave/test/properties/build_url 03:07:32 INFO - Contents: 03:07:32 INFO - build_url:https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:07:33 INFO - Running post-action listener: _resource_record_post_action 03:07:33 INFO - Running post-action listener: set_extra_try_arguments 03:07:33 INFO - ##### 03:07:33 INFO - ##### Running populate-webroot step. 03:07:33 INFO - ##### 03:07:33 INFO - Running pre-action listener: _resource_record_pre_action 03:07:33 INFO - Running main action method: populate_webroot 03:07:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:07:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:07:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:07:33 INFO - '--tppagecycles', 03:07:33 INFO - '7'], 03:07:33 INFO - 'tests': ['tsvgm']}}, 03:07:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:07:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:07:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:07:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:07:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:07:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:07:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:33 INFO - 'talos_options': ['--disable-e10s'], 03:07:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:33 INFO - 'talos_options': ['--disable-e10s'], 03:07:33 INFO - 'tests': ['damp', 'tps']}, 03:07:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:33 INFO - 'tests': ['damp', 'tps']}, 03:07:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:07:33 INFO - 'tests': ['dromaeo_dom']}, 03:07:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:07:33 INFO - 'tests': ['a11yr', 03:07:33 INFO - 'ts_paint', 03:07:33 INFO - 'tpaint', 03:07:33 INFO - 'sessionrestore', 03:07:33 INFO - 'sessionrestore_no_auto_restore', 03:07:33 INFO - 'tabpaint']}, 03:07:33 INFO - 'other-e10s': {'tests': ['a11yr', 03:07:33 INFO - 'ts_paint', 03:07:33 INFO - 'tpaint', 03:07:33 INFO - 'sessionrestore', 03:07:33 INFO - 'sessionrestore_no_auto_restore', 03:07:33 INFO - 'tabpaint']}, 03:07:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:07:33 INFO - 'ts_paint', 03:07:33 INFO - 'tpaint', 03:07:33 INFO - 'sessionrestore', 03:07:33 INFO - 'sessionrestore_no_auto_restore', 03:07:33 INFO - 'tabpaint']}, 03:07:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:07:33 INFO - 'ts_paint', 03:07:33 INFO - 'tpaint', 03:07:33 INFO - 'sessionrestore', 03:07:33 INFO - 'sessionrestore_no_auto_restore', 03:07:33 INFO - 'tabpaint']}, 03:07:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:07:33 INFO - 'tests': ['a11yr', 03:07:33 INFO - 'ts_paint', 03:07:33 INFO - 'tpaint', 03:07:33 INFO - 'sessionrestore', 03:07:33 INFO - 'sessionrestore_no_auto_restore', 03:07:33 INFO - 'tabpaint']}, 03:07:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:07:33 INFO - 'tests': ['a11yr', 03:07:33 INFO - 'ts_paint', 03:07:33 INFO - 'tpaint', 03:07:33 INFO - 'sessionrestore', 03:07:33 INFO - 'sessionrestore_no_auto_restore', 03:07:33 INFO - 'tabpaint']}, 03:07:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:07:33 INFO - 'tests': ['tsvgx', 03:07:33 INFO - 'tsvgr_opacity', 03:07:33 INFO - 'tart', 03:07:33 INFO - 'tscrollx', 03:07:33 INFO - 'cart']}, 03:07:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:07:33 INFO - 'tsvgr_opacity', 03:07:33 INFO - 'tart', 03:07:33 INFO - 'tscrollx', 03:07:33 INFO - 'cart']}, 03:07:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:33 INFO - 'talos_options': ['--disable-e10s'], 03:07:33 INFO - 'tests': ['tp5o']}, 03:07:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:33 INFO - 'tests': ['tp5o']}, 03:07:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:33 INFO - 'talos_options': ['--disable-e10s', 03:07:33 INFO - '--xperf_path', 03:07:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:33 INFO - 'tests': ['tp5n']}, 03:07:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:33 INFO - 'talos_options': ['--xperf_path', 03:07:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:33 INFO - 'tests': ['tp5n']}}, 03:07:33 INFO - 'talos.zip': {'path': '', 03:07:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:07:33 INFO - Running post-action listener: _resource_record_post_action 03:07:33 INFO - ##### 03:07:33 INFO - ##### Running create-virtualenv step. 03:07:33 INFO - ##### 03:07:33 INFO - Running pre-action listener: _resource_record_pre_action 03:07:33 INFO - Running main action method: create_virtualenv 03:07:33 INFO - Creating virtualenv /builds/slave/test/build/venv 03:07:33 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 03:07:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:07:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:34 INFO - Using real prefix '/tools/python27' 03:07:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:07:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:07:37 INFO - Installing pip.................done. 03:07:37 INFO - Return code: 0 03:07:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa434184c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c6e00>, '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 0x10402fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c1b20>, '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.TPxa1xFwMI/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.V9qAineymd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 03:07: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', 'pip>=1.5'] in /builds/slave/test/build 03:07: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 pip>=1.5 03:07:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPxa1xFwMI/Render', 03:07:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:37 INFO - 'HOME': '/Users/cltbld', 03:07:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:37 INFO - 'LOGNAME': 'cltbld', 03:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:37 INFO - 'MOZ_NO_REMOTE': '1', 03:07:37 INFO - 'NO_EM_RESTART': '1', 03:07:37 INFO - 'PAGER': '/bin/cat', 03:07:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:37 INFO - 'PWD': '/builds/slave/test', 03:07:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:37 INFO - 'SHELL': '/bin/bash', 03:07:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V9qAineymd/Listeners', 03:07:37 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:07:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:37 INFO - 'USER': 'cltbld', 03:07:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:37 INFO - 'XPC_FLAGS': '0x0', 03:07:37 INFO - 'XPC_SERVICE_NAME': '0', 03:07:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:37 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 03:07:37 INFO - Cleaning up... 03:07:37 INFO - Return code: 0 03:07:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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', '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 0x104327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa434184c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c6e00>, '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 0x10402fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c1b20>, '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.TPxa1xFwMI/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.V9qAineymd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 03:07: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:07: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 psutil>=0.7.1 03:07:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPxa1xFwMI/Render', 03:07:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:37 INFO - 'HOME': '/Users/cltbld', 03:07:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:37 INFO - 'LOGNAME': 'cltbld', 03:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:37 INFO - 'MOZ_NO_REMOTE': '1', 03:07:37 INFO - 'NO_EM_RESTART': '1', 03:07:37 INFO - 'PAGER': '/bin/cat', 03:07:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:37 INFO - 'PWD': '/builds/slave/test', 03:07:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:37 INFO - 'SHELL': '/bin/bash', 03:07:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V9qAineymd/Listeners', 03:07:37 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:07:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:37 INFO - 'USER': 'cltbld', 03:07:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:37 INFO - 'XPC_FLAGS': '0x0', 03:07:37 INFO - 'XPC_SERVICE_NAME': '0', 03:07:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:38 INFO - Downloading/unpacking psutil>=0.7.1 03:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:07:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:41 INFO - Installing collected packages: psutil 03:07:41 INFO - Running setup.py install for psutil 03:07:41 INFO - building 'psutil._psutil_osx' extension 03:07:41 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 03:07:41 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 03:07:41 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 03:07:42 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 03:07:42 INFO - building 'psutil._psutil_posix' extension 03:07:42 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 03:07:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:07:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:07:42 INFO - ^ 03:07:42 INFO - 1 warning generated. 03:07:42 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 03:07:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:07:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:07:42 INFO - Successfully installed psutil 03:07:42 INFO - Cleaning up... 03:07:42 INFO - Return code: 0 03:07:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:07:42 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')]} 03:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:42 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')]} 03:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:42 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 0x104327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa434184c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c6e00>, '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 0x10402fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c1b20>, '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.TPxa1xFwMI/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.V9qAineymd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 03:07:42 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 03:07:42 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 03:07:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPxa1xFwMI/Render', 03:07:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:42 INFO - 'HOME': '/Users/cltbld', 03:07:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:42 INFO - 'LOGNAME': 'cltbld', 03:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:42 INFO - 'MOZ_NO_REMOTE': '1', 03:07:42 INFO - 'NO_EM_RESTART': '1', 03:07:42 INFO - 'PAGER': '/bin/cat', 03:07:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:42 INFO - 'PWD': '/builds/slave/test', 03:07:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:42 INFO - 'SHELL': '/bin/bash', 03:07:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V9qAineymd/Listeners', 03:07:42 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:07:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:42 INFO - 'USER': 'cltbld', 03:07:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:42 INFO - 'XPC_FLAGS': '0x0', 03:07:42 INFO - 'XPC_SERVICE_NAME': '0', 03:07:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:07:42 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 03:07:42 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 03:07:42 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 03:07:42 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 03:07:42 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 03:07:42 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 03:07:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:07:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:07:45 INFO - Installing collected packages: mozsystemmonitor 03:07:45 INFO - Running setup.py install for mozsystemmonitor 03:07:45 INFO - Successfully installed mozsystemmonitor 03:07:45 INFO - Cleaning up... 03:07:45 INFO - Return code: 0 03:07:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:07:45 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')]} 03:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:45 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')]} 03:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:45 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 0x104327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa434184c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c6e00>, '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 0x10402fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c1b20>, '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.TPxa1xFwMI/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.V9qAineymd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 03:07:45 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 03:07:45 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 03:07:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPxa1xFwMI/Render', 03:07:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:45 INFO - 'HOME': '/Users/cltbld', 03:07:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:45 INFO - 'LOGNAME': 'cltbld', 03:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:45 INFO - 'MOZ_NO_REMOTE': '1', 03:07:45 INFO - 'NO_EM_RESTART': '1', 03:07:45 INFO - 'PAGER': '/bin/cat', 03:07:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:45 INFO - 'PWD': '/builds/slave/test', 03:07:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:45 INFO - 'SHELL': '/bin/bash', 03:07:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V9qAineymd/Listeners', 03:07:45 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:07:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:45 INFO - 'USER': 'cltbld', 03:07:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:45 INFO - 'XPC_FLAGS': '0x0', 03:07:45 INFO - 'XPC_SERVICE_NAME': '0', 03:07:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:07:45 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 03:07:45 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 03:07:45 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 03:07:45 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 03:07:45 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 03:07:45 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 03:07:48 INFO - Downloading blobuploader-1.2.4.tar.gz 03:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:07:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:07:48 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 03:07:48 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 03:07:48 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 03:07:48 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 03:07:48 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 03:07:48 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 03:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:07:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:07:48 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 03:07:48 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 03:07:48 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 03:07:48 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 03:07:48 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 03:07:48 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 03:07:49 INFO - Downloading docopt-0.6.1.tar.gz 03:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:07:49 INFO - Installing collected packages: blobuploader, requests, docopt 03:07:49 INFO - Running setup.py install for blobuploader 03:07:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:07:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:07:49 INFO - Running setup.py install for requests 03:07:49 INFO - Running setup.py install for docopt 03:07:50 INFO - Successfully installed blobuploader requests docopt 03:07:50 INFO - Cleaning up... 03:07:50 INFO - Return code: 0 03:07:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:50 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 0x104327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa434184c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c6e00>, '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 0x10402fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c1b20>, '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.TPxa1xFwMI/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.V9qAineymd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 03:07:50 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 03:07:50 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 03:07:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPxa1xFwMI/Render', 03:07:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:50 INFO - 'HOME': '/Users/cltbld', 03:07:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:50 INFO - 'LOGNAME': 'cltbld', 03:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:50 INFO - 'MOZ_NO_REMOTE': '1', 03:07:50 INFO - 'NO_EM_RESTART': '1', 03:07:50 INFO - 'PAGER': '/bin/cat', 03:07:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:50 INFO - 'PWD': '/builds/slave/test', 03:07:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:50 INFO - 'SHELL': '/bin/bash', 03:07:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V9qAineymd/Listeners', 03:07:50 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:07:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:50 INFO - 'USER': 'cltbld', 03:07:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:50 INFO - 'XPC_FLAGS': '0x0', 03:07:50 INFO - 'XPC_SERVICE_NAME': '0', 03:07:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:50 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Bkndx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:50 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-W0Rbre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:50 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-DABwBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:50 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-3znMuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:50 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-JZYIt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Ccun8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-wmOJR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-DGZina-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-mfZpjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-xyGoH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-cDiCX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-QQEzIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-B8x5XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Wms_8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:51 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-b_C22p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:52 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Q1JTQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:52 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-K5HKo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:07:52 INFO - Running setup.py install for manifestparser 03:07:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:07:52 INFO - Running setup.py install for mozcrash 03:07:52 INFO - Running setup.py install for mozdebug 03:07:52 INFO - Running setup.py install for mozdevice 03:07:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:07:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:07:52 INFO - Running setup.py install for mozfile 03:07:53 INFO - Running setup.py install for mozhttpd 03:07:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:07:53 INFO - Running setup.py install for mozinfo 03:07:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:07:53 INFO - Running setup.py install for mozInstall 03:07:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:07:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:07:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:07:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:07:53 INFO - Running setup.py install for mozleak 03:07:53 INFO - Running setup.py install for mozlog 03:07:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:07:53 INFO - Running setup.py install for moznetwork 03:07:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:07:53 INFO - Running setup.py install for mozprocess 03:07:54 INFO - Running setup.py install for mozprofile 03:07:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:07:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:07:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:07:54 INFO - Running setup.py install for mozrunner 03:07:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:07:54 INFO - Running setup.py install for mozscreenshot 03:07:54 INFO - Running setup.py install for moztest 03:07:54 INFO - Running setup.py install for mozversion 03:07:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:07:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:07:54 INFO - Cleaning up... 03:07:54 INFO - Return code: 0 03:07:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:07: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')]} 03:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07: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')]} 03:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:07:54 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 0x104327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa434184c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c6e00>, '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 0x10402fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c1b20>, '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.TPxa1xFwMI/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.V9qAineymd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 03:07:54 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 03:07:54 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 03:07:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPxa1xFwMI/Render', 03:07:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:07:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:07:54 INFO - 'HOME': '/Users/cltbld', 03:07:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:07:54 INFO - 'LOGNAME': 'cltbld', 03:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:07:54 INFO - 'MOZ_NO_REMOTE': '1', 03:07:54 INFO - 'NO_EM_RESTART': '1', 03:07:54 INFO - 'PAGER': '/bin/cat', 03:07:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:07:54 INFO - 'PWD': '/builds/slave/test', 03:07:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:07:54 INFO - 'SHELL': '/bin/bash', 03:07:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V9qAineymd/Listeners', 03:07:54 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:07:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:07:54 INFO - 'USER': 'cltbld', 03:07:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:07:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:07:54 INFO - 'XPC_FLAGS': '0x0', 03:07:54 INFO - 'XPC_SERVICE_NAME': '0', 03:07:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:07:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-iRTUKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:07:55 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)) 03:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:07:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-piVpLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:07:55 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)) 03:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:07:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-x43Pal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:07:55 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)) 03:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:07:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-TD0TgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:07:55 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)) 03:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:07:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-LRbK31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:07:55 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)) 03:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:07:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-HZtoPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:07:55 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)) 03:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:07:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-hyc7ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:07:55 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)) 03:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:07:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Xa76AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:07:56 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)) 03:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:07:56 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-ENSai0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:07:56 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)) 03:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:07:56 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Tkt59z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:07:56 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)) 03:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:07:56 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-WQVv34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:07:56 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)) 03:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:07:56 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-0SJs7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:07:56 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)) 03:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:07:56 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-WdXePq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:07:56 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)) 03:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:07:56 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-EYHt7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:07:56 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)) 03:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:56 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-2vyKmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:07:56 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)) 03:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:07:56 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8FR_aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:07:56 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)) 03:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:07:56 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-kQerqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:07:56 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)) 03:07:56 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)) 03:07:56 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)) 03:07:56 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)) 03:07:56 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)) 03:07:56 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)) 03:07:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:07:59 INFO - Downloading blessings-1.6.tar.gz 03:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:07:59 INFO - Installing collected packages: blessings 03:07:59 INFO - Running setup.py install for blessings 03:07:59 INFO - Successfully installed blessings 03:07:59 INFO - Cleaning up... 03:07:59 INFO - Return code: 0 03:07:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:07:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:00 INFO - Reading from file tmpfile_stdout 03:08:00 INFO - Current package versions: 03:08:00 INFO - blessings == 1.6 03:08:00 INFO - blobuploader == 1.2.4 03:08:00 INFO - docopt == 0.6.1 03:08:00 INFO - manifestparser == 1.1 03:08:00 INFO - mozInstall == 1.12 03:08:00 INFO - mozcrash == 0.17 03:08:00 INFO - mozdebug == 0.1 03:08:00 INFO - mozdevice == 0.48 03:08:00 INFO - mozfile == 1.2 03:08:00 INFO - mozhttpd == 0.7 03:08:00 INFO - mozinfo == 0.9 03:08:00 INFO - mozleak == 0.1 03:08:00 INFO - mozlog == 3.1 03:08:00 INFO - moznetwork == 0.27 03:08:00 INFO - mozprocess == 0.22 03:08:00 INFO - mozprofile == 0.28 03:08:00 INFO - mozrunner == 6.11 03:08:00 INFO - mozscreenshot == 0.1 03:08:00 INFO - mozsystemmonitor == 0.0 03:08:00 INFO - moztest == 0.7 03:08:00 INFO - mozversion == 1.4 03:08:00 INFO - psutil == 3.1.1 03:08:00 INFO - requests == 1.2.3 03:08:00 INFO - wsgiref == 0.1.2 03:08:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:00 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')]} 03:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:00 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')]} 03:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:00 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 0x104327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa434184c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c6e00>, '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 0x10402fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c1b20>, '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.TPxa1xFwMI/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.V9qAineymd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 03:08:00 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 03:08:00 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 03:08:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPxa1xFwMI/Render', 03:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:00 INFO - 'HOME': '/Users/cltbld', 03:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:00 INFO - 'LOGNAME': 'cltbld', 03:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:00 INFO - 'MOZ_NO_REMOTE': '1', 03:08:00 INFO - 'NO_EM_RESTART': '1', 03:08:00 INFO - 'PAGER': '/bin/cat', 03:08:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:00 INFO - 'PWD': '/builds/slave/test', 03:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:00 INFO - 'SHELL': '/bin/bash', 03:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V9qAineymd/Listeners', 03:08:00 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:00 INFO - 'USER': 'cltbld', 03:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:00 INFO - 'XPC_FLAGS': '0x0', 03:08:00 INFO - 'XPC_SERVICE_NAME': '0', 03:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:00 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)) 03:08:00 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)) 03:08:00 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)) 03:08:00 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)) 03:08:00 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)) 03:08:00 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)) 03:08:00 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)) 03:08:00 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)) 03:08:00 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)) 03:08:00 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)) 03:08:00 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)) 03:08:00 INFO - Cleaning up... 03:08:00 INFO - Return code: 0 03:08:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:08:00 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')]} 03:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:00 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')]} 03:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:00 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 0x104327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa434184c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c6e00>, '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 0x10402fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c1b20>, '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.TPxa1xFwMI/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.V9qAineymd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 03:08:00 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 03:08:00 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 03:08:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPxa1xFwMI/Render', 03:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:00 INFO - 'HOME': '/Users/cltbld', 03:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:00 INFO - 'LOGNAME': 'cltbld', 03:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:00 INFO - 'MOZ_NO_REMOTE': '1', 03:08:00 INFO - 'NO_EM_RESTART': '1', 03:08:00 INFO - 'PAGER': '/bin/cat', 03:08:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:00 INFO - 'PWD': '/builds/slave/test', 03:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:00 INFO - 'SHELL': '/bin/bash', 03:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V9qAineymd/Listeners', 03:08:00 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:00 INFO - 'USER': 'cltbld', 03:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:00 INFO - 'XPC_FLAGS': '0x0', 03:08:00 INFO - 'XPC_SERVICE_NAME': '0', 03:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:00 INFO - Downloading/unpacking jsonschema 03:08:00 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 03:08:00 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 03:08:00 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 03:08:00 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 03:08:00 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 03:08:00 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 03:08:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:08:03 INFO - Downloading/unpacking functools32 (from jsonschema) 03:08:03 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 03:08:03 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 03:08:03 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 03:08:03 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 03:08:03 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 03:08:03 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 03:08:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:08:03 INFO - warning: no files found matching '*.txt' 03:08:03 INFO - no previously-included directories found matching 'build' 03:08:03 INFO - no previously-included directories found matching 'dist' 03:08:03 INFO - no previously-included directories found matching '.git*' 03:08:03 INFO - Installing collected packages: jsonschema, functools32 03:08:03 INFO - Running setup.py install for functools32 03:08:03 INFO - warning: no files found matching '*.txt' 03:08:03 INFO - no previously-included directories found matching 'build' 03:08:03 INFO - no previously-included directories found matching 'dist' 03:08:03 INFO - no previously-included directories found matching '.git*' 03:08:03 INFO - Successfully installed jsonschema functools32 03:08:03 INFO - Cleaning up... 03:08:03 INFO - Return code: 0 03:08:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:03 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 0x104327a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104337420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa434184c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c6e00>, '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 0x10402fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c1b20>, '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.TPxa1xFwMI/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.V9qAineymd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 03:08:03 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 03:08:03 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 03:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPxa1xFwMI/Render', 03:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:03 INFO - 'HOME': '/Users/cltbld', 03:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:03 INFO - 'LOGNAME': 'cltbld', 03:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:03 INFO - 'MOZ_NO_REMOTE': '1', 03:08:03 INFO - 'NO_EM_RESTART': '1', 03:08:03 INFO - 'PAGER': '/bin/cat', 03:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:03 INFO - 'PWD': '/builds/slave/test', 03:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:03 INFO - 'SHELL': '/bin/bash', 03:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V9qAineymd/Listeners', 03:08:03 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:03 INFO - 'USER': 'cltbld', 03:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:03 INFO - 'XPC_FLAGS': '0x0', 03:08:03 INFO - 'XPC_SERVICE_NAME': '0', 03:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:04 INFO - Downloading/unpacking flake8 03:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:08:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:08:06 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 03:08:06 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 03:08:06 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 03:08:06 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 03:08:06 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 03:08:06 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 03:08:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:08:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:08:06 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 03:08:06 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 03:08:06 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 03:08:06 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 03:08:06 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 03:08:06 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 03:08:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:08:07 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 03:08:07 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 03:08:07 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 03:08:07 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 03:08:07 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 03:08:07 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 03:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:08:07 INFO - no previously-included directories found matching 'docs/_build' 03:08:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:08:07 INFO - Running setup.py install for pep8 03:08:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:08:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:08:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:08:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:08:08 INFO - no previously-included directories found matching 'docs/_build' 03:08:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:08:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:08:08 INFO - Cleaning up... 03:08:08 INFO - Return code: 0 03:08:08 INFO - Running post-action listener: _resource_record_post_action 03:08:08 INFO - Running post-action listener: _start_resource_monitoring 03:08:08 INFO - Starting resource monitoring. 03:08:08 INFO - ##### 03:08:08 INFO - ##### Running install step. 03:08:08 INFO - ##### 03:08:08 INFO - Running pre-action listener: _resource_record_pre_action 03:08:08 INFO - Running main action method: install 03:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:08 INFO - Reading from file tmpfile_stdout 03:08:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:08:08 INFO - Reading from file tmpfile_stdout 03:08:08 INFO - Output received: 03:08:08 INFO - Usage: mozinstall [options] installer 03:08:08 INFO - Options: 03:08:08 INFO - -h, --help show this help message and exit 03:08:08 INFO - -d DEST, --destination=DEST 03:08:08 INFO - Directory to install application into. [default: 03:08:08 INFO - "/builds/slave/test"] 03:08:08 INFO - --app=APP Application being installed. [default: firefox] 03:08:08 INFO - mkdir: /builds/slave/test/build/application 03:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:08:41 INFO - Reading from file tmpfile_stdout 03:08:41 INFO - Output received: 03:08:41 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:08:41 INFO - Running post-action listener: _resource_record_post_action 03:08:41 INFO - ##### 03:08:41 INFO - ##### Running run-tests step. 03:08:41 INFO - ##### 03:08:41 INFO - Running pre-action listener: _resource_record_pre_action 03:08:41 INFO - Running main action method: run_tests 03:08:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:08:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:08:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:08:41 INFO - 2016-05-28 03:08:41.134 screenresolution[1986:14630] starting screenresolution argv=screenresolution get 03:08:41 INFO - 2016-05-28 03:08:41.137 screenresolution[1986:14630] Display 0: 1600x1200x32@60 03:08:41 INFO - 2016-05-28 03:08:41.143 screenresolution[1987:14632] starting screenresolution argv=screenresolution list 03:08:41 INFO - Available Modes on Display 0 03:08:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:08:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:08:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:08:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:08:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:08:41 INFO - Intel Iris: 03:08:41 INFO - Chipset Model: Intel Iris 03:08:41 INFO - Type: GPU 03:08:41 INFO - Bus: Built-In 03:08:41 INFO - VRAM (Dynamic, Max): 1536 MB 03:08:41 INFO - Vendor: Intel (0x8086) 03:08:41 INFO - Device ID: 0x0a2e 03:08:41 INFO - Revision ID: 0x0009 03:08:41 INFO - Displays: 03:08:41 INFO - Display: 03:08:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:08:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:08:41 INFO - Display Serial Number: 1600x1200 60 03:08:41 INFO - Main Display: Yes 03:08:41 INFO - Mirror: Off 03:08:41 INFO - Online: Yes 03:08:41 INFO - Rotation: Supported 03:08:41 INFO - Return code: 0 03:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:08:41 INFO - Python 2.7.3 03:08:41 INFO - Return code: 0 03:08:41 INFO - grabbing minidump binary from tooltool 03:08:41 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')]} 03:08:41 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 0x1041c6e00>, '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 0x10402fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:08:41 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 03:08:41 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 03:08:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:08:41 INFO - Return code: 0 03:08:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:08:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:08:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:08:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:08:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:08:42 INFO - Return code: 0 03:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:08:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPxa1xFwMI/Render', 03:08:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:42 INFO - 'HOME': '/Users/cltbld', 03:08:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:42 INFO - 'LOGNAME': 'cltbld', 03:08:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:08:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:42 INFO - 'MOZ_NO_REMOTE': '1', 03:08:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:08:42 INFO - 'NO_EM_RESTART': '1', 03:08:42 INFO - 'PAGER': '/bin/cat', 03:08:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:42 INFO - 'PWD': '/builds/slave/test', 03:08:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:08:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:42 INFO - 'SHELL': '/bin/bash', 03:08:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V9qAineymd/Listeners', 03:08:42 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:08:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:42 INFO - 'USER': 'cltbld', 03:08:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:42 INFO - 'XPC_FLAGS': '0x0', 03:08:42 INFO - 'XPC_SERVICE_NAME': '0', 03:08:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:08:42 INFO - mozversion application_buildid: 20160525152143 03:08:42 INFO - mozversion application_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 03:08:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:08:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:08:42 INFO - mozversion application_name: Firefox 03:08:42 INFO - mozversion application_remotingname: firefox-dev 03:08:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:08:42 INFO - mozversion application_vendor: Mozilla 03:08:42 INFO - mozversion application_version: 48.0a2 03:08:42 INFO - mozversion platform_buildid: 20160525152143 03:08:42 INFO - mozversion platform_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 03:08:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:08:42 INFO - mozversion platform_version: 48.0a2 03:08:42 INFO - using testdate: 1464430122 03:08:42 INFO - actual date: 1464430122 03:08:42 INFO - starting webserver on 'localhost:51346' 03:08:42 INFO - SUITE-START | Running 2 tests 03:08:42 INFO - TEST-START | dromaeo_css 03:08:42 INFO - operating with platform_type : mac_ 03:08:42 INFO - Initialising browser for dromaeo_css test... 03:08:42 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpevqZjQ/profile http://localhost:51346/getInfo.html) 03:08:45 INFO - PROCESS | 2005 | __metrics Screen width/height:1600/1200 03:08:45 INFO - PROCESS | 2005 | colorDepth:24 03:08:45 INFO - PROCESS | 2005 | Browser inner width/height: 1024/689 03:08:45 INFO - PROCESS | 2005 | __metrics 03:08:45 INFO - PROCESS | 2005 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:08:45 ERROR - PROCESS | 2005 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:08:45 INFO - TEST-INFO | 2005: exit 0 03:08:45 INFO - Browser initialized. 03:08:45 INFO - Running cycle 1/1 for dromaeo_css test... 03:08:45 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpevqZjQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:57 INFO - PROCESS | 2007 | RSS: Main: 211255296 03:08:57 INFO - PROCESS | 2007 | 03:09:49 INFO - PROCESS | 2007 | 1464430189403 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] 03:12:00 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51346/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51346/tests/dromaeo/cssquery-ext.html) 03:12:01 INFO - PROCESS | 2007 | RSS: Main: 323555328 03:12:01 INFO - PROCESS | 2007 | 03:15:04 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51346/tests/dromaeo/cssquery-ext.html (next: http://localhost:51346/tests/dromaeo/cssquery-jquery.html) 03:15:04 INFO - PROCESS | 2007 | RSS: Main: 353710080 03:15:04 INFO - PROCESS | 2007 | 03:18:06 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51346/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51346/tests/dromaeo/cssquery-mootools.html) 03:18:07 INFO - PROCESS | 2007 | RSS: Main: 355090432 03:18:07 INFO - PROCESS | 2007 | 03:21:09 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51346/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51346/tests/dromaeo/cssquery-prototype.html) 03:21:10 INFO - PROCESS | 2007 | RSS: Main: 339132416 03:21:10 INFO - PROCESS | 2007 | 03:24:13 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51346/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51346/tests/dromaeo/cssquery-yui.html) 03:24:14 INFO - PROCESS | 2007 | RSS: Main: 322113536 03:24:14 INFO - PROCESS | 2007 | 03:27:16 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51346/tests/dromaeo/cssquery-yui.html (next: http://localhost:51346/tests/dromaeo/cssquery-dojo.html) 03:27:17 INFO - PROCESS | 2007 | RSS: Main: 368254976 03:27:17 INFO - PROCESS | 2007 | 03:27:17 INFO - PROCESS | 2007 | __start_tp_report 03:27:17 INFO - PROCESS | 2007 | _x_x_mozilla_page_load 03:27:17 INFO - PROCESS | 2007 | _x_x_mozilla_page_load_details 03:27:17 INFO - PROCESS | 2007 | |i|pagename|runs| 03:27:17 INFO - PROCESS | 2007 | |0;dojo.html;3328.3676101540705;3380.104272367822;3395.0663567518927;3424.520567120605;3454.4990976308436;5522.254495643092;5572.247746554214;5574.331080270374;5584.609077364576;5587.357453892803;5504.366997795255;5593.077142271531;5601.523870471005;5609.242752228448;5655.660660360381;5013.473585273548;5086.542211200991;5125.692458452496;5174.637775355726;5208.947910520903;5157.226416037587;5172.09488339541;5175.223716442545;5180.740962951837;5189.714565698885;5116.053530096944;5164.251183578379;5177.974110129463;5194.324737784083;5194.740262986855;5172.198309262051;5191.532762051395;5194.792208311663;5203.505666961632;5238.8690282742855;5022.522860328263;5044.899102017939;5068.645194836363;5119.385673719177;5126.820561280375;5433.320834895638;5439.5104440600535;5464.644798088111;5480;5484.8354549363585;6096.359882212392;6097.420745029215;6107.969460152715;6112.052631842072;6119.418655227746;5958.7616495340135;6104.603200791978;6119.632822030692;6155.476784473325;6163.691815409212;4846.75766211688;5680.886382272372;5684.34630017545;5696.088625819932;5716.628419152742;6332.4934005279465;6371.426571608485;6387.744490220339;6390.520710946697;6400.0719895614875;5736.1682556029145;5853.824385268449;5940.495057920039;6026.54800889935;6031.065184896348;6135.69203737716;6144.279601711439;6151.9384806151365;6153.784617538365;6155.815325540241;5994.400559944058;6028.5478589106;6031.125486804389;6052.03167493199;6099.664518451439;5958.6424814511265;6061.424164704346;6076.635401875901;6084.209052823105;6084.5436592255755;4781.52184781526;4802.951970480251;4804.855854324376;4815.15734746418;4827.8551643450755;4324.308110702273;4373.715708478939;4381.408509851193;4401.911961760747;4422.226110430662;5524.640898341675;5530.668159910419;5533.363663178706;5542.251796007568;5570.749316280696;6100.786472473531;6173.8456538586;6178.752849886044;6179.938200618026;6183.381661833871;5395.379531353945;5427.457254274541;5493.121100623881;5528.281323428009;5545.500904918576;4923.532264434873;4984.925226121611;5239.004589128053;5260.184671375943;5275.076861549213;5230.764615592308;6283.434490895841;6326.272478665012;6341.143945567382;6352.460040896391;6043.244594425697;6109.34393638171;6134.04922237054;6143.1706719592285;6210.72051757681;6278.591891527036;6302;6306.810795676137;6309.242890853127;6331.461825744679;5460.6177567569885;5903.970480147572;6055.424734650202;6063.423974722395;6079.848003799763;5884.32330282023;5989.970050149721;6066.7269972850445;6127.0673618518995;6148.985417406078;5893.263342082239;5925.200097986716;5932.317783454958;5947;5960;5875.383084776208;5906.970465147647;5913.379095194942;5915.260592425947;5920.052791553331;5607.943920560742;5704.087346024616;5718.685472299064;5760.769569217352;5818.505427038749;5833.329167145833;5931.881362372642;5943.762249510144;5958.702064896651;5964.956132676851;5815.738291776965;5823.272090988627;5827.475527202572;5837.503812176013;5861.6189947653265 03:27:17 INFO - PROCESS | 2007 | |1;ext.html;522.8483739715481;526.7445289034818;577.232281066182;583.9211706419635;585.9131311417318;31305.530417043734;31943.041708748744;31963.68036319636;31985.840070799644;38385.23229535408;43598.91002724934;44154.33768493467;44186.779066104704;44190.558094419044;44298.778506107425;9591.424514529133;9813.509324533745;9828.36115652484;9835.65575204868;9838.655647052354;9507.80984380312;9619.903800962005;9633.27750418718;9638.614455421775;9640.903590964072;9626.663066792664;9664.806703865954;9674.371165874196;9679.564419601134;9690.32167748258;9598.80802383952;9636.95181524095;9641.855372169422;9647.662331818388;9655.131038206595;8159.592020399015;9468.668596599086;9572.138507534355;9581.520923953844;9591;40492.797536012135;40979.18041639151;40991.97520061993;41014.38478422826;41048.384274235614;3108.704673056056;3225.7903236289567;3257.1042963185077;3265.8856940006985;3645.9270814583824;28693.28266793326;28964.42071158565;29087;29231.85384073066;29352.8532357339;2731.412746259544;2737.9589306160424;2757.0901602471336;2759.351552385188;2794.888204471819;469618;470679;471415;471689;472417;64220.67889660615;64524.35475645184;64530;64662.706745864816;64701.67649161724;67319.3268067313;67832.6608366955;69834.65082674655;71097;71196.64401677958;17479.126043697765;17550.29798808059;17664.91167544154;17678.204480798395;17680.469585912444;13266.336683165802;13360.39878205483;13366.866331336561;13370.264635445144;13384.665383365298;19429.611407771765;19699.803001970082;19708.408747737303;19747.210111595374;19760.505987350432;7907;7961.084475285301;7995.480293780885;8007.399445041645;8057.717979870677;916.2669864108686;950.2920324358397;980.3676628574672;983.1544871410581;993.1161266472845;29497.705022949925;29902.551461728093;29942;30775.38449231003;30879.919202827794;1010.6311196413403;1110.4725255503733;1126.1159989408275;1135.4720055174384;1161.5586077290745;15364;15370.09384067571;15375.461858834888;15487.767683484757;15918.9204053979;528427.3578632083;616252;617320;617559;617843;61101.38898610957;62971.685141574;63187.6840615794;63194.684026579576;63195;1462.6562757752133;1465.5603319004256;1477.6084337650532;1493.059372595258;1493.507142642947;29302.26744331409;29861;29982.850085750306;30649.54025689661;30682.386352273275;54056;54459.18311225414;54783.726081369336;54929.72535137299;54946.72526637341;535426;538635;538942;540238;542269;26923.192304230903;27252;27322.180334589993;27534.173974780788;27757.583636245876;43692.34461483017;44647.330290046324;44659.553404465536;46585.767071164424;47775;38087.428688570246;38233;38399.80800095982;38472;38703.03242418962;36718;37927.620723793516;37995.62004379921;39029.63396281117;39051.80474097611;29589.556156657236;33550;37954;38408.84773456801;39031.60968390393;30898.382032359677;30991.070267892;31602.841985789924;32765.344693106483;32793.83603081969;23935.640965385883;24492.387690307172;24601.753982459948;25024.74975250224;25170.49659006773 03:27:17 INFO - PROCESS | 2007 | |2;jquery.html;327.66250761715435;372.0271490053511;396.56179921187095;405.884322967954;408.9468369112015;16059.437919672813;16384.18079096045;20326.89836550819;21098.894505527453;21124.471888202803;16641.83358166418;20646.038626330475;20772.480687982807;20958.476038099056;20958.89520552399;4121.258173528764;5685.232493613351;5888.175655408247;5890.175375447441;5899.764009439617;6121.143039974407;6531.869362612745;6543.247526534438;6546.9017964730565;6560.540762146652;6356.424387712226;6496.187976502937;6501.577397469149;6502.837429064288;6521.250056243545;6284.12022316876;6446.033095035736;6453.999630057348;6458.160439142881;6479.22249330081;5474.452554744494;5545.3622833374275;5612.69130197839;5616.5787565932305;5656.585853536616;25287;26156.34609134787;26229.344266393302;26307.868460657766;26356.94572217109;2204;2309.891252198954;2338.865650159671;2350.247920665388;2401.2916189724074;14143.71712565743;14719.116852988747;14755.926220368829;14827.332770025374;15220.238988050553;1658.286936617254;1742.3534759652134;1772.3265159239406;1794.120880768427;1795.4793109998216;111912;112099.43950280278;112519;113836.99999999917;115982.42008789987;10508.264421490423;10618.469076546142;10844.72888177786;11064.293461690262;11212.719682008015;14046.1572305662;14064.08583442073;14101.506447274296;14105.153690778381;14111;8717.825643487095;8840.690575829814;8856.601452934634;8953.552322383985;8956.44741248741;8994.910050899538;9043.095690431035;9064.637414503346;9065.546722663972;9137.497437640994;5157.16920493227;6671.43292820106;6677.799666010027;6678.49911256648;6691.832704182434;1855.8144185581334;1882.5670095878024;1886.415211284506;1891.7446144770279;1905.1902941249914;904.737626088427;1002.1581871228203;1056.8256237720843;1065.6057258814287;1068.2522234435926;20639.277625283044;21146.154153833675;21183.243106199305;21186.364409067446;21382.679259811117;1002.5588740953957;1003.9759445365686;1014.2089170447063;1019.5463018956493;1090.4983707494482;10818.891811081789;11172.385518796544;11367.317960922372;11368.829467557993;11454.828177577343;495229;522893;523188;595976;616513;109825.45087274513;126252.7374726241;130960;131681.3415932914;139236.6076339244;1013.3717095400751;1034.3690348887174;1054.0671505717496;1056.3503445381189;1057.1437135920082;14833.332500037308;16069.839301606835;16325.020498770113;17825.643487130445;18574.721379179595;43188.568114318456;43826.561734382245;52371.95256094933;53250.06869332738;53727.6568085801;72704.9094263597;77510;77601;77690;77917.61041194758;7878.566678832719;8110.107888132183;10439.37363758177;10627.61840960701;12269.263844169378;11076.335419874833;12304.138710290194;13264.60206193777;13387.732245354844;13390.866091339352;11206.719832003939;11292;11368.94315528417;11418.602093560445;11677.824832627348;11294.60468883585;11374.715632108933;11528.711782205177;11625.825612615987;11698.824517632072;11699.707507312385;11741.29552226869;11809.71738578136;11816.70458238551;11838.585649502225;11961.222520536137;12025.819612705991;12059.75880482403;12302.692432688897;12364.319962402154;11489.138314626269;11494.885051149717;11586.246893951866;11728;11748.882511175121 03:27:17 INFO - PROCESS | 2007 | |3;mootools.html;1357.8845798107172;1539.284232831733;1546.9071855688655;1749.8425141737248;1900.1829213438225;7538.96230518848;7858.449908506407;8069.959650201748;8541.273991710705;8739.082396348387;8379.078301386842;8393.202645748659;8477.406581539295;8489.830203395928;8501.277391421736;2392.8803559822027;2415.420299128214;2416.142269494331;2417.5648383291086;2421.806255499556;2367.0768400323886;2407.145463360508;2410.8915098820507;2414.8309618326725;2415.770501802326;2384.7853693167613;2407.626817843237;2420.1529464687396;2423.212455951814;2430;2372.074890792592;2406.398400399891;2418.298693378918;2421.8667973261463;2427.4295540548046;2359.728631207416;2385.9522809543887;2392.9760702392928;2395.7843794058617;2398.6641870138196;8619.051904290523;8670;8702.042775294713;8711.259542938858;8715.041345451995;5142.254373115915;5360.678359298416;5366.356037275513;5370;5388.515033646991;3452.671996160361;3487.9825600872086;3493.3013397320383;3539.699125574329;3542.079059444563;1045.4459136657583;1062.2192688374116;1063.8244689626201;1069.1340014588209;1069.8769641491172;11435.828462572985;11608.477618507188;11617.709557261052;11630.6510804676;11645.18483706141;4445.866624001285;4549.658775591844;4565.360849481075;4596.379488768974;4655.580997710223;9186.356955013218;9199.4940278284;9204.723858284262;9214.493202873773;9217.953910230406;5221.660592061504;5223.007628550563;5246.3704355477585;5257.185136303879;5264.894702105937;4389.231884420214;4520.0507893342765;4731.1720448921305;4834.5890599299455;4957.553820156203;3774.6036666149657;3782.8865134046023;3831.233753249361;3859.6912247020173;3882.8835134946;1201.8077107662907;1210.5836171679157;1214.5991822698488;1226.779179747654;1227.1226073357413;655.6852710698796;817.3297895725567;892.1524551675934;929.8837645294338;934.3272843552631;5604.551635869121;5660.915086273709;5723.313202415737;5848.4151584841175;5971.731272092767;941.7127776028377;958.6500927161536;980.4852452462371;984.2224642532462;993.557866749304;3697.8705745298785;3854.5952674969285;3863.362545180014;3943.645071943539;3953.2291203215095;10381.740456488647;10616.681499555025;10872.075873550837;10937.56249750017;10967.396793176453;10635.883232260656;10655.62705305326;10793.946030269799;10810.567577296977;10811.40537270442;7726.729564465217;7987.241212084843;8011;8018.158093400109;8433;4814.638902082428;5586.944130558642;5668.121441176624;5712.171735098471;5827.533797296291;9339.953300233456;9490.478023708762;9582.712518624452;9608.95195524018;9616.855747163938;9470.621175152917;9522.52387380642;9723.02769723022;9792.265580081379;9992.20062394992;7410.666520006721;7459.216782238004;7487.812804679927;7531.8117047074265;7533.209013053551;8061.113277539584;8093.676252950052;8098.554579497949;8115.675372985014;8146;6027.819165425044;7047;7233.927660723325;7268.164161121539;7312.232215617283;6179.907301390393;7157.355837974607;7237.638118093969;7251.274872512707;7296.087989001375;6050.848728781815;6765.627890466071;6780.118584583973;6876.69054892541;6882.414994725505;4580.587747102777;4631.698939568917;4668.60316873056;4758.785854636619;4794.256890182028;4678.157931572349;4687.601553867959;4721.032188401438;4853.223484242504;4892.168331383602 03:27:17 INFO - PROCESS | 2007 | |4;prototype.html;310.3854368350664;315.06268850170744;324.073150788744;324.2849516815422;326.74024150800113;6388.968055159724;6459.6447195404235;6461.806145815622;6500.057491663706;6510.08858759774;4896.828610998616;6116;6319.273283572391;6323.20959880015;6405.807825765234;4771.165046116933;4780.80876764929;4802.951970480303;4806.8557943261585;4836.347093142434;4359.542248063955;4771.832985845496;4797.704619752664;4820;4823.758812059401;4496.078303947683;4572.977135114336;4669.182892993713;4715.669903106784;4766.475687674353;4637.721736695809;4751.40607424072;4752.7623618818925;4752.881177970544;4754.500777418356;3343.9832800836084;4094.2220978014084;4098.098418347989;4111.301078816608;4112.835486580563;6088;6114.1745864308195;6160.168377269056;6162.414570615784;6166.599171053912;5567.053600887859;5567.387587365387;5575.330960284792;5581.5255703265275;5590.944090559083;6553.442957348631;6689.120310220061;6759.357861003196;6782.660866956632;6803.455723542104;4331.242032644274;4537.4328208973875;4579.038401935598;4585.174668559658;4594.150082234797;7195.172555156171;7214.242504537053;7220.67506962188;7223.638818059128;7226.4580156489;4647.34937108805;4660.906781864343;4663.277192035172;4672.1356549037855;4677.415323084614;4721.622270218374;4722.276369125245;4724.622030237572;4726.172919739032;4749.311349854252;4572.862814115582;5139.665921715076;5496.983058134258;5541.750621222055;5551.528120109755;6664.83337916556;6714.261431242559;6715.2613212546585;6716.630585317756;6717.932820671828;1563.4059057558281;1589.1021572811323;1590.5943984283933;1592.5859276588171;1593.8485843844817;948.3551185194134;982.7985263021063;998.5556427389741;1004.4626125023224;1008.7982403519326;6080.844639518566;6136.8772624548155;6148;6148.907766383508;6170.784022559189;6940.930590694129;7064.682089305994;7090.539114957512;7092.148942126978;7101;6342.936570634234;6358.1416508771645;6358.618482891041;6380.202474690664;6390.680465976682;3730.552333719971;3781.6596506314563;3783.9432408513894;3788.3749181385315;3792.2036372361563;7295.489315747846;7560.130584982798;7561.243875612505;7566.1298950620285;7571.3942884569105;7332.046833911664;7372.373348265351;7375.88936165958;7379.88930166048;7386.15059268191;6080.847978800565;7522;7527.021487206628;7530.698772049057;7535.773926782205;7112.110986126734;7124.145102587722;7129;7132.179799323144;7132.821679458055;6718.563293385914;6952.721891124298;6953.374196322356;6960.686769095301;6990.580565165903;7033.753818616324;7441.888371674538;7541.660625271767;7550.282723141293;7573.772786816405;4676.672632915664;4741.407324084489;4743.525647435229;4743.620510359094;4747.050589881968;7017.543859649107;7024.4029257513685;7033.402160816388;7037.26108758573;7039.964800175966;6537.771178008747;6795.184577850492;6799.354061364163;6807.115075040213;6810.284920083518;6706.932930670826;6752.729890804313;6759.898601520883;6791.66041697923;6795.116634837637;5355.30381050461;5370.677759334452;6595;6621.370969757865;6638.5684930479365;6783.796486105425;6785.796426107225;6787.898181527183;6788.422984046214;6791.626460544718;6369.554131210771;6502;6547.770828020996;6635.279535390467;6766.96616516934 03:27:17 INFO - PROCESS | 2007 | |5;yui.html;674.0765151742113;687.3261819626538;708.9291070892908;712.1134187936019;757.685560492396;14711;14902.850971490281;14914;14940.327685254162;14965;13514.391852366642;13587.59237222885;14872.702545949074;15280.388784448636;15329.616759581017;891.8795962545055;901.0944001278739;912.174482093703;912.2701838529183;915.2723584750106;725.8403151306704;736.8305289783353;761.2881955371718;780.6252998560694;917.7980844214295;940.7507010642186;950.538988590533;953.2802733935869;954.3653470442148;956.6603855631255;747.5439981611213;937.4047479850276;947.1901524196782;947.3842002698233;949.8005418862048;687.1376422589668;696.6760456387753;699.9475039372068;700.6146619359332;700.7792545348199;14893.47872824446;14910.17994010329;14945.476908308267;14963.700725985529;14979.251037448084;9947.950260248652;10059.346142500788;12140.635780926586;12203.328816915066;12599.181053231603;9730.854037189449;9973.351732137387;10140.08739213467;10144.898551014468;10406;3405.4381027130494;3428.794272343667;3486.7733597316346;3551.6803487686234;3566.1262990567216;75635.96545802918;75657;75722;76492.61753691196;77188;9242.72271831846;9272;9340.906590934139;9479;9532.285078619132;21161.576768464543;21173.470663233235;21223;21229.363119106452;21240.150393984375;7402.29678180572;7496.737614183587;7596.544207347577;7709.42179336552;7809.492382995087;3441.913952151166;4062.532808726975;4092.9181416371507;4129.525104612948;4318.762468064224;3617.077645200457;3651.5253017107607;3669.87155449558;3673.3571624965525;3674.65090816372;643.0161852365887;653.6078352988169;659.3176062775101;666.1107421592131;673.4208580620663;550.2269311617184;585.4175095779726;597.2444857255575;604.1421181921681;607.5018484842387;8305.563188528939;8658.523781191969;8713.651453941771;8811.339149563808;8814.250788683034;532.3106576982816;586.7125108696708;606.6542071019477;611.7063809371526;621.9004959206505;3808.333541630204;3809.476458012253;3857.9228415432094;3864.768113913174;4077.0215148364773;85019.5749021251;86708.6993695095;86862.13137868667;91320;92508;69435.95846062314;69717.65141174261;70588.64705676542;70885.93671094938;71061;61772.1468355959;63141.68429157825;65372;65994;66585.33414665791;7032.542884712478;8068.757937261891;8253.83492330162;8331.583420828812;8421.4947103174;46191.538084618725;46999.530004700886;47402.288965664855;48308.51691483181;48465;59646;62823.37176628358;64408.711825762286;65629;66801;10864.185186110915;11041.282316649393;11073.778524429628;11297.774044519228;11895.988840948616;11606.94196529012;11928.642140735792;12131;12268.631941041784;12405;9280.860787088333;11497.310161390344;11528.942355288169;11723.179377443497;11750.823737644114;9049.457032578066;11383.829242561202;11619.941900290783;11661.183717139718;12277;9575.521223938915;11252.718682033015;11460.796616355496;11550;11631.88368116308;9394.154526092685;9402.15380615748;9472.95263523678;9740.659076932274;9783.51082445889;7251.709931602677;8394.706185283485;8566.400351975302;8635.87046194295;8739.300855931637 03:27:17 INFO - PROCESS | 2007 | __end_tp_report 03:27:17 INFO - PROCESS | 2007 | __start_cc_report 03:27:17 INFO - PROCESS | 2007 | _x_x_mozilla_cycle_collect,1098 03:27:17 INFO - PROCESS | 2007 | __end_cc_report 03:27:17 INFO - PROCESS | 2007 | __startTimestamp1464431237089__endTimestamp 03:27:17 INFO - PROCESS | 2007 | 03:27:17 INFO - PROCESS | 2007 | ------- Summary: start ------- 03:27:17 INFO - PROCESS | 2007 | Number of tests: 6 03:27:17 INFO - PROCESS | 2007 | 03:27:17 INFO - PROCESS | 2007 | [#0] dojo.html Cycles:165 Average:5616.69 Median:5815.74 stddev:620.63 (10.7%) stddev-sans-first:596.01 03:27:17 INFO - PROCESS | 2007 | Values: 3328.4 3380.1 3395.1 3424.5 3454.5 5522.3 5572.2 5574.3 5584.6 5587.4 5504.4 5593.1 5601.5 5609.2 5655.7 5013.5 5086.5 5125.7 5174.6 5208.9 5157.2 5172.1 5175.2 5180.7 5189.7 5116.1 5164.3 5178.0 5194.3 5194.7 5172.2 5191.5 5194.8 5203.5 5238.9 5022.5 5044.9 5068.6 5119.4 5126.8 5433.3 5439.5 5464.6 5480.0 5484.8 6096.4 6097.4 6108.0 6112.1 6119.4 5958.8 6104.6 6119.6 6155.5 6163.7 4846.8 5680.9 5684.3 5696.1 5716.6 6332.5 6371.4 6387.7 6390.5 6400.1 5736.2 5853.8 5940.5 6026.5 6031.1 6135.7 6144.3 6151.9 6153.8 6155.8 5994.4 6028.5 6031.1 6052.0 6099.7 5958.6 6061.4 6076.6 6084.2 6084.5 4781.5 4803.0 4804.9 4815.2 4827.9 4324.3 4373.7 4381.4 4401.9 4422.2 5524.6 5530.7 5533.4 5542.3 5570.7 6100.8 6173.8 6178.8 6179.9 6183.4 5395.4 5427.5 5493.1 5528.3 5545.5 4923.5 4984.9 5239.0 5260.2 5275.1 5230.8 6283.4 6326.3 6341.1 6352.5 6043.2 6109.3 6134.0 6143.2 6210.7 6278.6 6302.0 6306.8 6309.2 6331.5 5460.6 5904.0 6055.4 6063.4 6079.8 5884.3 5990.0 6066.7 6127.1 6149.0 5893.3 5925.2 5932.3 5947.0 5960.0 5875.4 5907.0 5913.4 5915.3 5920.1 5607.9 5704.1 5718.7 5760.8 5818.5 5833.3 5931.9 5943.8 5958.7 5965.0 5815.7 5823.3 5827.5 5837.5 5861.6 03:27:17 INFO - PROCESS | 2007 | 03:27:17 INFO - PROCESS | 2007 | [#1] ext.html Cycles:180 Average:67842.59 Median:40735.99 stddev:143887.64 (353.2%) stddev-sans-first:144202.51 03:27:17 INFO - PROCESS | 2007 | Values: 522.8 526.7 577.2 583.9 585.9 31305.5 31943.0 31963.7 31985.8 38385.2 43598.9 44154.3 44186.8 44190.6 44298.8 9591.4 9813.5 9828.4 9835.7 9838.7 9507.8 9619.9 9633.3 9638.6 9640.9 9626.7 9664.8 9674.4 9679.6 9690.3 9598.8 9637.0 9641.9 9647.7 9655.1 8159.6 9468.7 9572.1 9581.5 9591.0 40492.8 40979.2 40992.0 41014.4 41048.4 3108.7 3225.8 3257.1 3265.9 3645.9 28693.3 28964.4 29087.0 29231.9 29352.9 2731.4 2738.0 2757.1 2759.4 2794.9 469618.0 470679.0 471415.0 471689.0 472417.0 64220.7 64524.4 64530.0 64662.7 64701.7 67319.3 67832.7 69834.7 71097.0 71196.6 17479.1 17550.3 17664.9 17678.2 17680.5 13266.3 13360.4 13366.9 13370.3 13384.7 19429.6 19699.8 19708.4 19747.2 19760.5 7907.0 7961.1 7995.5 8007.4 8057.7 916.3 950.3 980.4 983.2 993.1 29497.7 29902.6 29942.0 30775.4 30879.9 1010.6 1110.5 1126.1 1135.5 1161.6 15364.0 15370.1 15375.5 15487.8 15918.9 528427.4 616252.0 617320.0 617559.0 617843.0 61101.4 62971.7 63187.7 63194.7 63195.0 1462.7 1465.6 1477.6 1493.1 1493.5 29302.3 29861.0 29982.9 30649.5 30682.4 54056.0 54459.2 54783.7 54929.7 54946.7 535426.0 538635.0 538942.0 540238.0 542269.0 26923.2 27252.0 27322.2 27534.2 27757.6 43692.3 44647.3 44659.6 46585.8 47775.0 38087.4 38233.0 38399.8 38472.0 38703.0 36718.0 37927.6 37995.6 39029.6 39051.8 29589.6 33550.0 37954.0 38408.8 39031.6 30898.4 30991.1 31602.8 32765.3 32793.8 23935.6 24492.4 24601.8 25024.7 25170.5 03:27:17 INFO - PROCESS | 2007 | 03:27:17 INFO - PROCESS | 2007 | [#2] jquery.html Cycles:180 Average:33792.45 Median:10228.64 stddev:92475.52 (904.1%) stddev-sans-first:92700.80 03:27:17 INFO - PROCESS | 2007 | Values: 327.7 372.0 396.6 405.9 408.9 16059.4 16384.2 20326.9 21098.9 21124.5 16641.8 20646.0 20772.5 20958.5 20958.9 4121.3 5685.2 5888.2 5890.2 5899.8 6121.1 6531.9 6543.2 6546.9 6560.5 6356.4 6496.2 6501.6 6502.8 6521.3 6284.1 6446.0 6454.0 6458.2 6479.2 5474.5 5545.4 5612.7 5616.6 5656.6 25287.0 26156.3 26229.3 26307.9 26356.9 2204.0 2309.9 2338.9 2350.2 2401.3 14143.7 14719.1 14755.9 14827.3 15220.2 1658.3 1742.4 1772.3 1794.1 1795.5 111912.0 112099.4 112519.0 113837.0 115982.4 10508.3 10618.5 10844.7 11064.3 11212.7 14046.2 14064.1 14101.5 14105.2 14111.0 8717.8 8840.7 8856.6 8953.6 8956.4 8994.9 9043.1 9064.6 9065.5 9137.5 5157.2 6671.4 6677.8 6678.5 6691.8 1855.8 1882.6 1886.4 1891.7 1905.2 904.7 1002.2 1056.8 1065.6 1068.3 20639.3 21146.2 21183.2 21186.4 21382.7 1002.6 1004.0 1014.2 1019.5 1090.5 10818.9 11172.4 11367.3 11368.8 11454.8 495229.0 522893.0 523188.0 595976.0 616513.0 109825.5 126252.7 130960.0 131681.3 139236.6 1013.4 1034.4 1054.1 1056.4 1057.1 14833.3 16069.8 16325.0 17825.6 18574.7 43188.6 43826.6 52372.0 53250.1 53727.7 72704.9 77510.0 77601.0 77690.0 77917.6 7878.6 8110.1 10439.4 10627.6 12269.3 11076.3 12304.1 13264.6 13387.7 13390.9 11206.7 11292.0 11368.9 11418.6 11677.8 11294.6 11374.7 11528.7 11625.8 11698.8 11699.7 11741.3 11809.7 11816.7 11838.6 11961.2 12025.8 12059.8 12302.7 12364.3 11489.1 11494.9 11586.2 11728.0 11748.9 03:27:17 INFO - PROCESS | 2007 | 03:27:17 INFO - PROCESS | 2007 | [#3] mootools.html Cycles:180 Average:5571.66 Median:5049.90 stddev:3104.86 (61.5%) stddev-sans-first:3097.42 03:27:17 INFO - PROCESS | 2007 | Values: 1357.9 1539.3 1546.9 1749.8 1900.2 7539.0 7858.4 8070.0 8541.3 8739.1 8379.1 8393.2 8477.4 8489.8 8501.3 2392.9 2415.4 2416.1 2417.6 2421.8 2367.1 2407.1 2410.9 2414.8 2415.8 2384.8 2407.6 2420.2 2423.2 2430.0 2372.1 2406.4 2418.3 2421.9 2427.4 2359.7 2386.0 2393.0 2395.8 2398.7 8619.1 8670.0 8702.0 8711.3 8715.0 5142.3 5360.7 5366.4 5370.0 5388.5 3452.7 3488.0 3493.3 3539.7 3542.1 1045.4 1062.2 1063.8 1069.1 1069.9 11435.8 11608.5 11617.7 11630.7 11645.2 4445.9 4549.7 4565.4 4596.4 4655.6 9186.4 9199.5 9204.7 9214.5 9218.0 5221.7 5223.0 5246.4 5257.2 5264.9 4389.2 4520.1 4731.2 4834.6 4957.6 3774.6 3782.9 3831.2 3859.7 3882.9 1201.8 1210.6 1214.6 1226.8 1227.1 655.7 817.3 892.2 929.9 934.3 5604.6 5660.9 5723.3 5848.4 5971.7 941.7 958.7 980.5 984.2 993.6 3697.9 3854.6 3863.4 3943.6 3953.2 10381.7 10616.7 10872.1 10937.6 10967.4 10635.9 10655.6 10793.9 10810.6 10811.4 7726.7 7987.2 8011.0 8018.2 8433.0 4814.6 5586.9 5668.1 5712.2 5827.5 9340.0 9490.5 9582.7 9609.0 9616.9 9470.6 9522.5 9723.0 9792.3 9992.2 7410.7 7459.2 7487.8 7531.8 7533.2 8061.1 8093.7 8098.6 8115.7 8146.0 6027.8 7047.0 7233.9 7268.2 7312.2 6179.9 7157.4 7237.6 7251.3 7296.1 6050.8 6765.6 6780.1 6876.7 6882.4 4580.6 4631.7 4668.6 4758.8 4794.3 4678.2 4687.6 4721.0 4853.2 4892.2 03:27:17 INFO - PROCESS | 2007 | 03:27:17 INFO - PROCESS | 2007 | [#4] prototype.html Cycles:180 Average:5594.72 Median:6358.38 stddev:1776.43 (27.9%) stddev-sans-first:1736.57 03:27:17 INFO - PROCESS | 2007 | Values: 310.4 315.1 324.1 324.3 326.7 6389.0 6459.6 6461.8 6500.1 6510.1 4896.8 6116.0 6319.3 6323.2 6405.8 4771.2 4780.8 4803.0 4806.9 4836.3 4359.5 4771.8 4797.7 4820.0 4823.8 4496.1 4573.0 4669.2 4715.7 4766.5 4637.7 4751.4 4752.8 4752.9 4754.5 3344.0 4094.2 4098.1 4111.3 4112.8 6088.0 6114.2 6160.2 6162.4 6166.6 5567.1 5567.4 5575.3 5581.5 5590.9 6553.4 6689.1 6759.4 6782.7 6803.5 4331.2 4537.4 4579.0 4585.2 4594.2 7195.2 7214.2 7220.7 7223.6 7226.5 4647.3 4660.9 4663.3 4672.1 4677.4 4721.6 4722.3 4724.6 4726.2 4749.3 4572.9 5139.7 5497.0 5541.8 5551.5 6664.8 6714.3 6715.3 6716.6 6717.9 1563.4 1589.1 1590.6 1592.6 1593.8 948.4 982.8 998.6 1004.5 1008.8 6080.8 6136.9 6148.0 6148.9 6170.8 6940.9 7064.7 7090.5 7092.1 7101.0 6342.9 6358.1 6358.6 6380.2 6390.7 3730.6 3781.7 3783.9 3788.4 3792.2 7295.5 7560.1 7561.2 7566.1 7571.4 7332.0 7372.4 7375.9 7379.9 7386.2 6080.8 7522.0 7527.0 7530.7 7535.8 7112.1 7124.1 7129.0 7132.2 7132.8 6718.6 6952.7 6953.4 6960.7 6990.6 7033.8 7441.9 7541.7 7550.3 7573.8 4676.7 4741.4 4743.5 4743.6 4747.1 7017.5 7024.4 7033.4 7037.3 7040.0 6537.8 6795.2 6799.4 6807.1 6810.3 6706.9 6752.7 6759.9 6791.7 6795.1 5355.3 5370.7 6595.0 6621.4 6638.6 6783.8 6785.8 6787.9 6788.4 6791.6 6369.6 6502.0 6547.8 6635.3 6767.0 03:27:17 INFO - PROCESS | 2007 | 03:27:17 INFO - PROCESS | 2007 | [#5] yui.html Cycles:180 Average:17444.50 Median:33012.80 stddev:24007.93 (72.7%) stddev-sans-first:24042.25 03:27:17 INFO - PROCESS | 2007 | Values: 674.1 687.3 708.9 712.1 757.7 14711.0 14902.9 14914.0 14940.3 14965.0 13514.4 13587.6 14872.7 15280.4 15329.6 891.9 901.1 912.2 912.3 915.3 725.8 736.8 761.3 780.6 917.8 940.8 950.5 953.3 954.4 956.7 747.5 937.4 947.2 947.4 949.8 687.1 696.7 699.9 700.6 700.8 14893.5 14910.2 14945.5 14963.7 14979.3 9948.0 10059.3 12140.6 12203.3 12599.2 9730.9 9973.4 10140.1 10144.9 10406.0 3405.4 3428.8 3486.8 3551.7 3566.1 75636.0 75657.0 75722.0 76492.6 77188.0 9242.7 9272.0 9340.9 9479.0 9532.3 21161.6 21173.5 21223.0 21229.4 21240.2 7402.3 7496.7 7596.5 7709.4 7809.5 3441.9 4062.5 4092.9 4129.5 4318.8 3617.1 3651.5 3669.9 3673.4 3674.7 643.0 653.6 659.3 666.1 673.4 550.2 585.4 597.2 604.1 607.5 8305.6 8658.5 8713.7 8811.3 8814.3 532.3 586.7 606.7 611.7 621.9 3808.3 3809.5 3857.9 3864.8 4077.0 85019.6 86708.7 86862.1 91320.0 92508.0 69436.0 69717.7 70588.6 70885.9 71061.0 61772.1 63141.7 65372.0 65994.0 66585.3 7032.5 8068.8 8253.8 8331.6 8421.5 46191.5 46999.5 47402.3 48308.5 48465.0 59646.0 62823.4 64408.7 65629.0 66801.0 10864.2 11041.3 11073.8 11297.8 11896.0 11606.9 11928.6 12131.0 12268.6 12405.0 9280.9 11497.3 11528.9 11723.2 11750.8 9049.5 11383.8 11619.9 11661.2 12277.0 9575.5 11252.7 11460.8 11550.0 11631.9 9394.2 9402.2 9473.0 9740.7 9783.5 7251.7 8394.7 8566.4 8635.9 8739.3 03:27:17 INFO - PROCESS | 2007 | -------- Summary: end -------- 03:27:17 INFO - PROCESS | 2007 | 03:27:17 INFO - TEST-INFO | 2007: exit 0 03:27:17 INFO - TEST-OK | dromaeo_css | took 1114841ms 03:27:17 INFO - TEST-START | kraken 03:27:17 INFO - operating with platform_type : mac_ 03:27:17 INFO - Initialising browser for kraken test... 03:27:17 INFO - TEST-INFO | started process 2012 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmplCjCcK/profile http://localhost:51346/getInfo.html) 03:27:20 INFO - PROCESS | 2012 | __metrics Screen width/height:1600/1200 03:27:20 INFO - PROCESS | 2012 | colorDepth:24 03:27:20 INFO - PROCESS | 2012 | Browser inner width/height: 1024/689 03:27:20 INFO - PROCESS | 2012 | __metrics 03:27:20 INFO - PROCESS | 2012 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:27:20 ERROR - PROCESS | 2012 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:27:20 INFO - TEST-INFO | 2012: exit 0 03:27:20 INFO - Browser initialized. 03:27:20 INFO - Running cycle 1/1 for kraken test... 03:27:20 INFO - TEST-INFO | started process 2014 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmplCjCcK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:32 INFO - PROCESS | 2014 | RSS: Main: 211095552 03:27:32 INFO - PROCESS | 2014 | 03:27:35 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51346/tests/kraken/driver.html?testName=audio-beat-detection) 03:27:36 INFO - PROCESS | 2014 | RSS: Main: 271908864 03:27:36 INFO - PROCESS | 2014 | 03:27:39 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51346/tests/kraken/driver.html?testName=audio-dft) 03:27:39 INFO - PROCESS | 2014 | RSS: Main: 285782016 03:27:39 INFO - PROCESS | 2014 | 03:27:42 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51346/tests/kraken/driver.html?testName=audio-fft) 03:27:43 INFO - PROCESS | 2014 | RSS: Main: 375259136 03:27:43 INFO - PROCESS | 2014 | 03:27:45 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51346/tests/kraken/driver.html?testName=audio-oscillator) 03:27:46 INFO - PROCESS | 2014 | RSS: Main: 278360064 03:27:46 INFO - PROCESS | 2014 | 03:27:48 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51346/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:27:48 INFO - PROCESS | 2014 | RSS: Main: 278831104 03:27:48 INFO - PROCESS | 2014 | 03:27:51 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51346/tests/kraken/driver.html?testName=imaging-darkroom) 03:27:52 INFO - PROCESS | 2014 | RSS: Main: 318951424 03:27:52 INFO - PROCESS | 2014 | 03:27:55 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51346/tests/kraken/driver.html?testName=imaging-desaturate) 03:27:55 INFO - PROCESS | 2014 | RSS: Main: 318984192 03:27:55 INFO - PROCESS | 2014 | 03:27:58 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51346/tests/kraken/driver.html?testName=json-parse-financial) 03:27:59 INFO - PROCESS | 2014 | RSS: Main: 318255104 03:27:59 INFO - PROCESS | 2014 | 03:28:00 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51346/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:28:01 INFO - PROCESS | 2014 | RSS: Main: 309194752 03:28:01 INFO - PROCESS | 2014 | 03:28:03 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51346/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:28:03 INFO - PROCESS | 2014 | RSS: Main: 316121088 03:28:03 INFO - PROCESS | 2014 | 03:28:06 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51346/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:28:07 INFO - PROCESS | 2014 | RSS: Main: 319070208 03:28:07 INFO - PROCESS | 2014 | 03:28:09 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:28:10 INFO - PROCESS | 2014 | RSS: Main: 324128768 03:28:10 INFO - PROCESS | 2014 | 03:28:13 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:28:13 INFO - PROCESS | 2014 | RSS: Main: 321949696 03:28:13 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | Cycle 1(1): loaded http://localhost:51346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51346/tests/kraken/driver.html?testName=ai-astar) 03:28:15 INFO - PROCESS | 2014 | RSS: Main: 386445312 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | __start_tp_report 03:28:15 INFO - PROCESS | 2014 | _x_x_mozilla_page_load 03:28:15 INFO - PROCESS | 2014 | _x_x_mozilla_page_load_details 03:28:15 INFO - PROCESS | 2014 | |i|pagename|runs| 03:28:15 INFO - PROCESS | 2014 | |0;ai-astar;114;114;120;115;113;113;114;114;114;138 03:28:15 INFO - PROCESS | 2014 | |1;audio-beat-detection;156;120;153;155;120;142;138;117;167;116 03:28:15 INFO - PROCESS | 2014 | |2;audio-dft;187;187;188;185;185;187;186;186;186;188 03:28:15 INFO - PROCESS | 2014 | |3;audio-fft;70;79;75;153;55;59;65;90;162;55 03:28:15 INFO - PROCESS | 2014 | |4;audio-oscillator;96;95;144;79;79;93;125;80;79;126 03:28:15 INFO - PROCESS | 2014 | |5;imaging-gaussian-blur;92;88;92;89;91;88;92;88;92;87 03:28:15 INFO - PROCESS | 2014 | |6;imaging-darkroom;96;97;96;97;97;96;96;97;95;97 03:28:15 INFO - PROCESS | 2014 | |7;imaging-desaturate;89;88;90;86;90;87;88;90;90;87 03:28:15 INFO - PROCESS | 2014 | |8;json-parse-financial;61;64;67;64;64;66;65;82;61;60 03:28:15 INFO - PROCESS | 2014 | |9;json-stringify-tinderbox;65;64;71;75;81;77;72;68;70;69 03:28:15 INFO - PROCESS | 2014 | |10;stanford-crypto-aes;84;102;104;103;83;82;87;100;105;107 03:28:15 INFO - PROCESS | 2014 | |11;stanford-crypto-ccm;129;130;127;127;128;130;129;127;147;164 03:28:15 INFO - PROCESS | 2014 | |12;stanford-crypto-pbkdf2;199;166;168;168;176;167;165;165;166;165 03:28:15 INFO - PROCESS | 2014 | |13;stanford-crypto-sha256-iterative;68;69;70;67;68;68;67;70;66;66 03:28:15 INFO - PROCESS | 2014 | __end_tp_report 03:28:15 INFO - PROCESS | 2014 | __start_cc_report 03:28:15 INFO - PROCESS | 2014 | _x_x_mozilla_cycle_collect,2047 03:28:15 INFO - PROCESS | 2014 | __end_cc_report 03:28:15 INFO - PROCESS | 2014 | __startTimestamp1464431295801__endTimestamp 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | ------- Summary: start ------- 03:28:15 INFO - PROCESS | 2014 | Number of tests: 14 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#0] ai-astar Cycles:10 Average:116.90 Median:114.00 stddev:7.68 (6.7%) stddev-sans-first:8.07 03:28:15 INFO - PROCESS | 2014 | Values: 114.0 114.0 120.0 115.0 113.0 113.0 114.0 114.0 114.0 138.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:147.50 stddev:19.05 (12.9%) stddev-sans-first:19.11 03:28:15 INFO - PROCESS | 2014 | Values: 156.0 120.0 153.0 155.0 120.0 142.0 138.0 117.0 167.0 116.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#2] audio-dft Cycles:10 Average:186.50 Median:187.00 stddev:1.08 (0.6%) stddev-sans-first:1.13 03:28:15 INFO - PROCESS | 2014 | Values: 187.0 187.0 188.0 185.0 185.0 187.0 186.0 186.0 186.0 188.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#3] audio-fft Cycles:10 Average:86.30 Median:67.50 stddev:39.16 (58.0%) stddev-sans-first:41.08 03:28:15 INFO - PROCESS | 2014 | Values: 70.0 79.0 75.0 153.0 55.0 59.0 65.0 90.0 162.0 55.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#4] audio-oscillator Cycles:10 Average:99.60 Median:79.50 stddev:23.68 (29.8%) stddev-sans-first:25.08 03:28:15 INFO - PROCESS | 2014 | Values: 96.0 95.0 144.0 79.0 79.0 93.0 125.0 80.0 79.0 126.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:91.50 stddev:2.08 (2.3%) stddev-sans-first:2.06 03:28:15 INFO - PROCESS | 2014 | Values: 92.0 88.0 92.0 89.0 91.0 88.0 92.0 88.0 92.0 87.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:28:15 INFO - PROCESS | 2014 | Values: 96.0 97.0 96.0 97.0 97.0 96.0 96.0 97.0 95.0 97.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#7] imaging-desaturate Cycles:10 Average:88.50 Median:89.50 stddev:1.51 (1.7%) stddev-sans-first:1.59 03:28:15 INFO - PROCESS | 2014 | Values: 89.0 88.0 90.0 86.0 90.0 87.0 88.0 90.0 90.0 87.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:64.50 stddev:6.26 (9.7%) stddev-sans-first:6.43 03:28:15 INFO - PROCESS | 2014 | Values: 61.0 64.0 67.0 64.0 64.0 66.0 65.0 82.0 61.0 60.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:5.29 (7.4%) stddev-sans-first:5.11 03:28:15 INFO - PROCESS | 2014 | Values: 65.0 64.0 71.0 75.0 81.0 77.0 72.0 68.0 70.0 69.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#10] stanford-crypto-aes Cycles:10 Average:95.70 Median:94.50 stddev:10.31 (10.9%) stddev-sans-first:10.02 03:28:15 INFO - PROCESS | 2014 | Values: 84.0 102.0 104.0 103.0 83.0 82.0 87.0 100.0 105.0 107.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:129.50 stddev:12.17 (9.4%) stddev-sans-first:12.79 03:28:15 INFO - PROCESS | 2014 | Values: 129.0 130.0 127.0 127.0 128.0 130.0 129.0 127.0 147.0 164.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:167.50 stddev:10.53 (6.3%) stddev-sans-first:3.46 03:28:15 INFO - PROCESS | 2014 | Values: 199.0 166.0 168.0 168.0 176.0 167.0 165.0 165.0 166.0 165.0 03:28:15 INFO - PROCESS | 2014 | 03:28:15 INFO - PROCESS | 2014 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.45 (2.1%) stddev-sans-first:1.54 03:28:15 INFO - PROCESS | 2014 | Values: 68.0 69.0 70.0 67.0 68.0 68.0 67.0 70.0 66.0 66.0 03:28:15 INFO - PROCESS | 2014 | -------- Summary: end -------- 03:28:15 INFO - PROCESS | 2014 | 03:28:16 INFO - TEST-INFO | 2014: exit 0 03:28:16 INFO - TEST-OK | kraken | took 59093ms 03:28:16 INFO - SUITE-END | took 1173s 03:28:16 INFO - Completed test suite (00:19:34) 03:28:16 INFO - javascript benchmark 03:28:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.3676101540705, 3380.104272367822, 3395.0663567518927, 3424.520567120605, 3454.4990976308436, 5522.254495643092, 5572.247746554214, 5574.331080270374, 5584.609077364576, 5587.357453892803, 5504.366997795255, 5593.077142271531, 5601.523870471005, 5609.242752228448, 5655.660660360381, 5013.473585273548, 5086.542211200991, 5125.692458452496, 5174.637775355726, 5208.947910520903, 5157.226416037587, 5172.09488339541, 5175.223716442545, 5180.740962951837, 5189.714565698885, 5116.053530096944, 5164.251183578379, 5177.974110129463, 5194.324737784083, 5194.740262986855, 5172.198309262051, 5191.532762051395, 5194.792208311663, 5203.505666961632, 5238.8690282742855, 5022.522860328263, 5044.899102017939, 5068.645194836363, 5119.385673719177, 5126.820561280375, 5433.320834895638, 5439.5104440600535, 5464.644798088111, 5480.0, 5484.8354549363585, 6096.359882212392, 6097.420745029215, 6107.969460152715, 6112.052631842072, 6119.418655227746, 5958.7616495340135, 6104.603200791978, 6119.632822030692, 6155.476784473325, 6163.691815409212, 4846.75766211688, 5680.886382272372, 5684.34630017545, 5696.088625819932, 5716.628419152742, 6332.4934005279465, 6371.426571608485, 6387.744490220339, 6390.520710946697, 6400.0719895614875, 5736.1682556029145, 5853.824385268449, 5940.495057920039, 6026.54800889935, 6031.065184896348, 6135.69203737716, 6144.279601711439, 6151.9384806151365, 6153.784617538365, 6155.815325540241, 5994.400559944058, 6028.5478589106, 6031.125486804389, 6052.03167493199, 6099.664518451439, 5958.6424814511265, 6061.424164704346, 6076.635401875901, 6084.209052823105, 6084.5436592255755, 4781.52184781526, 4802.951970480251, 4804.855854324376, 4815.15734746418, 4827.8551643450755, 4324.308110702273, 4373.715708478939, 4381.408509851193, 4401.911961760747, 4422.226110430662, 5524.640898341675, 5530.668159910419, 5533.363663178706, 5542.251796007568, 5570.749316280696, 6100.786472473531, 6173.8456538586, 6178.752849886044, 6179.938200618026, 6183.381661833871, 5395.379531353945, 5427.457254274541, 5493.121100623881, 5528.281323428009, 5545.500904918576, 4923.532264434873, 4984.925226121611, 5239.004589128053, 5260.184671375943, 5275.076861549213, 5230.764615592308, 6283.434490895841, 6326.272478665012, 6341.143945567382, 6352.460040896391, 6043.244594425697, 6109.34393638171, 6134.04922237054, 6143.1706719592285, 6210.72051757681, 6278.591891527036, 6302.0, 6306.810795676137, 6309.242890853127, 6331.461825744679, 5460.6177567569885, 5903.970480147572, 6055.424734650202, 6063.423974722395, 6079.848003799763, 5884.32330282023, 5989.970050149721, 6066.7269972850445, 6127.0673618518995, 6148.985417406078, 5893.263342082239, 5925.200097986716, 5932.317783454958, 5947.0, 5960.0, 5875.383084776208, 5906.970465147647, 5913.379095194942, 5915.260592425947, 5920.052791553331, 5607.943920560742, 5704.087346024616, 5718.685472299064, 5760.769569217352, 5818.505427038749, 5833.329167145833, 5931.881362372642, 5943.762249510144, 5958.702064896651, 5964.956132676851, 5815.738291776965, 5823.272090988627, 5827.475527202572, 5837.503812176013, 5861.6189947653265], "value": 5578.364533050936, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.8483739715481, 526.7445289034818, 577.232281066182, 583.9211706419635, 585.9131311417318, 31305.530417043734, 31943.041708748744, 31963.68036319636, 31985.840070799644, 38385.23229535408, 43598.91002724934, 44154.33768493467, 44186.779066104704, 44190.558094419044, 44298.778506107425, 9591.424514529133, 9813.509324533745, 9828.36115652484, 9835.65575204868, 9838.655647052354, 9507.80984380312, 9619.903800962005, 9633.27750418718, 9638.614455421775, 9640.903590964072, 9626.663066792664, 9664.806703865954, 9674.371165874196, 9679.564419601134, 9690.32167748258, 9598.80802383952, 9636.95181524095, 9641.855372169422, 9647.662331818388, 9655.131038206595, 8159.592020399015, 9468.668596599086, 9572.138507534355, 9581.520923953844, 9591.0, 40492.797536012135, 40979.18041639151, 40991.97520061993, 41014.38478422826, 41048.384274235614, 3108.704673056056, 3225.7903236289567, 3257.1042963185077, 3265.8856940006985, 3645.9270814583824, 28693.28266793326, 28964.42071158565, 29087.0, 29231.85384073066, 29352.8532357339, 2731.412746259544, 2737.9589306160424, 2757.0901602471336, 2759.351552385188, 2794.888204471819, 469618.0, 470679.0, 471415.0, 471689.0, 472417.0, 64220.67889660615, 64524.35475645184, 64530.0, 64662.706745864816, 64701.67649161724, 67319.3268067313, 67832.6608366955, 69834.65082674655, 71097.0, 71196.64401677958, 17479.126043697765, 17550.29798808059, 17664.91167544154, 17678.204480798395, 17680.469585912444, 13266.336683165802, 13360.39878205483, 13366.866331336561, 13370.264635445144, 13384.665383365298, 19429.611407771765, 19699.803001970082, 19708.408747737303, 19747.210111595374, 19760.505987350432, 7907.0, 7961.084475285301, 7995.480293780885, 8007.399445041645, 8057.717979870677, 916.2669864108686, 950.2920324358397, 980.3676628574672, 983.1544871410581, 993.1161266472845, 29497.705022949925, 29902.551461728093, 29942.0, 30775.38449231003, 30879.919202827794, 1010.6311196413403, 1110.4725255503733, 1126.1159989408275, 1135.4720055174384, 1161.5586077290745, 15364.0, 15370.09384067571, 15375.461858834888, 15487.767683484757, 15918.9204053979, 528427.3578632083, 616252.0, 617320.0, 617559.0, 617843.0, 61101.38898610957, 62971.685141574, 63187.6840615794, 63194.684026579576, 63195.0, 1462.6562757752133, 1465.5603319004256, 1477.6084337650532, 1493.059372595258, 1493.507142642947, 29302.26744331409, 29861.0, 29982.850085750306, 30649.54025689661, 30682.386352273275, 54056.0, 54459.18311225414, 54783.726081369336, 54929.72535137299, 54946.72526637341, 535426.0, 538635.0, 538942.0, 540238.0, 542269.0, 26923.192304230903, 27252.0, 27322.180334589993, 27534.173974780788, 27757.583636245876, 43692.34461483017, 44647.330290046324, 44659.553404465536, 46585.767071164424, 47775.0, 38087.428688570246, 38233.0, 38399.80800095982, 38472.0, 38703.03242418962, 36718.0, 37927.620723793516, 37995.62004379921, 39029.63396281117, 39051.80474097611, 29589.556156657236, 33550.0, 37954.0, 38408.84773456801, 39031.60968390393, 30898.382032359677, 30991.070267892, 31602.841985789924, 32765.344693106483, 32793.83603081969, 23935.640965385883, 24492.387690307172, 24601.753982459948, 25024.74975250224, 25170.49659006773], "value": 20015.733090333884, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.66250761715435, 372.0271490053511, 396.56179921187095, 405.884322967954, 408.9468369112015, 16059.437919672813, 16384.18079096045, 20326.89836550819, 21098.894505527453, 21124.471888202803, 16641.83358166418, 20646.038626330475, 20772.480687982807, 20958.476038099056, 20958.89520552399, 4121.258173528764, 5685.232493613351, 5888.175655408247, 5890.175375447441, 5899.764009439617, 6121.143039974407, 6531.869362612745, 6543.247526534438, 6546.9017964730565, 6560.540762146652, 6356.424387712226, 6496.187976502937, 6501.577397469149, 6502.837429064288, 6521.250056243545, 6284.12022316876, 6446.033095035736, 6453.999630057348, 6458.160439142881, 6479.22249330081, 5474.452554744494, 5545.3622833374275, 5612.69130197839, 5616.5787565932305, 5656.585853536616, 25287.0, 26156.34609134787, 26229.344266393302, 26307.868460657766, 26356.94572217109, 2204.0, 2309.891252198954, 2338.865650159671, 2350.247920665388, 2401.2916189724074, 14143.71712565743, 14719.116852988747, 14755.926220368829, 14827.332770025374, 15220.238988050553, 1658.286936617254, 1742.3534759652134, 1772.3265159239406, 1794.120880768427, 1795.4793109998216, 111912.0, 112099.43950280278, 112519.0, 113836.99999999917, 115982.42008789987, 10508.264421490423, 10618.469076546142, 10844.72888177786, 11064.293461690262, 11212.719682008015, 14046.1572305662, 14064.08583442073, 14101.506447274296, 14105.153690778381, 14111.0, 8717.825643487095, 8840.690575829814, 8856.601452934634, 8953.552322383985, 8956.44741248741, 8994.910050899538, 9043.095690431035, 9064.637414503346, 9065.546722663972, 9137.497437640994, 5157.16920493227, 6671.43292820106, 6677.799666010027, 6678.49911256648, 6691.832704182434, 1855.8144185581334, 1882.5670095878024, 1886.415211284506, 1891.7446144770279, 1905.1902941249914, 904.737626088427, 1002.1581871228203, 1056.8256237720843, 1065.6057258814287, 1068.2522234435926, 20639.277625283044, 21146.154153833675, 21183.243106199305, 21186.364409067446, 21382.679259811117, 1002.5588740953957, 1003.9759445365686, 1014.2089170447063, 1019.5463018956493, 1090.4983707494482, 10818.891811081789, 11172.385518796544, 11367.317960922372, 11368.829467557993, 11454.828177577343, 495229.0, 522893.0, 523188.0, 595976.0, 616513.0, 109825.45087274513, 126252.7374726241, 130960.0, 131681.3415932914, 139236.6076339244, 1013.3717095400751, 1034.3690348887174, 1054.0671505717496, 1056.3503445381189, 1057.1437135920082, 14833.332500037308, 16069.839301606835, 16325.020498770113, 17825.643487130445, 18574.721379179595, 43188.568114318456, 43826.561734382245, 52371.95256094933, 53250.06869332738, 53727.6568085801, 72704.9094263597, 77510.0, 77601.0, 77690.0, 77917.61041194758, 7878.566678832719, 8110.107888132183, 10439.37363758177, 10627.61840960701, 12269.263844169378, 11076.335419874833, 12304.138710290194, 13264.60206193777, 13387.732245354844, 13390.866091339352, 11206.719832003939, 11292.0, 11368.94315528417, 11418.602093560445, 11677.824832627348, 11294.60468883585, 11374.715632108933, 11528.711782205177, 11625.825612615987, 11698.824517632072, 11699.707507312385, 11741.29552226869, 11809.71738578136, 11816.70458238551, 11838.585649502225, 11961.222520536137, 12025.819612705991, 12059.75880482403, 12302.692432688897, 12364.319962402154, 11489.138314626269, 11494.885051149717, 11586.246893951866, 11728.0, 11748.882511175121], "value": 9995.50400497244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.8845798107172, 1539.284232831733, 1546.9071855688655, 1749.8425141737248, 1900.1829213438225, 7538.96230518848, 7858.449908506407, 8069.959650201748, 8541.273991710705, 8739.082396348387, 8379.078301386842, 8393.202645748659, 8477.406581539295, 8489.830203395928, 8501.277391421736, 2392.8803559822027, 2415.420299128214, 2416.142269494331, 2417.5648383291086, 2421.806255499556, 2367.0768400323886, 2407.145463360508, 2410.8915098820507, 2414.8309618326725, 2415.770501802326, 2384.7853693167613, 2407.626817843237, 2420.1529464687396, 2423.212455951814, 2430.0, 2372.074890792592, 2406.398400399891, 2418.298693378918, 2421.8667973261463, 2427.4295540548046, 2359.728631207416, 2385.9522809543887, 2392.9760702392928, 2395.7843794058617, 2398.6641870138196, 8619.051904290523, 8670.0, 8702.042775294713, 8711.259542938858, 8715.041345451995, 5142.254373115915, 5360.678359298416, 5366.356037275513, 5370.0, 5388.515033646991, 3452.671996160361, 3487.9825600872086, 3493.3013397320383, 3539.699125574329, 3542.079059444563, 1045.4459136657583, 1062.2192688374116, 1063.8244689626201, 1069.1340014588209, 1069.8769641491172, 11435.828462572985, 11608.477618507188, 11617.709557261052, 11630.6510804676, 11645.18483706141, 4445.866624001285, 4549.658775591844, 4565.360849481075, 4596.379488768974, 4655.580997710223, 9186.356955013218, 9199.4940278284, 9204.723858284262, 9214.493202873773, 9217.953910230406, 5221.660592061504, 5223.007628550563, 5246.3704355477585, 5257.185136303879, 5264.894702105937, 4389.231884420214, 4520.0507893342765, 4731.1720448921305, 4834.5890599299455, 4957.553820156203, 3774.6036666149657, 3782.8865134046023, 3831.233753249361, 3859.6912247020173, 3882.8835134946, 1201.8077107662907, 1210.5836171679157, 1214.5991822698488, 1226.779179747654, 1227.1226073357413, 655.6852710698796, 817.3297895725567, 892.1524551675934, 929.8837645294338, 934.3272843552631, 5604.551635869121, 5660.915086273709, 5723.313202415737, 5848.4151584841175, 5971.731272092767, 941.7127776028377, 958.6500927161536, 980.4852452462371, 984.2224642532462, 993.557866749304, 3697.8705745298785, 3854.5952674969285, 3863.362545180014, 3943.645071943539, 3953.2291203215095, 10381.740456488647, 10616.681499555025, 10872.075873550837, 10937.56249750017, 10967.396793176453, 10635.883232260656, 10655.62705305326, 10793.946030269799, 10810.567577296977, 10811.40537270442, 7726.729564465217, 7987.241212084843, 8011.0, 8018.158093400109, 8433.0, 4814.638902082428, 5586.944130558642, 5668.121441176624, 5712.171735098471, 5827.533797296291, 9339.953300233456, 9490.478023708762, 9582.712518624452, 9608.95195524018, 9616.855747163938, 9470.621175152917, 9522.52387380642, 9723.02769723022, 9792.265580081379, 9992.20062394992, 7410.666520006721, 7459.216782238004, 7487.812804679927, 7531.8117047074265, 7533.209013053551, 8061.113277539584, 8093.676252950052, 8098.554579497949, 8115.675372985014, 8146.0, 6027.819165425044, 7047.0, 7233.927660723325, 7268.164161121539, 7312.232215617283, 6179.907301390393, 7157.355837974607, 7237.638118093969, 7251.274872512707, 7296.087989001375, 6050.848728781815, 6765.627890466071, 6780.118584583973, 6876.69054892541, 6882.414994725505, 4580.587747102777, 4631.698939568917, 4668.60316873056, 4758.785854636619, 4794.256890182028, 4678.157931572349, 4687.601553867959, 4721.032188401438, 4853.223484242504, 4892.168331383602], "value": 4501.006929715485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.3854368350664, 315.06268850170744, 324.073150788744, 324.2849516815422, 326.74024150800113, 6388.968055159724, 6459.6447195404235, 6461.806145815622, 6500.057491663706, 6510.08858759774, 4896.828610998616, 6116.0, 6319.273283572391, 6323.20959880015, 6405.807825765234, 4771.165046116933, 4780.80876764929, 4802.951970480303, 4806.8557943261585, 4836.347093142434, 4359.542248063955, 4771.832985845496, 4797.704619752664, 4820.0, 4823.758812059401, 4496.078303947683, 4572.977135114336, 4669.182892993713, 4715.669903106784, 4766.475687674353, 4637.721736695809, 4751.40607424072, 4752.7623618818925, 4752.881177970544, 4754.500777418356, 3343.9832800836084, 4094.2220978014084, 4098.098418347989, 4111.301078816608, 4112.835486580563, 6088.0, 6114.1745864308195, 6160.168377269056, 6162.414570615784, 6166.599171053912, 5567.053600887859, 5567.387587365387, 5575.330960284792, 5581.5255703265275, 5590.944090559083, 6553.442957348631, 6689.120310220061, 6759.357861003196, 6782.660866956632, 6803.455723542104, 4331.242032644274, 4537.4328208973875, 4579.038401935598, 4585.174668559658, 4594.150082234797, 7195.172555156171, 7214.242504537053, 7220.67506962188, 7223.638818059128, 7226.4580156489, 4647.34937108805, 4660.906781864343, 4663.277192035172, 4672.1356549037855, 4677.415323084614, 4721.622270218374, 4722.276369125245, 4724.622030237572, 4726.172919739032, 4749.311349854252, 4572.862814115582, 5139.665921715076, 5496.983058134258, 5541.750621222055, 5551.528120109755, 6664.83337916556, 6714.261431242559, 6715.2613212546585, 6716.630585317756, 6717.932820671828, 1563.4059057558281, 1589.1021572811323, 1590.5943984283933, 1592.5859276588171, 1593.8485843844817, 948.3551185194134, 982.7985263021063, 998.5556427389741, 1004.4626125023224, 1008.7982403519326, 6080.844639518566, 6136.8772624548155, 6148.0, 6148.907766383508, 6170.784022559189, 6940.930590694129, 7064.682089305994, 7090.539114957512, 7092.148942126978, 7101.0, 6342.936570634234, 6358.1416508771645, 6358.618482891041, 6380.202474690664, 6390.680465976682, 3730.552333719971, 3781.6596506314563, 3783.9432408513894, 3788.3749181385315, 3792.2036372361563, 7295.489315747846, 7560.130584982798, 7561.243875612505, 7566.1298950620285, 7571.3942884569105, 7332.046833911664, 7372.373348265351, 7375.88936165958, 7379.88930166048, 7386.15059268191, 6080.847978800565, 7522.0, 7527.021487206628, 7530.698772049057, 7535.773926782205, 7112.110986126734, 7124.145102587722, 7129.0, 7132.179799323144, 7132.821679458055, 6718.563293385914, 6952.721891124298, 6953.374196322356, 6960.686769095301, 6990.580565165903, 7033.753818616324, 7441.888371674538, 7541.660625271767, 7550.282723141293, 7573.772786816405, 4676.672632915664, 4741.407324084489, 4743.525647435229, 4743.620510359094, 4747.050589881968, 7017.543859649107, 7024.4029257513685, 7033.402160816388, 7037.26108758573, 7039.964800175966, 6537.771178008747, 6795.184577850492, 6799.354061364163, 6807.115075040213, 6810.284920083518, 6706.932930670826, 6752.729890804313, 6759.898601520883, 6791.66041697923, 6795.116634837637, 5355.30381050461, 5370.677759334452, 6595.0, 6621.370969757865, 6638.5684930479365, 6783.796486105425, 6785.796426107225, 6787.898181527183, 6788.422984046214, 6791.626460544718, 6369.554131210771, 6502.0, 6547.770828020996, 6635.279535390467, 6766.96616516934], "value": 4996.437876021182, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.0765151742113, 687.3261819626538, 708.9291070892908, 712.1134187936019, 757.685560492396, 14711.0, 14902.850971490281, 14914.0, 14940.327685254162, 14965.0, 13514.391852366642, 13587.59237222885, 14872.702545949074, 15280.388784448636, 15329.616759581017, 891.8795962545055, 901.0944001278739, 912.174482093703, 912.2701838529183, 915.2723584750106, 725.8403151306704, 736.8305289783353, 761.2881955371718, 780.6252998560694, 917.7980844214295, 940.7507010642186, 950.538988590533, 953.2802733935869, 954.3653470442148, 956.6603855631255, 747.5439981611213, 937.4047479850276, 947.1901524196782, 947.3842002698233, 949.8005418862048, 687.1376422589668, 696.6760456387753, 699.9475039372068, 700.6146619359332, 700.7792545348199, 14893.47872824446, 14910.17994010329, 14945.476908308267, 14963.700725985529, 14979.251037448084, 9947.950260248652, 10059.346142500788, 12140.635780926586, 12203.328816915066, 12599.181053231603, 9730.854037189449, 9973.351732137387, 10140.08739213467, 10144.898551014468, 10406.0, 3405.4381027130494, 3428.794272343667, 3486.7733597316346, 3551.6803487686234, 3566.1262990567216, 75635.96545802918, 75657.0, 75722.0, 76492.61753691196, 77188.0, 9242.72271831846, 9272.0, 9340.906590934139, 9479.0, 9532.285078619132, 21161.576768464543, 21173.470663233235, 21223.0, 21229.363119106452, 21240.150393984375, 7402.29678180572, 7496.737614183587, 7596.544207347577, 7709.42179336552, 7809.492382995087, 3441.913952151166, 4062.532808726975, 4092.9181416371507, 4129.525104612948, 4318.762468064224, 3617.077645200457, 3651.5253017107607, 3669.87155449558, 3673.3571624965525, 3674.65090816372, 643.0161852365887, 653.6078352988169, 659.3176062775101, 666.1107421592131, 673.4208580620663, 550.2269311617184, 585.4175095779726, 597.2444857255575, 604.1421181921681, 607.5018484842387, 8305.563188528939, 8658.523781191969, 8713.651453941771, 8811.339149563808, 8814.250788683034, 532.3106576982816, 586.7125108696708, 606.6542071019477, 611.7063809371526, 621.9004959206505, 3808.333541630204, 3809.476458012253, 3857.9228415432094, 3864.768113913174, 4077.0215148364773, 85019.5749021251, 86708.6993695095, 86862.13137868667, 91320.0, 92508.0, 69435.95846062314, 69717.65141174261, 70588.64705676542, 70885.93671094938, 71061.0, 61772.1468355959, 63141.68429157825, 65372.0, 65994.0, 66585.33414665791, 7032.542884712478, 8068.757937261891, 8253.83492330162, 8331.583420828812, 8421.4947103174, 46191.538084618725, 46999.530004700886, 47402.288965664855, 48308.51691483181, 48465.0, 59646.0, 62823.37176628358, 64408.711825762286, 65629.0, 66801.0, 10864.185186110915, 11041.282316649393, 11073.778524429628, 11297.774044519228, 11895.988840948616, 11606.94196529012, 11928.642140735792, 12131.0, 12268.631941041784, 12405.0, 9280.860787088333, 11497.310161390344, 11528.942355288169, 11723.179377443497, 11750.823737644114, 9049.457032578066, 11383.829242561202, 11619.941900290783, 11661.183717139718, 12277.0, 9575.521223938915, 11252.718682033015, 11460.796616355496, 11550.0, 11631.88368116308, 9394.154526092685, 9402.15380615748, 9472.95263523678, 9740.659076932274, 9783.51082445889, 7251.709931602677, 8394.706185283485, 8566.400351975302, 8635.87046194295, 8739.300855931637], "value": 6759.006442504964, "unit": "score"}], "name": "dromaeo_css", "value": 7440.396725278915, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 120.0, 115.0, 113.0, 113.0, 114.0, 114.0, 114.0, 138.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 120.0, 153.0, 155.0, 120.0, 142.0, 138.0, 117.0, 167.0, 116.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 188.0, 185.0, 185.0, 187.0, 186.0, 186.0, 186.0, 188.0], "value": 186.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 79.0, 75.0, 153.0, 55.0, 59.0, 65.0, 90.0, 162.0, 55.0], "value": 86.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 144.0, 79.0, 79.0, 93.0, 125.0, 80.0, 79.0, 126.0], "value": 99.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 92.0, 89.0, 91.0, 88.0, 92.0, 88.0, 92.0, 87.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 95.0, 97.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 90.0, 86.0, 90.0, 87.0, 88.0, 90.0, 90.0, 87.0], "value": 88.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 67.0, 64.0, 64.0, 66.0, 65.0, 82.0, 61.0, 60.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 71.0, 75.0, 81.0, 77.0, 72.0, 68.0, 70.0, 69.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 102.0, 104.0, 103.0, 83.0, 82.0, 87.0, 100.0, 105.0, 107.0], "value": 95.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 127.0, 127.0, 128.0, 130.0, 129.0, 127.0, 147.0, 164.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 166.0, 168.0, 168.0, 176.0, 167.0, 165.0, 165.0, 166.0, 165.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 67.0, 68.0, 68.0, 67.0, 70.0, 66.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1507.0, "alertThreshold": 2.0}]} 03:28:17 INFO - Return code: 0 03:28:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:28:17 ERROR - # TBPL SUCCESS # 03:28:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:28:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:28:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:28:17 INFO - 2016-05-28 03:28:17.109 screenresolution[2018:16541] starting screenresolution argv=screenresolution get 03:28:17 INFO - 2016-05-28 03:28:17.112 screenresolution[2018:16541] Display 0: 1600x1200x32@60 03:28:17 INFO - 2016-05-28 03:28:17.118 screenresolution[2019:16545] starting screenresolution argv=screenresolution list 03:28:17 INFO - Available Modes on Display 0 03:28:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:28:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:28:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:28:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:28:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:28:17 INFO - Intel Iris: 03:28:17 INFO - Chipset Model: Intel Iris 03:28:17 INFO - Type: GPU 03:28:17 INFO - Bus: Built-In 03:28:17 INFO - VRAM (Dynamic, Max): 1536 MB 03:28:17 INFO - Vendor: Intel (0x8086) 03:28:17 INFO - Device ID: 0x0a2e 03:28:17 INFO - Revision ID: 0x0009 03:28:17 INFO - Displays: 03:28:17 INFO - Display: 03:28:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:28:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:28:17 INFO - Display Serial Number: 1600x1200 60 03:28:17 INFO - Main Display: Yes 03:28:17 INFO - Mirror: Off 03:28:17 INFO - Online: Yes 03:28:17 INFO - Rotation: Supported 03:28:17 INFO - Return code: 0 03:28:17 INFO - Running post-action listener: _resource_record_post_action 03:28:17 INFO - Running post-run listener: _resource_record_post_run 03:28:18 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 2114048; Write bytes: 652596736; Read time: 18; Write time: 1795 03:28:18 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 344584704; Write bytes: 344274432; Read time: 27133; Write time: 606 03:28:18 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 2114048; Write bytes: 296325120; Read time: 18; Write time: 1149 03:28:18 INFO - Running post-run listener: _upload_blobber_files 03:28:18 INFO - Blob upload gear active. 03:28:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:28:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:28:18 INFO - (blobuploader) - INFO - Open directory for files ... 03:28:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:28:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:28:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:19 INFO - (blobuploader) - INFO - Done attempting. 03:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:28:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:20 INFO - (blobuploader) - INFO - Done attempting. 03:28:20 INFO - (blobuploader) - INFO - Iteration through files over. 03:28:20 INFO - Return code: 0 03:28:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:28:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:28:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbd9685b7261c27dc848721de47a30db286747c5ea114a59c136377f9bffc7f235a23c6471974c88e3b41fcf1bd10af7411a648f407776cdb8b033d4ff42b04e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c31b700da4cd21ac0d503bd29f32b5881a3d921019aba5f6a89a71d39bfb795294e914ad59f796f5c6e47a297b70e3f946e498b0d605aeb85d2b39b27484d96f"} 03:28:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:28:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:28:20 INFO - Contents: 03:28:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbd9685b7261c27dc848721de47a30db286747c5ea114a59c136377f9bffc7f235a23c6471974c88e3b41fcf1bd10af7411a648f407776cdb8b033d4ff42b04e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c31b700da4cd21ac0d503bd29f32b5881a3d921019aba5f6a89a71d39bfb795294e914ad59f796f5c6e47a297b70e3f946e498b0d605aeb85d2b39b27484d96f"} 03:28:20 INFO - Running post-run listener: copy_logs_to_upload_dir 03:28:20 INFO - Copying logs to upload dir... 03:28:20 INFO - mkdir: /builds/slave/test/build/upload/logs 03:28:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.707217 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-05-28 03:28:20.845474) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:28:20.848873) ========= 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.TPxa1xFwMI/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.V9qAineymd/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbd9685b7261c27dc848721de47a30db286747c5ea114a59c136377f9bffc7f235a23c6471974c88e3b41fcf1bd10af7411a648f407776cdb8b033d4ff42b04e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c31b700da4cd21ac0d503bd29f32b5881a3d921019aba5f6a89a71d39bfb795294e914ad59f796f5c6e47a297b70e3f946e498b0d605aeb85d2b39b27484d96f"} build_url:https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/exYQfz-jThSjCJc2Onf53A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbd9685b7261c27dc848721de47a30db286747c5ea114a59c136377f9bffc7f235a23c6471974c88e3b41fcf1bd10af7411a648f407776cdb8b033d4ff42b04e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c31b700da4cd21ac0d503bd29f32b5881a3d921019aba5f6a89a71d39bfb795294e914ad59f796f5c6e47a297b70e3f946e498b0d605aeb85d2b39b27484d96f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:28:20.883005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:28:20.883666) ========= 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.TPxa1xFwMI/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.V9qAineymd/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.005187 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:28:20.935617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:28:20.936260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:28:20.936942) ========= ========= Total master_lag: 0.19 =========