builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0020 starttime: 1460637341.45 results: success (0) buildid: 20160414030247 builduid: 429190adabdc4754941ed0e71a4d0cdb revision: 91115264629dfaacf2d60d52a3eff89c18c5af0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:41.450455) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:41.450874) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:41.451158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:41.529591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:41.529936) ========= 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.kkCteiba0w/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.O3CDZp5x96/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-14 05:35:41-- 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% 7.76M=0.001s 2016-04-14 05:35:41 (7.76 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102878 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:41.649353) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:41.649687) ========= 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.kkCteiba0w/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.O3CDZp5x96/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.019916 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:41.697929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 05:35:41.698287) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 91115264629dfaacf2d60d52a3eff89c18c5af0d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 91115264629dfaacf2d60d52a3eff89c18c5af0d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kkCteiba0w/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.O3CDZp5x96/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-14 05:35:41,768 truncating revision to first 12 chars 2016-04-14 05:35:41,768 Setting DEBUG logging. 2016-04-14 05:35:41,768 attempt 1/10 2016-04-14 05:35:41,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/91115264629d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 05:35:43,112 unpacking tar archive at: mozilla-central-91115264629d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.596474 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 05:35:43.310942) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:43.311268) ========= script_repo_revision: 91115264629dfaacf2d60d52a3eff89c18c5af0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:43.311640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:43.311903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 05:35:43.325674) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-04-14 05:35:43.326238) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kkCteiba0w/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.O3CDZp5x96/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 05:35:43 INFO - MultiFileLogger online at 20160414 05:35:43 in /builds/slave/test 05:35:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:35:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:35:43 INFO - {'append_to_log': False, 05:35:43 INFO - 'base_work_dir': '/builds/slave/test', 05:35:43 INFO - 'blob_upload_branch': 'Firefox', 05:35:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:35:43 INFO - 'branch': 'Firefox', 05:35:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:43 INFO - 'config_files': ('talos/mac_config.py',), 05:35:43 INFO - 'default_actions': ('clobber', 05:35:43 INFO - 'read-buildbot-config', 05:35:43 INFO - 'download-and-extract', 05:35:43 INFO - 'populate-webroot', 05:35:43 INFO - 'create-virtualenv', 05:35:43 INFO - 'install', 05:35:43 INFO - 'run-tests'), 05:35:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:43 INFO - 'download_minidump_stackwalk': True, 05:35:43 INFO - 'download_symbols': 'ondemand', 05:35:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:43 INFO - 'installer_path': 'installer.exe', 05:35:43 INFO - 'log_level': 'info', 05:35:43 INFO - 'log_name': 'talos', 05:35:43 INFO - 'log_to_console': True, 05:35:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:35:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:35:43 INFO - 'opt_config_files': (), 05:35:43 INFO - 'pip_index': False, 05:35:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:43 INFO - 'cmd': ('bash', 05:35:43 INFO - '-c', 05:35:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:43 INFO - 'enabled': True, 05:35:43 INFO - 'halt_on_failure': False, 05:35:43 INFO - 'name': 'check_screen_resolution'},), 05:35:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:43 INFO - 'cmd': ('bash', 05:35:43 INFO - '-c', 05:35:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:43 INFO - 'enabled': True, 05:35:43 INFO - 'halt_on_failure': False, 05:35:43 INFO - 'name': 'check_screen_resolution'},), 05:35:43 INFO - 'run_cmd_checks_enabled': True, 05:35:43 INFO - 'sps_profile': False, 05:35:43 INFO - 'sps_profile_interval': 0, 05:35:43 INFO - 'suite': 'dromaeojs-e10s', 05:35:43 INFO - 'system_bits': '32', 05:35:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:43 INFO - 'title': 't-yosemite-r7-0020', 05:35:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:43 INFO - 'use_talos_json': True, 05:35:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:35:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:43 INFO - 'work_dir': 'build'} 05:35:43 INFO - ##### 05:35:43 INFO - ##### Running clobber step. 05:35:43 INFO - ##### 05:35:43 INFO - Running pre-action listener: _resource_record_pre_action 05:35:43 INFO - Running main action method: clobber 05:35:43 INFO - rmtree: /builds/slave/test/build 05:35:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:35:43 INFO - Running post-action listener: _resource_record_post_action 05:35:43 INFO - ##### 05:35:43 INFO - ##### Running read-buildbot-config step. 05:35:43 INFO - ##### 05:35:43 INFO - Running pre-action listener: _resource_record_pre_action 05:35:43 INFO - Running main action method: read_buildbot_config 05:35:43 INFO - Using buildbot properties: 05:35:43 INFO - { 05:35:43 INFO - "project": "", 05:35:43 INFO - "product": "firefox", 05:35:43 INFO - "script_repo_revision": "production", 05:35:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:35:43 INFO - "repository": "", 05:35:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:35:43 INFO - "buildid": "20160414030247", 05:35:43 INFO - "stage_platform": "macosx64", 05:35:43 INFO - "basedir": "/builds/slave/test", 05:35:43 INFO - "nightly_build": "True", 05:35:43 INFO - "buildnumber": 187, 05:35:43 INFO - "slavename": "t-yosemite-r7-0020", 05:35:43 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:35:43 INFO - "platform": "yosemite_r7", 05:35:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:35:43 INFO - "branch": "mozilla-central", 05:35:43 INFO - "repo_path": "mozilla-central", 05:35:43 INFO - "revision": "91115264629dfaacf2d60d52a3eff89c18c5af0d", 05:35:43 INFO - "pgo_build": "False", 05:35:43 INFO - "builduid": "429190adabdc4754941ed0e71a4d0cdb", 05:35:43 INFO - "slavebuilddir": "test" 05:35:43 INFO - } 05:35:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:35:43 INFO - Running post-action listener: _resource_record_post_action 05:35:43 INFO - ##### 05:35:43 INFO - ##### Running download-and-extract step. 05:35:43 INFO - ##### 05:35:43 INFO - Running pre-action listener: _resource_record_pre_action 05:35:43 INFO - Running main action method: download_and_extract 05:35:43 INFO - mkdir: /builds/slave/test/build/tests 05:35:43 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')]} 05:35:43 INFO - https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:35:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:35:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:35:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:35:45 INFO - Downloaded 1199 bytes. 05:35:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:35:45 INFO - Using the following test package requirements: 05:35:45 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:35:45 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:35:45 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:35:45 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:35:45 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:35:45 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:35:45 INFO - u'jsshell-mac.zip'], 05:35:45 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:35:45 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:35:45 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:35:45 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:35:45 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:35:45 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:35:45 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:35:45 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:35:45 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:35:45 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:35:45 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:35:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:45 INFO - https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:35:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:35:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:35:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:35:46 INFO - Downloaded 18031292 bytes. 05:35:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:35:49 INFO - Return code: 0 05:35:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:49 INFO - https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:35:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:35:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:35:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:35:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:35:50 INFO - Downloaded 18031292 bytes. 05:35:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:35:54 INFO - Return code: 0 05:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:54 INFO - https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:35:55 INFO - Downloaded 10841076 bytes. 05:35:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:35:55 INFO - Return code: 0 05:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:55 INFO - https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:35:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:35:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:35:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:35:58 INFO - Downloaded 109974439 bytes. 05:35:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:35:58 INFO - mkdir: /builds/slave/test/properties 05:35:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:58 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:58 INFO - Contents: 05:35:58 INFO - build_url:https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:35:59 INFO - Running post-action listener: _resource_record_post_action 05:35:59 INFO - Running post-action listener: set_extra_try_arguments 05:35:59 INFO - ##### 05:35:59 INFO - ##### Running populate-webroot step. 05:35:59 INFO - ##### 05:35:59 INFO - Running pre-action listener: _resource_record_pre_action 05:35:59 INFO - Running main action method: populate_webroot 05:35:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:59 INFO - '--tppagecycles', 05:35:59 INFO - '7'], 05:35:59 INFO - 'tests': ['tsvgm']}}, 05:35:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:35:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:35:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:35:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:35:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:35:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'talos_options': ['--disable-e10s'], 05:35:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'talos_options': ['--disable-e10s'], 05:35:59 INFO - 'tests': ['damp', 'tps']}, 05:35:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'tests': ['damp', 'tps']}, 05:35:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:35:59 INFO - 'tests': ['dromaeo_dom']}, 05:35:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:35:59 INFO - 'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore', 05:35:59 INFO - 'tabpaint']}, 05:35:59 INFO - 'other-e10s': {'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore', 05:35:59 INFO - 'tabpaint']}, 05:35:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore', 05:35:59 INFO - 'tabpaint']}, 05:35:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore', 05:35:59 INFO - 'tabpaint']}, 05:35:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:35:59 INFO - 'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore', 05:35:59 INFO - 'tabpaint']}, 05:35:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:35:59 INFO - 'tests': ['a11yr', 05:35:59 INFO - 'ts_paint', 05:35:59 INFO - 'tpaint', 05:35:59 INFO - 'sessionrestore', 05:35:59 INFO - 'sessionrestore_no_auto_restore', 05:35:59 INFO - 'tabpaint']}, 05:35:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:35:59 INFO - 'tests': ['tsvgx', 05:35:59 INFO - 'tsvgr_opacity', 05:35:59 INFO - 'tart', 05:35:59 INFO - 'tscrollx', 05:35:59 INFO - 'cart']}, 05:35:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:35:59 INFO - 'tsvgr_opacity', 05:35:59 INFO - 'tart', 05:35:59 INFO - 'tscrollx', 05:35:59 INFO - 'cart']}, 05:35:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'talos_options': ['--disable-e10s'], 05:35:59 INFO - 'tests': ['tp5o']}, 05:35:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'tests': ['tp5o']}, 05:35:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'talos_options': ['--disable-e10s', 05:35:59 INFO - '--xperf_path', 05:35:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:59 INFO - 'tests': ['tp5n']}, 05:35:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:59 INFO - 'talos_options': ['--xperf_path', 05:35:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:59 INFO - 'tests': ['tp5n']}}, 05:35:59 INFO - 'talos.zip': {'path': '', 05:35:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:59 INFO - Running post-action listener: _resource_record_post_action 05:35:59 INFO - ##### 05:35:59 INFO - ##### Running create-virtualenv step. 05:35:59 INFO - ##### 05:35:59 INFO - Running pre-action listener: _resource_record_pre_action 05:35:59 INFO - Running main action method: create_virtualenv 05:35:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35:59 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 05:35:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:59 INFO - Using real prefix '/tools/python27' 05:35:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:36:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:36:03 INFO - Installing pip.................done. 05:36:03 INFO - Return code: 0 05:36:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1051c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051d7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa813c99b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105066e00>, '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 0x104ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105061b20>, '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.kkCteiba0w/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.O3CDZp5x96/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 05:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kkCteiba0w/Render', 05:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:03 INFO - 'HOME': '/Users/cltbld', 05:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:03 INFO - 'LOGNAME': 'cltbld', 05:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:03 INFO - 'MOZ_NO_REMOTE': '1', 05:36:03 INFO - 'NO_EM_RESTART': '1', 05:36:03 INFO - 'PAGER': '/bin/cat', 05:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:03 INFO - 'PWD': '/builds/slave/test', 05:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:03 INFO - 'SHELL': '/bin/bash', 05:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3CDZp5x96/Listeners', 05:36:03 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 05:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:03 INFO - 'USER': 'cltbld', 05:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:03 INFO - 'XPC_FLAGS': '0x0', 05:36:03 INFO - 'XPC_SERVICE_NAME': '0', 05:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:03 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 05:36:03 INFO - Cleaning up... 05:36:03 INFO - Return code: 0 05:36:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1051c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051d7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa813c99b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105066e00>, '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 0x104ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105061b20>, '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.kkCteiba0w/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.O3CDZp5x96/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 05:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kkCteiba0w/Render', 05:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:03 INFO - 'HOME': '/Users/cltbld', 05:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:03 INFO - 'LOGNAME': 'cltbld', 05:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:03 INFO - 'MOZ_NO_REMOTE': '1', 05:36:03 INFO - 'NO_EM_RESTART': '1', 05:36:03 INFO - 'PAGER': '/bin/cat', 05:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:03 INFO - 'PWD': '/builds/slave/test', 05:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:03 INFO - 'SHELL': '/bin/bash', 05:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3CDZp5x96/Listeners', 05:36:03 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 05:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:03 INFO - 'USER': 'cltbld', 05:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:03 INFO - 'XPC_FLAGS': '0x0', 05:36:03 INFO - 'XPC_SERVICE_NAME': '0', 05:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:03 INFO - Downloading/unpacking psutil>=0.7.1 05:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:06 INFO - Installing collected packages: psutil 05:36:06 INFO - Running setup.py install for psutil 05:36:06 INFO - building 'psutil._psutil_osx' extension 05:36:06 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 05:36:06 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 05:36:06 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 05:36:07 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 05:36:07 INFO - building 'psutil._psutil_posix' extension 05:36:07 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 05:36:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:36:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:36:07 INFO - ^ 05:36:07 INFO - 1 warning generated. 05:36:07 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 05:36:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:07 INFO - Successfully installed psutil 05:36:07 INFO - Cleaning up... 05:36:07 INFO - Return code: 0 05:36:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:36:07 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')]} 05:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:07 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')]} 05:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:07 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 0x1051c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051d7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa813c99b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105066e00>, '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 0x104ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105061b20>, '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.kkCteiba0w/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.O3CDZp5x96/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 05:36:07 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 05:36:07 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 05:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kkCteiba0w/Render', 05:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:07 INFO - 'HOME': '/Users/cltbld', 05:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:07 INFO - 'LOGNAME': 'cltbld', 05:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:07 INFO - 'MOZ_NO_REMOTE': '1', 05:36:07 INFO - 'NO_EM_RESTART': '1', 05:36:07 INFO - 'PAGER': '/bin/cat', 05:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:07 INFO - 'PWD': '/builds/slave/test', 05:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:07 INFO - 'SHELL': '/bin/bash', 05:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3CDZp5x96/Listeners', 05:36:07 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 05:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:07 INFO - 'USER': 'cltbld', 05:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:07 INFO - 'XPC_FLAGS': '0x0', 05:36:07 INFO - 'XPC_SERVICE_NAME': '0', 05:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:36:10 INFO - Installing collected packages: mozsystemmonitor 05:36:10 INFO - Running setup.py install for mozsystemmonitor 05:36:10 INFO - Successfully installed mozsystemmonitor 05:36:10 INFO - Cleaning up... 05:36:10 INFO - Return code: 0 05:36:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1051c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051d7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa813c99b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105066e00>, '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 0x104ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105061b20>, '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.kkCteiba0w/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.O3CDZp5x96/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 05:36:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:36:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kkCteiba0w/Render', 05:36:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:10 INFO - 'HOME': '/Users/cltbld', 05:36:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:10 INFO - 'LOGNAME': 'cltbld', 05:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:10 INFO - 'MOZ_NO_REMOTE': '1', 05:36:10 INFO - 'NO_EM_RESTART': '1', 05:36:10 INFO - 'PAGER': '/bin/cat', 05:36:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:10 INFO - 'PWD': '/builds/slave/test', 05:36:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:10 INFO - 'SHELL': '/bin/bash', 05:36:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3CDZp5x96/Listeners', 05:36:10 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 05:36:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:10 INFO - 'USER': 'cltbld', 05:36:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:10 INFO - 'XPC_FLAGS': '0x0', 05:36:10 INFO - 'XPC_SERVICE_NAME': '0', 05:36:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:10 INFO - Downloading/unpacking blobuploader==1.2.4 05:36:10 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 05:36:10 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 05:36:10 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 05:36:10 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 05:36:10 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 05:36:10 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 05:36:13 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:36:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:14 INFO - Downloading docopt-0.6.1.tar.gz 05:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:14 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:14 INFO - Running setup.py install for blobuploader 05:36:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:36:14 INFO - Running setup.py install for requests 05:36:14 INFO - Running setup.py install for docopt 05:36:15 INFO - Successfully installed blobuploader requests docopt 05:36:15 INFO - Cleaning up... 05:36:15 INFO - Return code: 0 05:36:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:15 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 0x1051c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051d7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa813c99b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105066e00>, '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 0x104ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105061b20>, '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.kkCteiba0w/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.O3CDZp5x96/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 05:36:15 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 05:36:15 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 05:36:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kkCteiba0w/Render', 05:36:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:15 INFO - 'HOME': '/Users/cltbld', 05:36:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:15 INFO - 'LOGNAME': 'cltbld', 05:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:15 INFO - 'MOZ_NO_REMOTE': '1', 05:36:15 INFO - 'NO_EM_RESTART': '1', 05:36:15 INFO - 'PAGER': '/bin/cat', 05:36:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:15 INFO - 'PWD': '/builds/slave/test', 05:36:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:15 INFO - 'SHELL': '/bin/bash', 05:36:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3CDZp5x96/Listeners', 05:36:15 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 05:36:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:15 INFO - 'USER': 'cltbld', 05:36:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:15 INFO - 'XPC_FLAGS': '0x0', 05:36:15 INFO - 'XPC_SERVICE_NAME': '0', 05:36:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-SGv06Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Y1g1c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Oc6pI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-PFv7I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-v2jqqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:15 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-bBB8db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-l3DlKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-HLuT9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-WXyZsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Otv2jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-IcgWX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-HWIPfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-IN6F6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Oo8SYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:16 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-9LdeHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:17 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-mqbpD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:17 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-gczeTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:17 INFO - Running setup.py install for manifestparser 05:36:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:36:17 INFO - Running setup.py install for mozcrash 05:36:17 INFO - Running setup.py install for mozdebug 05:36:17 INFO - Running setup.py install for mozdevice 05:36:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:36:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:36:17 INFO - Running setup.py install for mozfile 05:36:18 INFO - Running setup.py install for mozhttpd 05:36:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Running setup.py install for mozinfo 05:36:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Running setup.py install for mozInstall 05:36:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Running setup.py install for mozleak 05:36:18 INFO - Running setup.py install for mozlog 05:36:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Running setup.py install for moznetwork 05:36:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:36:18 INFO - Running setup.py install for mozprocess 05:36:19 INFO - Running setup.py install for mozprofile 05:36:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:36:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:36:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:36:19 INFO - Running setup.py install for mozrunner 05:36:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:36:19 INFO - Running setup.py install for mozscreenshot 05:36:19 INFO - Running setup.py install for moztest 05:36:19 INFO - Running setup.py install for mozversion 05:36:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:36:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:19 INFO - Cleaning up... 05:36:19 INFO - Return code: 0 05:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:19 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 0x1051c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051d7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa813c99b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105066e00>, '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 0x104ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105061b20>, '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.kkCteiba0w/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.O3CDZp5x96/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 05:36:19 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 05:36:19 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 05:36:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kkCteiba0w/Render', 05:36:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:19 INFO - 'HOME': '/Users/cltbld', 05:36:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:19 INFO - 'LOGNAME': 'cltbld', 05:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:19 INFO - 'MOZ_NO_REMOTE': '1', 05:36:19 INFO - 'NO_EM_RESTART': '1', 05:36:19 INFO - 'PAGER': '/bin/cat', 05:36:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:19 INFO - 'PWD': '/builds/slave/test', 05:36:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:19 INFO - 'SHELL': '/bin/bash', 05:36:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3CDZp5x96/Listeners', 05:36:19 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 05:36:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:19 INFO - 'USER': 'cltbld', 05:36:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:19 INFO - 'XPC_FLAGS': '0x0', 05:36:19 INFO - 'XPC_SERVICE_NAME': '0', 05:36:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-sUobSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-AMyQOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-BDZfeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-66BIxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-_6RY0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-M8CCPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-akHkqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:20 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)) 05:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:20 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-2Tu5Qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:21 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-ORr3Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:21 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-o2VmV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:21 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-_hUzYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:21 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-wfQ0hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:21 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-EngtlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:21 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-2Uxe_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:21 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-RBsvVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:21 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-nuB8c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:21 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)) 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:21 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-6TrnhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:22 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)) 05:36:22 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)) 05:36:22 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)) 05:36:22 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)) 05:36:22 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)) 05:36:22 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)) 05:36:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:24 INFO - Downloading blessings-1.6.tar.gz 05:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:24 INFO - Installing collected packages: blessings 05:36:24 INFO - Running setup.py install for blessings 05:36:24 INFO - Successfully installed blessings 05:36:24 INFO - Cleaning up... 05:36:24 INFO - Return code: 0 05:36:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:25 INFO - Reading from file tmpfile_stdout 05:36:25 INFO - Current package versions: 05:36:25 INFO - blessings == 1.6 05:36:25 INFO - blobuploader == 1.2.4 05:36:25 INFO - docopt == 0.6.1 05:36:25 INFO - manifestparser == 1.1 05:36:25 INFO - mozInstall == 1.12 05:36:25 INFO - mozcrash == 0.17 05:36:25 INFO - mozdebug == 0.1 05:36:25 INFO - mozdevice == 0.48 05:36:25 INFO - mozfile == 1.2 05:36:25 INFO - mozhttpd == 0.7 05:36:25 INFO - mozinfo == 0.9 05:36:25 INFO - mozleak == 0.1 05:36:25 INFO - mozlog == 3.1 05:36:25 INFO - moznetwork == 0.27 05:36:25 INFO - mozprocess == 0.22 05:36:25 INFO - mozprofile == 0.28 05:36:25 INFO - mozrunner == 6.11 05:36:25 INFO - mozscreenshot == 0.1 05:36:25 INFO - mozsystemmonitor == 0.0 05:36:25 INFO - moztest == 0.7 05:36:25 INFO - mozversion == 1.4 05:36:25 INFO - psutil == 3.1.1 05:36:25 INFO - requests == 1.2.3 05:36:25 INFO - wsgiref == 0.1.2 05:36:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36: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')]} 05:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:25 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 0x1051c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051d7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa813c99b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105066e00>, '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 0x104ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105061b20>, '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.kkCteiba0w/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.O3CDZp5x96/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 05:36:25 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 05:36:25 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 05:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kkCteiba0w/Render', 05:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:25 INFO - 'HOME': '/Users/cltbld', 05:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:25 INFO - 'LOGNAME': 'cltbld', 05:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:25 INFO - 'MOZ_NO_REMOTE': '1', 05:36:25 INFO - 'NO_EM_RESTART': '1', 05:36:25 INFO - 'PAGER': '/bin/cat', 05:36:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:25 INFO - 'PWD': '/builds/slave/test', 05:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:25 INFO - 'SHELL': '/bin/bash', 05:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3CDZp5x96/Listeners', 05:36:25 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 05:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:25 INFO - 'USER': 'cltbld', 05:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:25 INFO - 'XPC_FLAGS': '0x0', 05:36:25 INFO - 'XPC_SERVICE_NAME': '0', 05:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 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)) 05:36:25 INFO - Cleaning up... 05:36:25 INFO - Return code: 0 05:36:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:36: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')]} 05:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1051c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051d7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa813c99b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105066e00>, '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 0x104ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105061b20>, '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.kkCteiba0w/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.O3CDZp5x96/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 05:36: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', 'jsonschema'] in /builds/slave/test/build 05:36: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 jsonschema 05:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kkCteiba0w/Render', 05:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:25 INFO - 'HOME': '/Users/cltbld', 05:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:25 INFO - 'LOGNAME': 'cltbld', 05:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:25 INFO - 'MOZ_NO_REMOTE': '1', 05:36:25 INFO - 'NO_EM_RESTART': '1', 05:36:25 INFO - 'PAGER': '/bin/cat', 05:36:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:25 INFO - 'PWD': '/builds/slave/test', 05:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:25 INFO - 'SHELL': '/bin/bash', 05:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3CDZp5x96/Listeners', 05:36:25 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 05:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:25 INFO - 'USER': 'cltbld', 05:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:25 INFO - 'XPC_FLAGS': '0x0', 05:36:25 INFO - 'XPC_SERVICE_NAME': '0', 05:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:25 INFO - Downloading/unpacking jsonschema 05:36:25 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 05:36:25 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 05:36:25 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 05:36:25 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 05:36:25 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 05:36:25 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 05:36:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:36:27 INFO - Downloading/unpacking functools32 (from jsonschema) 05:36:27 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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:28 INFO - Downloading functools32-3.2.3-2.tar.gz 05:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:36:28 INFO - warning: no files found matching '*.txt' 05:36:28 INFO - no previously-included directories found matching 'build' 05:36:28 INFO - no previously-included directories found matching 'dist' 05:36:28 INFO - no previously-included directories found matching '.git*' 05:36:28 INFO - Installing collected packages: jsonschema, functools32 05:36:28 INFO - Running setup.py install for functools32 05:36:28 INFO - warning: no files found matching '*.txt' 05:36:28 INFO - no previously-included directories found matching 'build' 05:36:28 INFO - no previously-included directories found matching 'dist' 05:36:28 INFO - no previously-included directories found matching '.git*' 05:36:28 INFO - Successfully installed jsonschema functools32 05:36:28 INFO - Cleaning up... 05:36:28 INFO - Return code: 0 05:36:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:28 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 0x1051c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051d7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa813c99b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105066e00>, '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 0x104ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105061b20>, '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.kkCteiba0w/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.O3CDZp5x96/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 05:36:28 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 05:36:28 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 05:36:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kkCteiba0w/Render', 05:36:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:28 INFO - 'HOME': '/Users/cltbld', 05:36:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:28 INFO - 'LOGNAME': 'cltbld', 05:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:28 INFO - 'MOZ_NO_REMOTE': '1', 05:36:28 INFO - 'NO_EM_RESTART': '1', 05:36:28 INFO - 'PAGER': '/bin/cat', 05:36:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:28 INFO - 'PWD': '/builds/slave/test', 05:36:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:28 INFO - 'SHELL': '/bin/bash', 05:36:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3CDZp5x96/Listeners', 05:36:28 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 05:36:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:28 INFO - 'USER': 'cltbld', 05:36:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:28 INFO - 'XPC_FLAGS': '0x0', 05:36:28 INFO - 'XPC_SERVICE_NAME': '0', 05:36:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:29 INFO - Downloading/unpacking flake8 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:36:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:36:31 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 05:36:31 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 05:36:31 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 05:36:31 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 05:36:31 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 05:36:31 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 05:36:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:36:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:36:32 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 05:36:32 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 05:36:32 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 05:36:32 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 05:36:32 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 05:36:32 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 05:36:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:36:32 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 05:36:32 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 05:36:32 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 05:36:32 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 05:36:32 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 05:36:32 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 05:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:36:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:36:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:36:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:36:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:36:32 INFO - no previously-included directories found matching 'docs/_build' 05:36:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:36:33 INFO - Running setup.py install for pep8 05:36:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:36:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:36:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:36:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:36:33 INFO - no previously-included directories found matching 'docs/_build' 05:36:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:36:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:36:33 INFO - Cleaning up... 05:36:33 INFO - Return code: 0 05:36:33 INFO - Running post-action listener: _resource_record_post_action 05:36:33 INFO - Running post-action listener: _start_resource_monitoring 05:36:33 INFO - Starting resource monitoring. 05:36:33 INFO - ##### 05:36:33 INFO - ##### Running install step. 05:36:33 INFO - ##### 05:36:33 INFO - Running pre-action listener: _resource_record_pre_action 05:36:33 INFO - Running main action method: install 05:36:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:33 INFO - Reading from file tmpfile_stdout 05:36:33 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:36:33 INFO - Reading from file tmpfile_stdout 05:36:33 INFO - Output received: 05:36:33 INFO - Usage: mozinstall [options] installer 05:36:33 INFO - Options: 05:36:33 INFO - -h, --help show this help message and exit 05:36:33 INFO - -d DEST, --destination=DEST 05:36:33 INFO - Directory to install application into. [default: 05:36:33 INFO - "/builds/slave/test"] 05:36:33 INFO - --app=APP Application being installed. [default: firefox] 05:36:33 INFO - mkdir: /builds/slave/test/build/application 05:36:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:37:07 INFO - Reading from file tmpfile_stdout 05:37:07 INFO - Output received: 05:37:07 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:37:07 INFO - Running post-action listener: _resource_record_post_action 05:37:07 INFO - ##### 05:37:07 INFO - ##### Running run-tests step. 05:37:07 INFO - ##### 05:37:07 INFO - Running pre-action listener: _resource_record_pre_action 05:37:07 INFO - Running main action method: run_tests 05:37:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:37:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:37:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:37:07 INFO - 2016-04-14 05:37:07.276 screenresolution[6134:102973] starting screenresolution argv=screenresolution get 05:37:07 INFO - 2016-04-14 05:37:07.279 screenresolution[6134:102973] Display 0: 1600x1200x32@60 05:37:07 INFO - 2016-04-14 05:37:07.284 screenresolution[6135:102975] starting screenresolution argv=screenresolution list 05:37:07 INFO - Available Modes on Display 0 05:37:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:37:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:37:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:37:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:37:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:37:07 INFO - Intel Iris: 05:37:07 INFO - Chipset Model: Intel Iris 05:37:07 INFO - Type: GPU 05:37:07 INFO - Bus: Built-In 05:37:07 INFO - VRAM (Dynamic, Max): 1536 MB 05:37:07 INFO - Vendor: Intel (0x8086) 05:37:07 INFO - Device ID: 0x0a2e 05:37:07 INFO - Revision ID: 0x0009 05:37:07 INFO - Displays: 05:37:07 INFO - Display: 05:37:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:37:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:37:07 INFO - Display Serial Number: 1600x1200 60 05:37:07 INFO - Main Display: Yes 05:37:07 INFO - Mirror: Off 05:37:07 INFO - Online: Yes 05:37:07 INFO - Rotation: Supported 05:37:07 INFO - Return code: 0 05:37:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:37:07 INFO - Python 2.7.3 05:37:07 INFO - Return code: 0 05:37:07 INFO - grabbing minidump binary from tooltool 05:37:07 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')]} 05:37:07 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 0x105066e00>, '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 0x104ecfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105061b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:37:07 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 05:37:07 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 05:37:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:07 INFO - Return code: 0 05:37:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:37:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:37:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:37:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:37:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:37:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:37:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:37:08 INFO - Return code: 0 05:37:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:37:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kkCteiba0w/Render', 05:37:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:08 INFO - 'HOME': '/Users/cltbld', 05:37:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:08 INFO - 'LOGNAME': 'cltbld', 05:37:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:37:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:08 INFO - 'MOZ_NO_REMOTE': '1', 05:37:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:37:08 INFO - 'NO_EM_RESTART': '1', 05:37:08 INFO - 'PAGER': '/bin/cat', 05:37:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:08 INFO - 'PWD': '/builds/slave/test', 05:37:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:37:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:08 INFO - 'SHELL': '/bin/bash', 05:37:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3CDZp5x96/Listeners', 05:37:08 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 05:37:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:08 INFO - 'USER': 'cltbld', 05:37:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:08 INFO - 'XPC_FLAGS': '0x0', 05:37:08 INFO - 'XPC_SERVICE_NAME': '0', 05:37:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:37:09 INFO - mozversion application_buildid: 20160414030247 05:37:09 INFO - mozversion application_changeset: 91115264629dfaacf2d60d52a3eff89c18c5af0d 05:37:09 INFO - mozversion application_display_name: Nightly 05:37:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:09 INFO - mozversion application_name: Firefox 05:37:09 INFO - mozversion application_remotingname: firefox 05:37:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:37:09 INFO - mozversion application_vendor: Mozilla 05:37:09 INFO - mozversion application_version: 48.0a1 05:37:09 INFO - mozversion platform_buildid: 20160414030247 05:37:09 INFO - mozversion platform_changeset: 91115264629dfaacf2d60d52a3eff89c18c5af0d 05:37:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:37:09 INFO - mozversion platform_version: 48.0a1 05:37:09 INFO - using testdate: 1460637429 05:37:09 INFO - actual date: 1460637429 05:37:09 INFO - starting webserver on 'localhost:56402' 05:37:09 INFO - SUITE-START | Running 2 tests 05:37:09 INFO - TEST-START | dromaeo_css 05:37:09 INFO - operating with platform_type : mac_ 05:37:09 INFO - Initialising browser for dromaeo_css test... 05:37:09 INFO - TEST-INFO | started process 6153 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpjnbFu5/profile http://localhost:56402/getInfo.html) 05:37:11 INFO - PROCESS | 6153 | JavaScript error: jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:37:12 INFO - PROCESS | 6153 | __metrics Screen width/height:1600/1200 05:37:12 INFO - PROCESS | 6153 | colorDepth:24 05:37:12 INFO - PROCESS | 6153 | Browser inner width/height: 1024/689 05:37:12 INFO - PROCESS | 6153 | __metrics 05:37:12 ERROR - PROCESS | 6153 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:37:12 INFO - TEST-INFO | 6153: exit 0 05:37:12 INFO - Browser initialized. 05:37:12 INFO - Running cycle 1/1 for dromaeo_css test... 05:37:12 INFO - TEST-INFO | started process 6158 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpjnbFu5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:24 INFO - PROCESS | 6158 | RSS: Main: 247902208 05:37:24 INFO - PROCESS | 6158 | 05:38:14 INFO - PROCESS | 6158 | 1460637494447 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] 05:40:24 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:56402/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56402/tests/dromaeo/cssquery-ext.html) 05:40:26 INFO - PROCESS | 6158 | RSS: Main: 260177920 05:40:26 INFO - PROCESS | 6158 | 05:43:28 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:56402/tests/dromaeo/cssquery-ext.html (next: http://localhost:56402/tests/dromaeo/cssquery-jquery.html) 05:43:28 INFO - PROCESS | 6158 | RSS: Main: 271761408 05:43:28 INFO - PROCESS | 6158 | 05:46:30 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:56402/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56402/tests/dromaeo/cssquery-mootools.html) 05:46:31 INFO - PROCESS | 6158 | RSS: Main: 273874944 05:46:31 INFO - PROCESS | 6158 | 05:49:33 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:56402/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56402/tests/dromaeo/cssquery-prototype.html) 05:49:33 INFO - PROCESS | 6158 | RSS: Main: 275406848 05:49:33 INFO - PROCESS | 6158 | 05:52:36 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:56402/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56402/tests/dromaeo/cssquery-yui.html) 05:52:37 INFO - PROCESS | 6158 | RSS: Main: 278249472 05:52:37 INFO - PROCESS | 6158 | 05:55:39 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:56402/tests/dromaeo/cssquery-yui.html (next: http://localhost:56402/tests/dromaeo/cssquery-dojo.html) 05:55:39 INFO - PROCESS | 6158 | RSS: Main: 279326720 05:55:39 INFO - PROCESS | 6158 | 05:55:39 INFO - PROCESS | 6158 | __start_tp_report 05:55:39 INFO - PROCESS | 6158 | _x_x_mozilla_page_load 05:55:39 INFO - PROCESS | 6158 | _x_x_mozilla_page_load_details 05:55:39 INFO - PROCESS | 6158 | |i|pagename|runs| 05:55:39 INFO - PROCESS | 6158 | |0;dojo.html;2962.3334749681326;3462.532558104656;3506.9298614027703;3517;3552.609212986569;5864.09106588479;5870.471657550819;5911.438413350736;5911.793087241947;5914.112883067532;5429.212764149196;5775.682337471438;5861.618994765348;5933.288005439343;6043.6675982820925;5217.191335343028;5283.28675628789;5308.787648494055;5318.813841515548;5352.678839269656;232.34309800184943;5246.7638956247065;5272.340957380327;5329.840104796862;5336.866578335534;5316.840494785162;5325.174597937326;5328.973355133238;5336.43967383423;5370.865728356784;5304.814331498417;5326.493983071641;5344.812931547416;5356.250124982505;5361.624686271963;4423.827685663302;5205.401378841444;5230.34620672416;5270.235815806686;5365.865853353658;4720.33915251865;5659.26429564154;5738.626989245686;5786.276715410574;5819.214406055171;6155.938440615581;6209.0996805462955;6267.874642507124;6272.2159730033745;6285.842853928642;5655.3779084300695;5992.820215393545;6217.626942383471;6278.058291256302;6290.276618188876;4814.927776083362;5895.734691938873;5899.46904778572;5901.02633065548;5911.674857882815;6228.408301211378;6356.078368636614;6357.936420635827;6363.140975968185;6380.521460890452;5352.464753524617;6196.969015154986;6240.219972503437;6289.842753931189;6291.496680265568;5249.763760630781;5266.683998960075;6271.404216599416;6279.246490421178;6335.651539165298;5027.899442011139;6207.348228435949;6284.780032698925;6289.308176100625;6307.274663413675;6280.309165991737;6281.214848143982;6287;6287.717052732638;6290.182276304051;5020.1214787412055;5027.572656324181;5043.092243396224;5046.9747651261505;5048.3941926969;3791.848326066982;4431.268840641258;4508.106595230011;4561.612262957686;4610.608098311614;5755.798547050917;5895.322037965603;5916.1421593868645;6006.489448396847;6040.7885724000325;6278.434940855345;6307.621542707452;6314.463270621956;6341.904871426932;6342.714577844008;5792;5896.911546326808;5939.940600594025;5953.077273022688;6009.729562169713;5504.119340905436;5522.061249587579;5529.419410961871;5542.97228513863;5551.7779288828;6512.446442052478;6533.346665333429;6546.672666366662;6550.443212326911;6550.901736473957;6165.568410211242;6262.060690896402;6288.213973253343;6347;6368.490520758235;6502;6523.869522609426;6528.608283503005;6544.3782840630065;6546;6254.874902502015;6294.685265736786;6301.117843501822;6306.054091886253;6318.62088274705;6197.81406557804;6226.470749986302;6256.873762722754;6281.560290779785;6305;6250.218722659668;6267.592606480564;6274.121622972696;6284.057391391328;6299.433051025429;6137.693115344304;6206.596571222856;6272.968635156795;6284.685765711604;6303.117563541016;5391.595630327663;6113.081058499921;6114.357992410733;6198.566100373111;6222.973209420395;5803.65178089316;6061.878762424815;6244.812655620339;6287.71705273273;6288.748450061947;6015;6092.329843717099;6145.446909778141;6160.845978850564;6189.226346706661 05:55:39 INFO - PROCESS | 6158 | |1;ext.html;499.2261993909439;513.2429666242292;517.9020476589629;582.7202942587561;670.8926571748522;37140.62859371406;37823.054423639456;37935.620643793554;37998.24003519928;38204;39348.60651393485;40066.39900401489;40078.59921400785;40124.59875401245;40416.79791601045;9319.161275485205;9545.236381089497;9560.13958743713;9571.138597526222;9572.760680982996;9392.436453812794;9526.428414295164;9566.37818541796;9581.041895810433;9612.51937403127;9635.710928672152;9667.468289244089;9710.66012689556;9721.125098741111;9737.902620973806;8121.025476942746;9608.2793790466;9649.662261820838;9716.75708107296;9727.951360243154;8549.145085491464;9416.058394160598;9565.282603804673;9650.034996500364;9690.224782017422;38285.234295314214;38643;38745;38782.41826372607;38811.22377552462;2791.7208279172123;2974.975728636252;3001.2346851552934;3047.8171309721265;3400.897973060812;26725.73274267252;26743.197704068716;26839.24250604917;27208.1837544872;27251.727482725317;2588.9482210355877;2591.676040494938;2651.178134778225;2677.3842016336157;2715.701272859984;375361;377758;378471;379299;380038;34582.481262781075;34757;35016.12459688477;35036.64963350385;35063.4740478893;36152.09619759474;36311.273774524365;68600;70694.64652676704;70976.290237098;15483.612909677347;15853.286602102933;15924.442644507619;15983.44057957966;16015.439459618858;12631.747365052648;12848.357582120856;12857.807132893015;12983.675408114872;13011.414486348138;19832.008399579965;20012.499687507636;20177.899110504648;20208.797912020986;20218.59562808765;8594.22651961314;8625.765337998251;8659.350548708871;8707.869381959275;8727.563621818883;968.4963818814177;1007.838745800683;1051.5951358726945;1085.7882712870914;1095.1512577752305;29934.251643708645;29953;30194.698053019627;30654.846725766227;30887.2278193047;1075.0432115417284;1085;1091.4324551233315;1157.9710507237387;1176.2178151529138;14708;14842.419186444282;14995.925020375047;15248.771268430983;15261.465848695465;624871;630026;631208;634492;639583;59123.40876591265;59428;60040.39959600348;60323.09515357273;60862;1365.7883028130457;1429.463951018368;1456.83974762776;1488.2335597167466;1488.3302513868803;24469.877650611634;26826.597601036392;27606.861965690045;28165.43669126647;29049.7095029047;42515.7874210627;51107.744461277456;51269.743651281504;51964.220536691224;51969;582109;582230;583613;585673;589171;23842.642360364956;25288.494230115663;26784.866075669495;26825;27176.048838290564;46142;46267.3059904095;46407.303890441;46799.298010529186;47535.76232118817;29772.55341169841;37205;37688;38087.61912380841;39025.60974390333;31803.363932721677;37104.81447592745;37411.877643670734;37485.43771843479;37571;37525.65171585568;38125.046873828374;38397.61602384052;38638.42042369423;39054.4141837867;27775.027874024312;27949.441011179257;31864.044078677678;31917.20206994844;31941;23544.29367118989;25005.499890002462;25155;25232.495350093264;25310.240692779247 05:55:39 INFO - PROCESS | 6158 | |2;jquery.html;366.95413073365813;374.6403452685422;391.44024045614793;393.89512417668436;411.4753689046467;19006;20128.59742805143;21108.894455527738;21205.57588848222;21292.574148517022;11794.469248883799;11848.229865058765;11937.701557461069;12144.149909506337;12232;5345.224942383362;5504.2294078829;5547.805826796063;5548.278723765905;5549.861253468655;3211.807291562502;4540.318952157169;6160.322364539897;6169.7532098716;6177.783777567786;6094.939050609503;6131.325554189036;6175.042868355412;6228.065790131472;6262.780802671908;6607.372299631527;6635.900461493057;6644.335566443317;6661.766838160665;6664;5700.942990570083;5859.589828711992;5886.117082437626;5906.025505791539;5928.110783382484;13453.730925381535;13488.527901523497;13597.864021359857;19833.702494462595;22926.96828642715;1903.7620297462818;2068.33813179781;2187.475005998549;2327.0691723310642;2470.9621958777357;9777.560009799576;9785.902140978571;9900.900990990142;10206.744831379201;14862.103426159378;1719.6474722681821;1747.5194321561546;1774.4321817018558;1789.1322708486373;1792.9193186306647;86253.56873215656;101348.49325753398;119664;124565;126659;9176.816463670822;9861.063198996084;11462.312261264184;11849.466773995191;11882.28706277626;15140.848591514165;15175.772363414557;15202.847971520365;15272.847271527366;15320.540383788504;8557.657693692183;8697.695580654647;8719.825603487894;8784.297256219486;8789.208971192624;7047.92952070483;8424.831503369898;8568.143185681507;8695.521746303888;8708.606622940299;3873.573906870242;4574.588287054181;4649.907001860011;4660.231061874752;4710.882227944328;1654.6359800843795;1679.6976544221914;1860.4976656302993;1981.6135853508426;1984.2658216460002;832.0680837462081;937.1846493550519;958.1616085924816;1052.7157667429904;1077.4074259157433;17192.31230750781;17243.655126897644;17374.913125434545;20440.182392704126;20544.178232870818;976.9218462522981;978.280963491833;1033.6692258477215;1033.994830025845;1046.6450486405588;8981.595828187617;9303.395279306824;9680.806383872425;9736.513174341255;10542.26204165701;606756;609740;617304;620089;623388;126726;129236.3538182303;129311.35344323218;129915.84313999394;131375;1027.429776474064;1032.8915463876185;1043.2644985285203;1052.6315789473622;1055.118975655321;17867.73198401999;17885.821141788936;17887.01621410835;17899.10504474745;18243.905365678103;47061.05877882355;49530.00939981252;49649;49979.250311244636;50433.49566504435;66485.66757166183;70506.29493705202;73229.26770732438;73449.6327518359;74191;7967.760967170994;7971.800704982422;8130.552819594979;8140.75577732669;8409.621567029377;9611.327207095715;11779.352135632622;12423.503059877865;12545.560905368633;12636.747265054464;5082.034413461431;10786.191035672513;10984.462175295625;11014.889851101387;11095.944520277348;10455.94772026135;10786.892131078588;10866.891331086905;11122.332660040423;11345.376004319842;10749.903247893979;10960.397178154959;11199.888001119885;11491;11544.538218471167;8157.225063619184;8202.671893124209;8302.418830682036;8377.95811020941;8386.832263354576;10508.001739834703;10593.682189534326;11235.7752844941;11464.713382165513;11473.713157171138 05:55:39 INFO - PROCESS | 6158 | |3;mootools.html;1352.9797053044203;1492.2762460206798;1566.6005168681984;1781.9198136083876;1916.4538106639593;7871.173526779691;8279.875801862969;8459.450135741172;8500.787480312994;8529.57352132394;8510.914890851089;8532.70135545256;8604;8629;8727.127287271269;2061.5569101628844;2076.3148161106874;2440.4386990992084;2451.950960980779;2452.534018536481;2411.3730430088217;2433.3429973907037;2441.023590563771;2454.361865914866;2473.837296470665;2426.7694569015916;2438.5732496813075;2439.609662454008;2459.754024597544;2471.752824717532;2434.318390850547;2436.52487764885;2453.7178224504232;2454.7299797022315;2470;2416.1905761569897;2433.9513209735705;2458.0905065126017;2465.7410971848058;2468.5062987402594;8652.653893844239;8774;8782.077881822444;8792.208701216858;8806;5166.7416629168765;5294.258803767476;5298.576113910878;5336.092864213054;5358;3549.8757543485854;3576.409892367756;3582.265635544707;3611;3647.6534729200685;990.9207263418981;1044.107288268527;1046.215338496128;1063.5798859450551;1070.7430216748003;11394.259373140801;11407.144464165138;11460.541578336857;11541.365224912626;11565.710857228552;4280.571942805756;4631.722096674143;4839.879003024953;4842.491538388489;4872.902541949141;7809;9703.66037188695;9775.560099795526;9780.119789219005;9787.608495660093;5307.867303317371;5328.200769884548;5333.200019997032;5337.386200586904;5337.786488540415;4386.627136693417;4715.976420117878;4890.926636100461;4899.265110233422;4906.901861962812;3998.140399814054;4019.055521952339;4096.713230073866;4130.586941305845;4137.234611596864;1319.6766792135795;1361.6035777032494;1363.7136201397818;1365.4469939674448;1366.1666383506054;893.9284857211408;909.3043821476575;912.0924679943498;928.944263344188;938.6389734884308;5911.527077833763;5937.762489500372;6047.12316714074;6048.0625503047095;6085.269767627913;441.5849101844256;452.0597157911536;457.3505622016744;468.98358557450325;469.77450823604863;3949.269385163754;4009.498812648419;4051.311277082903;4066.9796651016554;4075.184963007351;8183.918160818434;10515.474226288808;10575.471226438647;10715.24993250465;10731.785364292671;10382.065614094769;10493.842592361121;10543.947280263703;10581.735456613493;10656.094231990368;6708.597484150967;8041.517508949481;8090.826830109719;8101.987251593669;8209.220124088202;5783.797567085132;5784.50831679312;5831.620944638585;5906.793262235801;5915.645061296336;9792.412455252708;9838.852417213604;9840.852387214341;9864.802703945737;9897.50512474359;8993.605991071394;9382.296327775308;9561.330706850455;9607.13535781783;10087.445190514592;6982.371586557031;7328.303811138147;7516.210797866145;7981.8403631928195;8180.509169449852;7047.823804404931;8155.469894456842;8173.509589424653;8228.053773816087;8330.291925186184;7264.891026634499;7343;7381.778546643609;7473.962630186814;7481.17707052213;6401.679916004275;7214.206437291999;7252.927470725436;7276.818079547842;7291;5657.8019769307875;6565.671716414065;7054.188768291712;7059.71761129549;7089.503734738519;4726.36194113804;4785.808567657394;4832.178529649897;4915.287283343823;5009.198528235464;4844.927326090041;4884.291777692286;4900.975495122501;4993.975030124826;5104.69371837691 05:55:39 INFO - PROCESS | 6158 | |4;prototype.html;320.7546227136241;321.4663658327176;329.26409474823765;332.41992722698876;334.14625631511507;6142.140100385944;6309.652969086698;6370.617762934227;6396.616203027822;6401.519886008545;5819.632386389195;6201.751929922798;6252.874942501147;6292.905606415908;6334.049892516125;3427.931441371171;3801.619838016204;4519.638428925695;4614.284785858181;4644.767761611923;4244.0238745088645;4551.317302404649;4612.953870461302;4624.953750462503;4706.388169537955;3610.8806270056234;4033.7983100844986;4082.918026722906;4464.995376040398;4591.563801438858;3956.7625942443547;4591.471980722226;4593.885152871171;4604.79278432468;4653.488116307203;3934.409838524244;3939.98030009851;3966.4050392441077;3968.72218944674;3989.960100398988;5221.895562088775;5957.642541447527;5981.790637327673;6021.187139736124;6046.788362407338;5168.612354073422;5197.8960420791755;5452.454754524555;5480.808171713971;5502.174673798922;5646.802361917313;6106.603070800384;6643.966780166068;6650.900236496456;6654.900176497356;4247.277962746341;4275.337322714984;4329.134173165348;4480.260756975095;4484.094259939513;6175.783847565313;6837.623930683811;6985.3713165815325;7005.789826305168;7021.648917554102;3845.307844588001;4392.560743925582;4519.525449827721;4526.253168227271;4535.138323718549;4415.27148020573;4498.190325741398;4601.539846015438;4610.639861240942;4638.350630911675;5387.81142660005;5416.864578385572;5462.617616766788;5471.343438787291;5475.753591088331;5210.635255532152;6014.338422773491;6448.935925572322;6641.33586641332;6653.800385988428;1457.6501639606417;1558.9376424942875;1571.2379495944458;1591.9761203581957;1596.7684685720737;990.2820455170088;1032.8140934631688;1039.9844002339971;1055.6410820321128;1069.994650026745;5422.674639521641;6108.389161083945;6165.6570503208495;6173.783917562864;6179.660118693515;5574.442555744393;5927.644341339534;6806.897896531556;6848;6850.862982740317;5261.842144735664;5932;6135.815925522153;6137.140800287963;6151.938480615226;3542.71658267338;3618.5476815398074;3618.819059047037;3625.945610815787;3636.61815509373;6749.291324410964;6997;7056.259092795285;7078.681459334342;7079.82300442493;5817.50551203144;6913.686399584063;6939.322159255603;7000.61496617691;7013.26360732126;6752.257251702309;7070.964645176741;7088.574685518885;7241.674124664402;7252.7208946721685;5796.710164491674;6897.482688798461;6898.551594146365;6911.136107986502;6978.267281935324;6288.685565721604;6776.728930842908;6813.386795188457;6822.874225752696;6827.21487028998;7256.2743725627015;7260.128784545888;7273.709051637875;7290.198078211286;7323.157836848831;4283.0363168286885;4397.494288156903;4419.9116017678825;4421.314696222091;4437.445319335083;6502.0246962955935;6848.623325716934;6884.311568843075;6888.931110688829;6926.376626103674;6109.541784366102;6400.94325482882;6600.504962127764;6661.600303981777;6726.091977582963;6380.9361906380345;6667.633280169637;6669.065970868393;6696.229933557704;6700.162479690039;4765.451973023008;5048.343715316985;5678.971605141948;6194.318624951342;6553.4101930826455;5030.622703297194;5940.732667030081;6228.408301211378;6567.9671601641685;6741.22475915276;6140.20177376956;6540.215174179129;6560.770373036921;6581.539292249497;6598.307177746267 05:55:39 INFO - PROCESS | 6158 | |5;yui.html;654.2410803467972;664.7174950645975;748.7529115391922;757.3903008078498;767.3285874859498;14884.255787210637;14885.032472889268;14895.627609309773;14998.700025999473;15036.398544058224;13958.371873265727;13992.790108148385;14032.29838508073;14057.086289391207;14068.788968165485;722.2127880610134;906.2251774732607;923.353652443289;939.4222553129811;945.6028468043404;936.9578368973413;937.8124375124968;941.6892425499603;942.9905700943006;943.8725772020758;965.7295957132014;978.0952618827556;984.1536278800262;985.9950700246525;992.1318846009741;967.274544091931;970.3838062830154;977.5307852230933;979.9069088436659;982.287841315048;704.1303989572873;728.9307515785991;729.1468981291902;733.1532080447092;733.6148522025926;15174.317155728018;15188.164650944194;15206.239688015556;15240.695186096327;15288.082715037133;12441.377931103409;12568.245905245623;12593.74812503754;12603.558875439316;12736.426860791194;10734.790466395798;10901;11138;11193.888061119365;11224;4064.3700226464944;4095.365218391154;4095.5904409559103;4214.494260688737;4302.311630139163;84139.73790393087;84198.15801841965;86226;86606;87860.12139878584;9533.189678877374;9653.951730241304;9694.660686875926;9764.218862490983;9937.205023598095;21906.23328183538;22021.66967495489;22733.658995115085;22819.315420537412;22830.200942966916;7617.390608751287;7665.080190377191;7672.347850432664;8001.8399632008195;8100.2304781045705;4048.3725022621543;4075.694322925792;4106.178764247103;4107.9178416432105;4120.052387950788;2935.544990526472;3254.316593515341;3557.6442355764216;3655.1593133579427;3696.667299943018;650.8340373204898;656.8325077105403;668.0413606474724;676.2527407215055;676.9763058293034;516.7571241516481;528.6273177409917;550.8512701570553;570.6404964872104;588.7350692188533;7978.401619878532;7990.440669153103;8157.428979971463;8274.338052955749;8310.59811122775;485.26482379195545;513.1661050792462;513.8252993982064;519.1434133679459;569.0411656359048;3227.8870239541975;3875.5349358076646;3925.9214815703526;3939.1924655445564;4096.32410652245;65206.347936520026;84300.15699843045;84409;84625.37722085735;84785;70802;73245.63377183187;73557.6322118386;74260.62869685618;75513;62120;62542.374576254566;63310.68344658247;64871.35128648747;66013.66993165003;7040.683169257293;7577.696892124253;7762.379009679099;7837.373010159287;7926.959723362532;41634.375484367156;42012;42568.57431425646;42892.571074288855;43239.13521729485;55938;58655.4134458667;59005;59205.111923322045;59777.10334344902;10155.898441015495;10183;10240.795184096425;10330.948345258226;10588.41763702973;10665.89334106649;10773.569057237935;10791.892081079088;10799.40603266828;10831.620893268699;10193.388396695926;10288.742781430525;10406.635767748092;10670.30643008202;10683.25217234786;10124.898751012395;10196.235282353704;10201.84697229557;10581.206409519164;10623.628173013907;10018.298719089593;10050.64822731201;10112.696619101438;10135.746606334606;10461.47692615351;7963.960180199062;8804.163604457566;8856.690015849414;9025.503597302211;9132.49771262587;8218.958905205674;8701.608427620646;8903.821923561622;9067.863982040406;9356.532173391439 05:55:39 INFO - PROCESS | 6158 | __end_tp_report 05:55:39 INFO - PROCESS | 6158 | __start_cc_report 05:55:39 INFO - PROCESS | 6158 | _x_x_mozilla_cycle_collect,380 05:55:39 INFO - PROCESS | 6158 | __end_cc_report 05:55:39 INFO - PROCESS | 6158 | __startTimestamp1460638539806__endTimestamp 05:55:39 INFO - PROCESS | 6158 | 05:55:39 INFO - PROCESS | 6158 | ------- Summary: start ------- 05:55:39 INFO - PROCESS | 6158 | Number of tests: 6 05:55:39 INFO - PROCESS | 6158 | 05:55:39 INFO - PROCESS | 6158 | [#0] dojo.html Cycles:165 Average:5769.78 Median:6040.79 stddev:805.16 (13.3%) stddev-sans-first:776.93 05:55:39 INFO - PROCESS | 6158 | Values: 2962.3 3462.5 3506.9 3517.0 3552.6 5864.1 5870.5 5911.4 5911.8 5914.1 5429.2 5775.7 5861.6 5933.3 6043.7 5217.2 5283.3 5308.8 5318.8 5352.7 232.3 5246.8 5272.3 5329.8 5336.9 5316.8 5325.2 5329.0 5336.4 5370.9 5304.8 5326.5 5344.8 5356.3 5361.6 4423.8 5205.4 5230.3 5270.2 5365.9 4720.3 5659.3 5738.6 5786.3 5819.2 6155.9 6209.1 6267.9 6272.2 6285.8 5655.4 5992.8 6217.6 6278.1 6290.3 4814.9 5895.7 5899.5 5901.0 5911.7 6228.4 6356.1 6357.9 6363.1 6380.5 5352.5 6197.0 6240.2 6289.8 6291.5 5249.8 5266.7 6271.4 6279.2 6335.7 5027.9 6207.3 6284.8 6289.3 6307.3 6280.3 6281.2 6287.0 6287.7 6290.2 5020.1 5027.6 5043.1 5047.0 5048.4 3791.8 4431.3 4508.1 4561.6 4610.6 5755.8 5895.3 5916.1 6006.5 6040.8 6278.4 6307.6 6314.5 6341.9 6342.7 5792.0 5896.9 5939.9 5953.1 6009.7 5504.1 5522.1 5529.4 5543.0 5551.8 6512.4 6533.3 6546.7 6550.4 6550.9 6165.6 6262.1 6288.2 6347.0 6368.5 6502.0 6523.9 6528.6 6544.4 6546.0 6254.9 6294.7 6301.1 6306.1 6318.6 6197.8 6226.5 6256.9 6281.6 6305.0 6250.2 6267.6 6274.1 6284.1 6299.4 6137.7 6206.6 6273.0 6284.7 6303.1 5391.6 6113.1 6114.4 6198.6 6223.0 5803.7 6061.9 6244.8 6287.7 6288.7 6015.0 6092.3 6145.4 6160.8 6189.2 05:55:39 INFO - PROCESS | 6158 | 05:55:39 INFO - PROCESS | 6158 | [#1] ext.html Cycles:180 Average:65707.49 Median:37629.50 stddev:145376.34 (386.3%) stddev-sans-first:145701.72 05:55:39 INFO - PROCESS | 6158 | Values: 499.2 513.2 517.9 582.7 670.9 37140.6 37823.1 37935.6 37998.2 38204.0 39348.6 40066.4 40078.6 40124.6 40416.8 9319.2 9545.2 9560.1 9571.1 9572.8 9392.4 9526.4 9566.4 9581.0 9612.5 9635.7 9667.5 9710.7 9721.1 9737.9 8121.0 9608.3 9649.7 9716.8 9728.0 8549.1 9416.1 9565.3 9650.0 9690.2 38285.2 38643.0 38745.0 38782.4 38811.2 2791.7 2975.0 3001.2 3047.8 3400.9 26725.7 26743.2 26839.2 27208.2 27251.7 2588.9 2591.7 2651.2 2677.4 2715.7 375361.0 377758.0 378471.0 379299.0 380038.0 34582.5 34757.0 35016.1 35036.6 35063.5 36152.1 36311.3 68600.0 70694.6 70976.3 15483.6 15853.3 15924.4 15983.4 16015.4 12631.7 12848.4 12857.8 12983.7 13011.4 19832.0 20012.5 20177.9 20208.8 20218.6 8594.2 8625.8 8659.4 8707.9 8727.6 968.5 1007.8 1051.6 1085.8 1095.2 29934.3 29953.0 30194.7 30654.8 30887.2 1075.0 1085.0 1091.4 1158.0 1176.2 14708.0 14842.4 14995.9 15248.8 15261.5 624871.0 630026.0 631208.0 634492.0 639583.0 59123.4 59428.0 60040.4 60323.1 60862.0 1365.8 1429.5 1456.8 1488.2 1488.3 24469.9 26826.6 27606.9 28165.4 29049.7 42515.8 51107.7 51269.7 51964.2 51969.0 582109.0 582230.0 583613.0 585673.0 589171.0 23842.6 25288.5 26784.9 26825.0 27176.0 46142.0 46267.3 46407.3 46799.3 47535.8 29772.6 37205.0 37688.0 38087.6 39025.6 31803.4 37104.8 37411.9 37485.4 37571.0 37525.7 38125.0 38397.6 38638.4 39054.4 27775.0 27949.4 31864.0 31917.2 31941.0 23544.3 25005.5 25155.0 25232.5 25310.2 05:55:39 INFO - PROCESS | 6158 | 05:55:39 INFO - PROCESS | 6158 | [#2] jquery.html Cycles:180 Average:34472.09 Median:12627.02 stddev:102516.95 (811.9%) stddev-sans-first:102772.55 05:55:39 INFO - PROCESS | 6158 | Values: 367.0 374.6 391.4 393.9 411.5 19006.0 20128.6 21108.9 21205.6 21292.6 11794.5 11848.2 11937.7 12144.1 12232.0 5345.2 5504.2 5547.8 5548.3 5549.9 3211.8 4540.3 6160.3 6169.8 6177.8 6094.9 6131.3 6175.0 6228.1 6262.8 6607.4 6635.9 6644.3 6661.8 6664.0 5700.9 5859.6 5886.1 5906.0 5928.1 13453.7 13488.5 13597.9 19833.7 22927.0 1903.8 2068.3 2187.5 2327.1 2471.0 9777.6 9785.9 9900.9 10206.7 14862.1 1719.6 1747.5 1774.4 1789.1 1792.9 86253.6 101348.5 119664.0 124565.0 126659.0 9176.8 9861.1 11462.3 11849.5 11882.3 15140.8 15175.8 15202.8 15272.8 15320.5 8557.7 8697.7 8719.8 8784.3 8789.2 7047.9 8424.8 8568.1 8695.5 8708.6 3873.6 4574.6 4649.9 4660.2 4710.9 1654.6 1679.7 1860.5 1981.6 1984.3 832.1 937.2 958.2 1052.7 1077.4 17192.3 17243.7 17374.9 20440.2 20544.2 976.9 978.3 1033.7 1034.0 1046.6 8981.6 9303.4 9680.8 9736.5 10542.3 606756.0 609740.0 617304.0 620089.0 623388.0 126726.0 129236.4 129311.4 129915.8 131375.0 1027.4 1032.9 1043.3 1052.6 1055.1 17867.7 17885.8 17887.0 17899.1 18243.9 47061.1 49530.0 49649.0 49979.3 50433.5 66485.7 70506.3 73229.3 73449.6 74191.0 7967.8 7971.8 8130.6 8140.8 8409.6 9611.3 11779.4 12423.5 12545.6 12636.7 5082.0 10786.2 10984.5 11014.9 11095.9 10455.9 10786.9 10866.9 11122.3 11345.4 10749.9 10960.4 11199.9 11491.0 11544.5 8157.2 8202.7 8302.4 8378.0 8386.8 10508.0 10593.7 11235.8 11464.7 11473.7 05:55:39 INFO - PROCESS | 6158 | 05:55:39 INFO - PROCESS | 6158 | [#3] mootools.html Cycles:180 Average:5612.91 Median:4954.63 stddev:3096.96 (62.5%) stddev-sans-first:3089.09 05:55:39 INFO - PROCESS | 6158 | Values: 1353.0 1492.3 1566.6 1781.9 1916.5 7871.2 8279.9 8459.5 8500.8 8529.6 8510.9 8532.7 8604.0 8629.0 8727.1 2061.6 2076.3 2440.4 2452.0 2452.5 2411.4 2433.3 2441.0 2454.4 2473.8 2426.8 2438.6 2439.6 2459.8 2471.8 2434.3 2436.5 2453.7 2454.7 2470.0 2416.2 2434.0 2458.1 2465.7 2468.5 8652.7 8774.0 8782.1 8792.2 8806.0 5166.7 5294.3 5298.6 5336.1 5358.0 3549.9 3576.4 3582.3 3611.0 3647.7 990.9 1044.1 1046.2 1063.6 1070.7 11394.3 11407.1 11460.5 11541.4 11565.7 4280.6 4631.7 4839.9 4842.5 4872.9 7809.0 9703.7 9775.6 9780.1 9787.6 5307.9 5328.2 5333.2 5337.4 5337.8 4386.6 4716.0 4890.9 4899.3 4906.9 3998.1 4019.1 4096.7 4130.6 4137.2 1319.7 1361.6 1363.7 1365.4 1366.2 893.9 909.3 912.1 928.9 938.6 5911.5 5937.8 6047.1 6048.1 6085.3 441.6 452.1 457.4 469.0 469.8 3949.3 4009.5 4051.3 4067.0 4075.2 8183.9 10515.5 10575.5 10715.2 10731.8 10382.1 10493.8 10543.9 10581.7 10656.1 6708.6 8041.5 8090.8 8102.0 8209.2 5783.8 5784.5 5831.6 5906.8 5915.6 9792.4 9838.9 9840.9 9864.8 9897.5 8993.6 9382.3 9561.3 9607.1 10087.4 6982.4 7328.3 7516.2 7981.8 8180.5 7047.8 8155.5 8173.5 8228.1 8330.3 7264.9 7343.0 7381.8 7474.0 7481.2 6401.7 7214.2 7252.9 7276.8 7291.0 5657.8 6565.7 7054.2 7059.7 7089.5 4726.4 4785.8 4832.2 4915.3 5009.2 4844.9 4884.3 4901.0 4994.0 5104.7 05:55:39 INFO - PROCESS | 6158 | 05:55:39 INFO - PROCESS | 6158 | [#4] prototype.html Cycles:180 Average:5334.32 Median:5969.72 stddev:1701.35 (28.5%) stddev-sans-first:1663.99 05:55:39 INFO - PROCESS | 6158 | Values: 320.8 321.5 329.3 332.4 334.1 6142.1 6309.7 6370.6 6396.6 6401.5 5819.6 6201.8 6252.9 6292.9 6334.0 3427.9 3801.6 4519.6 4614.3 4644.8 4244.0 4551.3 4613.0 4625.0 4706.4 3610.9 4033.8 4082.9 4465.0 4591.6 3956.8 4591.5 4593.9 4604.8 4653.5 3934.4 3940.0 3966.4 3968.7 3990.0 5221.9 5957.6 5981.8 6021.2 6046.8 5168.6 5197.9 5452.5 5480.8 5502.2 5646.8 6106.6 6644.0 6650.9 6654.9 4247.3 4275.3 4329.1 4480.3 4484.1 6175.8 6837.6 6985.4 7005.8 7021.6 3845.3 4392.6 4519.5 4526.3 4535.1 4415.3 4498.2 4601.5 4610.6 4638.4 5387.8 5416.9 5462.6 5471.3 5475.8 5210.6 6014.3 6448.9 6641.3 6653.8 1457.7 1558.9 1571.2 1592.0 1596.8 990.3 1032.8 1040.0 1055.6 1070.0 5422.7 6108.4 6165.7 6173.8 6179.7 5574.4 5927.6 6806.9 6848.0 6850.9 5261.8 5932.0 6135.8 6137.1 6151.9 3542.7 3618.5 3618.8 3625.9 3636.6 6749.3 6997.0 7056.3 7078.7 7079.8 5817.5 6913.7 6939.3 7000.6 7013.3 6752.3 7071.0 7088.6 7241.7 7252.7 5796.7 6897.5 6898.6 6911.1 6978.3 6288.7 6776.7 6813.4 6822.9 6827.2 7256.3 7260.1 7273.7 7290.2 7323.2 4283.0 4397.5 4419.9 4421.3 4437.4 6502.0 6848.6 6884.3 6888.9 6926.4 6109.5 6400.9 6600.5 6661.6 6726.1 6380.9 6667.6 6669.1 6696.2 6700.2 4765.5 5048.3 5679.0 6194.3 6553.4 5030.6 5940.7 6228.4 6568.0 6741.2 6140.2 6540.2 6560.8 6581.5 6598.3 05:55:39 INFO - PROCESS | 6158 | 05:55:39 INFO - PROCESS | 6158 | [#5] yui.html Cycles:180 Average:17231.87 Median:29622.07 stddev:23883.59 (80.6%) stddev-sans-first:23918.15 05:55:39 INFO - PROCESS | 6158 | Values: 654.2 664.7 748.8 757.4 767.3 14884.3 14885.0 14895.6 14998.7 15036.4 13958.4 13992.8 14032.3 14057.1 14068.8 722.2 906.2 923.4 939.4 945.6 937.0 937.8 941.7 943.0 943.9 965.7 978.1 984.2 986.0 992.1 967.3 970.4 977.5 979.9 982.3 704.1 728.9 729.1 733.2 733.6 15174.3 15188.2 15206.2 15240.7 15288.1 12441.4 12568.2 12593.7 12603.6 12736.4 10734.8 10901.0 11138.0 11193.9 11224.0 4064.4 4095.4 4095.6 4214.5 4302.3 84139.7 84198.2 86226.0 86606.0 87860.1 9533.2 9654.0 9694.7 9764.2 9937.2 21906.2 22021.7 22733.7 22819.3 22830.2 7617.4 7665.1 7672.3 8001.8 8100.2 4048.4 4075.7 4106.2 4107.9 4120.1 2935.5 3254.3 3557.6 3655.2 3696.7 650.8 656.8 668.0 676.3 677.0 516.8 528.6 550.9 570.6 588.7 7978.4 7990.4 8157.4 8274.3 8310.6 485.3 513.2 513.8 519.1 569.0 3227.9 3875.5 3925.9 3939.2 4096.3 65206.3 84300.2 84409.0 84625.4 84785.0 70802.0 73245.6 73557.6 74260.6 75513.0 62120.0 62542.4 63310.7 64871.4 66013.7 7040.7 7577.7 7762.4 7837.4 7927.0 41634.4 42012.0 42568.6 42892.6 43239.1 55938.0 58655.4 59005.0 59205.1 59777.1 10155.9 10183.0 10240.8 10330.9 10588.4 10665.9 10773.6 10791.9 10799.4 10831.6 10193.4 10288.7 10406.6 10670.3 10683.3 10124.9 10196.2 10201.8 10581.2 10623.6 10018.3 10050.6 10112.7 10135.7 10461.5 7964.0 8804.2 8856.7 9025.5 9132.5 8219.0 8701.6 8903.8 9067.9 9356.5 05:55:39 INFO - PROCESS | 6158 | -------- Summary: end -------- 05:55:39 INFO - PROCESS | 6158 | 05:55:40 INFO - TEST-INFO | 6158: exit 0 05:55:40 INFO - TEST-OK | dromaeo_css | took 1111340ms 05:55:40 INFO - TEST-START | kraken 05:55:40 INFO - operating with platform_type : mac_ 05:55:40 INFO - Initialising browser for kraken test... 05:55:40 INFO - TEST-INFO | started process 6163 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmp42MqOo/profile http://localhost:56402/getInfo.html) 05:55:42 INFO - PROCESS | 6163 | JavaScript error: jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:55:43 INFO - PROCESS | 6163 | __metrics Screen width/height:1600/1200 05:55:43 INFO - PROCESS | 6163 | colorDepth:24 05:55:43 INFO - PROCESS | 6163 | Browser inner width/height: 1024/689 05:55:43 INFO - PROCESS | 6163 | __metrics 05:55:43 ERROR - PROCESS | 6163 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:55:43 INFO - TEST-INFO | 6163: exit 0 05:55:43 INFO - Browser initialized. 05:55:43 INFO - Running cycle 1/1 for kraken test... 05:55:43 INFO - TEST-INFO | started process 6167 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmp42MqOo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:56 INFO - PROCESS | 6167 | RSS: Main: 248205312 05:55:56 INFO - PROCESS | 6167 | 05:55:58 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56402/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:59 INFO - PROCESS | 6167 | RSS: Main: 260395008 05:55:59 INFO - PROCESS | 6167 | 05:56:02 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56402/tests/kraken/driver.html?testName=audio-dft) 05:56:03 INFO - PROCESS | 6167 | RSS: Main: 269619200 05:56:03 INFO - PROCESS | 6167 | 05:56:06 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56402/tests/kraken/driver.html?testName=audio-fft) 05:56:07 INFO - PROCESS | 6167 | RSS: Main: 272785408 05:56:07 INFO - PROCESS | 6167 | 05:56:09 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56402/tests/kraken/driver.html?testName=audio-oscillator) 05:56:09 INFO - PROCESS | 6167 | RSS: Main: 273850368 05:56:09 INFO - PROCESS | 6167 | 05:56:11 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56402/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:56:12 INFO - PROCESS | 6167 | RSS: Main: 273965056 05:56:12 INFO - PROCESS | 6167 | 05:56:15 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56402/tests/kraken/driver.html?testName=imaging-darkroom) 05:56:15 INFO - PROCESS | 6167 | RSS: Main: 273874944 05:56:15 INFO - PROCESS | 6167 | 05:56:18 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56402/tests/kraken/driver.html?testName=imaging-desaturate) 05:56:19 INFO - PROCESS | 6167 | RSS: Main: 275386368 05:56:19 INFO - PROCESS | 6167 | 05:56:22 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56402/tests/kraken/driver.html?testName=json-parse-financial) 05:56:23 INFO - PROCESS | 6167 | RSS: Main: 275296256 05:56:23 INFO - PROCESS | 6167 | 05:56:24 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56402/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:56:25 INFO - PROCESS | 6167 | RSS: Main: 275361792 05:56:25 INFO - PROCESS | 6167 | 05:56:27 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56402/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:27 INFO - PROCESS | 6167 | RSS: Main: 275296256 05:56:27 INFO - PROCESS | 6167 | 05:56:30 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56402/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:30 INFO - PROCESS | 6167 | RSS: Main: 275587072 05:56:30 INFO - PROCESS | 6167 | 05:56:33 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:34 INFO - PROCESS | 6167 | RSS: Main: 275693568 05:56:34 INFO - PROCESS | 6167 | 05:56:37 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:37 INFO - PROCESS | 6167 | RSS: Main: 275857408 05:56:37 INFO - PROCESS | 6167 | 05:56:39 INFO - PROCESS | 6167 | Cycle 1(1): loaded http://localhost:56402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56402/tests/kraken/driver.html?testName=ai-astar) 05:56:40 INFO - PROCESS | 6167 | RSS: Main: 277594112 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | __start_tp_report 05:56:40 INFO - PROCESS | 6167 | _x_x_mozilla_page_load 05:56:40 INFO - PROCESS | 6167 | _x_x_mozilla_page_load_details 05:56:40 INFO - PROCESS | 6167 | |i|pagename|runs| 05:56:40 INFO - PROCESS | 6167 | |0;ai-astar;114;106;118;116;117;128;117;116;116;141 05:56:40 INFO - PROCESS | 6167 | |1;audio-beat-detection;159;155;175;172;122;142;126;155;163;125 05:56:40 INFO - PROCESS | 6167 | |2;audio-dft;200;200;208;220;200;202;225;259;199;199 05:56:40 INFO - PROCESS | 6167 | |3;audio-fft;63;73;80;148;84;51;49;92;159;49 05:56:40 INFO - PROCESS | 6167 | |4;audio-oscillator;79;82;129;77;80;87;118;82;84;101 05:56:40 INFO - PROCESS | 6167 | |5;imaging-gaussian-blur;95;89;92;89;91;87;92;92;122;109 05:56:40 INFO - PROCESS | 6167 | |6;imaging-darkroom;97;98;98;121;152;151;98;97;105;108 05:56:40 INFO - PROCESS | 6167 | |7;imaging-desaturate;92;101;82;150;153;125;92;93;93;96 05:56:40 INFO - PROCESS | 6167 | |8;json-parse-financial;61;64;62;62;62;61;62;78;64;61 05:56:40 INFO - PROCESS | 6167 | |9;json-stringify-tinderbox;67;67;70;72;88;81;73;63;69;69 05:56:40 INFO - PROCESS | 6167 | |10;stanford-crypto-aes;88;86;89;90;89;89;90;90;90;84 05:56:40 INFO - PROCESS | 6167 | |11;stanford-crypto-ccm;141;167;152;165;168;162;151;149;180;151 05:56:40 INFO - PROCESS | 6167 | |12;stanford-crypto-pbkdf2;169;175;174;173;178;173;174;172;194;199 05:56:40 INFO - PROCESS | 6167 | |13;stanford-crypto-sha256-iterative;71;70;70;69;102;107;99;71;70;69 05:56:40 INFO - PROCESS | 6167 | __end_tp_report 05:56:40 INFO - PROCESS | 6167 | __start_cc_report 05:56:40 INFO - PROCESS | 6167 | _x_x_mozilla_cycle_collect,993 05:56:40 INFO - PROCESS | 6167 | __end_cc_report 05:56:40 INFO - PROCESS | 6167 | __startTimestamp1460638600045__endTimestamp 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | ------- Summary: start ------- 05:56:40 INFO - PROCESS | 6167 | Number of tests: 14 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#0] ai-astar Cycles:10 Average:118.90 Median:117.00 stddev:9.40 (8.0%) stddev-sans-first:9.80 05:56:40 INFO - PROCESS | 6167 | Values: 114.0 106.0 118.0 116.0 117.0 128.0 117.0 116.0 116.0 141.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:157.00 stddev:19.59 (12.5%) stddev-sans-first:20.47 05:56:40 INFO - PROCESS | 6167 | Values: 159.0 155.0 175.0 172.0 122.0 142.0 126.0 155.0 163.0 125.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#2] audio-dft Cycles:10 Average:211.20 Median:205.00 stddev:19.21 (9.4%) stddev-sans-first:19.94 05:56:40 INFO - PROCESS | 6167 | Values: 200.0 200.0 208.0 220.0 200.0 202.0 225.0 259.0 199.0 199.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#3] audio-fft Cycles:10 Average:84.80 Median:68.00 stddev:39.29 (57.8%) stddev-sans-first:40.88 05:56:40 INFO - PROCESS | 6167 | Values: 63.0 73.0 80.0 148.0 84.0 51.0 49.0 92.0 159.0 49.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:81.00 stddev:18.11 (22.4%) stddev-sans-first:18.60 05:56:40 INFO - PROCESS | 6167 | Values: 79.0 82.0 129.0 77.0 80.0 87.0 118.0 82.0 84.0 101.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#5] imaging-gaussian-blur Cycles:10 Average:95.80 Median:91.50 stddev:11.04 (12.1%) stddev-sans-first:11.71 05:56:40 INFO - PROCESS | 6167 | Values: 95.0 89.0 92.0 89.0 91.0 87.0 92.0 92.0 122.0 109.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#6] imaging-darkroom Cycles:10 Average:112.50 Median:97.00 stddev:21.86 (22.5%) stddev-sans-first:22.46 05:56:40 INFO - PROCESS | 6167 | Values: 97.0 98.0 98.0 121.0 152.0 151.0 98.0 97.0 105.0 108.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#7] imaging-desaturate Cycles:10 Average:107.70 Median:92.00 stddev:25.62 (27.8%) stddev-sans-first:26.54 05:56:40 INFO - PROCESS | 6167 | Values: 92.0 101.0 82.0 150.0 153.0 125.0 92.0 93.0 93.0 96.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:62.00 stddev:5.14 (8.3%) stddev-sans-first:5.36 05:56:40 INFO - PROCESS | 6167 | Values: 61.0 64.0 62.0 62.0 62.0 61.0 62.0 78.0 64.0 61.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:71.00 stddev:7.39 (10.4%) stddev-sans-first:7.62 05:56:40 INFO - PROCESS | 6167 | Values: 67.0 67.0 70.0 72.0 88.0 81.0 73.0 63.0 69.0 69.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:89.50 stddev:2.01 (2.3%) stddev-sans-first:2.13 05:56:40 INFO - PROCESS | 6167 | Values: 88.0 86.0 89.0 90.0 89.0 89.0 90.0 90.0 90.0 84.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#11] stanford-crypto-ccm Cycles:10 Average:158.60 Median:163.50 stddev:11.69 (7.2%) stddev-sans-first:10.53 05:56:40 INFO - PROCESS | 6167 | Values: 141.0 167.0 152.0 165.0 168.0 162.0 151.0 149.0 180.0 151.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:174.50 stddev:10.03 (5.7%) stddev-sans-first:10.08 05:56:40 INFO - PROCESS | 6167 | Values: 169.0 175.0 174.0 173.0 178.0 173.0 174.0 172.0 194.0 199.0 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - PROCESS | 6167 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.80 Median:70.00 stddev:15.91 (22.7%) stddev-sans-first:16.55 05:56:40 INFO - PROCESS | 6167 | Values: 71.0 70.0 70.0 69.0 102.0 107.0 99.0 71.0 70.0 69.0 05:56:40 INFO - PROCESS | 6167 | -------- Summary: end -------- 05:56:40 INFO - PROCESS | 6167 | 05:56:40 INFO - TEST-INFO | 6167: exit 0 05:56:40 INFO - TEST-OK | kraken | took 60480ms 05:56:40 INFO - SUITE-END | took 1171s 05:56:41 INFO - Completed test suite (00:19:32) 05:56:41 INFO - javascript benchmark 05:56:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2962.3334749681326, 3462.532558104656, 3506.9298614027703, 3517.0, 3552.609212986569, 5864.09106588479, 5870.471657550819, 5911.438413350736, 5911.793087241947, 5914.112883067532, 5429.212764149196, 5775.682337471438, 5861.618994765348, 5933.288005439343, 6043.6675982820925, 5217.191335343028, 5283.28675628789, 5308.787648494055, 5318.813841515548, 5352.678839269656, 232.34309800184943, 5246.7638956247065, 5272.340957380327, 5329.840104796862, 5336.866578335534, 5316.840494785162, 5325.174597937326, 5328.973355133238, 5336.43967383423, 5370.865728356784, 5304.814331498417, 5326.493983071641, 5344.812931547416, 5356.250124982505, 5361.624686271963, 4423.827685663302, 5205.401378841444, 5230.34620672416, 5270.235815806686, 5365.865853353658, 4720.33915251865, 5659.26429564154, 5738.626989245686, 5786.276715410574, 5819.214406055171, 6155.938440615581, 6209.0996805462955, 6267.874642507124, 6272.2159730033745, 6285.842853928642, 5655.3779084300695, 5992.820215393545, 6217.626942383471, 6278.058291256302, 6290.276618188876, 4814.927776083362, 5895.734691938873, 5899.46904778572, 5901.02633065548, 5911.674857882815, 6228.408301211378, 6356.078368636614, 6357.936420635827, 6363.140975968185, 6380.521460890452, 5352.464753524617, 6196.969015154986, 6240.219972503437, 6289.842753931189, 6291.496680265568, 5249.763760630781, 5266.683998960075, 6271.404216599416, 6279.246490421178, 6335.651539165298, 5027.899442011139, 6207.348228435949, 6284.780032698925, 6289.308176100625, 6307.274663413675, 6280.309165991737, 6281.214848143982, 6287.0, 6287.717052732638, 6290.182276304051, 5020.1214787412055, 5027.572656324181, 5043.092243396224, 5046.9747651261505, 5048.3941926969, 3791.848326066982, 4431.268840641258, 4508.106595230011, 4561.612262957686, 4610.608098311614, 5755.798547050917, 5895.322037965603, 5916.1421593868645, 6006.489448396847, 6040.7885724000325, 6278.434940855345, 6307.621542707452, 6314.463270621956, 6341.904871426932, 6342.714577844008, 5792.0, 5896.911546326808, 5939.940600594025, 5953.077273022688, 6009.729562169713, 5504.119340905436, 5522.061249587579, 5529.419410961871, 5542.97228513863, 5551.7779288828, 6512.446442052478, 6533.346665333429, 6546.672666366662, 6550.443212326911, 6550.901736473957, 6165.568410211242, 6262.060690896402, 6288.213973253343, 6347.0, 6368.490520758235, 6502.0, 6523.869522609426, 6528.608283503005, 6544.3782840630065, 6546.0, 6254.874902502015, 6294.685265736786, 6301.117843501822, 6306.054091886253, 6318.62088274705, 6197.81406557804, 6226.470749986302, 6256.873762722754, 6281.560290779785, 6305.0, 6250.218722659668, 6267.592606480564, 6274.121622972696, 6284.057391391328, 6299.433051025429, 6137.693115344304, 6206.596571222856, 6272.968635156795, 6284.685765711604, 6303.117563541016, 5391.595630327663, 6113.081058499921, 6114.357992410733, 6198.566100373111, 6222.973209420395, 5803.65178089316, 6061.878762424815, 6244.812655620339, 6287.71705273273, 6288.748450061947, 6015.0, 6092.329843717099, 6145.446909778141, 6160.845978850564, 6189.226346706661], "value": 5721.134799054998, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.2261993909439, 513.2429666242292, 517.9020476589629, 582.7202942587561, 670.8926571748522, 37140.62859371406, 37823.054423639456, 37935.620643793554, 37998.24003519928, 38204.0, 39348.60651393485, 40066.39900401489, 40078.59921400785, 40124.59875401245, 40416.79791601045, 9319.161275485205, 9545.236381089497, 9560.13958743713, 9571.138597526222, 9572.760680982996, 9392.436453812794, 9526.428414295164, 9566.37818541796, 9581.041895810433, 9612.51937403127, 9635.710928672152, 9667.468289244089, 9710.66012689556, 9721.125098741111, 9737.902620973806, 8121.025476942746, 9608.2793790466, 9649.662261820838, 9716.75708107296, 9727.951360243154, 8549.145085491464, 9416.058394160598, 9565.282603804673, 9650.034996500364, 9690.224782017422, 38285.234295314214, 38643.0, 38745.0, 38782.41826372607, 38811.22377552462, 2791.7208279172123, 2974.975728636252, 3001.2346851552934, 3047.8171309721265, 3400.897973060812, 26725.73274267252, 26743.197704068716, 26839.24250604917, 27208.1837544872, 27251.727482725317, 2588.9482210355877, 2591.676040494938, 2651.178134778225, 2677.3842016336157, 2715.701272859984, 375361.0, 377758.0, 378471.0, 379299.0, 380038.0, 34582.481262781075, 34757.0, 35016.12459688477, 35036.64963350385, 35063.4740478893, 36152.09619759474, 36311.273774524365, 68600.0, 70694.64652676704, 70976.290237098, 15483.612909677347, 15853.286602102933, 15924.442644507619, 15983.44057957966, 16015.439459618858, 12631.747365052648, 12848.357582120856, 12857.807132893015, 12983.675408114872, 13011.414486348138, 19832.008399579965, 20012.499687507636, 20177.899110504648, 20208.797912020986, 20218.59562808765, 8594.22651961314, 8625.765337998251, 8659.350548708871, 8707.869381959275, 8727.563621818883, 968.4963818814177, 1007.838745800683, 1051.5951358726945, 1085.7882712870914, 1095.1512577752305, 29934.251643708645, 29953.0, 30194.698053019627, 30654.846725766227, 30887.2278193047, 1075.0432115417284, 1085.0, 1091.4324551233315, 1157.9710507237387, 1176.2178151529138, 14708.0, 14842.419186444282, 14995.925020375047, 15248.771268430983, 15261.465848695465, 624871.0, 630026.0, 631208.0, 634492.0, 639583.0, 59123.40876591265, 59428.0, 60040.39959600348, 60323.09515357273, 60862.0, 1365.7883028130457, 1429.463951018368, 1456.83974762776, 1488.2335597167466, 1488.3302513868803, 24469.877650611634, 26826.597601036392, 27606.861965690045, 28165.43669126647, 29049.7095029047, 42515.7874210627, 51107.744461277456, 51269.743651281504, 51964.220536691224, 51969.0, 582109.0, 582230.0, 583613.0, 585673.0, 589171.0, 23842.642360364956, 25288.494230115663, 26784.866075669495, 26825.0, 27176.048838290564, 46142.0, 46267.3059904095, 46407.303890441, 46799.298010529186, 47535.76232118817, 29772.55341169841, 37205.0, 37688.0, 38087.61912380841, 39025.60974390333, 31803.363932721677, 37104.81447592745, 37411.877643670734, 37485.43771843479, 37571.0, 37525.65171585568, 38125.046873828374, 38397.61602384052, 38638.42042369423, 39054.4141837867, 27775.027874024312, 27949.441011179257, 31864.044078677678, 31917.20206994844, 31941.0, 23544.29367118989, 25005.499890002462, 25155.0, 25232.495350093264, 25310.240692779247], "value": 19185.646694290033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.95413073365813, 374.6403452685422, 391.44024045614793, 393.89512417668436, 411.4753689046467, 19006.0, 20128.59742805143, 21108.894455527738, 21205.57588848222, 21292.574148517022, 11794.469248883799, 11848.229865058765, 11937.701557461069, 12144.149909506337, 12232.0, 5345.224942383362, 5504.2294078829, 5547.805826796063, 5548.278723765905, 5549.861253468655, 3211.807291562502, 4540.318952157169, 6160.322364539897, 6169.7532098716, 6177.783777567786, 6094.939050609503, 6131.325554189036, 6175.042868355412, 6228.065790131472, 6262.780802671908, 6607.372299631527, 6635.900461493057, 6644.335566443317, 6661.766838160665, 6664.0, 5700.942990570083, 5859.589828711992, 5886.117082437626, 5906.025505791539, 5928.110783382484, 13453.730925381535, 13488.527901523497, 13597.864021359857, 19833.702494462595, 22926.96828642715, 1903.7620297462818, 2068.33813179781, 2187.475005998549, 2327.0691723310642, 2470.9621958777357, 9777.560009799576, 9785.902140978571, 9900.900990990142, 10206.744831379201, 14862.103426159378, 1719.6474722681821, 1747.5194321561546, 1774.4321817018558, 1789.1322708486373, 1792.9193186306647, 86253.56873215656, 101348.49325753398, 119664.0, 124565.0, 126659.0, 9176.816463670822, 9861.063198996084, 11462.312261264184, 11849.466773995191, 11882.28706277626, 15140.848591514165, 15175.772363414557, 15202.847971520365, 15272.847271527366, 15320.540383788504, 8557.657693692183, 8697.695580654647, 8719.825603487894, 8784.297256219486, 8789.208971192624, 7047.92952070483, 8424.831503369898, 8568.143185681507, 8695.521746303888, 8708.606622940299, 3873.573906870242, 4574.588287054181, 4649.907001860011, 4660.231061874752, 4710.882227944328, 1654.6359800843795, 1679.6976544221914, 1860.4976656302993, 1981.6135853508426, 1984.2658216460002, 832.0680837462081, 937.1846493550519, 958.1616085924816, 1052.7157667429904, 1077.4074259157433, 17192.31230750781, 17243.655126897644, 17374.913125434545, 20440.182392704126, 20544.178232870818, 976.9218462522981, 978.280963491833, 1033.6692258477215, 1033.994830025845, 1046.6450486405588, 8981.595828187617, 9303.395279306824, 9680.806383872425, 9736.513174341255, 10542.26204165701, 606756.0, 609740.0, 617304.0, 620089.0, 623388.0, 126726.0, 129236.3538182303, 129311.35344323218, 129915.84313999394, 131375.0, 1027.429776474064, 1032.8915463876185, 1043.2644985285203, 1052.6315789473622, 1055.118975655321, 17867.73198401999, 17885.821141788936, 17887.01621410835, 17899.10504474745, 18243.905365678103, 47061.05877882355, 49530.00939981252, 49649.0, 49979.250311244636, 50433.49566504435, 66485.66757166183, 70506.29493705202, 73229.26770732438, 73449.6327518359, 74191.0, 7967.760967170994, 7971.800704982422, 8130.552819594979, 8140.75577732669, 8409.621567029377, 9611.327207095715, 11779.352135632622, 12423.503059877865, 12545.560905368633, 12636.747265054464, 5082.034413461431, 10786.191035672513, 10984.462175295625, 11014.889851101387, 11095.944520277348, 10455.94772026135, 10786.892131078588, 10866.891331086905, 11122.332660040423, 11345.376004319842, 10749.903247893979, 10960.397178154959, 11199.888001119885, 11491.0, 11544.538218471167, 8157.225063619184, 8202.671893124209, 8302.418830682036, 8377.95811020941, 8386.832263354576, 10508.001739834703, 10593.682189534326, 11235.7752844941, 11464.713382165513, 11473.713157171138], "value": 9201.831859754033, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.9797053044203, 1492.2762460206798, 1566.6005168681984, 1781.9198136083876, 1916.4538106639593, 7871.173526779691, 8279.875801862969, 8459.450135741172, 8500.787480312994, 8529.57352132394, 8510.914890851089, 8532.70135545256, 8604.0, 8629.0, 8727.127287271269, 2061.5569101628844, 2076.3148161106874, 2440.4386990992084, 2451.950960980779, 2452.534018536481, 2411.3730430088217, 2433.3429973907037, 2441.023590563771, 2454.361865914866, 2473.837296470665, 2426.7694569015916, 2438.5732496813075, 2439.609662454008, 2459.754024597544, 2471.752824717532, 2434.318390850547, 2436.52487764885, 2453.7178224504232, 2454.7299797022315, 2470.0, 2416.1905761569897, 2433.9513209735705, 2458.0905065126017, 2465.7410971848058, 2468.5062987402594, 8652.653893844239, 8774.0, 8782.077881822444, 8792.208701216858, 8806.0, 5166.7416629168765, 5294.258803767476, 5298.576113910878, 5336.092864213054, 5358.0, 3549.8757543485854, 3576.409892367756, 3582.265635544707, 3611.0, 3647.6534729200685, 990.9207263418981, 1044.107288268527, 1046.215338496128, 1063.5798859450551, 1070.7430216748003, 11394.259373140801, 11407.144464165138, 11460.541578336857, 11541.365224912626, 11565.710857228552, 4280.571942805756, 4631.722096674143, 4839.879003024953, 4842.491538388489, 4872.902541949141, 7809.0, 9703.66037188695, 9775.560099795526, 9780.119789219005, 9787.608495660093, 5307.867303317371, 5328.200769884548, 5333.200019997032, 5337.386200586904, 5337.786488540415, 4386.627136693417, 4715.976420117878, 4890.926636100461, 4899.265110233422, 4906.901861962812, 3998.140399814054, 4019.055521952339, 4096.713230073866, 4130.586941305845, 4137.234611596864, 1319.6766792135795, 1361.6035777032494, 1363.7136201397818, 1365.4469939674448, 1366.1666383506054, 893.9284857211408, 909.3043821476575, 912.0924679943498, 928.944263344188, 938.6389734884308, 5911.527077833763, 5937.762489500372, 6047.12316714074, 6048.0625503047095, 6085.269767627913, 441.5849101844256, 452.0597157911536, 457.3505622016744, 468.98358557450325, 469.77450823604863, 3949.269385163754, 4009.498812648419, 4051.311277082903, 4066.9796651016554, 4075.184963007351, 8183.918160818434, 10515.474226288808, 10575.471226438647, 10715.24993250465, 10731.785364292671, 10382.065614094769, 10493.842592361121, 10543.947280263703, 10581.735456613493, 10656.094231990368, 6708.597484150967, 8041.517508949481, 8090.826830109719, 8101.987251593669, 8209.220124088202, 5783.797567085132, 5784.50831679312, 5831.620944638585, 5906.793262235801, 5915.645061296336, 9792.412455252708, 9838.852417213604, 9840.852387214341, 9864.802703945737, 9897.50512474359, 8993.605991071394, 9382.296327775308, 9561.330706850455, 9607.13535781783, 10087.445190514592, 6982.371586557031, 7328.303811138147, 7516.210797866145, 7981.8403631928195, 8180.509169449852, 7047.823804404931, 8155.469894456842, 8173.509589424653, 8228.053773816087, 8330.291925186184, 7264.891026634499, 7343.0, 7381.778546643609, 7473.962630186814, 7481.17707052213, 6401.679916004275, 7214.206437291999, 7252.927470725436, 7276.818079547842, 7291.0, 5657.8019769307875, 6565.671716414065, 7054.188768291712, 7059.71761129549, 7089.503734738519, 4726.36194113804, 4785.808567657394, 4832.178529649897, 4915.287283343823, 5009.198528235464, 4844.927326090041, 4884.291777692286, 4900.975495122501, 4993.975030124826, 5104.69371837691], "value": 4480.543181264607, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.7546227136241, 321.4663658327176, 329.26409474823765, 332.41992722698876, 334.14625631511507, 6142.140100385944, 6309.652969086698, 6370.617762934227, 6396.616203027822, 6401.519886008545, 5819.632386389195, 6201.751929922798, 6252.874942501147, 6292.905606415908, 6334.049892516125, 3427.931441371171, 3801.619838016204, 4519.638428925695, 4614.284785858181, 4644.767761611923, 4244.0238745088645, 4551.317302404649, 4612.953870461302, 4624.953750462503, 4706.388169537955, 3610.8806270056234, 4033.7983100844986, 4082.918026722906, 4464.995376040398, 4591.563801438858, 3956.7625942443547, 4591.471980722226, 4593.885152871171, 4604.79278432468, 4653.488116307203, 3934.409838524244, 3939.98030009851, 3966.4050392441077, 3968.72218944674, 3989.960100398988, 5221.895562088775, 5957.642541447527, 5981.790637327673, 6021.187139736124, 6046.788362407338, 5168.612354073422, 5197.8960420791755, 5452.454754524555, 5480.808171713971, 5502.174673798922, 5646.802361917313, 6106.603070800384, 6643.966780166068, 6650.900236496456, 6654.900176497356, 4247.277962746341, 4275.337322714984, 4329.134173165348, 4480.260756975095, 4484.094259939513, 6175.783847565313, 6837.623930683811, 6985.3713165815325, 7005.789826305168, 7021.648917554102, 3845.307844588001, 4392.560743925582, 4519.525449827721, 4526.253168227271, 4535.138323718549, 4415.27148020573, 4498.190325741398, 4601.539846015438, 4610.639861240942, 4638.350630911675, 5387.81142660005, 5416.864578385572, 5462.617616766788, 5471.343438787291, 5475.753591088331, 5210.635255532152, 6014.338422773491, 6448.935925572322, 6641.33586641332, 6653.800385988428, 1457.6501639606417, 1558.9376424942875, 1571.2379495944458, 1591.9761203581957, 1596.7684685720737, 990.2820455170088, 1032.8140934631688, 1039.9844002339971, 1055.6410820321128, 1069.994650026745, 5422.674639521641, 6108.389161083945, 6165.6570503208495, 6173.783917562864, 6179.660118693515, 5574.442555744393, 5927.644341339534, 6806.897896531556, 6848.0, 6850.862982740317, 5261.842144735664, 5932.0, 6135.815925522153, 6137.140800287963, 6151.938480615226, 3542.71658267338, 3618.5476815398074, 3618.819059047037, 3625.945610815787, 3636.61815509373, 6749.291324410964, 6997.0, 7056.259092795285, 7078.681459334342, 7079.82300442493, 5817.50551203144, 6913.686399584063, 6939.322159255603, 7000.61496617691, 7013.26360732126, 6752.257251702309, 7070.964645176741, 7088.574685518885, 7241.674124664402, 7252.7208946721685, 5796.710164491674, 6897.482688798461, 6898.551594146365, 6911.136107986502, 6978.267281935324, 6288.685565721604, 6776.728930842908, 6813.386795188457, 6822.874225752696, 6827.21487028998, 7256.2743725627015, 7260.128784545888, 7273.709051637875, 7290.198078211286, 7323.157836848831, 4283.0363168286885, 4397.494288156903, 4419.9116017678825, 4421.314696222091, 4437.445319335083, 6502.0246962955935, 6848.623325716934, 6884.311568843075, 6888.931110688829, 6926.376626103674, 6109.541784366102, 6400.94325482882, 6600.504962127764, 6661.600303981777, 6726.091977582963, 6380.9361906380345, 6667.633280169637, 6669.065970868393, 6696.229933557704, 6700.162479690039, 4765.451973023008, 5048.343715316985, 5678.971605141948, 6194.318624951342, 6553.4101930826455, 5030.622703297194, 5940.732667030081, 6228.408301211378, 6567.9671601641685, 6741.22475915276, 6140.20177376956, 6540.215174179129, 6560.770373036921, 6581.539292249497, 6598.307177746267], "value": 4784.474809271203, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.2410803467972, 664.7174950645975, 748.7529115391922, 757.3903008078498, 767.3285874859498, 14884.255787210637, 14885.032472889268, 14895.627609309773, 14998.700025999473, 15036.398544058224, 13958.371873265727, 13992.790108148385, 14032.29838508073, 14057.086289391207, 14068.788968165485, 722.2127880610134, 906.2251774732607, 923.353652443289, 939.4222553129811, 945.6028468043404, 936.9578368973413, 937.8124375124968, 941.6892425499603, 942.9905700943006, 943.8725772020758, 965.7295957132014, 978.0952618827556, 984.1536278800262, 985.9950700246525, 992.1318846009741, 967.274544091931, 970.3838062830154, 977.5307852230933, 979.9069088436659, 982.287841315048, 704.1303989572873, 728.9307515785991, 729.1468981291902, 733.1532080447092, 733.6148522025926, 15174.317155728018, 15188.164650944194, 15206.239688015556, 15240.695186096327, 15288.082715037133, 12441.377931103409, 12568.245905245623, 12593.74812503754, 12603.558875439316, 12736.426860791194, 10734.790466395798, 10901.0, 11138.0, 11193.888061119365, 11224.0, 4064.3700226464944, 4095.365218391154, 4095.5904409559103, 4214.494260688737, 4302.311630139163, 84139.73790393087, 84198.15801841965, 86226.0, 86606.0, 87860.12139878584, 9533.189678877374, 9653.951730241304, 9694.660686875926, 9764.218862490983, 9937.205023598095, 21906.23328183538, 22021.66967495489, 22733.658995115085, 22819.315420537412, 22830.200942966916, 7617.390608751287, 7665.080190377191, 7672.347850432664, 8001.8399632008195, 8100.2304781045705, 4048.3725022621543, 4075.694322925792, 4106.178764247103, 4107.9178416432105, 4120.052387950788, 2935.544990526472, 3254.316593515341, 3557.6442355764216, 3655.1593133579427, 3696.667299943018, 650.8340373204898, 656.8325077105403, 668.0413606474724, 676.2527407215055, 676.9763058293034, 516.7571241516481, 528.6273177409917, 550.8512701570553, 570.6404964872104, 588.7350692188533, 7978.401619878532, 7990.440669153103, 8157.428979971463, 8274.338052955749, 8310.59811122775, 485.26482379195545, 513.1661050792462, 513.8252993982064, 519.1434133679459, 569.0411656359048, 3227.8870239541975, 3875.5349358076646, 3925.9214815703526, 3939.1924655445564, 4096.32410652245, 65206.347936520026, 84300.15699843045, 84409.0, 84625.37722085735, 84785.0, 70802.0, 73245.63377183187, 73557.6322118386, 74260.62869685618, 75513.0, 62120.0, 62542.374576254566, 63310.68344658247, 64871.35128648747, 66013.66993165003, 7040.683169257293, 7577.696892124253, 7762.379009679099, 7837.373010159287, 7926.959723362532, 41634.375484367156, 42012.0, 42568.57431425646, 42892.571074288855, 43239.13521729485, 55938.0, 58655.4134458667, 59005.0, 59205.111923322045, 59777.10334344902, 10155.898441015495, 10183.0, 10240.795184096425, 10330.948345258226, 10588.41763702973, 10665.89334106649, 10773.569057237935, 10791.892081079088, 10799.40603266828, 10831.620893268699, 10193.388396695926, 10288.742781430525, 10406.635767748092, 10670.30643008202, 10683.25217234786, 10124.898751012395, 10196.235282353704, 10201.84697229557, 10581.206409519164, 10623.628173013907, 10018.298719089593, 10050.64822731201, 10112.696619101438, 10135.746606334606, 10461.47692615351, 7963.960180199062, 8804.163604457566, 8856.690015849414, 9025.503597302211, 9132.49771262587, 8218.958905205674, 8701.608427620646, 8903.821923561622, 9067.863982040406, 9356.532173391439], "value": 6727.563785445936, "unit": "score"}], "name": "dromaeo_css", "value": 7253.8027225837495, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 118.0, 116.0, 117.0, 128.0, 117.0, 116.0, 116.0, 141.0], "value": 118.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 175.0, 172.0, 122.0, 142.0, 126.0, 155.0, 163.0, 125.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 200.0, 208.0, 220.0, 200.0, 202.0, 225.0, 259.0, 199.0, 199.0], "value": 211.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 73.0, 80.0, 148.0, 84.0, 51.0, 49.0, 92.0, 159.0, 49.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 129.0, 77.0, 80.0, 87.0, 118.0, 82.0, 84.0, 101.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 89.0, 92.0, 89.0, 91.0, 87.0, 92.0, 92.0, 122.0, 109.0], "value": 95.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 98.0, 121.0, 152.0, 151.0, 98.0, 97.0, 105.0, 108.0], "value": 112.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 101.0, 82.0, 150.0, 153.0, 125.0, 92.0, 93.0, 93.0, 96.0], "value": 107.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 62.0, 62.0, 62.0, 61.0, 62.0, 78.0, 64.0, 61.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 72.0, 88.0, 81.0, 73.0, 63.0, 69.0, 69.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 90.0, 89.0, 89.0, 90.0, 90.0, 90.0, 84.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 167.0, 152.0, 165.0, 168.0, 162.0, 151.0, 149.0, 180.0, 151.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 174.0, 173.0, 178.0, 173.0, 174.0, 172.0, 194.0, 199.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 69.0, 102.0, 107.0, 99.0, 71.0, 70.0, 69.0], "value": 79.8, "unit": "score"}], "name": "kraken", "value": 1612.7999999999997, "alertThreshold": 2.0}]} 05:56:41 INFO - Return code: 0 05:56:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:56:41 ERROR - # TBPL SUCCESS # 05:56:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:56:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:56:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:56:41 INFO - 2016-04-14 05:56:41.393 screenresolution[6172:105457] starting screenresolution argv=screenresolution get 05:56:41 INFO - 2016-04-14 05:56:41.396 screenresolution[6172:105457] Display 0: 1600x1200x32@60 05:56:41 INFO - 2016-04-14 05:56:41.402 screenresolution[6173:105460] starting screenresolution argv=screenresolution list 05:56:41 INFO - Available Modes on Display 0 05:56:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:56:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:56:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:56:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:56:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:56:41 INFO - Intel Iris: 05:56:41 INFO - Chipset Model: Intel Iris 05:56:41 INFO - Type: GPU 05:56:41 INFO - Bus: Built-In 05:56:41 INFO - VRAM (Dynamic, Max): 1536 MB 05:56:41 INFO - Vendor: Intel (0x8086) 05:56:41 INFO - Device ID: 0x0a2e 05:56:41 INFO - Revision ID: 0x0009 05:56:41 INFO - Displays: 05:56:41 INFO - Display: 05:56:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:56:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:56:41 INFO - Display Serial Number: 1600x1200 60 05:56:41 INFO - Main Display: Yes 05:56:41 INFO - Mirror: Off 05:56:41 INFO - Online: Yes 05:56:41 INFO - Rotation: Supported 05:56:41 INFO - Return code: 0 05:56:41 INFO - Running post-action listener: _resource_record_post_action 05:56:41 INFO - Running post-run listener: _resource_record_post_run 05:56:42 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 8703488; Write bytes: 697660416; Read time: 98; Write time: 2135 05:56:42 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 372994560; Write bytes: 366931456; Read time: 27806; Write time: 746 05:56:42 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 8703488; Write bytes: 301471232; Read time: 98; Write time: 1333 05:56:42 INFO - Running post-run listener: _upload_blobber_files 05:56:42 INFO - Blob upload gear active. 05:56:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:56:42 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 05:56:42 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:56:42 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:56:43 INFO - (blobuploader) - INFO - Open directory for files ... 05:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:56:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:44 INFO - (blobuploader) - INFO - Done attempting. 05:56:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:56:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:46 INFO - (blobuploader) - INFO - Done attempting. 05:56:46 INFO - (blobuploader) - INFO - Iteration through files over. 05:56:46 INFO - Return code: 0 05:56:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:56:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:56:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80091b8456bbefcfa8ab2466fa61b6b6b3f36785583bdcf2d7f7d447068fc8048e03ac3253db8aae9965c1d64d224f9c00300d6004cf8d085744a7ec08732c10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e891abee5a5584bdcef7f2c248bc240dce363ac34fcc198de7543538723cc2c2f07d4272ba8c4dc9c1279a083b27be3c2ea1d8ba1648f00b005281afdb1815cf"} 05:56:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:56:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:56:46 INFO - Contents: 05:56:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80091b8456bbefcfa8ab2466fa61b6b6b3f36785583bdcf2d7f7d447068fc8048e03ac3253db8aae9965c1d64d224f9c00300d6004cf8d085744a7ec08732c10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e891abee5a5584bdcef7f2c248bc240dce363ac34fcc198de7543538723cc2c2f07d4272ba8c4dc9c1279a083b27be3c2ea1d8ba1648f00b005281afdb1815cf"} 05:56:46 INFO - Running post-run listener: copy_logs_to_upload_dir 05:56:46 INFO - Copying logs to upload dir... 05:56:46 INFO - mkdir: /builds/slave/test/build/upload/logs 05:56:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.980044 ========= master_lag: 11.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-04-14 05:56:58.135442) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-04-14 05:56:58.136528) ========= 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.kkCteiba0w/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.O3CDZp5x96/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80091b8456bbefcfa8ab2466fa61b6b6b3f36785583bdcf2d7f7d447068fc8048e03ac3253db8aae9965c1d64d224f9c00300d6004cf8d085744a7ec08732c10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e891abee5a5584bdcef7f2c248bc240dce363ac34fcc198de7543538723cc2c2f07d4272ba8c4dc9c1279a083b27be3c2ea1d8ba1648f00b005281afdb1815cf"} build_url:https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/E-wsmZcDRIyo94QW9bk2ZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80091b8456bbefcfa8ab2466fa61b6b6b3f36785583bdcf2d7f7d447068fc8048e03ac3253db8aae9965c1d64d224f9c00300d6004cf8d085744a7ec08732c10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e891abee5a5584bdcef7f2c248bc240dce363ac34fcc198de7543538723cc2c2f07d4272ba8c4dc9c1279a083b27be3c2ea1d8ba1648f00b005281afdb1815cf"}' ========= master_lag: 5.62 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-04-14 05:57:03.772006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-14 05:57:03.772300) ========= 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.kkCteiba0w/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.O3CDZp5x96/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005285 ========= master_lag: 2.96 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-14 05:57:06.738097) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-04-14 05:57:06.738392) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-04-14 05:57:10.520758) ========= ========= Total master_lag: 20.47 =========