builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1460830573.4 results: success (0) buildid: 20160416083214 builduid: e51a8f8729fb400ca6950d9d6dc66848 revision: abe15212891c03d58bee30a6ec38e89bcb4abef3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:13.399889) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:13.400399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:13.400728) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:13.448931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:13.449353) ========= 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=eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-16 11:16:13-- 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% 50.4M=0s 2016-04-16 11:16:13 (50.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176543 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:13.682913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:13.683298) ========= 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=eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.134561 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:13.828243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:13.828645) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev abe15212891c03d58bee30a6ec38e89bcb4abef3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev abe15212891c03d58bee30a6ec38e89bcb4abef3 --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=eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-16 11:16:13,913 truncating revision to first 12 chars 2016-04-16 11:16:13,913 Setting DEBUG logging. 2016-04-16 11:16:13,913 attempt 1/10 2016-04-16 11:16:13,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/abe15212891c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-16 11:16:14,167 unpacking tar archive at: fx-team-abe15212891c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630409 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:14.470881) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:14.471202) ========= script_repo_revision: abe15212891c03d58bee30a6ec38e89bcb4abef3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:14.471609) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:14.471890) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 11:16:14.480972) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-16 11:16:14.481282) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:16:14 INFO - MultiFileLogger online at 20160416 11:16:14 in /builds/slave/test 11:16:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:16:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:14 INFO - {'append_to_log': False, 11:16:14 INFO - 'base_work_dir': '/builds/slave/test', 11:16:14 INFO - 'blob_upload_branch': 'Fx-Team', 11:16:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:14 INFO - 'branch': 'Fx-Team', 11:16:14 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:14 INFO - 'config_files': ('talos/linux_config.py',), 11:16:14 INFO - 'default_actions': ('clobber', 11:16:14 INFO - 'read-buildbot-config', 11:16:14 INFO - 'download-and-extract', 11:16:14 INFO - 'populate-webroot', 11:16:14 INFO - 'create-virtualenv', 11:16:14 INFO - 'install', 11:16:14 INFO - 'run-tests'), 11:16:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:14 INFO - 'download_minidump_stackwalk': True, 11:16:14 INFO - 'download_symbols': 'ondemand', 11:16:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:14 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:14 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:14 INFO - 'installer_path': 'installer.exe', 11:16:14 INFO - 'log_level': 'info', 11:16:14 INFO - 'log_name': 'talos', 11:16:14 INFO - 'log_to_console': True, 11:16:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:16:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:16:14 INFO - 'opt_config_files': (), 11:16:14 INFO - 'pip_index': False, 11:16:14 INFO - 'sps_profile': False, 11:16:14 INFO - 'sps_profile_interval': 0, 11:16:14 INFO - 'suite': 'dromaeojs', 11:16:14 INFO - 'system_bits': '32', 11:16:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:14 INFO - 'title': 'talos-linux64-ix-010', 11:16:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:14 INFO - 'use_talos_json': True, 11:16:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:14 INFO - 'work_dir': 'build'} 11:16:14 INFO - ##### 11:16:14 INFO - ##### Running clobber step. 11:16:14 INFO - ##### 11:16:14 INFO - Running pre-action listener: _resource_record_pre_action 11:16:14 INFO - Running main action method: clobber 11:16:14 INFO - rmtree: /builds/slave/test/build 11:16:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:16:20 INFO - Running post-action listener: _resource_record_post_action 11:16:20 INFO - ##### 11:16:20 INFO - ##### Running read-buildbot-config step. 11:16:20 INFO - ##### 11:16:20 INFO - Running pre-action listener: _resource_record_pre_action 11:16:20 INFO - Running main action method: read_buildbot_config 11:16:20 INFO - Using buildbot properties: 11:16:20 INFO - { 11:16:20 INFO - "project": "", 11:16:20 INFO - "product": "firefox", 11:16:20 INFO - "script_repo_revision": "production", 11:16:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:16:20 INFO - "repository": "", 11:16:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:16:20 INFO - "buildid": "20160416083214", 11:16:20 INFO - "pgo_build": "True", 11:16:20 INFO - "basedir": "/builds/slave/test", 11:16:20 INFO - "buildnumber": 36, 11:16:20 INFO - "slavename": "talos-linux64-ix-010", 11:16:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:16:20 INFO - "platform": "ubuntu64_hw", 11:16:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:16:20 INFO - "branch": "fx-team", 11:16:20 INFO - "repo_path": "integration/fx-team", 11:16:20 INFO - "revision": "abe15212891c03d58bee30a6ec38e89bcb4abef3", 11:16:20 INFO - "stage_platform": "linux64-pgo", 11:16:20 INFO - "builduid": "e51a8f8729fb400ca6950d9d6dc66848", 11:16:20 INFO - "slavebuilddir": "test" 11:16:20 INFO - } 11:16:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:16:20 INFO - Running post-action listener: _resource_record_post_action 11:16:20 INFO - ##### 11:16:20 INFO - ##### Running download-and-extract step. 11:16:20 INFO - ##### 11:16:20 INFO - Running pre-action listener: _resource_record_pre_action 11:16:20 INFO - Running main action method: download_and_extract 11:16:20 INFO - mkdir: /builds/slave/test/build/tests 11:16:20 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')]} 11:16:20 INFO - https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:16:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:16:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:16:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:16:28 INFO - Downloaded 1361 bytes. 11:16:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:16:28 INFO - Using the following test package requirements: 11:16:28 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:28 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:16:28 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:16:28 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:28 INFO - u'jsshell-linux-x86_64.zip'], 11:16:28 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:16:28 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:28 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:16:28 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:16:28 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:16:28 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:16:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:28 INFO - https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:16:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:16:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:16:35 INFO - Downloaded 23775019 bytes. 11:16:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:16:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:16:36 INFO - Return code: 0 11:16:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:36 INFO - https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:16:38 INFO - Downloaded 23775019 bytes. 11:16:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:16:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:16:40 INFO - Return code: 0 11:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:40 INFO - https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:16:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:16:41 INFO - Downloaded 10841076 bytes. 11:16:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:16:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:16:41 INFO - Return code: 0 11:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:41 INFO - https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:16:43 INFO - Downloaded 58234768 bytes. 11:16:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:16:43 INFO - mkdir: /builds/slave/test/properties 11:16:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:16:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:16:43 INFO - Contents: 11:16:43 INFO - build_url:https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:16:44 INFO - Running post-action listener: _resource_record_post_action 11:16:44 INFO - Running post-action listener: set_extra_try_arguments 11:16:44 INFO - ##### 11:16:44 INFO - ##### Running populate-webroot step. 11:16:44 INFO - ##### 11:16:44 INFO - Running pre-action listener: _resource_record_pre_action 11:16:44 INFO - Running main action method: populate_webroot 11:16:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:16:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:16:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:16:44 INFO - '--tppagecycles', 11:16:44 INFO - '7'], 11:16:44 INFO - 'tests': ['tsvgm']}}, 11:16:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:16:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:16:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:16:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:16:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['damp', 'tps']}, 11:16:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'tests': ['damp', 'tps']}, 11:16:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['dromaeo_dom']}, 11:16:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:16:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['tsvgx', 11:16:44 INFO - 'tsvgr_opacity', 11:16:44 INFO - 'tart', 11:16:44 INFO - 'tscrollx', 11:16:44 INFO - 'cart']}, 11:16:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:16:44 INFO - 'tsvgr_opacity', 11:16:44 INFO - 'tart', 11:16:44 INFO - 'tscrollx', 11:16:44 INFO - 'cart']}, 11:16:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['tp5o']}, 11:16:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'tests': ['tp5o']}, 11:16:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--disable-e10s', 11:16:44 INFO - '--xperf_path', 11:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:44 INFO - 'tests': ['tp5n']}, 11:16:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--xperf_path', 11:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:44 INFO - 'tests': ['tp5n']}}, 11:16:44 INFO - 'talos.zip': {'path': '', 11:16:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:16:44 INFO - Running post-action listener: _resource_record_post_action 11:16:44 INFO - ##### 11:16:44 INFO - ##### Running create-virtualenv step. 11:16:44 INFO - ##### 11:16:44 INFO - Running pre-action listener: _resource_record_pre_action 11:16:44 INFO - Running main action method: create_virtualenv 11:16:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:16:44 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 11:16:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:16:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:16:44 INFO - Using real prefix '/usr' 11:16:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:16:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:16:47 INFO - Installing pip.................done. 11:16:47 INFO - Return code: 0 11:16:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 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 0x7fabd923cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd810>, '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 0x13fe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13feba0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', '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 11:16:47 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 11:16:47 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 11:16:47 INFO - Using env: {'DISPLAY': ':0', 11:16:47 INFO - 'HOME': '/home/cltbld', 11:16:47 INFO - 'LANG': 'en_US.UTF-8', 11:16:47 INFO - 'LANGUAGE': 'en_US:en', 11:16:47 INFO - 'LOGNAME': 'cltbld', 11:16:47 INFO - 'MAIL': '/var/mail/cltbld', 11:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:47 INFO - 'MOZ_NO_REMOTE': '1', 11:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:47 INFO - 'NO_EM_RESTART': '1', 11:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:47 INFO - 'PWD': '/builds/slave/test', 11:16:47 INFO - 'SHELL': '/bin/bash', 11:16:47 INFO - 'SHLVL': '1', 11:16:47 INFO - 'TERM': 'linux', 11:16:47 INFO - 'TMOUT': '86400', 11:16:47 INFO - 'USER': 'cltbld', 11:16:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', 11:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:47 INFO - '_': '/tools/buildbot/bin/python'} 11:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:48 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 11:16:48 INFO - Cleaning up... 11:16:48 INFO - Return code: 0 11:16:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:48 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 0x7fabd923cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd810>, '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 0x13fe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13feba0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', '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 11:16:48 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 11:16:48 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 11:16:48 INFO - Using env: {'DISPLAY': ':0', 11:16:48 INFO - 'HOME': '/home/cltbld', 11:16:48 INFO - 'LANG': 'en_US.UTF-8', 11:16:48 INFO - 'LANGUAGE': 'en_US:en', 11:16:48 INFO - 'LOGNAME': 'cltbld', 11:16:48 INFO - 'MAIL': '/var/mail/cltbld', 11:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:48 INFO - 'MOZ_NO_REMOTE': '1', 11:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:48 INFO - 'NO_EM_RESTART': '1', 11:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:48 INFO - 'PWD': '/builds/slave/test', 11:16:48 INFO - 'SHELL': '/bin/bash', 11:16:48 INFO - 'SHLVL': '1', 11:16:48 INFO - 'TERM': 'linux', 11:16:48 INFO - 'TMOUT': '86400', 11:16:48 INFO - 'USER': 'cltbld', 11:16:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', 11:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:48 INFO - '_': '/tools/buildbot/bin/python'} 11:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:48 INFO - Downloading/unpacking psutil>=0.7.1 11:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:16:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:50 INFO - Installing collected packages: psutil 11:16:50 INFO - Running setup.py install for psutil 11:16:50 INFO - building 'psutil._psutil_linux' extension 11:16:50 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 11:16:51 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 11:16:52 INFO - building 'psutil._psutil_posix' extension 11:16:52 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 11:16:52 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 11:16:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:52 INFO - Successfully installed psutil 11:16:52 INFO - Cleaning up... 11:16:52 INFO - Return code: 0 11:16:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:16:52 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')]} 11:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:52 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')]} 11:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:52 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 0x7fabd923cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd810>, '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 0x13fe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13feba0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', '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 11:16:52 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 11:16:52 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 11:16:52 INFO - Using env: {'DISPLAY': ':0', 11:16:52 INFO - 'HOME': '/home/cltbld', 11:16:52 INFO - 'LANG': 'en_US.UTF-8', 11:16:52 INFO - 'LANGUAGE': 'en_US:en', 11:16:52 INFO - 'LOGNAME': 'cltbld', 11:16:52 INFO - 'MAIL': '/var/mail/cltbld', 11:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:52 INFO - 'MOZ_NO_REMOTE': '1', 11:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:52 INFO - 'NO_EM_RESTART': '1', 11:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:52 INFO - 'PWD': '/builds/slave/test', 11:16:52 INFO - 'SHELL': '/bin/bash', 11:16:52 INFO - 'SHLVL': '1', 11:16:52 INFO - 'TERM': 'linux', 11:16:52 INFO - 'TMOUT': '86400', 11:16:52 INFO - 'USER': 'cltbld', 11:16:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', 11:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:52 INFO - '_': '/tools/buildbot/bin/python'} 11:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:16:52 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 11:16:52 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 11:16:52 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 11:16:52 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 11:16:52 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 11:16:52 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 11:16:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:16:54 INFO - Installing collected packages: mozsystemmonitor 11:16:54 INFO - Running setup.py install for mozsystemmonitor 11:16:54 INFO - Successfully installed mozsystemmonitor 11:16:54 INFO - Cleaning up... 11:16:54 INFO - Return code: 0 11:16:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:54 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 0x7fabd923cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd810>, '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 0x13fe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13feba0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', '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 11:16:54 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 11:16:54 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 11:16:54 INFO - Using env: {'DISPLAY': ':0', 11:16:54 INFO - 'HOME': '/home/cltbld', 11:16:54 INFO - 'LANG': 'en_US.UTF-8', 11:16:54 INFO - 'LANGUAGE': 'en_US:en', 11:16:54 INFO - 'LOGNAME': 'cltbld', 11:16:54 INFO - 'MAIL': '/var/mail/cltbld', 11:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:54 INFO - 'MOZ_NO_REMOTE': '1', 11:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:54 INFO - 'NO_EM_RESTART': '1', 11:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:54 INFO - 'PWD': '/builds/slave/test', 11:16:54 INFO - 'SHELL': '/bin/bash', 11:16:54 INFO - 'SHLVL': '1', 11:16:54 INFO - 'TERM': 'linux', 11:16:54 INFO - 'TMOUT': '86400', 11:16:54 INFO - 'USER': 'cltbld', 11:16:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', 11:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:54 INFO - '_': '/tools/buildbot/bin/python'} 11:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:54 INFO - Downloading/unpacking blobuploader==1.2.4 11:16:54 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 11:16:54 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 11:16:54 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 11:16:54 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 11:16:54 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 11:16:54 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 11:16:56 INFO - Downloading blobuploader-1.2.4.tar.gz 11:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:16:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:16:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:16:57 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 11:16:57 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 11:16:57 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 11:16:57 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 11:16:57 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 11:16:57 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 11:16:57 INFO - Downloading docopt-0.6.1.tar.gz 11:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:16:57 INFO - Installing collected packages: blobuploader, requests, docopt 11:16:57 INFO - Running setup.py install for blobuploader 11:16:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:16:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:16:57 INFO - Running setup.py install for requests 11:16:57 INFO - Running setup.py install for docopt 11:16:58 INFO - Successfully installed blobuploader requests docopt 11:16:58 INFO - Cleaning up... 11:16:58 INFO - Return code: 0 11:16:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:58 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')]} 11:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:58 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')]} 11:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:58 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 0x7fabd923cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd810>, '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 0x13fe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13feba0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', '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 11:16:58 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 11:16:58 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 11:16:58 INFO - Using env: {'DISPLAY': ':0', 11:16:58 INFO - 'HOME': '/home/cltbld', 11:16:58 INFO - 'LANG': 'en_US.UTF-8', 11:16:58 INFO - 'LANGUAGE': 'en_US:en', 11:16:58 INFO - 'LOGNAME': 'cltbld', 11:16:58 INFO - 'MAIL': '/var/mail/cltbld', 11:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:58 INFO - 'MOZ_NO_REMOTE': '1', 11:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:58 INFO - 'NO_EM_RESTART': '1', 11:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:58 INFO - 'PWD': '/builds/slave/test', 11:16:58 INFO - 'SHELL': '/bin/bash', 11:16:58 INFO - 'SHLVL': '1', 11:16:58 INFO - 'TERM': 'linux', 11:16:58 INFO - 'TMOUT': '86400', 11:16:58 INFO - 'USER': 'cltbld', 11:16:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', 11:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:58 INFO - '_': '/tools/buildbot/bin/python'} 11:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:58 INFO - Running setup.py (path:/tmp/pip-230qdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:58 INFO - Running setup.py (path:/tmp/pip-Jdxmg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:58 INFO - Running setup.py (path:/tmp/pip-ZWLhOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:58 INFO - Running setup.py (path:/tmp/pip-JvETyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:58 INFO - Running setup.py (path:/tmp/pip-l1ck2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:58 INFO - Running setup.py (path:/tmp/pip-U96TIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:58 INFO - Running setup.py (path:/tmp/pip-QSbJUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:58 INFO - Running setup.py (path:/tmp/pip-Osqap5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:58 INFO - Running setup.py (path:/tmp/pip-SgpLfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:58 INFO - Running setup.py (path:/tmp/pip-kBBZd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:59 INFO - Running setup.py (path:/tmp/pip-tSbREj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:59 INFO - Running setup.py (path:/tmp/pip-_mUvp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:59 INFO - Running setup.py (path:/tmp/pip-7dBWiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:59 INFO - Running setup.py (path:/tmp/pip-aelX0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:59 INFO - Running setup.py (path:/tmp/pip-6xe_2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:59 INFO - Running setup.py (path:/tmp/pip-BjeE7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:59 INFO - Running setup.py (path:/tmp/pip-H5_2KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:16:59 INFO - Running setup.py install for manifestparser 11:16:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:16:59 INFO - Running setup.py install for mozcrash 11:16:59 INFO - Running setup.py install for mozdebug 11:16:59 INFO - Running setup.py install for mozdevice 11:16:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:16:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:16:59 INFO - Running setup.py install for mozfile 11:17:00 INFO - Running setup.py install for mozhttpd 11:17:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Running setup.py install for mozinfo 11:17:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Running setup.py install for mozInstall 11:17:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Running setup.py install for mozleak 11:17:00 INFO - Running setup.py install for mozlog 11:17:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Running setup.py install for moznetwork 11:17:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Running setup.py install for mozprocess 11:17:00 INFO - Running setup.py install for mozprofile 11:17:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Running setup.py install for mozrunner 11:17:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Running setup.py install for mozscreenshot 11:17:01 INFO - Running setup.py install for moztest 11:17:01 INFO - Running setup.py install for mozversion 11:17:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:01 INFO - Cleaning up... 11:17:01 INFO - Return code: 0 11:17:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:01 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')]} 11:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:01 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')]} 11:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:01 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 0x7fabd923cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd810>, '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 0x13fe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13feba0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', '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 11:17:01 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 11:17:01 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 11:17:01 INFO - Using env: {'DISPLAY': ':0', 11:17:01 INFO - 'HOME': '/home/cltbld', 11:17:01 INFO - 'LANG': 'en_US.UTF-8', 11:17:01 INFO - 'LANGUAGE': 'en_US:en', 11:17:01 INFO - 'LOGNAME': 'cltbld', 11:17:01 INFO - 'MAIL': '/var/mail/cltbld', 11:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:01 INFO - 'MOZ_NO_REMOTE': '1', 11:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:01 INFO - 'NO_EM_RESTART': '1', 11:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:01 INFO - 'PWD': '/builds/slave/test', 11:17:01 INFO - 'SHELL': '/bin/bash', 11:17:01 INFO - 'SHLVL': '1', 11:17:01 INFO - 'TERM': 'linux', 11:17:01 INFO - 'TMOUT': '86400', 11:17:01 INFO - 'USER': 'cltbld', 11:17:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', 11:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:01 INFO - '_': '/tools/buildbot/bin/python'} 11:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:01 INFO - Running setup.py (path:/tmp/pip-iVRUc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:01 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)) 11:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:01 INFO - Running setup.py (path:/tmp/pip-_DcDrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:01 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)) 11:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:01 INFO - Running setup.py (path:/tmp/pip-AmSmbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:01 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)) 11:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:01 INFO - Running setup.py (path:/tmp/pip-xoOjYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:01 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)) 11:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:01 INFO - Running setup.py (path:/tmp/pip-MjnCUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:01 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)) 11:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:01 INFO - Running setup.py (path:/tmp/pip-rm2hPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:01 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)) 11:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:01 INFO - Running setup.py (path:/tmp/pip-L068Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:02 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)) 11:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:02 INFO - Running setup.py (path:/tmp/pip-yH7xQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:02 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)) 11:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:02 INFO - Running setup.py (path:/tmp/pip-mM06Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:02 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)) 11:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:02 INFO - Running setup.py (path:/tmp/pip-ECaakU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:02 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)) 11:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:02 INFO - Running setup.py (path:/tmp/pip-Yf2pLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:02 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)) 11:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:02 INFO - Running setup.py (path:/tmp/pip-dR98dX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:02 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)) 11:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:02 INFO - Running setup.py (path:/tmp/pip-dW5EGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:02 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)) 11:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:02 INFO - Running setup.py (path:/tmp/pip-PfXJTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:02 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)) 11:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:02 INFO - Running setup.py (path:/tmp/pip-_Y46DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:02 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)) 11:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:02 INFO - Running setup.py (path:/tmp/pip-v3HcyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:02 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)) 11:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:02 INFO - Running setup.py (path:/tmp/pip-LgGPMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:04 INFO - Downloading blessings-1.6.tar.gz 11:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:04 INFO - Installing collected packages: blessings 11:17:04 INFO - Running setup.py install for blessings 11:17:04 INFO - Successfully installed blessings 11:17:04 INFO - Cleaning up... 11:17:04 INFO - Return code: 0 11:17:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:05 INFO - Reading from file tmpfile_stdout 11:17:05 INFO - Current package versions: 11:17:05 INFO - argparse == 1.2.1 11:17:05 INFO - blessings == 1.6 11:17:05 INFO - blobuploader == 1.2.4 11:17:05 INFO - docopt == 0.6.1 11:17:05 INFO - manifestparser == 1.1 11:17:05 INFO - mozInstall == 1.12 11:17:05 INFO - mozcrash == 0.17 11:17:05 INFO - mozdebug == 0.1 11:17:05 INFO - mozdevice == 0.48 11:17:05 INFO - mozfile == 1.2 11:17:05 INFO - mozhttpd == 0.7 11:17:05 INFO - mozinfo == 0.9 11:17:05 INFO - mozleak == 0.1 11:17:05 INFO - mozlog == 3.1 11:17:05 INFO - moznetwork == 0.27 11:17:05 INFO - mozprocess == 0.22 11:17:05 INFO - mozprofile == 0.28 11:17:05 INFO - mozrunner == 6.11 11:17:05 INFO - mozscreenshot == 0.1 11:17:05 INFO - mozsystemmonitor == 0.0 11:17:05 INFO - moztest == 0.7 11:17:05 INFO - mozversion == 1.4 11:17:05 INFO - psutil == 3.1.1 11:17:05 INFO - requests == 1.2.3 11:17:05 INFO - wsgiref == 0.1.2 11:17:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:05 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 0x7fabd923cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd810>, '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 0x13fe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13feba0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', '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 11:17:05 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 11:17:05 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 11:17:05 INFO - Using env: {'DISPLAY': ':0', 11:17:05 INFO - 'HOME': '/home/cltbld', 11:17:05 INFO - 'LANG': 'en_US.UTF-8', 11:17:05 INFO - 'LANGUAGE': 'en_US:en', 11:17:05 INFO - 'LOGNAME': 'cltbld', 11:17:05 INFO - 'MAIL': '/var/mail/cltbld', 11:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:05 INFO - 'MOZ_NO_REMOTE': '1', 11:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:05 INFO - 'NO_EM_RESTART': '1', 11:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:05 INFO - 'PWD': '/builds/slave/test', 11:17:05 INFO - 'SHELL': '/bin/bash', 11:17:05 INFO - 'SHLVL': '1', 11:17:05 INFO - 'TERM': 'linux', 11:17:05 INFO - 'TMOUT': '86400', 11:17:05 INFO - 'USER': 'cltbld', 11:17:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', 11:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:05 INFO - '_': '/tools/buildbot/bin/python'} 11:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:05 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)) 11:17:05 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)) 11:17:05 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)) 11:17:05 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)) 11:17:05 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)) 11:17:05 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)) 11:17:05 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)) 11:17:05 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)) 11:17:05 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)) 11:17:05 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)) 11:17:05 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)) 11:17:05 INFO - Cleaning up... 11:17:05 INFO - Return code: 0 11:17:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:05 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 0x7fabd923cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd810>, '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 0x13fe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13feba0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', '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 11:17:05 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 11:17:05 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 11:17:05 INFO - Using env: {'DISPLAY': ':0', 11:17:05 INFO - 'HOME': '/home/cltbld', 11:17:05 INFO - 'LANG': 'en_US.UTF-8', 11:17:05 INFO - 'LANGUAGE': 'en_US:en', 11:17:05 INFO - 'LOGNAME': 'cltbld', 11:17:05 INFO - 'MAIL': '/var/mail/cltbld', 11:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:05 INFO - 'MOZ_NO_REMOTE': '1', 11:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:05 INFO - 'NO_EM_RESTART': '1', 11:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:05 INFO - 'PWD': '/builds/slave/test', 11:17:05 INFO - 'SHELL': '/bin/bash', 11:17:05 INFO - 'SHLVL': '1', 11:17:05 INFO - 'TERM': 'linux', 11:17:05 INFO - 'TMOUT': '86400', 11:17:05 INFO - 'USER': 'cltbld', 11:17:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', 11:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:05 INFO - '_': '/tools/buildbot/bin/python'} 11:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:05 INFO - Downloading/unpacking jsonschema 11:17:05 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 11:17:05 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 11:17:05 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 11:17:05 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 11:17:05 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 11:17:05 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 11:17:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:07 INFO - Downloading/unpacking functools32 (from jsonschema) 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:07 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:07 INFO - warning: no files found matching '*.txt' 11:17:07 INFO - no previously-included directories found matching 'build' 11:17:07 INFO - no previously-included directories found matching 'dist' 11:17:07 INFO - no previously-included directories found matching '.git*' 11:17:07 INFO - Installing collected packages: jsonschema, functools32 11:17:07 INFO - Running setup.py install for functools32 11:17:08 INFO - warning: no files found matching '*.txt' 11:17:08 INFO - no previously-included directories found matching 'build' 11:17:08 INFO - no previously-included directories found matching 'dist' 11:17:08 INFO - no previously-included directories found matching '.git*' 11:17:08 INFO - Successfully installed jsonschema functools32 11:17:08 INFO - Cleaning up... 11:17:08 INFO - Return code: 0 11:17:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:08 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 0x7fabd923cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd810>, '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 0x13fe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13feba0>, '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': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', '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 11:17:08 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 11:17:08 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 11:17:08 INFO - Using env: {'DISPLAY': ':0', 11:17:08 INFO - 'HOME': '/home/cltbld', 11:17:08 INFO - 'LANG': 'en_US.UTF-8', 11:17:08 INFO - 'LANGUAGE': 'en_US:en', 11:17:08 INFO - 'LOGNAME': 'cltbld', 11:17:08 INFO - 'MAIL': '/var/mail/cltbld', 11:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:08 INFO - 'MOZ_NO_REMOTE': '1', 11:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:08 INFO - 'NO_EM_RESTART': '1', 11:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:08 INFO - 'PWD': '/builds/slave/test', 11:17:08 INFO - 'SHELL': '/bin/bash', 11:17:08 INFO - 'SHLVL': '1', 11:17:08 INFO - 'TERM': 'linux', 11:17:08 INFO - 'TMOUT': '86400', 11:17:08 INFO - 'USER': 'cltbld', 11:17:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', 11:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:08 INFO - '_': '/tools/buildbot/bin/python'} 11:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:08 INFO - Downloading/unpacking flake8 11:17:08 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 11:17:08 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 11:17:08 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 11:17:08 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 11:17:08 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 11:17:08 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 11:17:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:17:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:17:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:17:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:10 INFO - no previously-included directories found matching 'docs/_build' 11:17:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:17:10 INFO - Running setup.py install for pep8 11:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:11 INFO - no previously-included directories found matching 'docs/_build' 11:17:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:17:11 INFO - Cleaning up... 11:17:11 INFO - Return code: 0 11:17:11 INFO - Running post-action listener: _resource_record_post_action 11:17:11 INFO - Running post-action listener: _start_resource_monitoring 11:17:11 INFO - Starting resource monitoring. 11:17:11 INFO - ##### 11:17:11 INFO - ##### Running install step. 11:17:11 INFO - ##### 11:17:11 INFO - Running pre-action listener: _resource_record_pre_action 11:17:11 INFO - Running main action method: install 11:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:11 INFO - Reading from file tmpfile_stdout 11:17:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:11 INFO - Reading from file tmpfile_stdout 11:17:11 INFO - Output received: 11:17:11 INFO - Usage: mozinstall [options] installer 11:17:11 INFO - Options: 11:17:11 INFO - -h, --help show this help message and exit 11:17:11 INFO - -d DEST, --destination=DEST 11:17:11 INFO - Directory to install application into. [default: 11:17:11 INFO - "/builds/slave/test"] 11:17:11 INFO - --app=APP Application being installed. [default: firefox] 11:17:11 INFO - mkdir: /builds/slave/test/build/application 11:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:17:28 INFO - Reading from file tmpfile_stdout 11:17:28 INFO - Output received: 11:17:28 INFO - /builds/slave/test/build/application/firefox/firefox 11:17:28 INFO - Running post-action listener: _resource_record_post_action 11:17:28 INFO - ##### 11:17:28 INFO - ##### Running run-tests step. 11:17:28 INFO - ##### 11:17:28 INFO - Running pre-action listener: _resource_record_pre_action 11:17:28 INFO - Running main action method: run_tests 11:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:28 INFO - Python 2.7.3 11:17:28 INFO - Return code: 0 11:17:28 INFO - grabbing minidump binary from tooltool 11:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:28 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 0x13fd810>, '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 0x13fe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13feba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:28 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 11:17:28 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 11:17:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:28 INFO - Return code: 0 11:17:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:17:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:17:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:17:29 INFO - Return code: 0 11:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:17:29 INFO - Using env: {'DISPLAY': ':0', 11:17:29 INFO - 'HOME': '/home/cltbld', 11:17:29 INFO - 'LANG': 'en_US.UTF-8', 11:17:29 INFO - 'LANGUAGE': 'en_US:en', 11:17:29 INFO - 'LOGNAME': 'cltbld', 11:17:29 INFO - 'MAIL': '/var/mail/cltbld', 11:17:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:29 INFO - 'MOZ_NO_REMOTE': '1', 11:17:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:29 INFO - 'NO_EM_RESTART': '1', 11:17:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:29 INFO - 'PWD': '/builds/slave/test', 11:17:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:29 INFO - 'SHELL': '/bin/bash', 11:17:29 INFO - 'SHLVL': '1', 11:17:29 INFO - 'TERM': 'linux', 11:17:29 INFO - 'TMOUT': '86400', 11:17:29 INFO - 'USER': 'cltbld', 11:17:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261', 11:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:29 INFO - '_': '/tools/buildbot/bin/python'} 11:17:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:17:29 INFO - mozversion application_buildid: 20160416083214 11:17:29 INFO - mozversion application_changeset: abe15212891c03d58bee30a6ec38e89bcb4abef3 11:17:29 INFO - mozversion application_display_name: Nightly 11:17:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:29 INFO - mozversion application_name: Firefox 11:17:29 INFO - mozversion application_remotingname: firefox 11:17:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:17:29 INFO - mozversion application_vendor: Mozilla 11:17:29 INFO - mozversion application_version: 48.0a1 11:17:29 INFO - mozversion platform_buildid: 20160416083214 11:17:29 INFO - mozversion platform_changeset: abe15212891c03d58bee30a6ec38e89bcb4abef3 11:17:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:17:29 INFO - mozversion platform_version: 48.0a1 11:17:29 INFO - using testdate: 1460830649 11:17:29 INFO - actual date: 1460830649 11:17:29 INFO - starting webserver on 'localhost:43896' 11:17:29 INFO - SUITE-START | Running 2 tests 11:17:29 INFO - TEST-START | dromaeo_css 11:17:29 INFO - operating with platform_type : linux_ 11:17:29 INFO - Initialising browser for dromaeo_css test... 11:17:29 INFO - TEST-INFO | started process 3324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GoKVx/profile http://localhost:43896/getInfo.html) 11:17:35 INFO - PROCESS | 3324 | __metrics Screen width/height:1600/1200 11:17:35 INFO - PROCESS | 3324 | colorDepth:24 11:17:35 INFO - PROCESS | 3324 | Browser inner width/height: 1024/697 11:17:35 INFO - PROCESS | 3324 | __metrics 11:17:37 ERROR - PROCESS | 3324 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:17:37 INFO - TEST-INFO | 3324: exit 0 11:17:37 INFO - Browser initialized. 11:17:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:17:37 INFO - TEST-INFO | started process 3407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GoKVx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:49 INFO - PROCESS | 3407 | RSS: Main: 153473024 11:17:49 INFO - PROCESS | 3407 | 11:18:40 INFO - PROCESS | 3407 | 1460830720855 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] 11:20:48 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:43896/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43896/tests/dromaeo/cssquery-ext.html) 11:20:49 INFO - PROCESS | 3407 | RSS: Main: 241340416 11:20:49 INFO - PROCESS | 3407 | 11:23:52 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:43896/tests/dromaeo/cssquery-ext.html (next: http://localhost:43896/tests/dromaeo/cssquery-jquery.html) 11:23:52 INFO - PROCESS | 3407 | RSS: Main: 238919680 11:23:52 INFO - PROCESS | 3407 | 11:26:54 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:43896/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43896/tests/dromaeo/cssquery-mootools.html) 11:26:55 INFO - PROCESS | 3407 | RSS: Main: 241217536 11:26:55 INFO - PROCESS | 3407 | 11:29:57 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:43896/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43896/tests/dromaeo/cssquery-prototype.html) 11:29:57 INFO - PROCESS | 3407 | RSS: Main: 241197056 11:29:57 INFO - PROCESS | 3407 | 11:33:00 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:43896/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43896/tests/dromaeo/cssquery-yui.html) 11:33:01 INFO - PROCESS | 3407 | RSS: Main: 226947072 11:33:01 INFO - PROCESS | 3407 | 11:36:03 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:43896/tests/dromaeo/cssquery-yui.html (next: http://localhost:43896/tests/dromaeo/cssquery-dojo.html) 11:36:03 INFO - PROCESS | 3407 | RSS: Main: 264708096 11:36:03 INFO - PROCESS | 3407 | 11:36:03 INFO - PROCESS | 3407 | __start_tp_report 11:36:03 INFO - PROCESS | 3407 | _x_x_mozilla_page_load 11:36:03 INFO - PROCESS | 3407 | _x_x_mozilla_page_load_details 11:36:03 INFO - PROCESS | 3407 | |i|pagename|runs| 11:36:03 INFO - PROCESS | 3407 | |0;dojo.html;3055.938881222375;3084.1518582389854;3116.1897906544305;3119.610048743907;3150.68493150685;5269.130593452085;5319.335083114611;5322.2282768998475;5341.439148889364;5354.063038968179;5368.1679339702405;5417.945820541793;5434.755436005379;5439.3200849893765;5468.945310546894;4769.761511924407;4840.104580652591;4876.804927802901;4927.6797008194535;4971.627127965399;4904.337914381566;4909.877253068684;4929.630277729167;4943;4944.2089265717495;4739.92890106647;4862.708237505761;4895.632827537931;4900.313956046157;4970.204767237261;4859.368282123337;4876.683015603974;4882.194437917739;4886;4914.090893184736;4813.470518242991;4837.129316722989;4861.513848615145;4870.707757534524;4913.06651736169;5224.791008359661;5248.816291429782;5293.57651387888;5324.227986941911;5344.625876188668;5669.773209071632;5694.800681976152;5698.601097923147;5699.145128230757;5705.087186050212;5606.159076138611;5729.4843464088435;5732.799352022701;5734.799282025151;5737.655740655532;5289.973550132263;5320.52115309624;5327.3074500314715;5359.517643412111;5370.033393989081;5843.9773039717875;5847.38602446737;5850.063989761617;5850.5612079094235;5898.292204935349;5418.647787893774;5603.271574695264;5619.241402410704;5619.381867994517;5621.072523033654;5675.3757086720425;5706.115552089433;5725.227094342294;5729.427057294237;5777.104548794943;5626.774929002876;5636.605437619327;5659.971700141556;5668.319801623749;5689.061304884731;5474.863128421821;5674.460926212003;5694.572907031989;5695.686737229409;5752.050911599623;4280.336547835091;4292.12011537634;4298.032942587893;4325.978370108192;4338.522762496123;3838.808059597009;3842.3083844907624;3852;3870.4000879863665;3875.9612403876163;5228.163493841043;5303.0719624066405;5319.015982043335;5351.785928562814;5427.0773968425465;5736.340320863071;5754.539636829044;5766.971165144148;5772.278465191851;5796.768129274866;5379.973100134474;5381.54256888161;5384.353877534721;5388.353397592314;5395.244665746799;4555.316702494586;4650.093231819763;4701.27130294798;4708.270218116198;4762.571368576775;5814.854628634318;5901.557383196277;5905.557083218776;5916.497097746654;5955.464008239279;5697.287839020122;5727.140928860705;5742.626729262584;5760.337561180518;5765.221695071112;5789.3921138279875;5841.269841269841;5896.587238893237;5923.585349025527;5949.8215053548465;5610.831675049755;5653.745581448927;5656.60403771732;5657.321121465286;5676.2337084493065;5692.260006199168;5729.885402292014;5747.48272655463;5766.538676905753;5772;5337.466253374787;5579.8047068354035;5604.8318550443555;5664.0371136906;5676.233708449472;5531.778728850801;5544.362398324244;5544.417836127149;5559.972200139136;5565.499105080562;5340.225667278145;5454.972725136349;5482.479164479368;5485.61600687948;5520.558355331644;5580.804671836466;5589.077802162597;5604.523615492729;5629.183768353484;5635.549156067586;5521.475459831309;5522.2544956431975;5526.640768350045;5527.917081243865;5547.611667183259 11:36:03 INFO - PROCESS | 3407 | |1;ext.html;642.0593830038991;643.9678016099194;647.2588885725844;651.5113664751436;652.9878688033547;36184.457233141526;37383.62616373836;37421.62578374219;37438.25123497529;37530.81234593827;43439.3484097738;44171.337429938576;44210.55789442104;44381;44451.333230001575;8574.914250857506;8759.386842920998;8766.649334026662;8789.47263164209;8791.780205494882;8601.053884072748;8706.172913573231;8716.433431826943;8717.476951382938;8720.040795512488;8730.825383492327;8796.69211577595;8804.20762131408;8812.691555795549;8814;8665.870011949826;8731.214190722865;8735.519546424945;8735.737927862174;8746.212840844355;8592.5703714814;8696.78258043554;8703.782405439852;8705.173008564176;8707.259882909897;39158.216835663414;39644.20711585752;39780;39827.8008609958;39917.60082399168;3579.2304654499408;3681.5766186888313;3866.149447121629;3997.2405243003736;4022.35642297231;30170.547441788392;30286.242843928856;30529.23676908073;31096;32204;4338.262495375762;4345.804438800262;4349.586789255016;4419.204543182226;4430.977845110786;283806;285369;285645;285793.5710321456;286704;55144.724276379166;55187;55442.44557554373;55589.722051389486;55600.721996390566;51673;58011.70994145087;58887.41112588819;60367;60576;16335.26491307894;16580.336786528405;16585.419510317082;16595.751063734053;16598.25307861149;11708.70728231801;13133.934330328479;13250.867491324963;13261.535846245335;13274.269915154566;15556.377744890304;15687.72527983436;16049.358025678843;16084;16098.597535061483;6237.563370564108;6259.342769009279;6271.749130034747;6427.742890284337;6430.7106180222;1039.812833689943;1052.8894466081103;1084.9566017359375;1099.0493223361893;1158.3860553906443;30489.695103048685;32099;32106;32527.837360813046;32929.67070329314;1053.7945100705442;1085.0180586569168;1094.7482079121846;1115.715492549411;1183.6567395455393;14589.854101459061;15512.37950481968;17105.572360690832;17986.91006544959;18000.459986200436;394958;399383;399893;401278;402930;55073.724631376586;55308.44691553113;55403;55412.16881746777;55527.72236138793;1179.5281887245171;1244.794608889523;1345.1323896087165;1410.75311820431;1470.9338079786435;27587.724122758515;29407.264818378855;30777;31082.378352433276;31594.684053159173;42996.14007719891;43349.56650433455;43506.782466088735;43561.34657980196;43634.56365436305;261492;263801;263805;264174;264625;22536.66195007109;26749.732502674724;27613.585796213476;27644.58533122045;27649.308767280978;39448.802755986035;47517.52482475269;48594;48956.2656560159;49737.502624973284;34605.48091778575;34802.477962830075;35088.64911350854;35128.82435587806;35562.64437355697;34409.65590344165;34773.82613086919;35273.47089793604;36441;38531.61468385392;39101;39157.804210978764;39601.207975840895;39802;40015;33129.83435082809;33647.15882102967;34039.149021274665;34870;34970.650293497754;26800.195994120208;27985.860070699517;28899.133026009255;30857.69142308638;30935.845320773253 11:36:03 INFO - PROCESS | 3407 | |2;jquery.html;385.63557438220874;389.12252869778644;393.07234925575654;403.119184581689;408.07774429788685;14139.434422623108;14575.489857854976;16749.83250167498;17514.91242543787;17548.473545793615;17504.21231044603;17755.46733597991;17920.910395448005;17930.551736206602;18713.90643046786;5576.776928922848;5625.634333768312;5707.800226992056;5771.509421699139;5773.1917531545405;5482.150266708666;5661.122526008476;5679.602427830054;5705.087186050233;5708.657480551159;5282.709450980214;5635.3801081881165;5642.463965923231;5646.802361917334;5650.152477128443;5457.181422786574;5457.263269458612;5466.562674985991;5480.177973304017;5483.698396588186;4843.297721830315;5196.454372290893;5315.73421328932;5323.1749078892835;5325.20121981702;12362.44369003397;12434.37828108591;12557.372131393393;12560.246385216917;15201.543953681297;2143.9142434302607;2180.6510958246763;2254.9098036078535;2286.1998300594823;2332.696749422581;9197;9259.398139120936;9701.417914925056;10641.414722190353;13331.266780327078;1871.1953859840264;1900.2968901506392;1921.750172477583;1948.6102779444168;1969.3402710091993;76214.61892690556;79000.60499697522;79736.20263797346;79767;79796;10696.679099627023;10715.732106697238;11233.382163980896;11430.540366436464;11657.53369865196;14987.625309367135;14989.925050374679;15085.849141508665;15089.24553772307;15101.546953591409;7667.463277570517;7868.763937081897;7922.286994170552;8022.518648881086;8055.113937466874;7370.815729606803;7485.887711684329;7557.886631700529;7577.962110189524;7801.1667258194275;4533.84131555394;4627.6529260305615;4643.303504474356;4713.269443236304;4717.268823332389;1909.961800763977;1921.9711704324445;1924.3745782620704;1957.412776167144;1979.1687491253708;870.5821205821114;920.5903372999085;944.9527523623791;997.5162046407487;1023.6059117239917;17732.11339433023;18274.26902923895;18574.349897753513;18878.24487020504;19031.714524282146;961.5721004153085;986.5708416838698;999.8450240212778;1017.2167431078028;1034.9896501034893;9834.93604146078;10215;10397.688069357931;10452.268341216042;10546.261761676762;364275;369270;373509;376006;462986;52509.737451312496;53191.01067419881;55084.72457637686;84566;91252;1029.7940411917646;1054.4306074719566;1070.550368845087;1095.2442814457997;1099.378850949211;11938.64184074479;15474.381024758884;16349.83650163483;16858.325666973185;17139;38906.80546597249;39778.40332395074;40074;40224.1955160901;40863;49217.75391123021;49959.25061124159;54923;56986.580805151825;58371;7330.890036649561;7429.33136017761;7446.292602202782;7751.8837217442915;8154.633041513265;10421.68734937953;11342.149338799458;11534.13493987971;11543;11596.478158483058;10060.547275372772;10477.633282835064;10619.840702389625;10883.510242038968;10981.505832237408;10400.167986561208;10419.426931518536;10452;10773.730656733644;10834.620788272372;10108.595656173671;10127.848082278624;10347.43089130105;10583;10882.94558527234;7449.553026818408;7762.728304509315;7868.763937081897;7970.561619111005;8133.79665508367;9270.53647317618;9416;10022.799544009225;10026.548805303924;10279 11:36:03 INFO - PROCESS | 3407 | |3;mootools.html;1289.9419526121324;1415.2711353652867;1468.6328417895527;1550.155165434838;1703.684818308613;7040.084788977432;8197;8322.79193020174;8358.83282334353;8391.832163356728;8163.551004694754;8279.627416766245;8296.460730052557;8319;8328.91671083289;1984.7122167285736;2031.8476114291414;2249.201533455624;2250.8987095580737;2275.0899640143907;2307.9192228272013;2330.1960823515947;2330.463993281546;2333.101755824003;2333.2533589251448;2273.8521996070285;2276.157821606008;2309.145616122037;2310.676505289261;2313.421644588853;1937.6609093408597;1988.2245924089543;2179.1719146724304;2214.2250212425683;2278.2823410625765;2281.828862835294;2302.067662596651;2305.1470955746313;2307.953840923189;2308.56137333906;7971.681132754683;8019.639116239783;8020.518768873886;8039;8043.839123217562;4714.57568818808;4867.099586576494;4870.707757534559;4895.902081958341;4915.090708218991;3146.465100932824;3193.9361212775616;3271.574695289621;3293.0450169450833;3293.2919422324076;1056.862607860981;1062.654637242899;1081.6376513867863;1087.0922779479145;1091.6779550032759;11162.888371116265;11224.102071834233;11230.606928757454;11231.21381503287;11234.21360504765;4249.723767955073;4375.759333236702;4525.932111018337;4548.6133678637025;4551.522090180483;9488.430694158373;9508.857367139499;9534.475603841855;9552.570134343832;9555.283353748497;5093.286939828427;5102.158143906214;5114.43741188469;5132.820351287687;5137.486251374833;4077.6330130288416;4614.353990441341;4730.053989202104;4737.431508219036;4750.477447480775;3849.2109117630816;3872.128771026553;3983.9203215935518;3988.361862102108;4000.5199376075057;1189.2804853063944;1201.0271679939276;1220.2190598017276;1258.0627432562617;1267.88589026988;952.0812416018575;963.710886733977;964.6720115160879;974.4007435427161;989.4854675568807;5378.838634840961;5399.919001214985;5441.6190866639745;5452.890942181134;5732.3121225453215;916.2166347772692;945.2768631996528;971.6113554578226;1012.9493525323704;1019.4800651667703;3930.901727456779;4060.0661847774586;4064.166845796605;4100.097978444737;4131.731437456556;9913.75215619601;10097.596096156218;10426.478676066166;10434.37393756377;10532.631357902437;10364.429956352322;10465.319754215952;10641.5211315491;10754.408507532004;10764.40795756241;7536.0956685198125;7562.319391254813;7734.651940662684;7762.029746281715;7769.572673503011;5383.838484845461;5459.590530710292;5461.208124821799;5549.667019978814;5640.379558248507;9312.813743725223;9350.812983740423;9386.436813791195;9498.810023799348;9503.904960950578;9197.77005574866;9474.621015159591;9501.04989501072;9517.048295170705;9568.091031352289;6427.228732552124;6829.760958366433;7140.964295178491;7191.71233150689;7239.457040721862;8193.59032048407;8195.180481951757;8232.917670823215;8262.17378262169;8265.586720663823;7247.782566523013;7268.309510596485;7459.142198647225;7549.886751698838;7577.5453472791805;7236.927630723625;7385.409167266714;7431.256874312526;7433.25667433274;7525.397968162643;6717.361850624183;6808.38724514796;6819;6822.931770682229;6828.214755303204;4964;4980.850574482772;5124.359455068116;5181.06740786662;5181.3005244291535;5092.592592592658;5147.382314122329;5182.637215394886;5251.186066159751;5282.2604835323855 11:36:03 INFO - PROCESS | 3407 | |4;prototype.html;308.68668301673796;308.8779931926889;318.7832274053644;325.7133722324354;329.40706727889807;5543.140813173959;5572.080606699889;5633.070543360346;5646.092262484824;5667.829965101043;5535.58483113767;5554.611177217596;5561.416051314604;5576.247206627104;5578.30271216098;4016.8393264269466;4179.582041795811;4339.088791353819;4353.41228934093;4353.651707863363;4294.119705460389;4336.761478118702;4354.368616550598;4354.47746270448;4365.432493775805;4003.9799801000954;4278.844711927778;4322.82708691652;4335.978320108395;4336.934945975813;3968.8610898618554;4087.264292427362;4340.934885976713;4354.063876266586;4355.085432059272;3808.257389808988;3812.80935953204;3820.4269359596005;3838.6161383861668;3842.4812650292133;5345.09133447311;5395.595330350239;5396.1905714143195;5409.6213265071465;5464.972675136639;4962.900741985176;4963.45402005779;4966.627502937295;4981.37732783402;5006.874828129289;5742.28221472316;5759.913601295984;5774.364819869811;5781.508571771405;5820.272465941757;4090.7750073745933;4176.227397931392;4181.205570941542;4186.079062606222;4188.937165942513;6066.815946259343;6083.361247069082;6094.6952652367645;6104;6112.755489780404;4273.893152671146;4278.614924656796;4289.571042895685;4295.269804133305;4304.935425968613;4235.30117530604;4315.6763242756915;4338.761368124783;4358.4769827620885;4363.847265345697;4990.600751939836;4998.6500944933505;4998.850034498971;5002.624803139779;5004.324416203839;5885;5903.498202652737;5909.113632955091;5925.644461332334;5936.940630593639;1462.6928345047659;1489.9851001490063;1513.6291608555973;1515.2878147270765;1518.772184172361;886.1138861138861;998.8601595776597;1018.1396719771781;1038.937663740178;1047.5233768635253;5549.667019978814;5616.5787565932715;5623.718814059281;5652.971735141298;5661.631993920382;5973.850653733604;5978.252718410199;5985.311689155803;6013.849653758691;6027.095935609606;5546.145428926857;5627.52166065889;5665.6034077614995;5668.26312579362;5706.400827913092;3186.203449137716;3210.7431405487973;3228.451163302197;3231.6122065352306;3238.951415728766;6065.181200537959;6132.50939924805;6198.256209254918;6203.193584834033;6225.688715564203;6062.605930614584;6071.423214794588;6084.087386891913;6117.174181485442;6135.478484328882;6118.816435506942;6167.537434692416;6177.139287945034;6190.226221722285;6198.659073750987;5830.2129212555765;5994.400559943971;6016.4585187331595;6033.487153591994;6037.396260373927;5879.441453061952;5933.080372542263;5938.257717785277;5943.881122377615;5950.940490595039;6004.939950600613;6180.876382472416;6197.783077592263;6204.3795620437595;6215.627062376272;4291.656667466657;4317.0934103838545;4318.654507639319;4320.200762858881;4324.870253892388;5999.970000149971;6012.1582978382185;6014.368491308524;6015.428534289235;6027.558838670346;5654.6324488908085;5845.473907348359;5903.26209223847;5942.227510423617;5972.34304226526;5906.4093590642315;5910.734016969161;5922.407759224216;5927.347991720821;5946.759016336021;5506.394296627448;5662.943370566241;5793.246877906014;5823.505002074871;5867.706614669335;5936.8812623748145;5973.940260597338;5988.8802223956145;5990.603758496636;6012.278526576839;5855.473007429352;5859.794907178229;5881.7647294107755;5887.52899768009;5895.67573783446 11:36:03 INFO - PROCESS | 3407 | |5;yui.html;728.3626826526789;736.8946580129806;746.9141048779389;789.3487872505183;813.2761841960653;11692.181547291693;11939.701507462318;11950.880491195085;11970.700732481682;12063.819042714365;11545.942270288637;12344.93827530861;13048.804267935988;13050.869491305084;13051.673708157301;655.2922843329217;779.777763337449;796.3151689547;798.1619299735283;803.2609998801117;797.1629788721848;805.3275514945028;805.613305613303;805.6535689653447;805.9838803223932;826.8718348655938;837.9874301885477;838.3460900497622;839.3872473094614;839.4291881520563;688.9069975553336;819.5287709566963;828.1180542721982;833.9499630022218;836.7615229659579;612.3845535237102;614.8094090831812;617.5615313127685;618.4434009391539;618.780332981794;11459.083273338112;11481.770364592661;11513.884861151366;11516.25144365622;11517.942410287978;13426.597202083953;13861.306934653328;13932.164070155823;14028;14084.647883802987;11129.888701112966;11155.163362747746;11226;11357.488912998851;11392.487338069806;3816.122291872857;3827.5789663137034;3829.349010668193;3900.8244628991765;3900.8829735107706;60680.393196068355;61354.69322653403;61829.381706182816;61940.380596193914;62207;11129.554817807359;11213.66359009231;11270.492827822767;11285.43572821372;11456.427178641035;19154.71267930982;19221.231150753814;19237.326693565657;19260.614787704166;20080.297189598296;8031.237032481905;8269.421140520106;8441.662333506714;8451.746447606582;8530.274926631306;4539.409876716006;4592.88517787058;4598.3102534620075;4647.651426143053;4697.765111744399;3198.9360212795614;3277.6558461361215;3283.9819655906745;3305.4380755271663;3308.4871844864083;564.6499170514307;582.6445868020504;586.589387428793;594.5808205215313;598.9850253743604;550.3423409026256;625.1810128731377;648.3581254557954;650.6453982579505;709.5529816215751;8523.147685231552;8735.30117590604;8784.671097138733;8842.602082906285;8972.775680608038;654.1300070905684;705.3193668110298;742.4580056558742;755.5768769488993;776.3633820267327;3998.0804414984136;4015.3976903464713;4084;4089.672826173899;4154.750714957112;58517;61107.6944615283;61561;63761.36238637647;64440.35559644437;51983.48016519862;53610.7319463408;53755.462445375044;55128;60050;53122.468775312525;53620.19569706458;53891.46108538943;54700.72649636806;56554.7172264136;8925.107489251022;8945.19493245585;9014.368994170345;9016.639334426549;9070.365074444726;30081.69918300789;33193.83403082969;33241.83379083089;33361.49957750587;34088.48867266943;40506.79746601366;42113.45374014285;42451;42529.787351063045;43285.3507197386;11515.769684606428;11562.826557601475;11606;11693.123015774021;11725.589604363806;12323.938380308042;12495;12698.746025079261;12865.228086314852;12957.740845182854;12002.519899203933;12066.939665301617;12117.15179937396;12172.2696638202;12372.505099795908;11917.582884598998;12008.039356851606;12012.099092567918;12021.639350819489;12182.634520964386;10876.293040952312;10877.510512027136;11351.432428378714;11566.884331156918;12008.699782505159;10370.585176592851;10373.325733827278;10373.481325933522;10472.528736206737;10617.840732388866;10085.767396428639;10206.948965255424;10293.53679084458;10321.122704570196;10441.582336706446 11:36:03 INFO - PROCESS | 3407 | __end_tp_report 11:36:03 INFO - PROCESS | 3407 | __start_cc_report 11:36:03 INFO - PROCESS | 3407 | _x_x_mozilla_cycle_collect,810 11:36:03 INFO - PROCESS | 3407 | __end_cc_report 11:36:03 INFO - PROCESS | 3407 | __startTimestamp1460831763687__endTimestamp 11:36:03 INFO - PROCESS | 3407 | 11:36:03 INFO - PROCESS | 3407 | ------- Summary: start ------- 11:36:03 INFO - PROCESS | 3407 | Number of tests: 6 11:36:03 INFO - PROCESS | 3407 | 11:36:03 INFO - PROCESS | 3407 | [#0] dojo.html Cycles:165 Average:5294.16 Median:5520.56 stddev:607.86 (11.0%) stddev-sans-first:583.81 11:36:03 INFO - PROCESS | 3407 | Values: 3055.9 3084.2 3116.2 3119.6 3150.7 5269.1 5319.3 5322.2 5341.4 5354.1 5368.2 5417.9 5434.8 5439.3 5468.9 4769.8 4840.1 4876.8 4927.7 4971.6 4904.3 4909.9 4929.6 4943.0 4944.2 4739.9 4862.7 4895.6 4900.3 4970.2 4859.4 4876.7 4882.2 4886.0 4914.1 4813.5 4837.1 4861.5 4870.7 4913.1 5224.8 5248.8 5293.6 5324.2 5344.6 5669.8 5694.8 5698.6 5699.1 5705.1 5606.2 5729.5 5732.8 5734.8 5737.7 5290.0 5320.5 5327.3 5359.5 5370.0 5844.0 5847.4 5850.1 5850.6 5898.3 5418.6 5603.3 5619.2 5619.4 5621.1 5675.4 5706.1 5725.2 5729.4 5777.1 5626.8 5636.6 5660.0 5668.3 5689.1 5474.9 5674.5 5694.6 5695.7 5752.1 4280.3 4292.1 4298.0 4326.0 4338.5 3838.8 3842.3 3852.0 3870.4 3876.0 5228.2 5303.1 5319.0 5351.8 5427.1 5736.3 5754.5 5767.0 5772.3 5796.8 5380.0 5381.5 5384.4 5388.4 5395.2 4555.3 4650.1 4701.3 4708.3 4762.6 5814.9 5901.6 5905.6 5916.5 5955.5 5697.3 5727.1 5742.6 5760.3 5765.2 5789.4 5841.3 5896.6 5923.6 5949.8 5610.8 5653.7 5656.6 5657.3 5676.2 5692.3 5729.9 5747.5 5766.5 5772.0 5337.5 5579.8 5604.8 5664.0 5676.2 5531.8 5544.4 5544.4 5560.0 5565.5 5340.2 5455.0 5482.5 5485.6 5520.6 5580.8 5589.1 5604.5 5629.2 5635.5 5521.5 5522.3 5526.6 5527.9 5547.6 11:36:03 INFO - PROCESS | 3407 | 11:36:03 INFO - PROCESS | 3407 | [#1] ext.html Cycles:180 Average:48501.37 Median:38031.21 stddev:84504.42 (222.2%) stddev-sans-first:84665.08 11:36:03 INFO - PROCESS | 3407 | Values: 642.1 644.0 647.3 651.5 653.0 36184.5 37383.6 37421.6 37438.3 37530.8 43439.3 44171.3 44210.6 44381.0 44451.3 8574.9 8759.4 8766.6 8789.5 8791.8 8601.1 8706.2 8716.4 8717.5 8720.0 8730.8 8796.7 8804.2 8812.7 8814.0 8665.9 8731.2 8735.5 8735.7 8746.2 8592.6 8696.8 8703.8 8705.2 8707.3 39158.2 39644.2 39780.0 39827.8 39917.6 3579.2 3681.6 3866.1 3997.2 4022.4 30170.5 30286.2 30529.2 31096.0 32204.0 4338.3 4345.8 4349.6 4419.2 4431.0 283806.0 285369.0 285645.0 285793.6 286704.0 55144.7 55187.0 55442.4 55589.7 55600.7 51673.0 58011.7 58887.4 60367.0 60576.0 16335.3 16580.3 16585.4 16595.8 16598.3 11708.7 13133.9 13250.9 13261.5 13274.3 15556.4 15687.7 16049.4 16084.0 16098.6 6237.6 6259.3 6271.7 6427.7 6430.7 1039.8 1052.9 1085.0 1099.0 1158.4 30489.7 32099.0 32106.0 32527.8 32929.7 1053.8 1085.0 1094.7 1115.7 1183.7 14589.9 15512.4 17105.6 17986.9 18000.5 394958.0 399383.0 399893.0 401278.0 402930.0 55073.7 55308.4 55403.0 55412.2 55527.7 1179.5 1244.8 1345.1 1410.8 1470.9 27587.7 29407.3 30777.0 31082.4 31594.7 42996.1 43349.6 43506.8 43561.3 43634.6 261492.0 263801.0 263805.0 264174.0 264625.0 22536.7 26749.7 27613.6 27644.6 27649.3 39448.8 47517.5 48594.0 48956.3 49737.5 34605.5 34802.5 35088.6 35128.8 35562.6 34409.7 34773.8 35273.5 36441.0 38531.6 39101.0 39157.8 39601.2 39802.0 40015.0 33129.8 33647.2 34039.1 34870.0 34970.7 26800.2 27985.9 28899.1 30857.7 30935.8 11:36:03 INFO - PROCESS | 3407 | 11:36:03 INFO - PROCESS | 3407 | [#2] jquery.html Cycles:180 Average:24519.49 Median:188195.82 stddev:64660.06 (34.4%) stddev-sans-first:64816.06 11:36:03 INFO - PROCESS | 3407 | Values: 385.6 389.1 393.1 403.1 408.1 14139.4 14575.5 16749.8 17514.9 17548.5 17504.2 17755.5 17920.9 17930.6 18713.9 5576.8 5625.6 5707.8 5771.5 5773.2 5482.2 5661.1 5679.6 5705.1 5708.7 5282.7 5635.4 5642.5 5646.8 5650.2 5457.2 5457.3 5466.6 5480.2 5483.7 4843.3 5196.5 5315.7 5323.2 5325.2 12362.4 12434.4 12557.4 12560.2 15201.5 2143.9 2180.7 2254.9 2286.2 2332.7 9197.0 9259.4 9701.4 10641.4 13331.3 1871.2 1900.3 1921.8 1948.6 1969.3 76214.6 79000.6 79736.2 79767.0 79796.0 10696.7 10715.7 11233.4 11430.5 11657.5 14987.6 14989.9 15085.8 15089.2 15101.5 7667.5 7868.8 7922.3 8022.5 8055.1 7370.8 7485.9 7557.9 7578.0 7801.2 4533.8 4627.7 4643.3 4713.3 4717.3 1910.0 1922.0 1924.4 1957.4 1979.2 870.6 920.6 945.0 997.5 1023.6 17732.1 18274.3 18574.3 18878.2 19031.7 961.6 986.6 999.8 1017.2 1035.0 9834.9 10215.0 10397.7 10452.3 10546.3 364275.0 369270.0 373509.0 376006.0 462986.0 52509.7 53191.0 55084.7 84566.0 91252.0 1029.8 1054.4 1070.6 1095.2 1099.4 11938.6 15474.4 16349.8 16858.3 17139.0 38906.8 39778.4 40074.0 40224.2 40863.0 49217.8 49959.3 54923.0 56986.6 58371.0 7330.9 7429.3 7446.3 7751.9 8154.6 10421.7 11342.1 11534.1 11543.0 11596.5 10060.5 10477.6 10619.8 10883.5 10981.5 10400.2 10419.4 10452.0 10773.7 10834.6 10108.6 10127.8 10347.4 10583.0 10882.9 7449.6 7762.7 7868.8 7970.6 8133.8 9270.5 9416.0 10022.8 10026.5 10279.0 11:36:03 INFO - PROCESS | 3407 | 11:36:03 INFO - PROCESS | 3407 | [#3] mootools.html Cycles:180 Average:5493.42 Median:5108.30 stddev:3053.67 (59.8%) stddev-sans-first:3045.89 11:36:03 INFO - PROCESS | 3407 | Values: 1289.9 1415.3 1468.6 1550.2 1703.7 7040.1 8197.0 8322.8 8358.8 8391.8 8163.6 8279.6 8296.5 8319.0 8328.9 1984.7 2031.8 2249.2 2250.9 2275.1 2307.9 2330.2 2330.5 2333.1 2333.3 2273.9 2276.2 2309.1 2310.7 2313.4 1937.7 1988.2 2179.2 2214.2 2278.3 2281.8 2302.1 2305.1 2308.0 2308.6 7971.7 8019.6 8020.5 8039.0 8043.8 4714.6 4867.1 4870.7 4895.9 4915.1 3146.5 3193.9 3271.6 3293.0 3293.3 1056.9 1062.7 1081.6 1087.1 1091.7 11162.9 11224.1 11230.6 11231.2 11234.2 4249.7 4375.8 4525.9 4548.6 4551.5 9488.4 9508.9 9534.5 9552.6 9555.3 5093.3 5102.2 5114.4 5132.8 5137.5 4077.6 4614.4 4730.1 4737.4 4750.5 3849.2 3872.1 3983.9 3988.4 4000.5 1189.3 1201.0 1220.2 1258.1 1267.9 952.1 963.7 964.7 974.4 989.5 5378.8 5399.9 5441.6 5452.9 5732.3 916.2 945.3 971.6 1012.9 1019.5 3930.9 4060.1 4064.2 4100.1 4131.7 9913.8 10097.6 10426.5 10434.4 10532.6 10364.4 10465.3 10641.5 10754.4 10764.4 7536.1 7562.3 7734.7 7762.0 7769.6 5383.8 5459.6 5461.2 5549.7 5640.4 9312.8 9350.8 9386.4 9498.8 9503.9 9197.8 9474.6 9501.0 9517.0 9568.1 6427.2 6829.8 7141.0 7191.7 7239.5 8193.6 8195.2 8232.9 8262.2 8265.6 7247.8 7268.3 7459.1 7549.9 7577.5 7236.9 7385.4 7431.3 7433.3 7525.4 6717.4 6808.4 6819.0 6822.9 6828.2 4964.0 4980.9 5124.4 5181.1 5181.3 5092.6 5147.4 5182.6 5251.2 5282.3 11:36:03 INFO - PROCESS | 3407 | 11:36:03 INFO - PROCESS | 3407 | [#4] prototype.html Cycles:180 Average:4930.46 Median:5630.30 stddev:1459.34 (25.9%) stddev-sans-first:1421.60 11:36:03 INFO - PROCESS | 3407 | Values: 308.7 308.9 318.8 325.7 329.4 5543.1 5572.1 5633.1 5646.1 5667.8 5535.6 5554.6 5561.4 5576.2 5578.3 4016.8 4179.6 4339.1 4353.4 4353.7 4294.1 4336.8 4354.4 4354.5 4365.4 4004.0 4278.8 4322.8 4336.0 4336.9 3968.9 4087.3 4340.9 4354.1 4355.1 3808.3 3812.8 3820.4 3838.6 3842.5 5345.1 5395.6 5396.2 5409.6 5465.0 4962.9 4963.5 4966.6 4981.4 5006.9 5742.3 5759.9 5774.4 5781.5 5820.3 4090.8 4176.2 4181.2 4186.1 4188.9 6066.8 6083.4 6094.7 6104.0 6112.8 4273.9 4278.6 4289.6 4295.3 4304.9 4235.3 4315.7 4338.8 4358.5 4363.8 4990.6 4998.7 4998.9 5002.6 5004.3 5885.0 5903.5 5909.1 5925.6 5936.9 1462.7 1490.0 1513.6 1515.3 1518.8 886.1 998.9 1018.1 1038.9 1047.5 5549.7 5616.6 5623.7 5653.0 5661.6 5973.9 5978.3 5985.3 6013.8 6027.1 5546.1 5627.5 5665.6 5668.3 5706.4 3186.2 3210.7 3228.5 3231.6 3239.0 6065.2 6132.5 6198.3 6203.2 6225.7 6062.6 6071.4 6084.1 6117.2 6135.5 6118.8 6167.5 6177.1 6190.2 6198.7 5830.2 5994.4 6016.5 6033.5 6037.4 5879.4 5933.1 5938.3 5943.9 5950.9 6004.9 6180.9 6197.8 6204.4 6215.6 4291.7 4317.1 4318.7 4320.2 4324.9 6000.0 6012.2 6014.4 6015.4 6027.6 5654.6 5845.5 5903.3 5942.2 5972.3 5906.4 5910.7 5922.4 5927.3 5946.8 5506.4 5662.9 5793.2 5823.5 5867.7 5936.9 5973.9 5988.9 5990.6 6012.3 5855.5 5859.8 5881.8 5887.5 5895.7 11:36:03 INFO - PROCESS | 3407 | 11:36:03 INFO - PROCESS | 3407 | [#5] yui.html Cycles:180 Average:14681.02 Median:23134.10 stddev:17679.38 (76.4%) stddev-sans-first:17697.93 11:36:03 INFO - PROCESS | 3407 | Values: 728.4 736.9 746.9 789.3 813.3 11692.2 11939.7 11950.9 11970.7 12063.8 11545.9 12344.9 13048.8 13050.9 13051.7 655.3 779.8 796.3 798.2 803.3 797.2 805.3 805.6 805.7 806.0 826.9 838.0 838.3 839.4 839.4 688.9 819.5 828.1 833.9 836.8 612.4 614.8 617.6 618.4 618.8 11459.1 11481.8 11513.9 11516.3 11517.9 13426.6 13861.3 13932.2 14028.0 14084.6 11129.9 11155.2 11226.0 11357.5 11392.5 3816.1 3827.6 3829.3 3900.8 3900.9 60680.4 61354.7 61829.4 61940.4 62207.0 11129.6 11213.7 11270.5 11285.4 11456.4 19154.7 19221.2 19237.3 19260.6 20080.3 8031.2 8269.4 8441.7 8451.7 8530.3 4539.4 4592.9 4598.3 4647.7 4697.8 3198.9 3277.7 3284.0 3305.4 3308.5 564.6 582.6 586.6 594.6 599.0 550.3 625.2 648.4 650.6 709.6 8523.1 8735.3 8784.7 8842.6 8972.8 654.1 705.3 742.5 755.6 776.4 3998.1 4015.4 4084.0 4089.7 4154.8 58517.0 61107.7 61561.0 63761.4 64440.4 51983.5 53610.7 53755.5 55128.0 60050.0 53122.5 53620.2 53891.5 54700.7 56554.7 8925.1 8945.2 9014.4 9016.6 9070.4 30081.7 33193.8 33241.8 33361.5 34088.5 40506.8 42113.5 42451.0 42529.8 43285.4 11515.8 11562.8 11606.0 11693.1 11725.6 12323.9 12495.0 12698.7 12865.2 12957.7 12002.5 12066.9 12117.2 12172.3 12372.5 11917.6 12008.0 12012.1 12021.6 12182.6 10876.3 10877.5 11351.4 11566.9 12008.7 10370.6 10373.3 10373.5 10472.5 10617.8 10085.8 10206.9 10293.5 10321.1 10441.6 11:36:03 INFO - PROCESS | 3407 | -------- Summary: end -------- 11:36:03 INFO - PROCESS | 3407 | 11:36:04 INFO - TEST-INFO | 3407: exit 0 11:36:04 INFO - TEST-OK | dromaeo_css | took 1114656ms 11:36:04 INFO - TEST-START | kraken 11:36:04 INFO - operating with platform_type : linux_ 11:36:04 INFO - Initialising browser for kraken test... 11:36:04 INFO - TEST-INFO | started process 3589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpObuLAP/profile http://localhost:43896/getInfo.html) 11:36:08 INFO - PROCESS | 3589 | __metrics Screen width/height:1600/1200 11:36:08 INFO - PROCESS | 3589 | colorDepth:24 11:36:08 INFO - PROCESS | 3589 | Browser inner width/height: 1024/697 11:36:08 INFO - PROCESS | 3589 | __metrics 11:36:09 ERROR - PROCESS | 3589 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:36:10 INFO - TEST-INFO | 3589: exit 0 11:36:10 INFO - Browser initialized. 11:36:10 INFO - Running cycle 1/1 for kraken test... 11:36:10 INFO - TEST-INFO | started process 3671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpObuLAP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:22 INFO - PROCESS | 3671 | RSS: Main: 153108480 11:36:22 INFO - PROCESS | 3671 | 11:36:24 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43896/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:25 INFO - PROCESS | 3671 | RSS: Main: 208211968 11:36:25 INFO - PROCESS | 3671 | 11:36:28 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43896/tests/kraken/driver.html?testName=audio-dft) 11:36:29 INFO - PROCESS | 3671 | RSS: Main: 194342912 11:36:29 INFO - PROCESS | 3671 | 11:36:32 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43896/tests/kraken/driver.html?testName=audio-fft) 11:36:32 INFO - PROCESS | 3671 | RSS: Main: 264900608 11:36:32 INFO - PROCESS | 3671 | 11:36:34 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43896/tests/kraken/driver.html?testName=audio-oscillator) 11:36:35 INFO - PROCESS | 3671 | RSS: Main: 173084672 11:36:35 INFO - PROCESS | 3671 | 11:36:37 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43896/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:36:38 INFO - PROCESS | 3671 | RSS: Main: 176857088 11:36:38 INFO - PROCESS | 3671 | 11:36:41 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43896/tests/kraken/driver.html?testName=imaging-darkroom) 11:36:41 INFO - PROCESS | 3671 | RSS: Main: 213241856 11:36:41 INFO - PROCESS | 3671 | 11:36:45 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43896/tests/kraken/driver.html?testName=imaging-desaturate) 11:36:45 INFO - PROCESS | 3671 | RSS: Main: 213831680 11:36:45 INFO - PROCESS | 3671 | 11:36:48 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43896/tests/kraken/driver.html?testName=json-parse-financial) 11:36:49 INFO - PROCESS | 3671 | RSS: Main: 214175744 11:36:49 INFO - PROCESS | 3671 | 11:36:50 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43896/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:51 INFO - PROCESS | 3671 | RSS: Main: 202960896 11:36:51 INFO - PROCESS | 3671 | 11:36:52 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43896/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:36:53 INFO - PROCESS | 3671 | RSS: Main: 203599872 11:36:53 INFO - PROCESS | 3671 | 11:36:55 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43896/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:36:56 INFO - PROCESS | 3671 | RSS: Main: 217202688 11:36:56 INFO - PROCESS | 3671 | 11:36:58 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:59 INFO - PROCESS | 3671 | RSS: Main: 222818304 11:36:59 INFO - PROCESS | 3671 | 11:37:02 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:03 INFO - PROCESS | 3671 | RSS: Main: 217276416 11:37:03 INFO - PROCESS | 3671 | 11:37:04 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:43896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43896/tests/kraken/driver.html?testName=ai-astar) 11:37:05 INFO - PROCESS | 3671 | RSS: Main: 281198592 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | __start_tp_report 11:37:05 INFO - PROCESS | 3671 | _x_x_mozilla_page_load 11:37:05 INFO - PROCESS | 3671 | _x_x_mozilla_page_load_details 11:37:05 INFO - PROCESS | 3671 | |i|pagename|runs| 11:37:05 INFO - PROCESS | 3671 | |0;ai-astar;110;111;105;110;111;112;99;110;110;113 11:37:05 INFO - PROCESS | 3671 | |1;audio-beat-detection;150;127;152;201;130;154;155;136;188;128 11:37:05 INFO - PROCESS | 3671 | |2;audio-dft;161;164;160;160;160;161;162;160;161;161 11:37:05 INFO - PROCESS | 3671 | |3;audio-fft;75;76;112;103;77;72;73;127;102;77 11:37:05 INFO - PROCESS | 3671 | |4;audio-oscillator;91;92;162;93;93;92;157;92;93;143 11:37:05 INFO - PROCESS | 3671 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;117 11:37:05 INFO - PROCESS | 3671 | |6;imaging-darkroom;145;146;144;145;145;145;145;145;145;145 11:37:05 INFO - PROCESS | 3671 | |7;imaging-desaturate;95;95;95;95;94;95;94;94;95;94 11:37:05 INFO - PROCESS | 3671 | |8;json-parse-financial;55;56;56;55;55;56;56;71;53;54 11:37:05 INFO - PROCESS | 3671 | |9;json-stringify-tinderbox;67;61;62;60;60;61;61;60;62;61 11:37:05 INFO - PROCESS | 3671 | |10;stanford-crypto-aes;77;75;84;74;76;75;76;76;76;76 11:37:05 INFO - PROCESS | 3671 | |11;stanford-crypto-ccm;128;132;125;126;123;121;122;120;155;127 11:37:05 INFO - PROCESS | 3671 | |12;stanford-crypto-pbkdf2;165;166;162;160;164;169;163;163;164;165 11:37:05 INFO - PROCESS | 3671 | |13;stanford-crypto-sha256-iterative;68;68;70;67;68;66;67;66;67;68 11:37:05 INFO - PROCESS | 3671 | __end_tp_report 11:37:05 INFO - PROCESS | 3671 | __start_cc_report 11:37:05 INFO - PROCESS | 3671 | _x_x_mozilla_cycle_collect,1618 11:37:05 INFO - PROCESS | 3671 | __end_cc_report 11:37:05 INFO - PROCESS | 3671 | __startTimestamp1460831825133__endTimestamp 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | ------- Summary: start ------- 11:37:05 INFO - PROCESS | 3671 | Number of tests: 14 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:4.12 (3.7%) stddev-sans-first:4.36 11:37:05 INFO - PROCESS | 3671 | Values: 110.0 111.0 105.0 110.0 111.0 112.0 99.0 110.0 110.0 113.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:153.00 stddev:25.07 (16.4%) stddev-sans-first:26.58 11:37:05 INFO - PROCESS | 3671 | Values: 150.0 127.0 152.0 201.0 130.0 154.0 155.0 136.0 188.0 128.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 11:37:05 INFO - PROCESS | 3671 | Values: 161.0 164.0 160.0 160.0 160.0 161.0 162.0 160.0 161.0 161.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#3] audio-fft Cycles:10 Average:89.40 Median:74.00 stddev:19.82 (26.8%) stddev-sans-first:20.32 11:37:05 INFO - PROCESS | 3671 | Values: 75.0 76.0 112.0 103.0 77.0 72.0 73.0 127.0 102.0 77.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:92.00 stddev:30.18 (32.8%) stddev-sans-first:31.14 11:37:05 INFO - PROCESS | 3671 | Values: 91.0 92.0 162.0 93.0 93.0 92.0 157.0 92.0 93.0 143.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:37:05 INFO - PROCESS | 3671 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 11:37:05 INFO - PROCESS | 3671 | Values: 145.0 146.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:37:05 INFO - PROCESS | 3671 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:5.12 (9.1%) stddev-sans-first:5.40 11:37:05 INFO - PROCESS | 3671 | Values: 55.0 56.0 56.0 55.0 55.0 56.0 56.0 71.0 53.0 54.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:2.07 (3.4%) stddev-sans-first:0.78 11:37:05 INFO - PROCESS | 3671 | Values: 67.0 61.0 62.0 60.0 60.0 61.0 61.0 60.0 62.0 61.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.00 stddev:2.76 (3.6%) stddev-sans-first:2.92 11:37:05 INFO - PROCESS | 3671 | Values: 77.0 75.0 84.0 74.0 76.0 75.0 76.0 76.0 76.0 76.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:126.50 stddev:10.18 (8.0%) stddev-sans-first:10.80 11:37:05 INFO - PROCESS | 3671 | Values: 128.0 132.0 125.0 126.0 123.0 121.0 122.0 120.0 155.0 127.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.50 stddev:2.42 (1.5%) stddev-sans-first:2.55 11:37:05 INFO - PROCESS | 3671 | Values: 165.0 166.0 162.0 160.0 164.0 169.0 163.0 163.0 164.0 165.0 11:37:05 INFO - PROCESS | 3671 | 11:37:05 INFO - PROCESS | 3671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.18 (1.7%) stddev-sans-first:1.24 11:37:05 INFO - PROCESS | 3671 | Values: 68.0 68.0 70.0 67.0 68.0 66.0 67.0 66.0 67.0 68.0 11:37:05 INFO - PROCESS | 3671 | -------- Summary: end -------- 11:37:05 INFO - PROCESS | 3671 | 11:37:06 INFO - TEST-INFO | 3671: exit 0 11:37:06 INFO - TEST-OK | kraken | took 61673ms 11:37:06 INFO - SUITE-END | took 1176s 11:37:06 INFO - Completed test suite (00:19:36) 11:37:06 INFO - javascript benchmark 11:37:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3055.938881222375, 3084.1518582389854, 3116.1897906544305, 3119.610048743907, 3150.68493150685, 5269.130593452085, 5319.335083114611, 5322.2282768998475, 5341.439148889364, 5354.063038968179, 5368.1679339702405, 5417.945820541793, 5434.755436005379, 5439.3200849893765, 5468.945310546894, 4769.761511924407, 4840.104580652591, 4876.804927802901, 4927.6797008194535, 4971.627127965399, 4904.337914381566, 4909.877253068684, 4929.630277729167, 4943.0, 4944.2089265717495, 4739.92890106647, 4862.708237505761, 4895.632827537931, 4900.313956046157, 4970.204767237261, 4859.368282123337, 4876.683015603974, 4882.194437917739, 4886.0, 4914.090893184736, 4813.470518242991, 4837.129316722989, 4861.513848615145, 4870.707757534524, 4913.06651736169, 5224.791008359661, 5248.816291429782, 5293.57651387888, 5324.227986941911, 5344.625876188668, 5669.773209071632, 5694.800681976152, 5698.601097923147, 5699.145128230757, 5705.087186050212, 5606.159076138611, 5729.4843464088435, 5732.799352022701, 5734.799282025151, 5737.655740655532, 5289.973550132263, 5320.52115309624, 5327.3074500314715, 5359.517643412111, 5370.033393989081, 5843.9773039717875, 5847.38602446737, 5850.063989761617, 5850.5612079094235, 5898.292204935349, 5418.647787893774, 5603.271574695264, 5619.241402410704, 5619.381867994517, 5621.072523033654, 5675.3757086720425, 5706.115552089433, 5725.227094342294, 5729.427057294237, 5777.104548794943, 5626.774929002876, 5636.605437619327, 5659.971700141556, 5668.319801623749, 5689.061304884731, 5474.863128421821, 5674.460926212003, 5694.572907031989, 5695.686737229409, 5752.050911599623, 4280.336547835091, 4292.12011537634, 4298.032942587893, 4325.978370108192, 4338.522762496123, 3838.808059597009, 3842.3083844907624, 3852.0, 3870.4000879863665, 3875.9612403876163, 5228.163493841043, 5303.0719624066405, 5319.015982043335, 5351.785928562814, 5427.0773968425465, 5736.340320863071, 5754.539636829044, 5766.971165144148, 5772.278465191851, 5796.768129274866, 5379.973100134474, 5381.54256888161, 5384.353877534721, 5388.353397592314, 5395.244665746799, 4555.316702494586, 4650.093231819763, 4701.27130294798, 4708.270218116198, 4762.571368576775, 5814.854628634318, 5901.557383196277, 5905.557083218776, 5916.497097746654, 5955.464008239279, 5697.287839020122, 5727.140928860705, 5742.626729262584, 5760.337561180518, 5765.221695071112, 5789.3921138279875, 5841.269841269841, 5896.587238893237, 5923.585349025527, 5949.8215053548465, 5610.831675049755, 5653.745581448927, 5656.60403771732, 5657.321121465286, 5676.2337084493065, 5692.260006199168, 5729.885402292014, 5747.48272655463, 5766.538676905753, 5772.0, 5337.466253374787, 5579.8047068354035, 5604.8318550443555, 5664.0371136906, 5676.233708449472, 5531.778728850801, 5544.362398324244, 5544.417836127149, 5559.972200139136, 5565.499105080562, 5340.225667278145, 5454.972725136349, 5482.479164479368, 5485.61600687948, 5520.558355331644, 5580.804671836466, 5589.077802162597, 5604.523615492729, 5629.183768353484, 5635.549156067586, 5521.475459831309, 5522.2544956431975, 5526.640768350045, 5527.917081243865, 5547.611667183259], "value": 5252.787045747762, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.0593830038991, 643.9678016099194, 647.2588885725844, 651.5113664751436, 652.9878688033547, 36184.457233141526, 37383.62616373836, 37421.62578374219, 37438.25123497529, 37530.81234593827, 43439.3484097738, 44171.337429938576, 44210.55789442104, 44381.0, 44451.333230001575, 8574.914250857506, 8759.386842920998, 8766.649334026662, 8789.47263164209, 8791.780205494882, 8601.053884072748, 8706.172913573231, 8716.433431826943, 8717.476951382938, 8720.040795512488, 8730.825383492327, 8796.69211577595, 8804.20762131408, 8812.691555795549, 8814.0, 8665.870011949826, 8731.214190722865, 8735.519546424945, 8735.737927862174, 8746.212840844355, 8592.5703714814, 8696.78258043554, 8703.782405439852, 8705.173008564176, 8707.259882909897, 39158.216835663414, 39644.20711585752, 39780.0, 39827.8008609958, 39917.60082399168, 3579.2304654499408, 3681.5766186888313, 3866.149447121629, 3997.2405243003736, 4022.35642297231, 30170.547441788392, 30286.242843928856, 30529.23676908073, 31096.0, 32204.0, 4338.262495375762, 4345.804438800262, 4349.586789255016, 4419.204543182226, 4430.977845110786, 283806.0, 285369.0, 285645.0, 285793.5710321456, 286704.0, 55144.724276379166, 55187.0, 55442.44557554373, 55589.722051389486, 55600.721996390566, 51673.0, 58011.70994145087, 58887.41112588819, 60367.0, 60576.0, 16335.26491307894, 16580.336786528405, 16585.419510317082, 16595.751063734053, 16598.25307861149, 11708.70728231801, 13133.934330328479, 13250.867491324963, 13261.535846245335, 13274.269915154566, 15556.377744890304, 15687.72527983436, 16049.358025678843, 16084.0, 16098.597535061483, 6237.563370564108, 6259.342769009279, 6271.749130034747, 6427.742890284337, 6430.7106180222, 1039.812833689943, 1052.8894466081103, 1084.9566017359375, 1099.0493223361893, 1158.3860553906443, 30489.695103048685, 32099.0, 32106.0, 32527.837360813046, 32929.67070329314, 1053.7945100705442, 1085.0180586569168, 1094.7482079121846, 1115.715492549411, 1183.6567395455393, 14589.854101459061, 15512.37950481968, 17105.572360690832, 17986.91006544959, 18000.459986200436, 394958.0, 399383.0, 399893.0, 401278.0, 402930.0, 55073.724631376586, 55308.44691553113, 55403.0, 55412.16881746777, 55527.72236138793, 1179.5281887245171, 1244.794608889523, 1345.1323896087165, 1410.75311820431, 1470.9338079786435, 27587.724122758515, 29407.264818378855, 30777.0, 31082.378352433276, 31594.684053159173, 42996.14007719891, 43349.56650433455, 43506.782466088735, 43561.34657980196, 43634.56365436305, 261492.0, 263801.0, 263805.0, 264174.0, 264625.0, 22536.66195007109, 26749.732502674724, 27613.585796213476, 27644.58533122045, 27649.308767280978, 39448.802755986035, 47517.52482475269, 48594.0, 48956.2656560159, 49737.502624973284, 34605.48091778575, 34802.477962830075, 35088.64911350854, 35128.82435587806, 35562.64437355697, 34409.65590344165, 34773.82613086919, 35273.47089793604, 36441.0, 38531.61468385392, 39101.0, 39157.804210978764, 39601.207975840895, 39802.0, 40015.0, 33129.83435082809, 33647.15882102967, 34039.149021274665, 34870.0, 34970.650293497754, 26800.195994120208, 27985.860070699517, 28899.133026009255, 30857.69142308638, 30935.845320773253], "value": 18881.198012131816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.63557438220874, 389.12252869778644, 393.07234925575654, 403.119184581689, 408.07774429788685, 14139.434422623108, 14575.489857854976, 16749.83250167498, 17514.91242543787, 17548.473545793615, 17504.21231044603, 17755.46733597991, 17920.910395448005, 17930.551736206602, 18713.90643046786, 5576.776928922848, 5625.634333768312, 5707.800226992056, 5771.509421699139, 5773.1917531545405, 5482.150266708666, 5661.122526008476, 5679.602427830054, 5705.087186050233, 5708.657480551159, 5282.709450980214, 5635.3801081881165, 5642.463965923231, 5646.802361917334, 5650.152477128443, 5457.181422786574, 5457.263269458612, 5466.562674985991, 5480.177973304017, 5483.698396588186, 4843.297721830315, 5196.454372290893, 5315.73421328932, 5323.1749078892835, 5325.20121981702, 12362.44369003397, 12434.37828108591, 12557.372131393393, 12560.246385216917, 15201.543953681297, 2143.9142434302607, 2180.6510958246763, 2254.9098036078535, 2286.1998300594823, 2332.696749422581, 9197.0, 9259.398139120936, 9701.417914925056, 10641.414722190353, 13331.266780327078, 1871.1953859840264, 1900.2968901506392, 1921.750172477583, 1948.6102779444168, 1969.3402710091993, 76214.61892690556, 79000.60499697522, 79736.20263797346, 79767.0, 79796.0, 10696.679099627023, 10715.732106697238, 11233.382163980896, 11430.540366436464, 11657.53369865196, 14987.625309367135, 14989.925050374679, 15085.849141508665, 15089.24553772307, 15101.546953591409, 7667.463277570517, 7868.763937081897, 7922.286994170552, 8022.518648881086, 8055.113937466874, 7370.815729606803, 7485.887711684329, 7557.886631700529, 7577.962110189524, 7801.1667258194275, 4533.84131555394, 4627.6529260305615, 4643.303504474356, 4713.269443236304, 4717.268823332389, 1909.961800763977, 1921.9711704324445, 1924.3745782620704, 1957.412776167144, 1979.1687491253708, 870.5821205821114, 920.5903372999085, 944.9527523623791, 997.5162046407487, 1023.6059117239917, 17732.11339433023, 18274.26902923895, 18574.349897753513, 18878.24487020504, 19031.714524282146, 961.5721004153085, 986.5708416838698, 999.8450240212778, 1017.2167431078028, 1034.9896501034893, 9834.93604146078, 10215.0, 10397.688069357931, 10452.268341216042, 10546.261761676762, 364275.0, 369270.0, 373509.0, 376006.0, 462986.0, 52509.737451312496, 53191.01067419881, 55084.72457637686, 84566.0, 91252.0, 1029.7940411917646, 1054.4306074719566, 1070.550368845087, 1095.2442814457997, 1099.378850949211, 11938.64184074479, 15474.381024758884, 16349.83650163483, 16858.325666973185, 17139.0, 38906.80546597249, 39778.40332395074, 40074.0, 40224.1955160901, 40863.0, 49217.75391123021, 49959.25061124159, 54923.0, 56986.580805151825, 58371.0, 7330.890036649561, 7429.33136017761, 7446.292602202782, 7751.8837217442915, 8154.633041513265, 10421.68734937953, 11342.149338799458, 11534.13493987971, 11543.0, 11596.478158483058, 10060.547275372772, 10477.633282835064, 10619.840702389625, 10883.510242038968, 10981.505832237408, 10400.167986561208, 10419.426931518536, 10452.0, 10773.730656733644, 10834.620788272372, 10108.595656173671, 10127.848082278624, 10347.43089130105, 10583.0, 10882.94558527234, 7449.553026818408, 7762.728304509315, 7868.763937081897, 7970.561619111005, 8133.79665508367, 9270.53647317618, 9416.0, 10022.799544009225, 10026.548805303924, 10279.0], "value": 8525.636891231408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.9419526121324, 1415.2711353652867, 1468.6328417895527, 1550.155165434838, 1703.684818308613, 7040.084788977432, 8197.0, 8322.79193020174, 8358.83282334353, 8391.832163356728, 8163.551004694754, 8279.627416766245, 8296.460730052557, 8319.0, 8328.91671083289, 1984.7122167285736, 2031.8476114291414, 2249.201533455624, 2250.8987095580737, 2275.0899640143907, 2307.9192228272013, 2330.1960823515947, 2330.463993281546, 2333.101755824003, 2333.2533589251448, 2273.8521996070285, 2276.157821606008, 2309.145616122037, 2310.676505289261, 2313.421644588853, 1937.6609093408597, 1988.2245924089543, 2179.1719146724304, 2214.2250212425683, 2278.2823410625765, 2281.828862835294, 2302.067662596651, 2305.1470955746313, 2307.953840923189, 2308.56137333906, 7971.681132754683, 8019.639116239783, 8020.518768873886, 8039.0, 8043.839123217562, 4714.57568818808, 4867.099586576494, 4870.707757534559, 4895.902081958341, 4915.090708218991, 3146.465100932824, 3193.9361212775616, 3271.574695289621, 3293.0450169450833, 3293.2919422324076, 1056.862607860981, 1062.654637242899, 1081.6376513867863, 1087.0922779479145, 1091.6779550032759, 11162.888371116265, 11224.102071834233, 11230.606928757454, 11231.21381503287, 11234.21360504765, 4249.723767955073, 4375.759333236702, 4525.932111018337, 4548.6133678637025, 4551.522090180483, 9488.430694158373, 9508.857367139499, 9534.475603841855, 9552.570134343832, 9555.283353748497, 5093.286939828427, 5102.158143906214, 5114.43741188469, 5132.820351287687, 5137.486251374833, 4077.6330130288416, 4614.353990441341, 4730.053989202104, 4737.431508219036, 4750.477447480775, 3849.2109117630816, 3872.128771026553, 3983.9203215935518, 3988.361862102108, 4000.5199376075057, 1189.2804853063944, 1201.0271679939276, 1220.2190598017276, 1258.0627432562617, 1267.88589026988, 952.0812416018575, 963.710886733977, 964.6720115160879, 974.4007435427161, 989.4854675568807, 5378.838634840961, 5399.919001214985, 5441.6190866639745, 5452.890942181134, 5732.3121225453215, 916.2166347772692, 945.2768631996528, 971.6113554578226, 1012.9493525323704, 1019.4800651667703, 3930.901727456779, 4060.0661847774586, 4064.166845796605, 4100.097978444737, 4131.731437456556, 9913.75215619601, 10097.596096156218, 10426.478676066166, 10434.37393756377, 10532.631357902437, 10364.429956352322, 10465.319754215952, 10641.5211315491, 10754.408507532004, 10764.40795756241, 7536.0956685198125, 7562.319391254813, 7734.651940662684, 7762.029746281715, 7769.572673503011, 5383.838484845461, 5459.590530710292, 5461.208124821799, 5549.667019978814, 5640.379558248507, 9312.813743725223, 9350.812983740423, 9386.436813791195, 9498.810023799348, 9503.904960950578, 9197.77005574866, 9474.621015159591, 9501.04989501072, 9517.048295170705, 9568.091031352289, 6427.228732552124, 6829.760958366433, 7140.964295178491, 7191.71233150689, 7239.457040721862, 8193.59032048407, 8195.180481951757, 8232.917670823215, 8262.17378262169, 8265.586720663823, 7247.782566523013, 7268.309510596485, 7459.142198647225, 7549.886751698838, 7577.5453472791805, 7236.927630723625, 7385.409167266714, 7431.256874312526, 7433.25667433274, 7525.397968162643, 6717.361850624183, 6808.38724514796, 6819.0, 6822.931770682229, 6828.214755303204, 4964.0, 4980.850574482772, 5124.359455068116, 5181.06740786662, 5181.3005244291535, 5092.592592592658, 5147.382314122329, 5182.637215394886, 5251.186066159751, 5282.2604835323855], "value": 4437.521205397426, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.68668301673796, 308.8779931926889, 318.7832274053644, 325.7133722324354, 329.40706727889807, 5543.140813173959, 5572.080606699889, 5633.070543360346, 5646.092262484824, 5667.829965101043, 5535.58483113767, 5554.611177217596, 5561.416051314604, 5576.247206627104, 5578.30271216098, 4016.8393264269466, 4179.582041795811, 4339.088791353819, 4353.41228934093, 4353.651707863363, 4294.119705460389, 4336.761478118702, 4354.368616550598, 4354.47746270448, 4365.432493775805, 4003.9799801000954, 4278.844711927778, 4322.82708691652, 4335.978320108395, 4336.934945975813, 3968.8610898618554, 4087.264292427362, 4340.934885976713, 4354.063876266586, 4355.085432059272, 3808.257389808988, 3812.80935953204, 3820.4269359596005, 3838.6161383861668, 3842.4812650292133, 5345.09133447311, 5395.595330350239, 5396.1905714143195, 5409.6213265071465, 5464.972675136639, 4962.900741985176, 4963.45402005779, 4966.627502937295, 4981.37732783402, 5006.874828129289, 5742.28221472316, 5759.913601295984, 5774.364819869811, 5781.508571771405, 5820.272465941757, 4090.7750073745933, 4176.227397931392, 4181.205570941542, 4186.079062606222, 4188.937165942513, 6066.815946259343, 6083.361247069082, 6094.6952652367645, 6104.0, 6112.755489780404, 4273.893152671146, 4278.614924656796, 4289.571042895685, 4295.269804133305, 4304.935425968613, 4235.30117530604, 4315.6763242756915, 4338.761368124783, 4358.4769827620885, 4363.847265345697, 4990.600751939836, 4998.6500944933505, 4998.850034498971, 5002.624803139779, 5004.324416203839, 5885.0, 5903.498202652737, 5909.113632955091, 5925.644461332334, 5936.940630593639, 1462.6928345047659, 1489.9851001490063, 1513.6291608555973, 1515.2878147270765, 1518.772184172361, 886.1138861138861, 998.8601595776597, 1018.1396719771781, 1038.937663740178, 1047.5233768635253, 5549.667019978814, 5616.5787565932715, 5623.718814059281, 5652.971735141298, 5661.631993920382, 5973.850653733604, 5978.252718410199, 5985.311689155803, 6013.849653758691, 6027.095935609606, 5546.145428926857, 5627.52166065889, 5665.6034077614995, 5668.26312579362, 5706.400827913092, 3186.203449137716, 3210.7431405487973, 3228.451163302197, 3231.6122065352306, 3238.951415728766, 6065.181200537959, 6132.50939924805, 6198.256209254918, 6203.193584834033, 6225.688715564203, 6062.605930614584, 6071.423214794588, 6084.087386891913, 6117.174181485442, 6135.478484328882, 6118.816435506942, 6167.537434692416, 6177.139287945034, 6190.226221722285, 6198.659073750987, 5830.2129212555765, 5994.400559943971, 6016.4585187331595, 6033.487153591994, 6037.396260373927, 5879.441453061952, 5933.080372542263, 5938.257717785277, 5943.881122377615, 5950.940490595039, 6004.939950600613, 6180.876382472416, 6197.783077592263, 6204.3795620437595, 6215.627062376272, 4291.656667466657, 4317.0934103838545, 4318.654507639319, 4320.200762858881, 4324.870253892388, 5999.970000149971, 6012.1582978382185, 6014.368491308524, 6015.428534289235, 6027.558838670346, 5654.6324488908085, 5845.473907348359, 5903.26209223847, 5942.227510423617, 5972.34304226526, 5906.4093590642315, 5910.734016969161, 5922.407759224216, 5927.347991720821, 5946.759016336021, 5506.394296627448, 5662.943370566241, 5793.246877906014, 5823.505002074871, 5867.706614669335, 5936.8812623748145, 5973.940260597338, 5988.8802223956145, 5990.603758496636, 6012.278526576839, 5855.473007429352, 5859.794907178229, 5881.7647294107755, 5887.52899768009, 5895.67573783446], "value": 4455.704034335425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.3626826526789, 736.8946580129806, 746.9141048779389, 789.3487872505183, 813.2761841960653, 11692.181547291693, 11939.701507462318, 11950.880491195085, 11970.700732481682, 12063.819042714365, 11545.942270288637, 12344.93827530861, 13048.804267935988, 13050.869491305084, 13051.673708157301, 655.2922843329217, 779.777763337449, 796.3151689547, 798.1619299735283, 803.2609998801117, 797.1629788721848, 805.3275514945028, 805.613305613303, 805.6535689653447, 805.9838803223932, 826.8718348655938, 837.9874301885477, 838.3460900497622, 839.3872473094614, 839.4291881520563, 688.9069975553336, 819.5287709566963, 828.1180542721982, 833.9499630022218, 836.7615229659579, 612.3845535237102, 614.8094090831812, 617.5615313127685, 618.4434009391539, 618.780332981794, 11459.083273338112, 11481.770364592661, 11513.884861151366, 11516.25144365622, 11517.942410287978, 13426.597202083953, 13861.306934653328, 13932.164070155823, 14028.0, 14084.647883802987, 11129.888701112966, 11155.163362747746, 11226.0, 11357.488912998851, 11392.487338069806, 3816.122291872857, 3827.5789663137034, 3829.349010668193, 3900.8244628991765, 3900.8829735107706, 60680.393196068355, 61354.69322653403, 61829.381706182816, 61940.380596193914, 62207.0, 11129.554817807359, 11213.66359009231, 11270.492827822767, 11285.43572821372, 11456.427178641035, 19154.71267930982, 19221.231150753814, 19237.326693565657, 19260.614787704166, 20080.297189598296, 8031.237032481905, 8269.421140520106, 8441.662333506714, 8451.746447606582, 8530.274926631306, 4539.409876716006, 4592.88517787058, 4598.3102534620075, 4647.651426143053, 4697.765111744399, 3198.9360212795614, 3277.6558461361215, 3283.9819655906745, 3305.4380755271663, 3308.4871844864083, 564.6499170514307, 582.6445868020504, 586.589387428793, 594.5808205215313, 598.9850253743604, 550.3423409026256, 625.1810128731377, 648.3581254557954, 650.6453982579505, 709.5529816215751, 8523.147685231552, 8735.30117590604, 8784.671097138733, 8842.602082906285, 8972.775680608038, 654.1300070905684, 705.3193668110298, 742.4580056558742, 755.5768769488993, 776.3633820267327, 3998.0804414984136, 4015.3976903464713, 4084.0, 4089.672826173899, 4154.750714957112, 58517.0, 61107.6944615283, 61561.0, 63761.36238637647, 64440.35559644437, 51983.48016519862, 53610.7319463408, 53755.462445375044, 55128.0, 60050.0, 53122.468775312525, 53620.19569706458, 53891.46108538943, 54700.72649636806, 56554.7172264136, 8925.107489251022, 8945.19493245585, 9014.368994170345, 9016.639334426549, 9070.365074444726, 30081.69918300789, 33193.83403082969, 33241.83379083089, 33361.49957750587, 34088.48867266943, 40506.79746601366, 42113.45374014285, 42451.0, 42529.787351063045, 43285.3507197386, 11515.769684606428, 11562.826557601475, 11606.0, 11693.123015774021, 11725.589604363806, 12323.938380308042, 12495.0, 12698.746025079261, 12865.228086314852, 12957.740845182854, 12002.519899203933, 12066.939665301617, 12117.15179937396, 12172.2696638202, 12372.505099795908, 11917.582884598998, 12008.039356851606, 12012.099092567918, 12021.639350819489, 12182.634520964386, 10876.293040952312, 10877.510512027136, 11351.432428378714, 11566.884331156918, 12008.699782505159, 10370.585176592851, 10373.325733827278, 10373.481325933522, 10472.528736206737, 10617.840732388866, 10085.767396428639, 10206.948965255424, 10293.53679084458, 10321.122704570196, 10441.582336706446], "value": 6516.178121398795, "unit": "score"}], "name": "dromaeo_css", "value": 6910.979015310359, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 105.0, 110.0, 111.0, 112.0, 99.0, 110.0, 110.0, 113.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 152.0, 201.0, 130.0, 154.0, 155.0, 136.0, 188.0, 128.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 160.0, 160.0, 160.0, 161.0, 162.0, 160.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 112.0, 103.0, 77.0, 72.0, 73.0, 127.0, 102.0, 77.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 162.0, 93.0, 93.0, 92.0, 157.0, 92.0, 93.0, 143.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 55.0, 56.0, 56.0, 71.0, 53.0, 54.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 61.0, 62.0, 60.0, 60.0, 61.0, 61.0, 60.0, 62.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 84.0, 74.0, 76.0, 75.0, 76.0, 76.0, 76.0, 76.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 132.0, 125.0, 126.0, 123.0, 121.0, 122.0, 120.0, 155.0, 127.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 162.0, 160.0, 164.0, 169.0, 163.0, 163.0, 164.0, 165.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 67.0, 68.0, 66.0, 67.0, 66.0, 67.0, 68.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1533.0, "alertThreshold": 2.0}]} 11:37:06 INFO - Return code: 0 11:37:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:37:06 ERROR - # TBPL SUCCESS # 11:37:06 INFO - Running post-action listener: _resource_record_post_action 11:37:06 INFO - Running post-run listener: _resource_record_post_run 11:37:07 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7802880; Write bytes: 435490816; Read time: 1940; Write time: 526872 11:37:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 10264576; Read time: 0; Write time: 12776 11:37:07 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 7802880; Write bytes: 402456576; Read time: 1940; Write time: 499004 11:37:07 INFO - Running post-run listener: _upload_blobber_files 11:37:07 INFO - Blob upload gear active. 11:37:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37: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 11:37: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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:37: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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:37:07 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:37:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:37:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:08 INFO - (blobuploader) - INFO - Done attempting. 11:37:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:37:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:37:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:09 INFO - (blobuploader) - INFO - Done attempting. 11:37:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:09 INFO - Return code: 0 11:37:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82033d9b435c80b4f5bfa5d9def36895c2ab6a63871d0fba8114c31b89031b271332e68e9dc90382362498533e603ece5e6ebb1bdcdf10a280d1e317baa951ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/701d346d0dc4eb1cefe69118462246383dab5e245749d016703503bfff302629a2c57254dd14243a68cd5a7aea4223ac70b6377aa3ddfc8ea57bc931684c949f"} 11:37:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:09 INFO - Contents: 11:37:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82033d9b435c80b4f5bfa5d9def36895c2ab6a63871d0fba8114c31b89031b271332e68e9dc90382362498533e603ece5e6ebb1bdcdf10a280d1e317baa951ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/701d346d0dc4eb1cefe69118462246383dab5e245749d016703503bfff302629a2c57254dd14243a68cd5a7aea4223ac70b6377aa3ddfc8ea57bc931684c949f"} 11:37:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:09 INFO - Copying logs to upload dir... 11:37:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.959944 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-16 11:37:09.453330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 11:37:09.456470) ========= 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=eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82033d9b435c80b4f5bfa5d9def36895c2ab6a63871d0fba8114c31b89031b271332e68e9dc90382362498533e603ece5e6ebb1bdcdf10a280d1e317baa951ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/701d346d0dc4eb1cefe69118462246383dab5e245749d016703503bfff302629a2c57254dd14243a68cd5a7aea4223ac70b6377aa3ddfc8ea57bc931684c949f"} build_url:https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/VpjGGumQR525rc6-i3-jSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82033d9b435c80b4f5bfa5d9def36895c2ab6a63871d0fba8114c31b89031b271332e68e9dc90382362498533e603ece5e6ebb1bdcdf10a280d1e317baa951ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/701d346d0dc4eb1cefe69118462246383dab5e245749d016703503bfff302629a2c57254dd14243a68cd5a7aea4223ac70b6377aa3ddfc8ea57bc931684c949f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 11:37:09.481177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 11:37:09.481494) ========= 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=eca2ab57546de7b41f256b19000001ef-1460828139.777267-1529939261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 11:37:09.565925) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 11:37:09.566243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 11:37:09.566531) ========= ========= Total master_lag: 0.18 =========