builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0120 starttime: 1464103903.69 results: success (0) buildid: 20160524070908 builduid: d35eaacb15fd4cd18d4a12cb17e18bb5 revision: 9fe9c798d44ff40eb793feb857602cce7dff16e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:43.690271) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:43.690630) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:43.690904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:43.711589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:43.711878) ========= 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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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-24 08:31:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.52M=0.002s 2016-05-24 08:31:43 (6.52 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119760 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:43.917499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:43.917784) ========= 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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.031088 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:43.970359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 08:31:43.970653) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9fe9c798d44ff40eb793feb857602cce7dff16e8 --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 9fe9c798d44ff40eb793feb857602cce7dff16e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eBJ6u9bkHO/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.06qVu1TYfI/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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-24 08:31:43,486 truncating revision to first 12 chars 2016-05-24 08:31:43,486 Setting DEBUG logging. 2016-05-24 08:31:43,486 attempt 1/10 2016-05-24 08:31:43,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9fe9c798d44f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 08:31:44,503 unpacking tar archive at: mozilla-aurora-9fe9c798d44f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.268030 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 08:31:45.259512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:45.259784) ========= script_repo_revision: 9fe9c798d44ff40eb793feb857602cce7dff16e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:45.260129) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:45.260385) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 08:31:45.279533) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-05-24 08:31:45.279820) ========= /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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:31:44 INFO - MultiFileLogger online at 20160524 08:31:44 in /builds/slave/test 08:31:44 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 08:31:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:31:44 INFO - {'append_to_log': False, 08:31:44 INFO - 'base_work_dir': '/builds/slave/test', 08:31:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:31:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:31:44 INFO - 'branch': 'Mozilla-Aurora', 08:31:44 INFO - 'buildbot_json_path': 'buildprops.json', 08:31:44 INFO - 'config_files': ('talos/mac_config.py',), 08:31:44 INFO - 'default_actions': ('clobber', 08:31:44 INFO - 'read-buildbot-config', 08:31:44 INFO - 'download-and-extract', 08:31:44 INFO - 'populate-webroot', 08:31:44 INFO - 'create-virtualenv', 08:31:44 INFO - 'install', 08:31:44 INFO - 'run-tests'), 08:31:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:31:44 INFO - 'download_minidump_stackwalk': True, 08:31:44 INFO - 'download_symbols': 'ondemand', 08:31:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:31:44 INFO - 'tooltool.py': '/tools/tooltool.py', 08:31:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:31:44 INFO - '/tools/misc-python/virtualenv.py')}, 08:31:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:31:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:31:44 INFO - 'installer_path': 'installer.exe', 08:31:44 INFO - 'log_level': 'info', 08:31:44 INFO - 'log_name': 'talos', 08:31:44 INFO - 'log_to_console': True, 08:31:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:31:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:31:44 INFO - 'opt_config_files': (), 08:31:44 INFO - 'pip_index': False, 08:31:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:31:44 INFO - 'cmd': ('bash', 08:31:44 INFO - '-c', 08:31:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:31:44 INFO - 'enabled': True, 08:31:44 INFO - 'halt_on_failure': False, 08:31:44 INFO - 'name': 'check_screen_resolution'},), 08:31:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:31:44 INFO - 'cmd': ('bash', 08:31:44 INFO - '-c', 08:31:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:31:44 INFO - 'enabled': True, 08:31:44 INFO - 'halt_on_failure': False, 08:31:44 INFO - 'name': 'check_screen_resolution'},), 08:31:44 INFO - 'run_cmd_checks_enabled': True, 08:31:44 INFO - 'sps_profile': False, 08:31:44 INFO - 'sps_profile_interval': 0, 08:31:44 INFO - 'suite': 'dromaeojs', 08:31:44 INFO - 'system_bits': '32', 08:31:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:31:44 INFO - 'title': 't-yosemite-r7-0120', 08:31:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:31:44 INFO - 'use_talos_json': True, 08:31:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:31:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:31:44 INFO - 'work_dir': 'build'} 08:31:44 INFO - ##### 08:31:44 INFO - ##### Running clobber step. 08:31:44 INFO - ##### 08:31:44 INFO - Running pre-action listener: _resource_record_pre_action 08:31:44 INFO - Running main action method: clobber 08:31:44 INFO - rmtree: /builds/slave/test/build 08:31:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:31:46 INFO - Running post-action listener: _resource_record_post_action 08:31:46 INFO - ##### 08:31:46 INFO - ##### Running read-buildbot-config step. 08:31:46 INFO - ##### 08:31:46 INFO - Running pre-action listener: _resource_record_pre_action 08:31:46 INFO - Running main action method: read_buildbot_config 08:31:46 INFO - Using buildbot properties: 08:31:46 INFO - { 08:31:46 INFO - "project": "", 08:31:46 INFO - "product": "firefox", 08:31:46 INFO - "script_repo_revision": "production", 08:31:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:31:46 INFO - "repository": "", 08:31:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:31:46 INFO - "buildid": "20160524070908", 08:31:46 INFO - "pgo_build": "False", 08:31:46 INFO - "basedir": "/builds/slave/test", 08:31:46 INFO - "buildnumber": 356, 08:31:46 INFO - "slavename": "t-yosemite-r7-0120", 08:31:46 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:31:46 INFO - "platform": "yosemite_r7", 08:31:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:31:46 INFO - "branch": "mozilla-aurora", 08:31:46 INFO - "repo_path": "releases/mozilla-aurora", 08:31:46 INFO - "revision": "9fe9c798d44ff40eb793feb857602cce7dff16e8", 08:31:46 INFO - "stage_platform": "macosx64", 08:31:46 INFO - "builduid": "d35eaacb15fd4cd18d4a12cb17e18bb5", 08:31:46 INFO - "slavebuilddir": "test" 08:31:46 INFO - } 08:31:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 08:31:46 INFO - Running post-action listener: _resource_record_post_action 08:31:46 INFO - ##### 08:31:46 INFO - ##### Running download-and-extract step. 08:31:46 INFO - ##### 08:31:46 INFO - Running pre-action listener: _resource_record_pre_action 08:31:46 INFO - Running main action method: download_and_extract 08:31:46 INFO - mkdir: /builds/slave/test/build/tests 08:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:46 INFO - https://queue.taskcluster.net/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 08:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 08:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/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 08:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/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 08:31:50 INFO - Downloaded 1199 bytes. 08:31:50 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 08:31:50 INFO - Using the following test package requirements: 08:31:50 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 08:31:50 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:31:50 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 08:31:50 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:31:50 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 08:31:50 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:31:50 INFO - u'jsshell-mac.zip'], 08:31:50 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:31:50 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 08:31:50 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 08:31:50 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:31:50 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 08:31:50 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:31:50 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 08:31:50 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:31:50 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 08:31:50 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 08:31:50 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 08:31:50 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:31: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')]} 08:31:50 INFO - https://queue.taskcluster.net/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:31:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 08:31:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 08:31:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/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 08:31:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/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 08:31:53 INFO - Downloaded 18425392 bytes. 08:31:53 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'] 08:31:53 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 08:31:56 INFO - Return code: 0 08:31:56 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 08:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:56 INFO - https://queue.taskcluster.net/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:31:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 08:31:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 08:31:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/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 08:31:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/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 08:32:01 INFO - Downloaded 18425392 bytes. 08:32:01 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'] 08:32:01 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 08:32:05 INFO - Return code: 0 08:32:05 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')]} 08:32:05 INFO - https://queue.taskcluster.net/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:32:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 08:32:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 08:32:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/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 08:32:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/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 08:32:06 INFO - Downloaded 10840145 bytes. 08:32:06 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'] 08:32:06 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 08:32:06 INFO - Return code: 0 08:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:06 INFO - https://queue.taskcluster.net/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:32:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 08:32:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 08:32:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 08:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fYP1jvNPQvioSByJD1tn4Q/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 08:32:12 INFO - Downloaded 114131713 bytes. 08:32:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 08:32:12 INFO - mkdir: /builds/slave/test/properties 08:32:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:12 INFO - Contents: 08:32:12 INFO - build_url:https://queue.taskcluster.net/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 08:32:13 INFO - Running post-action listener: _resource_record_post_action 08:32:13 INFO - Running post-action listener: set_extra_try_arguments 08:32:13 INFO - ##### 08:32:13 INFO - ##### Running populate-webroot step. 08:32:13 INFO - ##### 08:32:13 INFO - Running pre-action listener: _resource_record_pre_action 08:32:13 INFO - Running main action method: populate_webroot 08:32:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:13 INFO - '--tppagecycles', 08:32:13 INFO - '7'], 08:32:13 INFO - 'tests': ['tsvgm']}}, 08:32:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:32:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:32:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:32:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:32:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:32:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:13 INFO - 'talos_options': ['--disable-e10s'], 08:32:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:13 INFO - 'talos_options': ['--disable-e10s'], 08:32:13 INFO - 'tests': ['damp', 'tps']}, 08:32:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:13 INFO - 'tests': ['damp', 'tps']}, 08:32:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:32:13 INFO - 'tests': ['dromaeo_dom']}, 08:32:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:32:13 INFO - 'tests': ['a11yr', 08:32:13 INFO - 'ts_paint', 08:32:13 INFO - 'tpaint', 08:32:13 INFO - 'sessionrestore', 08:32:13 INFO - 'sessionrestore_no_auto_restore', 08:32:13 INFO - 'tabpaint']}, 08:32:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:32:13 INFO - 'ts_paint', 08:32:13 INFO - 'tpaint', 08:32:13 INFO - 'sessionrestore', 08:32:13 INFO - 'sessionrestore_no_auto_restore', 08:32:13 INFO - 'tabpaint']}, 08:32:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:32:13 INFO - 'ts_paint', 08:32:13 INFO - 'tpaint', 08:32:13 INFO - 'sessionrestore', 08:32:13 INFO - 'sessionrestore_no_auto_restore', 08:32:13 INFO - 'tabpaint']}, 08:32:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:32:13 INFO - 'ts_paint', 08:32:13 INFO - 'tpaint', 08:32:13 INFO - 'sessionrestore', 08:32:13 INFO - 'sessionrestore_no_auto_restore', 08:32:13 INFO - 'tabpaint']}, 08:32:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:32:13 INFO - 'tests': ['a11yr', 08:32:13 INFO - 'ts_paint', 08:32:13 INFO - 'tpaint', 08:32:13 INFO - 'sessionrestore', 08:32:13 INFO - 'sessionrestore_no_auto_restore', 08:32:13 INFO - 'tabpaint']}, 08:32:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:32:13 INFO - 'tests': ['a11yr', 08:32:13 INFO - 'ts_paint', 08:32:13 INFO - 'tpaint', 08:32:13 INFO - 'sessionrestore', 08:32:13 INFO - 'sessionrestore_no_auto_restore', 08:32:13 INFO - 'tabpaint']}, 08:32:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:32:13 INFO - 'tests': ['tsvgx', 08:32:13 INFO - 'tsvgr_opacity', 08:32:13 INFO - 'tart', 08:32:13 INFO - 'tscrollx', 08:32:13 INFO - 'cart']}, 08:32:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:32:13 INFO - 'tsvgr_opacity', 08:32:13 INFO - 'tart', 08:32:13 INFO - 'tscrollx', 08:32:13 INFO - 'cart']}, 08:32:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:13 INFO - 'talos_options': ['--disable-e10s'], 08:32:13 INFO - 'tests': ['tp5o']}, 08:32:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:13 INFO - 'tests': ['tp5o']}, 08:32:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:13 INFO - 'talos_options': ['--disable-e10s', 08:32:13 INFO - '--xperf_path', 08:32:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:13 INFO - 'tests': ['tp5n']}, 08:32:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:13 INFO - 'talos_options': ['--xperf_path', 08:32:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:13 INFO - 'tests': ['tp5n']}}, 08:32:13 INFO - 'talos.zip': {'path': '', 08:32:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:13 INFO - Running post-action listener: _resource_record_post_action 08:32:13 INFO - ##### 08:32:13 INFO - ##### Running create-virtualenv step. 08:32:13 INFO - ##### 08:32:13 INFO - Running pre-action listener: _resource_record_pre_action 08:32:13 INFO - Running main action method: create_virtualenv 08:32:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:13 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 08:32:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:14 INFO - Using real prefix '/tools/python27' 08:32:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:14 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:17 INFO - Installing pip.................done. 08:32:17 INFO - Return code: 0 08:32:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103821a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103831420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90855e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c0e00>, '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 0x103529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036bbb20>, '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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eBJ6u9bkHO/Render', 08:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:18 INFO - 'HOME': '/Users/cltbld', 08:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:18 INFO - 'LOGNAME': 'cltbld', 08:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:18 INFO - 'MOZ_NO_REMOTE': '1', 08:32:18 INFO - 'NO_EM_RESTART': '1', 08:32:18 INFO - 'PAGER': '/bin/cat', 08:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:18 INFO - 'PWD': '/builds/slave/test', 08:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:18 INFO - 'SHELL': '/bin/bash', 08:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.06qVu1TYfI/Listeners', 08:32:18 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:18 INFO - 'USER': 'cltbld', 08:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:18 INFO - 'XPC_FLAGS': '0x0', 08:32:18 INFO - 'XPC_SERVICE_NAME': '0', 08:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:18 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 08:32:18 INFO - Cleaning up... 08:32:18 INFO - Return code: 0 08:32:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103821a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103831420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90855e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c0e00>, '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 0x103529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036bbb20>, '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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eBJ6u9bkHO/Render', 08:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:18 INFO - 'HOME': '/Users/cltbld', 08:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:18 INFO - 'LOGNAME': 'cltbld', 08:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:18 INFO - 'MOZ_NO_REMOTE': '1', 08:32:18 INFO - 'NO_EM_RESTART': '1', 08:32:18 INFO - 'PAGER': '/bin/cat', 08:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:18 INFO - 'PWD': '/builds/slave/test', 08:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:18 INFO - 'SHELL': '/bin/bash', 08:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.06qVu1TYfI/Listeners', 08:32:18 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:18 INFO - 'USER': 'cltbld', 08:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:18 INFO - 'XPC_FLAGS': '0x0', 08:32:18 INFO - 'XPC_SERVICE_NAME': '0', 08:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:18 INFO - Downloading/unpacking psutil>=0.7.1 08:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:21 INFO - Installing collected packages: psutil 08:32:21 INFO - Running setup.py install for psutil 08:32:21 INFO - building 'psutil._psutil_osx' extension 08:32:21 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 08:32:22 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 08:32:22 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 08:32:22 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 08:32:22 INFO - building 'psutil._psutil_posix' extension 08:32:22 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 08:32:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:32:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:32:22 INFO - ^ 08:32:22 INFO - 1 warning generated. 08:32:22 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 08:32:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:22 INFO - Successfully installed psutil 08:32:22 INFO - Cleaning up... 08:32:22 INFO - Return code: 0 08:32:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:22 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 0x103821a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103831420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90855e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c0e00>, '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 0x103529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036bbb20>, '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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:32:22 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 08:32:22 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 08:32:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eBJ6u9bkHO/Render', 08:32:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:22 INFO - 'HOME': '/Users/cltbld', 08:32:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:22 INFO - 'LOGNAME': 'cltbld', 08:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:22 INFO - 'MOZ_NO_REMOTE': '1', 08:32:22 INFO - 'NO_EM_RESTART': '1', 08:32:22 INFO - 'PAGER': '/bin/cat', 08:32:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:22 INFO - 'PWD': '/builds/slave/test', 08:32:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:22 INFO - 'SHELL': '/bin/bash', 08:32:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.06qVu1TYfI/Listeners', 08:32:22 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:32:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:22 INFO - 'USER': 'cltbld', 08:32:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:22 INFO - 'XPC_FLAGS': '0x0', 08:32:22 INFO - 'XPC_SERVICE_NAME': '0', 08:32:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:32:25 INFO - Installing collected packages: mozsystemmonitor 08:32:25 INFO - Running setup.py install for mozsystemmonitor 08:32:25 INFO - Successfully installed mozsystemmonitor 08:32:25 INFO - Cleaning up... 08:32:25 INFO - Return code: 0 08:32:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:32:25 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')]} 08:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:25 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')]} 08:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:25 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 0x103821a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103831420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90855e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c0e00>, '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 0x103529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036bbb20>, '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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:32:25 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 08:32:25 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 08:32:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eBJ6u9bkHO/Render', 08:32:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:25 INFO - 'HOME': '/Users/cltbld', 08:32:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:25 INFO - 'LOGNAME': 'cltbld', 08:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:25 INFO - 'MOZ_NO_REMOTE': '1', 08:32:25 INFO - 'NO_EM_RESTART': '1', 08:32:25 INFO - 'PAGER': '/bin/cat', 08:32:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:25 INFO - 'PWD': '/builds/slave/test', 08:32:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:25 INFO - 'SHELL': '/bin/bash', 08:32:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.06qVu1TYfI/Listeners', 08:32:25 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:32:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:25 INFO - 'USER': 'cltbld', 08:32:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:25 INFO - 'XPC_FLAGS': '0x0', 08:32:25 INFO - 'XPC_SERVICE_NAME': '0', 08:32:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:32:26 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 08:32:26 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 08:32:26 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 08:32:26 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 08:32:26 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 08:32:26 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 08:32:28 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32:28 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 08:32:28 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 08:32:28 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 08:32:28 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 08:32:28 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 08:32:28 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 08:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:32:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:29 INFO - Downloading docopt-0.6.1.tar.gz 08:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:29 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:29 INFO - Running setup.py install for blobuploader 08:32:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:32:29 INFO - Running setup.py install for requests 08:32:30 INFO - Running setup.py install for docopt 08:32:30 INFO - Successfully installed blobuploader requests docopt 08:32:30 INFO - Cleaning up... 08:32:30 INFO - Return code: 0 08:32:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:30 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')]} 08:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:30 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')]} 08:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:30 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 0x103821a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103831420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90855e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c0e00>, '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 0x103529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036bbb20>, '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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:32:30 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 08:32:30 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 08:32:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eBJ6u9bkHO/Render', 08:32:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:30 INFO - 'HOME': '/Users/cltbld', 08:32:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:30 INFO - 'LOGNAME': 'cltbld', 08:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:30 INFO - 'MOZ_NO_REMOTE': '1', 08:32:30 INFO - 'NO_EM_RESTART': '1', 08:32:30 INFO - 'PAGER': '/bin/cat', 08:32:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:30 INFO - 'PWD': '/builds/slave/test', 08:32:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:30 INFO - 'SHELL': '/bin/bash', 08:32:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.06qVu1TYfI/Listeners', 08:32:30 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:32:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:30 INFO - 'USER': 'cltbld', 08:32:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:30 INFO - 'XPC_FLAGS': '0x0', 08:32:30 INFO - 'XPC_SERVICE_NAME': '0', 08:32:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:30 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-F5GfiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:31 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-fcILV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:31 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-lo7w23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:31 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Trki3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:31 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-qdw8ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:31 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-l8YWiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:31 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-fvGROJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:31 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-YS2ShG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:31 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-oE8qNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:31 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-vxjYet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:32 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-MyzpDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:32 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-HTzogc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:32 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-VCTFTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:32 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-AipdDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:32 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-l9oBYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:32 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-VDEoq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:32 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-HYqXsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:32:32 INFO - Running setup.py install for manifestparser 08:32:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:32:32 INFO - Running setup.py install for mozcrash 08:32:33 INFO - Running setup.py install for mozdebug 08:32:33 INFO - Running setup.py install for mozdevice 08:32:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:32:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:32:33 INFO - Running setup.py install for mozfile 08:32:33 INFO - Running setup.py install for mozhttpd 08:32:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:32:33 INFO - Running setup.py install for mozinfo 08:32:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:32:33 INFO - Running setup.py install for mozInstall 08:32:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:32:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:32:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:32:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:32:33 INFO - Running setup.py install for mozleak 08:32:34 INFO - Running setup.py install for mozlog 08:32:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:32:34 INFO - Running setup.py install for moznetwork 08:32:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:32:34 INFO - Running setup.py install for mozprocess 08:32:34 INFO - Running setup.py install for mozprofile 08:32:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:32:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:32:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:32:34 INFO - Running setup.py install for mozrunner 08:32:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:32:34 INFO - Running setup.py install for mozscreenshot 08:32:35 INFO - Running setup.py install for moztest 08:32:35 INFO - Running setup.py install for mozversion 08:32:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:32:35 INFO - Cleaning up... 08:32:35 INFO - Return code: 0 08:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:35 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 0x103821a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103831420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90855e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c0e00>, '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 0x103529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036bbb20>, '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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:32:35 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 08:32:35 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 08:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eBJ6u9bkHO/Render', 08:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:35 INFO - 'HOME': '/Users/cltbld', 08:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:35 INFO - 'LOGNAME': 'cltbld', 08:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:35 INFO - 'MOZ_NO_REMOTE': '1', 08:32:35 INFO - 'NO_EM_RESTART': '1', 08:32:35 INFO - 'PAGER': '/bin/cat', 08:32:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:35 INFO - 'PWD': '/builds/slave/test', 08:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:35 INFO - 'SHELL': '/bin/bash', 08:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.06qVu1TYfI/Listeners', 08:32:35 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:35 INFO - 'USER': 'cltbld', 08:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:35 INFO - 'XPC_FLAGS': '0x0', 08:32:35 INFO - 'XPC_SERVICE_NAME': '0', 08:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:35 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-1ebN74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:35 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)) 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:35 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-balPkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:35 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)) 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:35 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-pYgtbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:35 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)) 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:35 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-cpLLxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:36 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)) 08:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:36 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-qwMaUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:36 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)) 08:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:36 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-MGjR61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:36 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)) 08:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:36 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-_n9nD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:36 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)) 08:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:36 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-CAunI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:36 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)) 08:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:36 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-7p4g_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:36 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)) 08:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:36 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-yLiTpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:36 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)) 08:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:36 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-gmnfIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:36 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)) 08:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:36 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-AgAUNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:36 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)) 08:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:36 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-s8zZvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:37 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)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:37 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-J9OIAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:37 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)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:37 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-4JIXw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:37 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)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:37 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-UFAOuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:37 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)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:37 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-c8_rI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:37 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)) 08:32:37 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)) 08:32:37 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)) 08:32:37 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)) 08:32:37 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)) 08:32:37 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)) 08:32:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:39 INFO - Downloading blessings-1.6.tar.gz 08:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:32:39 INFO - Installing collected packages: blessings 08:32:39 INFO - Running setup.py install for blessings 08:32:40 INFO - Successfully installed blessings 08:32:40 INFO - Cleaning up... 08:32:40 INFO - Return code: 0 08:32:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:40 INFO - Reading from file tmpfile_stdout 08:32:40 INFO - Current package versions: 08:32:40 INFO - blessings == 1.6 08:32:40 INFO - blobuploader == 1.2.4 08:32:40 INFO - docopt == 0.6.1 08:32:40 INFO - manifestparser == 1.1 08:32:40 INFO - mozInstall == 1.12 08:32:40 INFO - mozcrash == 0.17 08:32:40 INFO - mozdebug == 0.1 08:32:40 INFO - mozdevice == 0.48 08:32:40 INFO - mozfile == 1.2 08:32:40 INFO - mozhttpd == 0.7 08:32:40 INFO - mozinfo == 0.9 08:32:40 INFO - mozleak == 0.1 08:32:40 INFO - mozlog == 3.1 08:32:40 INFO - moznetwork == 0.27 08:32:40 INFO - mozprocess == 0.22 08:32:40 INFO - mozprofile == 0.28 08:32:40 INFO - mozrunner == 6.11 08:32:40 INFO - mozscreenshot == 0.1 08:32:40 INFO - mozsystemmonitor == 0.0 08:32:40 INFO - moztest == 0.7 08:32:40 INFO - mozversion == 1.4 08:32:40 INFO - psutil == 3.1.1 08:32:40 INFO - requests == 1.2.3 08:32:40 INFO - wsgiref == 0.1.2 08:32:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:40 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')]} 08:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:40 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')]} 08:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:40 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 0x103821a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103831420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90855e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c0e00>, '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 0x103529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036bbb20>, '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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:32:40 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 08:32:40 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 08:32:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eBJ6u9bkHO/Render', 08:32:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:40 INFO - 'HOME': '/Users/cltbld', 08:32:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:40 INFO - 'LOGNAME': 'cltbld', 08:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:40 INFO - 'MOZ_NO_REMOTE': '1', 08:32:40 INFO - 'NO_EM_RESTART': '1', 08:32:40 INFO - 'PAGER': '/bin/cat', 08:32:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:40 INFO - 'PWD': '/builds/slave/test', 08:32:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:40 INFO - 'SHELL': '/bin/bash', 08:32:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.06qVu1TYfI/Listeners', 08:32:40 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:32:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:40 INFO - 'USER': 'cltbld', 08:32:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:40 INFO - 'XPC_FLAGS': '0x0', 08:32:40 INFO - 'XPC_SERVICE_NAME': '0', 08:32:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:40 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)) 08:32:40 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)) 08:32:40 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)) 08:32:40 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)) 08:32:40 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)) 08:32:40 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)) 08:32:40 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)) 08:32:40 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)) 08:32:40 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)) 08:32:40 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)) 08:32:40 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)) 08:32:40 INFO - Cleaning up... 08:32:40 INFO - Return code: 0 08:32:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:32:40 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')]} 08:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:40 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')]} 08:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:40 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 0x103821a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103831420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90855e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c0e00>, '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 0x103529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036bbb20>, '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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:32:40 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 08:32:40 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 08:32:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eBJ6u9bkHO/Render', 08:32:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:40 INFO - 'HOME': '/Users/cltbld', 08:32:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:40 INFO - 'LOGNAME': 'cltbld', 08:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:40 INFO - 'MOZ_NO_REMOTE': '1', 08:32:40 INFO - 'NO_EM_RESTART': '1', 08:32:40 INFO - 'PAGER': '/bin/cat', 08:32:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:40 INFO - 'PWD': '/builds/slave/test', 08:32:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:40 INFO - 'SHELL': '/bin/bash', 08:32:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.06qVu1TYfI/Listeners', 08:32:40 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:32:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:40 INFO - 'USER': 'cltbld', 08:32:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:40 INFO - 'XPC_FLAGS': '0x0', 08:32:40 INFO - 'XPC_SERVICE_NAME': '0', 08:32:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:41 INFO - Downloading/unpacking jsonschema 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:41 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 08:32:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:32:43 INFO - Downloading/unpacking functools32 (from jsonschema) 08:32:43 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 08:32:43 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 08:32:43 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 08:32:43 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 08:32:43 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 08:32:43 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 08:32:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:32:43 INFO - warning: no files found matching '*.txt' 08:32:43 INFO - no previously-included directories found matching 'build' 08:32:43 INFO - no previously-included directories found matching 'dist' 08:32:43 INFO - no previously-included directories found matching '.git*' 08:32:43 INFO - Installing collected packages: jsonschema, functools32 08:32:44 INFO - Running setup.py install for functools32 08:32:44 INFO - warning: no files found matching '*.txt' 08:32:44 INFO - no previously-included directories found matching 'build' 08:32:44 INFO - no previously-included directories found matching 'dist' 08:32:44 INFO - no previously-included directories found matching '.git*' 08:32:44 INFO - Successfully installed jsonschema functools32 08:32:44 INFO - Cleaning up... 08:32:44 INFO - Return code: 0 08:32:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:44 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 0x103821a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103831420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc90855e790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c0e00>, '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 0x103529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036bbb20>, '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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 08:32:44 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 08:32:44 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 08:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eBJ6u9bkHO/Render', 08:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:44 INFO - 'HOME': '/Users/cltbld', 08:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:44 INFO - 'LOGNAME': 'cltbld', 08:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:44 INFO - 'MOZ_NO_REMOTE': '1', 08:32:44 INFO - 'NO_EM_RESTART': '1', 08:32:44 INFO - 'PAGER': '/bin/cat', 08:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:44 INFO - 'PWD': '/builds/slave/test', 08:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:44 INFO - 'SHELL': '/bin/bash', 08:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.06qVu1TYfI/Listeners', 08:32:44 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:44 INFO - 'USER': 'cltbld', 08:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:44 INFO - 'XPC_FLAGS': '0x0', 08:32:44 INFO - 'XPC_SERVICE_NAME': '0', 08:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:44 INFO - Downloading/unpacking flake8 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:44 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 08:32:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:32:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:32:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:32:47 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 08:32:47 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 08:32:47 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 08:32:47 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 08:32:47 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 08:32:47 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 08:32:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:32:47 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 08:32:47 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 08:32:47 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 08:32:47 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 08:32:47 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 08:32:47 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 08:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:32:48 INFO - no previously-included directories found matching 'docs/_build' 08:32:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:32:48 INFO - Running setup.py install for pep8 08:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:32:48 INFO - no previously-included directories found matching 'docs/_build' 08:32:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:32:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:32:48 INFO - Cleaning up... 08:32:48 INFO - Return code: 0 08:32:48 INFO - Running post-action listener: _resource_record_post_action 08:32:48 INFO - Running post-action listener: _start_resource_monitoring 08:32:48 INFO - Starting resource monitoring. 08:32:48 INFO - ##### 08:32:48 INFO - ##### Running install step. 08:32:48 INFO - ##### 08:32:48 INFO - Running pre-action listener: _resource_record_pre_action 08:32:48 INFO - Running main action method: install 08:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:48 INFO - Reading from file tmpfile_stdout 08:32:48 INFO - Detecting whether we're running mozinstall >=1.0... 08:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:32:48 INFO - Reading from file tmpfile_stdout 08:32:48 INFO - Output received: 08:32:48 INFO - Usage: mozinstall [options] installer 08:32:48 INFO - Options: 08:32:48 INFO - -h, --help show this help message and exit 08:32:48 INFO - -d DEST, --destination=DEST 08:32:48 INFO - Directory to install application into. [default: 08:32:48 INFO - "/builds/slave/test"] 08:32:48 INFO - --app=APP Application being installed. [default: firefox] 08:32:48 INFO - mkdir: /builds/slave/test/build/application 08:32:48 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'] 08:32:48 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 08:33:21 INFO - Reading from file tmpfile_stdout 08:33:21 INFO - Output received: 08:33:21 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:33:21 INFO - Running post-action listener: _resource_record_post_action 08:33:21 INFO - ##### 08:33:21 INFO - ##### Running run-tests step. 08:33:21 INFO - ##### 08:33:21 INFO - Running pre-action listener: _resource_record_pre_action 08:33:21 INFO - Running main action method: run_tests 08:33:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:33:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:33:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:33:21 INFO - 2016-05-24 08:33:21.356 screenresolution[1645:7724] starting screenresolution argv=screenresolution get 08:33:21 INFO - 2016-05-24 08:33:21.358 screenresolution[1645:7724] Display 0: 1600x1200x32@60 08:33:21 INFO - 2016-05-24 08:33:21.364 screenresolution[1646:7726] starting screenresolution argv=screenresolution list 08:33:21 INFO - Available Modes on Display 0 08:33:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:33:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:33:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:33:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:33:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:33:21 INFO - Intel Iris: 08:33:21 INFO - Chipset Model: Intel Iris 08:33:21 INFO - Type: GPU 08:33:21 INFO - Bus: Built-In 08:33:21 INFO - VRAM (Dynamic, Max): 1536 MB 08:33:21 INFO - Vendor: Intel (0x8086) 08:33:21 INFO - Device ID: 0x0a2e 08:33:21 INFO - Revision ID: 0x0009 08:33:21 INFO - Displays: 08:33:21 INFO - Display: 08:33:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:33:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:33:21 INFO - Display Serial Number: 1600x1200 60 08:33:21 INFO - Main Display: Yes 08:33:21 INFO - Mirror: Off 08:33:21 INFO - Online: Yes 08:33:21 INFO - Rotation: Supported 08:33:21 INFO - Return code: 0 08:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:21 INFO - Python 2.7.3 08:33:21 INFO - Return code: 0 08:33:21 INFO - grabbing minidump binary from tooltool 08:33:21 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')]} 08:33:21 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 0x1036c0e00>, '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 0x103529db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036bbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33:21 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 08:33:21 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 08:33:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:21 INFO - Return code: 0 08:33:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:33:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:33:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:33:22 INFO - Return code: 0 08:33:22 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/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 08:33:22 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/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0120 --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 08:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eBJ6u9bkHO/Render', 08:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:22 INFO - 'HOME': '/Users/cltbld', 08:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:22 INFO - 'LOGNAME': 'cltbld', 08:33:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:22 INFO - 'MOZ_NO_REMOTE': '1', 08:33:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:22 INFO - 'NO_EM_RESTART': '1', 08:33:22 INFO - 'PAGER': '/bin/cat', 08:33:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:22 INFO - 'PWD': '/builds/slave/test', 08:33:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:22 INFO - 'SHELL': '/bin/bash', 08:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.06qVu1TYfI/Listeners', 08:33:22 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 08:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:22 INFO - 'USER': 'cltbld', 08:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:22 INFO - 'XPC_FLAGS': '0x0', 08:33:22 INFO - 'XPC_SERVICE_NAME': '0', 08:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:22 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/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 08:33:23 INFO - mozversion application_buildid: 20160524070908 08:33:23 INFO - mozversion application_changeset: 9fe9c798d44ff40eb793feb857602cce7dff16e8 08:33:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:33:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:23 INFO - mozversion application_name: Firefox 08:33:23 INFO - mozversion application_remotingname: firefox-dev 08:33:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:33:23 INFO - mozversion application_vendor: Mozilla 08:33:23 INFO - mozversion application_version: 48.0a2 08:33:23 INFO - mozversion platform_buildid: 20160524070908 08:33:23 INFO - mozversion platform_changeset: 9fe9c798d44ff40eb793feb857602cce7dff16e8 08:33:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:33:23 INFO - mozversion platform_version: 48.0a2 08:33:23 INFO - using testdate: 1464104003 08:33:23 INFO - actual date: 1464104003 08:33:23 INFO - starting webserver on 'localhost:49270' 08:33:23 INFO - SUITE-START | Running 2 tests 08:33:23 INFO - TEST-START | dromaeo_css 08:33:23 INFO - operating with platform_type : mac_ 08:33:23 INFO - Initialising browser for dromaeo_css test... 08:33:23 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmp8kf3CX/profile http://localhost:49270/getInfo.html) 08:33:25 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 08:33:25 INFO - PROCESS | 1664 | colorDepth:24 08:33:25 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 08:33:25 INFO - PROCESS | 1664 | __metrics 08:33:25 INFO - PROCESS | 1664 | 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" 08:33:25 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:33:25 INFO - TEST-INFO | 1664: exit 0 08:33:25 INFO - Browser initialized. 08:33:25 INFO - Running cycle 1/1 for dromaeo_css test... 08:33:25 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmp8kf3CX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:37 INFO - PROCESS | 1666 | RSS: Main: 210771968 08:33:37 INFO - PROCESS | 1666 | 08:34:29 INFO - PROCESS | 1666 | 1464104069159 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] 08:36:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 08:36:41 INFO - PROCESS | 1666 | RSS: Main: 454254592 08:36:41 INFO - PROCESS | 1666 | 08:39:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 08:39:45 INFO - PROCESS | 1666 | RSS: Main: 359849984 08:39:45 INFO - PROCESS | 1666 | 08:42:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 08:42:47 INFO - PROCESS | 1666 | RSS: Main: 359464960 08:42:47 INFO - PROCESS | 1666 | 08:45:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 08:45:50 INFO - PROCESS | 1666 | RSS: Main: 358330368 08:45:50 INFO - PROCESS | 1666 | 08:48:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 08:48:54 INFO - PROCESS | 1666 | RSS: Main: 323993600 08:48:54 INFO - PROCESS | 1666 | 08:51:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 08:51:57 INFO - PROCESS | 1666 | RSS: Main: 367448064 08:51:57 INFO - PROCESS | 1666 | 08:51:57 INFO - PROCESS | 1666 | __start_tp_report 08:51:57 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 08:51:57 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 08:51:57 INFO - PROCESS | 1666 | |i|pagename|runs| 08:51:57 INFO - PROCESS | 1666 | |0;dojo.html;2595.7534034266737;3344.2976974835283;3409.6872704008965;3429.6227414984346;3464.774789638673;5578.497935185833;5580.665160090397;5597.692126933017;5601.887962240753;5603.579731520137;4652.737666062504;5556.249906262653;5612.831615051555;5625.324961004675;5667.206591077253;4981.402231732197;5040.991801639678;5111.565516931066;5120.846374608767;5164.664296820713;4430.003249268921;4998.475160108191;5163.974180129094;5181.6113791465605;5184.974075129619;5077.086124497589;5117;5134.948650513485;5147.459516750725;5154.458781827911;5098.133317336062;5101.132807422747;5111.097873354375;5118.155504341779;5152.098382782998;4975.875603109915;4990.90018199634;5064.721440320781;5073.746312684351;5083.161278389061;5397.892042159174;5457.945420545823;5481.725913704299;5483.424240454735;5499.697516636584;6125.5712100153005;6136.9079463808075;6137.41694539018;6144.078388241799;6167.722452489604;4447.5552444755585;6027.427394397525;6122.062734707318;6230;6238.9376106238815;4768.3085952536685;5716.428357164292;5738.368779434259;5738.426157384228;5770.567207459458;6300.27546832111;6355.777547785898;6365.140706004723;6380.712867920862;6385.329540398191;5875.706214689249;5998.400159984054;6014.548908831767;6015.30823955242;6058.1215723719815;5623.662580245198;5839.357670656224;6185.350538193515;6210.627362358273;6221.253449586078;6155.415235552616;6159.076138579249;6167.753289868445;6169.290531588835;6170.321264660884;6033;6102.603330783485;6134.631922084689;6173.197484327009;6183;4800.543948324904;4824.469308376076;4835.44392394872;4838.03239352131;4840.806367745251;4364.279893817548;4397.956020439755;4399.868003959887;4418.138462999685;4431.977840110779;5647.435256474319;5667.036603777367;5677.943220567741;5681.403452637496;5690.146478028246;6195.349488303754;6219;6236.532260080421;6237.688115594202;6247;5450.345958485007;5541.418151094158;5591.6365436246515;5627;5664.0937450007805;5269.736513174326;5276.604254680914;5281.524662780368;5289.444608316148;5298.496642818926;6244.12582238487;6296.338884417162;6307.684615769193;6309.369063093745;6373.426391624776;6065.696715164312;6119.624418755179;6129.572745043327;6182.9798083315745;6223.097650840693;6305.432511074026;6333.619982801047;6361.586496877688;6366.77716279928;6368.554201206057;5975.492083172805;5982.102684597346;5986.521078313637;5996.340402555628;6004.639721616717;6043.274807023009;6084.330723620486;6116.847078823065;6126.846828829315;6149.72326245329;5909.143174239797;5933.881322373615;5939.554533409925;5940.613860099253;5947.018741907536;5929.733162007807;5930.080837470199;5936.762529498772;5951.7024148791525;5955.612885162624;4740.739259340769;5610.831675049755;5784.971075144766;5788.131780232999;5794.855128621818;5914.585978981602;5937.643741375531;5975.043992961106;5989.7304621293015;6048.213732214784;5862.296524417097;5869.943410186207;5885.558583106199;5900.203472531153;5930.52555795544 08:51:57 INFO - PROCESS | 1666 | |1;ext.html;508.2757071173578;535.4645354645355;573.4466240078325;574.7729646789518;614.2046050364777;24233;28686.856565717193;31297.843510782444;31454.685453145463;37526.81236593813;41076;41296;41493;41557.96105097374;41699.58300416995;9311.720648380526;9529;9541.379810312343;9579.425234485952;9605.711828645151;8425.789355266137;8671;9379.671711490098;9529.857052144223;11655.417229138551;11332.943335283311;11423.428828558539;11430.771384572303;11437.74184839667;11463.140264480156;8431.536265505394;11275.154363422735;11343.546258149665;11348.978591926683;11361.829572556418;11415.942920285428;11619.954204121585;11640.476178571984;11642.01042911345;11662.008729258023;38266.808665956494;38679;38770.41844372336;38789.836304910896;38805.02987425337;3234.0459564428315;3236.64396916339;3538.929221415583;3566.233259849119;3828.9808550957346;22633.660495092587;27888.884444622192;28224.717752822413;28248.293792655142;28293.57559636607;2703.648525691667;2723.7820974322203;2780.2215379693716;2823.463541927048;2861.756750676195;446841;448204;449900.7504962454;450161;451150;35291.470627940085;35944.820275898455;35982.640173598455;59463;59862.70068649629;34910.82544587312;35207.295854083284;35289.47065794015;35292;35301.82349088238;14813.851861481462;14863.851361486462;14882.925585372004;14892.329845156994;14905.329260183318;11738.471768770425;11916.16586838913;12614.243145411305;12672.80990785139;12694.365281735876;8045.477043992122;8100.432969692065;8100.918990810134;8178.877316840252;8200.179982001751;2981.6869228731107;3407.16524451511;3451.376953515296;3454.4818277258614;3478.2347883465595;998.6604554451376;1010.3533738407425;1023.8976102389702;1039.9948000259951;1148.7070796946725;29196.854015729787;29427.852860735988;29677.703222967495;30331.393372132432;30398;1080.4927126658424;1140.7433327501246;1204.4278967490372;1208;1250.9437075331632;12981.610551683465;15009.399624014917;15153.696926061417;15381.9230903847;15474.613134671723;623608;628357;636821;638519;640085;58610.706946465;59233.40766592365;59313;59377.81244375088;59622.70188649116;1327.183781974079;1369.7260547890462;1471.8160229971254;1513.2585033333587;1569.968600627981;28669.28326791847;28816.135515934555;29808.85095574508;30029.5495567571;30258.697413025588;47949.760251199914;48059.75970120127;48478.5152148474;48519.272210917574;48617.75691121522;422731;425646;425855;426175;426257;26516.867415662797;26529.07148249802;26548.67256637119;26983.46033079288;27013.86493067522;45089.32366014578;45863;46084.07831843411;46576.30135548037;46909;36520;37717.4342384859;37763.81118094392;38568;38783.806080969414;36852.81573592115;37068.629313706515;37209;37857.05357366088;38006;36771.26457470782;37457.81271093736;37964.2407151861;38130.61869381271;38169.80915095407;31880.278500793538;32551.83724081459;33898.661013390534;33940;34025.48961765526;22447;24810.50378992446;24836.25491235266;25142.371440714127;25207.36981575475 08:51:57 INFO - PROCESS | 1666 | |2;jquery.html;392.36436972105184;401.98593049243283;403.8687426586358;406.1308799169779;414.7946766350657;17750.911245443785;20122.893240871745;20691.96540172991;20827.895860520694;21071.68392474114;19343;19832.70250946237;19858.304959326426;20667;20971.47571310718;5945.643261404308;5985;6108.877822443548;6151.846203844895;6209.844753881144;5133.794648214086;6110.236220472441;6138.877222455548;6142.262928448592;6159.907601385983;6011.669358185298;6062.333143354227;6105.084237364409;6115.7247923843315;6125.724342404603;6099.207103076616;6115.113308570277;6128.387161283836;6129.356417576158;6137.048757442603;5220.817271395483;5291.074062039128;5574.916376254359;5851.795187168471;5874.618149820248;13382.13016153947;13533.661658458519;13619.795703064461;13707.794383084261;24737.752622473727;2075.5848830233863;2108.1988844239245;2254.120892851789;2454.2023842251338;2876.3096856754437;9706.805863882682;9790.755231119208;9802.313838031341;9972.401655900669;10158.542865571068;1735.1757914990405;1751.0719318761078;1751.7109676903297;1762.330314480502;1789.7673302470726;103681.48159259156;108964.45517772439;114253;117134.41432792782;119182;11851.585194518151;11867.76264474723;11954.940225298991;11965.820512692317;11997.100942193822;15270.541883743506;15343.07941523512;15345.923270383577;15356.692866142615;15358.692826143639;8569.528675922884;8722.258608018263;8740.169683880022;8794.516301603473;8836;7259.201487836333;8615.39692221551;8667.653293868301;8701.260392866678;8744.125587441333;3766.5668448128818;4665.766711664471;4671.7430541320555;4675.4155730533685;4737.099951009297;1845.298786461163;1849.5098798818324;1851.5741379482795;1973.4375702924597;1978.5053736565858;926.6525053105086;952.0431965874391;988.8071825994006;993.8111758765812;999.2455695949511;19793.901030495043;20211.8989405052;20308.593828123354;20384.89807550953;20484.897575512026;877.8675508593842;958.1376760915232;986.1124987511297;986.8569057486768;1021.5352014833232;10640.893591064145;10829.458527073615;10848.837267440837;10879.782404351869;10903.945480272549;601415;610087.9495602493;625518;625701;627877;81131;111260;114172;119017.46670331697;124567;928.2481190235931;929.5445231836487;957.9521023948774;984.4880662055691;985.3841349156634;17530.649387012443;17596.38412655551;17824.91087544554;17839.554011149306;18197.272109116017;50494.7376315595;50496;50773.238401424744;52889.735551321995;53498.732506338776;76255;76882.6155869217;77639;77988;78308;8122.634481448467;8165.836683266182;8240.299574536231;8294.212049855254;8560.957195213985;11830.822537662114;11870.643880683594;12622.55821046259;12771.36143192818;12929.353532323534;11179;11230.887691122984;11439.428028598702;11500.827487587525;11579.305241685526;11105.722356941142;11155.94422027917;11321.71695707614;11424.543018279175;11499.827502587636;11075.169362298022;11562.710932226426;11706.824397633873;11923.82114268304;11940.522379105087;8403.117672644285;8482.745517634481;8532.104129066358;8586.356023298402;8843.60203790818;11198.888011119785;11558.479868405773;11777.057835373322;11845.052395808143;11857.288562686266 08:51:57 INFO - PROCESS | 1666 | |3;mootools.html;1376.8623137686227;1579.7235483790337;1600.263878615837;1772.335374234662;1850.574367895384;7516.924830751697;7788.337991270741;8567.35744819138;8573.185547373005;8575.65697372106;8282.544460054694;8357.665693372273;8427.789305267372;8442.746717598482;8443.11347308533;2130.1585873579925;2192.4299682082615;2398.628212627041;2419.4677171022345;2420.9031638734427;2378.5956387414094;2445.4375493636476;2448.09420514409;2449.963250551243;2450.1546966296687;2377.09670325277;2398.5442765874513;2399.328188107324;2404.5431368040104;2436.5979613363775;2033;2123.7770034146347;2344.9882750586307;2409.33743220614;2412.5416170927556;2381.0951838301507;2418.661387405765;2419.8669073200967;2421.3099266708905;2425.92722218332;8496.192861678132;8576.871346929802;8582.442141260799;8586.356023298278;8610.913890861137;4633.351330813689;5206.895862082775;5282.603804714623;5338.91991620126;5376.1398176292;2847.4732174547776;3454.9827250863586;3548.449990251515;3549.5208146900095;3552.0587044433246;1020.9183265338755;1021.4637315409395;1024.4109636958704;1051.1013083813382;1073.002108039523;11749.706257343549;11776.175667703264;11807.704807379885;11812.468438920268;11824.11319151067;4607.815687372535;4675.4155730533685;4804.8318308859725;4807.6394270429855;4830.347903033045;10083.949580252052;10097.949510252402;10121.544530496145;10121.59513619447;10130.341527800669;5398.514133727984;5403.864903377447;5406.810761623325;5438.401775804658;5444.020076386209;4354.521002689701;4509.188346097734;4720.33915251865;4970.080535101018;4971;3992.2215168042535;3993.9600603994168;4028.0332720146953;4047.1905618876344;4100.671946244293;1150.3385553306882;1326.085001349066;1336.5188532128425;1338.1569611144917;1356.1998420931698;917.9678711245074;921.709661456639;925.5279807298326;935.9064093590723;964.6141543382563;4582.877195087159;5767.596268261182;5828;5845.707714614252;6008.309044459856;420.4912056411715;423.733048179651;473.97867095980763;477.11971412743435;484.9127157111754;3745.7377983541437;3797.8290976906105;3844.3464611016193;3909.8240579174008;3912.1002169501176;10296.918823523572;10815.675529733962;10844.837327440095;10865.239433239756;10872.728181795519;10454.68635940923;10500.527476263587;10575.788484230272;10581.894181058246;10595.311304765166;7853.921460785434;8196.42625016255;8205.71280005197;8256.926599542021;8295.62669679866;5491.533219676213;5828.854278643068;5917.852053698692;5944.762209511744;6121.602095863755;9101.135392137736;9365.953170234105;9480.383775054599;9503.857442138511;9652.131308182297;9686.273529485457;9913;10054.34646747959;10086.142677872464;10235.027672371112;6823.795286141423;7026.754063607749;7157.427405807419;7519.962400187964;7671.693132274647;8212.301954333949;8217.055038670629;8227.465214761021;8266.710665126691;8276.255137037695;7192.280771922766;7318.414526837733;7350.558966462029;7444.553326800409;7473.6263186841525;7192.172900116344;7299.708011679473;7320.304571065741;7340.70637174507;7401.0748656417945;6877.793666189822;6964.825879352854;6968.581885086911;6975.860482790417;6976.197737260077;4552.135094332067;4586.151561961048;4621.653375996881;4682.367880336111;4730.4796472387325;4914.434839993446;4966.106100901872;4986.800527978985;5022.171341728574;5061.848144555522 08:51:57 INFO - PROCESS | 1666 | |4;prototype.html;308.57416764864485;318.2029017311634;324.36748340735573;327.1037357640066;330.2190319893451;5358;5366.543843773279;6442.645654489002;6584.868302633944;6658.933410665892;6395.424411802936;6469.026946781241;6496.350364963501;6566.409023187912;6570.342965703439;4798.208295631217;4827.348307978431;4828.058528586918;4835.226363781796;4866.926996095061;4788.449328327252;4809.663323567334;4810.39870016248;4825.348577941968;4869.8782530436665;4554.977225113887;4623.214053610877;4654.371659825914;4657.464391594976;4706.858794236178;4718.079974404993;4728.763561821912;4731.81072757091;4743.478217396084;4809.374781278411;3447.655594195946;4118.546959834416;4126.174765047002;4133.256013917494;4136.6483848872585;6304;6335.04974253861;6335.746570137189;6338.6196828189995;6373.808785736435;5698;5701.743421546041;5703.31560212773;5704.71476426177;5726.198332233491;5906.320773111104;6307.716152773136;6513.153290072308;7003.439724822002;7012.333828286304;4627.95372046282;4666.9965957319;4669.089527542131;4671.416072990876;4694.2723877799;7389.445791565654;7395.038644976119;7395.186529481753;7399.593022383767;7404.444666649969;4706.811727530929;4715.198416269242;4722.244440889442;4734.668573199843;4744.905101897943;4791.5687588117235;4793.376861008047;4798.49615790344;4800.95199048012;4810.470848206694;5523.889522209533;5677.517411020027;5727.828165155052;5747.770089196469;5756.56825738063;5697.886042279131;6992;7032.12098487689;7056.188538318056;7063.71745130189;1357.9388927498287;1634.5014770495113;1655.4123286233455;1656.942007029748;1659.468969929635;886.9512176830207;934.9762010598384;1010.8584798128268;1029.3052189771875;1080.1358912869673;5021.824236151717;5992.700364981733;6551.541392102602;6564.245111812107;6591.472682185414;7225;7225.710971561079;7241.782746517613;7263.346298833025;7271.018412514349;5726.341470730919;6544.803655890331;6557.377049180321;6559;6562.146920900253;3683.208110256308;3789.9242015160094;3833.3483307837178;3835.9808200959374;3836.712246581518;7566.546007239584;7569.962150189324;7599.202083781234;7615.314621683964;7626.656800443993;7436.107667079985;7443.017985377797;7474.476786624993;7485;7485.887711684329;6700.731970721214;7052.294770522906;7572.129205141369;7594.202608726005;7601.315881570796;7007.264237255219;7214.494985350975;7215.170255420484;7227.7831665050135;7250.456215783732;7096.006559081836;7139.643017848983;7159.821004474721;7163.426925845815;7173.569585824867;6203.069539569101;7534.924650753642;7562.924370756222;7568.735094271674;7616.5810880399895;4727.503612120815;4741.099191153669;4742.359781429463;4749.715017098985;4763.261694437368;5824.534037276923;6879.518433709793;7213.567185968858;7235.421166306577;7236.312550307713;6961.025456436002;6969.686364113526;6977;6985.825354366181;7015.052967849275;6889.621070840952;6948.096747422803;6984.301569842975;6985.441164706913;7007.057036044772;4939.654224204415;5556.72216389187;5863.325717542537;6815.625140617313;6818.147731533559;5021.648484606042;6735.663216839236;6954.200266969363;6954.860902782018;6985.44116470671;6606.867862642816;6776.898346524905;6830.897536536857;6881.449484041164;6996.790096297119 08:51:57 INFO - PROCESS | 1666 | |5;yui.html;614.990775138373;663.0452148905573;679.6533767778433;720.4344589497246;746.5035751225436;14890.627734306649;14990.475333363322;15183.392664293442;15196.62008449788;15303.234838258099;13672.589822305323;13815;13834.861651383482;13848.099873508216;13970.790438143436;730.1165589636546;741.4957828676498;741.5958302725028;902.9864552031709;913.8355096082703;737.8081698758334;741.1846968334843;900.1043961258557;923.5659240157115;925.167349385555;976.7899901521172;976.8192884316388;980.8577756225343;981.1562056631292;981.7889153831925;970.5583959298538;970.9902900971006;971.68905950096;971.9514024298792;972.8540718892152;561.6910699115471;659.205657183098;670.9064225312758;714.0895358418006;716.2908720366852;14920.850791492163;14954.40182392703;14984.100953942689;15063.472778452702;15067.547973560811;10634.255602107856;12482.188657737219;12636.368181590884;12791.168574042658;13190.142640728322;9741.074597913186;10101.141402980755;10131.696049118538;10175.033371829664;10420.374777513374;3519.3313270478784;3522.119470132467;3590.533230680021;3614.34941710492;3653.598104208535;78786.6060669693;82620.17379826185;83122.75315870266;83808;84013;9608.375455595364;9650.517474126405;9695.272854535939;9781.168600669023;9790.265730070274;21944.89027554852;21952.45118872041;21957.341279761633;22016.44958876009;22025.11899524001;6400.615963042139;7209.0628218331285;7488.887666685004;7503.062117235346;7618.6190690466365;4075.164591258844;4081.4898137732785;4082.7115668515175;4213.6207741302815;4350.499692535335;3435.158386195398;3488.75578709493;3490.3193877193703;3495.4232551628697;3502.824858757052;598.5959477352769;600.8708127752554;601.6330038676404;604.8880957022965;612.8896798576299;578.7337824600646;592.9911051334234;595.1489370200654;610.7960179272573;619.3496828330325;7872.488288261359;8139.145389734111;8156.306713929263;8163.959180204061;8183.427160098736;563.3211979564614;574.4284436985143;588.5321169670123;607.4654304212265;608.1941427608436;3797.373433383516;3800.9429858552144;3801.5438147421933;3822.7897465639103;3836.5204349456317;84500.57749711335;84684.57657711796;85660;85735;91111;73478;73737.6313118431;74077.5184496307;74186;74195.62902185562;68220;70217.64891175511;70435.29564704288;70720;71232.64383678048;8090.312323452337;8091.514509129471;8163;8403.915960840313;8483.74548763538;47451.050978980915;47661.52338476571;48053.27920081132;49444;49541.752291238314;64054;65213.34786652263;65511.67244163939;66540.66918661697;67023.66488167529;11335.71660708456;11443.656690299304;11509.942450287695;11750.70623234426;11946.76106477883;11851.644450666494;12099.939500302442;12113.939430302793;12284.938575307066;12500;9461.439461439408;11434.256773309708;11459.369734664673;11648.41757912084;12065.336406497376;11076.335419874833;11342.319460832376;11463.770724585294;11514.078873690252;12009;11186.216964812385;11188.83216751733;11483.081353491867;11492.36791976416;11774.470148843151;9521.428714277166;9715.07706767856;9759.365641233297;9904.25718071133;9970.651027214013;9486.383385080224;9656.420614763138;9697.16928880427;9726.173275271682;9918.900810991798 08:51:57 INFO - PROCESS | 1666 | __end_tp_report 08:51:57 INFO - PROCESS | 1666 | __start_cc_report 08:51:57 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2544 08:51:57 INFO - PROCESS | 1666 | __end_cc_report 08:51:57 INFO - PROCESS | 1666 | __startTimestamp1464105117588__endTimestamp 08:51:57 INFO - PROCESS | 1666 | 08:51:57 INFO - PROCESS | 1666 | ------- Summary: start ------- 08:51:57 INFO - PROCESS | 1666 | Number of tests: 6 08:51:57 INFO - PROCESS | 1666 | 08:51:57 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5618.24 Median:5839.36 stddev:671.31 (11.5%) stddev-sans-first:630.11 08:51:57 INFO - PROCESS | 1666 | Values: 2595.8 3344.3 3409.7 3429.6 3464.8 5578.5 5580.7 5597.7 5601.9 5603.6 4652.7 5556.2 5612.8 5625.3 5667.2 4981.4 5041.0 5111.6 5120.8 5164.7 4430.0 4998.5 5164.0 5181.6 5185.0 5077.1 5117.0 5134.9 5147.5 5154.5 5098.1 5101.1 5111.1 5118.2 5152.1 4975.9 4990.9 5064.7 5073.7 5083.2 5397.9 5457.9 5481.7 5483.4 5499.7 6125.6 6136.9 6137.4 6144.1 6167.7 4447.6 6027.4 6122.1 6230.0 6238.9 4768.3 5716.4 5738.4 5738.4 5770.6 6300.3 6355.8 6365.1 6380.7 6385.3 5875.7 5998.4 6014.5 6015.3 6058.1 5623.7 5839.4 6185.4 6210.6 6221.3 6155.4 6159.1 6167.8 6169.3 6170.3 6033.0 6102.6 6134.6 6173.2 6183.0 4800.5 4824.5 4835.4 4838.0 4840.8 4364.3 4398.0 4399.9 4418.1 4432.0 5647.4 5667.0 5677.9 5681.4 5690.1 6195.3 6219.0 6236.5 6237.7 6247.0 5450.3 5541.4 5591.6 5627.0 5664.1 5269.7 5276.6 5281.5 5289.4 5298.5 6244.1 6296.3 6307.7 6309.4 6373.4 6065.7 6119.6 6129.6 6183.0 6223.1 6305.4 6333.6 6361.6 6366.8 6368.6 5975.5 5982.1 5986.5 5996.3 6004.6 6043.3 6084.3 6116.8 6126.8 6149.7 5909.1 5933.9 5939.6 5940.6 5947.0 5929.7 5930.1 5936.8 5951.7 5955.6 4740.7 5610.8 5785.0 5788.1 5794.9 5914.6 5937.6 5975.0 5989.7 6048.2 5862.3 5869.9 5885.6 5900.2 5930.5 08:51:57 INFO - PROCESS | 1666 | 08:51:57 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:62598.80 Median:35059.06 stddev:136701.52 (389.9%) stddev-sans-first:137005.52 08:51:57 INFO - PROCESS | 1666 | Values: 508.3 535.5 573.4 574.8 614.2 24233.0 28686.9 31297.8 31454.7 37526.8 41076.0 41296.0 41493.0 41558.0 41699.6 9311.7 9529.0 9541.4 9579.4 9605.7 8425.8 8671.0 9379.7 9529.9 11655.4 11332.9 11423.4 11430.8 11437.7 11463.1 8431.5 11275.2 11343.5 11349.0 11361.8 11415.9 11620.0 11640.5 11642.0 11662.0 38266.8 38679.0 38770.4 38789.8 38805.0 3234.0 3236.6 3538.9 3566.2 3829.0 22633.7 27888.9 28224.7 28248.3 28293.6 2703.6 2723.8 2780.2 2823.5 2861.8 446841.0 448204.0 449900.8 450161.0 451150.0 35291.5 35944.8 35982.6 59463.0 59862.7 34910.8 35207.3 35289.5 35292.0 35301.8 14813.9 14863.9 14882.9 14892.3 14905.3 11738.5 11916.2 12614.2 12672.8 12694.4 8045.5 8100.4 8100.9 8178.9 8200.2 2981.7 3407.2 3451.4 3454.5 3478.2 998.7 1010.4 1023.9 1040.0 1148.7 29196.9 29427.9 29677.7 30331.4 30398.0 1080.5 1140.7 1204.4 1208.0 1250.9 12981.6 15009.4 15153.7 15381.9 15474.6 623608.0 628357.0 636821.0 638519.0 640085.0 58610.7 59233.4 59313.0 59377.8 59622.7 1327.2 1369.7 1471.8 1513.3 1570.0 28669.3 28816.1 29808.9 30029.5 30258.7 47949.8 48059.8 48478.5 48519.3 48617.8 422731.0 425646.0 425855.0 426175.0 426257.0 26516.9 26529.1 26548.7 26983.5 27013.9 45089.3 45863.0 46084.1 46576.3 46909.0 36520.0 37717.4 37763.8 38568.0 38783.8 36852.8 37068.6 37209.0 37857.1 38006.0 36771.3 37457.8 37964.2 38130.6 38169.8 31880.3 32551.8 33898.7 33940.0 34025.5 22447.0 24810.5 24836.3 25142.4 25207.4 08:51:57 INFO - PROCESS | 1666 | 08:51:57 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34661.74 Median:3321.44 stddev:102514.78 (3086.5%) stddev-sans-first:102770.07 08:51:57 INFO - PROCESS | 1666 | Values: 392.4 402.0 403.9 406.1 414.8 17750.9 20122.9 20692.0 20827.9 21071.7 19343.0 19832.7 19858.3 20667.0 20971.5 5945.6 5985.0 6108.9 6151.8 6209.8 5133.8 6110.2 6138.9 6142.3 6159.9 6011.7 6062.3 6105.1 6115.7 6125.7 6099.2 6115.1 6128.4 6129.4 6137.0 5220.8 5291.1 5574.9 5851.8 5874.6 13382.1 13533.7 13619.8 13707.8 24737.8 2075.6 2108.2 2254.1 2454.2 2876.3 9706.8 9790.8 9802.3 9972.4 10158.5 1735.2 1751.1 1751.7 1762.3 1789.8 103681.5 108964.5 114253.0 117134.4 119182.0 11851.6 11867.8 11954.9 11965.8 11997.1 15270.5 15343.1 15345.9 15356.7 15358.7 8569.5 8722.3 8740.2 8794.5 8836.0 7259.2 8615.4 8667.7 8701.3 8744.1 3766.6 4665.8 4671.7 4675.4 4737.1 1845.3 1849.5 1851.6 1973.4 1978.5 926.7 952.0 988.8 993.8 999.2 19793.9 20211.9 20308.6 20384.9 20484.9 877.9 958.1 986.1 986.9 1021.5 10640.9 10829.5 10848.8 10879.8 10903.9 601415.0 610087.9 625518.0 625701.0 627877.0 81131.0 111260.0 114172.0 119017.5 124567.0 928.2 929.5 958.0 984.5 985.4 17530.6 17596.4 17824.9 17839.6 18197.3 50494.7 50496.0 50773.2 52889.7 53498.7 76255.0 76882.6 77639.0 77988.0 78308.0 8122.6 8165.8 8240.3 8294.2 8561.0 11830.8 11870.6 12622.6 12771.4 12929.4 11179.0 11230.9 11439.4 11500.8 11579.3 11105.7 11155.9 11321.7 11424.5 11499.8 11075.2 11562.7 11706.8 11923.8 11940.5 8403.1 8482.7 8532.1 8586.4 8843.6 11198.9 11558.5 11777.1 11845.1 11857.3 08:51:57 INFO - PROCESS | 1666 | 08:51:57 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5628.17 Median:2597.16 stddev:3175.96 (122.3%) stddev-sans-first:3168.79 08:51:57 INFO - PROCESS | 1666 | Values: 1376.9 1579.7 1600.3 1772.3 1850.6 7516.9 7788.3 8567.4 8573.2 8575.7 8282.5 8357.7 8427.8 8442.7 8443.1 2130.2 2192.4 2398.6 2419.5 2420.9 2378.6 2445.4 2448.1 2450.0 2450.2 2377.1 2398.5 2399.3 2404.5 2436.6 2033.0 2123.8 2345.0 2409.3 2412.5 2381.1 2418.7 2419.9 2421.3 2425.9 8496.2 8576.9 8582.4 8586.4 8610.9 4633.4 5206.9 5282.6 5338.9 5376.1 2847.5 3455.0 3548.4 3549.5 3552.1 1020.9 1021.5 1024.4 1051.1 1073.0 11749.7 11776.2 11807.7 11812.5 11824.1 4607.8 4675.4 4804.8 4807.6 4830.3 10083.9 10097.9 10121.5 10121.6 10130.3 5398.5 5403.9 5406.8 5438.4 5444.0 4354.5 4509.2 4720.3 4970.1 4971.0 3992.2 3994.0 4028.0 4047.2 4100.7 1150.3 1326.1 1336.5 1338.2 1356.2 918.0 921.7 925.5 935.9 964.6 4582.9 5767.6 5828.0 5845.7 6008.3 420.5 423.7 474.0 477.1 484.9 3745.7 3797.8 3844.3 3909.8 3912.1 10296.9 10815.7 10844.8 10865.2 10872.7 10454.7 10500.5 10575.8 10581.9 10595.3 7853.9 8196.4 8205.7 8256.9 8295.6 5491.5 5828.9 5917.9 5944.8 6121.6 9101.1 9366.0 9480.4 9503.9 9652.1 9686.3 9913.0 10054.3 10086.1 10235.0 6823.8 7026.8 7157.4 7520.0 7671.7 8212.3 8217.1 8227.5 8266.7 8276.3 7192.3 7318.4 7350.6 7444.6 7473.6 7192.2 7299.7 7320.3 7340.7 7401.1 6877.8 6964.8 6968.6 6975.9 6976.2 4552.1 4586.2 4621.7 4682.4 4730.5 4914.4 4966.1 4986.8 5022.2 5061.8 08:51:57 INFO - PROCESS | 1666 | 08:51:57 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5656.41 Median:6356.21 stddev:1806.44 (28.4%) stddev-sans-first:1766.35 08:51:57 INFO - PROCESS | 1666 | Values: 308.6 318.2 324.4 327.1 330.2 5358.0 5366.5 6442.6 6584.9 6658.9 6395.4 6469.0 6496.4 6566.4 6570.3 4798.2 4827.3 4828.1 4835.2 4866.9 4788.4 4809.7 4810.4 4825.3 4869.9 4555.0 4623.2 4654.4 4657.5 4706.9 4718.1 4728.8 4731.8 4743.5 4809.4 3447.7 4118.5 4126.2 4133.3 4136.6 6304.0 6335.0 6335.7 6338.6 6373.8 5698.0 5701.7 5703.3 5704.7 5726.2 5906.3 6307.7 6513.2 7003.4 7012.3 4628.0 4667.0 4669.1 4671.4 4694.3 7389.4 7395.0 7395.2 7399.6 7404.4 4706.8 4715.2 4722.2 4734.7 4744.9 4791.6 4793.4 4798.5 4801.0 4810.5 5523.9 5677.5 5727.8 5747.8 5756.6 5697.9 6992.0 7032.1 7056.2 7063.7 1357.9 1634.5 1655.4 1656.9 1659.5 887.0 935.0 1010.9 1029.3 1080.1 5021.8 5992.7 6551.5 6564.2 6591.5 7225.0 7225.7 7241.8 7263.3 7271.0 5726.3 6544.8 6557.4 6559.0 6562.1 3683.2 3789.9 3833.3 3836.0 3836.7 7566.5 7570.0 7599.2 7615.3 7626.7 7436.1 7443.0 7474.5 7485.0 7485.9 6700.7 7052.3 7572.1 7594.2 7601.3 7007.3 7214.5 7215.2 7227.8 7250.5 7096.0 7139.6 7159.8 7163.4 7173.6 6203.1 7534.9 7562.9 7568.7 7616.6 4727.5 4741.1 4742.4 4749.7 4763.3 5824.5 6879.5 7213.6 7235.4 7236.3 6961.0 6969.7 6977.0 6985.8 7015.1 6889.6 6948.1 6984.3 6985.4 7007.1 4939.7 5556.7 5863.3 6815.6 6818.1 5021.6 6735.7 6954.2 6954.9 6985.4 6606.9 6776.9 6830.9 6881.4 6996.8 08:51:57 INFO - PROCESS | 1666 | 08:51:57 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:17995.07 Median:609.50 stddev:24927.42 (4089.8%) stddev-sans-first:24963.18 08:51:57 INFO - PROCESS | 1666 | Values: 615.0 663.0 679.7 720.4 746.5 14890.6 14990.5 15183.4 15196.6 15303.2 13672.6 13815.0 13834.9 13848.1 13970.8 730.1 741.5 741.6 903.0 913.8 737.8 741.2 900.1 923.6 925.2 976.8 976.8 980.9 981.2 981.8 970.6 971.0 971.7 972.0 972.9 561.7 659.2 670.9 714.1 716.3 14920.9 14954.4 14984.1 15063.5 15067.5 10634.3 12482.2 12636.4 12791.2 13190.1 9741.1 10101.1 10131.7 10175.0 10420.4 3519.3 3522.1 3590.5 3614.3 3653.6 78786.6 82620.2 83122.8 83808.0 84013.0 9608.4 9650.5 9695.3 9781.2 9790.3 21944.9 21952.5 21957.3 22016.4 22025.1 6400.6 7209.1 7488.9 7503.1 7618.6 4075.2 4081.5 4082.7 4213.6 4350.5 3435.2 3488.8 3490.3 3495.4 3502.8 598.6 600.9 601.6 604.9 612.9 578.7 593.0 595.1 610.8 619.3 7872.5 8139.1 8156.3 8164.0 8183.4 563.3 574.4 588.5 607.5 608.2 3797.4 3800.9 3801.5 3822.8 3836.5 84500.6 84684.6 85660.0 85735.0 91111.0 73478.0 73737.6 74077.5 74186.0 74195.6 68220.0 70217.6 70435.3 70720.0 71232.6 8090.3 8091.5 8163.0 8403.9 8483.7 47451.1 47661.5 48053.3 49444.0 49541.8 64054.0 65213.3 65511.7 66540.7 67023.7 11335.7 11443.7 11509.9 11750.7 11946.8 11851.6 12099.9 12113.9 12284.9 12500.0 9461.4 11434.3 11459.4 11648.4 12065.3 11076.3 11342.3 11463.8 11514.1 12009.0 11186.2 11188.8 11483.1 11492.4 11774.5 9521.4 9715.1 9759.4 9904.3 9970.7 9486.4 9656.4 9697.2 9726.2 9918.9 08:51:57 INFO - PROCESS | 1666 | -------- Summary: end -------- 08:51:57 INFO - PROCESS | 1666 | 08:51:58 INFO - TEST-INFO | 1666: exit 0 08:51:58 INFO - TEST-OK | dromaeo_css | took 1115191ms 08:51:58 INFO - TEST-START | kraken 08:51:58 INFO - operating with platform_type : mac_ 08:51:58 INFO - Initialising browser for kraken test... 08:51:58 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpMxM6NM/profile http://localhost:49270/getInfo.html) 08:52:00 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 08:52:00 INFO - PROCESS | 1675 | colorDepth:24 08:52:00 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 08:52:00 INFO - PROCESS | 1675 | __metrics 08:52:00 INFO - PROCESS | 1675 | 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" 08:52:00 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:52:01 INFO - TEST-INFO | 1675: exit 0 08:52:01 INFO - Browser initialized. 08:52:01 INFO - Running cycle 1/1 for kraken test... 08:52:01 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpMxM6NM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:13 INFO - PROCESS | 1677 | RSS: Main: 210984960 08:52:13 INFO - PROCESS | 1677 | 08:52:15 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:16 INFO - PROCESS | 1677 | RSS: Main: 272195584 08:52:16 INFO - PROCESS | 1677 | 08:52:19 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 08:52:19 INFO - PROCESS | 1677 | RSS: Main: 287137792 08:52:19 INFO - PROCESS | 1677 | 08:52:23 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 08:52:23 INFO - PROCESS | 1677 | RSS: Main: 373657600 08:52:23 INFO - PROCESS | 1677 | 08:52:25 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 08:52:26 INFO - PROCESS | 1677 | RSS: Main: 278261760 08:52:26 INFO - PROCESS | 1677 | 08:52:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:29 INFO - PROCESS | 1677 | RSS: Main: 279707648 08:52:29 INFO - PROCESS | 1677 | 08:52:31 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:32 INFO - PROCESS | 1677 | RSS: Main: 318291968 08:52:32 INFO - PROCESS | 1677 | 08:52:35 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:36 INFO - PROCESS | 1677 | RSS: Main: 318763008 08:52:36 INFO - PROCESS | 1677 | 08:52:38 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 08:52:39 INFO - PROCESS | 1677 | RSS: Main: 317771776 08:52:39 INFO - PROCESS | 1677 | 08:52:41 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:41 INFO - PROCESS | 1677 | RSS: Main: 309174272 08:52:41 INFO - PROCESS | 1677 | 08:52:43 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:44 INFO - PROCESS | 1677 | RSS: Main: 315887616 08:52:44 INFO - PROCESS | 1677 | 08:52:46 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:47 INFO - PROCESS | 1677 | RSS: Main: 318644224 08:52:47 INFO - PROCESS | 1677 | 08:52:49 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:52:50 INFO - PROCESS | 1677 | RSS: Main: 323702784 08:52:50 INFO - PROCESS | 1677 | 08:52:53 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:52:53 INFO - PROCESS | 1677 | RSS: Main: 321765376 08:52:53 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 08:52:55 INFO - PROCESS | 1677 | RSS: Main: 385945600 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | __start_tp_report 08:52:55 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 08:52:55 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 08:52:55 INFO - PROCESS | 1677 | |i|pagename|runs| 08:52:55 INFO - PROCESS | 1677 | |0;ai-astar;114;115;121;113;115;114;115;114;117;192 08:52:55 INFO - PROCESS | 1677 | |1;audio-beat-detection;158;123;155;154;121;142;136;119;167;116 08:52:55 INFO - PROCESS | 1677 | |2;audio-dft;186;185;186;187;185;184;185;184;187;185 08:52:55 INFO - PROCESS | 1677 | |3;audio-fft;71;81;73;143;80;80;88;69;140;56 08:52:55 INFO - PROCESS | 1677 | |4;audio-oscillator;97;97;141;77;82;88;121;86;113;162 08:52:55 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;90;87;90;87;89;87;91;88;91;87 08:52:55 INFO - PROCESS | 1677 | |6;imaging-darkroom;95;100;120;95;95;94;94;94;95;95 08:52:55 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;84;84;85;85;85;87;93;132;85 08:52:55 INFO - PROCESS | 1677 | |8;json-parse-financial;61;65;64;64;64;64;65;80;60;59 08:52:55 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;66;65;70;80;76;71;69;69;68;70 08:52:55 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;81;82;82;81;83;80;81;81;81;86 08:52:55 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;127;130;132;143;143;117;141;126;173;162 08:52:55 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;168;164;165;166;161;168;165;165;161;164 08:52:55 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;68;70;68;67;71;69;67;67;68;67 08:52:55 INFO - PROCESS | 1677 | __end_tp_report 08:52:55 INFO - PROCESS | 1677 | __start_cc_report 08:52:55 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,2024 08:52:55 INFO - PROCESS | 1677 | __end_cc_report 08:52:55 INFO - PROCESS | 1677 | __startTimestamp1464105175863__endTimestamp 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | ------- Summary: start ------- 08:52:55 INFO - PROCESS | 1677 | Number of tests: 14 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:123.00 Median:115.00 stddev:24.35 (21.2%) stddev-sans-first:25.61 08:52:55 INFO - PROCESS | 1677 | Values: 114.0 115.0 121.0 113.0 115.0 114.0 115.0 114.0 117.0 192.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:148.00 stddev:18.72 (12.6%) stddev-sans-first:18.56 08:52:55 INFO - PROCESS | 1677 | Values: 158.0 123.0 155.0 154.0 121.0 142.0 136.0 119.0 167.0 116.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:185.40 Median:185.50 stddev:1.07 (0.6%) stddev-sans-first:1.12 08:52:55 INFO - PROCESS | 1677 | Values: 186.0 185.0 186.0 187.0 185.0 184.0 185.0 184.0 187.0 185.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:88.10 Median:76.50 stddev:29.45 (38.5%) stddev-sans-first:30.58 08:52:55 INFO - PROCESS | 1677 | Values: 71.0 81.0 73.0 143.0 80.0 80.0 88.0 69.0 140.0 56.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:84.00 stddev:27.76 (33.0%) stddev-sans-first:29.24 08:52:55 INFO - PROCESS | 1677 | Values: 97.0 97.0 141.0 77.0 82.0 88.0 121.0 86.0 113.0 162.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.50 stddev:1.70 (1.9%) stddev-sans-first:1.74 08:52:55 INFO - PROCESS | 1677 | Values: 90.0 87.0 90.0 87.0 89.0 87.0 91.0 88.0 91.0 87.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:97.70 Median:95.00 stddev:8.03 (8.5%) stddev-sans-first:8.46 08:52:55 INFO - PROCESS | 1677 | Values: 95.0 100.0 120.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:90.50 Median:85.00 stddev:14.82 (17.4%) stddev-sans-first:15.58 08:52:55 INFO - PROCESS | 1677 | Values: 85.0 84.0 84.0 85.0 85.0 85.0 87.0 93.0 132.0 85.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:5.82 (9.1%) stddev-sans-first:6.02 08:52:55 INFO - PROCESS | 1677 | Values: 61.0 65.0 64.0 64.0 64.0 64.0 65.0 80.0 60.0 59.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.00 stddev:4.50 (6.4%) stddev-sans-first:4.48 08:52:55 INFO - PROCESS | 1677 | Values: 66.0 65.0 70.0 80.0 76.0 71.0 69.0 69.0 68.0 70.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.50 stddev:1.69 (2.1%) stddev-sans-first:1.76 08:52:55 INFO - PROCESS | 1677 | Values: 81.0 82.0 82.0 81.0 83.0 80.0 81.0 81.0 81.0 86.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:142.00 stddev:17.15 (12.1%) stddev-sans-first:17.59 08:52:55 INFO - PROCESS | 1677 | Values: 127.0 130.0 132.0 143.0 143.0 117.0 141.0 126.0 173.0 162.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.00 stddev:2.41 (1.5%) stddev-sans-first:2.24 08:52:55 INFO - PROCESS | 1677 | Values: 168.0 164.0 165.0 166.0 161.0 168.0 165.0 165.0 161.0 164.0 08:52:55 INFO - PROCESS | 1677 | 08:52:55 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 08:52:55 INFO - PROCESS | 1677 | Values: 68.0 70.0 68.0 67.0 71.0 69.0 67.0 67.0 68.0 67.0 08:52:55 INFO - PROCESS | 1677 | -------- Summary: end -------- 08:52:55 INFO - PROCESS | 1677 | 08:52:56 INFO - TEST-INFO | 1677: exit 0 08:52:56 INFO - TEST-OK | kraken | took 58592ms 08:52:56 INFO - SUITE-END | took 1173s 08:52:57 INFO - Completed test suite (00:19:34) 08:52:57 INFO - javascript benchmark 08:52:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2595.7534034266737, 3344.2976974835283, 3409.6872704008965, 3429.6227414984346, 3464.774789638673, 5578.497935185833, 5580.665160090397, 5597.692126933017, 5601.887962240753, 5603.579731520137, 4652.737666062504, 5556.249906262653, 5612.831615051555, 5625.324961004675, 5667.206591077253, 4981.402231732197, 5040.991801639678, 5111.565516931066, 5120.846374608767, 5164.664296820713, 4430.003249268921, 4998.475160108191, 5163.974180129094, 5181.6113791465605, 5184.974075129619, 5077.086124497589, 5117.0, 5134.948650513485, 5147.459516750725, 5154.458781827911, 5098.133317336062, 5101.132807422747, 5111.097873354375, 5118.155504341779, 5152.098382782998, 4975.875603109915, 4990.90018199634, 5064.721440320781, 5073.746312684351, 5083.161278389061, 5397.892042159174, 5457.945420545823, 5481.725913704299, 5483.424240454735, 5499.697516636584, 6125.5712100153005, 6136.9079463808075, 6137.41694539018, 6144.078388241799, 6167.722452489604, 4447.5552444755585, 6027.427394397525, 6122.062734707318, 6230.0, 6238.9376106238815, 4768.3085952536685, 5716.428357164292, 5738.368779434259, 5738.426157384228, 5770.567207459458, 6300.27546832111, 6355.777547785898, 6365.140706004723, 6380.712867920862, 6385.329540398191, 5875.706214689249, 5998.400159984054, 6014.548908831767, 6015.30823955242, 6058.1215723719815, 5623.662580245198, 5839.357670656224, 6185.350538193515, 6210.627362358273, 6221.253449586078, 6155.415235552616, 6159.076138579249, 6167.753289868445, 6169.290531588835, 6170.321264660884, 6033.0, 6102.603330783485, 6134.631922084689, 6173.197484327009, 6183.0, 4800.543948324904, 4824.469308376076, 4835.44392394872, 4838.03239352131, 4840.806367745251, 4364.279893817548, 4397.956020439755, 4399.868003959887, 4418.138462999685, 4431.977840110779, 5647.435256474319, 5667.036603777367, 5677.943220567741, 5681.403452637496, 5690.146478028246, 6195.349488303754, 6219.0, 6236.532260080421, 6237.688115594202, 6247.0, 5450.345958485007, 5541.418151094158, 5591.6365436246515, 5627.0, 5664.0937450007805, 5269.736513174326, 5276.604254680914, 5281.524662780368, 5289.444608316148, 5298.496642818926, 6244.12582238487, 6296.338884417162, 6307.684615769193, 6309.369063093745, 6373.426391624776, 6065.696715164312, 6119.624418755179, 6129.572745043327, 6182.9798083315745, 6223.097650840693, 6305.432511074026, 6333.619982801047, 6361.586496877688, 6366.77716279928, 6368.554201206057, 5975.492083172805, 5982.102684597346, 5986.521078313637, 5996.340402555628, 6004.639721616717, 6043.274807023009, 6084.330723620486, 6116.847078823065, 6126.846828829315, 6149.72326245329, 5909.143174239797, 5933.881322373615, 5939.554533409925, 5940.613860099253, 5947.018741907536, 5929.733162007807, 5930.080837470199, 5936.762529498772, 5951.7024148791525, 5955.612885162624, 4740.739259340769, 5610.831675049755, 5784.971075144766, 5788.131780232999, 5794.855128621818, 5914.585978981602, 5937.643741375531, 5975.043992961106, 5989.7304621293015, 6048.213732214784, 5862.296524417097, 5869.943410186207, 5885.558583106199, 5900.203472531153, 5930.52555795544], "value": 5575.069438302505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.2757071173578, 535.4645354645355, 573.4466240078325, 574.7729646789518, 614.2046050364777, 24233.0, 28686.856565717193, 31297.843510782444, 31454.685453145463, 37526.81236593813, 41076.0, 41296.0, 41493.0, 41557.96105097374, 41699.58300416995, 9311.720648380526, 9529.0, 9541.379810312343, 9579.425234485952, 9605.711828645151, 8425.789355266137, 8671.0, 9379.671711490098, 9529.857052144223, 11655.417229138551, 11332.943335283311, 11423.428828558539, 11430.771384572303, 11437.74184839667, 11463.140264480156, 8431.536265505394, 11275.154363422735, 11343.546258149665, 11348.978591926683, 11361.829572556418, 11415.942920285428, 11619.954204121585, 11640.476178571984, 11642.01042911345, 11662.008729258023, 38266.808665956494, 38679.0, 38770.41844372336, 38789.836304910896, 38805.02987425337, 3234.0459564428315, 3236.64396916339, 3538.929221415583, 3566.233259849119, 3828.9808550957346, 22633.660495092587, 27888.884444622192, 28224.717752822413, 28248.293792655142, 28293.57559636607, 2703.648525691667, 2723.7820974322203, 2780.2215379693716, 2823.463541927048, 2861.756750676195, 446841.0, 448204.0, 449900.7504962454, 450161.0, 451150.0, 35291.470627940085, 35944.820275898455, 35982.640173598455, 59463.0, 59862.70068649629, 34910.82544587312, 35207.295854083284, 35289.47065794015, 35292.0, 35301.82349088238, 14813.851861481462, 14863.851361486462, 14882.925585372004, 14892.329845156994, 14905.329260183318, 11738.471768770425, 11916.16586838913, 12614.243145411305, 12672.80990785139, 12694.365281735876, 8045.477043992122, 8100.432969692065, 8100.918990810134, 8178.877316840252, 8200.179982001751, 2981.6869228731107, 3407.16524451511, 3451.376953515296, 3454.4818277258614, 3478.2347883465595, 998.6604554451376, 1010.3533738407425, 1023.8976102389702, 1039.9948000259951, 1148.7070796946725, 29196.854015729787, 29427.852860735988, 29677.703222967495, 30331.393372132432, 30398.0, 1080.4927126658424, 1140.7433327501246, 1204.4278967490372, 1208.0, 1250.9437075331632, 12981.610551683465, 15009.399624014917, 15153.696926061417, 15381.9230903847, 15474.613134671723, 623608.0, 628357.0, 636821.0, 638519.0, 640085.0, 58610.706946465, 59233.40766592365, 59313.0, 59377.81244375088, 59622.70188649116, 1327.183781974079, 1369.7260547890462, 1471.8160229971254, 1513.2585033333587, 1569.968600627981, 28669.28326791847, 28816.135515934555, 29808.85095574508, 30029.5495567571, 30258.697413025588, 47949.760251199914, 48059.75970120127, 48478.5152148474, 48519.272210917574, 48617.75691121522, 422731.0, 425646.0, 425855.0, 426175.0, 426257.0, 26516.867415662797, 26529.07148249802, 26548.67256637119, 26983.46033079288, 27013.86493067522, 45089.32366014578, 45863.0, 46084.07831843411, 46576.30135548037, 46909.0, 36520.0, 37717.4342384859, 37763.81118094392, 38568.0, 38783.806080969414, 36852.81573592115, 37068.629313706515, 37209.0, 37857.05357366088, 38006.0, 36771.26457470782, 37457.81271093736, 37964.2407151861, 38130.61869381271, 38169.80915095407, 31880.278500793538, 32551.83724081459, 33898.661013390534, 33940.0, 34025.48961765526, 22447.0, 24810.50378992446, 24836.25491235266, 25142.371440714127, 25207.36981575475], "value": 18368.22762417776, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.36436972105184, 401.98593049243283, 403.8687426586358, 406.1308799169779, 414.7946766350657, 17750.911245443785, 20122.893240871745, 20691.96540172991, 20827.895860520694, 21071.68392474114, 19343.0, 19832.70250946237, 19858.304959326426, 20667.0, 20971.47571310718, 5945.643261404308, 5985.0, 6108.877822443548, 6151.846203844895, 6209.844753881144, 5133.794648214086, 6110.236220472441, 6138.877222455548, 6142.262928448592, 6159.907601385983, 6011.669358185298, 6062.333143354227, 6105.084237364409, 6115.7247923843315, 6125.724342404603, 6099.207103076616, 6115.113308570277, 6128.387161283836, 6129.356417576158, 6137.048757442603, 5220.817271395483, 5291.074062039128, 5574.916376254359, 5851.795187168471, 5874.618149820248, 13382.13016153947, 13533.661658458519, 13619.795703064461, 13707.794383084261, 24737.752622473727, 2075.5848830233863, 2108.1988844239245, 2254.120892851789, 2454.2023842251338, 2876.3096856754437, 9706.805863882682, 9790.755231119208, 9802.313838031341, 9972.401655900669, 10158.542865571068, 1735.1757914990405, 1751.0719318761078, 1751.7109676903297, 1762.330314480502, 1789.7673302470726, 103681.48159259156, 108964.45517772439, 114253.0, 117134.41432792782, 119182.0, 11851.585194518151, 11867.76264474723, 11954.940225298991, 11965.820512692317, 11997.100942193822, 15270.541883743506, 15343.07941523512, 15345.923270383577, 15356.692866142615, 15358.692826143639, 8569.528675922884, 8722.258608018263, 8740.169683880022, 8794.516301603473, 8836.0, 7259.201487836333, 8615.39692221551, 8667.653293868301, 8701.260392866678, 8744.125587441333, 3766.5668448128818, 4665.766711664471, 4671.7430541320555, 4675.4155730533685, 4737.099951009297, 1845.298786461163, 1849.5098798818324, 1851.5741379482795, 1973.4375702924597, 1978.5053736565858, 926.6525053105086, 952.0431965874391, 988.8071825994006, 993.8111758765812, 999.2455695949511, 19793.901030495043, 20211.8989405052, 20308.593828123354, 20384.89807550953, 20484.897575512026, 877.8675508593842, 958.1376760915232, 986.1124987511297, 986.8569057486768, 1021.5352014833232, 10640.893591064145, 10829.458527073615, 10848.837267440837, 10879.782404351869, 10903.945480272549, 601415.0, 610087.9495602493, 625518.0, 625701.0, 627877.0, 81131.0, 111260.0, 114172.0, 119017.46670331697, 124567.0, 928.2481190235931, 929.5445231836487, 957.9521023948774, 984.4880662055691, 985.3841349156634, 17530.649387012443, 17596.38412655551, 17824.91087544554, 17839.554011149306, 18197.272109116017, 50494.7376315595, 50496.0, 50773.238401424744, 52889.735551321995, 53498.732506338776, 76255.0, 76882.6155869217, 77639.0, 77988.0, 78308.0, 8122.634481448467, 8165.836683266182, 8240.299574536231, 8294.212049855254, 8560.957195213985, 11830.822537662114, 11870.643880683594, 12622.55821046259, 12771.36143192818, 12929.353532323534, 11179.0, 11230.887691122984, 11439.428028598702, 11500.827487587525, 11579.305241685526, 11105.722356941142, 11155.94422027917, 11321.71695707614, 11424.543018279175, 11499.827502587636, 11075.169362298022, 11562.710932226426, 11706.824397633873, 11923.82114268304, 11940.522379105087, 8403.117672644285, 8482.745517634481, 8532.104129066358, 8586.356023298402, 8843.60203790818, 11198.888011119785, 11558.479868405773, 11777.057835373322, 11845.052395808143, 11857.288562686266], "value": 9486.817052703795, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.8623137686227, 1579.7235483790337, 1600.263878615837, 1772.335374234662, 1850.574367895384, 7516.924830751697, 7788.337991270741, 8567.35744819138, 8573.185547373005, 8575.65697372106, 8282.544460054694, 8357.665693372273, 8427.789305267372, 8442.746717598482, 8443.11347308533, 2130.1585873579925, 2192.4299682082615, 2398.628212627041, 2419.4677171022345, 2420.9031638734427, 2378.5956387414094, 2445.4375493636476, 2448.09420514409, 2449.963250551243, 2450.1546966296687, 2377.09670325277, 2398.5442765874513, 2399.328188107324, 2404.5431368040104, 2436.5979613363775, 2033.0, 2123.7770034146347, 2344.9882750586307, 2409.33743220614, 2412.5416170927556, 2381.0951838301507, 2418.661387405765, 2419.8669073200967, 2421.3099266708905, 2425.92722218332, 8496.192861678132, 8576.871346929802, 8582.442141260799, 8586.356023298278, 8610.913890861137, 4633.351330813689, 5206.895862082775, 5282.603804714623, 5338.91991620126, 5376.1398176292, 2847.4732174547776, 3454.9827250863586, 3548.449990251515, 3549.5208146900095, 3552.0587044433246, 1020.9183265338755, 1021.4637315409395, 1024.4109636958704, 1051.1013083813382, 1073.002108039523, 11749.706257343549, 11776.175667703264, 11807.704807379885, 11812.468438920268, 11824.11319151067, 4607.815687372535, 4675.4155730533685, 4804.8318308859725, 4807.6394270429855, 4830.347903033045, 10083.949580252052, 10097.949510252402, 10121.544530496145, 10121.59513619447, 10130.341527800669, 5398.514133727984, 5403.864903377447, 5406.810761623325, 5438.401775804658, 5444.020076386209, 4354.521002689701, 4509.188346097734, 4720.33915251865, 4970.080535101018, 4971.0, 3992.2215168042535, 3993.9600603994168, 4028.0332720146953, 4047.1905618876344, 4100.671946244293, 1150.3385553306882, 1326.085001349066, 1336.5188532128425, 1338.1569611144917, 1356.1998420931698, 917.9678711245074, 921.709661456639, 925.5279807298326, 935.9064093590723, 964.6141543382563, 4582.877195087159, 5767.596268261182, 5828.0, 5845.707714614252, 6008.309044459856, 420.4912056411715, 423.733048179651, 473.97867095980763, 477.11971412743435, 484.9127157111754, 3745.7377983541437, 3797.8290976906105, 3844.3464611016193, 3909.8240579174008, 3912.1002169501176, 10296.918823523572, 10815.675529733962, 10844.837327440095, 10865.239433239756, 10872.728181795519, 10454.68635940923, 10500.527476263587, 10575.788484230272, 10581.894181058246, 10595.311304765166, 7853.921460785434, 8196.42625016255, 8205.71280005197, 8256.926599542021, 8295.62669679866, 5491.533219676213, 5828.854278643068, 5917.852053698692, 5944.762209511744, 6121.602095863755, 9101.135392137736, 9365.953170234105, 9480.383775054599, 9503.857442138511, 9652.131308182297, 9686.273529485457, 9913.0, 10054.34646747959, 10086.142677872464, 10235.027672371112, 6823.795286141423, 7026.754063607749, 7157.427405807419, 7519.962400187964, 7671.693132274647, 8212.301954333949, 8217.055038670629, 8227.465214761021, 8266.710665126691, 8276.255137037695, 7192.280771922766, 7318.414526837733, 7350.558966462029, 7444.553326800409, 7473.6263186841525, 7192.172900116344, 7299.708011679473, 7320.304571065741, 7340.70637174507, 7401.0748656417945, 6877.793666189822, 6964.825879352854, 6968.581885086911, 6975.860482790417, 6976.197737260077, 4552.135094332067, 4586.151561961048, 4621.653375996881, 4682.367880336111, 4730.4796472387325, 4914.434839993446, 4966.106100901872, 4986.800527978985, 5022.171341728574, 5061.848144555522], "value": 4460.077927284907, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.57416764864485, 318.2029017311634, 324.36748340735573, 327.1037357640066, 330.2190319893451, 5358.0, 5366.543843773279, 6442.645654489002, 6584.868302633944, 6658.933410665892, 6395.424411802936, 6469.026946781241, 6496.350364963501, 6566.409023187912, 6570.342965703439, 4798.208295631217, 4827.348307978431, 4828.058528586918, 4835.226363781796, 4866.926996095061, 4788.449328327252, 4809.663323567334, 4810.39870016248, 4825.348577941968, 4869.8782530436665, 4554.977225113887, 4623.214053610877, 4654.371659825914, 4657.464391594976, 4706.858794236178, 4718.079974404993, 4728.763561821912, 4731.81072757091, 4743.478217396084, 4809.374781278411, 3447.655594195946, 4118.546959834416, 4126.174765047002, 4133.256013917494, 4136.6483848872585, 6304.0, 6335.04974253861, 6335.746570137189, 6338.6196828189995, 6373.808785736435, 5698.0, 5701.743421546041, 5703.31560212773, 5704.71476426177, 5726.198332233491, 5906.320773111104, 6307.716152773136, 6513.153290072308, 7003.439724822002, 7012.333828286304, 4627.95372046282, 4666.9965957319, 4669.089527542131, 4671.416072990876, 4694.2723877799, 7389.445791565654, 7395.038644976119, 7395.186529481753, 7399.593022383767, 7404.444666649969, 4706.811727530929, 4715.198416269242, 4722.244440889442, 4734.668573199843, 4744.905101897943, 4791.5687588117235, 4793.376861008047, 4798.49615790344, 4800.95199048012, 4810.470848206694, 5523.889522209533, 5677.517411020027, 5727.828165155052, 5747.770089196469, 5756.56825738063, 5697.886042279131, 6992.0, 7032.12098487689, 7056.188538318056, 7063.71745130189, 1357.9388927498287, 1634.5014770495113, 1655.4123286233455, 1656.942007029748, 1659.468969929635, 886.9512176830207, 934.9762010598384, 1010.8584798128268, 1029.3052189771875, 1080.1358912869673, 5021.824236151717, 5992.700364981733, 6551.541392102602, 6564.245111812107, 6591.472682185414, 7225.0, 7225.710971561079, 7241.782746517613, 7263.346298833025, 7271.018412514349, 5726.341470730919, 6544.803655890331, 6557.377049180321, 6559.0, 6562.146920900253, 3683.208110256308, 3789.9242015160094, 3833.3483307837178, 3835.9808200959374, 3836.712246581518, 7566.546007239584, 7569.962150189324, 7599.202083781234, 7615.314621683964, 7626.656800443993, 7436.107667079985, 7443.017985377797, 7474.476786624993, 7485.0, 7485.887711684329, 6700.731970721214, 7052.294770522906, 7572.129205141369, 7594.202608726005, 7601.315881570796, 7007.264237255219, 7214.494985350975, 7215.170255420484, 7227.7831665050135, 7250.456215783732, 7096.006559081836, 7139.643017848983, 7159.821004474721, 7163.426925845815, 7173.569585824867, 6203.069539569101, 7534.924650753642, 7562.924370756222, 7568.735094271674, 7616.5810880399895, 4727.503612120815, 4741.099191153669, 4742.359781429463, 4749.715017098985, 4763.261694437368, 5824.534037276923, 6879.518433709793, 7213.567185968858, 7235.421166306577, 7236.312550307713, 6961.025456436002, 6969.686364113526, 6977.0, 6985.825354366181, 7015.052967849275, 6889.621070840952, 6948.096747422803, 6984.301569842975, 6985.441164706913, 7007.057036044772, 4939.654224204415, 5556.72216389187, 5863.325717542537, 6815.625140617313, 6818.147731533559, 5021.648484606042, 6735.663216839236, 6954.200266969363, 6954.860902782018, 6985.44116470671, 6606.867862642816, 6776.898346524905, 6830.897536536857, 6881.449484041164, 6996.790096297119], "value": 5050.04116038273, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.990775138373, 663.0452148905573, 679.6533767778433, 720.4344589497246, 746.5035751225436, 14890.627734306649, 14990.475333363322, 15183.392664293442, 15196.62008449788, 15303.234838258099, 13672.589822305323, 13815.0, 13834.861651383482, 13848.099873508216, 13970.790438143436, 730.1165589636546, 741.4957828676498, 741.5958302725028, 902.9864552031709, 913.8355096082703, 737.8081698758334, 741.1846968334843, 900.1043961258557, 923.5659240157115, 925.167349385555, 976.7899901521172, 976.8192884316388, 980.8577756225343, 981.1562056631292, 981.7889153831925, 970.5583959298538, 970.9902900971006, 971.68905950096, 971.9514024298792, 972.8540718892152, 561.6910699115471, 659.205657183098, 670.9064225312758, 714.0895358418006, 716.2908720366852, 14920.850791492163, 14954.40182392703, 14984.100953942689, 15063.472778452702, 15067.547973560811, 10634.255602107856, 12482.188657737219, 12636.368181590884, 12791.168574042658, 13190.142640728322, 9741.074597913186, 10101.141402980755, 10131.696049118538, 10175.033371829664, 10420.374777513374, 3519.3313270478784, 3522.119470132467, 3590.533230680021, 3614.34941710492, 3653.598104208535, 78786.6060669693, 82620.17379826185, 83122.75315870266, 83808.0, 84013.0, 9608.375455595364, 9650.517474126405, 9695.272854535939, 9781.168600669023, 9790.265730070274, 21944.89027554852, 21952.45118872041, 21957.341279761633, 22016.44958876009, 22025.11899524001, 6400.615963042139, 7209.0628218331285, 7488.887666685004, 7503.062117235346, 7618.6190690466365, 4075.164591258844, 4081.4898137732785, 4082.7115668515175, 4213.6207741302815, 4350.499692535335, 3435.158386195398, 3488.75578709493, 3490.3193877193703, 3495.4232551628697, 3502.824858757052, 598.5959477352769, 600.8708127752554, 601.6330038676404, 604.8880957022965, 612.8896798576299, 578.7337824600646, 592.9911051334234, 595.1489370200654, 610.7960179272573, 619.3496828330325, 7872.488288261359, 8139.145389734111, 8156.306713929263, 8163.959180204061, 8183.427160098736, 563.3211979564614, 574.4284436985143, 588.5321169670123, 607.4654304212265, 608.1941427608436, 3797.373433383516, 3800.9429858552144, 3801.5438147421933, 3822.7897465639103, 3836.5204349456317, 84500.57749711335, 84684.57657711796, 85660.0, 85735.0, 91111.0, 73478.0, 73737.6313118431, 74077.5184496307, 74186.0, 74195.62902185562, 68220.0, 70217.64891175511, 70435.29564704288, 70720.0, 71232.64383678048, 8090.312323452337, 8091.514509129471, 8163.0, 8403.915960840313, 8483.74548763538, 47451.050978980915, 47661.52338476571, 48053.27920081132, 49444.0, 49541.752291238314, 64054.0, 65213.34786652263, 65511.67244163939, 66540.66918661697, 67023.66488167529, 11335.71660708456, 11443.656690299304, 11509.942450287695, 11750.70623234426, 11946.76106477883, 11851.644450666494, 12099.939500302442, 12113.939430302793, 12284.938575307066, 12500.0, 9461.439461439408, 11434.256773309708, 11459.369734664673, 11648.41757912084, 12065.336406497376, 11076.335419874833, 11342.319460832376, 11463.770724585294, 11514.078873690252, 12009.0, 11186.216964812385, 11188.83216751733, 11483.081353491867, 11492.36791976416, 11774.470148843151, 9521.428714277166, 9715.07706767856, 9759.365641233297, 9904.25718071133, 9970.651027214013, 9486.383385080224, 9656.420614763138, 9697.16928880427, 9726.173275271682, 9918.900810991798], "value": 6843.1188930879425, "unit": "score"}], "name": "dromaeo_css", "value": 7287.205432631836, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 121.0, 113.0, 115.0, 114.0, 115.0, 114.0, 117.0, 192.0], "value": 123.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 123.0, 155.0, 154.0, 121.0, 142.0, 136.0, 119.0, 167.0, 116.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 186.0, 187.0, 185.0, 184.0, 185.0, 184.0, 187.0, 185.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 81.0, 73.0, 143.0, 80.0, 80.0, 88.0, 69.0, 140.0, 56.0], "value": 88.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 141.0, 77.0, 82.0, 88.0, 121.0, 86.0, 113.0, 162.0], "value": 106.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 89.0, 87.0, 91.0, 88.0, 91.0, 87.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 120.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 97.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 87.0, 93.0, 132.0, 85.0], "value": 90.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 80.0, 60.0, 59.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 70.0, 80.0, 76.0, 71.0, 69.0, 69.0, 68.0, 70.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 81.0, 83.0, 80.0, 81.0, 81.0, 81.0, 86.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 130.0, 132.0, 143.0, 143.0, 117.0, 141.0, 126.0, 173.0, 162.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 165.0, 166.0, 161.0, 168.0, 165.0, 165.0, 161.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 67.0, 71.0, 69.0, 67.0, 67.0, 68.0, 67.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1508.0000000000002, "alertThreshold": 2.0}]} 08:52:57 INFO - Return code: 0 08:52:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:52:57 ERROR - # TBPL SUCCESS # 08:52:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:52:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:52:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:52:57 INFO - 2016-05-24 08:52:57.207 screenresolution[1681:10149] starting screenresolution argv=screenresolution get 08:52:57 INFO - 2016-05-24 08:52:57.210 screenresolution[1681:10149] Display 0: 1600x1200x32@60 08:52:57 INFO - 2016-05-24 08:52:57.216 screenresolution[1682:10152] starting screenresolution argv=screenresolution list 08:52:57 INFO - Available Modes on Display 0 08:52:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:52:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:52:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:52:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:52:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:52:57 INFO - Intel Iris: 08:52:57 INFO - Chipset Model: Intel Iris 08:52:57 INFO - Type: GPU 08:52:57 INFO - Bus: Built-In 08:52:57 INFO - VRAM (Dynamic, Max): 1536 MB 08:52:57 INFO - Vendor: Intel (0x8086) 08:52:57 INFO - Device ID: 0x0a2e 08:52:57 INFO - Revision ID: 0x0009 08:52:57 INFO - Displays: 08:52:57 INFO - Display: 08:52:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:52:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:52:57 INFO - Display Serial Number: 1600x1200 60 08:52:57 INFO - Main Display: Yes 08:52:57 INFO - Mirror: Off 08:52:57 INFO - Online: Yes 08:52:57 INFO - Rotation: Supported 08:52:57 INFO - Return code: 0 08:52:57 INFO - Running post-action listener: _resource_record_post_action 08:52:57 INFO - Running post-run listener: _resource_record_post_run 08:52:58 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37807616; Write bytes: 653541376; Read time: 390; Write time: 1888 08:52:58 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 346853888; Write bytes: 347086336; Read time: 27917; Write time: 701 08:52:58 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 36886016; Write bytes: 296497664; Read time: 377; Write time: 1154 08:52:58 INFO - Running post-run listener: _upload_blobber_files 08:52:58 INFO - Blob upload gear active. 08:52:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:52:58 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 08:52:58 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'] 08:52:58 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 08:52:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:52:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:52:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:52:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:59 INFO - (blobuploader) - INFO - Done attempting. 08:52:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:52:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:53:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:00 INFO - (blobuploader) - INFO - Done attempting. 08:53:00 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:00 INFO - Return code: 0 08:53:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:53:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/774a6445b1afe2156b2f1cfca9c1e829aab364dd5e3a6a820a721169b7d650726e3464f50b72ea31780bac1bb4604abb0ffdd5a007f1ec2b5bbeafd81c50f318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6485c097c371990baf539435b47c68d08ed34ded31cf0a3066eefe25f480cbe381a3d8f9fd238f82ad48a7ff6ec636001acbda90099a20163e345a754a2077f4"} 08:53:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:53:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:53:00 INFO - Contents: 08:53:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/774a6445b1afe2156b2f1cfca9c1e829aab364dd5e3a6a820a721169b7d650726e3464f50b72ea31780bac1bb4604abb0ffdd5a007f1ec2b5bbeafd81c50f318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6485c097c371990baf539435b47c68d08ed34ded31cf0a3066eefe25f480cbe381a3d8f9fd238f82ad48a7ff6ec636001acbda90099a20163e345a754a2077f4"} 08:53:00 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:00 INFO - Copying logs to upload dir... 08:53:00 INFO - mkdir: /builds/slave/test/build/upload/logs 08:53:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.067147 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-05-24 08:53:01.380994) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 08:53:01.384146) ========= 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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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/774a6445b1afe2156b2f1cfca9c1e829aab364dd5e3a6a820a721169b7d650726e3464f50b72ea31780bac1bb4604abb0ffdd5a007f1ec2b5bbeafd81c50f318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6485c097c371990baf539435b47c68d08ed34ded31cf0a3066eefe25f480cbe381a3d8f9fd238f82ad48a7ff6ec636001acbda90099a20163e345a754a2077f4"} build_url:https://queue.taskcluster.net/v1/task/fYP1jvNPQvioSByJD1tn4Q/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010901 build_url: 'https://queue.taskcluster.net/v1/task/fYP1jvNPQvioSByJD1tn4Q/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/774a6445b1afe2156b2f1cfca9c1e829aab364dd5e3a6a820a721169b7d650726e3464f50b72ea31780bac1bb4604abb0ffdd5a007f1ec2b5bbeafd81c50f318", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6485c097c371990baf539435b47c68d08ed34ded31cf0a3066eefe25f480cbe381a3d8f9fd238f82ad48a7ff6ec636001acbda90099a20163e345a754a2077f4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 08:53:01.412639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 08:53:01.413022) ========= 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.eBJ6u9bkHO/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.06qVu1TYfI/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.005017 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 08:53:01.460681) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 08:53:01.461043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 08:53:01.461371) ========= ========= Total master_lag: 0.22 =========