builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1467132465.68 results: success (0) buildid: 20160628075828 builduid: cc79df57ceac4240aee67e4232804bc3 revision: 39023f2bbf6e44d29165130cd5e19d35385f0b97 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:45.678764) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:45.679331) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:45.679662) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:45.698845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:45.699300) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 09:47:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (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% 221M=0s 2016-06-28 09:47:46 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115361 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:45.829527) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:45.829857) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015230 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:45.879518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:45.879882) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 39023f2bbf6e44d29165130cd5e19d35385f0b97 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 39023f2bbf6e44d29165130cd5e19d35385f0b97 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 09:47:46,356 truncating revision to first 12 chars 2016-06-28 09:47:46,356 Setting DEBUG logging. 2016-06-28 09:47:46,356 attempt 1/10 2016-06-28 09:47:46,356 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/39023f2bbf6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 09:47:46,680 unpacking tar archive at: mozilla-beta-39023f2bbf6e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692899 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:46.586906) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:46.587266) ========= script_repo_revision: 39023f2bbf6e44d29165130cd5e19d35385f0b97 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:46.587700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:46.587976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 09:47:46.599180) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-28 09:47:46.599608) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:47:47 INFO - MultiFileLogger online at 20160628 09:47:47 in /builds/slave/test 09:47:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:47:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:47:47 INFO - {'append_to_log': False, 09:47:47 INFO - 'base_work_dir': '/builds/slave/test', 09:47:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:47:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:47:47 INFO - 'branch': 'Mozilla-Beta', 09:47:47 INFO - 'buildbot_json_path': 'buildprops.json', 09:47:47 INFO - 'config_files': ('talos/linux_config.py',), 09:47:47 INFO - 'default_actions': ('clobber', 09:47:47 INFO - 'read-buildbot-config', 09:47:47 INFO - 'download-and-extract', 09:47:47 INFO - 'populate-webroot', 09:47:47 INFO - 'create-virtualenv', 09:47:47 INFO - 'install', 09:47:47 INFO - 'run-tests'), 09:47:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:47:47 INFO - 'download_minidump_stackwalk': True, 09:47:47 INFO - 'download_symbols': 'ondemand', 09:47:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:47:47 INFO - 'tooltool.py': '/tools/tooltool.py', 09:47:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:47:47 INFO - '/tools/misc-python/virtualenv.py')}, 09:47:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:47:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:47:47 INFO - 'installer_path': 'installer.exe', 09:47:47 INFO - 'log_level': 'info', 09:47:47 INFO - 'log_name': 'talos', 09:47:47 INFO - 'log_to_console': True, 09:47:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:47:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:47:47 INFO - 'opt_config_files': (), 09:47:47 INFO - 'pip_index': False, 09:47:47 INFO - 'sps_profile': False, 09:47:47 INFO - 'sps_profile_interval': 0, 09:47:47 INFO - 'suite': 'dromaeojs-e10s', 09:47:47 INFO - 'system_bits': '32', 09:47:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:47:47 INFO - 'title': 'talos-linux64-ix-048', 09:47:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:47:47 INFO - 'use_talos_json': True, 09:47:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:47:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:47:47 INFO - 'work_dir': 'build'} 09:47:47 INFO - ##### 09:47:47 INFO - ##### Running clobber step. 09:47:47 INFO - ##### 09:47:47 INFO - Running pre-action listener: _resource_record_pre_action 09:47:47 INFO - Running main action method: clobber 09:47:47 INFO - rmtree: /builds/slave/test/build 09:47:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:47:47 INFO - Running post-action listener: _resource_record_post_action 09:47:47 INFO - ##### 09:47:47 INFO - ##### Running read-buildbot-config step. 09:47:47 INFO - ##### 09:47:47 INFO - Running pre-action listener: _resource_record_pre_action 09:47:47 INFO - Running main action method: read_buildbot_config 09:47:47 INFO - Using buildbot properties: 09:47:47 INFO - { 09:47:47 INFO - "project": "", 09:47:47 INFO - "product": "firefox", 09:47:47 INFO - "script_repo_revision": "production", 09:47:47 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:47:47 INFO - "repository": "", 09:47:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 09:47:47 INFO - "buildid": "20160628075828", 09:47:47 INFO - "pgo_build": "True", 09:47:47 INFO - "basedir": "/builds/slave/test", 09:47:47 INFO - "buildnumber": 67, 09:47:47 INFO - "slavename": "talos-linux64-ix-048", 09:47:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:47:47 INFO - "platform": "ubuntu64_hw", 09:47:47 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:47:47 INFO - "branch": "mozilla-beta", 09:47:47 INFO - "repo_path": "releases/mozilla-beta", 09:47:47 INFO - "revision": "39023f2bbf6e44d29165130cd5e19d35385f0b97", 09:47:47 INFO - "stage_platform": "linux64-pgo", 09:47:47 INFO - "builduid": "cc79df57ceac4240aee67e4232804bc3", 09:47:47 INFO - "slavebuilddir": "test" 09:47:47 INFO - } 09:47:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 09:47:47 INFO - Running post-action listener: _resource_record_post_action 09:47:47 INFO - ##### 09:47:47 INFO - ##### Running download-and-extract step. 09:47:47 INFO - ##### 09:47:47 INFO - Running pre-action listener: _resource_record_pre_action 09:47:47 INFO - Running main action method: download_and_extract 09:47:47 INFO - mkdir: /builds/slave/test/build/tests 09:47:47 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')]} 09:47:47 INFO - https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:47:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:47:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:47:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:47:48 INFO - Downloaded 1327 bytes. 09:47:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:47:48 INFO - Using the following test package requirements: 09:47:48 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:47:48 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:47:48 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:47:48 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:47:48 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 09:47:48 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:47:48 INFO - u'jsshell-linux-x86_64.zip'], 09:47:48 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:47:48 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:47:48 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:47:48 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:47:48 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 09:47:48 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:47:48 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 09:47:48 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:47:48 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:47:48 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:47:48 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:47:48 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:47:48 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')]} 09:47:48 INFO - https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:47:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:47:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:47:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:47:49 INFO - Downloaded 24235687 bytes. 09:47:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:47:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:47:50 INFO - Return code: 0 09:47:50 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:47: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')]} 09:47:50 INFO - https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:47:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:47:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:47:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:47:51 INFO - Downloaded 24235687 bytes. 09:47:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:47:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:47:53 INFO - Return code: 0 09:47:53 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')]} 09:47:53 INFO - https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:47:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:47:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:47:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:47:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:47:54 INFO - Downloaded 10840145 bytes. 09:47:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:47:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:47:54 INFO - Return code: 0 09:47: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')]} 09:47:54 INFO - https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:47:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:47:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:47:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:47:55 INFO - Downloaded 56001096 bytes. 09:47:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:47:55 INFO - mkdir: /builds/slave/test/properties 09:47:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:47:55 INFO - Writing to file /builds/slave/test/properties/build_url 09:47:55 INFO - Contents: 09:47:55 INFO - build_url:https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:47:56 INFO - Running post-action listener: _resource_record_post_action 09:47:56 INFO - Running post-action listener: set_extra_try_arguments 09:47:56 INFO - ##### 09:47:56 INFO - ##### Running populate-webroot step. 09:47:56 INFO - ##### 09:47:56 INFO - Running pre-action listener: _resource_record_pre_action 09:47:56 INFO - Running main action method: populate_webroot 09:47:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:47:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:47:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:47:56 INFO - '--tppagecycles', 09:47:56 INFO - '7'], 09:47:56 INFO - 'tests': ['tsvgm']}}, 09:47:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:47:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:47:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:47:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:47:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:47:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:47:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:56 INFO - 'talos_options': ['--disable-e10s'], 09:47:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:56 INFO - 'talos_options': ['--disable-e10s'], 09:47:56 INFO - 'tests': ['damp', 'tps']}, 09:47:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:56 INFO - 'tests': ['damp', 'tps']}, 09:47:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:47:56 INFO - 'tests': ['dromaeo_dom']}, 09:47:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:47:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:47:56 INFO - 'tests': ['a11yr', 09:47:56 INFO - 'ts_paint', 09:47:56 INFO - 'tpaint', 09:47:56 INFO - 'sessionrestore', 09:47:56 INFO - 'sessionrestore_no_auto_restore', 09:47:56 INFO - 'tabpaint']}, 09:47:56 INFO - 'other-e10s': {'tests': ['a11yr', 09:47:56 INFO - 'ts_paint', 09:47:56 INFO - 'tpaint', 09:47:56 INFO - 'sessionrestore', 09:47:56 INFO - 'sessionrestore_no_auto_restore', 09:47:56 INFO - 'tabpaint']}, 09:47:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:47:56 INFO - 'ts_paint', 09:47:56 INFO - 'tpaint', 09:47:56 INFO - 'sessionrestore', 09:47:56 INFO - 'sessionrestore_no_auto_restore', 09:47:56 INFO - 'tabpaint']}, 09:47:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:47:56 INFO - 'ts_paint', 09:47:56 INFO - 'tpaint', 09:47:56 INFO - 'sessionrestore', 09:47:56 INFO - 'sessionrestore_no_auto_restore', 09:47:56 INFO - 'tabpaint']}, 09:47:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:47:56 INFO - 'tests': ['a11yr', 09:47:56 INFO - 'ts_paint', 09:47:56 INFO - 'tpaint', 09:47:56 INFO - 'sessionrestore', 09:47:56 INFO - 'sessionrestore_no_auto_restore', 09:47:56 INFO - 'tabpaint']}, 09:47:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:47:56 INFO - 'tests': ['a11yr', 09:47:56 INFO - 'ts_paint', 09:47:56 INFO - 'tpaint', 09:47:56 INFO - 'sessionrestore', 09:47:56 INFO - 'sessionrestore_no_auto_restore', 09:47:56 INFO - 'tabpaint']}, 09:47:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:47:56 INFO - 'tests': ['tsvgx', 09:47:56 INFO - 'tsvgr_opacity', 09:47:56 INFO - 'tart', 09:47:56 INFO - 'tscrollx', 09:47:56 INFO - 'cart']}, 09:47:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:47:56 INFO - 'tsvgr_opacity', 09:47:56 INFO - 'tart', 09:47:56 INFO - 'tscrollx', 09:47:56 INFO - 'cart']}, 09:47:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:56 INFO - 'talos_options': ['--disable-e10s'], 09:47:56 INFO - 'tests': ['tp5o']}, 09:47:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:56 INFO - 'tests': ['tp5o']}, 09:47:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:56 INFO - 'talos_options': ['--disable-e10s', 09:47:56 INFO - '--xperf_path', 09:47:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:56 INFO - 'tests': ['tp5n']}, 09:47:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:56 INFO - 'talos_options': ['--xperf_path', 09:47:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:56 INFO - 'tests': ['tp5n']}}, 09:47:56 INFO - 'talos.zip': {'path': '', 09:47:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:47:56 INFO - Running post-action listener: _resource_record_post_action 09:47:56 INFO - ##### 09:47:56 INFO - ##### Running create-virtualenv step. 09:47:56 INFO - ##### 09:47:56 INFO - Running pre-action listener: _resource_record_pre_action 09:47:56 INFO - Running main action method: create_virtualenv 09:47:56 INFO - Creating virtualenv /builds/slave/test/build/venv 09:47:56 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 09:47:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:47:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:47:56 INFO - Using real prefix '/usr' 09:47:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:47:57 INFO - Installing distribute.............................................................................................................................................................................................done. 09:47:59 INFO - Installing pip.................done. 09:47:59 INFO - Return code: 0 09:47:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:47: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')]} 09:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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')]} 09:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a000daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e3410>, '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 0x27e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e47a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:47: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', 'pip>=1.5'] in /builds/slave/test/build 09:47: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 pip>=1.5 09:47:59 INFO - Using env: {'DISPLAY': ':0', 09:47:59 INFO - 'HOME': '/home/cltbld', 09:47:59 INFO - 'LANG': 'en_US.UTF-8', 09:47:59 INFO - 'LANGUAGE': 'en_US:en', 09:47:59 INFO - 'LOGNAME': 'cltbld', 09:47:59 INFO - 'MAIL': '/var/mail/cltbld', 09:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:59 INFO - 'MOZ_NO_REMOTE': '1', 09:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:59 INFO - 'NO_EM_RESTART': '1', 09:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:59 INFO - 'PWD': '/builds/slave/test', 09:47:59 INFO - 'SHELL': '/bin/bash', 09:47:59 INFO - 'SHLVL': '1', 09:47:59 INFO - 'TERM': 'linux', 09:47:59 INFO - 'TMOUT': '86400', 09:47:59 INFO - 'USER': 'cltbld', 09:47:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 09:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:59 INFO - '_': '/tools/buildbot/bin/python'} 09:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:59 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 09:47:59 INFO - Cleaning up... 09:47:59 INFO - Return code: 0 09:47:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:47: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')]} 09:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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')]} 09:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47: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', '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 0x7f1a000daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e3410>, '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 0x27e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e47a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:47: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', 'psutil>=0.7.1'] in /builds/slave/test/build 09:47: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 psutil>=0.7.1 09:47:59 INFO - Using env: {'DISPLAY': ':0', 09:47:59 INFO - 'HOME': '/home/cltbld', 09:47:59 INFO - 'LANG': 'en_US.UTF-8', 09:47:59 INFO - 'LANGUAGE': 'en_US:en', 09:47:59 INFO - 'LOGNAME': 'cltbld', 09:47:59 INFO - 'MAIL': '/var/mail/cltbld', 09:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:59 INFO - 'MOZ_NO_REMOTE': '1', 09:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:59 INFO - 'NO_EM_RESTART': '1', 09:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:59 INFO - 'PWD': '/builds/slave/test', 09:47:59 INFO - 'SHELL': '/bin/bash', 09:47:59 INFO - 'SHLVL': '1', 09:47:59 INFO - 'TERM': 'linux', 09:47:59 INFO - 'TMOUT': '86400', 09:47:59 INFO - 'USER': 'cltbld', 09:47:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 09:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:59 INFO - '_': '/tools/buildbot/bin/python'} 09:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:59 INFO - Downloading/unpacking psutil>=0.7.1 09:47:59 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 09:47:59 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 09:47:59 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 09:47:59 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 09:47:59 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 09:47:59 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 09:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:01 INFO - Installing collected packages: psutil 09:48:01 INFO - Running setup.py install for psutil 09:48:01 INFO - building 'psutil._psutil_linux' extension 09:48:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:48:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:48:01 INFO - building 'psutil._psutil_posix' extension 09:48:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:48:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:48:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:02 INFO - Successfully installed psutil 09:48:02 INFO - Cleaning up... 09:48:02 INFO - Return code: 0 09:48:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:48:02 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')]} 09:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:02 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')]} 09:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:02 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 0x7f1a000daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e3410>, '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 0x27e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e47a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:02 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 09:48:02 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 09:48:02 INFO - Using env: {'DISPLAY': ':0', 09:48:02 INFO - 'HOME': '/home/cltbld', 09:48:02 INFO - 'LANG': 'en_US.UTF-8', 09:48:02 INFO - 'LANGUAGE': 'en_US:en', 09:48:02 INFO - 'LOGNAME': 'cltbld', 09:48:02 INFO - 'MAIL': '/var/mail/cltbld', 09:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:02 INFO - 'MOZ_NO_REMOTE': '1', 09:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:02 INFO - 'NO_EM_RESTART': '1', 09:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:02 INFO - 'PWD': '/builds/slave/test', 09:48:02 INFO - 'SHELL': '/bin/bash', 09:48:02 INFO - 'SHLVL': '1', 09:48:02 INFO - 'TERM': 'linux', 09:48:02 INFO - 'TMOUT': '86400', 09:48:02 INFO - 'USER': 'cltbld', 09:48:02 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 09:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:02 INFO - '_': '/tools/buildbot/bin/python'} 09:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:48:04 INFO - Installing collected packages: mozsystemmonitor 09:48:04 INFO - Running setup.py install for mozsystemmonitor 09:48:04 INFO - Successfully installed mozsystemmonitor 09:48:04 INFO - Cleaning up... 09:48:04 INFO - Return code: 0 09:48:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:04 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 0x7f1a000daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e3410>, '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 0x27e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e47a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:04 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 09:48:04 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 09:48:04 INFO - Using env: {'DISPLAY': ':0', 09:48:04 INFO - 'HOME': '/home/cltbld', 09:48:04 INFO - 'LANG': 'en_US.UTF-8', 09:48:04 INFO - 'LANGUAGE': 'en_US:en', 09:48:04 INFO - 'LOGNAME': 'cltbld', 09:48:04 INFO - 'MAIL': '/var/mail/cltbld', 09:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:04 INFO - 'MOZ_NO_REMOTE': '1', 09:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:04 INFO - 'NO_EM_RESTART': '1', 09:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:04 INFO - 'PWD': '/builds/slave/test', 09:48:04 INFO - 'SHELL': '/bin/bash', 09:48:04 INFO - 'SHLVL': '1', 09:48:04 INFO - 'TERM': 'linux', 09:48:04 INFO - 'TMOUT': '86400', 09:48:04 INFO - 'USER': 'cltbld', 09:48:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 09:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:04 INFO - '_': '/tools/buildbot/bin/python'} 09:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:06 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:07 INFO - Downloading docopt-0.6.1.tar.gz 09:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:07 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:07 INFO - Running setup.py install for blobuploader 09:48:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:07 INFO - Running setup.py install for requests 09:48:08 INFO - Running setup.py install for docopt 09:48:08 INFO - Successfully installed blobuploader requests docopt 09:48:08 INFO - Cleaning up... 09:48:08 INFO - Return code: 0 09:48:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:08 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')]} 09:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:08 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')]} 09:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:08 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 0x7f1a000daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e3410>, '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 0x27e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e47a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:08 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 09:48:08 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 09:48:08 INFO - Using env: {'DISPLAY': ':0', 09:48:08 INFO - 'HOME': '/home/cltbld', 09:48:08 INFO - 'LANG': 'en_US.UTF-8', 09:48:08 INFO - 'LANGUAGE': 'en_US:en', 09:48:08 INFO - 'LOGNAME': 'cltbld', 09:48:08 INFO - 'MAIL': '/var/mail/cltbld', 09:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:08 INFO - 'MOZ_NO_REMOTE': '1', 09:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:08 INFO - 'NO_EM_RESTART': '1', 09:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:08 INFO - 'PWD': '/builds/slave/test', 09:48:08 INFO - 'SHELL': '/bin/bash', 09:48:08 INFO - 'SHLVL': '1', 09:48:08 INFO - 'TERM': 'linux', 09:48:08 INFO - 'TMOUT': '86400', 09:48:08 INFO - 'USER': 'cltbld', 09:48:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 09:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:08 INFO - '_': '/tools/buildbot/bin/python'} 09:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:08 INFO - Running setup.py (path:/tmp/pip-g5TfIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:08 INFO - Running setup.py (path:/tmp/pip-FXQPgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:08 INFO - Running setup.py (path:/tmp/pip-Lwol6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:08 INFO - Running setup.py (path:/tmp/pip-hiYde9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:08 INFO - Running setup.py (path:/tmp/pip-deOrfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:08 INFO - Running setup.py (path:/tmp/pip-ZUt6jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:08 INFO - Running setup.py (path:/tmp/pip-S9Io3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:09 INFO - Running setup.py (path:/tmp/pip-kchjMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:09 INFO - Running setup.py (path:/tmp/pip-P7I33t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:09 INFO - Running setup.py (path:/tmp/pip-sezqgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:09 INFO - Running setup.py (path:/tmp/pip-mgnzLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:09 INFO - Running setup.py (path:/tmp/pip-0BiToR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:09 INFO - Running setup.py (path:/tmp/pip-z4LApY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:09 INFO - Running setup.py (path:/tmp/pip-YqblU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:09 INFO - Running setup.py (path:/tmp/pip-jDr8Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:09 INFO - Running setup.py (path:/tmp/pip-qXK_Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:09 INFO - Running setup.py (path:/tmp/pip-UHdh_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:09 INFO - Running setup.py install for manifestparser 09:48:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:09 INFO - Running setup.py install for mozcrash 09:48:09 INFO - Running setup.py install for mozdebug 09:48:10 INFO - Running setup.py install for mozdevice 09:48:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:48:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:10 INFO - Running setup.py install for mozfile 09:48:10 INFO - Running setup.py install for mozhttpd 09:48:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:10 INFO - Running setup.py install for mozinfo 09:48:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:10 INFO - Running setup.py install for mozInstall 09:48:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:10 INFO - Running setup.py install for mozleak 09:48:10 INFO - Running setup.py install for mozlog 09:48:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:10 INFO - Running setup.py install for moznetwork 09:48:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:10 INFO - Running setup.py install for mozprocess 09:48:10 INFO - Running setup.py install for mozprofile 09:48:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:11 INFO - Running setup.py install for mozrunner 09:48:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:11 INFO - Running setup.py install for mozscreenshot 09:48:11 INFO - Running setup.py install for moztest 09:48:11 INFO - Running setup.py install for mozversion 09:48:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:11 INFO - Cleaning up... 09:48:11 INFO - Return code: 0 09:48:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:11 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 0x7f1a000daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e3410>, '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 0x27e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e47a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:11 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 09:48:11 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 09:48:11 INFO - Using env: {'DISPLAY': ':0', 09:48:11 INFO - 'HOME': '/home/cltbld', 09:48:11 INFO - 'LANG': 'en_US.UTF-8', 09:48:11 INFO - 'LANGUAGE': 'en_US:en', 09:48:11 INFO - 'LOGNAME': 'cltbld', 09:48:11 INFO - 'MAIL': '/var/mail/cltbld', 09:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:11 INFO - 'MOZ_NO_REMOTE': '1', 09:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:11 INFO - 'NO_EM_RESTART': '1', 09:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:11 INFO - 'PWD': '/builds/slave/test', 09:48:11 INFO - 'SHELL': '/bin/bash', 09:48:11 INFO - 'SHLVL': '1', 09:48:11 INFO - 'TERM': 'linux', 09:48:11 INFO - 'TMOUT': '86400', 09:48:11 INFO - 'USER': 'cltbld', 09:48:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 09:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:11 INFO - '_': '/tools/buildbot/bin/python'} 09:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:11 INFO - Running setup.py (path:/tmp/pip-AJG1qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:11 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)) 09:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:11 INFO - Running setup.py (path:/tmp/pip-U8eiEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:11 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)) 09:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:11 INFO - Running setup.py (path:/tmp/pip-QSS3yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:11 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)) 09:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:11 INFO - Running setup.py (path:/tmp/pip-zBWKL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:12 INFO - Running setup.py (path:/tmp/pip-DfdUJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:12 INFO - Running setup.py (path:/tmp/pip-KbVGNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:12 INFO - Running setup.py (path:/tmp/pip-_YzteU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:12 INFO - Running setup.py (path:/tmp/pip-XTs84W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:12 INFO - Running setup.py (path:/tmp/pip-7pP6VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:12 INFO - Running setup.py (path:/tmp/pip-cuBMi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:12 INFO - Running setup.py (path:/tmp/pip-K95_S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:12 INFO - Running setup.py (path:/tmp/pip-8HDqhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:12 INFO - Running setup.py (path:/tmp/pip-LRLN3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:12 INFO - Running setup.py (path:/tmp/pip-MTQ5rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:12 INFO - Running setup.py (path:/tmp/pip-4VuQR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:12 INFO - Running setup.py (path:/tmp/pip-xvJM0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:12 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)) 09:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:12 INFO - Running setup.py (path:/tmp/pip-SID9K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 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)) 09:48:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:14 INFO - Downloading blessings-1.6.tar.gz 09:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:14 INFO - Installing collected packages: blessings 09:48:14 INFO - Running setup.py install for blessings 09:48:15 INFO - Successfully installed blessings 09:48:15 INFO - Cleaning up... 09:48:15 INFO - Return code: 0 09:48:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:15 INFO - Reading from file tmpfile_stdout 09:48:15 INFO - Current package versions: 09:48:15 INFO - argparse == 1.2.1 09:48:15 INFO - blessings == 1.6 09:48:15 INFO - blobuploader == 1.2.4 09:48:15 INFO - docopt == 0.6.1 09:48:15 INFO - manifestparser == 1.1 09:48:15 INFO - mozInstall == 1.12 09:48:15 INFO - mozcrash == 0.17 09:48:15 INFO - mozdebug == 0.1 09:48:15 INFO - mozdevice == 0.48 09:48:15 INFO - mozfile == 1.2 09:48:15 INFO - mozhttpd == 0.7 09:48:15 INFO - mozinfo == 0.9 09:48:15 INFO - mozleak == 0.1 09:48:15 INFO - mozlog == 3.1 09:48:15 INFO - moznetwork == 0.27 09:48:15 INFO - mozprocess == 0.22 09:48:15 INFO - mozprofile == 0.28 09:48:15 INFO - mozrunner == 6.11 09:48:15 INFO - mozscreenshot == 0.1 09:48:15 INFO - mozsystemmonitor == 0.0 09:48:15 INFO - moztest == 0.7 09:48:15 INFO - mozversion == 1.4 09:48:15 INFO - psutil == 3.1.1 09:48:15 INFO - requests == 1.2.3 09:48:15 INFO - wsgiref == 0.1.2 09:48:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:15 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 0x7f1a000daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e3410>, '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 0x27e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e47a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:15 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 09:48:15 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 09:48:15 INFO - Using env: {'DISPLAY': ':0', 09:48:15 INFO - 'HOME': '/home/cltbld', 09:48:15 INFO - 'LANG': 'en_US.UTF-8', 09:48:15 INFO - 'LANGUAGE': 'en_US:en', 09:48:15 INFO - 'LOGNAME': 'cltbld', 09:48:15 INFO - 'MAIL': '/var/mail/cltbld', 09:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:15 INFO - 'MOZ_NO_REMOTE': '1', 09:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:15 INFO - 'NO_EM_RESTART': '1', 09:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:15 INFO - 'PWD': '/builds/slave/test', 09:48:15 INFO - 'SHELL': '/bin/bash', 09:48:15 INFO - 'SHLVL': '1', 09:48:15 INFO - 'TERM': 'linux', 09:48:15 INFO - 'TMOUT': '86400', 09:48:15 INFO - 'USER': 'cltbld', 09:48:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 09:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:15 INFO - '_': '/tools/buildbot/bin/python'} 09:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:15 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)) 09:48:15 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)) 09:48:15 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)) 09:48:15 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)) 09:48:15 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)) 09:48:15 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)) 09:48:15 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)) 09:48:15 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)) 09:48:15 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)) 09:48:15 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)) 09:48:15 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)) 09:48:15 INFO - Cleaning up... 09:48:15 INFO - Return code: 0 09:48:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a000daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e3410>, '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 0x27e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e47a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:48:15 INFO - Using env: {'DISPLAY': ':0', 09:48:15 INFO - 'HOME': '/home/cltbld', 09:48:15 INFO - 'LANG': 'en_US.UTF-8', 09:48:15 INFO - 'LANGUAGE': 'en_US:en', 09:48:15 INFO - 'LOGNAME': 'cltbld', 09:48:15 INFO - 'MAIL': '/var/mail/cltbld', 09:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:15 INFO - 'MOZ_NO_REMOTE': '1', 09:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:15 INFO - 'NO_EM_RESTART': '1', 09:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:15 INFO - 'PWD': '/builds/slave/test', 09:48:15 INFO - 'SHELL': '/bin/bash', 09:48:15 INFO - 'SHLVL': '1', 09:48:15 INFO - 'TERM': 'linux', 09:48:15 INFO - 'TMOUT': '86400', 09:48:15 INFO - 'USER': 'cltbld', 09:48:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 09:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:15 INFO - '_': '/tools/buildbot/bin/python'} 09:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:15 INFO - Downloading/unpacking jsonschema 09:48:15 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 09:48:15 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 09:48:15 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 09:48:15 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 09:48:15 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 09:48:15 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 09:48:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:17 INFO - Downloading/unpacking functools32 (from jsonschema) 09:48:17 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 09:48:17 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 09:48:17 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 09:48:17 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 09:48:17 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 09:48:17 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 09:48:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:17 INFO - warning: no files found matching '*.txt' 09:48:17 INFO - no previously-included directories found matching 'build' 09:48:17 INFO - no previously-included directories found matching 'dist' 09:48:17 INFO - no previously-included directories found matching '.git*' 09:48:17 INFO - Installing collected packages: jsonschema, functools32 09:48:18 INFO - Running setup.py install for functools32 09:48:18 INFO - warning: no files found matching '*.txt' 09:48:18 INFO - no previously-included directories found matching 'build' 09:48:18 INFO - no previously-included directories found matching 'dist' 09:48:18 INFO - no previously-included directories found matching '.git*' 09:48:18 INFO - Successfully installed jsonschema functools32 09:48:18 INFO - Cleaning up... 09:48:18 INFO - Return code: 0 09:48:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a000daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e3410>, '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 0x27e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e47a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:48:18 INFO - Using env: {'DISPLAY': ':0', 09:48:18 INFO - 'HOME': '/home/cltbld', 09:48:18 INFO - 'LANG': 'en_US.UTF-8', 09:48:18 INFO - 'LANGUAGE': 'en_US:en', 09:48:18 INFO - 'LOGNAME': 'cltbld', 09:48:18 INFO - 'MAIL': '/var/mail/cltbld', 09:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:18 INFO - 'MOZ_NO_REMOTE': '1', 09:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:18 INFO - 'NO_EM_RESTART': '1', 09:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:18 INFO - 'PWD': '/builds/slave/test', 09:48:18 INFO - 'SHELL': '/bin/bash', 09:48:18 INFO - 'SHLVL': '1', 09:48:18 INFO - 'TERM': 'linux', 09:48:18 INFO - 'TMOUT': '86400', 09:48:18 INFO - 'USER': 'cltbld', 09:48:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 09:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:18 INFO - '_': '/tools/buildbot/bin/python'} 09:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:18 INFO - Downloading/unpacking flake8 09:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:48:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:48:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 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 09:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:48:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:21 INFO - no previously-included directories found matching 'docs/_build' 09:48:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:48:21 INFO - Running setup.py install for pep8 09:48:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:21 INFO - no previously-included directories found matching 'docs/_build' 09:48:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:48:21 INFO - Cleaning up... 09:48:21 INFO - Return code: 0 09:48:21 INFO - Running post-action listener: _resource_record_post_action 09:48:21 INFO - Running post-action listener: _start_resource_monitoring 09:48:21 INFO - Starting resource monitoring. 09:48:21 INFO - ##### 09:48:21 INFO - ##### Running install step. 09:48:21 INFO - ##### 09:48:21 INFO - Running pre-action listener: _resource_record_pre_action 09:48:21 INFO - Running main action method: install 09:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:21 INFO - Reading from file tmpfile_stdout 09:48:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:21 INFO - Reading from file tmpfile_stdout 09:48:21 INFO - Output received: 09:48:21 INFO - Usage: mozinstall [options] installer 09:48:21 INFO - Options: 09:48:21 INFO - -h, --help show this help message and exit 09:48:21 INFO - -d DEST, --destination=DEST 09:48:21 INFO - Directory to install application into. [default: 09:48:21 INFO - "/builds/slave/test"] 09:48:21 INFO - --app=APP Application being installed. [default: firefox] 09:48:21 INFO - mkdir: /builds/slave/test/build/application 09:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:48:34 INFO - Reading from file tmpfile_stdout 09:48:34 INFO - Output received: 09:48:34 INFO - /builds/slave/test/build/application/firefox/firefox 09:48:34 INFO - Running post-action listener: _resource_record_post_action 09:48:34 INFO - ##### 09:48:34 INFO - ##### Running run-tests step. 09:48:34 INFO - ##### 09:48:34 INFO - Running pre-action listener: _resource_record_pre_action 09:48:34 INFO - Running main action method: run_tests 09:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:48:34 INFO - Python 2.7.3 09:48:34 INFO - Return code: 0 09:48:34 INFO - grabbing minidump binary from tooltool 09:48:34 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')]} 09:48:34 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e3410>, '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 0x27e4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:48:34 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:48:34 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/linux64/releng.manifest -o -c /builds/tooltool_cache 09:48:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:48:34 INFO - Return code: 0 09:48:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:48:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:48:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:48:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:48:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:48:35 INFO - Return code: 0 09:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 09:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 09:48:35 INFO - Using env: {'DISPLAY': ':0', 09:48:35 INFO - 'HOME': '/home/cltbld', 09:48:35 INFO - 'LANG': 'en_US.UTF-8', 09:48:35 INFO - 'LANGUAGE': 'en_US:en', 09:48:35 INFO - 'LOGNAME': 'cltbld', 09:48:35 INFO - 'MAIL': '/var/mail/cltbld', 09:48:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:48:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:35 INFO - 'MOZ_NO_REMOTE': '1', 09:48:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:35 INFO - 'NO_EM_RESTART': '1', 09:48:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:35 INFO - 'PWD': '/builds/slave/test', 09:48:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:48:35 INFO - 'SHELL': '/bin/bash', 09:48:35 INFO - 'SHLVL': '1', 09:48:35 INFO - 'TERM': 'linux', 09:48:35 INFO - 'TMOUT': '86400', 09:48:35 INFO - 'USER': 'cltbld', 09:48:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411', 09:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:35 INFO - '_': '/tools/buildbot/bin/python'} 09:48:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 09:48:36 INFO - mozversion application_buildid: 20160628075828 09:48:36 INFO - mozversion application_changeset: 39023f2bbf6e44d29165130cd5e19d35385f0b97 09:48:36 INFO - mozversion application_display_name: Firefox 09:48:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:48:36 INFO - mozversion application_name: Firefox 09:48:36 INFO - mozversion application_remotingname: firefox 09:48:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:48:36 INFO - mozversion application_vendor: Mozilla 09:48:36 INFO - mozversion application_version: 48.0 09:48:36 INFO - mozversion platform_buildid: 20160628075828 09:48:36 INFO - mozversion platform_changeset: 39023f2bbf6e44d29165130cd5e19d35385f0b97 09:48:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:48:36 INFO - mozversion platform_version: 48.0 09:48:36 INFO - using testdate: 1467132516 09:48:36 INFO - actual date: 1467132516 09:48:36 INFO - starting webserver on 'localhost:56547' 09:48:36 INFO - SUITE-START | Running 2 tests 09:48:36 INFO - TEST-START | dromaeo_css 09:48:36 INFO - operating with platform_type : linux_ 09:48:36 INFO - Initialising browser for dromaeo_css test... 09:48:36 INFO - TEST-INFO | started process 22658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyDlnYA/profile http://localhost:56547/getInfo.html) 09:48:39 INFO - PROCESS | 22658 | 09:48:39 INFO - PROCESS | 22658 | (process:22738): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:48:40 INFO - PROCESS | 22658 | __metrics Screen width/height:1600/1200 09:48:40 INFO - PROCESS | 22658 | colorDepth:24 09:48:40 INFO - PROCESS | 22658 | Browser inner width/height: 1024/697 09:48:40 INFO - PROCESS | 22658 | __metrics 09:48:41 ERROR - PROCESS | 22658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:48:42 INFO - TEST-INFO | 22658: exit 0 09:48:42 INFO - Browser initialized. 09:48:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:48:42 INFO - TEST-INFO | started process 22788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyDlnYA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:48:43 INFO - PROCESS | 22788 | 09:48:43 INFO - PROCESS | 22788 | (process:22858): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:48:53 INFO - PROCESS | 22788 | RSS: Main: 151207936 09:48:53 INFO - PROCESS | 22788 | 09:49:43 INFO - PROCESS | 22788 | 1467132583497 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] 09:51:50 INFO - PROCESS | 22788 | Cycle 1(1): loaded http://localhost:56547/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56547/tests/dromaeo/cssquery-ext.html) 09:51:51 INFO - PROCESS | 22788 | RSS: Main: 155787264 09:51:51 INFO - PROCESS | 22788 | 09:54:53 INFO - PROCESS | 22788 | Cycle 1(1): loaded http://localhost:56547/tests/dromaeo/cssquery-ext.html (next: http://localhost:56547/tests/dromaeo/cssquery-jquery.html) 09:54:54 INFO - PROCESS | 22788 | RSS: Main: 152805376 09:54:54 INFO - PROCESS | 22788 | 09:57:56 INFO - PROCESS | 22788 | Cycle 1(1): loaded http://localhost:56547/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56547/tests/dromaeo/cssquery-mootools.html) 09:57:56 INFO - PROCESS | 22788 | RSS: Main: 153190400 09:57:56 INFO - PROCESS | 22788 | 10:00:58 INFO - PROCESS | 22788 | Cycle 1(1): loaded http://localhost:56547/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56547/tests/dromaeo/cssquery-prototype.html) 10:00:58 INFO - PROCESS | 22788 | RSS: Main: 153477120 10:00:58 INFO - PROCESS | 22788 | 10:04:01 INFO - PROCESS | 22788 | Cycle 1(1): loaded http://localhost:56547/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56547/tests/dromaeo/cssquery-yui.html) 10:04:01 INFO - PROCESS | 22788 | RSS: Main: 152829952 10:04:01 INFO - PROCESS | 22788 | 10:07:04 INFO - PROCESS | 22788 | Cycle 1(1): loaded http://localhost:56547/tests/dromaeo/cssquery-yui.html (next: http://localhost:56547/tests/dromaeo/cssquery-dojo.html) 10:07:04 INFO - PROCESS | 22788 | RSS: Main: 156663808 10:07:04 INFO - PROCESS | 22788 | 10:07:04 INFO - PROCESS | 22788 | __start_tp_report 10:07:04 INFO - PROCESS | 22788 | _x_x_mozilla_page_load 10:07:04 INFO - PROCESS | 22788 | _x_x_mozilla_page_load_details 10:07:04 INFO - PROCESS | 22788 | |i|pagename|runs| 10:07:04 INFO - PROCESS | 22788 | |0;dojo.html;3317.00489853044;3400.4729266963627;3419.623841377449;3440.2947395783867;3458.8270586470685;5584.469475399836;5612.803551875685;5614.550835933126;5623.437656234374;5630.521405680522;5595.048841696911;5600.747966341514;5611.691356975365;5626.887462250763;5636.859078523029;5095.4140273868425;5131.871703207413;5152.716600586966;5175.404828444739;5202.323697919265;5045.217991211368;5105.05556472052;5206.167013277857;5274.9472505275035;5295.602829787762;5168.793248270064;5181.455947125535;5220.321358223426;5228.424873263938;5235.816746413876;5129.307543481619;5130.127878260686;5141.074606570815;5143.819966301162;5173.042987047408;4998.150314446553;5016.799328026875;5031.924521132186;5049.722265275445;5067.467915868854;5371.462853714636;5374.328208973879;5411.053065713484;5424.267723857268;5440.3743569489225;5874.9412505874825;5917.704114794286;5927.110933359987;5927.555433342473;5931.347551769302;5923.5853490255695;5976.910346344808;6064.302605200371;6119.380693981191;6127.4644201291;5643.40744221859;5644.8306550803545;5648.858778530528;5661.377248502661;5680.204771332017;6024.759009639565;6076.210092687922;6090.969545152246;6133.080037994337;6146.446819786241;5829.562782791308;5839.532837373;5898.911516327258;5903.085021821625;5936.28764548257;6048.909266361008;6057.878842423127;6062.939370606326;6063.9090413643835;6065.757369705162;5878;6023.48800351975;6031.306399763996;6034.607750496204;6037.969810150921;5987.940120598738;6073.605215660968;6077.696115194222;6078.361772013964;6109.236345456818;4537.3647689323525;4585.10590434862;4598.494165641777;4599.195140850338;4624.468186158568;4060.451839001697;4074.246264441088;4115.238680844053;4120.031792528754;4138.337865941435;5779.971100144472;5785.739641716133;5872.265966754156;5902.4097590240635;5929.851753706192;6026.0659597762415;6060.090986351995;6070.2412198475195;6114.57197996136;6122.693865306717;5635.013872572284;5695.800646977336;5854.912176317359;5864.882702345929;5905.143754155623;5026.371703537058;5072.391313042384;5085.9745701271995;5092.668976516515;5102.540771330598;6408.134901788292;6420.839479012969;6440.516961227927;6443.613383197023;6462;5800.1589769484035;6012.9098063529955;6064.636121832704;6086.2087928569;6116.29662588808;6318.968405157945;6321.115043893767;6324.778632747832;6329.145565348803;6329.6518691470565;5856.736446859816;5868.2077919480325;5873.823785286449;5878.617889837147;5927.229460170151;5936.732847021808;5992.101184822137;6049.304330002106;6100.328963813889;6143.569950103629;5861.677607731615;5867.413258674099;5868;5886.440788125121;5900.085486749561;5831.970840145942;5888.941110588839;5889.234399528034;5891.1457838612305;5911.083782013795;5673.659580425187;5692.345380281321;5786.710664466844;5786.884262314646;5798.246227990334;5929.525637948867;5932.733027013708;5935.614185077956;5940.55445841555;5988.5508586855285;5708.914366284592;5822.039363505143;5833.387494313036;5834.562407819515;5837.912431313619 10:07:04 INFO - PROCESS | 22788 | |1;ext.html;661.3783043938697;683.1290105115979;688.277308825733;727.3017902813302;746.7013194722113;41847.79076104619;42250.52123175693;42305.576944230546;42308.57691423085;42537.57462425375;44955;45558;45645.033072850325;45703.771481142634;45888.770556147174;8776.385653004292;8931.910680893174;8993.100689930987;8994.370394072417;9002.954985225064;8829.117088291152;8922.464652120894;8938.374313798036;9155.130262625073;9179.127982841619;9205.539723013855;9221.953890230572;9235.676751313706;9284.932232793213;9301.116393942599;9187.586558604879;9280.535973201348;9292.210162136227;9298.814023719555;9306.90693093074;9191;9230.53847307632;9240.953795231047;9292.117248861347;9297.070292970717;46067.53932460666;46419.53580464186;46731.29903051457;46766.53233467656;46855.76572117152;3930.0764320384687;4035;4092.46797916269;4241.448611680462;4727.467258425605;34848.12879678003;34978.30043399143;35165.12087197815;35245.47131793025;36776.816115919515;4507.3689683444345;4514.345419914127;4559.224931761575;4588.197065513522;4652.674312798105;335822;337383;337633;338356;339479;68998.65500672464;69127;69529.30470695329;69707.65146174339;69761.30238697548;71415.28584714087;73711;75180.62409687917;75346.24653753392;75431.24568754352;18272.63454730898;18477.90761046186;18489.352872649393;18540.536486587673;18708.53228669267;14753.631159221106;14838.70322593542;14855.554333370017;14859.777103343458;14861.331240094221;20880;20998.160073596886;20999.685004724943;21026.89486552588;21089.050992705364;7859.449838511364;7901.762947111596;8025.23760242776;8169.9591502043295;8210.178982101743;1078.6871807175987;1161.7908776420325;1178.699431644925;1182.456070207714;1185.8399116119385;34481.827590862384;34583.13542161466;34592.654073459445;34945.30109397849;34961.65038349635;1220.4263995921901;1249.6188662458037;1268.245393990574;1278.6867217531578;1299.4022749535131;17871.910640446975;18160.909195454202;18282.542936426697;18392.356267530573;18539.907300463412;507334;564798;566160;570603;585868;58594.70702646545;59506.40493595095;59527;59590;59609.403905961255;1534.401583382504;1541.814982202143;1550.9069455832687;1564.4368027510088;1566.8746500279951;32164;32260.677393225767;32721.836390817894;33034.33931321312;33680.83159584186;57909.4209057904;58576;58671.4132858683;58782.70608646929;58813.11780323213;465240;465829;467340;467859;470507;32827;33189;33206.335873282886;49383;49478;48826.511734882195;49177.50822491729;49178.75410622924;49771.751141244065;49870;43284.567154329314;43524.78237608792;44183.55816441795;44681.32978005397;44688;44230.55769442393;45403.31895021643;46110.30834537418;46574.30138547992;47120.92609794334;44803.551964479935;44872.32691509565;45523.544764553255;45599.31601025921;45613.77193114013;37821.43267850929;38018.2396352077;38119.42820857745;38654.226915462095;38847;29486;29956.251093722833;30158.84920575383;30598.082057538308;30659.846700766353 10:07:04 INFO - PROCESS | 22788 | |2;jquery.html;428.5457415139951;431.5210116770384;432.3471557947498;435.55790872264635;439.8834308908139;19101.331453399132;19290.90354548227;19826.801731982694;21369.679454808153;21569.78430215701;19819.108140133692;20301.289454869082;20416.285430009953;20472.181112755472;20712;5576.693281869485;5937.792177273796;5973.820785376446;5976.3724808895095;6006.819795406145;5300.443453437372;5567.387587365387;5569.526590239834;5800.970995145019;5896.793612223573;5539.833804985857;5542.63972841766;5558.944410555883;5569.972150139243;5633.324001119871;6600.735970561172;6631.469482441417;6634.137562116918;6658.633775142365;6674.399304062634;5791.971040144815;5964.493018093467;5972.820815375502;5977.8804423911715;5997.370276120988;14664.340104695315;14722.337494812758;14850.480233191787;14864.405423783035;20043;2506.5112303100905;2596.5585850405287;2626.1858823764696;2930.575066615329;3153.038323311389;9535.570899309549;10619.30974486656;11006.284591501606;13432.19406835593;14054;2043.5810658814908;2134.583756167548;2140.6039882621767;2142.9357119286447;2152.9031193596325;82535.587322063;82692.58653706753;83547.16452835515;85899.57050214772;85916.57041714813;11466.31202127875;11574;11653.6503904883;11831.112666550043;11888.286702797686;16683.416080437128;16753.1623418831;16799.16004199785;16831.74752378715;16848.74726879098;8904.8664270036;8992.325575581857;9046;9066.818663626822;9172.12864777845;8913.064128266567;8953.328500362499;8976.551172441483;9033.457992520338;9071.183593476619;4965.404151501771;4967;4969.503049695001;5047.217681259411;5050;1911.3710123685612;2093.9162433502793;2123.9256626018014;2149.18331034206;2191;1031.3193292427113;1059.7138772531373;1061.4162210784039;1089.6730980705756;1118.608487029533;18275;18369.81630183681;18409.355672551395;18658.253669853326;19042.204067789946;1069.946502674863;1070.2561719604955;1075.704181350135;1154.699778057711;1159.066951104369;10931.672049838518;10982.670519884416;11079;11153.10775137987;11153.888461115284;512284;529560;529747;532310;555515;93671;94618;96899.51550242344;96945;98514.01485985192;1104.6133853151493;1122.186414849244;1165.7318816672043;1171.3264872698232;1184.650528094197;16906;16985.575360616083;17200.913995429943;17356.82643173552;17447.82552174462;39446.408303874894;39556;41107.383389248585;41147.38278925759;41148;57538.7123064382;57614.42385576258;58181.41818581929;58268.4173158263;58936.70531647314;8516.787080323042;8981.101889810967;9187.586558604746;9264.490453024879;9316.44101353921;12574.434150463068;12811.231326120462;13313.600591982256;13530.323483825572;13554.525591604246;11401.714957126138;11590.304581725124;11703.180777345504;11855.58505452305;11967.281963082243;11352.318860868045;11420.486078126338;11449.42752862337;11734;11746.58886938953;6699.899501507384;8930;11810;11882.881171188177;11937.343446110548;8790.164934331227;8845.203931646183;8879;9066.592003359996;9276.02601726809;10575;12354.938225308815;12382.938085309515;12473.688157796129;12599.118061735591 10:07:04 INFO - PROCESS | 22788 | |3;mootools.html;1568.0670001349197;1575.1100628145098;1768.9557761055971;1893.0534732633682;1907.8759880607768;7810.687572497093;8123.5125892446495;8456.830863382736;8767;8793.956030219855;8279;8386.20331068549;8387.16128387161;8511.063782983867;8593.054763975957;2467.444824914398;2468.950620987579;2479.4297311618247;2507.3856905058287;2514.6856642919633;2460;2521.722610512851;2522.3441905104623;2523.823332366735;2527.153403609793;2472.777450029497;2480.8635525046116;2483.776460118589;2487.577111890974;2495.25142457263;2435.7198922124007;2444.8533088014774;2453.766892145243;2456.066694656028;2478.7273399925994;2492.2024952015363;2497;2526.0527302261653;2543.0972004938167;2545.8727063646743;8833.514156721378;8874.86687699685;8875.245604123656;8880.245179159714;8892.377533572653;5441.374241962186;5569.916451253234;5600.719964001824;5623.971880140573;5627.521660658849;3319.4191016572004;3333;3342.314825460799;3384.4415671414185;3390.915227119317;1032.5818043692316;1048.8846226915034;1063.0280433144237;1067.4502631144967;1074.833400822866;12171.878281217163;12228.388580571025;12262.632121036384;12287.877121228763;12367.567135150317;4592.862214133581;4604.424446944132;4649.814297354153;4655.720656760605;4687.320338550891;9772.364796288219;9778.559964801601;9785.755356116011;9788.804223915482;9815.656452024288;5405.70268635221;5426.782928682808;5439.564834813205;5445.346558412936;5445.992491389105;4987.451380348159;5029.270755740397;5075.162598171334;5131.025105229995;5133.820316288912;4021.9798901005893;4030.7581545107387;4050.5341885683524;4100.876973690794;4106.7125301228625;1242.3850194153952;1271.3643178410794;1278.961631151067;1290.4128621477205;1294.0747365633617;1071.9303245289032;1093.1254996003324;1103.2608152537819;1105.5080489182396;1107.0147568663895;6311;6437.549371544041;6451.516136289797;6509.479241660656;6567.868642627216;499.44810983863033;503.3833553896521;505.43391401629674;511.41187634220944;525.1623660261877;4184.7070705050355;4268.359746038119;4304.160688665743;4319.913601727948;4344.826206951687;10603.151747860153;10852.565897364017;10966.177536684781;10986.725331866768;11008.559657613767;10382.42896640677;10796.67609971702;10814.29707069038;10829.620963266249;10843.186760992958;8306.169383061646;8313.750587482386;8328.791780205422;8335.8332833343;8404.327653787683;6135.63186208811;6140.692965351804;6187.84530386726;6255.624662520263;6316.242050953915;9476.668316608886;9536.23710103204;9593.32846700752;9645.9035409645;9723.65967191145;9177.862332064891;9397.953010234905;9418.858717119385;9443.858342124737;9597.136257736836;6971.26801685836;7752.186020467995;7799;7861.213878612093;7996.520208787491;8262.628181731716;8273.503589784632;8274.379421543528;8284.668613255402;8326.333893288644;7350.816229594303;7638.8090297743;7644.617769111411;7696.961515192388;7783.455158138876;7377.4098072155175;7425.628718563942;7482.139553951365;7535.321821036133;7563.886541701769;7148.678309475982;7155.427565794828;7159.176694680178;7217.206107328085;7237.674304656198;5481.917771233514;5506.229127922014;5563.8609034772835;5611.747471363717;5675.460831221028;5447;5477.04151773446;5588.916166257428;5600.215969764155;5602.971985140048 10:07:04 INFO - PROCESS | 22788 | |4;prototype.html;352.30595726418954;355.2061143344624;360.44311538672747;360.6952125453992;361.7214744646624;6430.131932189153;6537.0848081268605;6565.179352580927;6580.045893345462;6619.304972977834;6418.582792118521;6422.293547709748;6422.871542569146;6429.549931504796;6450.129232553604;4809.326694262797;4920.138975679241;4946.738581661672;4957.132501812186;4961.429435614897;4928.433230178522;4936.827211047614;4941.110600091982;4944.554990050895;4961.975190124044;4908.263760435945;4913.140200464923;4915.016996600676;4923.753812309388;4924.4583095859425;4914.680545764531;4921.040397122545;4928.827491037814;4936.136176169156;4947.876303092416;4340.327249276335;4352.064306174188;4354.042110735665;4357.978210108961;4368.344748287751;6004.3395226525045;6227.097070924736;6244.12582238487;6257.780977665805;6270.937290627081;5673.8581535461535;5679.886402271973;5702.059160238556;5731.627444216113;5734.483896449298;6744.359285867835;6809.727610895558;6818.249992500871;6825.419839313664;6838.623875686835;4745.620350371996;4793.904121917542;4800.207965685658;4805.495422980606;4820.638452116105;7022;7071.504994650377;7095.609741464217;7096.254893236239;7097.325754053409;4704.1767690654;4891.657583969088;4894.877628059256;4901.5588597026435;4915.262710593368;4943.555080042742;4965.776540055706;4992.151334273182;4999.575036121898;5001.574866136347;5679.2333035040565;5703.287089113861;5736.483716465538;5738.569607279471;5748.338941021752;6868.450523958171;6872.140982377203;6873.759418420332;6884.070650462124;6893.862122757617;1749.5013921032444;1774.6184570317187;1775.1568005197428;1778.4220128458044;1779.2082523277018;1154.4343271796927;1158.426578843478;1186.5431808753692;1193.117093350914;1207.8550573931009;6681.064650948871;6693.230278517935;6696.665166741644;6699.129113215348;6699.899501507482;6953.930460695429;7031.226565077837;7048.823779405453;7068.68190931399;7080.291970802981;6774.3225677431865;6775.322467753185;6780.288069752703;6786.728530858809;6802.897956530656;3801.125741079567;3844.6539811417106;3845.384738441892;3845.5577608575372;3851.67260782831;7524.548527088392;7525.4355923305975;7546.698132074765;7552.055993000875;7559.28186822251;6975.616341101187;7197.604131772698;7217.711291548279;7224.0608720867;7224.13310402755;7550;7576.772696819105;7577.810554736066;7614.923850761422;7615.847683046419;7102.076730025064;7112.395446387115;7145;7148.67830947619;7156.9642151790995;6987.986741922495;7023.33278338557;7033.507654464139;7035.718571257093;7074.540154889915;7323.8535229296185;7517.361024312776;7527.1343795462035;7537;7546.603878282535;4761.500042495488;4785.59322457595;4794.976025119852;4802.399700037496;4805.27920811881;7094.822629434306;7143.785686429415;7152.284771522806;7157.785266442015;7160.176579693402;6866.759663411756;6901.89647155283;6917.27368626287;6925.965370173117;6927.134108236471;6767.511147547531;6818.352256535622;6885.139357580302;6896.034555162381;6917.654117294216;6723.327667233433;6762;6763.560368576027;6765.86468270622;6773.221079575715;6952.687129079305;6954.095967524392;6955.513114081966;6955.582665040114;6974.442044636518;6758.5269031167345;6766.766966900813;6773.458123350021;6775.356341147583;6779.491538134758 10:07:04 INFO - PROCESS | 22788 | |5;yui.html;923.6305477808877;933.6545478173073;948.743839163426;948.9667861624845;962.0427674463905;14788.26058697065;14822.184779837105;14948.252587370614;14991.925040374797;15009.92495037526;14159.867210623152;14176.858231417682;14296.285185740724;14322.140671559713;14324.641883952907;740.5741698523344;880.8458519759049;904.0281697175529;907.6687009241646;908.6955869783598;890.2788741119681;892.6429428228728;899.8470260055806;900.7387857521311;903.3902116071625;939.7274790310836;954.9618015279381;955.1690029674194;955.3217215776807;956.9377990430635;944.6221511395428;948.1656142594542;950.1401231885155;950.7908260182749;952.3999880075577;698.1691786773723;698.9056477375591;701.7578935267376;701.7789396340188;702.1609177033447;13816.585502434944;13848.861511384857;13874.375653095634;13911.095778774448;13926.885849132044;14911.552653420415;15207.163606001666;15283;15330;15358;12102.273863568214;12219.144659873813;12269.509219631203;12353.444095015746;12364.690882727913;4077.2032407522056;4114.321137012389;4152.647025002879;4163.437935878648;4192.224438478891;56072.15891761586;56087.71956140193;56110;56257.71871140659;56381.43618563803;10920.235583509078;11023.503942322615;11268.323900565993;11386.544538218544;11579.652610421701;18601;18870.339538116375;18884.90557547231;18912.905435472734;18957.905210474135;8963.058878817761;9030.187283144549;9182.449053056838;9233.169014788702;9241.93717722457;5153.742312884341;5203.869903252449;5213.791448342024;5214.426413094557;5226.059309324282;3669.339518886626;3688.741788074809;3699.426588878728;3699.5375578052744;3725.925481490355;691.778630838127;701.2006312803409;708.3058602569511;716.8566286742672;720.7585458871232;778.9415793815486;786.3709032773758;831.3058596072226;849.2611428057506;869.7129947117436;10014.399136051714;10302.639407620698;10475.685729428129;10498.160147188206;10506.212034097472;681.3084719010209;708.7767353283699;748.1807420874134;782.1669921533548;788.5899332347147;4511.70673906195;4596.770161491912;4770.95229047712;4821;4864.489228631013;61775.38224617786;61933.07100393498;65203;66216.33783662198;67140;52142;52567.73716131395;55000.449995500334;58363.708181458824;59050.704746475996;52724.47275527272;52920.47079529233;53201.46798532043;53353.46646533562;53364.46635533595;10159.695209143738;10499.107575855833;10830.241883068426;10955.397453139834;11087.667369978913;36415;38946.805265974624;39126.6087339123;40665.186696265315;40773.1845363097;44152.33771493366;44327.77836110799;45030.324545132506;45649.77175114103;45890.770546147054;12808.6797830055;12914.547990820276;12942;13101.672458188621;13187.406566704329;13546.864531354955;14715.264236788333;14722.631934201303;14766.48317308889;14809.481668141563;12473.87526124727;12476.563320283747;12533.362655817042;13174.670633233862;14011.859881401464;13000.804987925378;13386.933065334611;13815.516456923959;13842.515511957034;13901.930490347484;11709.180357374902;13048.869511304765;13347.933260333637;13413.128146670435;13705.520306789214;10665.626703065356;10822.837657434988;10883.619073332395;11049.447527623748;11241.831372529583;10629.559308484246;10941.56233750641;11044.558217671203;11097.445127743418;11129.833052504056 10:07:04 INFO - PROCESS | 22788 | __end_tp_report 10:07:04 INFO - PROCESS | 22788 | __start_cc_report 10:07:04 INFO - PROCESS | 22788 | _x_x_mozilla_cycle_collect,339 10:07:04 INFO - PROCESS | 22788 | __end_cc_report 10:07:04 INFO - PROCESS | 22788 | __startTimestamp1467133624428__endTimestamp 10:07:04 INFO - PROCESS | 22788 | 10:07:04 INFO - PROCESS | 22788 | ------- Summary: start ------- 10:07:04 INFO - PROCESS | 22788 | Number of tests: 6 10:07:04 INFO - PROCESS | 22788 | 10:07:04 INFO - PROCESS | 22788 | [#0] dojo.html Cycles:165 Average:5603.82 Median:5839.53 stddev:631.39 (10.8%) stddev-sans-first:607.31 10:07:04 INFO - PROCESS | 22788 | Values: 3317.0 3400.5 3419.6 3440.3 3458.8 5584.5 5612.8 5614.6 5623.4 5630.5 5595.0 5600.7 5611.7 5626.9 5636.9 5095.4 5131.9 5152.7 5175.4 5202.3 5045.2 5105.1 5206.2 5274.9 5295.6 5168.8 5181.5 5220.3 5228.4 5235.8 5129.3 5130.1 5141.1 5143.8 5173.0 4998.2 5016.8 5031.9 5049.7 5067.5 5371.5 5374.3 5411.1 5424.3 5440.4 5874.9 5917.7 5927.1 5927.6 5931.3 5923.6 5976.9 6064.3 6119.4 6127.5 5643.4 5644.8 5648.9 5661.4 5680.2 6024.8 6076.2 6091.0 6133.1 6146.4 5829.6 5839.5 5898.9 5903.1 5936.3 6048.9 6057.9 6062.9 6063.9 6065.8 5878.0 6023.5 6031.3 6034.6 6038.0 5987.9 6073.6 6077.7 6078.4 6109.2 4537.4 4585.1 4598.5 4599.2 4624.5 4060.5 4074.2 4115.2 4120.0 4138.3 5780.0 5785.7 5872.3 5902.4 5929.9 6026.1 6060.1 6070.2 6114.6 6122.7 5635.0 5695.8 5854.9 5864.9 5905.1 5026.4 5072.4 5086.0 5092.7 5102.5 6408.1 6420.8 6440.5 6443.6 6462.0 5800.2 6012.9 6064.6 6086.2 6116.3 6319.0 6321.1 6324.8 6329.1 6329.7 5856.7 5868.2 5873.8 5878.6 5927.2 5936.7 5992.1 6049.3 6100.3 6143.6 5861.7 5867.4 5868.0 5886.4 5900.1 5832.0 5888.9 5889.2 5891.1 5911.1 5673.7 5692.3 5786.7 5786.9 5798.2 5929.5 5932.7 5935.6 5940.6 5988.6 5708.9 5822.0 5833.4 5834.6 5837.9 10:07:04 INFO - PROCESS | 22788 | 10:07:04 INFO - PROCESS | 22788 | [#1] ext.html Cycles:180 Average:63758.86 Median:25058.61 stddev:122878.60 (490.4%) stddev-sans-first:123131.99 10:07:04 INFO - PROCESS | 22788 | Values: 661.4 683.1 688.3 727.3 746.7 41847.8 42250.5 42305.6 42308.6 42537.6 44955.0 45558.0 45645.0 45703.8 45888.8 8776.4 8931.9 8993.1 8994.4 9003.0 8829.1 8922.5 8938.4 9155.1 9179.1 9205.5 9222.0 9235.7 9284.9 9301.1 9187.6 9280.5 9292.2 9298.8 9306.9 9191.0 9230.5 9241.0 9292.1 9297.1 46067.5 46419.5 46731.3 46766.5 46855.8 3930.1 4035.0 4092.5 4241.4 4727.5 34848.1 34978.3 35165.1 35245.5 36776.8 4507.4 4514.3 4559.2 4588.2 4652.7 335822.0 337383.0 337633.0 338356.0 339479.0 68998.7 69127.0 69529.3 69707.7 69761.3 71415.3 73711.0 75180.6 75346.2 75431.2 18272.6 18477.9 18489.4 18540.5 18708.5 14753.6 14838.7 14855.6 14859.8 14861.3 20880.0 20998.2 20999.7 21026.9 21089.1 7859.4 7901.8 8025.2 8170.0 8210.2 1078.7 1161.8 1178.7 1182.5 1185.8 34481.8 34583.1 34592.7 34945.3 34961.7 1220.4 1249.6 1268.2 1278.7 1299.4 17871.9 18160.9 18282.5 18392.4 18539.9 507334.0 564798.0 566160.0 570603.0 585868.0 58594.7 59506.4 59527.0 59590.0 59609.4 1534.4 1541.8 1550.9 1564.4 1566.9 32164.0 32260.7 32721.8 33034.3 33680.8 57909.4 58576.0 58671.4 58782.7 58813.1 465240.0 465829.0 467340.0 467859.0 470507.0 32827.0 33189.0 33206.3 49383.0 49478.0 48826.5 49177.5 49178.8 49771.8 49870.0 43284.6 43524.8 44183.6 44681.3 44688.0 44230.6 45403.3 46110.3 46574.3 47120.9 44803.6 44872.3 45523.5 45599.3 45613.8 37821.4 38018.2 38119.4 38654.2 38847.0 29486.0 29956.3 30158.8 30598.1 30659.8 10:07:04 INFO - PROCESS | 22788 | 10:07:04 INFO - PROCESS | 22788 | [#2] jquery.html Cycles:180 Average:30397.30 Median:11880.39 stddev:87614.47 (737.5%) stddev-sans-first:87831.35 10:07:04 INFO - PROCESS | 22788 | Values: 428.5 431.5 432.3 435.6 439.9 19101.3 19290.9 19826.8 21369.7 21569.8 19819.1 20301.3 20416.3 20472.2 20712.0 5576.7 5937.8 5973.8 5976.4 6006.8 5300.4 5567.4 5569.5 5801.0 5896.8 5539.8 5542.6 5558.9 5570.0 5633.3 6600.7 6631.5 6634.1 6658.6 6674.4 5792.0 5964.5 5972.8 5977.9 5997.4 14664.3 14722.3 14850.5 14864.4 20043.0 2506.5 2596.6 2626.2 2930.6 3153.0 9535.6 10619.3 11006.3 13432.2 14054.0 2043.6 2134.6 2140.6 2142.9 2152.9 82535.6 82692.6 83547.2 85899.6 85916.6 11466.3 11574.0 11653.7 11831.1 11888.3 16683.4 16753.2 16799.2 16831.7 16848.7 8904.9 8992.3 9046.0 9066.8 9172.1 8913.1 8953.3 8976.6 9033.5 9071.2 4965.4 4967.0 4969.5 5047.2 5050.0 1911.4 2093.9 2123.9 2149.2 2191.0 1031.3 1059.7 1061.4 1089.7 1118.6 18275.0 18369.8 18409.4 18658.3 19042.2 1069.9 1070.3 1075.7 1154.7 1159.1 10931.7 10982.7 11079.0 11153.1 11153.9 512284.0 529560.0 529747.0 532310.0 555515.0 93671.0 94618.0 96899.5 96945.0 98514.0 1104.6 1122.2 1165.7 1171.3 1184.7 16906.0 16985.6 17200.9 17356.8 17447.8 39446.4 39556.0 41107.4 41147.4 41148.0 57538.7 57614.4 58181.4 58268.4 58936.7 8516.8 8981.1 9187.6 9264.5 9316.4 12574.4 12811.2 13313.6 13530.3 13554.5 11401.7 11590.3 11703.2 11855.6 11967.3 11352.3 11420.5 11449.4 11734.0 11746.6 6699.9 8930.0 11810.0 11882.9 11937.3 8790.2 8845.2 8879.0 9066.6 9276.0 10575.0 12354.9 12382.9 12473.7 12599.1 10:07:04 INFO - PROCESS | 22788 | 10:07:04 INFO - PROCESS | 22788 | [#3] mootools.html Cycles:180 Average:5813.12 Median:5416.24 stddev:3177.01 (58.7%) stddev-sans-first:3169.91 10:07:04 INFO - PROCESS | 22788 | Values: 1568.1 1575.1 1769.0 1893.1 1907.9 7810.7 8123.5 8456.8 8767.0 8794.0 8279.0 8386.2 8387.2 8511.1 8593.1 2467.4 2469.0 2479.4 2507.4 2514.7 2460.0 2521.7 2522.3 2523.8 2527.2 2472.8 2480.9 2483.8 2487.6 2495.3 2435.7 2444.9 2453.8 2456.1 2478.7 2492.2 2497.0 2526.1 2543.1 2545.9 8833.5 8874.9 8875.2 8880.2 8892.4 5441.4 5569.9 5600.7 5624.0 5627.5 3319.4 3333.0 3342.3 3384.4 3390.9 1032.6 1048.9 1063.0 1067.5 1074.8 12171.9 12228.4 12262.6 12287.9 12367.6 4592.9 4604.4 4649.8 4655.7 4687.3 9772.4 9778.6 9785.8 9788.8 9815.7 5405.7 5426.8 5439.6 5445.3 5446.0 4987.5 5029.3 5075.2 5131.0 5133.8 4022.0 4030.8 4050.5 4100.9 4106.7 1242.4 1271.4 1279.0 1290.4 1294.1 1071.9 1093.1 1103.3 1105.5 1107.0 6311.0 6437.5 6451.5 6509.5 6567.9 499.4 503.4 505.4 511.4 525.2 4184.7 4268.4 4304.2 4319.9 4344.8 10603.2 10852.6 10966.2 10986.7 11008.6 10382.4 10796.7 10814.3 10829.6 10843.2 8306.2 8313.8 8328.8 8335.8 8404.3 6135.6 6140.7 6187.8 6255.6 6316.2 9476.7 9536.2 9593.3 9645.9 9723.7 9177.9 9398.0 9418.9 9443.9 9597.1 6971.3 7752.2 7799.0 7861.2 7996.5 8262.6 8273.5 8274.4 8284.7 8326.3 7350.8 7638.8 7644.6 7697.0 7783.5 7377.4 7425.6 7482.1 7535.3 7563.9 7148.7 7155.4 7159.2 7217.2 7237.7 5481.9 5506.2 5563.9 5611.7 5675.5 5447.0 5477.0 5588.9 5600.2 5603.0 10:07:04 INFO - PROCESS | 22788 | 10:07:04 INFO - PROCESS | 22788 | [#4] prototype.html Cycles:180 Average:5773.82 Median:6687.15 stddev:1749.85 (26.2%) stddev-sans-first:1706.79 10:07:04 INFO - PROCESS | 22788 | Values: 352.3 355.2 360.4 360.7 361.7 6430.1 6537.1 6565.2 6580.0 6619.3 6418.6 6422.3 6422.9 6429.5 6450.1 4809.3 4920.1 4946.7 4957.1 4961.4 4928.4 4936.8 4941.1 4944.6 4962.0 4908.3 4913.1 4915.0 4923.8 4924.5 4914.7 4921.0 4928.8 4936.1 4947.9 4340.3 4352.1 4354.0 4358.0 4368.3 6004.3 6227.1 6244.1 6257.8 6270.9 5673.9 5679.9 5702.1 5731.6 5734.5 6744.4 6809.7 6818.2 6825.4 6838.6 4745.6 4793.9 4800.2 4805.5 4820.6 7022.0 7071.5 7095.6 7096.3 7097.3 4704.2 4891.7 4894.9 4901.6 4915.3 4943.6 4965.8 4992.2 4999.6 5001.6 5679.2 5703.3 5736.5 5738.6 5748.3 6868.5 6872.1 6873.8 6884.1 6893.9 1749.5 1774.6 1775.2 1778.4 1779.2 1154.4 1158.4 1186.5 1193.1 1207.9 6681.1 6693.2 6696.7 6699.1 6699.9 6953.9 7031.2 7048.8 7068.7 7080.3 6774.3 6775.3 6780.3 6786.7 6802.9 3801.1 3844.7 3845.4 3845.6 3851.7 7524.5 7525.4 7546.7 7552.1 7559.3 6975.6 7197.6 7217.7 7224.1 7224.1 7550.0 7576.8 7577.8 7614.9 7615.8 7102.1 7112.4 7145.0 7148.7 7157.0 6988.0 7023.3 7033.5 7035.7 7074.5 7323.9 7517.4 7527.1 7537.0 7546.6 4761.5 4785.6 4795.0 4802.4 4805.3 7094.8 7143.8 7152.3 7157.8 7160.2 6866.8 6901.9 6917.3 6926.0 6927.1 6767.5 6818.4 6885.1 6896.0 6917.7 6723.3 6762.0 6763.6 6765.9 6773.2 6952.7 6954.1 6955.5 6955.6 6974.4 6758.5 6766.8 6773.5 6775.4 6779.5 10:07:04 INFO - PROCESS | 22788 | 10:07:04 INFO - PROCESS | 22788 | [#5] yui.html Cycles:180 Average:15513.28 Median:22443.75 stddev:17634.97 (78.6%) stddev-sans-first:17650.40 10:07:04 INFO - PROCESS | 22788 | Values: 923.6 933.7 948.7 949.0 962.0 14788.3 14822.2 14948.3 14991.9 15009.9 14159.9 14176.9 14296.3 14322.1 14324.6 740.6 880.8 904.0 907.7 908.7 890.3 892.6 899.8 900.7 903.4 939.7 955.0 955.2 955.3 956.9 944.6 948.2 950.1 950.8 952.4 698.2 698.9 701.8 701.8 702.2 13816.6 13848.9 13874.4 13911.1 13926.9 14911.6 15207.2 15283.0 15330.0 15358.0 12102.3 12219.1 12269.5 12353.4 12364.7 4077.2 4114.3 4152.6 4163.4 4192.2 56072.2 56087.7 56110.0 56257.7 56381.4 10920.2 11023.5 11268.3 11386.5 11579.7 18601.0 18870.3 18884.9 18912.9 18957.9 8963.1 9030.2 9182.4 9233.2 9241.9 5153.7 5203.9 5213.8 5214.4 5226.1 3669.3 3688.7 3699.4 3699.5 3725.9 691.8 701.2 708.3 716.9 720.8 778.9 786.4 831.3 849.3 869.7 10014.4 10302.6 10475.7 10498.2 10506.2 681.3 708.8 748.2 782.2 788.6 4511.7 4596.8 4771.0 4821.0 4864.5 61775.4 61933.1 65203.0 66216.3 67140.0 52142.0 52567.7 55000.4 58363.7 59050.7 52724.5 52920.5 53201.5 53353.5 53364.5 10159.7 10499.1 10830.2 10955.4 11087.7 36415.0 38946.8 39126.6 40665.2 40773.2 44152.3 44327.8 45030.3 45649.8 45890.8 12808.7 12914.5 12942.0 13101.7 13187.4 13546.9 14715.3 14722.6 14766.5 14809.5 12473.9 12476.6 12533.4 13174.7 14011.9 13000.8 13386.9 13815.5 13842.5 13901.9 11709.2 13048.9 13347.9 13413.1 13705.5 10665.6 10822.8 10883.6 11049.4 11241.8 10629.6 10941.6 11044.6 11097.4 11129.8 10:07:04 INFO - PROCESS | 22788 | -------- Summary: end -------- 10:07:04 INFO - PROCESS | 22788 | 10:07:05 INFO - TEST-INFO | 22788: exit 0 10:07:05 INFO - TEST-OK | dromaeo_css | took 1109119ms 10:07:05 INFO - TEST-START | kraken 10:07:05 INFO - operating with platform_type : linux_ 10:07:05 INFO - Initialising browser for kraken test... 10:07:05 INFO - TEST-INFO | started process 23034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppO9xkM/profile http://localhost:56547/getInfo.html) 10:07:08 INFO - PROCESS | 23034 | 10:07:08 INFO - PROCESS | 23034 | (process:23111): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:07:09 INFO - PROCESS | 23034 | __metrics Screen width/height:1600/1200 10:07:09 INFO - PROCESS | 23034 | colorDepth:24 10:07:09 INFO - PROCESS | 23034 | Browser inner width/height: 1024/697 10:07:09 INFO - PROCESS | 23034 | __metrics 10:07:10 ERROR - PROCESS | 23034 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:07:11 INFO - TEST-INFO | 23034: exit 0 10:07:11 INFO - Browser initialized. 10:07:11 INFO - Running cycle 1/1 for kraken test... 10:07:11 INFO - TEST-INFO | started process 23161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppO9xkM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:12 INFO - PROCESS | 23161 | 10:07:12 INFO - PROCESS | 23161 | (process:23227): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:07:22 INFO - PROCESS | 23161 | RSS: Main: 150446080 10:07:22 INFO - PROCESS | 23161 | 10:07:25 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56547/tests/kraken/driver.html?testName=audio-beat-detection) 10:07:26 INFO - PROCESS | 23161 | RSS: Main: 156246016 10:07:26 INFO - PROCESS | 23161 | 10:07:28 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56547/tests/kraken/driver.html?testName=audio-dft) 10:07:29 INFO - PROCESS | 23161 | RSS: Main: 156168192 10:07:29 INFO - PROCESS | 23161 | 10:07:32 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56547/tests/kraken/driver.html?testName=audio-fft) 10:07:33 INFO - PROCESS | 23161 | RSS: Main: 156352512 10:07:33 INFO - PROCESS | 23161 | 10:07:35 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56547/tests/kraken/driver.html?testName=audio-oscillator) 10:07:35 INFO - PROCESS | 23161 | RSS: Main: 156291072 10:07:35 INFO - PROCESS | 23161 | 10:07:37 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56547/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:07:38 INFO - PROCESS | 23161 | RSS: Main: 156422144 10:07:38 INFO - PROCESS | 23161 | 10:07:41 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56547/tests/kraken/driver.html?testName=imaging-darkroom) 10:07:42 INFO - PROCESS | 23161 | RSS: Main: 156798976 10:07:42 INFO - PROCESS | 23161 | 10:07:45 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56547/tests/kraken/driver.html?testName=imaging-desaturate) 10:07:46 INFO - PROCESS | 23161 | RSS: Main: 156778496 10:07:46 INFO - PROCESS | 23161 | 10:07:48 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56547/tests/kraken/driver.html?testName=json-parse-financial) 10:07:49 INFO - PROCESS | 23161 | RSS: Main: 156979200 10:07:49 INFO - PROCESS | 23161 | 10:07:51 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56547/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:07:51 INFO - PROCESS | 23161 | RSS: Main: 156561408 10:07:51 INFO - PROCESS | 23161 | 10:07:53 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56547/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:07:53 INFO - PROCESS | 23161 | RSS: Main: 156479488 10:07:53 INFO - PROCESS | 23161 | 10:07:55 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56547/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:07:56 INFO - PROCESS | 23161 | RSS: Main: 156794880 10:07:56 INFO - PROCESS | 23161 | 10:07:59 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:07:59 INFO - PROCESS | 23161 | RSS: Main: 157442048 10:07:59 INFO - PROCESS | 23161 | 10:08:02 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:02 INFO - PROCESS | 23161 | RSS: Main: 157396992 10:08:02 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | Cycle 1(1): loaded http://localhost:56547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56547/tests/kraken/driver.html?testName=ai-astar) 10:08:04 INFO - PROCESS | 23161 | RSS: Main: 158883840 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | __start_tp_report 10:08:04 INFO - PROCESS | 23161 | _x_x_mozilla_page_load 10:08:04 INFO - PROCESS | 23161 | _x_x_mozilla_page_load_details 10:08:04 INFO - PROCESS | 23161 | |i|pagename|runs| 10:08:04 INFO - PROCESS | 23161 | |0;ai-astar;108;110;104;110;112;110;100;110;109;110 10:08:04 INFO - PROCESS | 23161 | |1;audio-beat-detection;156;127;151;183;128;155;174;128;184;128 10:08:04 INFO - PROCESS | 23161 | |2;audio-dft;164;163;163;161;162;164;162;163;164;164 10:08:04 INFO - PROCESS | 23161 | |3;audio-fft;76;76;76;181;79;77;74;76;157;76 10:08:04 INFO - PROCESS | 23161 | |4;audio-oscillator;92;93;158;92;93;92;140;92;93;140 10:08:04 INFO - PROCESS | 23161 | |5;imaging-gaussian-blur;119;117;118;117;117;117;117;117;117;118 10:08:04 INFO - PROCESS | 23161 | |6;imaging-darkroom;146;147;147;147;146;147;147;146;146;147 10:08:04 INFO - PROCESS | 23161 | |7;imaging-desaturate;95;94;95;96;95;96;96;95;95;94 10:08:04 INFO - PROCESS | 23161 | |8;json-parse-financial;56;56;56;56;55;64;57;77;54;53 10:08:04 INFO - PROCESS | 23161 | |9;json-stringify-tinderbox;57;58;58;58;59;58;58;58;58;58 10:08:04 INFO - PROCESS | 23161 | |10;stanford-crypto-aes;72;72;73;74;74;73;74;74;76;74 10:08:04 INFO - PROCESS | 23161 | |11;stanford-crypto-ccm;114;118;114;122;121;127;114;121;129;143 10:08:04 INFO - PROCESS | 23161 | |12;stanford-crypto-pbkdf2;157;156;160;156;157;155;163;157;161;158 10:08:04 INFO - PROCESS | 23161 | |13;stanford-crypto-sha256-iterative;66;67;66;68;69;66;65;67;65;70 10:08:04 INFO - PROCESS | 23161 | __end_tp_report 10:08:04 INFO - PROCESS | 23161 | __start_cc_report 10:08:04 INFO - PROCESS | 23161 | _x_x_mozilla_cycle_collect,839 10:08:04 INFO - PROCESS | 23161 | __end_cc_report 10:08:04 INFO - PROCESS | 23161 | __startTimestamp1467133684831__endTimestamp 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | ------- Summary: start ------- 10:08:04 INFO - PROCESS | 23161 | Number of tests: 14 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.59 (3.3%) stddev-sans-first:3.81 10:08:04 INFO - PROCESS | 23161 | Values: 108.0 110.0 104.0 110.0 112.0 110.0 100.0 110.0 109.0 110.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:155.50 stddev:23.20 (14.9%) stddev-sans-first:24.55 10:08:04 INFO - PROCESS | 23161 | Values: 156.0 127.0 151.0 183.0 128.0 155.0 174.0 128.0 184.0 128.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:1.05 (0.6%) stddev-sans-first:1.05 10:08:04 INFO - PROCESS | 23161 | Values: 164.0 163.0 163.0 161.0 162.0 164.0 162.0 163.0 164.0 164.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:39.53 (52.0%) stddev-sans-first:41.34 10:08:04 INFO - PROCESS | 23161 | Values: 76.0 76.0 76.0 181.0 79.0 77.0 74.0 76.0 157.0 76.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:92.00 stddev:26.34 (28.6%) stddev-sans-first:27.25 10:08:04 INFO - PROCESS | 23161 | Values: 92.0 93.0 158.0 92.0 93.0 92.0 140.0 92.0 93.0 140.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.44 10:08:04 INFO - PROCESS | 23161 | Values: 119.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:08:04 INFO - PROCESS | 23161 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 10:08:04 INFO - PROCESS | 23161 | Values: 95.0 94.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 94.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:56.00 stddev:7.17 (12.8%) stddev-sans-first:7.55 10:08:04 INFO - PROCESS | 23161 | Values: 56.0 56.0 56.0 56.0 55.0 64.0 57.0 77.0 54.0 53.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 10:08:04 INFO - PROCESS | 23161 | Values: 57.0 58.0 58.0 58.0 59.0 58.0 58.0 58.0 58.0 58.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:74.00 stddev:1.17 (1.6%) stddev-sans-first:1.09 10:08:04 INFO - PROCESS | 23161 | Values: 72.0 72.0 73.0 74.0 74.0 73.0 74.0 74.0 76.0 74.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:121.50 stddev:8.97 (7.4%) stddev-sans-first:9.00 10:08:04 INFO - PROCESS | 23161 | Values: 114.0 118.0 114.0 122.0 121.0 127.0 114.0 121.0 129.0 143.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:157.50 stddev:2.54 (1.6%) stddev-sans-first:2.67 10:08:04 INFO - PROCESS | 23161 | Values: 157.0 156.0 160.0 156.0 157.0 155.0 163.0 157.0 161.0 158.0 10:08:04 INFO - PROCESS | 23161 | 10:08:04 INFO - PROCESS | 23161 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.66 (2.5%) stddev-sans-first:1.73 10:08:04 INFO - PROCESS | 23161 | Values: 66.0 67.0 66.0 68.0 69.0 66.0 65.0 67.0 65.0 70.0 10:08:04 INFO - PROCESS | 23161 | -------- Summary: end -------- 10:08:04 INFO - PROCESS | 23161 | 10:08:05 INFO - TEST-INFO | 23161: exit 0 10:08:05 INFO - TEST-OK | kraken | took 60563ms 10:08:05 INFO - SUITE-END | took 1169s 10:08:05 INFO - Completed test suite (00:19:29) 10:08:05 INFO - javascript benchmark 10:08:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.00489853044, 3400.4729266963627, 3419.623841377449, 3440.2947395783867, 3458.8270586470685, 5584.469475399836, 5612.803551875685, 5614.550835933126, 5623.437656234374, 5630.521405680522, 5595.048841696911, 5600.747966341514, 5611.691356975365, 5626.887462250763, 5636.859078523029, 5095.4140273868425, 5131.871703207413, 5152.716600586966, 5175.404828444739, 5202.323697919265, 5045.217991211368, 5105.05556472052, 5206.167013277857, 5274.9472505275035, 5295.602829787762, 5168.793248270064, 5181.455947125535, 5220.321358223426, 5228.424873263938, 5235.816746413876, 5129.307543481619, 5130.127878260686, 5141.074606570815, 5143.819966301162, 5173.042987047408, 4998.150314446553, 5016.799328026875, 5031.924521132186, 5049.722265275445, 5067.467915868854, 5371.462853714636, 5374.328208973879, 5411.053065713484, 5424.267723857268, 5440.3743569489225, 5874.9412505874825, 5917.704114794286, 5927.110933359987, 5927.555433342473, 5931.347551769302, 5923.5853490255695, 5976.910346344808, 6064.302605200371, 6119.380693981191, 6127.4644201291, 5643.40744221859, 5644.8306550803545, 5648.858778530528, 5661.377248502661, 5680.204771332017, 6024.759009639565, 6076.210092687922, 6090.969545152246, 6133.080037994337, 6146.446819786241, 5829.562782791308, 5839.532837373, 5898.911516327258, 5903.085021821625, 5936.28764548257, 6048.909266361008, 6057.878842423127, 6062.939370606326, 6063.9090413643835, 6065.757369705162, 5878.0, 6023.48800351975, 6031.306399763996, 6034.607750496204, 6037.969810150921, 5987.940120598738, 6073.605215660968, 6077.696115194222, 6078.361772013964, 6109.236345456818, 4537.3647689323525, 4585.10590434862, 4598.494165641777, 4599.195140850338, 4624.468186158568, 4060.451839001697, 4074.246264441088, 4115.238680844053, 4120.031792528754, 4138.337865941435, 5779.971100144472, 5785.739641716133, 5872.265966754156, 5902.4097590240635, 5929.851753706192, 6026.0659597762415, 6060.090986351995, 6070.2412198475195, 6114.57197996136, 6122.693865306717, 5635.013872572284, 5695.800646977336, 5854.912176317359, 5864.882702345929, 5905.143754155623, 5026.371703537058, 5072.391313042384, 5085.9745701271995, 5092.668976516515, 5102.540771330598, 6408.134901788292, 6420.839479012969, 6440.516961227927, 6443.613383197023, 6462.0, 5800.1589769484035, 6012.9098063529955, 6064.636121832704, 6086.2087928569, 6116.29662588808, 6318.968405157945, 6321.115043893767, 6324.778632747832, 6329.145565348803, 6329.6518691470565, 5856.736446859816, 5868.2077919480325, 5873.823785286449, 5878.617889837147, 5927.229460170151, 5936.732847021808, 5992.101184822137, 6049.304330002106, 6100.328963813889, 6143.569950103629, 5861.677607731615, 5867.413258674099, 5868.0, 5886.440788125121, 5900.085486749561, 5831.970840145942, 5888.941110588839, 5889.234399528034, 5891.1457838612305, 5911.083782013795, 5673.659580425187, 5692.345380281321, 5786.710664466844, 5786.884262314646, 5798.246227990334, 5929.525637948867, 5932.733027013708, 5935.614185077956, 5940.55445841555, 5988.5508586855285, 5708.914366284592, 5822.039363505143, 5833.387494313036, 5834.562407819515, 5837.912431313619], "value": 5562.520877675685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.3783043938697, 683.1290105115979, 688.277308825733, 727.3017902813302, 746.7013194722113, 41847.79076104619, 42250.52123175693, 42305.576944230546, 42308.57691423085, 42537.57462425375, 44955.0, 45558.0, 45645.033072850325, 45703.771481142634, 45888.770556147174, 8776.385653004292, 8931.910680893174, 8993.100689930987, 8994.370394072417, 9002.954985225064, 8829.117088291152, 8922.464652120894, 8938.374313798036, 9155.130262625073, 9179.127982841619, 9205.539723013855, 9221.953890230572, 9235.676751313706, 9284.932232793213, 9301.116393942599, 9187.586558604879, 9280.535973201348, 9292.210162136227, 9298.814023719555, 9306.90693093074, 9191.0, 9230.53847307632, 9240.953795231047, 9292.117248861347, 9297.070292970717, 46067.53932460666, 46419.53580464186, 46731.29903051457, 46766.53233467656, 46855.76572117152, 3930.0764320384687, 4035.0, 4092.46797916269, 4241.448611680462, 4727.467258425605, 34848.12879678003, 34978.30043399143, 35165.12087197815, 35245.47131793025, 36776.816115919515, 4507.3689683444345, 4514.345419914127, 4559.224931761575, 4588.197065513522, 4652.674312798105, 335822.0, 337383.0, 337633.0, 338356.0, 339479.0, 68998.65500672464, 69127.0, 69529.30470695329, 69707.65146174339, 69761.30238697548, 71415.28584714087, 73711.0, 75180.62409687917, 75346.24653753392, 75431.24568754352, 18272.63454730898, 18477.90761046186, 18489.352872649393, 18540.536486587673, 18708.53228669267, 14753.631159221106, 14838.70322593542, 14855.554333370017, 14859.777103343458, 14861.331240094221, 20880.0, 20998.160073596886, 20999.685004724943, 21026.89486552588, 21089.050992705364, 7859.449838511364, 7901.762947111596, 8025.23760242776, 8169.9591502043295, 8210.178982101743, 1078.6871807175987, 1161.7908776420325, 1178.699431644925, 1182.456070207714, 1185.8399116119385, 34481.827590862384, 34583.13542161466, 34592.654073459445, 34945.30109397849, 34961.65038349635, 1220.4263995921901, 1249.6188662458037, 1268.245393990574, 1278.6867217531578, 1299.4022749535131, 17871.910640446975, 18160.909195454202, 18282.542936426697, 18392.356267530573, 18539.907300463412, 507334.0, 564798.0, 566160.0, 570603.0, 585868.0, 58594.70702646545, 59506.40493595095, 59527.0, 59590.0, 59609.403905961255, 1534.401583382504, 1541.814982202143, 1550.9069455832687, 1564.4368027510088, 1566.8746500279951, 32164.0, 32260.677393225767, 32721.836390817894, 33034.33931321312, 33680.83159584186, 57909.4209057904, 58576.0, 58671.4132858683, 58782.70608646929, 58813.11780323213, 465240.0, 465829.0, 467340.0, 467859.0, 470507.0, 32827.0, 33189.0, 33206.335873282886, 49383.0, 49478.0, 48826.511734882195, 49177.50822491729, 49178.75410622924, 49771.751141244065, 49870.0, 43284.567154329314, 43524.78237608792, 44183.55816441795, 44681.32978005397, 44688.0, 44230.55769442393, 45403.31895021643, 46110.30834537418, 46574.30138547992, 47120.92609794334, 44803.551964479935, 44872.32691509565, 45523.544764553255, 45599.31601025921, 45613.77193114013, 37821.43267850929, 38018.2396352077, 38119.42820857745, 38654.226915462095, 38847.0, 29486.0, 29956.251093722833, 30158.84920575383, 30598.082057538308, 30659.846700766353], "value": 21948.478027232733, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.5457415139951, 431.5210116770384, 432.3471557947498, 435.55790872264635, 439.8834308908139, 19101.331453399132, 19290.90354548227, 19826.801731982694, 21369.679454808153, 21569.78430215701, 19819.108140133692, 20301.289454869082, 20416.285430009953, 20472.181112755472, 20712.0, 5576.693281869485, 5937.792177273796, 5973.820785376446, 5976.3724808895095, 6006.819795406145, 5300.443453437372, 5567.387587365387, 5569.526590239834, 5800.970995145019, 5896.793612223573, 5539.833804985857, 5542.63972841766, 5558.944410555883, 5569.972150139243, 5633.324001119871, 6600.735970561172, 6631.469482441417, 6634.137562116918, 6658.633775142365, 6674.399304062634, 5791.971040144815, 5964.493018093467, 5972.820815375502, 5977.8804423911715, 5997.370276120988, 14664.340104695315, 14722.337494812758, 14850.480233191787, 14864.405423783035, 20043.0, 2506.5112303100905, 2596.5585850405287, 2626.1858823764696, 2930.575066615329, 3153.038323311389, 9535.570899309549, 10619.30974486656, 11006.284591501606, 13432.19406835593, 14054.0, 2043.5810658814908, 2134.583756167548, 2140.6039882621767, 2142.9357119286447, 2152.9031193596325, 82535.587322063, 82692.58653706753, 83547.16452835515, 85899.57050214772, 85916.57041714813, 11466.31202127875, 11574.0, 11653.6503904883, 11831.112666550043, 11888.286702797686, 16683.416080437128, 16753.1623418831, 16799.16004199785, 16831.74752378715, 16848.74726879098, 8904.8664270036, 8992.325575581857, 9046.0, 9066.818663626822, 9172.12864777845, 8913.064128266567, 8953.328500362499, 8976.551172441483, 9033.457992520338, 9071.183593476619, 4965.404151501771, 4967.0, 4969.503049695001, 5047.217681259411, 5050.0, 1911.3710123685612, 2093.9162433502793, 2123.9256626018014, 2149.18331034206, 2191.0, 1031.3193292427113, 1059.7138772531373, 1061.4162210784039, 1089.6730980705756, 1118.608487029533, 18275.0, 18369.81630183681, 18409.355672551395, 18658.253669853326, 19042.204067789946, 1069.946502674863, 1070.2561719604955, 1075.704181350135, 1154.699778057711, 1159.066951104369, 10931.672049838518, 10982.670519884416, 11079.0, 11153.10775137987, 11153.888461115284, 512284.0, 529560.0, 529747.0, 532310.0, 555515.0, 93671.0, 94618.0, 96899.51550242344, 96945.0, 98514.01485985192, 1104.6133853151493, 1122.186414849244, 1165.7318816672043, 1171.3264872698232, 1184.650528094197, 16906.0, 16985.575360616083, 17200.913995429943, 17356.82643173552, 17447.82552174462, 39446.408303874894, 39556.0, 41107.383389248585, 41147.38278925759, 41148.0, 57538.7123064382, 57614.42385576258, 58181.41818581929, 58268.4173158263, 58936.70531647314, 8516.787080323042, 8981.101889810967, 9187.586558604746, 9264.490453024879, 9316.44101353921, 12574.434150463068, 12811.231326120462, 13313.600591982256, 13530.323483825572, 13554.525591604246, 11401.714957126138, 11590.304581725124, 11703.180777345504, 11855.58505452305, 11967.281963082243, 11352.318860868045, 11420.486078126338, 11449.42752862337, 11734.0, 11746.58886938953, 6699.899501507384, 8930.0, 11810.0, 11882.881171188177, 11937.343446110548, 8790.164934331227, 8845.203931646183, 8879.0, 9066.592003359996, 9276.02601726809, 10575.0, 12354.938225308815, 12382.938085309515, 12473.688157796129, 12599.118061735591], "value": 9570.829198801994, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1568.0670001349197, 1575.1100628145098, 1768.9557761055971, 1893.0534732633682, 1907.8759880607768, 7810.687572497093, 8123.5125892446495, 8456.830863382736, 8767.0, 8793.956030219855, 8279.0, 8386.20331068549, 8387.16128387161, 8511.063782983867, 8593.054763975957, 2467.444824914398, 2468.950620987579, 2479.4297311618247, 2507.3856905058287, 2514.6856642919633, 2460.0, 2521.722610512851, 2522.3441905104623, 2523.823332366735, 2527.153403609793, 2472.777450029497, 2480.8635525046116, 2483.776460118589, 2487.577111890974, 2495.25142457263, 2435.7198922124007, 2444.8533088014774, 2453.766892145243, 2456.066694656028, 2478.7273399925994, 2492.2024952015363, 2497.0, 2526.0527302261653, 2543.0972004938167, 2545.8727063646743, 8833.514156721378, 8874.86687699685, 8875.245604123656, 8880.245179159714, 8892.377533572653, 5441.374241962186, 5569.916451253234, 5600.719964001824, 5623.971880140573, 5627.521660658849, 3319.4191016572004, 3333.0, 3342.314825460799, 3384.4415671414185, 3390.915227119317, 1032.5818043692316, 1048.8846226915034, 1063.0280433144237, 1067.4502631144967, 1074.833400822866, 12171.878281217163, 12228.388580571025, 12262.632121036384, 12287.877121228763, 12367.567135150317, 4592.862214133581, 4604.424446944132, 4649.814297354153, 4655.720656760605, 4687.320338550891, 9772.364796288219, 9778.559964801601, 9785.755356116011, 9788.804223915482, 9815.656452024288, 5405.70268635221, 5426.782928682808, 5439.564834813205, 5445.346558412936, 5445.992491389105, 4987.451380348159, 5029.270755740397, 5075.162598171334, 5131.025105229995, 5133.820316288912, 4021.9798901005893, 4030.7581545107387, 4050.5341885683524, 4100.876973690794, 4106.7125301228625, 1242.3850194153952, 1271.3643178410794, 1278.961631151067, 1290.4128621477205, 1294.0747365633617, 1071.9303245289032, 1093.1254996003324, 1103.2608152537819, 1105.5080489182396, 1107.0147568663895, 6311.0, 6437.549371544041, 6451.516136289797, 6509.479241660656, 6567.868642627216, 499.44810983863033, 503.3833553896521, 505.43391401629674, 511.41187634220944, 525.1623660261877, 4184.7070705050355, 4268.359746038119, 4304.160688665743, 4319.913601727948, 4344.826206951687, 10603.151747860153, 10852.565897364017, 10966.177536684781, 10986.725331866768, 11008.559657613767, 10382.42896640677, 10796.67609971702, 10814.29707069038, 10829.620963266249, 10843.186760992958, 8306.169383061646, 8313.750587482386, 8328.791780205422, 8335.8332833343, 8404.327653787683, 6135.63186208811, 6140.692965351804, 6187.84530386726, 6255.624662520263, 6316.242050953915, 9476.668316608886, 9536.23710103204, 9593.32846700752, 9645.9035409645, 9723.65967191145, 9177.862332064891, 9397.953010234905, 9418.858717119385, 9443.858342124737, 9597.136257736836, 6971.26801685836, 7752.186020467995, 7799.0, 7861.213878612093, 7996.520208787491, 8262.628181731716, 8273.503589784632, 8274.379421543528, 8284.668613255402, 8326.333893288644, 7350.816229594303, 7638.8090297743, 7644.617769111411, 7696.961515192388, 7783.455158138876, 7377.4098072155175, 7425.628718563942, 7482.139553951365, 7535.321821036133, 7563.886541701769, 7148.678309475982, 7155.427565794828, 7159.176694680178, 7217.206107328085, 7237.674304656198, 5481.917771233514, 5506.229127922014, 5563.8609034772835, 5611.747471363717, 5675.460831221028, 5447.0, 5477.04151773446, 5588.916166257428, 5600.215969764155, 5602.971985140048], "value": 4656.141615228551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.30595726418954, 355.2061143344624, 360.44311538672747, 360.6952125453992, 361.7214744646624, 6430.131932189153, 6537.0848081268605, 6565.179352580927, 6580.045893345462, 6619.304972977834, 6418.582792118521, 6422.293547709748, 6422.871542569146, 6429.549931504796, 6450.129232553604, 4809.326694262797, 4920.138975679241, 4946.738581661672, 4957.132501812186, 4961.429435614897, 4928.433230178522, 4936.827211047614, 4941.110600091982, 4944.554990050895, 4961.975190124044, 4908.263760435945, 4913.140200464923, 4915.016996600676, 4923.753812309388, 4924.4583095859425, 4914.680545764531, 4921.040397122545, 4928.827491037814, 4936.136176169156, 4947.876303092416, 4340.327249276335, 4352.064306174188, 4354.042110735665, 4357.978210108961, 4368.344748287751, 6004.3395226525045, 6227.097070924736, 6244.12582238487, 6257.780977665805, 6270.937290627081, 5673.8581535461535, 5679.886402271973, 5702.059160238556, 5731.627444216113, 5734.483896449298, 6744.359285867835, 6809.727610895558, 6818.249992500871, 6825.419839313664, 6838.623875686835, 4745.620350371996, 4793.904121917542, 4800.207965685658, 4805.495422980606, 4820.638452116105, 7022.0, 7071.504994650377, 7095.609741464217, 7096.254893236239, 7097.325754053409, 4704.1767690654, 4891.657583969088, 4894.877628059256, 4901.5588597026435, 4915.262710593368, 4943.555080042742, 4965.776540055706, 4992.151334273182, 4999.575036121898, 5001.574866136347, 5679.2333035040565, 5703.287089113861, 5736.483716465538, 5738.569607279471, 5748.338941021752, 6868.450523958171, 6872.140982377203, 6873.759418420332, 6884.070650462124, 6893.862122757617, 1749.5013921032444, 1774.6184570317187, 1775.1568005197428, 1778.4220128458044, 1779.2082523277018, 1154.4343271796927, 1158.426578843478, 1186.5431808753692, 1193.117093350914, 1207.8550573931009, 6681.064650948871, 6693.230278517935, 6696.665166741644, 6699.129113215348, 6699.899501507482, 6953.930460695429, 7031.226565077837, 7048.823779405453, 7068.68190931399, 7080.291970802981, 6774.3225677431865, 6775.322467753185, 6780.288069752703, 6786.728530858809, 6802.897956530656, 3801.125741079567, 3844.6539811417106, 3845.384738441892, 3845.5577608575372, 3851.67260782831, 7524.548527088392, 7525.4355923305975, 7546.698132074765, 7552.055993000875, 7559.28186822251, 6975.616341101187, 7197.604131772698, 7217.711291548279, 7224.0608720867, 7224.13310402755, 7550.0, 7576.772696819105, 7577.810554736066, 7614.923850761422, 7615.847683046419, 7102.076730025064, 7112.395446387115, 7145.0, 7148.67830947619, 7156.9642151790995, 6987.986741922495, 7023.33278338557, 7033.507654464139, 7035.718571257093, 7074.540154889915, 7323.8535229296185, 7517.361024312776, 7527.1343795462035, 7537.0, 7546.603878282535, 4761.500042495488, 4785.59322457595, 4794.976025119852, 4802.399700037496, 4805.27920811881, 7094.822629434306, 7143.785686429415, 7152.284771522806, 7157.785266442015, 7160.176579693402, 6866.759663411756, 6901.89647155283, 6917.27368626287, 6925.965370173117, 6927.134108236471, 6767.511147547531, 6818.352256535622, 6885.139357580302, 6896.034555162381, 6917.654117294216, 6723.327667233433, 6762.0, 6763.560368576027, 6765.86468270622, 6773.221079575715, 6952.687129079305, 6954.095967524392, 6955.513114081966, 6955.582665040114, 6974.442044636518, 6758.5269031167345, 6766.766966900813, 6773.458123350021, 6775.356341147583, 6779.491538134758], "value": 5204.212287959974, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.6305477808877, 933.6545478173073, 948.743839163426, 948.9667861624845, 962.0427674463905, 14788.26058697065, 14822.184779837105, 14948.252587370614, 14991.925040374797, 15009.92495037526, 14159.867210623152, 14176.858231417682, 14296.285185740724, 14322.140671559713, 14324.641883952907, 740.5741698523344, 880.8458519759049, 904.0281697175529, 907.6687009241646, 908.6955869783598, 890.2788741119681, 892.6429428228728, 899.8470260055806, 900.7387857521311, 903.3902116071625, 939.7274790310836, 954.9618015279381, 955.1690029674194, 955.3217215776807, 956.9377990430635, 944.6221511395428, 948.1656142594542, 950.1401231885155, 950.7908260182749, 952.3999880075577, 698.1691786773723, 698.9056477375591, 701.7578935267376, 701.7789396340188, 702.1609177033447, 13816.585502434944, 13848.861511384857, 13874.375653095634, 13911.095778774448, 13926.885849132044, 14911.552653420415, 15207.163606001666, 15283.0, 15330.0, 15358.0, 12102.273863568214, 12219.144659873813, 12269.509219631203, 12353.444095015746, 12364.690882727913, 4077.2032407522056, 4114.321137012389, 4152.647025002879, 4163.437935878648, 4192.224438478891, 56072.15891761586, 56087.71956140193, 56110.0, 56257.71871140659, 56381.43618563803, 10920.235583509078, 11023.503942322615, 11268.323900565993, 11386.544538218544, 11579.652610421701, 18601.0, 18870.339538116375, 18884.90557547231, 18912.905435472734, 18957.905210474135, 8963.058878817761, 9030.187283144549, 9182.449053056838, 9233.169014788702, 9241.93717722457, 5153.742312884341, 5203.869903252449, 5213.791448342024, 5214.426413094557, 5226.059309324282, 3669.339518886626, 3688.741788074809, 3699.426588878728, 3699.5375578052744, 3725.925481490355, 691.778630838127, 701.2006312803409, 708.3058602569511, 716.8566286742672, 720.7585458871232, 778.9415793815486, 786.3709032773758, 831.3058596072226, 849.2611428057506, 869.7129947117436, 10014.399136051714, 10302.639407620698, 10475.685729428129, 10498.160147188206, 10506.212034097472, 681.3084719010209, 708.7767353283699, 748.1807420874134, 782.1669921533548, 788.5899332347147, 4511.70673906195, 4596.770161491912, 4770.95229047712, 4821.0, 4864.489228631013, 61775.38224617786, 61933.07100393498, 65203.0, 66216.33783662198, 67140.0, 52142.0, 52567.73716131395, 55000.449995500334, 58363.708181458824, 59050.704746475996, 52724.47275527272, 52920.47079529233, 53201.46798532043, 53353.46646533562, 53364.46635533595, 10159.695209143738, 10499.107575855833, 10830.241883068426, 10955.397453139834, 11087.667369978913, 36415.0, 38946.805265974624, 39126.6087339123, 40665.186696265315, 40773.1845363097, 44152.33771493366, 44327.77836110799, 45030.324545132506, 45649.77175114103, 45890.770546147054, 12808.6797830055, 12914.547990820276, 12942.0, 13101.672458188621, 13187.406566704329, 13546.864531354955, 14715.264236788333, 14722.631934201303, 14766.48317308889, 14809.481668141563, 12473.87526124727, 12476.563320283747, 12533.362655817042, 13174.670633233862, 14011.859881401464, 13000.804987925378, 13386.933065334611, 13815.516456923959, 13842.515511957034, 13901.930490347484, 11709.180357374902, 13048.869511304765, 13347.933260333637, 13413.128146670435, 13705.520306789214, 10665.626703065356, 10822.837657434988, 10883.619073332395, 11049.447527623748, 11241.831372529583, 10629.559308484246, 10941.56233750641, 11044.558217671203, 11097.445127743418, 11129.833052504056], "value": 7236.1682332708415, "unit": "score"}], "name": "dromaeo_css", "value": 7678.198662783033, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 104.0, 110.0, 112.0, 110.0, 100.0, 110.0, 109.0, 110.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 151.0, 183.0, 128.0, 155.0, 174.0, 128.0, 184.0, 128.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 161.0, 162.0, 164.0, 162.0, 163.0, 164.0, 164.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 181.0, 79.0, 77.0, 74.0, 76.0, 157.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 158.0, 92.0, 93.0, 92.0, 140.0, 92.0, 93.0, 140.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 55.0, 64.0, 57.0, 77.0, 54.0, 53.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 74.0, 74.0, 73.0, 74.0, 74.0, 76.0, 74.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 114.0, 122.0, 121.0, 127.0, 114.0, 121.0, 129.0, 143.0], "value": 122.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 160.0, 156.0, 157.0, 155.0, 163.0, 157.0, 161.0, 158.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 68.0, 69.0, 66.0, 65.0, 67.0, 65.0, 70.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1522.3, "alertThreshold": 2.0}]} 10:08:06 INFO - Return code: 0 10:08:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:08:06 ERROR - # TBPL SUCCESS # 10:08:06 INFO - Running post-action listener: _resource_record_post_action 10:08:06 INFO - Running post-run listener: _resource_record_post_run 10:08:07 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 462536704; Read time: 12; Write time: 418940 10:08:07 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242323456; Read time: 0; Write time: 287920 10:08:07 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219693056; Read time: 12; Write time: 131020 10:08:07 INFO - Running post-run listener: _upload_blobber_files 10:08:07 INFO - Blob upload gear active. 10:08:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08:07 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 10:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:08:07 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:08:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:08:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:08 INFO - (blobuploader) - INFO - Done attempting. 10:08:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:08:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:08:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:09 INFO - (blobuploader) - INFO - Done attempting. 10:08:09 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:09 INFO - Return code: 0 10:08:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c6d7906518b9a66600996dba894d75411ac1ca15f45bd7f6d19649d793722761cca8fb5f24ab0a5efc151cc02902534e70f7ea1c3e7011450453793bb35bd31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c411a4b338a14783cdce9220ec4f93e4cdc1857a2a93cda2e824edf6009114621c7dadc28be0b6dc57dc1635060c6840d62da681e3e199e742cbaef2aa05177"} 10:08:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:09 INFO - Contents: 10:08:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c6d7906518b9a66600996dba894d75411ac1ca15f45bd7f6d19649d793722761cca8fb5f24ab0a5efc151cc02902534e70f7ea1c3e7011450453793bb35bd31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c411a4b338a14783cdce9220ec4f93e4cdc1857a2a93cda2e824edf6009114621c7dadc28be0b6dc57dc1635060c6840d62da681e3e199e742cbaef2aa05177"} 10:08:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:09 INFO - Copying logs to upload dir... 10:08:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.103359 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-28 10:08:08.713347) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:08:08.717314) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c6d7906518b9a66600996dba894d75411ac1ca15f45bd7f6d19649d793722761cca8fb5f24ab0a5efc151cc02902534e70f7ea1c3e7011450453793bb35bd31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c411a4b338a14783cdce9220ec4f93e4cdc1857a2a93cda2e824edf6009114621c7dadc28be0b6dc57dc1635060c6840d62da681e3e199e742cbaef2aa05177"} build_url:https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011124 build_url: 'https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c6d7906518b9a66600996dba894d75411ac1ca15f45bd7f6d19649d793722761cca8fb5f24ab0a5efc151cc02902534e70f7ea1c3e7011450453793bb35bd31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c411a4b338a14783cdce9220ec4f93e4cdc1857a2a93cda2e824edf6009114621c7dadc28be0b6dc57dc1635060c6840d62da681e3e199e742cbaef2aa05177"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:08:08.746486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:08:08.746861) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1467132464.846645-1602102411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:08:08.831295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:08:08.832046) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:08:08.832876) ========= ========= Total master_lag: 0.17 =========