builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0176 starttime: 1460750820.63 results: success (0) buildid: 20160415110147 builduid: 183ae156ad8945b3951829d2cb87ff8b revision: 354cb3932e36994d7e772cedba237e9c3c60fe4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:00.626536) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:00.626943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:00.627218) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:00.742048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:00.742302) ========= 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.0yGw5F1obc/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.jJ1M40lsaE/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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-15 13:07:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-04-15 13:07:00 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131252 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:00.901889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:00.902285) ========= 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.0yGw5F1obc/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.jJ1M40lsaE/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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.033306 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:00.962351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 13:07:00.962694) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 354cb3932e36994d7e772cedba237e9c3c60fe4c --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 354cb3932e36994d7e772cedba237e9c3c60fe4c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0yGw5F1obc/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.jJ1M40lsaE/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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-15 13:07:01,034 truncating revision to first 12 chars 2016-04-15 13:07:01,034 Setting DEBUG logging. 2016-04-15 13:07:01,034 attempt 1/10 2016-04-15 13:07:01,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/354cb3932e36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 13:07:02,091 unpacking tar archive at: mozilla-central-354cb3932e36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.305114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 13:07:02.286302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:02.286573) ========= script_repo_revision: 354cb3932e36994d7e772cedba237e9c3c60fe4c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:02.286938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:02.287199) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 13:07:02.304797) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-15 13:07:02.305088) ========= /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.0yGw5F1obc/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.jJ1M40lsaE/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 13:07:02 INFO - MultiFileLogger online at 20160415 13:07:02 in /builds/slave/test 13:07:02 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 13:07:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:02 INFO - {'append_to_log': False, 13:07:02 INFO - 'base_work_dir': '/builds/slave/test', 13:07:02 INFO - 'blob_upload_branch': 'Firefox', 13:07:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:02 INFO - 'branch': 'Firefox', 13:07:02 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:02 INFO - 'config_files': ('talos/mac_config.py',), 13:07:02 INFO - 'default_actions': ('clobber', 13:07:02 INFO - 'read-buildbot-config', 13:07:02 INFO - 'download-and-extract', 13:07:02 INFO - 'populate-webroot', 13:07:02 INFO - 'create-virtualenv', 13:07:02 INFO - 'install', 13:07:02 INFO - 'run-tests'), 13:07:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:02 INFO - 'download_minidump_stackwalk': True, 13:07:02 INFO - 'download_symbols': 'ondemand', 13:07:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:02 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:02 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:02 INFO - 'installer_path': 'installer.exe', 13:07:02 INFO - 'log_level': 'info', 13:07:02 INFO - 'log_name': 'talos', 13:07:02 INFO - 'log_to_console': True, 13:07:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:07:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:07:02 INFO - 'opt_config_files': (), 13:07:02 INFO - 'pip_index': False, 13:07:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:07:02 INFO - 'cmd': ('bash', 13:07:02 INFO - '-c', 13:07:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:07:02 INFO - 'enabled': True, 13:07:02 INFO - 'halt_on_failure': False, 13:07:02 INFO - 'name': 'check_screen_resolution'},), 13:07:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:07:02 INFO - 'cmd': ('bash', 13:07:02 INFO - '-c', 13:07:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:07:02 INFO - 'enabled': True, 13:07:02 INFO - 'halt_on_failure': False, 13:07:02 INFO - 'name': 'check_screen_resolution'},), 13:07:02 INFO - 'run_cmd_checks_enabled': True, 13:07:02 INFO - 'sps_profile': False, 13:07:02 INFO - 'sps_profile_interval': 0, 13:07:02 INFO - 'suite': 'dromaeojs-e10s', 13:07:02 INFO - 'system_bits': '32', 13:07:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:02 INFO - 'title': 't-yosemite-r7-0176', 13:07:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:02 INFO - 'use_talos_json': True, 13:07:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:02 INFO - 'work_dir': 'build'} 13:07:02 INFO - ##### 13:07:02 INFO - ##### Running clobber step. 13:07:02 INFO - ##### 13:07:02 INFO - Running pre-action listener: _resource_record_pre_action 13:07:02 INFO - Running main action method: clobber 13:07:02 INFO - rmtree: /builds/slave/test/build 13:07:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:04 INFO - Running post-action listener: _resource_record_post_action 13:07:04 INFO - ##### 13:07:04 INFO - ##### Running read-buildbot-config step. 13:07:04 INFO - ##### 13:07:04 INFO - Running pre-action listener: _resource_record_pre_action 13:07:04 INFO - Running main action method: read_buildbot_config 13:07:04 INFO - Using buildbot properties: 13:07:04 INFO - { 13:07:04 INFO - "project": "", 13:07:04 INFO - "product": "firefox", 13:07:04 INFO - "script_repo_revision": "production", 13:07:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:07:04 INFO - "repository": "", 13:07:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:07:04 INFO - "buildid": "20160415110147", 13:07:04 INFO - "pgo_build": "False", 13:07:04 INFO - "basedir": "/builds/slave/test", 13:07:04 INFO - "buildnumber": 191, 13:07:04 INFO - "slavename": "t-yosemite-r7-0176", 13:07:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:07:04 INFO - "platform": "yosemite_r7", 13:07:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:07:04 INFO - "branch": "mozilla-central", 13:07:04 INFO - "repo_path": "mozilla-central", 13:07:04 INFO - "revision": "354cb3932e36994d7e772cedba237e9c3c60fe4c", 13:07:04 INFO - "stage_platform": "macosx64", 13:07:04 INFO - "builduid": "183ae156ad8945b3951829d2cb87ff8b", 13:07:04 INFO - "slavebuilddir": "test" 13:07:04 INFO - } 13:07:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 13:07:04 INFO - Running post-action listener: _resource_record_post_action 13:07:04 INFO - ##### 13:07:04 INFO - ##### Running download-and-extract step. 13:07:04 INFO - ##### 13:07:04 INFO - Running pre-action listener: _resource_record_pre_action 13:07:04 INFO - Running main action method: download_and_extract 13:07:04 INFO - mkdir: /builds/slave/test/build/tests 13:07:04 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')]} 13:07:04 INFO - https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:07:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:07:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:07:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/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 13:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/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 13:07:06 INFO - Downloaded 1199 bytes. 13:07:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 13:07:06 INFO - Using the following test package requirements: 13:07:06 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:07:06 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:07:06 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 13:07:06 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:07:06 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 13:07:06 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:07:06 INFO - u'jsshell-mac.zip'], 13:07:06 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:07:06 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 13:07:06 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:07:06 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:07:06 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 13:07:06 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:07:06 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 13:07:06 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:07:06 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 13:07:06 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:07:06 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 13:07:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:06 INFO - https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:07:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:07:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:07:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/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 13:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/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 13:07:08 INFO - Downloaded 18030636 bytes. 13:07:08 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'] 13:07:08 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 13:07:11 INFO - Return code: 0 13:07:11 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 13:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:11 INFO - https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:07:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:07:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:07:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/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 13:07:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/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 13:07:20 INFO - Downloaded 18030636 bytes. 13:07:20 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'] 13:07:20 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 13:07:24 INFO - Return code: 0 13:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:24 INFO - https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:07:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:07:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:07:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/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 13:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/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 13:07:25 INFO - Downloaded 10841076 bytes. 13:07:25 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'] 13:07:25 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 13:07:25 INFO - Return code: 0 13:07: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')]} 13:07:25 INFO - https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:07:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:07:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:07:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 13:07:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Igo4IgpLRyasEQkfMkUaXQ/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 13:07:31 INFO - Downloaded 109943530 bytes. 13:07:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:07:31 INFO - mkdir: /builds/slave/test/properties 13:07:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:07:31 INFO - Writing to file /builds/slave/test/properties/build_url 13:07:31 INFO - Contents: 13:07:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:07:32 INFO - Running post-action listener: _resource_record_post_action 13:07:32 INFO - Running post-action listener: set_extra_try_arguments 13:07:32 INFO - ##### 13:07:32 INFO - ##### Running populate-webroot step. 13:07:32 INFO - ##### 13:07:32 INFO - Running pre-action listener: _resource_record_pre_action 13:07:32 INFO - Running main action method: populate_webroot 13:07:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:07:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:07:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:07:32 INFO - '--tppagecycles', 13:07:32 INFO - '7'], 13:07:32 INFO - 'tests': ['tsvgm']}}, 13:07:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:07:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:07:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:07:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:07:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:07:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:07:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:32 INFO - 'talos_options': ['--disable-e10s'], 13:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:32 INFO - 'talos_options': ['--disable-e10s'], 13:07:32 INFO - 'tests': ['damp', 'tps']}, 13:07:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:32 INFO - 'tests': ['damp', 'tps']}, 13:07:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:07:32 INFO - 'tests': ['dromaeo_dom']}, 13:07:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:07:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:07:32 INFO - 'tests': ['a11yr', 13:07:32 INFO - 'ts_paint', 13:07:32 INFO - 'tpaint', 13:07:32 INFO - 'sessionrestore', 13:07:32 INFO - 'sessionrestore_no_auto_restore', 13:07:32 INFO - 'tabpaint']}, 13:07:32 INFO - 'other-e10s': {'tests': ['a11yr', 13:07:32 INFO - 'ts_paint', 13:07:32 INFO - 'tpaint', 13:07:32 INFO - 'sessionrestore', 13:07:32 INFO - 'sessionrestore_no_auto_restore', 13:07:32 INFO - 'tabpaint']}, 13:07:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:07:32 INFO - 'ts_paint', 13:07:32 INFO - 'tpaint', 13:07:32 INFO - 'sessionrestore', 13:07:32 INFO - 'sessionrestore_no_auto_restore', 13:07:32 INFO - 'tabpaint']}, 13:07:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:07:32 INFO - 'ts_paint', 13:07:32 INFO - 'tpaint', 13:07:32 INFO - 'sessionrestore', 13:07:32 INFO - 'sessionrestore_no_auto_restore', 13:07:32 INFO - 'tabpaint']}, 13:07:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:07:32 INFO - 'tests': ['a11yr', 13:07:32 INFO - 'ts_paint', 13:07:32 INFO - 'tpaint', 13:07:32 INFO - 'sessionrestore', 13:07:32 INFO - 'sessionrestore_no_auto_restore', 13:07:32 INFO - 'tabpaint']}, 13:07:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:07:32 INFO - 'tests': ['a11yr', 13:07:32 INFO - 'ts_paint', 13:07:32 INFO - 'tpaint', 13:07:32 INFO - 'sessionrestore', 13:07:32 INFO - 'sessionrestore_no_auto_restore', 13:07:32 INFO - 'tabpaint']}, 13:07:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:07:32 INFO - 'tests': ['tsvgx', 13:07:32 INFO - 'tsvgr_opacity', 13:07:32 INFO - 'tart', 13:07:32 INFO - 'tscrollx', 13:07:32 INFO - 'cart']}, 13:07:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:07:32 INFO - 'tsvgr_opacity', 13:07:32 INFO - 'tart', 13:07:32 INFO - 'tscrollx', 13:07:32 INFO - 'cart']}, 13:07:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:32 INFO - 'talos_options': ['--disable-e10s'], 13:07:32 INFO - 'tests': ['tp5o']}, 13:07:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:32 INFO - 'tests': ['tp5o']}, 13:07:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:32 INFO - 'talos_options': ['--disable-e10s', 13:07:32 INFO - '--xperf_path', 13:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:32 INFO - 'tests': ['tp5n']}, 13:07:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:32 INFO - 'talos_options': ['--xperf_path', 13:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:32 INFO - 'tests': ['tp5n']}}, 13:07:32 INFO - 'talos.zip': {'path': '', 13:07:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:07:32 INFO - Running post-action listener: _resource_record_post_action 13:07:32 INFO - ##### 13:07:32 INFO - ##### Running create-virtualenv step. 13:07:32 INFO - ##### 13:07:32 INFO - Running pre-action listener: _resource_record_pre_action 13:07:32 INFO - Running main action method: create_virtualenv 13:07:32 INFO - Creating virtualenv /builds/slave/test/build/venv 13:07:32 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 13:07:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:07:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:07:32 INFO - Using real prefix '/tools/python27' 13:07:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:07:33 INFO - Installing distribute.............................................................................................................................................................................................done. 13:07:36 INFO - Installing pip.................done. 13:07:36 INFO - Return code: 0 13:07:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:07:36 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')]} 13:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:36 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')]} 13:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:36 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 0x10f69fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6af420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb403c813a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ee00>, '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 0x10f3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f539b20>, '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.0yGw5F1obc/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.jJ1M40lsaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 13:07:36 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 13:07:36 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 13:07:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0yGw5F1obc/Render', 13:07:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:07:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:07:36 INFO - 'HOME': '/Users/cltbld', 13:07:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:07:36 INFO - 'LOGNAME': 'cltbld', 13:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:36 INFO - 'MOZ_NO_REMOTE': '1', 13:07:36 INFO - 'NO_EM_RESTART': '1', 13:07:36 INFO - 'PAGER': '/bin/cat', 13:07:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:36 INFO - 'PWD': '/builds/slave/test', 13:07:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:07:36 INFO - 'SHELL': '/bin/bash', 13:07:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jJ1M40lsaE/Listeners', 13:07:36 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 13:07:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:07:36 INFO - 'USER': 'cltbld', 13:07:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:07:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:36 INFO - 'XPC_FLAGS': '0x0', 13:07:36 INFO - 'XPC_SERVICE_NAME': '0', 13:07:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:36 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 13:07:36 INFO - Cleaning up... 13:07:36 INFO - Return code: 0 13:07:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:07:36 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')]} 13:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:36 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')]} 13:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:36 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 0x10f69fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6af420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb403c813a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ee00>, '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 0x10f3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f539b20>, '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.0yGw5F1obc/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.jJ1M40lsaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 13:07:36 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 13:07:36 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 13:07:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0yGw5F1obc/Render', 13:07:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:07:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:07:36 INFO - 'HOME': '/Users/cltbld', 13:07:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:07:36 INFO - 'LOGNAME': 'cltbld', 13:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:36 INFO - 'MOZ_NO_REMOTE': '1', 13:07:36 INFO - 'NO_EM_RESTART': '1', 13:07:36 INFO - 'PAGER': '/bin/cat', 13:07:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:36 INFO - 'PWD': '/builds/slave/test', 13:07:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:07:36 INFO - 'SHELL': '/bin/bash', 13:07:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jJ1M40lsaE/Listeners', 13:07:36 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 13:07:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:07:36 INFO - 'USER': 'cltbld', 13:07:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:07:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:36 INFO - 'XPC_FLAGS': '0x0', 13:07:36 INFO - 'XPC_SERVICE_NAME': '0', 13:07:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:37 INFO - Downloading/unpacking psutil>=0.7.1 13:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:07:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:40 INFO - Installing collected packages: psutil 13:07:40 INFO - Running setup.py install for psutil 13:07:40 INFO - building 'psutil._psutil_osx' extension 13:07:40 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 13:07:40 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 13:07:40 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 13:07:40 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 13:07:41 INFO - building 'psutil._psutil_posix' extension 13:07:41 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 13:07:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:07:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:07:41 INFO - ^ 13:07:41 INFO - 1 warning generated. 13:07:41 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 13:07:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:41 INFO - Successfully installed psutil 13:07:41 INFO - Cleaning up... 13:07:41 INFO - Return code: 0 13:07:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:41 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 0x10f69fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6af420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb403c813a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ee00>, '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 0x10f3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f539b20>, '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.0yGw5F1obc/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.jJ1M40lsaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 13:07:41 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 13:07:41 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 13:07:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0yGw5F1obc/Render', 13:07:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:07:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:07:41 INFO - 'HOME': '/Users/cltbld', 13:07:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:07:41 INFO - 'LOGNAME': 'cltbld', 13:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:41 INFO - 'MOZ_NO_REMOTE': '1', 13:07:41 INFO - 'NO_EM_RESTART': '1', 13:07:41 INFO - 'PAGER': '/bin/cat', 13:07:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:41 INFO - 'PWD': '/builds/slave/test', 13:07:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:07:41 INFO - 'SHELL': '/bin/bash', 13:07:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jJ1M40lsaE/Listeners', 13:07:41 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 13:07:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:07:41 INFO - 'USER': 'cltbld', 13:07:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:07:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:41 INFO - 'XPC_FLAGS': '0x0', 13:07:41 INFO - 'XPC_SERVICE_NAME': '0', 13:07:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:07:44 INFO - Installing collected packages: mozsystemmonitor 13:07:44 INFO - Running setup.py install for mozsystemmonitor 13:07:45 INFO - Successfully installed mozsystemmonitor 13:07:45 INFO - Cleaning up... 13:07:45 INFO - Return code: 0 13:07:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f69fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6af420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb403c813a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ee00>, '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 0x10f3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f539b20>, '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.0yGw5F1obc/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.jJ1M40lsaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 13:07:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:07:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0yGw5F1obc/Render', 13:07:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:07:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:07:45 INFO - 'HOME': '/Users/cltbld', 13:07:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:07:45 INFO - 'LOGNAME': 'cltbld', 13:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:45 INFO - 'MOZ_NO_REMOTE': '1', 13:07:45 INFO - 'NO_EM_RESTART': '1', 13:07:45 INFO - 'PAGER': '/bin/cat', 13:07:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:45 INFO - 'PWD': '/builds/slave/test', 13:07:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:07:45 INFO - 'SHELL': '/bin/bash', 13:07:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jJ1M40lsaE/Listeners', 13:07:45 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 13:07:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:07:45 INFO - 'USER': 'cltbld', 13:07:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:07:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:45 INFO - 'XPC_FLAGS': '0x0', 13:07:45 INFO - 'XPC_SERVICE_NAME': '0', 13:07:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:45 INFO - Downloading/unpacking blobuploader==1.2.4 13:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:47 INFO - Downloading blobuploader-1.2.4.tar.gz 13:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:07:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:07:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:49 INFO - Downloading docopt-0.6.1.tar.gz 13:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:07:49 INFO - Installing collected packages: blobuploader, requests, docopt 13:07:49 INFO - Running setup.py install for blobuploader 13:07:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:07:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:07:49 INFO - Running setup.py install for requests 13:07:49 INFO - Running setup.py install for docopt 13:07:49 INFO - Successfully installed blobuploader requests docopt 13:07:49 INFO - Cleaning up... 13:07:50 INFO - Return code: 0 13:07:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f69fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6af420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb403c813a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ee00>, '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 0x10f3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f539b20>, '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.0yGw5F1obc/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.jJ1M40lsaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 13:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:07:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0yGw5F1obc/Render', 13:07:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:07:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:07:50 INFO - 'HOME': '/Users/cltbld', 13:07:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:07:50 INFO - 'LOGNAME': 'cltbld', 13:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:50 INFO - 'MOZ_NO_REMOTE': '1', 13:07:50 INFO - 'NO_EM_RESTART': '1', 13:07:50 INFO - 'PAGER': '/bin/cat', 13:07:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:50 INFO - 'PWD': '/builds/slave/test', 13:07:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:07:50 INFO - 'SHELL': '/bin/bash', 13:07:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jJ1M40lsaE/Listeners', 13:07:50 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 13:07:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:07:50 INFO - 'USER': 'cltbld', 13:07:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:07:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:50 INFO - 'XPC_FLAGS': '0x0', 13:07:50 INFO - 'XPC_SERVICE_NAME': '0', 13:07:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-opaT9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-fbqMnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-0OklbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-0Ue8XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-7th3r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-wyztI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-AodVVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:51 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-4bSz1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:51 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-TGh46S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:51 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-Nx4aGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:51 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-sZKyFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:51 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-XJRoTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:51 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-KDc30K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:51 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-RPaX57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:51 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-3TporF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:51 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-IPhEiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:51 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-h2Y2rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:07:52 INFO - Running setup.py install for manifestparser 13:07:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:07:52 INFO - Running setup.py install for mozcrash 13:07:52 INFO - Running setup.py install for mozdebug 13:07:52 INFO - Running setup.py install for mozdevice 13:07:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:07:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:07:52 INFO - Running setup.py install for mozfile 13:07:52 INFO - Running setup.py install for mozhttpd 13:07:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:07:52 INFO - Running setup.py install for mozinfo 13:07:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for mozInstall 13:07:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for mozleak 13:07:53 INFO - Running setup.py install for mozlog 13:07:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for moznetwork 13:07:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for mozprocess 13:07:53 INFO - Running setup.py install for mozprofile 13:07:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:07:53 INFO - Running setup.py install for mozrunner 13:07:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:07:54 INFO - Running setup.py install for mozscreenshot 13:07:54 INFO - Running setup.py install for moztest 13:07:54 INFO - Running setup.py install for mozversion 13:07:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:07:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:07:54 INFO - Cleaning up... 13:07:54 INFO - Return code: 0 13:07:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f69fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6af420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb403c813a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ee00>, '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 0x10f3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f539b20>, '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.0yGw5F1obc/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.jJ1M40lsaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 13:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:07:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0yGw5F1obc/Render', 13:07:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:07:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:07:54 INFO - 'HOME': '/Users/cltbld', 13:07:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:07:54 INFO - 'LOGNAME': 'cltbld', 13:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:54 INFO - 'MOZ_NO_REMOTE': '1', 13:07:54 INFO - 'NO_EM_RESTART': '1', 13:07:54 INFO - 'PAGER': '/bin/cat', 13:07:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:54 INFO - 'PWD': '/builds/slave/test', 13:07:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:07:54 INFO - 'SHELL': '/bin/bash', 13:07:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jJ1M40lsaE/Listeners', 13:07:54 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 13:07:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:07:54 INFO - 'USER': 'cltbld', 13:07:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:07:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:54 INFO - 'XPC_FLAGS': '0x0', 13:07:54 INFO - 'XPC_SERVICE_NAME': '0', 13:07:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:54 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-MdVacc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-DT6v0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-mnzRM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-WBjus5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-8_SQpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-NBqwFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-1hE1Of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-_nmGYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:55 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-bsAuTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:55 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-OtBXeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:55 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)) 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-62kY5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:56 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-5VItUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:56 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-rFRw3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:56 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-DiGJkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:56 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-PoKXKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:56 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-Uqsrqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:56 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-jl4gHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:07:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:59 INFO - Downloading blessings-1.6.tar.gz 13:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:07:59 INFO - Installing collected packages: blessings 13:07:59 INFO - Running setup.py install for blessings 13:07:59 INFO - Successfully installed blessings 13:07:59 INFO - Cleaning up... 13:07:59 INFO - Return code: 0 13:07:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:07:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:07:59 INFO - Reading from file tmpfile_stdout 13:07:59 INFO - Current package versions: 13:07:59 INFO - blessings == 1.6 13:07:59 INFO - blobuploader == 1.2.4 13:07:59 INFO - docopt == 0.6.1 13:07:59 INFO - manifestparser == 1.1 13:07:59 INFO - mozInstall == 1.12 13:07:59 INFO - mozcrash == 0.17 13:07:59 INFO - mozdebug == 0.1 13:07:59 INFO - mozdevice == 0.48 13:07:59 INFO - mozfile == 1.2 13:07:59 INFO - mozhttpd == 0.7 13:07:59 INFO - mozinfo == 0.9 13:07:59 INFO - mozleak == 0.1 13:07:59 INFO - mozlog == 3.1 13:07:59 INFO - moznetwork == 0.27 13:07:59 INFO - mozprocess == 0.22 13:07:59 INFO - mozprofile == 0.28 13:07:59 INFO - mozrunner == 6.11 13:07:59 INFO - mozscreenshot == 0.1 13:07:59 INFO - mozsystemmonitor == 0.0 13:07:59 INFO - moztest == 0.7 13:07:59 INFO - mozversion == 1.4 13:07:59 INFO - psutil == 3.1.1 13:07:59 INFO - requests == 1.2.3 13:07:59 INFO - wsgiref == 0.1.2 13:07:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:59 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')]} 13:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:59 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')]} 13:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:59 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 0x10f69fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6af420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb403c813a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ee00>, '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 0x10f3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f539b20>, '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.0yGw5F1obc/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.jJ1M40lsaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 13:07:59 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 13:07:59 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 13:07:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0yGw5F1obc/Render', 13:07:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:07:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:07:59 INFO - 'HOME': '/Users/cltbld', 13:07:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:07:59 INFO - 'LOGNAME': 'cltbld', 13:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:59 INFO - 'MOZ_NO_REMOTE': '1', 13:07:59 INFO - 'NO_EM_RESTART': '1', 13:07:59 INFO - 'PAGER': '/bin/cat', 13:07:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:59 INFO - 'PWD': '/builds/slave/test', 13:07:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:07:59 INFO - 'SHELL': '/bin/bash', 13:07:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jJ1M40lsaE/Listeners', 13:07:59 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 13:07:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:07:59 INFO - 'USER': 'cltbld', 13:07:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:07:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:59 INFO - 'XPC_FLAGS': '0x0', 13:07:59 INFO - 'XPC_SERVICE_NAME': '0', 13:07:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 INFO - Cleaning up... 13:07:59 INFO - Return code: 0 13:07:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:07:59 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')]} 13:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:59 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')]} 13:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:59 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 0x10f69fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6af420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb403c813a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ee00>, '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 0x10f3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f539b20>, '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.0yGw5F1obc/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.jJ1M40lsaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 13:07:59 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 13:07:59 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 13:07:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0yGw5F1obc/Render', 13:07:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:07:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:07:59 INFO - 'HOME': '/Users/cltbld', 13:07:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:07:59 INFO - 'LOGNAME': 'cltbld', 13:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:59 INFO - 'MOZ_NO_REMOTE': '1', 13:07:59 INFO - 'NO_EM_RESTART': '1', 13:07:59 INFO - 'PAGER': '/bin/cat', 13:07:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:59 INFO - 'PWD': '/builds/slave/test', 13:07:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:07:59 INFO - 'SHELL': '/bin/bash', 13:07:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jJ1M40lsaE/Listeners', 13:07:59 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 13:07:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:07:59 INFO - 'USER': 'cltbld', 13:07:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:07:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:59 INFO - 'XPC_FLAGS': '0x0', 13:07:59 INFO - 'XPC_SERVICE_NAME': '0', 13:07:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:00 INFO - Downloading/unpacking jsonschema 13:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:08:02 INFO - Downloading/unpacking functools32 (from jsonschema) 13:08:02 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 13:08:02 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 13:08:02 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 13:08:02 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 13:08:02 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 13:08:02 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 13:08:02 INFO - Downloading functools32-3.2.3-2.tar.gz 13:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:08:03 INFO - warning: no files found matching '*.txt' 13:08:03 INFO - no previously-included directories found matching 'build' 13:08:03 INFO - no previously-included directories found matching 'dist' 13:08:03 INFO - no previously-included directories found matching '.git*' 13:08:03 INFO - Installing collected packages: jsonschema, functools32 13:08:03 INFO - Running setup.py install for functools32 13:08:03 INFO - warning: no files found matching '*.txt' 13:08:03 INFO - no previously-included directories found matching 'build' 13:08:03 INFO - no previously-included directories found matching 'dist' 13:08:03 INFO - no previously-included directories found matching '.git*' 13:08:03 INFO - Successfully installed jsonschema functools32 13:08:03 INFO - Cleaning up... 13:08:03 INFO - Return code: 0 13:08:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f69fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6af420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb403c813a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f53ee00>, '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 0x10f3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f539b20>, '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.0yGw5F1obc/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.jJ1M40lsaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 13:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0yGw5F1obc/Render', 13:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:03 INFO - 'HOME': '/Users/cltbld', 13:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:03 INFO - 'LOGNAME': 'cltbld', 13:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:03 INFO - 'MOZ_NO_REMOTE': '1', 13:08:03 INFO - 'NO_EM_RESTART': '1', 13:08:03 INFO - 'PAGER': '/bin/cat', 13:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:03 INFO - 'PWD': '/builds/slave/test', 13:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:03 INFO - 'SHELL': '/bin/bash', 13:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jJ1M40lsaE/Listeners', 13:08:03 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 13:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:03 INFO - 'USER': 'cltbld', 13:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:03 INFO - 'XPC_FLAGS': '0x0', 13:08:03 INFO - 'XPC_SERVICE_NAME': '0', 13:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:03 INFO - Downloading/unpacking flake8 13:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:08:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:08:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:08:07 INFO - no previously-included directories found matching 'docs/_build' 13:08:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:08:07 INFO - Running setup.py install for pep8 13:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:08:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:08:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:08:07 INFO - no previously-included directories found matching 'docs/_build' 13:08:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:08:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:08:07 INFO - Cleaning up... 13:08:07 INFO - Return code: 0 13:08:07 INFO - Running post-action listener: _resource_record_post_action 13:08:07 INFO - Running post-action listener: _start_resource_monitoring 13:08:08 INFO - Starting resource monitoring. 13:08:08 INFO - ##### 13:08:08 INFO - ##### Running install step. 13:08:08 INFO - ##### 13:08:08 INFO - Running pre-action listener: _resource_record_pre_action 13:08:08 INFO - Running main action method: install 13:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:08 INFO - Reading from file tmpfile_stdout 13:08:08 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:08 INFO - Reading from file tmpfile_stdout 13:08:08 INFO - Output received: 13:08:08 INFO - Usage: mozinstall [options] installer 13:08:08 INFO - Options: 13:08:08 INFO - -h, --help show this help message and exit 13:08:08 INFO - -d DEST, --destination=DEST 13:08:08 INFO - Directory to install application into. [default: 13:08:08 INFO - "/builds/slave/test"] 13:08:08 INFO - --app=APP Application being installed. [default: firefox] 13:08:08 INFO - mkdir: /builds/slave/test/build/application 13:08:08 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'] 13:08:08 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 13:08:42 INFO - Reading from file tmpfile_stdout 13:08:42 INFO - Output received: 13:08:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:08:42 INFO - Running post-action listener: _resource_record_post_action 13:08:42 INFO - ##### 13:08:42 INFO - ##### Running run-tests step. 13:08:42 INFO - ##### 13:08:42 INFO - Running pre-action listener: _resource_record_pre_action 13:08:42 INFO - Running main action method: run_tests 13:08:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:08:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:08:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:08:42 INFO - 2016-04-15 13:08:42.274 screenresolution[1640:7646] starting screenresolution argv=screenresolution get 13:08:42 INFO - 2016-04-15 13:08:42.277 screenresolution[1640:7646] Display 0: 1600x1200x32@60 13:08:42 INFO - 2016-04-15 13:08:42.282 screenresolution[1641:7649] starting screenresolution argv=screenresolution list 13:08:42 INFO - Available Modes on Display 0 13:08:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:08:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:08:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:08:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:08:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:08:42 INFO - Intel Iris: 13:08:42 INFO - Chipset Model: Intel Iris 13:08:42 INFO - Type: GPU 13:08:42 INFO - Bus: Built-In 13:08:42 INFO - VRAM (Dynamic, Max): 1536 MB 13:08:42 INFO - Vendor: Intel (0x8086) 13:08:42 INFO - Device ID: 0x0a2e 13:08:42 INFO - Revision ID: 0x0009 13:08:42 INFO - Displays: 13:08:42 INFO - Display: 13:08:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:08:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:08:42 INFO - Display Serial Number: 1600x1200 60 13:08:42 INFO - Main Display: Yes 13:08:42 INFO - Mirror: Off 13:08:42 INFO - Online: Yes 13:08:42 INFO - Rotation: Supported 13:08:42 INFO - Return code: 0 13:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:42 INFO - Python 2.7.3 13:08:42 INFO - Return code: 0 13:08:42 INFO - grabbing minidump binary from tooltool 13:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:42 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 0x10f53ee00>, '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 0x10f3a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f539b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:42 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 13:08:42 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 13:08:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:42 INFO - Return code: 0 13:08:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:08:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:08:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:08:43 INFO - Return code: 0 13:08:43 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0176', '--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 13:08:43 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0176 --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 13:08:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0yGw5F1obc/Render', 13:08:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:43 INFO - 'HOME': '/Users/cltbld', 13:08:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:43 INFO - 'LOGNAME': 'cltbld', 13:08:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:43 INFO - 'MOZ_NO_REMOTE': '1', 13:08:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:43 INFO - 'NO_EM_RESTART': '1', 13:08:43 INFO - 'PAGER': '/bin/cat', 13:08:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:43 INFO - 'PWD': '/builds/slave/test', 13:08:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:43 INFO - 'SHELL': '/bin/bash', 13:08:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jJ1M40lsaE/Listeners', 13:08:43 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 13:08:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:43 INFO - 'USER': 'cltbld', 13:08:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:43 INFO - 'XPC_FLAGS': '0x0', 13:08:43 INFO - 'XPC_SERVICE_NAME': '0', 13:08:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:43 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0176', '--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 13:08:44 INFO - mozversion application_buildid: 20160415110147 13:08:44 INFO - mozversion application_changeset: 354cb3932e36994d7e772cedba237e9c3c60fe4c 13:08:44 INFO - mozversion application_display_name: Nightly 13:08:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:44 INFO - mozversion application_name: Firefox 13:08:44 INFO - mozversion application_remotingname: firefox 13:08:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:08:44 INFO - mozversion application_vendor: Mozilla 13:08:44 INFO - mozversion application_version: 48.0a1 13:08:44 INFO - mozversion platform_buildid: 20160415110147 13:08:44 INFO - mozversion platform_changeset: 354cb3932e36994d7e772cedba237e9c3c60fe4c 13:08:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:08:44 INFO - mozversion platform_version: 48.0a1 13:08:44 INFO - using testdate: 1460750924 13:08:44 INFO - actual date: 1460750924 13:08:44 INFO - starting webserver on 'localhost:49276' 13:08:44 INFO - SUITE-START | Running 2 tests 13:08:44 INFO - TEST-START | dromaeo_css 13:08:44 INFO - operating with platform_type : mac_ 13:08:44 INFO - Initialising browser for dromaeo_css test... 13:08:44 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmp93q5mu/profile http://localhost:49276/getInfo.html) 13:08:46 INFO - PROCESS | 1659 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.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] 13:08:47 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 13:08:47 INFO - PROCESS | 1659 | colorDepth:24 13:08:47 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 13:08:47 INFO - PROCESS | 1659 | __metrics 13:08:47 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:08:47 INFO - TEST-INFO | 1659: exit 0 13:08:47 INFO - Browser initialized. 13:08:47 INFO - Running cycle 1/1 for dromaeo_css test... 13:08:47 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmp93q5mu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:59 INFO - PROCESS | 1662 | RSS: Main: 247726080 13:08:59 INFO - PROCESS | 1662 | 13:09:49 INFO - PROCESS | 1662 | 1460750989411 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] 13:12:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 13:12:01 INFO - PROCESS | 1662 | RSS: Main: 259993600 13:12:01 INFO - PROCESS | 1662 | 13:15:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 13:15:04 INFO - PROCESS | 1662 | RSS: Main: 271527936 13:15:04 INFO - PROCESS | 1662 | 13:18:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 13:18:06 INFO - PROCESS | 1662 | RSS: Main: 273903616 13:18:06 INFO - PROCESS | 1662 | 13:21:08 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 13:21:08 INFO - PROCESS | 1662 | RSS: Main: 275427328 13:21:08 INFO - PROCESS | 1662 | 13:24:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 13:24:12 INFO - PROCESS | 1662 | RSS: Main: 278327296 13:24:12 INFO - PROCESS | 1662 | 13:27:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 13:27:15 INFO - PROCESS | 1662 | RSS: Main: 279425024 13:27:15 INFO - PROCESS | 1662 | 13:27:15 INFO - PROCESS | 1662 | __start_tp_report 13:27:15 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 13:27:15 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 13:27:15 INFO - PROCESS | 1662 | |i|pagename|runs| 13:27:15 INFO - PROCESS | 1662 | |0;dojo.html;2812.7609153221974;3254.056323666137;3339.4656854903205;3398.2014226656715;3410.931781364373;5465.0982587873;5471.50756431921;5504.311961004874;5515.558755299577;5519.868426972471;4492.7978240979155;5503.862403439916;5525.944740552593;5613.46672066153;5655.208270842086;5030.993801239749;5046.697198168104;5099.541041306282;5275.920861187085;5283.55089817366;5172.456892026321;5173.560247378978;5202.245674377213;5205.089109405858;5234.476552344754;4070.6539944104934;5035.798568057273;5094.61790365724;5119.436861945183;5153.304303918961;5058.291839142523;5114.079465696173;5118.795248190068;5127.53852153308;5136.357955255593;4462.977685111554;4882.218844984821;5099.107656160157;5104.617153713486;5136;5410.97294513525;5445.891082178334;5488.341399032101;5491.121420572729;5572.60991730579;5954.583179177459;6041.124037014608;6102.0541816018585;6123.601965872204;6160.229971253593;5848.502877255439;6026.246719160105;6173.59871608344;6184.659843708594;6198.194234749499;4344.391785150082;4905.117078925828;5538.6399884007415;5688.91466628005;5699.813170015308;5446.2375267462585;6177.135201071854;6205.2553693557065;6213.130161777355;6223.377662233831;4751.239801631722;5960.970195148997;6008.24896887889;6045.093236014633;6124.173236613089;5087.949120508748;6015.849603759941;6022.5483088768515;6139.062858969336;6140.3552626974415;6075.969620151871;6081.604695694854;6101.572889897753;6112.205413296243;6134.6319220846;5976.61152025117;6059.182010428536;6063.181470501514;6073.180120683651;6106.877862442815;4806.591439727592;4839.516048395203;4857.149998750205;4862.222044472938;4898.559129678275;4295.699301048897;4321.913561728811;4330.718503297276;4344.847930322424;4403.779811009436;5417.322834645669;5479.671219726829;5546.362168350611;5566;5577.386487486373;6152.8769424611255;6164.167837341991;6173.104899789505;6189.319174890758;6211.3167551569295;5582.218489411485;5582.358028826656;5587.217789509472;5587.44125587438;5590.2453168821685;5163.974180129076;5264.499872512105;5278.656887302313;5307.177387504866;5385.542228910586;6246.875062498815;6261.311255761862;6263.6241825490615;6268.341824108494;6270.2789179244055;6148.407788777588;6184.845378865564;6214.067889816563;6218.098375735583;6221.5333849960525;6139.614800607318;6205.813825585059;6226.688665566613;6234.906476402948;6271.78048768291;6029.111198412736;6066;6087.908681369871;6117.663528505975;6126.295476020315;6023.849403764941;6070.599487889849;6132.110843927517;6171.149874337544;6195.504359651307;5756.222909907109;5897.970510147422;5968.582199246011;6068.150458935665;6089.147519347206;5917.5857689961285;5926.170336153028;5930.495907847881;5934;5982.611130276518;5642.322921249476;5744.3681195067675;5765.740541675551;5766.94233057664;5808.390119037609;5150.304708864405;5825.330087040044;5912.172295878667;6026.638401695912;6042.607230530001;4380.9780951095045;4964.379452568429;5069.366329208849;5769.0481070624555;5842.824715258549 13:27:15 INFO - PROCESS | 1662 | |1;ext.html;504.52070532993656;566.8157848699174;587.832467746692;594.9881002379952;601.8405122642499;30895.691043089562;37095.629043709625;37266.81366593163;37284.813575932116;37343.813280933595;38119.61880381195;38639.806800965955;38677.03307417316;38774.61225387745;38901.8054909725;9402.717918462457;9492.240620750323;9506.146301471215;9595;9599.088086631758;9439.716808495721;9508.80982380352;9632.711018669415;9658.951705241463;9719.319647624669;9548.713538593853;9613.99053099425;9648.75878103046;9664.75838104046;9688.854667179998;9561.187299079587;9653.75865603362;9658.420494770266;9674.516274186262;9682.273829462818;9555.331126821126;9559.761005974837;9667.613295468173;9683.467409292487;9730.610775568968;37917;38002.80998594989;38096.19038096196;38184.80907595444;38310.80844595787;2750.986245068782;2808.269849839036;2988.8941091796173;3179.586653735;3264.951025734616;26627.73372266272;26783.52690602016;26987.055453059245;27300.31749206286;27420.451590968267;2674.2378422149786;2694.2321438389963;2722.128918746002;2868.4119755450083;2942.3085574889883;413811;414104;414561;418479.999999997;419286;34479.65520344814;35622.64377356245;58035.12947305794;58446.707766461746;58534.707326463096;34533.82733086318;34552.308953820786;34792.82603587017;34934.30131397358;34981.9505414838;14524.491642792664;14715.19066451334;14847.777283340758;14871.405143794127;14900.478483253035;10888.510017049251;11241.55033798639;11372.090232781358;11383.772324553462;11398.031167350702;8084.231997960184;8122.553259570662;8179.550124743197;8194.918050819415;8215.876761848576;3356.3455126250146;3379.391709492315;3401.4217583010945;3402.42158832999;3432.4508078707786;924.4822899176348;977.5747549815853;1005.7535903703639;1055.5250137438184;1065.8827528971806;26197.083102091336;26342.604860927102;29529;30062;30185.09444716662;1000.2246013326404;1032.7882784029257;1077.138289368502;1093.676651251994;1142.1833389126814;14888.92555537237;15017.699646007019;15024.09855408679;15305.693886122215;15334.693306133815;630058;640419;649327;649926;650251;57583.42416575781;57883.71058144682;58482.122768158515;58564;58671.41328586745;1421.2822524624999;1452.8183977002664;1477.409036385433;1485.591462347863;1561.4925149326514;28788.424231514833;29117.417651646425;29164.416711665224;29630.703692962794;29642.555361670024;48646.51353486561;49222.75388623034;49940.75029624828;49994.75002624963;50098.49901500938;553098;573062;573255;573779;575665;26026.869865651308;26129.82415791332;26289;26371.736282636928;26445.206643800717;44728.88177795581;45097.098058039315;45206.32190517211;45723.856903577675;46016.7699161502;32694;33249;36033.81983090068;36882.63117368792;37617.87146385613;36458.8177059113;36590.45114323234;36993.07517312089;37289.25421491501;37371.06572335713;36165;36167.457488137174;36195.63804362028;36780;37649.247015058994;31560.210994725316;31894.52158217582;32123.839380802947;32179;32455.837720811243;21115.8944205278;23830.88084559566;24563;24698.753012469646;24956 13:27:15 INFO - PROCESS | 1662 | |2;jquery.html;342.7943234059564;389.3653345047573;390.3753993610226;396.50040948405;406.5629448343032;18941.337053203122;20359;21025.264115755952;21175.68236476454;21188.152473901046;17729.55676108098;18951.810481895176;20339.983000849974;21705.891470542625;21713;5482.91775623365;5591.776328946838;5756.453136951983;6032.849178770522;6040.939590604082;5870.794522191724;5876.500497457721;5935.317438494585;5967.433093856077;6000.549958753089;5559.6664200148125;5712.343080545749;5849.502792262663;5861.765529378841;5876.559258055641;5732.254806875121;5829.067349224125;5835.241418615553;5838.065909454467;5838.065909454488;5104.132297509433;5136.075506408845;5167.354080739908;5187.610929180289;5194;25386.11148609808;26134.085307014164;26164.215073547824;26388.340291492674;26499.072532461272;2262.072550254388;2326.755690652474;2331.63859601762;2523.1421316752208;2714.7013828478853;13450.663733406645;14495.347709353104;14832.480863169738;15104.867134964812;15166;1702.4977631598583;1704.6505466379363;1717.5706073481629;1759.683257013737;1770.530809335527;77516.61241693812;110476;115226.27160592514;121132.30941524656;122907;11137;11244.26912250701;11255.549778008952;11681.18231723788;11802.232854864405;13206.33968301581;13574.524891628746;14355.497557585435;14516.491922782652;14629.634259143393;8853.15894989975;9027.954860225656;9062.04848490912;9139.99460059393;9142.63429462814;8985;8987.146221108984;9020.233280171127;9022;9080;6880.862382752417;6928.237893831674;7010.826643740456;7019.227884932653;7037.859242815218;1622.3916031488193;1943.1741509858255;1947.20164732459;1950.9122089506006;1958.9608207835763;886.3883920095113;910.6767097680228;913.2374467319862;932.934694571387;1007.8208496059627;20907.68638470424;21748.866623110338;21754.564908701737;21808.672869906964;21900.890495547737;921.663587797696;943.7546237978175;957.0188861695906;986.4574484033752;1056.1497994114657;9107.362484626145;11385.544578216779;11599.710007249887;11609.30344179352;11612.709682258012;593894;600913.9634414662;611107;618715;620032;116476.41761791137;119947.40026299813;120810;122135.38932305282;124242;1022.9641962531275;1023.744063984004;1035.3632516002754;1045.0281238448165;1048.0567489259727;16709.832901670827;18873.150708218436;19166.329178478685;19240.615187696447;19344.41966741;48098.27852582144;48824.51175488342;48837.75581122072;50457.24314135218;52630.47369526409;67965;69368;69376.30623693699;69601.30398695948;69618.60762784818;6933.2720064392515;7304.671289791866;7735.6518956648215;8048.758537243892;8317.875231871647;11694.782794821165;12370;12370.75258494843;12490.063245256824;12767.233965962072;9025.323100767337;10473.109785668303;10647.627333043616;10876.673699789018;11058.778824423305;7156.964215178891;7264.091988501437;9797;10462.424566648908;10510.789784204426;10241.18070554339;10973.835392469278;11101.722456938642;11337.659870203906;11522.732499424888;8007.35941124697;8061.314788243065;8321.875171872305;8354.45696029756;8509.531975741145;9458;10628.681139565826;11182.217244792786;11207.775844482901;11486.425678715863 13:27:15 INFO - PROCESS | 1662 | |3;mootools.html;1529.7781821635863;1605.5263697209323;1866.2255164106896;1953.6971769375734;1958.461423108646;6700.664966751655;8714.564271786418;8718.60766265518;8987.910120898789;9026.323025773068;8682.739517814476;8741;8773.517456539888;8834.116588341163;8856.5571721414;2458.9016439342404;2472.24596498068;2482.553140434721;2485.4159272570932;2487.701475822904;2397.580423425902;2476.3932836455006;2501.562226610345;2505.7744802967727;2506.135383292761;2251.909923603062;2350.6591544226076;2478.4175718706088;2478.950420991579;2502.049221295905;2471.2462698876748;2478.7893029092456;2486.925392238236;2500.9124680636273;2511.4098186926058;2452.1785201957364;2468.1608253194;2472.097684345201;2485.3041148478455;2486.502699460097;8831.02858685544;8854.247388971946;8985.595648195847;9001.774955626097;9012.053734357864;5306.628536002481;5457.617966742329;5484.040292948758;5504.532114770249;5516.668999860021;2872.8707208175683;3495.702865256431;3523.594786599548;3578.838952247129;3588.5334906461994;981.4209616326401;999.855021021955;1000.1248907206194;1000.4347543637822;1007.9395236285773;11640.417979101096;11737.94131029348;11771.999380052706;11781.46983385741;11800.350980696057;4497.16802391552;4526.954730452653;4807.807687692523;4999.150144475448;5058.595312375075;10058.094771470604;10080.294379393372;10107.494625268708;10109.44398058099;10115.494225288707;5447.809326673548;5494.8076817312;5501.202325662756;5557.499825015687;5561.221428999943;4461.933071003938;4831.541003604652;4972.229304457815;4981.327520784647;4996.850094497171;4107.445494858216;4108.767369789051;4127.876163715094;4181.310083836193;4181.310083836193;1338.2840180503579;1354.5462270139417;1357.8099066130749;1368.60310509951;1376.5319791271015;891.0732837848565;903.1465265324206;912.2018234045211;934.8223837470858;950.296780382512;5748;5910;5915.970420147872;5936.91837608116;5977.163197152402;448.3812338972198;453.3358629607641;461.3011287898836;468.60871172570603;476.81165939454417;3524.013276282645;3879.631435013669;4022.879313620596;4090.2637525245145;4107.260693075275;10390.012948769854;10455.895441045492;10527.631532896312;10940.781184376268;10962.56149754001;10748.086412655011;10795.892041079489;10867.782644347228;10977.231593788518;10988.670339889815;7399.408047356199;8055.63749631268;8143.470674406145;8198.795030124174;8269.545175015312;5786.594938354275;5848.590598658053;5960.493358064439;5977.103434484862;5990.400959904149;8643.26532244741;9833.213342932691;10174.03346682064;10177.134943529587;10283.84574231402;9866.605335786488;9980.101790838859;10337.84493232587;10407.531661075422;10450.216233782345;6600.768973085919;7363.447741419523;7578.317951384402;7639.388848891964;7677.692892284246;8381.287590554628;8423.8736418955;8462.449940753831;8463.195996380335;8464.195901389357;7332.890006650011;7377.5204611700065;7432.368248698921;7577;7639.197884222299;7313.890291645524;7362;7416;7432.665530051268;7557.601843658941;6963.373296403348;6985.1967023790885;7044.823879402851;7047.541909775849;7087.82280442993;4798;4825.782839772289;4935.284383764406;4981.302617633607;5111.284420181103;4461.330800379969;4896.167651499325;4999.925001124913;5014.498550144956;5048.671836330626 13:27:15 INFO - PROCESS | 1662 | |4;prototype.html;281.18456476218967;325.3217042466457;329.9389612921608;330.4366055874733;335.6123677152886;5941;5995.430434108764;6002.849928751778;6050.757969681207;6056.576039677225;5960;5974.8506287342725;5981.401859814027;6024.518038556916;6040.275166979968;4267.829286828523;4335.6531477481885;4424.451441995292;4500.459944806627;4540.614047805941;4263.232618128735;4448.621867141297;4522.479914809806;4526.75102869342;4531.139083574127;4177.874663760092;4279.893002674927;4318;4524.886877828048;4543.273076307792;3698.611645777195;4362.8691139265875;4468.463784345867;4470.75410852403;4493.30353795159;2911.3303940093683;3069.600951876264;3732.4774531565604;3877.7203522837676;3895.844166233347;4895.730734809584;4925;5555.388907220203;5667.773289068432;5695.686737229451;4046.959530404717;4944.901101977976;5088.821891233826;5208.723862653636;5214.270002199695;5409.43200963901;5601.075822489284;6259.029850373199;6316.9368306317265;6338.176037115191;3640.508531348287;4286.6570674346285;4288.335308027261;4321.481422229353;4352.7605981670995;5615.9157612635845;6180.969095154541;6635.966820165917;6723;6723.159605049369;3759.9624003759614;4139.793010349531;4218.978905105455;4254.212970600449;4270.636995855387;3846.788426636506;4334.089841133397;4334.45819272591;4344.761038142869;4361.890952726144;4210.72630279037;4771.665983381199;5078.898422031539;5096.923546146811;5104.668196567211;6373.139626150503;6377.202849643794;6383;6389.265234498;6412.519061070345;1472.8429132417364;1486.4351546412295;1497.4983380567414;1497.6630258192038;1502.9699406012037;896.3635818568889;945.9101385368378;947.5262368815593;951.5004622573205;980.4950450517989;4628.958484340997;5223.865680591614;5684.067417078213;5781.88436231273;5792.362840087587;5727.310443419118;6166.5816862121965;6425.518086143558;6477.574933514619;6496.6426846522945;4944.813244821217;5427.530473634487;5427.674339539641;5654.5193658538665;5768.826935191951;2550.8086893483064;2827.703091175397;3188.772322655794;3467.4105402081705;3507.3686736387185;6236.291599842181;6437.549371543947;6881.277465866112;6905.861882762417;6919.125289837606;5693.971530142323;6782.491313151533;6827;6841.486888483384;6860.931390686129;6532.510061745293;6578.80263592093;6930.861382772317;6956.8956465653055;7004.544704594185;5862.062070068769;6611.867762644816;6684.899726504009;6698.39714425704;6725.637181409295;5497.917531237114;6500.25247096571;6605.504587155887;6633.402993730588;6641.734330626721;5556.222128902038;6476.740930362733;6640.904250798564;6653.268140504444;7029.367356937695;3764.9247015059;3891.3579259421876;3944.2505923874373;4227.027783609726;4304.117655880599;5491.807786727445;5505.614606977633;6252.374762523711;6565.474762019123;6603.471722262111;5559.303737687138;6269.373062693694;6308.467258335347;6324.3991820776955;6347.746090156526;6310.684465776784;6319.368063193644;6334.334894835976;6337.429631333202;6350;5178.6374953752875;5695;5791.276090488689;5858.736356864037;6041.24484439445;5628.887422251614;5918.526517878646;6200.387899146164;6244.46922011616;6426.369101457662;4842.370491836039;5230.660007099526;6268.937310627018;6280.842978925563;6308.873822523432 13:27:15 INFO - PROCESS | 1662 | |5;yui.html;613.7729040255105;737.3511310047154;746.5073051785822;758.1773775453632;767.4282659418734;12777.169483983535;14577.271136443174;14862.108273503598;15564.533064008083;16001.83998160018;11142.610008649699;14365.138091714505;14507.49223777168;14569.198694071822;14581.19803410812;715.2061212054615;876.570480464571;922.6263363337858;923.8383282925495;937.3719607862714;898.5507246376811;920.9171174594285;926.5089502563618;927.4574373991223;931.4923366765129;955.7037318431273;982.8083523712879;984.6356847966263;986.3342243985317;988.7330420786384;938.9061093890624;947.5688561704408;953.2469349214113;957.3250858145026;972.5526257921365;697.5326531224041;701.4388489208663;720.3408880873994;723.9095113110861;728.2971932085563;14570.562883113524;14599.854001459955;14658.560243192722;14688.971771975966;14709.779353309708;12451;12496.375181240901;12502.3748812559;12554.68613284666;12788.808167877489;10806.72983175419;10999.450027498673;11181.161412893984;11197.328160310326;11457.713557161138;4063.7155399122075;4075.3071977763852;4076.551579326301;4203.381698046243;4401.339799030139;67848.3215167847;78093.60953195198;84235;86304;86811.56594217052;9635.951820240854;9744.31789774723;9937.453440060866;9968.102870741668;10423.681812779769;18527.72208416875;22844.543109137725;23094.65358019631;23147.88426057859;23183;6354.872902542016;6950.3049695030095;7746.147923728386;7846.803829904298;7960.323372513401;3654.8172591370326;3976.602339766;4015.2772500949527;4080.591940805896;4098.7950602470355;3485.89542313731;3585.032041348821;3605.188832512664;3611.711063114997;3613.638636136418;634.5712430159933;634.9523785715998;640.078287266335;640.8590110175754;647.1037612906159;511.64185070450833;522.6002108387087;590.8552404660885;612.6262979582451;616.8889599872066;6219.445138715321;7564.978727871667;7640;7993.960030199928;8124.903138076403;487.4053654541454;504.7451037226177;564.3876394112434;592.2271435776267;607.4806040835023;3307.8842240521467;3775.9238616994026;3784.394496880486;3806.923861522754;3926.7447615904875;83630;85259.14740852636;85507;86632.56683716542;88724.5563772177;69434;72030;72260;73217.26782732105;73863.63068184625;63135.6843215781;63174.36825631685;63487.730245394836;68336;68983.65508172427;6530.346965303432;7120.394766444911;8051.436399451982;8151.551664658501;8216.613472617117;36964;39228.607713922494;42055;42169.578304216564;42370.728878133705;49875.0049997996;63031.6848415755;65297.347026529125;65414.672926636966;65774;10552.736181595521;10736;10755.677329680122;11219.775604488028;11441.970222679665;11635.41822908868;11817.527298908291;12135.150539462153;12330.848038410024;12727.681807954876;11256;11281.71795705114;11331.47025151594;11365.261258018203;11806.940965295118;10734.19493537972;11088.833667495155;11112.999830015337;11153.888461115284;11409.372484513431;10947.945260273966;11350.943245284052;11373.135510964048;11397.08823294118;11478.598249061577;9510.667126650535;9611.807763844545;9827.11555959967;10045.69862904114;10079.092881640687;9264.44413335202;9596.66411675588;9645.27660425485;9687;9784.412935223625 13:27:15 INFO - PROCESS | 1662 | __end_tp_report 13:27:15 INFO - PROCESS | 1662 | __start_cc_report 13:27:15 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,405 13:27:15 INFO - PROCESS | 1662 | __end_cc_report 13:27:15 INFO - PROCESS | 1662 | __startTimestamp1460752035078__endTimestamp 13:27:15 INFO - PROCESS | 1662 | 13:27:15 INFO - PROCESS | 1662 | ------- Summary: start ------- 13:27:15 INFO - PROCESS | 1662 | Number of tests: 6 13:27:15 INFO - PROCESS | 1662 | 13:27:15 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5557.65 Median:5699.81 stddev:675.82 (11.9%) stddev-sans-first:642.68 13:27:15 INFO - PROCESS | 1662 | Values: 2812.8 3254.1 3339.5 3398.2 3410.9 5465.1 5471.5 5504.3 5515.6 5519.9 4492.8 5503.9 5525.9 5613.5 5655.2 5031.0 5046.7 5099.5 5275.9 5283.6 5172.5 5173.6 5202.2 5205.1 5234.5 4070.7 5035.8 5094.6 5119.4 5153.3 5058.3 5114.1 5118.8 5127.5 5136.4 4463.0 4882.2 5099.1 5104.6 5136.0 5411.0 5445.9 5488.3 5491.1 5572.6 5954.6 6041.1 6102.1 6123.6 6160.2 5848.5 6026.2 6173.6 6184.7 6198.2 4344.4 4905.1 5538.6 5688.9 5699.8 5446.2 6177.1 6205.3 6213.1 6223.4 4751.2 5961.0 6008.2 6045.1 6124.2 5087.9 6015.8 6022.5 6139.1 6140.4 6076.0 6081.6 6101.6 6112.2 6134.6 5976.6 6059.2 6063.2 6073.2 6106.9 4806.6 4839.5 4857.1 4862.2 4898.6 4295.7 4321.9 4330.7 4344.8 4403.8 5417.3 5479.7 5546.4 5566.0 5577.4 6152.9 6164.2 6173.1 6189.3 6211.3 5582.2 5582.4 5587.2 5587.4 5590.2 5164.0 5264.5 5278.7 5307.2 5385.5 6246.9 6261.3 6263.6 6268.3 6270.3 6148.4 6184.8 6214.1 6218.1 6221.5 6139.6 6205.8 6226.7 6234.9 6271.8 6029.1 6066.0 6087.9 6117.7 6126.3 6023.8 6070.6 6132.1 6171.1 6195.5 5756.2 5898.0 5968.6 6068.2 6089.1 5917.6 5926.2 5930.5 5934.0 5982.6 5642.3 5744.4 5765.7 5766.9 5808.4 5150.3 5825.3 5912.2 6026.6 6042.6 4381.0 4964.4 5069.4 5769.0 5842.8 13:27:15 INFO - PROCESS | 1662 | 13:27:15 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:65717.10 Median:36937.85 stddev:147871.20 (400.3%) stddev-sans-first:148204.96 13:27:15 INFO - PROCESS | 1662 | Values: 504.5 566.8 587.8 595.0 601.8 30895.7 37095.6 37266.8 37284.8 37343.8 38119.6 38639.8 38677.0 38774.6 38901.8 9402.7 9492.2 9506.1 9595.0 9599.1 9439.7 9508.8 9632.7 9659.0 9719.3 9548.7 9614.0 9648.8 9664.8 9688.9 9561.2 9653.8 9658.4 9674.5 9682.3 9555.3 9559.8 9667.6 9683.5 9730.6 37917.0 38002.8 38096.2 38184.8 38310.8 2751.0 2808.3 2988.9 3179.6 3265.0 26627.7 26783.5 26987.1 27300.3 27420.5 2674.2 2694.2 2722.1 2868.4 2942.3 413811.0 414104.0 414561.0 418480.0 419286.0 34479.7 35622.6 58035.1 58446.7 58534.7 34533.8 34552.3 34792.8 34934.3 34982.0 14524.5 14715.2 14847.8 14871.4 14900.5 10888.5 11241.6 11372.1 11383.8 11398.0 8084.2 8122.6 8179.6 8194.9 8215.9 3356.3 3379.4 3401.4 3402.4 3432.5 924.5 977.6 1005.8 1055.5 1065.9 26197.1 26342.6 29529.0 30062.0 30185.1 1000.2 1032.8 1077.1 1093.7 1142.2 14888.9 15017.7 15024.1 15305.7 15334.7 630058.0 640419.0 649327.0 649926.0 650251.0 57583.4 57883.7 58482.1 58564.0 58671.4 1421.3 1452.8 1477.4 1485.6 1561.5 28788.4 29117.4 29164.4 29630.7 29642.6 48646.5 49222.8 49940.8 49994.8 50098.5 553098.0 573062.0 573255.0 573779.0 575665.0 26026.9 26129.8 26289.0 26371.7 26445.2 44728.9 45097.1 45206.3 45723.9 46016.8 32694.0 33249.0 36033.8 36882.6 37617.9 36458.8 36590.5 36993.1 37289.3 37371.1 36165.0 36167.5 36195.6 36780.0 37649.2 31560.2 31894.5 32123.8 32179.0 32455.8 21115.9 23830.9 24563.0 24698.8 24956.0 13:27:15 INFO - PROCESS | 1662 | 13:27:15 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:34684.78 Median:26149.15 stddev:101081.88 (386.6%) stddev-sans-first:101332.55 13:27:15 INFO - PROCESS | 1662 | Values: 342.8 389.4 390.4 396.5 406.6 18941.3 20359.0 21025.3 21175.7 21188.2 17729.6 18951.8 20340.0 21705.9 21713.0 5482.9 5591.8 5756.5 6032.8 6040.9 5870.8 5876.5 5935.3 5967.4 6000.5 5559.7 5712.3 5849.5 5861.8 5876.6 5732.3 5829.1 5835.2 5838.1 5838.1 5104.1 5136.1 5167.4 5187.6 5194.0 25386.1 26134.1 26164.2 26388.3 26499.1 2262.1 2326.8 2331.6 2523.1 2714.7 13450.7 14495.3 14832.5 15104.9 15166.0 1702.5 1704.7 1717.6 1759.7 1770.5 77516.6 110476.0 115226.3 121132.3 122907.0 11137.0 11244.3 11255.5 11681.2 11802.2 13206.3 13574.5 14355.5 14516.5 14629.6 8853.2 9028.0 9062.0 9140.0 9142.6 8985.0 8987.1 9020.2 9022.0 9080.0 6880.9 6928.2 7010.8 7019.2 7037.9 1622.4 1943.2 1947.2 1950.9 1959.0 886.4 910.7 913.2 932.9 1007.8 20907.7 21748.9 21754.6 21808.7 21900.9 921.7 943.8 957.0 986.5 1056.1 9107.4 11385.5 11599.7 11609.3 11612.7 593894.0 600914.0 611107.0 618715.0 620032.0 116476.4 119947.4 120810.0 122135.4 124242.0 1023.0 1023.7 1035.4 1045.0 1048.1 16709.8 18873.2 19166.3 19240.6 19344.4 48098.3 48824.5 48837.8 50457.2 52630.5 67965.0 69368.0 69376.3 69601.3 69618.6 6933.3 7304.7 7735.7 8048.8 8317.9 11694.8 12370.0 12370.8 12490.1 12767.2 9025.3 10473.1 10647.6 10876.7 11058.8 7157.0 7264.1 9797.0 10462.4 10510.8 10241.2 10973.8 11101.7 11337.7 11522.7 8007.4 8061.3 8321.9 8354.5 8509.5 9458.0 10628.7 11182.2 11207.8 11486.4 13:27:15 INFO - PROCESS | 1662 | 13:27:15 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5745.29 Median:4828.66 stddev:3214.74 (66.6%) stddev-sans-first:3208.15 13:27:15 INFO - PROCESS | 1662 | Values: 1529.8 1605.5 1866.2 1953.7 1958.5 6700.7 8714.6 8718.6 8987.9 9026.3 8682.7 8741.0 8773.5 8834.1 8856.6 2458.9 2472.2 2482.6 2485.4 2487.7 2397.6 2476.4 2501.6 2505.8 2506.1 2251.9 2350.7 2478.4 2479.0 2502.0 2471.2 2478.8 2486.9 2500.9 2511.4 2452.2 2468.2 2472.1 2485.3 2486.5 8831.0 8854.2 8985.6 9001.8 9012.1 5306.6 5457.6 5484.0 5504.5 5516.7 2872.9 3495.7 3523.6 3578.8 3588.5 981.4 999.9 1000.1 1000.4 1007.9 11640.4 11737.9 11772.0 11781.5 11800.4 4497.2 4527.0 4807.8 4999.2 5058.6 10058.1 10080.3 10107.5 10109.4 10115.5 5447.8 5494.8 5501.2 5557.5 5561.2 4461.9 4831.5 4972.2 4981.3 4996.9 4107.4 4108.8 4127.9 4181.3 4181.3 1338.3 1354.5 1357.8 1368.6 1376.5 891.1 903.1 912.2 934.8 950.3 5748.0 5910.0 5916.0 5936.9 5977.2 448.4 453.3 461.3 468.6 476.8 3524.0 3879.6 4022.9 4090.3 4107.3 10390.0 10455.9 10527.6 10940.8 10962.6 10748.1 10795.9 10867.8 10977.2 10988.7 7399.4 8055.6 8143.5 8198.8 8269.5 5786.6 5848.6 5960.5 5977.1 5990.4 8643.3 9833.2 10174.0 10177.1 10283.8 9866.6 9980.1 10337.8 10407.5 10450.2 6600.8 7363.4 7578.3 7639.4 7677.7 8381.3 8423.9 8462.4 8463.2 8464.2 7332.9 7377.5 7432.4 7577.0 7639.2 7313.9 7362.0 7416.0 7432.7 7557.6 6963.4 6985.2 7044.8 7047.5 7087.8 4798.0 4825.8 4935.3 4981.3 5111.3 4461.3 4896.2 4999.9 5014.5 5048.7 13:27:15 INFO - PROCESS | 1662 | 13:27:15 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5057.22 Median:5661.15 stddev:1628.01 (28.8%) stddev-sans-first:1592.62 13:27:15 INFO - PROCESS | 1662 | Values: 281.2 325.3 329.9 330.4 335.6 5941.0 5995.4 6002.8 6050.8 6056.6 5960.0 5974.9 5981.4 6024.5 6040.3 4267.8 4335.7 4424.5 4500.5 4540.6 4263.2 4448.6 4522.5 4526.8 4531.1 4177.9 4279.9 4318.0 4524.9 4543.3 3698.6 4362.9 4468.5 4470.8 4493.3 2911.3 3069.6 3732.5 3877.7 3895.8 4895.7 4925.0 5555.4 5667.8 5695.7 4047.0 4944.9 5088.8 5208.7 5214.3 5409.4 5601.1 6259.0 6316.9 6338.2 3640.5 4286.7 4288.3 4321.5 4352.8 5615.9 6181.0 6636.0 6723.0 6723.2 3760.0 4139.8 4219.0 4254.2 4270.6 3846.8 4334.1 4334.5 4344.8 4361.9 4210.7 4771.7 5078.9 5096.9 5104.7 6373.1 6377.2 6383.0 6389.3 6412.5 1472.8 1486.4 1497.5 1497.7 1503.0 896.4 945.9 947.5 951.5 980.5 4629.0 5223.9 5684.1 5781.9 5792.4 5727.3 6166.6 6425.5 6477.6 6496.6 4944.8 5427.5 5427.7 5654.5 5768.8 2550.8 2827.7 3188.8 3467.4 3507.4 6236.3 6437.5 6881.3 6905.9 6919.1 5694.0 6782.5 6827.0 6841.5 6860.9 6532.5 6578.8 6930.9 6956.9 7004.5 5862.1 6611.9 6684.9 6698.4 6725.6 5497.9 6500.3 6605.5 6633.4 6641.7 5556.2 6476.7 6640.9 6653.3 7029.4 3764.9 3891.4 3944.3 4227.0 4304.1 5491.8 5505.6 6252.4 6565.5 6603.5 5559.3 6269.4 6308.5 6324.4 6347.7 6310.7 6319.4 6334.3 6337.4 6350.0 5178.6 5695.0 5791.3 5858.7 6041.2 5628.9 5918.5 6200.4 6244.5 6426.4 4842.4 5230.7 6268.9 6280.8 6308.9 13:27:15 INFO - PROCESS | 1662 | 13:27:15 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:17411.30 Median:599.85 stddev:23999.14 (4000.8%) stddev-sans-first:24033.32 13:27:15 INFO - PROCESS | 1662 | Values: 613.8 737.4 746.5 758.2 767.4 12777.2 14577.3 14862.1 15564.5 16001.8 11142.6 14365.1 14507.5 14569.2 14581.2 715.2 876.6 922.6 923.8 937.4 898.6 920.9 926.5 927.5 931.5 955.7 982.8 984.6 986.3 988.7 938.9 947.6 953.2 957.3 972.6 697.5 701.4 720.3 723.9 728.3 14570.6 14599.9 14658.6 14689.0 14709.8 12451.0 12496.4 12502.4 12554.7 12788.8 10806.7 10999.5 11181.2 11197.3 11457.7 4063.7 4075.3 4076.6 4203.4 4401.3 67848.3 78093.6 84235.0 86304.0 86811.6 9636.0 9744.3 9937.5 9968.1 10423.7 18527.7 22844.5 23094.7 23147.9 23183.0 6354.9 6950.3 7746.1 7846.8 7960.3 3654.8 3976.6 4015.3 4080.6 4098.8 3485.9 3585.0 3605.2 3611.7 3613.6 634.6 635.0 640.1 640.9 647.1 511.6 522.6 590.9 612.6 616.9 6219.4 7565.0 7640.0 7994.0 8124.9 487.4 504.7 564.4 592.2 607.5 3307.9 3775.9 3784.4 3806.9 3926.7 83630.0 85259.1 85507.0 86632.6 88724.6 69434.0 72030.0 72260.0 73217.3 73863.6 63135.7 63174.4 63487.7 68336.0 68983.7 6530.3 7120.4 8051.4 8151.6 8216.6 36964.0 39228.6 42055.0 42169.6 42370.7 49875.0 63031.7 65297.3 65414.7 65774.0 10552.7 10736.0 10755.7 11219.8 11442.0 11635.4 11817.5 12135.2 12330.8 12727.7 11256.0 11281.7 11331.5 11365.3 11806.9 10734.2 11088.8 11113.0 11153.9 11409.4 10947.9 11350.9 11373.1 11397.1 11478.6 9510.7 9611.8 9827.1 10045.7 10079.1 9264.4 9596.7 9645.3 9687.0 9784.4 13:27:15 INFO - PROCESS | 1662 | -------- Summary: end -------- 13:27:15 INFO - PROCESS | 1662 | 13:27:15 INFO - TEST-INFO | 1662: exit 0 13:27:15 INFO - TEST-OK | dromaeo_css | took 1111582ms 13:27:15 INFO - TEST-START | kraken 13:27:15 INFO - operating with platform_type : mac_ 13:27:15 INFO - Initialising browser for kraken test... 13:27:15 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmp2TngQS/profile http://localhost:49276/getInfo.html) 13:27:17 INFO - PROCESS | 1670 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.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] 13:27:18 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 13:27:18 INFO - PROCESS | 1670 | colorDepth:24 13:27:18 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 13:27:18 INFO - PROCESS | 1670 | __metrics 13:27:18 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:27:19 INFO - TEST-INFO | 1670: exit 0 13:27:19 INFO - Browser initialized. 13:27:19 INFO - Running cycle 1/1 for kraken test... 13:27:19 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmp2TngQS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:31 INFO - PROCESS | 1673 | RSS: Main: 247689216 13:27:31 INFO - PROCESS | 1673 | 13:27:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:34 INFO - PROCESS | 1673 | RSS: Main: 259903488 13:27:34 INFO - PROCESS | 1673 | 13:27:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 13:27:38 INFO - PROCESS | 1673 | RSS: Main: 268881920 13:27:38 INFO - PROCESS | 1673 | 13:27:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 13:27:42 INFO - PROCESS | 1673 | RSS: Main: 271872000 13:27:42 INFO - PROCESS | 1673 | 13:27:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 13:27:44 INFO - PROCESS | 1673 | RSS: Main: 272973824 13:27:44 INFO - PROCESS | 1673 | 13:27:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:27:47 INFO - PROCESS | 1673 | RSS: Main: 273391616 13:27:47 INFO - PROCESS | 1673 | 13:27:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 13:27:50 INFO - PROCESS | 1673 | RSS: Main: 273289216 13:27:50 INFO - PROCESS | 1673 | 13:27:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 13:27:54 INFO - PROCESS | 1673 | RSS: Main: 273489920 13:27:54 INFO - PROCESS | 1673 | 13:27:57 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 13:27:58 INFO - PROCESS | 1673 | RSS: Main: 275144704 13:27:58 INFO - PROCESS | 1673 | 13:27:59 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:28:00 INFO - PROCESS | 1673 | RSS: Main: 274714624 13:28:00 INFO - PROCESS | 1673 | 13:28:02 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:28:03 INFO - PROCESS | 1673 | RSS: Main: 274718720 13:28:03 INFO - PROCESS | 1673 | 13:28:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:28:06 INFO - PROCESS | 1673 | RSS: Main: 274870272 13:28:06 INFO - PROCESS | 1673 | 13:28:08 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:28:09 INFO - PROCESS | 1673 | RSS: Main: 275001344 13:28:09 INFO - PROCESS | 1673 | 13:28:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:28:13 INFO - PROCESS | 1673 | RSS: Main: 275034112 13:28:13 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 13:28:15 INFO - PROCESS | 1673 | RSS: Main: 276508672 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | __start_tp_report 13:28:15 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 13:28:15 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 13:28:15 INFO - PROCESS | 1673 | |i|pagename|runs| 13:28:15 INFO - PROCESS | 1673 | |0;ai-astar;122;126;119;134;172;169;117;115;116;115 13:28:15 INFO - PROCESS | 1673 | |1;audio-beat-detection;152;122;145;168;127;137;155;195;197;121 13:28:15 INFO - PROCESS | 1673 | |2;audio-dft;200;205;236;197;200;196;198;201;199;198 13:28:15 INFO - PROCESS | 1673 | |3;audio-fft;65;73;75;144;58;55;69;67;148;56 13:28:15 INFO - PROCESS | 1673 | |4;audio-oscillator;79;83;139;116;123;82;132;93;80;119 13:28:15 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;89;86;88;86;90;91;91;86;89;87 13:28:15 INFO - PROCESS | 1673 | |6;imaging-darkroom;94;95;96;96;95;95;98;107;153;150 13:28:15 INFO - PROCESS | 1673 | |7;imaging-desaturate;117;121;105;79;106;112;125;141;140;146 13:28:15 INFO - PROCESS | 1673 | |8;json-parse-financial;63;63;63;59;52;74;95;93;64;60 13:28:15 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;77;56;63;75;76;76;70;56;69;86 13:28:15 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;90;104;113;110;79;113;114;76;101;106 13:28:15 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;141;136;141;139;154;159;157;142;177;158 13:28:15 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;231;233;187;171;170;229;181;209;235;182 13:28:15 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;72;71;70;68;74;66;68;70;71;67 13:28:15 INFO - PROCESS | 1673 | __end_tp_report 13:28:15 INFO - PROCESS | 1673 | __start_cc_report 13:28:15 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1057 13:28:15 INFO - PROCESS | 1673 | __end_cc_report 13:28:15 INFO - PROCESS | 1673 | __startTimestamp1460752095477__endTimestamp 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | ------- Summary: start ------- 13:28:15 INFO - PROCESS | 1673 | Number of tests: 14 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:130.50 Median:124.00 stddev:21.89 (17.7%) stddev-sans-first:23.01 13:28:15 INFO - PROCESS | 1673 | Values: 122.0 126.0 119.0 134.0 172.0 169.0 117.0 115.0 116.0 115.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:153.50 stddev:27.69 (18.0%) stddev-sans-first:29.37 13:28:15 INFO - PROCESS | 1673 | Values: 152.0 122.0 145.0 168.0 127.0 137.0 155.0 195.0 197.0 121.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:203.00 Median:200.00 stddev:11.86 (5.9%) stddev-sans-first:12.53 13:28:15 INFO - PROCESS | 1673 | Values: 200.0 205.0 236.0 197.0 200.0 196.0 198.0 201.0 199.0 198.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:81.00 Median:66.00 stddev:34.93 (52.9%) stddev-sans-first:36.57 13:28:15 INFO - PROCESS | 1673 | Values: 65.0 73.0 75.0 144.0 58.0 55.0 69.0 67.0 148.0 56.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:79.50 stddev:23.53 (29.6%) stddev-sans-first:23.06 13:28:15 INFO - PROCESS | 1673 | Values: 79.0 83.0 139.0 116.0 123.0 82.0 132.0 93.0 80.0 119.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:2.00 (2.3%) stddev-sans-first:2.11 13:28:15 INFO - PROCESS | 1673 | Values: 89.0 86.0 88.0 86.0 90.0 91.0 91.0 86.0 89.0 87.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:107.90 Median:95.00 stddev:23.29 (24.5%) stddev-sans-first:24.15 13:28:15 INFO - PROCESS | 1673 | Values: 94.0 95.0 96.0 96.0 95.0 95.0 98.0 107.0 153.0 150.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:119.20 Median:132.50 stddev:20.31 (15.3%) stddev-sans-first:21.52 13:28:15 INFO - PROCESS | 1673 | Values: 117.0 121.0 105.0 79.0 106.0 112.0 125.0 141.0 140.0 146.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:68.60 Median:63.50 stddev:14.45 (22.8%) stddev-sans-first:15.18 13:28:15 INFO - PROCESS | 1673 | Values: 63.0 63.0 63.0 59.0 52.0 74.0 95.0 93.0 64.0 60.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:75.50 stddev:9.67 (12.8%) stddev-sans-first:9.96 13:28:15 INFO - PROCESS | 1673 | Values: 77.0 56.0 63.0 75.0 76.0 76.0 70.0 56.0 69.0 86.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:100.60 Median:113.50 stddev:14.14 (12.5%) stddev-sans-first:14.47 13:28:15 INFO - PROCESS | 1673 | Values: 90.0 104.0 113.0 110.0 79.0 113.0 114.0 76.0 101.0 106.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:155.50 stddev:12.83 (8.2%) stddev-sans-first:13.14 13:28:15 INFO - PROCESS | 1673 | Values: 141.0 136.0 141.0 139.0 154.0 159.0 157.0 142.0 177.0 158.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.80 Median:219.00 stddev:27.31 (12.5%) stddev-sans-first:27.00 13:28:15 INFO - PROCESS | 1673 | Values: 231.0 233.0 187.0 171.0 170.0 229.0 181.0 209.0 235.0 182.0 13:28:15 INFO - PROCESS | 1673 | 13:28:15 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.50 stddev:2.45 (3.5%) stddev-sans-first:2.46 13:28:15 INFO - PROCESS | 1673 | Values: 72.0 71.0 70.0 68.0 74.0 66.0 68.0 70.0 71.0 67.0 13:28:15 INFO - PROCESS | 1673 | -------- Summary: end -------- 13:28:15 INFO - PROCESS | 1673 | 13:28:16 INFO - TEST-INFO | 1673: exit 0 13:28:16 INFO - TEST-OK | kraken | took 60638ms 13:28:16 INFO - SUITE-END | took 1172s 13:28:16 INFO - Completed test suite (00:19:32) 13:28:16 INFO - javascript benchmark 13:28:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2812.7609153221974, 3254.056323666137, 3339.4656854903205, 3398.2014226656715, 3410.931781364373, 5465.0982587873, 5471.50756431921, 5504.311961004874, 5515.558755299577, 5519.868426972471, 4492.7978240979155, 5503.862403439916, 5525.944740552593, 5613.46672066153, 5655.208270842086, 5030.993801239749, 5046.697198168104, 5099.541041306282, 5275.920861187085, 5283.55089817366, 5172.456892026321, 5173.560247378978, 5202.245674377213, 5205.089109405858, 5234.476552344754, 4070.6539944104934, 5035.798568057273, 5094.61790365724, 5119.436861945183, 5153.304303918961, 5058.291839142523, 5114.079465696173, 5118.795248190068, 5127.53852153308, 5136.357955255593, 4462.977685111554, 4882.218844984821, 5099.107656160157, 5104.617153713486, 5136.0, 5410.97294513525, 5445.891082178334, 5488.341399032101, 5491.121420572729, 5572.60991730579, 5954.583179177459, 6041.124037014608, 6102.0541816018585, 6123.601965872204, 6160.229971253593, 5848.502877255439, 6026.246719160105, 6173.59871608344, 6184.659843708594, 6198.194234749499, 4344.391785150082, 4905.117078925828, 5538.6399884007415, 5688.91466628005, 5699.813170015308, 5446.2375267462585, 6177.135201071854, 6205.2553693557065, 6213.130161777355, 6223.377662233831, 4751.239801631722, 5960.970195148997, 6008.24896887889, 6045.093236014633, 6124.173236613089, 5087.949120508748, 6015.849603759941, 6022.5483088768515, 6139.062858969336, 6140.3552626974415, 6075.969620151871, 6081.604695694854, 6101.572889897753, 6112.205413296243, 6134.6319220846, 5976.61152025117, 6059.182010428536, 6063.181470501514, 6073.180120683651, 6106.877862442815, 4806.591439727592, 4839.516048395203, 4857.149998750205, 4862.222044472938, 4898.559129678275, 4295.699301048897, 4321.913561728811, 4330.718503297276, 4344.847930322424, 4403.779811009436, 5417.322834645669, 5479.671219726829, 5546.362168350611, 5566.0, 5577.386487486373, 6152.8769424611255, 6164.167837341991, 6173.104899789505, 6189.319174890758, 6211.3167551569295, 5582.218489411485, 5582.358028826656, 5587.217789509472, 5587.44125587438, 5590.2453168821685, 5163.974180129076, 5264.499872512105, 5278.656887302313, 5307.177387504866, 5385.542228910586, 6246.875062498815, 6261.311255761862, 6263.6241825490615, 6268.341824108494, 6270.2789179244055, 6148.407788777588, 6184.845378865564, 6214.067889816563, 6218.098375735583, 6221.5333849960525, 6139.614800607318, 6205.813825585059, 6226.688665566613, 6234.906476402948, 6271.78048768291, 6029.111198412736, 6066.0, 6087.908681369871, 6117.663528505975, 6126.295476020315, 6023.849403764941, 6070.599487889849, 6132.110843927517, 6171.149874337544, 6195.504359651307, 5756.222909907109, 5897.970510147422, 5968.582199246011, 6068.150458935665, 6089.147519347206, 5917.5857689961285, 5926.170336153028, 5930.495907847881, 5934.0, 5982.611130276518, 5642.322921249476, 5744.3681195067675, 5765.740541675551, 5766.94233057664, 5808.390119037609, 5150.304708864405, 5825.330087040044, 5912.172295878667, 6026.638401695912, 6042.607230530001, 4380.9780951095045, 4964.379452568429, 5069.366329208849, 5769.0481070624555, 5842.824715258549], "value": 5515.386684147476, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.52070532993656, 566.8157848699174, 587.832467746692, 594.9881002379952, 601.8405122642499, 30895.691043089562, 37095.629043709625, 37266.81366593163, 37284.813575932116, 37343.813280933595, 38119.61880381195, 38639.806800965955, 38677.03307417316, 38774.61225387745, 38901.8054909725, 9402.717918462457, 9492.240620750323, 9506.146301471215, 9595.0, 9599.088086631758, 9439.716808495721, 9508.80982380352, 9632.711018669415, 9658.951705241463, 9719.319647624669, 9548.713538593853, 9613.99053099425, 9648.75878103046, 9664.75838104046, 9688.854667179998, 9561.187299079587, 9653.75865603362, 9658.420494770266, 9674.516274186262, 9682.273829462818, 9555.331126821126, 9559.761005974837, 9667.613295468173, 9683.467409292487, 9730.610775568968, 37917.0, 38002.80998594989, 38096.19038096196, 38184.80907595444, 38310.80844595787, 2750.986245068782, 2808.269849839036, 2988.8941091796173, 3179.586653735, 3264.951025734616, 26627.73372266272, 26783.52690602016, 26987.055453059245, 27300.31749206286, 27420.451590968267, 2674.2378422149786, 2694.2321438389963, 2722.128918746002, 2868.4119755450083, 2942.3085574889883, 413811.0, 414104.0, 414561.0, 418479.999999997, 419286.0, 34479.65520344814, 35622.64377356245, 58035.12947305794, 58446.707766461746, 58534.707326463096, 34533.82733086318, 34552.308953820786, 34792.82603587017, 34934.30131397358, 34981.9505414838, 14524.491642792664, 14715.19066451334, 14847.777283340758, 14871.405143794127, 14900.478483253035, 10888.510017049251, 11241.55033798639, 11372.090232781358, 11383.772324553462, 11398.031167350702, 8084.231997960184, 8122.553259570662, 8179.550124743197, 8194.918050819415, 8215.876761848576, 3356.3455126250146, 3379.391709492315, 3401.4217583010945, 3402.42158832999, 3432.4508078707786, 924.4822899176348, 977.5747549815853, 1005.7535903703639, 1055.5250137438184, 1065.8827528971806, 26197.083102091336, 26342.604860927102, 29529.0, 30062.0, 30185.09444716662, 1000.2246013326404, 1032.7882784029257, 1077.138289368502, 1093.676651251994, 1142.1833389126814, 14888.92555537237, 15017.699646007019, 15024.09855408679, 15305.693886122215, 15334.693306133815, 630058.0, 640419.0, 649327.0, 649926.0, 650251.0, 57583.42416575781, 57883.71058144682, 58482.122768158515, 58564.0, 58671.41328586745, 1421.2822524624999, 1452.8183977002664, 1477.409036385433, 1485.591462347863, 1561.4925149326514, 28788.424231514833, 29117.417651646425, 29164.416711665224, 29630.703692962794, 29642.555361670024, 48646.51353486561, 49222.75388623034, 49940.75029624828, 49994.75002624963, 50098.49901500938, 553098.0, 573062.0, 573255.0, 573779.0, 575665.0, 26026.869865651308, 26129.82415791332, 26289.0, 26371.736282636928, 26445.206643800717, 44728.88177795581, 45097.098058039315, 45206.32190517211, 45723.856903577675, 46016.7699161502, 32694.0, 33249.0, 36033.81983090068, 36882.63117368792, 37617.87146385613, 36458.8177059113, 36590.45114323234, 36993.07517312089, 37289.25421491501, 37371.06572335713, 36165.0, 36167.457488137174, 36195.63804362028, 36780.0, 37649.247015058994, 31560.210994725316, 31894.52158217582, 32123.839380802947, 32179.0, 32455.837720811243, 21115.8944205278, 23830.88084559566, 24563.0, 24698.753012469646, 24956.0], "value": 18041.922400140495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.7943234059564, 389.3653345047573, 390.3753993610226, 396.50040948405, 406.5629448343032, 18941.337053203122, 20359.0, 21025.264115755952, 21175.68236476454, 21188.152473901046, 17729.55676108098, 18951.810481895176, 20339.983000849974, 21705.891470542625, 21713.0, 5482.91775623365, 5591.776328946838, 5756.453136951983, 6032.849178770522, 6040.939590604082, 5870.794522191724, 5876.500497457721, 5935.317438494585, 5967.433093856077, 6000.549958753089, 5559.6664200148125, 5712.343080545749, 5849.502792262663, 5861.765529378841, 5876.559258055641, 5732.254806875121, 5829.067349224125, 5835.241418615553, 5838.065909454467, 5838.065909454488, 5104.132297509433, 5136.075506408845, 5167.354080739908, 5187.610929180289, 5194.0, 25386.11148609808, 26134.085307014164, 26164.215073547824, 26388.340291492674, 26499.072532461272, 2262.072550254388, 2326.755690652474, 2331.63859601762, 2523.1421316752208, 2714.7013828478853, 13450.663733406645, 14495.347709353104, 14832.480863169738, 15104.867134964812, 15166.0, 1702.4977631598583, 1704.6505466379363, 1717.5706073481629, 1759.683257013737, 1770.530809335527, 77516.61241693812, 110476.0, 115226.27160592514, 121132.30941524656, 122907.0, 11137.0, 11244.26912250701, 11255.549778008952, 11681.18231723788, 11802.232854864405, 13206.33968301581, 13574.524891628746, 14355.497557585435, 14516.491922782652, 14629.634259143393, 8853.15894989975, 9027.954860225656, 9062.04848490912, 9139.99460059393, 9142.63429462814, 8985.0, 8987.146221108984, 9020.233280171127, 9022.0, 9080.0, 6880.862382752417, 6928.237893831674, 7010.826643740456, 7019.227884932653, 7037.859242815218, 1622.3916031488193, 1943.1741509858255, 1947.20164732459, 1950.9122089506006, 1958.9608207835763, 886.3883920095113, 910.6767097680228, 913.2374467319862, 932.934694571387, 1007.8208496059627, 20907.68638470424, 21748.866623110338, 21754.564908701737, 21808.672869906964, 21900.890495547737, 921.663587797696, 943.7546237978175, 957.0188861695906, 986.4574484033752, 1056.1497994114657, 9107.362484626145, 11385.544578216779, 11599.710007249887, 11609.30344179352, 11612.709682258012, 593894.0, 600913.9634414662, 611107.0, 618715.0, 620032.0, 116476.41761791137, 119947.40026299813, 120810.0, 122135.38932305282, 124242.0, 1022.9641962531275, 1023.744063984004, 1035.3632516002754, 1045.0281238448165, 1048.0567489259727, 16709.832901670827, 18873.150708218436, 19166.329178478685, 19240.615187696447, 19344.41966741, 48098.27852582144, 48824.51175488342, 48837.75581122072, 50457.24314135218, 52630.47369526409, 67965.0, 69368.0, 69376.30623693699, 69601.30398695948, 69618.60762784818, 6933.2720064392515, 7304.671289791866, 7735.6518956648215, 8048.758537243892, 8317.875231871647, 11694.782794821165, 12370.0, 12370.75258494843, 12490.063245256824, 12767.233965962072, 9025.323100767337, 10473.109785668303, 10647.627333043616, 10876.673699789018, 11058.778824423305, 7156.964215178891, 7264.091988501437, 9797.0, 10462.424566648908, 10510.789784204426, 10241.18070554339, 10973.835392469278, 11101.722456938642, 11337.659870203906, 11522.732499424888, 8007.35941124697, 8061.314788243065, 8321.875171872305, 8354.45696029756, 8509.531975741145, 9458.0, 10628.681139565826, 11182.217244792786, 11207.775844482901, 11486.425678715863], "value": 9638.96495073517, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1529.7781821635863, 1605.5263697209323, 1866.2255164106896, 1953.6971769375734, 1958.461423108646, 6700.664966751655, 8714.564271786418, 8718.60766265518, 8987.910120898789, 9026.323025773068, 8682.739517814476, 8741.0, 8773.517456539888, 8834.116588341163, 8856.5571721414, 2458.9016439342404, 2472.24596498068, 2482.553140434721, 2485.4159272570932, 2487.701475822904, 2397.580423425902, 2476.3932836455006, 2501.562226610345, 2505.7744802967727, 2506.135383292761, 2251.909923603062, 2350.6591544226076, 2478.4175718706088, 2478.950420991579, 2502.049221295905, 2471.2462698876748, 2478.7893029092456, 2486.925392238236, 2500.9124680636273, 2511.4098186926058, 2452.1785201957364, 2468.1608253194, 2472.097684345201, 2485.3041148478455, 2486.502699460097, 8831.02858685544, 8854.247388971946, 8985.595648195847, 9001.774955626097, 9012.053734357864, 5306.628536002481, 5457.617966742329, 5484.040292948758, 5504.532114770249, 5516.668999860021, 2872.8707208175683, 3495.702865256431, 3523.594786599548, 3578.838952247129, 3588.5334906461994, 981.4209616326401, 999.855021021955, 1000.1248907206194, 1000.4347543637822, 1007.9395236285773, 11640.417979101096, 11737.94131029348, 11771.999380052706, 11781.46983385741, 11800.350980696057, 4497.16802391552, 4526.954730452653, 4807.807687692523, 4999.150144475448, 5058.595312375075, 10058.094771470604, 10080.294379393372, 10107.494625268708, 10109.44398058099, 10115.494225288707, 5447.809326673548, 5494.8076817312, 5501.202325662756, 5557.499825015687, 5561.221428999943, 4461.933071003938, 4831.541003604652, 4972.229304457815, 4981.327520784647, 4996.850094497171, 4107.445494858216, 4108.767369789051, 4127.876163715094, 4181.310083836193, 4181.310083836193, 1338.2840180503579, 1354.5462270139417, 1357.8099066130749, 1368.60310509951, 1376.5319791271015, 891.0732837848565, 903.1465265324206, 912.2018234045211, 934.8223837470858, 950.296780382512, 5748.0, 5910.0, 5915.970420147872, 5936.91837608116, 5977.163197152402, 448.3812338972198, 453.3358629607641, 461.3011287898836, 468.60871172570603, 476.81165939454417, 3524.013276282645, 3879.631435013669, 4022.879313620596, 4090.2637525245145, 4107.260693075275, 10390.012948769854, 10455.895441045492, 10527.631532896312, 10940.781184376268, 10962.56149754001, 10748.086412655011, 10795.892041079489, 10867.782644347228, 10977.231593788518, 10988.670339889815, 7399.408047356199, 8055.63749631268, 8143.470674406145, 8198.795030124174, 8269.545175015312, 5786.594938354275, 5848.590598658053, 5960.493358064439, 5977.103434484862, 5990.400959904149, 8643.26532244741, 9833.213342932691, 10174.03346682064, 10177.134943529587, 10283.84574231402, 9866.605335786488, 9980.101790838859, 10337.84493232587, 10407.531661075422, 10450.216233782345, 6600.768973085919, 7363.447741419523, 7578.317951384402, 7639.388848891964, 7677.692892284246, 8381.287590554628, 8423.8736418955, 8462.449940753831, 8463.195996380335, 8464.195901389357, 7332.890006650011, 7377.5204611700065, 7432.368248698921, 7577.0, 7639.197884222299, 7313.890291645524, 7362.0, 7416.0, 7432.665530051268, 7557.601843658941, 6963.373296403348, 6985.1967023790885, 7044.823879402851, 7047.541909775849, 7087.82280442993, 4798.0, 4825.782839772289, 4935.284383764406, 4981.302617633607, 5111.284420181103, 4461.330800379969, 4896.167651499325, 4999.925001124913, 5014.498550144956, 5048.671836330626], "value": 4562.347872383501, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.18456476218967, 325.3217042466457, 329.9389612921608, 330.4366055874733, 335.6123677152886, 5941.0, 5995.430434108764, 6002.849928751778, 6050.757969681207, 6056.576039677225, 5960.0, 5974.8506287342725, 5981.401859814027, 6024.518038556916, 6040.275166979968, 4267.829286828523, 4335.6531477481885, 4424.451441995292, 4500.459944806627, 4540.614047805941, 4263.232618128735, 4448.621867141297, 4522.479914809806, 4526.75102869342, 4531.139083574127, 4177.874663760092, 4279.893002674927, 4318.0, 4524.886877828048, 4543.273076307792, 3698.611645777195, 4362.8691139265875, 4468.463784345867, 4470.75410852403, 4493.30353795159, 2911.3303940093683, 3069.600951876264, 3732.4774531565604, 3877.7203522837676, 3895.844166233347, 4895.730734809584, 4925.0, 5555.388907220203, 5667.773289068432, 5695.686737229451, 4046.959530404717, 4944.901101977976, 5088.821891233826, 5208.723862653636, 5214.270002199695, 5409.43200963901, 5601.075822489284, 6259.029850373199, 6316.9368306317265, 6338.176037115191, 3640.508531348287, 4286.6570674346285, 4288.335308027261, 4321.481422229353, 4352.7605981670995, 5615.9157612635845, 6180.969095154541, 6635.966820165917, 6723.0, 6723.159605049369, 3759.9624003759614, 4139.793010349531, 4218.978905105455, 4254.212970600449, 4270.636995855387, 3846.788426636506, 4334.089841133397, 4334.45819272591, 4344.761038142869, 4361.890952726144, 4210.72630279037, 4771.665983381199, 5078.898422031539, 5096.923546146811, 5104.668196567211, 6373.139626150503, 6377.202849643794, 6383.0, 6389.265234498, 6412.519061070345, 1472.8429132417364, 1486.4351546412295, 1497.4983380567414, 1497.6630258192038, 1502.9699406012037, 896.3635818568889, 945.9101385368378, 947.5262368815593, 951.5004622573205, 980.4950450517989, 4628.958484340997, 5223.865680591614, 5684.067417078213, 5781.88436231273, 5792.362840087587, 5727.310443419118, 6166.5816862121965, 6425.518086143558, 6477.574933514619, 6496.6426846522945, 4944.813244821217, 5427.530473634487, 5427.674339539641, 5654.5193658538665, 5768.826935191951, 2550.8086893483064, 2827.703091175397, 3188.772322655794, 3467.4105402081705, 3507.3686736387185, 6236.291599842181, 6437.549371543947, 6881.277465866112, 6905.861882762417, 6919.125289837606, 5693.971530142323, 6782.491313151533, 6827.0, 6841.486888483384, 6860.931390686129, 6532.510061745293, 6578.80263592093, 6930.861382772317, 6956.8956465653055, 7004.544704594185, 5862.062070068769, 6611.867762644816, 6684.899726504009, 6698.39714425704, 6725.637181409295, 5497.917531237114, 6500.25247096571, 6605.504587155887, 6633.402993730588, 6641.734330626721, 5556.222128902038, 6476.740930362733, 6640.904250798564, 6653.268140504444, 7029.367356937695, 3764.9247015059, 3891.3579259421876, 3944.2505923874373, 4227.027783609726, 4304.117655880599, 5491.807786727445, 5505.614606977633, 6252.374762523711, 6565.474762019123, 6603.471722262111, 5559.303737687138, 6269.373062693694, 6308.467258335347, 6324.3991820776955, 6347.746090156526, 6310.684465776784, 6319.368063193644, 6334.334894835976, 6337.429631333202, 6350.0, 5178.6374953752875, 5695.0, 5791.276090488689, 5858.736356864037, 6041.24484439445, 5628.887422251614, 5918.526517878646, 6200.387899146164, 6244.46922011616, 6426.369101457662, 4842.370491836039, 5230.660007099526, 6268.937310627018, 6280.842978925563, 6308.873822523432], "value": 4532.77567321445, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.7729040255105, 737.3511310047154, 746.5073051785822, 758.1773775453632, 767.4282659418734, 12777.169483983535, 14577.271136443174, 14862.108273503598, 15564.533064008083, 16001.83998160018, 11142.610008649699, 14365.138091714505, 14507.49223777168, 14569.198694071822, 14581.19803410812, 715.2061212054615, 876.570480464571, 922.6263363337858, 923.8383282925495, 937.3719607862714, 898.5507246376811, 920.9171174594285, 926.5089502563618, 927.4574373991223, 931.4923366765129, 955.7037318431273, 982.8083523712879, 984.6356847966263, 986.3342243985317, 988.7330420786384, 938.9061093890624, 947.5688561704408, 953.2469349214113, 957.3250858145026, 972.5526257921365, 697.5326531224041, 701.4388489208663, 720.3408880873994, 723.9095113110861, 728.2971932085563, 14570.562883113524, 14599.854001459955, 14658.560243192722, 14688.971771975966, 14709.779353309708, 12451.0, 12496.375181240901, 12502.3748812559, 12554.68613284666, 12788.808167877489, 10806.72983175419, 10999.450027498673, 11181.161412893984, 11197.328160310326, 11457.713557161138, 4063.7155399122075, 4075.3071977763852, 4076.551579326301, 4203.381698046243, 4401.339799030139, 67848.3215167847, 78093.60953195198, 84235.0, 86304.0, 86811.56594217052, 9635.951820240854, 9744.31789774723, 9937.453440060866, 9968.102870741668, 10423.681812779769, 18527.72208416875, 22844.543109137725, 23094.65358019631, 23147.88426057859, 23183.0, 6354.872902542016, 6950.3049695030095, 7746.147923728386, 7846.803829904298, 7960.323372513401, 3654.8172591370326, 3976.602339766, 4015.2772500949527, 4080.591940805896, 4098.7950602470355, 3485.89542313731, 3585.032041348821, 3605.188832512664, 3611.711063114997, 3613.638636136418, 634.5712430159933, 634.9523785715998, 640.078287266335, 640.8590110175754, 647.1037612906159, 511.64185070450833, 522.6002108387087, 590.8552404660885, 612.6262979582451, 616.8889599872066, 6219.445138715321, 7564.978727871667, 7640.0, 7993.960030199928, 8124.903138076403, 487.4053654541454, 504.7451037226177, 564.3876394112434, 592.2271435776267, 607.4806040835023, 3307.8842240521467, 3775.9238616994026, 3784.394496880486, 3806.923861522754, 3926.7447615904875, 83630.0, 85259.14740852636, 85507.0, 86632.56683716542, 88724.5563772177, 69434.0, 72030.0, 72260.0, 73217.26782732105, 73863.63068184625, 63135.6843215781, 63174.36825631685, 63487.730245394836, 68336.0, 68983.65508172427, 6530.346965303432, 7120.394766444911, 8051.436399451982, 8151.551664658501, 8216.613472617117, 36964.0, 39228.607713922494, 42055.0, 42169.578304216564, 42370.728878133705, 49875.0049997996, 63031.6848415755, 65297.347026529125, 65414.672926636966, 65774.0, 10552.736181595521, 10736.0, 10755.677329680122, 11219.775604488028, 11441.970222679665, 11635.41822908868, 11817.527298908291, 12135.150539462153, 12330.848038410024, 12727.681807954876, 11256.0, 11281.71795705114, 11331.47025151594, 11365.261258018203, 11806.940965295118, 10734.19493537972, 11088.833667495155, 11112.999830015337, 11153.888461115284, 11409.372484513431, 10947.945260273966, 11350.943245284052, 11373.135510964048, 11397.08823294118, 11478.598249061577, 9510.667126650535, 9611.807763844545, 9827.11555959967, 10045.69862904114, 10079.092881640687, 9264.44413335202, 9596.66411675588, 9645.27660425485, 9687.0, 9784.412935223625], "value": 6811.7471986282735, "unit": "score"}], "name": "dromaeo_css", "value": 7163.465891009061, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 126.0, 119.0, 134.0, 172.0, 169.0, 117.0, 115.0, 116.0, 115.0], "value": 130.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 145.0, 168.0, 127.0, 137.0, 155.0, 195.0, 197.0, 121.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 205.0, 236.0, 197.0, 200.0, 196.0, 198.0, 201.0, 199.0, 198.0], "value": 203.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 75.0, 144.0, 58.0, 55.0, 69.0, 67.0, 148.0, 56.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 139.0, 116.0, 123.0, 82.0, 132.0, 93.0, 80.0, 119.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 90.0, 91.0, 91.0, 86.0, 89.0, 87.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 96.0, 95.0, 95.0, 98.0, 107.0, 153.0, 150.0], "value": 107.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 105.0, 79.0, 106.0, 112.0, 125.0, 141.0, 140.0, 146.0], "value": 119.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 59.0, 52.0, 74.0, 95.0, 93.0, 64.0, 60.0], "value": 68.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 56.0, 63.0, 75.0, 76.0, 76.0, 70.0, 56.0, 69.0, 86.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 104.0, 113.0, 110.0, 79.0, 113.0, 114.0, 76.0, 101.0, 106.0], "value": 100.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 136.0, 141.0, 139.0, 154.0, 159.0, 157.0, 142.0, 177.0, 158.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [231.0, 233.0, 187.0, 171.0, 170.0, 229.0, 181.0, 209.0, 235.0, 182.0], "value": 202.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 70.0, 68.0, 74.0, 66.0, 68.0, 70.0, 71.0, 67.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1648.9, "alertThreshold": 2.0}]} 13:28:16 INFO - Return code: 0 13:28:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:28:16 ERROR - # TBPL SUCCESS # 13:28:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:28:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:28:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:28:16 INFO - 2016-04-15 13:28:16.799 screenresolution[1678:10341] starting screenresolution argv=screenresolution get 13:28:16 INFO - 2016-04-15 13:28:16.802 screenresolution[1678:10341] Display 0: 1600x1200x32@60 13:28:16 INFO - 2016-04-15 13:28:16.808 screenresolution[1679:10344] starting screenresolution argv=screenresolution list 13:28:16 INFO - Available Modes on Display 0 13:28:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:28:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:28:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:28:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:28:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:28:17 INFO - Intel Iris: 13:28:17 INFO - Chipset Model: Intel Iris 13:28:17 INFO - Type: GPU 13:28:17 INFO - Bus: Built-In 13:28:17 INFO - VRAM (Dynamic, Max): 1536 MB 13:28:17 INFO - Vendor: Intel (0x8086) 13:28:17 INFO - Device ID: 0x0a2e 13:28:17 INFO - Revision ID: 0x0009 13:28:17 INFO - Displays: 13:28:17 INFO - Display: 13:28:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:28:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:28:17 INFO - Display Serial Number: 1600x1200 60 13:28:17 INFO - Main Display: Yes 13:28:17 INFO - Mirror: Off 13:28:17 INFO - Online: Yes 13:28:17 INFO - Rotation: Supported 13:28:17 INFO - Return code: 0 13:28:17 INFO - Running post-action listener: _resource_record_post_action 13:28:17 INFO - Running post-run listener: _resource_record_post_run 13:28:18 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37651968; Write bytes: 695944192; Read time: 396; Write time: 1920 13:28:18 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 397668864; Write bytes: 386741760; Read time: 30051; Write time: 733 13:28:18 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 30416384; Write bytes: 297946624; Read time: 302; Write time: 1156 13:28:18 INFO - Running post-run listener: _upload_blobber_files 13:28:18 INFO - Blob upload gear active. 13:28:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:28:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:28:18 INFO - (blobuploader) - INFO - Open directory for files ... 13:28:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:28:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:28:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:19 INFO - (blobuploader) - INFO - Done attempting. 13:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:28:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:20 INFO - (blobuploader) - INFO - Done attempting. 13:28:20 INFO - (blobuploader) - INFO - Iteration through files over. 13:28:20 INFO - Return code: 0 13:28:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:28:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:28:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaf1c837bac9834c8c752bf0d9ebf39751dac5e6b9e9ee0995740b49265a2e04a3c2b323cccd4fa62726baf76f00201b2bae6843c2a449aedb6a898015e18ba8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6caaa4c39fb8de7967cc41574885225e73d1c2217d8b5fe5c1d4add599c94de2383e248be95dbe6e1606cc72b88026f28a978cd43f314ceff822abbd494334fd"} 13:28:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:28:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:28:20 INFO - Contents: 13:28:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaf1c837bac9834c8c752bf0d9ebf39751dac5e6b9e9ee0995740b49265a2e04a3c2b323cccd4fa62726baf76f00201b2bae6843c2a449aedb6a898015e18ba8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6caaa4c39fb8de7967cc41574885225e73d1c2217d8b5fe5c1d4add599c94de2383e248be95dbe6e1606cc72b88026f28a978cd43f314ceff822abbd494334fd"} 13:28:20 INFO - Running post-run listener: copy_logs_to_upload_dir 13:28:20 INFO - Copying logs to upload dir... 13:28:20 INFO - mkdir: /builds/slave/test/build/upload/logs 13:28:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.448621 ========= master_lag: 0.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-15 13:28:21.396229) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 13:28:21.400100) ========= 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.0yGw5F1obc/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.jJ1M40lsaE/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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/eaf1c837bac9834c8c752bf0d9ebf39751dac5e6b9e9ee0995740b49265a2e04a3c2b323cccd4fa62726baf76f00201b2bae6843c2a449aedb6a898015e18ba8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6caaa4c39fb8de7967cc41574885225e73d1c2217d8b5fe5c1d4add599c94de2383e248be95dbe6e1606cc72b88026f28a978cd43f314ceff822abbd494334fd"} build_url:https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010956 build_url: 'https://queue.taskcluster.net/v1/task/Igo4IgpLRyasEQkfMkUaXQ/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/eaf1c837bac9834c8c752bf0d9ebf39751dac5e6b9e9ee0995740b49265a2e04a3c2b323cccd4fa62726baf76f00201b2bae6843c2a449aedb6a898015e18ba8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6caaa4c39fb8de7967cc41574885225e73d1c2217d8b5fe5c1d4add599c94de2383e248be95dbe6e1606cc72b88026f28a978cd43f314ceff822abbd494334fd"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 13:28:21.442493) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 13:28:21.442896) ========= 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.0yGw5F1obc/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.jJ1M40lsaE/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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.004955 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 13:28:21.492458) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 13:28:21.495859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 13:28:21.496299) ========= ========= Total master_lag: 0.79 =========