builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1461271096.64 results: success (0) buildid: 20160421130623 builduid: 80cedbe1cfe94b50bba3723e71cef2cd revision: b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.635605) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.636113) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.636405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.673811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.674337) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 13:38:16-- 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% 215M=0s 2016-04-21 13:38:16 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.223255 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.950770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:16.951116) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052455 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.015713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.016149) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 --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 b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 --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=5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 13:38:17,109 truncating revision to first 12 chars 2016-04-21 13:38:17,109 Setting DEBUG logging. 2016-04-21 13:38:17,109 attempt 1/10 2016-04-21 13:38:17,109 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b31b99289389?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 13:38:17,767 unpacking tar archive at: fx-team-b31b99289389/testing/mozharness/ program finished with exit code 0 elapsedTime=0.947539 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.976811) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.977144) ========= script_repo_revision: b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.977551) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.977819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 13:38:17.996252) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-21 13:38:17.996852) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:38:18 INFO - MultiFileLogger online at 20160421 13:38:18 in /builds/slave/test 13:38:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:38:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:38:18 INFO - {'append_to_log': False, 13:38:18 INFO - 'base_work_dir': '/builds/slave/test', 13:38:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:38:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:38:18 INFO - 'branch': 'Fx-Team-Non-PGO', 13:38:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:38:18 INFO - 'config_files': ('talos/linux_config.py',), 13:38:18 INFO - 'default_actions': ('clobber', 13:38:18 INFO - 'read-buildbot-config', 13:38:18 INFO - 'download-and-extract', 13:38:18 INFO - 'populate-webroot', 13:38:18 INFO - 'create-virtualenv', 13:38:18 INFO - 'install', 13:38:18 INFO - 'run-tests'), 13:38:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:38:18 INFO - 'download_minidump_stackwalk': True, 13:38:18 INFO - 'download_symbols': 'ondemand', 13:38:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:38:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:38:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:38:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:38:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:38:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:38:18 INFO - 'installer_path': 'installer.exe', 13:38:18 INFO - 'log_level': 'info', 13:38:18 INFO - 'log_name': 'talos', 13:38:18 INFO - 'log_to_console': True, 13:38:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:38:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:38:18 INFO - 'opt_config_files': (), 13:38:18 INFO - 'pip_index': False, 13:38:18 INFO - 'sps_profile': False, 13:38:18 INFO - 'sps_profile_interval': 0, 13:38:18 INFO - 'suite': 'dromaeojs-e10s', 13:38:18 INFO - 'system_bits': '32', 13:38:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:38:18 INFO - 'title': 'talos-linux64-ix-039', 13:38:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:38:18 INFO - 'use_talos_json': True, 13:38:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:38:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:38:18 INFO - 'work_dir': 'build'} 13:38:18 INFO - ##### 13:38:18 INFO - ##### Running clobber step. 13:38:18 INFO - ##### 13:38:18 INFO - Running pre-action listener: _resource_record_pre_action 13:38:18 INFO - Running main action method: clobber 13:38:18 INFO - rmtree: /builds/slave/test/build 13:38:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:38:21 INFO - Running post-action listener: _resource_record_post_action 13:38:21 INFO - ##### 13:38:21 INFO - ##### Running read-buildbot-config step. 13:38:21 INFO - ##### 13:38:21 INFO - Running pre-action listener: _resource_record_pre_action 13:38:21 INFO - Running main action method: read_buildbot_config 13:38:21 INFO - Using buildbot properties: 13:38:21 INFO - { 13:38:21 INFO - "project": "", 13:38:21 INFO - "product": "firefox", 13:38:21 INFO - "script_repo_revision": "production", 13:38:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:38:21 INFO - "repository": "", 13:38:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:38:21 INFO - "buildid": "20160421130623", 13:38:21 INFO - "pgo_build": "False", 13:38:21 INFO - "basedir": "/builds/slave/test", 13:38:21 INFO - "buildnumber": 1181, 13:38:21 INFO - "slavename": "talos-linux64-ix-039", 13:38:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:38:21 INFO - "platform": "ubuntu64_hw", 13:38:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:38:21 INFO - "branch": "fx-team", 13:38:21 INFO - "repo_path": "integration/fx-team", 13:38:21 INFO - "revision": "b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4", 13:38:21 INFO - "stage_platform": "linux64", 13:38:21 INFO - "builduid": "80cedbe1cfe94b50bba3723e71cef2cd", 13:38:21 INFO - "slavebuilddir": "test" 13:38:21 INFO - } 13:38:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:38:21 INFO - Running post-action listener: _resource_record_post_action 13:38:21 INFO - ##### 13:38:21 INFO - ##### Running download-and-extract step. 13:38:21 INFO - ##### 13:38:21 INFO - Running pre-action listener: _resource_record_pre_action 13:38:21 INFO - Running main action method: download_and_extract 13:38:21 INFO - mkdir: /builds/slave/test/build/tests 13:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:21 INFO - https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:38:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:38:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:38:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/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 13:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/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 13:38:27 INFO - Downloaded 1361 bytes. 13:38:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:38:27 INFO - Using the following test package requirements: 13:38:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:38:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:38:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:38:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:27 INFO - u'jsshell-linux-x86_64.zip'], 13:38:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:38:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:38:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:38:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:38:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:38:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:38:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:38:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:27 INFO - https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:38:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:38:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:38:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/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 13:38:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/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 13:38:43 INFO - Downloaded 22275480 bytes. 13:38:43 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'] 13:38:43 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 13:38:44 INFO - Return code: 0 13:38:44 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 13:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:44 INFO - https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:38:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:38:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:38:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/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 13:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/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 13:38:45 INFO - Downloaded 22275480 bytes. 13:38:45 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'] 13:38:45 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 13:38:47 INFO - Return code: 0 13:38: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')]} 13:38:47 INFO - https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:38:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:38:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:38:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/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 13:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/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 13:38:48 INFO - Downloaded 10845952 bytes. 13:38:48 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'] 13:38:48 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 13:38:48 INFO - Return code: 0 13:38: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')]} 13:38:48 INFO - https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:38:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:38:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:38:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/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 13:38:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/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 13:38:50 INFO - Downloaded 54622518 bytes. 13:38:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:38:50 INFO - mkdir: /builds/slave/test/properties 13:38:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:38:50 INFO - Writing to file /builds/slave/test/properties/build_url 13:38:50 INFO - Contents: 13:38:50 INFO - build_url:https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:38:50 INFO - Running post-action listener: _resource_record_post_action 13:38:50 INFO - Running post-action listener: set_extra_try_arguments 13:38:50 INFO - ##### 13:38:50 INFO - ##### Running populate-webroot step. 13:38:50 INFO - ##### 13:38:50 INFO - Running pre-action listener: _resource_record_pre_action 13:38:50 INFO - Running main action method: populate_webroot 13:38:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:38:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:38:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:38:50 INFO - '--tppagecycles', 13:38:50 INFO - '7'], 13:38:50 INFO - 'tests': ['tsvgm']}}, 13:38:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:38:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:38:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:38:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:38:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:38:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:38:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:50 INFO - 'talos_options': ['--disable-e10s'], 13:38:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:38:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:38:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:50 INFO - 'talos_options': ['--disable-e10s'], 13:38:50 INFO - 'tests': ['damp', 'tps']}, 13:38:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:50 INFO - 'tests': ['damp', 'tps']}, 13:38:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:38:50 INFO - 'tests': ['dromaeo_dom']}, 13:38:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:38:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:38:50 INFO - 'tests': ['a11yr', 13:38:50 INFO - 'ts_paint', 13:38:50 INFO - 'tpaint', 13:38:50 INFO - 'sessionrestore', 13:38:50 INFO - 'sessionrestore_no_auto_restore', 13:38:50 INFO - 'tabpaint']}, 13:38:50 INFO - 'other-e10s': {'tests': ['a11yr', 13:38:50 INFO - 'ts_paint', 13:38:50 INFO - 'tpaint', 13:38:50 INFO - 'sessionrestore', 13:38:50 INFO - 'sessionrestore_no_auto_restore', 13:38:50 INFO - 'tabpaint']}, 13:38:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:38:50 INFO - 'ts_paint', 13:38:50 INFO - 'tpaint', 13:38:50 INFO - 'sessionrestore', 13:38:50 INFO - 'sessionrestore_no_auto_restore', 13:38:50 INFO - 'tabpaint']}, 13:38:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:38:50 INFO - 'ts_paint', 13:38:50 INFO - 'tpaint', 13:38:50 INFO - 'sessionrestore', 13:38:50 INFO - 'sessionrestore_no_auto_restore', 13:38:50 INFO - 'tabpaint']}, 13:38:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:38:50 INFO - 'tests': ['a11yr', 13:38:50 INFO - 'ts_paint', 13:38:50 INFO - 'tpaint', 13:38:50 INFO - 'sessionrestore', 13:38:50 INFO - 'sessionrestore_no_auto_restore', 13:38:50 INFO - 'tabpaint']}, 13:38:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:38:50 INFO - 'tests': ['a11yr', 13:38:50 INFO - 'ts_paint', 13:38:50 INFO - 'tpaint', 13:38:50 INFO - 'sessionrestore', 13:38:50 INFO - 'sessionrestore_no_auto_restore', 13:38:50 INFO - 'tabpaint']}, 13:38:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:38:50 INFO - 'tests': ['tsvgx', 13:38:50 INFO - 'tsvgr_opacity', 13:38:50 INFO - 'tart', 13:38:50 INFO - 'tscrollx', 13:38:50 INFO - 'cart']}, 13:38:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:38:50 INFO - 'tsvgr_opacity', 13:38:50 INFO - 'tart', 13:38:50 INFO - 'tscrollx', 13:38:50 INFO - 'cart']}, 13:38:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:50 INFO - 'talos_options': ['--disable-e10s'], 13:38:50 INFO - 'tests': ['tp5o']}, 13:38:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:50 INFO - 'tests': ['tp5o']}, 13:38:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:50 INFO - 'talos_options': ['--disable-e10s', 13:38:50 INFO - '--xperf_path', 13:38:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:38:50 INFO - 'tests': ['tp5n']}, 13:38:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:38:50 INFO - 'talos_options': ['--xperf_path', 13:38:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:38:50 INFO - 'tests': ['tp5n']}}, 13:38:50 INFO - 'talos.zip': {'path': '', 13:38:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:38:50 INFO - Running post-action listener: _resource_record_post_action 13:38:50 INFO - ##### 13:38:50 INFO - ##### Running create-virtualenv step. 13:38:50 INFO - ##### 13:38:50 INFO - Running pre-action listener: _resource_record_pre_action 13:38:50 INFO - Running main action method: create_virtualenv 13:38:50 INFO - Creating virtualenv /builds/slave/test/build/venv 13:38:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:38:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:38:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:38:51 INFO - Using real prefix '/usr' 13:38:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:38:51 INFO - Installing distribute.............................................................................................................................................................................................done. 13:38:53 INFO - Installing pip.................done. 13:38:53 INFO - Return code: 0 13:38:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:53 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 0x7f3736149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d410>, '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 0x2c2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', '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 13:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:38:53 INFO - Using env: {'DISPLAY': ':0', 13:38:53 INFO - 'HOME': '/home/cltbld', 13:38:53 INFO - 'LANG': 'en_US.UTF-8', 13:38:53 INFO - 'LANGUAGE': 'en_US:en', 13:38:53 INFO - 'LOGNAME': 'cltbld', 13:38:53 INFO - 'MAIL': '/var/mail/cltbld', 13:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:53 INFO - 'MOZ_NO_REMOTE': '1', 13:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:53 INFO - 'NO_EM_RESTART': '1', 13:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:53 INFO - 'PWD': '/builds/slave/test', 13:38:53 INFO - 'SHELL': '/bin/bash', 13:38:53 INFO - 'SHLVL': '1', 13:38:53 INFO - 'TERM': 'linux', 13:38:53 INFO - 'TMOUT': '86400', 13:38:53 INFO - 'USER': 'cltbld', 13:38:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', 13:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:53 INFO - '_': '/tools/buildbot/bin/python'} 13:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:38:54 INFO - Cleaning up... 13:38:54 INFO - Return code: 0 13:38:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38: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', '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 0x7f3736149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d410>, '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 0x2c2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', '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 13:38: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', 'psutil>=0.7.1'] in /builds/slave/test/build 13:38: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 psutil>=0.7.1 13:38:54 INFO - Using env: {'DISPLAY': ':0', 13:38:54 INFO - 'HOME': '/home/cltbld', 13:38:54 INFO - 'LANG': 'en_US.UTF-8', 13:38:54 INFO - 'LANGUAGE': 'en_US:en', 13:38:54 INFO - 'LOGNAME': 'cltbld', 13:38:54 INFO - 'MAIL': '/var/mail/cltbld', 13:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:54 INFO - 'MOZ_NO_REMOTE': '1', 13:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:54 INFO - 'NO_EM_RESTART': '1', 13:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:54 INFO - 'PWD': '/builds/slave/test', 13:38:54 INFO - 'SHELL': '/bin/bash', 13:38:54 INFO - 'SHLVL': '1', 13:38:54 INFO - 'TERM': 'linux', 13:38:54 INFO - 'TMOUT': '86400', 13:38:54 INFO - 'USER': 'cltbld', 13:38:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', 13:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:54 INFO - '_': '/tools/buildbot/bin/python'} 13:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:54 INFO - Downloading/unpacking psutil>=0.7.1 13:38: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 13:38: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 13:38: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 13:38: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 13:38: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 13:38: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 13:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:38:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:38:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:38:56 INFO - Installing collected packages: psutil 13:38:56 INFO - Running setup.py install for psutil 13:38:56 INFO - building 'psutil._psutil_linux' extension 13:38:56 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 13:38:57 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 13:38:57 INFO - building 'psutil._psutil_posix' extension 13:38:57 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 13:38:57 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 13:38:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:38:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:38:57 INFO - Successfully installed psutil 13:38:57 INFO - Cleaning up... 13:38:57 INFO - Return code: 0 13:38:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:38:57 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 0x7f3736149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d410>, '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 0x2c2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', '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 13:38:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:38:57 INFO - Using env: {'DISPLAY': ':0', 13:38:57 INFO - 'HOME': '/home/cltbld', 13:38:57 INFO - 'LANG': 'en_US.UTF-8', 13:38:57 INFO - 'LANGUAGE': 'en_US:en', 13:38:57 INFO - 'LOGNAME': 'cltbld', 13:38:57 INFO - 'MAIL': '/var/mail/cltbld', 13:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:38:57 INFO - 'MOZ_NO_REMOTE': '1', 13:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:38:57 INFO - 'NO_EM_RESTART': '1', 13:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:38:57 INFO - 'PWD': '/builds/slave/test', 13:38:57 INFO - 'SHELL': '/bin/bash', 13:38:57 INFO - 'SHLVL': '1', 13:38:57 INFO - 'TERM': 'linux', 13:38:57 INFO - 'TMOUT': '86400', 13:38:57 INFO - 'USER': 'cltbld', 13:38:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', 13:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:38:57 INFO - '_': '/tools/buildbot/bin/python'} 13:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:38:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:38:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:39:00 INFO - Installing collected packages: mozsystemmonitor 13:39:00 INFO - Running setup.py install for mozsystemmonitor 13:39:00 INFO - Successfully installed mozsystemmonitor 13:39:00 INFO - Cleaning up... 13:39:00 INFO - Return code: 0 13:39:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:00 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 0x7f3736149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d410>, '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 0x2c2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', '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 13:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:39:00 INFO - Using env: {'DISPLAY': ':0', 13:39:00 INFO - 'HOME': '/home/cltbld', 13:39:00 INFO - 'LANG': 'en_US.UTF-8', 13:39:00 INFO - 'LANGUAGE': 'en_US:en', 13:39:00 INFO - 'LOGNAME': 'cltbld', 13:39:00 INFO - 'MAIL': '/var/mail/cltbld', 13:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:00 INFO - 'MOZ_NO_REMOTE': '1', 13:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:00 INFO - 'NO_EM_RESTART': '1', 13:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:00 INFO - 'PWD': '/builds/slave/test', 13:39:00 INFO - 'SHELL': '/bin/bash', 13:39:00 INFO - 'SHLVL': '1', 13:39:00 INFO - 'TERM': 'linux', 13:39:00 INFO - 'TMOUT': '86400', 13:39:00 INFO - 'USER': 'cltbld', 13:39:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', 13:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:00 INFO - '_': '/tools/buildbot/bin/python'} 13:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:00 INFO - Downloading/unpacking blobuploader==1.2.4 13:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:02 INFO - Downloading blobuploader-1.2.4.tar.gz 13:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:39:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:39:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:03 INFO - Downloading docopt-0.6.1.tar.gz 13:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:39:03 INFO - Installing collected packages: blobuploader, requests, docopt 13:39:03 INFO - Running setup.py install for blobuploader 13:39:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:39:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:39:03 INFO - Running setup.py install for requests 13:39:03 INFO - Running setup.py install for docopt 13:39:03 INFO - Successfully installed blobuploader requests docopt 13:39:03 INFO - Cleaning up... 13:39:03 INFO - Return code: 0 13:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:03 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 0x7f3736149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d410>, '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 0x2c2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', '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 13:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:39:03 INFO - Using env: {'DISPLAY': ':0', 13:39:03 INFO - 'HOME': '/home/cltbld', 13:39:03 INFO - 'LANG': 'en_US.UTF-8', 13:39:03 INFO - 'LANGUAGE': 'en_US:en', 13:39:03 INFO - 'LOGNAME': 'cltbld', 13:39:03 INFO - 'MAIL': '/var/mail/cltbld', 13:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:03 INFO - 'MOZ_NO_REMOTE': '1', 13:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:03 INFO - 'NO_EM_RESTART': '1', 13:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:03 INFO - 'PWD': '/builds/slave/test', 13:39:03 INFO - 'SHELL': '/bin/bash', 13:39:03 INFO - 'SHLVL': '1', 13:39:03 INFO - 'TERM': 'linux', 13:39:03 INFO - 'TMOUT': '86400', 13:39:03 INFO - 'USER': 'cltbld', 13:39:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', 13:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:03 INFO - '_': '/tools/buildbot/bin/python'} 13:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:03 INFO - Running setup.py (path:/tmp/pip-BJ8vzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:04 INFO - Running setup.py (path:/tmp/pip-7hk9u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:04 INFO - Running setup.py (path:/tmp/pip-LVELfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:04 INFO - Running setup.py (path:/tmp/pip-MHoN8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:04 INFO - Running setup.py (path:/tmp/pip-KhdLjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:04 INFO - Running setup.py (path:/tmp/pip-mXbK5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:04 INFO - Running setup.py (path:/tmp/pip-b9zOlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:04 INFO - Running setup.py (path:/tmp/pip-mgrbgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:04 INFO - Running setup.py (path:/tmp/pip-fTlda9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:04 INFO - Running setup.py (path:/tmp/pip-v808Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:04 INFO - Running setup.py (path:/tmp/pip-Oq4gAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:04 INFO - Running setup.py (path:/tmp/pip-MYqYTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:04 INFO - Running setup.py (path:/tmp/pip-A1Z37Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:04 INFO - Running setup.py (path:/tmp/pip-WDn1GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:04 INFO - Running setup.py (path:/tmp/pip-gnxPie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:04 INFO - Running setup.py (path:/tmp/pip-2Zudsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:05 INFO - Running setup.py (path:/tmp/pip-LBhKt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:39:05 INFO - Running setup.py install for manifestparser 13:39:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:39:05 INFO - Running setup.py install for mozcrash 13:39:05 INFO - Running setup.py install for mozdebug 13:39:05 INFO - Running setup.py install for mozdevice 13:39:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:39:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:39:05 INFO - Running setup.py install for mozfile 13:39:05 INFO - Running setup.py install for mozhttpd 13:39:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:39:05 INFO - Running setup.py install for mozinfo 13:39:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:39:05 INFO - Running setup.py install for mozInstall 13:39:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:39:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:39:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:39:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:39:05 INFO - Running setup.py install for mozleak 13:39:06 INFO - Running setup.py install for mozlog 13:39:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:39:06 INFO - Running setup.py install for moznetwork 13:39:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:39:06 INFO - Running setup.py install for mozprocess 13:39:06 INFO - Running setup.py install for mozprofile 13:39:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:39:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:39:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:39:06 INFO - Running setup.py install for mozrunner 13:39:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:39:06 INFO - Running setup.py install for mozscreenshot 13:39:06 INFO - Running setup.py install for moztest 13:39:06 INFO - Running setup.py install for mozversion 13:39:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:39:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:39:06 INFO - Cleaning up... 13:39:06 INFO - Return code: 0 13:39:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:06 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 0x7f3736149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d410>, '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 0x2c2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', '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 13:39:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:39:06 INFO - Using env: {'DISPLAY': ':0', 13:39:06 INFO - 'HOME': '/home/cltbld', 13:39:06 INFO - 'LANG': 'en_US.UTF-8', 13:39:06 INFO - 'LANGUAGE': 'en_US:en', 13:39:06 INFO - 'LOGNAME': 'cltbld', 13:39:06 INFO - 'MAIL': '/var/mail/cltbld', 13:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:06 INFO - 'MOZ_NO_REMOTE': '1', 13:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:06 INFO - 'NO_EM_RESTART': '1', 13:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:06 INFO - 'PWD': '/builds/slave/test', 13:39:06 INFO - 'SHELL': '/bin/bash', 13:39:06 INFO - 'SHLVL': '1', 13:39:06 INFO - 'TERM': 'linux', 13:39:06 INFO - 'TMOUT': '86400', 13:39:06 INFO - 'USER': 'cltbld', 13:39:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', 13:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:06 INFO - '_': '/tools/buildbot/bin/python'} 13:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:07 INFO - Running setup.py (path:/tmp/pip-ua9uAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:07 INFO - Running setup.py (path:/tmp/pip-1lvlC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:07 INFO - Running setup.py (path:/tmp/pip-9oWILQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:07 INFO - Running setup.py (path:/tmp/pip-vGXlja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:07 INFO - Running setup.py (path:/tmp/pip-ZiTJ9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:07 INFO - Running setup.py (path:/tmp/pip-86ygRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:07 INFO - Running setup.py (path:/tmp/pip-ilPjBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:07 INFO - Running setup.py (path:/tmp/pip-jXS8gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:07 INFO - Running setup.py (path:/tmp/pip-17vFyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:07 INFO - Running setup.py (path:/tmp/pip-vIhSEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:07 INFO - Running setup.py (path:/tmp/pip-2CTvGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:07 INFO - Running setup.py (path:/tmp/pip-ZRxTnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:08 INFO - Running setup.py (path:/tmp/pip-oro9Zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:08 INFO - Running setup.py (path:/tmp/pip-roortP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:08 INFO - Running setup.py (path:/tmp/pip-coOtc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:08 INFO - Running setup.py (path:/tmp/pip-lz3k5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:08 INFO - Running setup.py (path:/tmp/pip-MTNGu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:39:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:10 INFO - Downloading blessings-1.6.tar.gz 13:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:39:10 INFO - Installing collected packages: blessings 13:39:10 INFO - Running setup.py install for blessings 13:39:10 INFO - Successfully installed blessings 13:39:10 INFO - Cleaning up... 13:39:10 INFO - Return code: 0 13:39:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:10 INFO - Reading from file tmpfile_stdout 13:39:10 INFO - Current package versions: 13:39:10 INFO - argparse == 1.2.1 13:39:10 INFO - blessings == 1.6 13:39:10 INFO - blobuploader == 1.2.4 13:39:10 INFO - docopt == 0.6.1 13:39:10 INFO - manifestparser == 1.1 13:39:10 INFO - mozInstall == 1.12 13:39:10 INFO - mozcrash == 0.17 13:39:10 INFO - mozdebug == 0.1 13:39:10 INFO - mozdevice == 0.48 13:39:10 INFO - mozfile == 1.2 13:39:10 INFO - mozhttpd == 0.7 13:39:10 INFO - mozinfo == 0.9 13:39:10 INFO - mozleak == 0.1 13:39:10 INFO - mozlog == 3.1 13:39:10 INFO - moznetwork == 0.27 13:39:10 INFO - mozprocess == 0.22 13:39:10 INFO - mozprofile == 0.28 13:39:10 INFO - mozrunner == 6.11 13:39:10 INFO - mozscreenshot == 0.1 13:39:10 INFO - mozsystemmonitor == 0.0 13:39:10 INFO - moztest == 0.7 13:39:10 INFO - mozversion == 1.4 13:39:10 INFO - psutil == 3.1.1 13:39:10 INFO - requests == 1.2.3 13:39:10 INFO - wsgiref == 0.1.2 13:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:10 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 0x7f3736149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d410>, '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 0x2c2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', '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 13:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:39:10 INFO - Using env: {'DISPLAY': ':0', 13:39:10 INFO - 'HOME': '/home/cltbld', 13:39:10 INFO - 'LANG': 'en_US.UTF-8', 13:39:10 INFO - 'LANGUAGE': 'en_US:en', 13:39:10 INFO - 'LOGNAME': 'cltbld', 13:39:10 INFO - 'MAIL': '/var/mail/cltbld', 13:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:10 INFO - 'MOZ_NO_REMOTE': '1', 13:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:10 INFO - 'NO_EM_RESTART': '1', 13:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:10 INFO - 'PWD': '/builds/slave/test', 13:39:10 INFO - 'SHELL': '/bin/bash', 13:39:10 INFO - 'SHLVL': '1', 13:39:10 INFO - 'TERM': 'linux', 13:39:10 INFO - 'TMOUT': '86400', 13:39:10 INFO - 'USER': 'cltbld', 13:39:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', 13:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:10 INFO - '_': '/tools/buildbot/bin/python'} 13:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:39:10 INFO - Cleaning up... 13:39:10 INFO - Return code: 0 13:39:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3736149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d410>, '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 0x2c2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', '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 13:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:39:10 INFO - Using env: {'DISPLAY': ':0', 13:39:10 INFO - 'HOME': '/home/cltbld', 13:39:10 INFO - 'LANG': 'en_US.UTF-8', 13:39:10 INFO - 'LANGUAGE': 'en_US:en', 13:39:10 INFO - 'LOGNAME': 'cltbld', 13:39:10 INFO - 'MAIL': '/var/mail/cltbld', 13:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:10 INFO - 'MOZ_NO_REMOTE': '1', 13:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:10 INFO - 'NO_EM_RESTART': '1', 13:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:10 INFO - 'PWD': '/builds/slave/test', 13:39:10 INFO - 'SHELL': '/bin/bash', 13:39:10 INFO - 'SHLVL': '1', 13:39:10 INFO - 'TERM': 'linux', 13:39:10 INFO - 'TMOUT': '86400', 13:39:10 INFO - 'USER': 'cltbld', 13:39:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', 13:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:10 INFO - '_': '/tools/buildbot/bin/python'} 13:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:11 INFO - Downloading/unpacking jsonschema 13:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:39:13 INFO - Downloading/unpacking functools32 (from jsonschema) 13:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:13 INFO - Downloading functools32-3.2.3-2.tar.gz 13:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:39:13 INFO - warning: no files found matching '*.txt' 13:39:13 INFO - no previously-included directories found matching 'build' 13:39:13 INFO - no previously-included directories found matching 'dist' 13:39:13 INFO - no previously-included directories found matching '.git*' 13:39:13 INFO - Installing collected packages: jsonschema, functools32 13:39:13 INFO - Running setup.py install for functools32 13:39:13 INFO - warning: no files found matching '*.txt' 13:39:13 INFO - no previously-included directories found matching 'build' 13:39:13 INFO - no previously-included directories found matching 'dist' 13:39:13 INFO - no previously-included directories found matching '.git*' 13:39:13 INFO - Successfully installed jsonschema functools32 13:39:13 INFO - Cleaning up... 13:39:13 INFO - Return code: 0 13:39:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:13 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 0x7f3736149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c2d410>, '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 0x2c2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', '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 13:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:39:13 INFO - Using env: {'DISPLAY': ':0', 13:39:13 INFO - 'HOME': '/home/cltbld', 13:39:13 INFO - 'LANG': 'en_US.UTF-8', 13:39:13 INFO - 'LANGUAGE': 'en_US:en', 13:39:13 INFO - 'LOGNAME': 'cltbld', 13:39:13 INFO - 'MAIL': '/var/mail/cltbld', 13:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:13 INFO - 'MOZ_NO_REMOTE': '1', 13:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:13 INFO - 'NO_EM_RESTART': '1', 13:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:13 INFO - 'PWD': '/builds/slave/test', 13:39:13 INFO - 'SHELL': '/bin/bash', 13:39:13 INFO - 'SHLVL': '1', 13:39:13 INFO - 'TERM': 'linux', 13:39:13 INFO - 'TMOUT': '86400', 13:39:13 INFO - 'USER': 'cltbld', 13:39:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', 13:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:13 INFO - '_': '/tools/buildbot/bin/python'} 13:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:13 INFO - Downloading/unpacking flake8 13:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:39:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:39:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:39:16 INFO - no previously-included directories found matching 'docs/_build' 13:39:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:39:16 INFO - Running setup.py install for pep8 13:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:39:16 INFO - no previously-included directories found matching 'docs/_build' 13:39:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:39:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:39:16 INFO - Cleaning up... 13:39:16 INFO - Return code: 0 13:39:16 INFO - Running post-action listener: _resource_record_post_action 13:39:16 INFO - Running post-action listener: _start_resource_monitoring 13:39:16 INFO - Starting resource monitoring. 13:39:16 INFO - ##### 13:39:16 INFO - ##### Running install step. 13:39:16 INFO - ##### 13:39:16 INFO - Running pre-action listener: _resource_record_pre_action 13:39:16 INFO - Running main action method: install 13:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:16 INFO - Reading from file tmpfile_stdout 13:39:16 INFO - Detecting whether we're running mozinstall >=1.0... 13:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:39:16 INFO - Reading from file tmpfile_stdout 13:39:16 INFO - Output received: 13:39:16 INFO - Usage: mozinstall [options] installer 13:39:16 INFO - Options: 13:39:16 INFO - -h, --help show this help message and exit 13:39:16 INFO - -d DEST, --destination=DEST 13:39:16 INFO - Directory to install application into. [default: 13:39:16 INFO - "/builds/slave/test"] 13:39:16 INFO - --app=APP Application being installed. [default: firefox] 13:39:16 INFO - mkdir: /builds/slave/test/build/application 13:39:16 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'] 13:39:16 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 13:39:32 INFO - Reading from file tmpfile_stdout 13:39:32 INFO - Output received: 13:39:32 INFO - /builds/slave/test/build/application/firefox/firefox 13:39:32 INFO - Running post-action listener: _resource_record_post_action 13:39:32 INFO - ##### 13:39:32 INFO - ##### Running run-tests step. 13:39:32 INFO - ##### 13:39:32 INFO - Running pre-action listener: _resource_record_pre_action 13:39:32 INFO - Running main action method: run_tests 13:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:39:32 INFO - Python 2.7.3 13:39:32 INFO - Return code: 0 13:39:32 INFO - grabbing minidump binary from tooltool 13:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:32 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 0x2c2d410>, '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 0x2c2e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:39:32 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 13:39:32 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 13:39:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:39:32 INFO - Return code: 0 13:39:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:39:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:39:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:39:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:39:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:39:33 INFO - Return code: 0 13:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:39:33 INFO - Using env: {'DISPLAY': ':0', 13:39:33 INFO - 'HOME': '/home/cltbld', 13:39:33 INFO - 'LANG': 'en_US.UTF-8', 13:39:33 INFO - 'LANGUAGE': 'en_US:en', 13:39:33 INFO - 'LOGNAME': 'cltbld', 13:39:33 INFO - 'MAIL': '/var/mail/cltbld', 13:39:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:39:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:33 INFO - 'MOZ_NO_REMOTE': '1', 13:39:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:39:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:33 INFO - 'NO_EM_RESTART': '1', 13:39:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:33 INFO - 'PWD': '/builds/slave/test', 13:39:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:39:33 INFO - 'SHELL': '/bin/bash', 13:39:33 INFO - 'SHLVL': '1', 13:39:33 INFO - 'TERM': 'linux', 13:39:33 INFO - 'TMOUT': '86400', 13:39:33 INFO - 'USER': 'cltbld', 13:39:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645', 13:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:33 INFO - '_': '/tools/buildbot/bin/python'} 13:39:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:39:33 INFO - mozversion application_buildid: 20160421130623 13:39:33 INFO - mozversion application_changeset: b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 13:39:33 INFO - mozversion application_display_name: Nightly 13:39:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:39:33 INFO - mozversion application_name: Firefox 13:39:33 INFO - mozversion application_remotingname: firefox 13:39:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:39:33 INFO - mozversion application_vendor: Mozilla 13:39:33 INFO - mozversion application_version: 48.0a1 13:39:33 INFO - mozversion platform_buildid: 20160421130623 13:39:33 INFO - mozversion platform_changeset: b31b99289389a5e0ddab1ca9eccd4f03a6d81fe4 13:39:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:39:33 INFO - mozversion platform_version: 48.0a1 13:39:33 INFO - using testdate: 1461271173 13:39:33 INFO - actual date: 1461271173 13:39:33 INFO - starting webserver on 'localhost:46842' 13:39:33 INFO - SUITE-START | Running 2 tests 13:39:33 INFO - TEST-START | dromaeo_css 13:39:33 INFO - operating with platform_type : linux_ 13:39:33 INFO - Initialising browser for dromaeo_css test... 13:39:33 INFO - TEST-INFO | started process 3286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp37oLv/profile http://localhost:46842/getInfo.html) 13:39:40 INFO - PROCESS | 3286 | 13:39:40 INFO - PROCESS | 3286 | (process:3354): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:39:41 INFO - PROCESS | 3286 | __metrics Screen width/height:1600/1200 13:39:41 INFO - PROCESS | 3286 | colorDepth:24 13:39:41 INFO - PROCESS | 3286 | Browser inner width/height: 1024/697 13:39:41 INFO - PROCESS | 3286 | __metrics 13:39:42 ERROR - PROCESS | 3286 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:39:43 INFO - TEST-INFO | 3286: exit 0 13:39:43 INFO - Browser initialized. 13:39:43 INFO - Running cycle 1/1 for dromaeo_css test... 13:39:43 INFO - TEST-INFO | started process 3406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp37oLv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:39:45 INFO - PROCESS | 3406 | 13:39:45 INFO - PROCESS | 3406 | (process:3467): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:39:55 INFO - PROCESS | 3406 | RSS: Main: 164974592 13:39:55 INFO - PROCESS | 3406 | 13:40:45 INFO - PROCESS | 3406 | 1461271245018 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:42:56 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:46842/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46842/tests/dromaeo/cssquery-ext.html) 13:42:57 INFO - PROCESS | 3406 | RSS: Main: 169742336 13:42:57 INFO - PROCESS | 3406 | 13:45:59 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:46842/tests/dromaeo/cssquery-ext.html (next: http://localhost:46842/tests/dromaeo/cssquery-jquery.html) 13:46:00 INFO - PROCESS | 3406 | RSS: Main: 166293504 13:46:00 INFO - PROCESS | 3406 | 13:49:02 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:46842/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46842/tests/dromaeo/cssquery-mootools.html) 13:49:03 INFO - PROCESS | 3406 | RSS: Main: 167563264 13:49:03 INFO - PROCESS | 3406 | 13:52:04 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:46842/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46842/tests/dromaeo/cssquery-prototype.html) 13:52:05 INFO - PROCESS | 3406 | RSS: Main: 164671488 13:52:05 INFO - PROCESS | 3406 | 13:55:08 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:46842/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46842/tests/dromaeo/cssquery-yui.html) 13:55:09 INFO - PROCESS | 3406 | RSS: Main: 166412288 13:55:09 INFO - PROCESS | 3406 | 13:58:11 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:46842/tests/dromaeo/cssquery-yui.html (next: http://localhost:46842/tests/dromaeo/cssquery-dojo.html) 13:58:11 INFO - PROCESS | 3406 | RSS: Main: 168579072 13:58:11 INFO - PROCESS | 3406 | 13:58:11 INFO - PROCESS | 3406 | __start_tp_report 13:58:11 INFO - PROCESS | 3406 | _x_x_mozilla_page_load 13:58:11 INFO - PROCESS | 3406 | _x_x_mozilla_page_load_details 13:58:11 INFO - PROCESS | 3406 | |i|pagename|runs| 13:58:11 INFO - PROCESS | 3406 | |0;dojo.html;2620.7117217106115;2688.74456926592;2721.034032918315;2725.7546820786138;2739.3288644282143;4625;4648.837290694826;4658.697184682993;4693.155232058228;4706.764661766915;4646.1172377248295;4700.905981880369;4702.0360826030665;4713.505081966396;4726.763661816913;4239.745615263078;4287.914241715163;4408.294672852344;4415.690901636886;4461.040876211614;4315.676324275676;4389.385486031958;4429.911401771963;4431.335299705038;4464.799084041226;4286.7856607169515;4372.125574885035;4374.803133858984;4426.424564806571;4434.756088415136;4374.715643483163;4385.1229754049;4407.559244075599;4420.138073075752;4426.468823741139;4367.606915377632;4374.693771436001;4382.780860956971;4423.867283981485;4454.866354009385;4504.842330518416;4619.0530941156985;4683.718976861365;4708.964027913854;4745.810167593292;5113.897722045575;5114.795408183668;5153.768080436389;5154.175331946908;5208.088584497736;5209.557187639018;5212.582993360522;5215.113430716788;5215.348081489814;5216.765245563959;4679.508651591568;4807;4809.350737650442;4851.175300198975;4887.315775791392;5196.584273258206;5233.215017747369;5235.4502777207845;5236.319278493847;5251.711155886463;4867.7322747249245;5007.624428167902;5011.824586139468;5019.598432125421;5021.774020169101;5094.490550944876;5100.897982040338;5130.589552835764;5135.563477104413;5185.274061631375;5033.597312215014;5040.722760248148;5040.823571174991;5045.873853153627;5095.643304968617;4882.414110306786;4955.2567114933045;5030.893203495225;5034.993001399662;5056.671316364498;4147.543770185277;4252.702310838274;4283.0363168286885;4310.3103503439925;4334.869953901388;3749.1751814600743;3778.1499162688174;3809.314323421755;3810.847566097325;3876.3604005338802;4268.274393353137;4375;4385.583369579885;4394.1651086293505;4433.1577000369825;5071.985602879439;5137.640365174402;5138.665986710852;5161.483851614808;5194.714290714047;4335.089631177488;4348.978255108705;4355.760433176142;4361.214981303396;4403.229434848889;4510.819567217274;4563.566461186182;4617.12274667812;4622.445306563234;4657.976710116428;4763.951930575268;4783.425988881357;4799.232122860326;4815.855524334275;4840.080384726891;5096.159133743039;5097.490250974873;5119.232115182753;5125;5170.8965820684125;4628.166929952641;4747.264174053027;4771.045790841776;4825.806967721252;4837.927431088607;5000.124978128885;5011.473795251592;5031.245313203049;5033.395992480926;5053.469385714447;5089.847304580869;5098.694078355311;5111.846644600668;5117;5133.358330208724;4800.807967681254;4939.5554400104165;4958.281049247911;5017.623678224075;5048.066107770074;4936.605071594336;4937.925931111108;4949.109160351028;4985.277134815504;5016.297718319365;4866.294387313749;4873.951260487492;4886.584640305614;4904.852854414374;4944.208926571875;4789.760511974457;4801.735904525145;4884.194107972145;5089.949100508948;5100.158473851921;4890.2909078184175;4940.6788558743565;4957;4961.70229786214;5008.273800299009 13:58:11 INFO - PROCESS | 3406 | |1;ext.html;555.6608573338253;586.4165155670107;598.4464370457326;625.6183727925967;626.3986572890026;33267.16832079196;34355.65644343556;34413;34473.482897756556;34492.482612760796;36728.592568891705;37322.066948326305;37463.81268093662;37468.62531374685;37574.81212593933;7577.431692623048;7753.922460775377;7805.804854878645;7822.647980840848;7830.373570114377;7589.354904833068;7609.124950630665;7641.885371719429;7646.808829779245;7680.923190768104;7636.083669959613;7681.078270607507;7710.151883292861;7721.073471183466;7738.4969976951315;7624.42816788743;7669.424793140509;7681.23187681233;7708.730194443224;7722.961385193066;7655.349295309906;7738.342240909529;7771.067471903351;7774.6501407436235;7776.494527855728;29128.708712912812;35172.47241291383;35794.105147371265;35844.283114337566;35954.64045359565;3038.4075105354464;3052.7597604314265;3129.906102816919;3341.7827841190247;3583.4624806279007;24270.271891843273;24324.756752432604;24586.262412127486;24660.383490412703;24661.38346541351;3211.165097074754;3233.967660323414;3234.741220702338;3291.5720956275773;3357.3285342931513;177778;178206;179248;179630;180557;31129;31211.687883121333;31243.68756312453;31320;31325.530117047805;55874.72062639661;57402.7129864348;57452.13821792677;57600.42399576034;57721;13173.275469849059;13392.12951158191;13405.195688258736;13443.932780336036;13482.662933426744;9668.806623867624;9711.951440242754;9746.512674366253;9749.317547771589;9795.216382689368;18145.81854181468;18177.545561360806;18330.541736456427;18427.63144737098;18474.353397631286;6951.478639101986;7073.92926070743;7087.149542054986;7157.105361829771;7229.530080544748;843.9534976628936;852.1435956863313;909.1908201700492;960.673371053845;1009.7071849163807;26530.469390612467;27499.587506187425;27628.033018844242;27935.161945141677;28012.71987280142;983.5819776594918;993.557866749304;1058.915286777056;1078.2021304234809;1107.2249425402251;14490.927545362205;15151.106111736033;15192.316345764468;15213.31540080699;15246.695066098839;335311;339611;341748;343990;344127;47919;48674;48694;48701;48730.51269487331;1175.2302242031483;1204.1209916760638;1230.5200971621075;1242.7452372263665;1245.1844042152404;26168.34579135537;27623.58564621492;27755.583666245428;27781.722182777914;28303.29241768972;41518.16963660649;41852.790736046125;42180.1563968725;42305.15389692251;42319.7884010578;310558;311257;312131;312293;312487;24847.62728559037;25409.87295063513;25411.237662870142;25467.36331591725;37355.879323620335;35667.46498802572;36332;36627.26745465129;36642.8167859159;36678.63321366752;29521.409571808872;30607.54088688716;30648.080557583307;31360.843195783877;31705.20736981594;30384.39231215319;30814;31225.68774312228;34137.146571334924;34781.47827782535;32632.34735305328;33867.15332116717;33936.490952636224;35730;36724.08189795277;29544.261393465335;31465.21336966594;31520.81096601851;31692.683073169894;31840.52239216367;23851;24148.275551733477;24272.27183184507;24749.752502474745;24849.006039758206 13:58:11 INFO - PROCESS | 3406 | |2;jquery.html;370.4683778777454;373.8074891430912;375.48558474889387;375.8947494701484;383.8216674808339;15782.131982740944;15951.202439878003;15996.200189990483;16498.75251871223;16509.669806603877;15422.383104675828;16377.42679006235;16464.423745168922;16521.504354869372;16593.585160370996;4982.177940639799;5193.5325820676135;5223.033738758342;5241.109011468059;5254.054270231357;3685.09715119796;5141.434442211354;5618.747156377973;5936.139259807325;5944.078667806475;5840.853978650525;5855.121731740231;5869.178315035899;5871.29544454666;5873.970630146843;5688.061469857489;5706.28671416073;5775.855603609902;5813.6802475863815;5833.562482813806;4968.925466118011;5079.644424890223;5089.898202035975;5113.590912726973;5119.206522988943;19781.307654232034;19859.106340214727;19894.502637434034;19942.401727948185;20041.79958200414;2001.3895761792648;2050.3336415664967;2069.3378119001927;2181.4219231903558;2569.396191894903;12920;13002.219866808022;13055.477780888754;13164.40760165795;13581.728365432735;1778.759867417895;1812.474382429094;1835.6420498002894;1842.0789605197401;1853.8966987368358;63503.6824815873;63820.68089659568;66514.3348566513;66537.66731166313;66637.33362666408;9125.543722813833;9253.537323133816;9392.29557783169;9552.331336806357;9704;12789.36053197355;12847.357632118543;12940.741185176244;12940.805887911689;12992.285424301564;6782.626955517494;6836.863262734817;6895;6900.5859648420255;6936.410405115622;6469.5794773339585;6558.245801732862;6600.53796234259;6663.333666633298;6693.698783554752;5904.793332233351;5954.672493012926;5963.850903727442;5976.223090998143;6094.232672525007;1615.6122530592572;1642.5729310379388;1730.9221085051204;1759.9032053237195;1796.9191386387645;892.6786356911507;912.8356895758827;938.9389689670286;969.3795970578835;1056.6196169379018;16364.754528682079;16385.344586216655;16633.584160395843;16656.417025404295;16837.915810421113;907.1155623267261;952.64752041745;967.579103090158;974.5760594141572;975.2198241406846;9458.290628202913;9520.476373799507;9537.618495260112;9538.635014244499;9784.119429251401;376600;384228;386115;386623;387125;64908;67324.6633766828;67986;68981.3101868985;69745.3025469749;943.193569498083;949.292776881228;958.6836344006462;961.0581630002497;971.32007594684;14683.412663493767;14783.778243326575;14837.851621483647;14894.40422383136;14930.253487325373;29801.701982979892;29965.550516742704;31109.844450778506;31401.8429907849;31853.20366990844;41677.58322416737;41959.790201048796;41975.58024419717;42238.57761422346;42494.36258456187;7275.163356213891;7325.4872158948365;7438.776836694908;7519.962400187964;7609.961950190213;11470.827937580776;11624.360660163773;11636.243644163102;11872.881271187178;12335.136540442083;10267.229957753349;10560.455760725681;10664.253502255078;10943.890561094606;11002.33985960845;9847.753806154904;10033.548490318099;10176.287659863738;10255.230857685554;10339.121174699934;10386.636467723594;10433;10604.151667866707;10628.25602207838;11140.777184456103;7378.4466165036765;7654.961725191339;7939.6030198491;8234.176582341717;8257.256846883809;9712.417254964725;10301.793964120825;10369.170466362522;10397.792044158923;10574.471276435994 13:58:11 INFO - PROCESS | 3406 | |3;mootools.html;1467.911925284483;1495.9850401495985;1643.7945256842895;1776.0941919621005;1817.9363722269723;7354.227806080365;7461.515001524911;7554.584497852629;7567.621618919053;7570.05374328209;6612.206535215781;7423.9628801855915;7471.850562988737;7688.807779805494;7707.576083315415;2174.3911704722664;2198.3075331270597;2215.213599172295;2217.390217690132;2224.5662095891307;2213.8339624528144;2214.2914267434426;2238.40682219212;2239.5185035217423;2243.2372993182316;2217.2904670505363;2222.411061068818;2225.4770129019666;2227.7438094619083;2227.8106360959337;2192.5286063496346;2194.462356722597;2204.7464541577765;2205.8566193197553;2208;2158.5143342747915;2162.848600597959;2163.0374483354913;2167.382296045635;2170.913163473459;7775.4168437367425;7919.851621514906;7930.206979302024;7939.047314322318;7976.202379761978;4504.346869703874;4644;4649.302604609302;4650.395448591696;4654.232051711463;2818.126380821952;2860.828350298989;2901.76785857133;2914.6502419709773;2939.1476471823144;886.7561420609384;907.7957459571544;919.1314208073373;924.0528458330265;927.3740225347864;9961.501924903798;10243.79512409755;10292.897071029269;10465.162786977024;10658.307210031324;3931.6461518463475;3977.622125898035;4080.81636326366;4084.8774536763945;4113.814878330482;8035.517868927883;8085.070216925012;8096;8100.594970251464;8140.470869393471;4555.111753208159;4580.404547408815;4593.678442508993;4601.884952876205;4608.723476591415;3607.2965771674794;4122.711410201257;4224.831006759757;4283.22901877665;4287.871363859089;3423.9657603424143;3519.6832285094465;3538.858445662196;3582.8208589570418;3615.240799432149;1031.9896801032044;1057.582255009267;1062.39443517196;1063.4310643805527;1072.088724584113;853.7865533616596;863.6631713631689;866.9393142479965;884.9999500564321;890.7238755985666;5110.310108135429;5204.141316682781;5264.078786212397;5264.973675131677;5308.893822123536;414.56884839766303;415.738085006444;431.2776100032496;431.46067415730334;433.6032530234863;3367.865285388606;3666.7616604920595;3684.024087849829;3699.8705045323286;3727.7949712765517;9111.81776364469;9423.623055077856;9481.810363792685;9545.618175272912;9611.903880961101;9298.814023719488;9306.441613503212;9324.207442367338;9326.906730932604;9351.812963740687;7114.822129446805;7265.164506081763;7265.273472652798;7270.236625154283;7273.745418910418;5094.057599344133;5196.376434827845;5307.150855863043;5336.973315133399;5348.277982472317;8729.650813967624;8797.912020879965;8805.031446541003;8808.647654093764;8884.422512536665;8172.591370431336;8420.200080992296;8459.238668519863;8482.872756908775;8537.957310213409;5889.263842019747;6782.525223234524;6875.449964002968;7187.209406965125;7451.552906825608;7556.811079723051;7590.354819840375;7596.316331530189;7640.847183056197;7641.312281894656;6771.3905748482875;6972.930270697431;7025.981232721125;7118.501704880816;7127.82180445493;6565.179352580927;6628.933710662832;6677.098591690254;6787.355201255873;6877.724891004504;6162.599431036968;6348.714307856065;6396.71214795326;6481.578697384655;6487.091807147098;4706.364640773451;4816.157172494729;4843.806247750051;4860.95139048605;4909.950900491092;4759.16714574941;4814.350062741485;4859.392575928009;4943.728094954668;4970.950290497049 13:58:11 INFO - PROCESS | 3406 | |4;prototype.html;286.12873799281186;289.62782824071076;296.0127973209347;306.96469905960817;313.35761688538497;5267.4469180736;5274.630775845688;5298.284731561238;5341.359036915565;5346.438623944488;5235.659682120659;5237.659552129109;5243.397009343927;5251.789928402859;5257.316548848654;3880.1075752576994;3992.920141597166;4135.979320103395;4136.565660605638;4155.39746736723;4125.876223713293;4132.173565286939;4132.793360331986;4145.129522800215;4156.854510092147;4128.380742888561;4128.60778226068;4130.277201489742;4138.813753381105;4145.0880806222585;4040.1111755413763;4112.609302116294;4122.711410201287;4125.195586860564;4131.338985762279;3614.0964758810296;3634.818259087035;3635.909102272438;3639.5632524097014;3641.708663306929;5070.29015937769;5122.206058061007;5128.051310507531;5129.12804823181;5140.742962851842;4589.2886602576655;4733.786979585927;4752.5485078917445;4761.833350829034;4765.475797662289;5544.556435485151;5566.10752344205;5570.047874626454;5587.1339942309005;5606.523445507096;3944.664703500206;3968.511808071973;3981.98009009956;3997.360422332442;4019.2966230909765;5539;5846.619969701998;5867.178594996704;5886.558508111909;5907.084401917709;3929.76421414716;3964.6630036447227;3965.1673148638533;3969.980150099231;3992.2414741199077;3999.1002024544246;4012.29784787661;4019.437278780973;4031.536373317106;4045.7370270932884;4552.1806074906835;4656.022235330618;4671.743054131987;4682.367880336179;4684.273937539687;5549.7780088796;5577.581681373913;5590.077637189818;5600.887982240332;5653.943460565424;1363.1412210307442;1377.8622137786342;1381.5095641047485;1382.7096309774859;1388.777795552727;869.1699427047281;897.6364572348209;918.1415376622879;933.8319102561468;938.671464987249;4844.802430395922;4852.975735121302;4853.538913803183;4860.975695121501;4865.513448655177;5690.9146362804595;5696.287964004499;5715.799947001919;5724.942750572524;5754.482096611325;4618.122556714214;4803.927941080887;4819.662623616383;4825.30033145199;4875.634327425386;3075.9384812304074;3107.347457034003;3117.2830249042845;3117.9376412471624;3124.1877111950603;5361.624686272002;5398.757055932492;5422.15956526739;5429;5439.5104440600535;5854.2096816930025;5883.294004719461;5975.43233392827;5993.310769261503;5999.2002399280045;5413.810516631899;5419.674819510763;5426.945730542644;5429.104197807317;5441.455854414606;5714.028660112254;5819.447152520504;5837.824865254049;5839.591228613956;5841.1530328101335;5704.714764261853;5715.628484148517;5716.5998380113;5736.340320863154;5743.74153163117;5385.380681221553;5413.972930135482;5418.295621569171;5418.485243901823;5423.457654234545;3800.201957588937;3921.9019524510973;3948.1511475033008;3952.308346039374;3955.9406608901463;5766.3368712598585;5769.1634712967225;5776.797812076557;5789.768409263583;5792.391798861059;5592.552595792408;5623.297087864017;5640.88718225625;5641.294838145232;5642.981005162219;5367.194920761917;5545.395492929628;5609.411011843697;5668.688222147822;5684.607271218578;5284.762185701576;5523.7790488380015;5561.193626924154;5568.860778480571;5568.944310557004;5512.228288039598;5641.294838145232;5658.207850900795;5694.174344720075;5712.485876271156;5519.420460851713;5530.5022547970875;5541.778328866801;5564;5574.08027675429 13:58:11 INFO - PROCESS | 3406 | |5;yui.html;659.5284371674252;690.9896351554728;701.7719241246596;709.9999999999999;762.4929421934414;11269.661910142699;11477.885221147786;11693.356865372401;12516.186447880904;12893.097483176181;13840.238786866717;13854.792178117335;13905.304734763247;13922.164670119775;13928.233947132903;642.3127253838395;796.8446153000139;807.366217519246;811.059171361221;814.8818421328904;810.2100452059254;814;815.2662603656697;815.4373482297226;817.6361519123992;847.7795773099008;850.587465079436;851.3742399336483;854.363499193102;855.5422848775906;839.0225387423644;845.3659755183612;846.4371193156544;846.9999999999939;848.567230712335;620.3796203796204;623.4451338308909;624.3912185619031;625.2028663454087;626.5989766549412;12381.504739810487;12531.812022819666;12597.055220858472;12621.368931553385;12631.557895473614;12670.80993785094;12764.80852787209;12794.232346059172;12799.936000319938;12905;10088.142507886838;10093.949530252376;10268.229882758824;10297.845532317022;10322.380657160595;3250.837458127084;3338.065341704327;3339.699427051553;3463.7229021678204;3466.341395134916;49608.75195624035;49756.0048799022;50196.24705629418;50364.496355036346;50586;10031.749206269902;10126.645567405105;10225;10324.793504129875;10357.430341331148;16107.838921610868;16534.503964881074;16628.3348666052;16653;16673.166341682867;6740.898886516707;6765.188177418741;6840.247572766992;6888.793336199822;6890.173179218526;3726.273376691519;3782.487045081622;3795.1840354323954;3886.3198940185353;3896.532416110085;2863.7708983281286;2882.3514709190686;2913.1115009921755;2918.416316736661;2931.8387488688327;515.8942416804546;520.8723862653599;521.3769545393294;523.4529916237541;527.8337323743009;645.1645119570168;666.4068978609042;668.1481111582674;671.2884342596863;672.3343889549311;7885.448018638755;8208.09710931797;8254.669813207405;8343.8331233375;8539.74380768578;534.2600498309791;577.2812848004178;608.8325710429579;663.6283681138577;666.4934649666192;3926.6662333701956;3941.763494190358;3949.269385163754;3994.9201015979515;4082.387641853686;43050.569494304655;44988.10023799506;52813;52964.205536916976;53399.466005340226;39209.803950980066;39585;39609.40585891214;39827.80086099551;44759.32861007087;33387.16532086717;33467.99999999951;39088.218235635126;39834.804955851374;40475.39286910699;8115.310198632947;8352.665893364441;8514.191151840565;8635.784105397415;8652.134786521297;27863.582046269727;28140.71859281463;28216.29459263535;28304.292392690346;28545.714542854304;36025.63974360223;37873;38069.42895856509;38324.233515330096;38446.423303649906;9577.23382129442;9712.465814380277;9807.362521436084;9974.700758977242;10105.191584673355;11318.4906679198;11373.14701397382;11562.30626162433;11683.474243658886;11925.463354148911;11191.608293709682;11200.495977680861;11255.705593856484;11411.828822567833;11633.418329083343;11386.487608057492;11645.76708465809;11704.94147529291;12071.939640301742;12205.69485762863;11050.834237486284;11132.443377831238;11305.830412543983;11342;11764.176507644383;9104.45373277579;9446.29152813528;9463.952680236554;9640.807183856425;9697.563609637442;9419.858702119336;9767.365121267096;9771.218302535637;9833.557489913113;9893.802123957625 13:58:11 INFO - PROCESS | 3406 | __end_tp_report 13:58:11 INFO - PROCESS | 3406 | __start_cc_report 13:58:11 INFO - PROCESS | 3406 | _x_x_mozilla_cycle_collect,375 13:58:11 INFO - PROCESS | 3406 | __end_cc_report 13:58:11 INFO - PROCESS | 3406 | __startTimestamp1461272291760__endTimestamp 13:58:11 INFO - PROCESS | 3406 | 13:58:11 INFO - PROCESS | 3406 | ------- Summary: start ------- 13:58:11 INFO - PROCESS | 3406 | Number of tests: 6 13:58:11 INFO - PROCESS | 3406 | 13:58:11 INFO - PROCESS | 3406 | [#0] dojo.html Cycles:165 Average:4705.52 Median:4815.86 stddev:493.44 (10.2%) stddev-sans-first:467.06 13:58:11 INFO - PROCESS | 3406 | Values: 2620.7 2688.7 2721.0 2725.8 2739.3 4625.0 4648.8 4658.7 4693.2 4706.8 4646.1 4700.9 4702.0 4713.5 4726.8 4239.7 4287.9 4408.3 4415.7 4461.0 4315.7 4389.4 4429.9 4431.3 4464.8 4286.8 4372.1 4374.8 4426.4 4434.8 4374.7 4385.1 4407.6 4420.1 4426.5 4367.6 4374.7 4382.8 4423.9 4454.9 4504.8 4619.1 4683.7 4709.0 4745.8 5113.9 5114.8 5153.8 5154.2 5208.1 5209.6 5212.6 5215.1 5215.3 5216.8 4679.5 4807.0 4809.4 4851.2 4887.3 5196.6 5233.2 5235.5 5236.3 5251.7 4867.7 5007.6 5011.8 5019.6 5021.8 5094.5 5100.9 5130.6 5135.6 5185.3 5033.6 5040.7 5040.8 5045.9 5095.6 4882.4 4955.3 5030.9 5035.0 5056.7 4147.5 4252.7 4283.0 4310.3 4334.9 3749.2 3778.1 3809.3 3810.8 3876.4 4268.3 4375.0 4385.6 4394.2 4433.2 5072.0 5137.6 5138.7 5161.5 5194.7 4335.1 4349.0 4355.8 4361.2 4403.2 4510.8 4563.6 4617.1 4622.4 4658.0 4764.0 4783.4 4799.2 4815.9 4840.1 5096.2 5097.5 5119.2 5125.0 5170.9 4628.2 4747.3 4771.0 4825.8 4837.9 5000.1 5011.5 5031.2 5033.4 5053.5 5089.8 5098.7 5111.8 5117.0 5133.4 4800.8 4939.6 4958.3 5017.6 5048.1 4936.6 4937.9 4949.1 4985.3 5016.3 4866.3 4874.0 4886.6 4904.9 4944.2 4789.8 4801.7 4884.2 5089.9 5100.2 4890.3 4940.7 4957.0 4961.7 5008.3 13:58:11 INFO - PROCESS | 3406 | 13:58:11 INFO - PROCESS | 3406 | [#1] ext.html Cycles:180 Average:42386.68 Median:186773.75 stddev:75332.39 (40.3%) stddev-sans-first:75478.25 13:58:11 INFO - PROCESS | 3406 | Values: 555.7 586.4 598.4 625.6 626.4 33267.2 34355.7 34413.0 34473.5 34492.5 36728.6 37322.1 37463.8 37468.6 37574.8 7577.4 7753.9 7805.8 7822.6 7830.4 7589.4 7609.1 7641.9 7646.8 7680.9 7636.1 7681.1 7710.2 7721.1 7738.5 7624.4 7669.4 7681.2 7708.7 7723.0 7655.3 7738.3 7771.1 7774.7 7776.5 29128.7 35172.5 35794.1 35844.3 35954.6 3038.4 3052.8 3129.9 3341.8 3583.5 24270.3 24324.8 24586.3 24660.4 24661.4 3211.2 3234.0 3234.7 3291.6 3357.3 177778.0 178206.0 179248.0 179630.0 180557.0 31129.0 31211.7 31243.7 31320.0 31325.5 55874.7 57402.7 57452.1 57600.4 57721.0 13173.3 13392.1 13405.2 13443.9 13482.7 9668.8 9712.0 9746.5 9749.3 9795.2 18145.8 18177.5 18330.5 18427.6 18474.4 6951.5 7073.9 7087.1 7157.1 7229.5 844.0 852.1 909.2 960.7 1009.7 26530.5 27499.6 27628.0 27935.2 28012.7 983.6 993.6 1058.9 1078.2 1107.2 14490.9 15151.1 15192.3 15213.3 15246.7 335311.0 339611.0 341748.0 343990.0 344127.0 47919.0 48674.0 48694.0 48701.0 48730.5 1175.2 1204.1 1230.5 1242.7 1245.2 26168.3 27623.6 27755.6 27781.7 28303.3 41518.2 41852.8 42180.2 42305.2 42319.8 310558.0 311257.0 312131.0 312293.0 312487.0 24847.6 25409.9 25411.2 25467.4 37355.9 35667.5 36332.0 36627.3 36642.8 36678.6 29521.4 30607.5 30648.1 31360.8 31705.2 30384.4 30814.0 31225.7 34137.1 34781.5 32632.3 33867.2 33936.5 35730.0 36724.1 29544.3 31465.2 31520.8 31692.7 31840.5 23851.0 24148.3 24272.3 24749.8 24849.0 13:58:11 INFO - PROCESS | 3406 | 13:58:11 INFO - PROCESS | 3406 | [#2] jquery.html Cycles:180 Average:23426.59 Median:41818.69 stddev:63054.56 (150.8%) stddev-sans-first:63207.68 13:58:11 INFO - PROCESS | 3406 | Values: 370.5 373.8 375.5 375.9 383.8 15782.1 15951.2 15996.2 16498.8 16509.7 15422.4 16377.4 16464.4 16521.5 16593.6 4982.2 5193.5 5223.0 5241.1 5254.1 3685.1 5141.4 5618.7 5936.1 5944.1 5840.9 5855.1 5869.2 5871.3 5874.0 5688.1 5706.3 5775.9 5813.7 5833.6 4968.9 5079.6 5089.9 5113.6 5119.2 19781.3 19859.1 19894.5 19942.4 20041.8 2001.4 2050.3 2069.3 2181.4 2569.4 12920.0 13002.2 13055.5 13164.4 13581.7 1778.8 1812.5 1835.6 1842.1 1853.9 63503.7 63820.7 66514.3 66537.7 66637.3 9125.5 9253.5 9392.3 9552.3 9704.0 12789.4 12847.4 12940.7 12940.8 12992.3 6782.6 6836.9 6895.0 6900.6 6936.4 6469.6 6558.2 6600.5 6663.3 6693.7 5904.8 5954.7 5963.9 5976.2 6094.2 1615.6 1642.6 1730.9 1759.9 1796.9 892.7 912.8 938.9 969.4 1056.6 16364.8 16385.3 16633.6 16656.4 16837.9 907.1 952.6 967.6 974.6 975.2 9458.3 9520.5 9537.6 9538.6 9784.1 376600.0 384228.0 386115.0 386623.0 387125.0 64908.0 67324.7 67986.0 68981.3 69745.3 943.2 949.3 958.7 961.1 971.3 14683.4 14783.8 14837.9 14894.4 14930.3 29801.7 29965.6 31109.8 31401.8 31853.2 41677.6 41959.8 41975.6 42238.6 42494.4 7275.2 7325.5 7438.8 7520.0 7610.0 11470.8 11624.4 11636.2 11872.9 12335.1 10267.2 10560.5 10664.3 10943.9 11002.3 9847.8 10033.5 10176.3 10255.2 10339.1 10386.6 10433.0 10604.2 10628.3 11140.8 7378.4 7655.0 7939.6 8234.2 8257.3 9712.4 10301.8 10369.2 10397.8 10574.5 13:58:11 INFO - PROCESS | 3406 | 13:58:11 INFO - PROCESS | 3406 | [#3] mootools.html Cycles:180 Average:5068.62 Median:5153.34 stddev:2789.63 (54.1%) stddev-sans-first:2784.34 13:58:11 INFO - PROCESS | 3406 | Values: 1467.9 1496.0 1643.8 1776.1 1817.9 7354.2 7461.5 7554.6 7567.6 7570.1 6612.2 7424.0 7471.9 7688.8 7707.6 2174.4 2198.3 2215.2 2217.4 2224.6 2213.8 2214.3 2238.4 2239.5 2243.2 2217.3 2222.4 2225.5 2227.7 2227.8 2192.5 2194.5 2204.7 2205.9 2208.0 2158.5 2162.8 2163.0 2167.4 2170.9 7775.4 7919.9 7930.2 7939.0 7976.2 4504.3 4644.0 4649.3 4650.4 4654.2 2818.1 2860.8 2901.8 2914.7 2939.1 886.8 907.8 919.1 924.1 927.4 9961.5 10243.8 10292.9 10465.2 10658.3 3931.6 3977.6 4080.8 4084.9 4113.8 8035.5 8085.1 8096.0 8100.6 8140.5 4555.1 4580.4 4593.7 4601.9 4608.7 3607.3 4122.7 4224.8 4283.2 4287.9 3424.0 3519.7 3538.9 3582.8 3615.2 1032.0 1057.6 1062.4 1063.4 1072.1 853.8 863.7 866.9 885.0 890.7 5110.3 5204.1 5264.1 5265.0 5308.9 414.6 415.7 431.3 431.5 433.6 3367.9 3666.8 3684.0 3699.9 3727.8 9111.8 9423.6 9481.8 9545.6 9611.9 9298.8 9306.4 9324.2 9326.9 9351.8 7114.8 7265.2 7265.3 7270.2 7273.7 5094.1 5196.4 5307.2 5337.0 5348.3 8729.7 8797.9 8805.0 8808.6 8884.4 8172.6 8420.2 8459.2 8482.9 8538.0 5889.3 6782.5 6875.4 7187.2 7451.6 7556.8 7590.4 7596.3 7640.8 7641.3 6771.4 6972.9 7026.0 7118.5 7127.8 6565.2 6628.9 6677.1 6787.4 6877.7 6162.6 6348.7 6396.7 6481.6 6487.1 4706.4 4816.2 4843.8 4861.0 4910.0 4759.2 4814.4 4859.4 4943.7 4971.0 13:58:11 INFO - PROCESS | 3406 | 13:58:11 INFO - PROCESS | 3406 | [#4] prototype.html Cycles:180 Average:4623.01 Median:5271.04 stddev:1367.41 (25.9%) stddev-sans-first:1331.94 13:58:11 INFO - PROCESS | 3406 | Values: 286.1 289.6 296.0 307.0 313.4 5267.4 5274.6 5298.3 5341.4 5346.4 5235.7 5237.7 5243.4 5251.8 5257.3 3880.1 3992.9 4136.0 4136.6 4155.4 4125.9 4132.2 4132.8 4145.1 4156.9 4128.4 4128.6 4130.3 4138.8 4145.1 4040.1 4112.6 4122.7 4125.2 4131.3 3614.1 3634.8 3635.9 3639.6 3641.7 5070.3 5122.2 5128.1 5129.1 5140.7 4589.3 4733.8 4752.5 4761.8 4765.5 5544.6 5566.1 5570.0 5587.1 5606.5 3944.7 3968.5 3982.0 3997.4 4019.3 5539.0 5846.6 5867.2 5886.6 5907.1 3929.8 3964.7 3965.2 3970.0 3992.2 3999.1 4012.3 4019.4 4031.5 4045.7 4552.2 4656.0 4671.7 4682.4 4684.3 5549.8 5577.6 5590.1 5600.9 5653.9 1363.1 1377.9 1381.5 1382.7 1388.8 869.2 897.6 918.1 933.8 938.7 4844.8 4853.0 4853.5 4861.0 4865.5 5690.9 5696.3 5715.8 5724.9 5754.5 4618.1 4803.9 4819.7 4825.3 4875.6 3075.9 3107.3 3117.3 3117.9 3124.2 5361.6 5398.8 5422.2 5429.0 5439.5 5854.2 5883.3 5975.4 5993.3 5999.2 5413.8 5419.7 5426.9 5429.1 5441.5 5714.0 5819.4 5837.8 5839.6 5841.2 5704.7 5715.6 5716.6 5736.3 5743.7 5385.4 5414.0 5418.3 5418.5 5423.5 3800.2 3921.9 3948.2 3952.3 3955.9 5766.3 5769.2 5776.8 5789.8 5792.4 5592.6 5623.3 5640.9 5641.3 5643.0 5367.2 5545.4 5609.4 5668.7 5684.6 5284.8 5523.8 5561.2 5568.9 5568.9 5512.2 5641.3 5658.2 5694.2 5712.5 5519.4 5530.5 5541.8 5564.0 5574.1 13:58:11 INFO - PROCESS | 3406 | 13:58:11 INFO - PROCESS | 3406 | [#5] yui.html Cycles:180 Average:12516.28 Median:39831.30 stddev:13781.08 (34.6%) stddev-sans-first:13790.98 13:58:11 INFO - PROCESS | 3406 | Values: 659.5 691.0 701.8 710.0 762.5 11269.7 11477.9 11693.4 12516.2 12893.1 13840.2 13854.8 13905.3 13922.2 13928.2 642.3 796.8 807.4 811.1 814.9 810.2 814.0 815.3 815.4 817.6 847.8 850.6 851.4 854.4 855.5 839.0 845.4 846.4 847.0 848.6 620.4 623.4 624.4 625.2 626.6 12381.5 12531.8 12597.1 12621.4 12631.6 12670.8 12764.8 12794.2 12799.9 12905.0 10088.1 10093.9 10268.2 10297.8 10322.4 3250.8 3338.1 3339.7 3463.7 3466.3 49608.8 49756.0 50196.2 50364.5 50586.0 10031.7 10126.6 10225.0 10324.8 10357.4 16107.8 16534.5 16628.3 16653.0 16673.2 6740.9 6765.2 6840.2 6888.8 6890.2 3726.3 3782.5 3795.2 3886.3 3896.5 2863.8 2882.4 2913.1 2918.4 2931.8 515.9 520.9 521.4 523.5 527.8 645.2 666.4 668.1 671.3 672.3 7885.4 8208.1 8254.7 8343.8 8539.7 534.3 577.3 608.8 663.6 666.5 3926.7 3941.8 3949.3 3994.9 4082.4 43050.6 44988.1 52813.0 52964.2 53399.5 39209.8 39585.0 39609.4 39827.8 44759.3 33387.2 33468.0 39088.2 39834.8 40475.4 8115.3 8352.7 8514.2 8635.8 8652.1 27863.6 28140.7 28216.3 28304.3 28545.7 36025.6 37873.0 38069.4 38324.2 38446.4 9577.2 9712.5 9807.4 9974.7 10105.2 11318.5 11373.1 11562.3 11683.5 11925.5 11191.6 11200.5 11255.7 11411.8 11633.4 11386.5 11645.8 11704.9 12071.9 12205.7 11050.8 11132.4 11305.8 11342.0 11764.2 9104.5 9446.3 9464.0 9640.8 9697.6 9419.9 9767.4 9771.2 9833.6 9893.8 13:58:11 INFO - PROCESS | 3406 | -------- Summary: end -------- 13:58:11 INFO - PROCESS | 3406 | 13:58:12 INFO - TEST-INFO | 3406: exit 0 13:58:12 INFO - TEST-OK | dromaeo_css | took 1118600ms 13:58:12 INFO - TEST-START | kraken 13:58:12 INFO - operating with platform_type : linux_ 13:58:12 INFO - Initialising browser for kraken test... 13:58:12 INFO - TEST-INFO | started process 3641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKmb2rx/profile http://localhost:46842/getInfo.html) 13:58:16 INFO - PROCESS | 3641 | 13:58:16 INFO - PROCESS | 3641 | (process:3709): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:58:17 INFO - PROCESS | 3641 | __metrics Screen width/height:1600/1200 13:58:17 INFO - PROCESS | 3641 | colorDepth:24 13:58:17 INFO - PROCESS | 3641 | Browser inner width/height: 1024/697 13:58:17 INFO - PROCESS | 3641 | __metrics 13:58:18 ERROR - PROCESS | 3641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:58:19 INFO - TEST-INFO | 3641: exit 0 13:58:19 INFO - Browser initialized. 13:58:19 INFO - Running cycle 1/1 for kraken test... 13:58:19 INFO - TEST-INFO | started process 3761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKmb2rx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:58:21 INFO - PROCESS | 3761 | 13:58:21 INFO - PROCESS | 3761 | (process:3820): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:58:31 INFO - PROCESS | 3761 | RSS: Main: 165130240 13:58:31 INFO - PROCESS | 3761 | 13:58:34 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46842/tests/kraken/driver.html?testName=audio-beat-detection) 13:58:34 INFO - PROCESS | 3761 | RSS: Main: 169463808 13:58:34 INFO - PROCESS | 3761 | 13:58:37 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46842/tests/kraken/driver.html?testName=audio-dft) 13:58:38 INFO - PROCESS | 3761 | RSS: Main: 173072384 13:58:38 INFO - PROCESS | 3761 | 13:58:41 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46842/tests/kraken/driver.html?testName=audio-fft) 13:58:42 INFO - PROCESS | 3761 | RSS: Main: 164720640 13:58:42 INFO - PROCESS | 3761 | 13:58:44 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46842/tests/kraken/driver.html?testName=audio-oscillator) 13:58:44 INFO - PROCESS | 3761 | RSS: Main: 164638720 13:58:44 INFO - PROCESS | 3761 | 13:58:47 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46842/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:58:47 INFO - PROCESS | 3761 | RSS: Main: 165089280 13:58:47 INFO - PROCESS | 3761 | 13:58:50 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46842/tests/kraken/driver.html?testName=imaging-darkroom) 13:58:51 INFO - PROCESS | 3761 | RSS: Main: 165203968 13:58:51 INFO - PROCESS | 3761 | 13:58:55 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46842/tests/kraken/driver.html?testName=imaging-desaturate) 13:58:55 INFO - PROCESS | 3761 | RSS: Main: 164827136 13:58:55 INFO - PROCESS | 3761 | 13:58:58 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46842/tests/kraken/driver.html?testName=json-parse-financial) 13:58:59 INFO - PROCESS | 3761 | RSS: Main: 165486592 13:58:59 INFO - PROCESS | 3761 | 13:59:00 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46842/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:59:01 INFO - PROCESS | 3761 | RSS: Main: 165629952 13:59:02 INFO - PROCESS | 3761 | 13:59:03 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46842/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:59:04 INFO - PROCESS | 3761 | RSS: Main: 165777408 13:59:04 INFO - PROCESS | 3761 | 13:59:06 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46842/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:59:06 INFO - PROCESS | 3761 | RSS: Main: 166572032 13:59:06 INFO - PROCESS | 3761 | 13:59:10 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:59:11 INFO - PROCESS | 3761 | RSS: Main: 162942976 13:59:11 INFO - PROCESS | 3761 | 13:59:14 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:59:15 INFO - PROCESS | 3761 | RSS: Main: 163495936 13:59:15 INFO - PROCESS | 3761 | 13:59:16 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:46842/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46842/tests/kraken/driver.html?testName=ai-astar) 13:59:17 INFO - PROCESS | 3761 | RSS: Main: 166043648 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | __start_tp_report 13:59:17 INFO - PROCESS | 3761 | _x_x_mozilla_page_load 13:59:17 INFO - PROCESS | 3761 | _x_x_mozilla_page_load_details 13:59:17 INFO - PROCESS | 3761 | |i|pagename|runs| 13:59:17 INFO - PROCESS | 3761 | |0;ai-astar;116;110;111;114;114;127;114;116;114;114 13:59:17 INFO - PROCESS | 3761 | |1;audio-beat-detection;165;140;153;183;136;155;165;141;191;141 13:59:17 INFO - PROCESS | 3761 | |2;audio-dft;163;165;165;174;161;165;163;161;163;162 13:59:17 INFO - PROCESS | 3761 | |3;audio-fft;74;74;77;153;78;77;78;77;154;74 13:59:17 INFO - PROCESS | 3761 | |4;audio-oscillator;96;95;153;95;95;94;154;97;95;141 13:59:17 INFO - PROCESS | 3761 | |5;imaging-gaussian-blur;118;119;118;120;118;117;118;118;117;118 13:59:17 INFO - PROCESS | 3761 | |6;imaging-darkroom;148;148;148;149;148;147;148;148;148;149 13:59:17 INFO - PROCESS | 3761 | |7;imaging-desaturate;95;96;95;96;95;95;95;95;94;96 13:59:17 INFO - PROCESS | 3761 | |8;json-parse-financial;73;67;66;66;65;67;65;83;65;64 13:59:17 INFO - PROCESS | 3761 | |9;json-stringify-tinderbox;65;65;66;64;65;66;64;64;64;65 13:59:17 INFO - PROCESS | 3761 | |10;stanford-crypto-aes;88;79;81;83;80;80;81;80;81;80 13:59:17 INFO - PROCESS | 3761 | |11;stanford-crypto-ccm;135;138;134;137;140;136;141;147;221;141 13:59:17 INFO - PROCESS | 3761 | |12;stanford-crypto-pbkdf2;180;178;186;176;178;181;182;177;183;176 13:59:17 INFO - PROCESS | 3761 | |13;stanford-crypto-sha256-iterative;74;74;77;75;74;73;72;74;81;73 13:59:17 INFO - PROCESS | 3761 | __end_tp_report 13:59:17 INFO - PROCESS | 3761 | __start_cc_report 13:59:17 INFO - PROCESS | 3761 | _x_x_mozilla_cycle_collect,909 13:59:17 INFO - PROCESS | 3761 | __end_cc_report 13:59:17 INFO - PROCESS | 3761 | __startTimestamp1461272357208__endTimestamp 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | ------- Summary: start ------- 13:59:17 INFO - PROCESS | 3761 | Number of tests: 14 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.00 stddev:4.62 (4.1%) stddev-sans-first:4.88 13:59:17 INFO - PROCESS | 3761 | Values: 116.0 110.0 111.0 114.0 114.0 127.0 114.0 116.0 114.0 114.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:160.00 stddev:18.92 (11.8%) stddev-sans-first:19.85 13:59:17 INFO - PROCESS | 3761 | Values: 165.0 140.0 153.0 183.0 136.0 155.0 165.0 141.0 191.0 141.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.77 (2.3%) stddev-sans-first:3.97 13:59:17 INFO - PROCESS | 3761 | Values: 163.0 165.0 165.0 174.0 161.0 165.0 163.0 161.0 163.0 162.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#3] audio-fft Cycles:10 Average:91.60 Median:77.00 stddev:32.66 (42.4%) stddev-sans-first:34.02 13:59:17 INFO - PROCESS | 3761 | Values: 74.0 74.0 77.0 153.0 78.0 77.0 78.0 77.0 154.0 74.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:95.00 stddev:26.34 (27.7%) stddev-sans-first:27.33 13:59:17 INFO - PROCESS | 3761 | Values: 96.0 95.0 153.0 95.0 95.0 94.0 154.0 97.0 95.0 141.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 13:59:17 INFO - PROCESS | 3761 | Values: 118.0 119.0 118.0 120.0 118.0 117.0 118.0 118.0 117.0 118.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 13:59:17 INFO - PROCESS | 3761 | Values: 148.0 148.0 148.0 149.0 148.0 147.0 148.0 148.0 148.0 149.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 13:59:17 INFO - PROCESS | 3761 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 94.0 96.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:66.50 stddev:5.80 (8.7%) stddev-sans-first:5.88 13:59:17 INFO - PROCESS | 3761 | Values: 73.0 67.0 66.0 66.0 65.0 67.0 65.0 83.0 65.0 64.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 13:59:17 INFO - PROCESS | 3761 | Values: 65.0 65.0 66.0 64.0 65.0 66.0 64.0 64.0 64.0 65.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:2.58 (3.2%) stddev-sans-first:1.13 13:59:17 INFO - PROCESS | 3761 | Values: 88.0 79.0 81.0 83.0 80.0 80.0 81.0 80.0 81.0 80.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:140.50 stddev:26.27 (18.7%) stddev-sans-first:27.50 13:59:17 INFO - PROCESS | 3761 | Values: 135.0 138.0 134.0 137.0 140.0 136.0 141.0 147.0 221.0 141.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:180.50 stddev:3.30 (1.8%) stddev-sans-first:3.50 13:59:17 INFO - PROCESS | 3761 | Values: 180.0 178.0 186.0 176.0 178.0 181.0 182.0 177.0 183.0 176.0 13:59:17 INFO - PROCESS | 3761 | 13:59:17 INFO - PROCESS | 3761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:74.00 stddev:2.58 (3.5%) stddev-sans-first:2.73 13:59:17 INFO - PROCESS | 3761 | Values: 74.0 74.0 77.0 75.0 74.0 73.0 72.0 74.0 81.0 73.0 13:59:17 INFO - PROCESS | 3761 | -------- Summary: end -------- 13:59:17 INFO - PROCESS | 3761 | 13:59:18 INFO - TEST-INFO | 3761: exit 0 13:59:18 INFO - TEST-OK | kraken | took 65719ms 13:59:18 INFO - SUITE-END | took 1184s 13:59:18 INFO - Completed test suite (00:19:44) 13:59:18 INFO - javascript benchmark 13:59:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.7117217106115, 2688.74456926592, 2721.034032918315, 2725.7546820786138, 2739.3288644282143, 4625.0, 4648.837290694826, 4658.697184682993, 4693.155232058228, 4706.764661766915, 4646.1172377248295, 4700.905981880369, 4702.0360826030665, 4713.505081966396, 4726.763661816913, 4239.745615263078, 4287.914241715163, 4408.294672852344, 4415.690901636886, 4461.040876211614, 4315.676324275676, 4389.385486031958, 4429.911401771963, 4431.335299705038, 4464.799084041226, 4286.7856607169515, 4372.125574885035, 4374.803133858984, 4426.424564806571, 4434.756088415136, 4374.715643483163, 4385.1229754049, 4407.559244075599, 4420.138073075752, 4426.468823741139, 4367.606915377632, 4374.693771436001, 4382.780860956971, 4423.867283981485, 4454.866354009385, 4504.842330518416, 4619.0530941156985, 4683.718976861365, 4708.964027913854, 4745.810167593292, 5113.897722045575, 5114.795408183668, 5153.768080436389, 5154.175331946908, 5208.088584497736, 5209.557187639018, 5212.582993360522, 5215.113430716788, 5215.348081489814, 5216.765245563959, 4679.508651591568, 4807.0, 4809.350737650442, 4851.175300198975, 4887.315775791392, 5196.584273258206, 5233.215017747369, 5235.4502777207845, 5236.319278493847, 5251.711155886463, 4867.7322747249245, 5007.624428167902, 5011.824586139468, 5019.598432125421, 5021.774020169101, 5094.490550944876, 5100.897982040338, 5130.589552835764, 5135.563477104413, 5185.274061631375, 5033.597312215014, 5040.722760248148, 5040.823571174991, 5045.873853153627, 5095.643304968617, 4882.414110306786, 4955.2567114933045, 5030.893203495225, 5034.993001399662, 5056.671316364498, 4147.543770185277, 4252.702310838274, 4283.0363168286885, 4310.3103503439925, 4334.869953901388, 3749.1751814600743, 3778.1499162688174, 3809.314323421755, 3810.847566097325, 3876.3604005338802, 4268.274393353137, 4375.0, 4385.583369579885, 4394.1651086293505, 4433.1577000369825, 5071.985602879439, 5137.640365174402, 5138.665986710852, 5161.483851614808, 5194.714290714047, 4335.089631177488, 4348.978255108705, 4355.760433176142, 4361.214981303396, 4403.229434848889, 4510.819567217274, 4563.566461186182, 4617.12274667812, 4622.445306563234, 4657.976710116428, 4763.951930575268, 4783.425988881357, 4799.232122860326, 4815.855524334275, 4840.080384726891, 5096.159133743039, 5097.490250974873, 5119.232115182753, 5125.0, 5170.8965820684125, 4628.166929952641, 4747.264174053027, 4771.045790841776, 4825.806967721252, 4837.927431088607, 5000.124978128885, 5011.473795251592, 5031.245313203049, 5033.395992480926, 5053.469385714447, 5089.847304580869, 5098.694078355311, 5111.846644600668, 5117.0, 5133.358330208724, 4800.807967681254, 4939.5554400104165, 4958.281049247911, 5017.623678224075, 5048.066107770074, 4936.605071594336, 4937.925931111108, 4949.109160351028, 4985.277134815504, 5016.297718319365, 4866.294387313749, 4873.951260487492, 4886.584640305614, 4904.852854414374, 4944.208926571875, 4789.760511974457, 4801.735904525145, 4884.194107972145, 5089.949100508948, 5100.158473851921, 4890.2909078184175, 4940.6788558743565, 4957.0, 4961.70229786214, 5008.273800299009], "value": 4674.532020883777, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6608573338253, 586.4165155670107, 598.4464370457326, 625.6183727925967, 626.3986572890026, 33267.16832079196, 34355.65644343556, 34413.0, 34473.482897756556, 34492.482612760796, 36728.592568891705, 37322.066948326305, 37463.81268093662, 37468.62531374685, 37574.81212593933, 7577.431692623048, 7753.922460775377, 7805.804854878645, 7822.647980840848, 7830.373570114377, 7589.354904833068, 7609.124950630665, 7641.885371719429, 7646.808829779245, 7680.923190768104, 7636.083669959613, 7681.078270607507, 7710.151883292861, 7721.073471183466, 7738.4969976951315, 7624.42816788743, 7669.424793140509, 7681.23187681233, 7708.730194443224, 7722.961385193066, 7655.349295309906, 7738.342240909529, 7771.067471903351, 7774.6501407436235, 7776.494527855728, 29128.708712912812, 35172.47241291383, 35794.105147371265, 35844.283114337566, 35954.64045359565, 3038.4075105354464, 3052.7597604314265, 3129.906102816919, 3341.7827841190247, 3583.4624806279007, 24270.271891843273, 24324.756752432604, 24586.262412127486, 24660.383490412703, 24661.38346541351, 3211.165097074754, 3233.967660323414, 3234.741220702338, 3291.5720956275773, 3357.3285342931513, 177778.0, 178206.0, 179248.0, 179630.0, 180557.0, 31129.0, 31211.687883121333, 31243.68756312453, 31320.0, 31325.530117047805, 55874.72062639661, 57402.7129864348, 57452.13821792677, 57600.42399576034, 57721.0, 13173.275469849059, 13392.12951158191, 13405.195688258736, 13443.932780336036, 13482.662933426744, 9668.806623867624, 9711.951440242754, 9746.512674366253, 9749.317547771589, 9795.216382689368, 18145.81854181468, 18177.545561360806, 18330.541736456427, 18427.63144737098, 18474.353397631286, 6951.478639101986, 7073.92926070743, 7087.149542054986, 7157.105361829771, 7229.530080544748, 843.9534976628936, 852.1435956863313, 909.1908201700492, 960.673371053845, 1009.7071849163807, 26530.469390612467, 27499.587506187425, 27628.033018844242, 27935.161945141677, 28012.71987280142, 983.5819776594918, 993.557866749304, 1058.915286777056, 1078.2021304234809, 1107.2249425402251, 14490.927545362205, 15151.106111736033, 15192.316345764468, 15213.31540080699, 15246.695066098839, 335311.0, 339611.0, 341748.0, 343990.0, 344127.0, 47919.0, 48674.0, 48694.0, 48701.0, 48730.51269487331, 1175.2302242031483, 1204.1209916760638, 1230.5200971621075, 1242.7452372263665, 1245.1844042152404, 26168.34579135537, 27623.58564621492, 27755.583666245428, 27781.722182777914, 28303.29241768972, 41518.16963660649, 41852.790736046125, 42180.1563968725, 42305.15389692251, 42319.7884010578, 310558.0, 311257.0, 312131.0, 312293.0, 312487.0, 24847.62728559037, 25409.87295063513, 25411.237662870142, 25467.36331591725, 37355.879323620335, 35667.46498802572, 36332.0, 36627.26745465129, 36642.8167859159, 36678.63321366752, 29521.409571808872, 30607.54088688716, 30648.080557583307, 31360.843195783877, 31705.20736981594, 30384.39231215319, 30814.0, 31225.68774312228, 34137.146571334924, 34781.47827782535, 32632.34735305328, 33867.15332116717, 33936.490952636224, 35730.0, 36724.08189795277, 29544.261393465335, 31465.21336966594, 31520.81096601851, 31692.683073169894, 31840.52239216367, 23851.0, 24148.275551733477, 24272.27183184507, 24749.752502474745, 24849.006039758206], "value": 16554.588069914695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.4683778777454, 373.8074891430912, 375.48558474889387, 375.8947494701484, 383.8216674808339, 15782.131982740944, 15951.202439878003, 15996.200189990483, 16498.75251871223, 16509.669806603877, 15422.383104675828, 16377.42679006235, 16464.423745168922, 16521.504354869372, 16593.585160370996, 4982.177940639799, 5193.5325820676135, 5223.033738758342, 5241.109011468059, 5254.054270231357, 3685.09715119796, 5141.434442211354, 5618.747156377973, 5936.139259807325, 5944.078667806475, 5840.853978650525, 5855.121731740231, 5869.178315035899, 5871.29544454666, 5873.970630146843, 5688.061469857489, 5706.28671416073, 5775.855603609902, 5813.6802475863815, 5833.562482813806, 4968.925466118011, 5079.644424890223, 5089.898202035975, 5113.590912726973, 5119.206522988943, 19781.307654232034, 19859.106340214727, 19894.502637434034, 19942.401727948185, 20041.79958200414, 2001.3895761792648, 2050.3336415664967, 2069.3378119001927, 2181.4219231903558, 2569.396191894903, 12920.0, 13002.219866808022, 13055.477780888754, 13164.40760165795, 13581.728365432735, 1778.759867417895, 1812.474382429094, 1835.6420498002894, 1842.0789605197401, 1853.8966987368358, 63503.6824815873, 63820.68089659568, 66514.3348566513, 66537.66731166313, 66637.33362666408, 9125.543722813833, 9253.537323133816, 9392.29557783169, 9552.331336806357, 9704.0, 12789.36053197355, 12847.357632118543, 12940.741185176244, 12940.805887911689, 12992.285424301564, 6782.626955517494, 6836.863262734817, 6895.0, 6900.5859648420255, 6936.410405115622, 6469.5794773339585, 6558.245801732862, 6600.53796234259, 6663.333666633298, 6693.698783554752, 5904.793332233351, 5954.672493012926, 5963.850903727442, 5976.223090998143, 6094.232672525007, 1615.6122530592572, 1642.5729310379388, 1730.9221085051204, 1759.9032053237195, 1796.9191386387645, 892.6786356911507, 912.8356895758827, 938.9389689670286, 969.3795970578835, 1056.6196169379018, 16364.754528682079, 16385.344586216655, 16633.584160395843, 16656.417025404295, 16837.915810421113, 907.1155623267261, 952.64752041745, 967.579103090158, 974.5760594141572, 975.2198241406846, 9458.290628202913, 9520.476373799507, 9537.618495260112, 9538.635014244499, 9784.119429251401, 376600.0, 384228.0, 386115.0, 386623.0, 387125.0, 64908.0, 67324.6633766828, 67986.0, 68981.3101868985, 69745.3025469749, 943.193569498083, 949.292776881228, 958.6836344006462, 961.0581630002497, 971.32007594684, 14683.412663493767, 14783.778243326575, 14837.851621483647, 14894.40422383136, 14930.253487325373, 29801.701982979892, 29965.550516742704, 31109.844450778506, 31401.8429907849, 31853.20366990844, 41677.58322416737, 41959.790201048796, 41975.58024419717, 42238.57761422346, 42494.36258456187, 7275.163356213891, 7325.4872158948365, 7438.776836694908, 7519.962400187964, 7609.961950190213, 11470.827937580776, 11624.360660163773, 11636.243644163102, 11872.881271187178, 12335.136540442083, 10267.229957753349, 10560.455760725681, 10664.253502255078, 10943.890561094606, 11002.33985960845, 9847.753806154904, 10033.548490318099, 10176.287659863738, 10255.230857685554, 10339.121174699934, 10386.636467723594, 10433.0, 10604.151667866707, 10628.25602207838, 11140.777184456103, 7378.4466165036765, 7654.961725191339, 7939.6030198491, 8234.176582341717, 8257.256846883809, 9712.417254964725, 10301.793964120825, 10369.170466362522, 10397.792044158923, 10574.471276435994], "value": 8255.034529433153, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.911925284483, 1495.9850401495985, 1643.7945256842895, 1776.0941919621005, 1817.9363722269723, 7354.227806080365, 7461.515001524911, 7554.584497852629, 7567.621618919053, 7570.05374328209, 6612.206535215781, 7423.9628801855915, 7471.850562988737, 7688.807779805494, 7707.576083315415, 2174.3911704722664, 2198.3075331270597, 2215.213599172295, 2217.390217690132, 2224.5662095891307, 2213.8339624528144, 2214.2914267434426, 2238.40682219212, 2239.5185035217423, 2243.2372993182316, 2217.2904670505363, 2222.411061068818, 2225.4770129019666, 2227.7438094619083, 2227.8106360959337, 2192.5286063496346, 2194.462356722597, 2204.7464541577765, 2205.8566193197553, 2208.0, 2158.5143342747915, 2162.848600597959, 2163.0374483354913, 2167.382296045635, 2170.913163473459, 7775.4168437367425, 7919.851621514906, 7930.206979302024, 7939.047314322318, 7976.202379761978, 4504.346869703874, 4644.0, 4649.302604609302, 4650.395448591696, 4654.232051711463, 2818.126380821952, 2860.828350298989, 2901.76785857133, 2914.6502419709773, 2939.1476471823144, 886.7561420609384, 907.7957459571544, 919.1314208073373, 924.0528458330265, 927.3740225347864, 9961.501924903798, 10243.79512409755, 10292.897071029269, 10465.162786977024, 10658.307210031324, 3931.6461518463475, 3977.622125898035, 4080.81636326366, 4084.8774536763945, 4113.814878330482, 8035.517868927883, 8085.070216925012, 8096.0, 8100.594970251464, 8140.470869393471, 4555.111753208159, 4580.404547408815, 4593.678442508993, 4601.884952876205, 4608.723476591415, 3607.2965771674794, 4122.711410201257, 4224.831006759757, 4283.22901877665, 4287.871363859089, 3423.9657603424143, 3519.6832285094465, 3538.858445662196, 3582.8208589570418, 3615.240799432149, 1031.9896801032044, 1057.582255009267, 1062.39443517196, 1063.4310643805527, 1072.088724584113, 853.7865533616596, 863.6631713631689, 866.9393142479965, 884.9999500564321, 890.7238755985666, 5110.310108135429, 5204.141316682781, 5264.078786212397, 5264.973675131677, 5308.893822123536, 414.56884839766303, 415.738085006444, 431.2776100032496, 431.46067415730334, 433.6032530234863, 3367.865285388606, 3666.7616604920595, 3684.024087849829, 3699.8705045323286, 3727.7949712765517, 9111.81776364469, 9423.623055077856, 9481.810363792685, 9545.618175272912, 9611.903880961101, 9298.814023719488, 9306.441613503212, 9324.207442367338, 9326.906730932604, 9351.812963740687, 7114.822129446805, 7265.164506081763, 7265.273472652798, 7270.236625154283, 7273.745418910418, 5094.057599344133, 5196.376434827845, 5307.150855863043, 5336.973315133399, 5348.277982472317, 8729.650813967624, 8797.912020879965, 8805.031446541003, 8808.647654093764, 8884.422512536665, 8172.591370431336, 8420.200080992296, 8459.238668519863, 8482.872756908775, 8537.957310213409, 5889.263842019747, 6782.525223234524, 6875.449964002968, 7187.209406965125, 7451.552906825608, 7556.811079723051, 7590.354819840375, 7596.316331530189, 7640.847183056197, 7641.312281894656, 6771.3905748482875, 6972.930270697431, 7025.981232721125, 7118.501704880816, 7127.82180445493, 6565.179352580927, 6628.933710662832, 6677.098591690254, 6787.355201255873, 6877.724891004504, 6162.599431036968, 6348.714307856065, 6396.71214795326, 6481.578697384655, 6487.091807147098, 4706.364640773451, 4816.157172494729, 4843.806247750051, 4860.95139048605, 4909.950900491092, 4759.16714574941, 4814.350062741485, 4859.392575928009, 4943.728094954668, 4970.950290497049], "value": 4043.1563105109085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.12873799281186, 289.62782824071076, 296.0127973209347, 306.96469905960817, 313.35761688538497, 5267.4469180736, 5274.630775845688, 5298.284731561238, 5341.359036915565, 5346.438623944488, 5235.659682120659, 5237.659552129109, 5243.397009343927, 5251.789928402859, 5257.316548848654, 3880.1075752576994, 3992.920141597166, 4135.979320103395, 4136.565660605638, 4155.39746736723, 4125.876223713293, 4132.173565286939, 4132.793360331986, 4145.129522800215, 4156.854510092147, 4128.380742888561, 4128.60778226068, 4130.277201489742, 4138.813753381105, 4145.0880806222585, 4040.1111755413763, 4112.609302116294, 4122.711410201287, 4125.195586860564, 4131.338985762279, 3614.0964758810296, 3634.818259087035, 3635.909102272438, 3639.5632524097014, 3641.708663306929, 5070.29015937769, 5122.206058061007, 5128.051310507531, 5129.12804823181, 5140.742962851842, 4589.2886602576655, 4733.786979585927, 4752.5485078917445, 4761.833350829034, 4765.475797662289, 5544.556435485151, 5566.10752344205, 5570.047874626454, 5587.1339942309005, 5606.523445507096, 3944.664703500206, 3968.511808071973, 3981.98009009956, 3997.360422332442, 4019.2966230909765, 5539.0, 5846.619969701998, 5867.178594996704, 5886.558508111909, 5907.084401917709, 3929.76421414716, 3964.6630036447227, 3965.1673148638533, 3969.980150099231, 3992.2414741199077, 3999.1002024544246, 4012.29784787661, 4019.437278780973, 4031.536373317106, 4045.7370270932884, 4552.1806074906835, 4656.022235330618, 4671.743054131987, 4682.367880336179, 4684.273937539687, 5549.7780088796, 5577.581681373913, 5590.077637189818, 5600.887982240332, 5653.943460565424, 1363.1412210307442, 1377.8622137786342, 1381.5095641047485, 1382.7096309774859, 1388.777795552727, 869.1699427047281, 897.6364572348209, 918.1415376622879, 933.8319102561468, 938.671464987249, 4844.802430395922, 4852.975735121302, 4853.538913803183, 4860.975695121501, 4865.513448655177, 5690.9146362804595, 5696.287964004499, 5715.799947001919, 5724.942750572524, 5754.482096611325, 4618.122556714214, 4803.927941080887, 4819.662623616383, 4825.30033145199, 4875.634327425386, 3075.9384812304074, 3107.347457034003, 3117.2830249042845, 3117.9376412471624, 3124.1877111950603, 5361.624686272002, 5398.757055932492, 5422.15956526739, 5429.0, 5439.5104440600535, 5854.2096816930025, 5883.294004719461, 5975.43233392827, 5993.310769261503, 5999.2002399280045, 5413.810516631899, 5419.674819510763, 5426.945730542644, 5429.104197807317, 5441.455854414606, 5714.028660112254, 5819.447152520504, 5837.824865254049, 5839.591228613956, 5841.1530328101335, 5704.714764261853, 5715.628484148517, 5716.5998380113, 5736.340320863154, 5743.74153163117, 5385.380681221553, 5413.972930135482, 5418.295621569171, 5418.485243901823, 5423.457654234545, 3800.201957588937, 3921.9019524510973, 3948.1511475033008, 3952.308346039374, 3955.9406608901463, 5766.3368712598585, 5769.1634712967225, 5776.797812076557, 5789.768409263583, 5792.391798861059, 5592.552595792408, 5623.297087864017, 5640.88718225625, 5641.294838145232, 5642.981005162219, 5367.194920761917, 5545.395492929628, 5609.411011843697, 5668.688222147822, 5684.607271218578, 5284.762185701576, 5523.7790488380015, 5561.193626924154, 5568.860778480571, 5568.944310557004, 5512.228288039598, 5641.294838145232, 5658.207850900795, 5694.174344720075, 5712.485876271156, 5519.420460851713, 5530.5022547970875, 5541.778328866801, 5564.0, 5574.08027675429], "value": 4175.931496809916, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.5284371674252, 690.9896351554728, 701.7719241246596, 709.9999999999999, 762.4929421934414, 11269.661910142699, 11477.885221147786, 11693.356865372401, 12516.186447880904, 12893.097483176181, 13840.238786866717, 13854.792178117335, 13905.304734763247, 13922.164670119775, 13928.233947132903, 642.3127253838395, 796.8446153000139, 807.366217519246, 811.059171361221, 814.8818421328904, 810.2100452059254, 814.0, 815.2662603656697, 815.4373482297226, 817.6361519123992, 847.7795773099008, 850.587465079436, 851.3742399336483, 854.363499193102, 855.5422848775906, 839.0225387423644, 845.3659755183612, 846.4371193156544, 846.9999999999939, 848.567230712335, 620.3796203796204, 623.4451338308909, 624.3912185619031, 625.2028663454087, 626.5989766549412, 12381.504739810487, 12531.812022819666, 12597.055220858472, 12621.368931553385, 12631.557895473614, 12670.80993785094, 12764.80852787209, 12794.232346059172, 12799.936000319938, 12905.0, 10088.142507886838, 10093.949530252376, 10268.229882758824, 10297.845532317022, 10322.380657160595, 3250.837458127084, 3338.065341704327, 3339.699427051553, 3463.7229021678204, 3466.341395134916, 49608.75195624035, 49756.0048799022, 50196.24705629418, 50364.496355036346, 50586.0, 10031.749206269902, 10126.645567405105, 10225.0, 10324.793504129875, 10357.430341331148, 16107.838921610868, 16534.503964881074, 16628.3348666052, 16653.0, 16673.166341682867, 6740.898886516707, 6765.188177418741, 6840.247572766992, 6888.793336199822, 6890.173179218526, 3726.273376691519, 3782.487045081622, 3795.1840354323954, 3886.3198940185353, 3896.532416110085, 2863.7708983281286, 2882.3514709190686, 2913.1115009921755, 2918.416316736661, 2931.8387488688327, 515.8942416804546, 520.8723862653599, 521.3769545393294, 523.4529916237541, 527.8337323743009, 645.1645119570168, 666.4068978609042, 668.1481111582674, 671.2884342596863, 672.3343889549311, 7885.448018638755, 8208.09710931797, 8254.669813207405, 8343.8331233375, 8539.74380768578, 534.2600498309791, 577.2812848004178, 608.8325710429579, 663.6283681138577, 666.4934649666192, 3926.6662333701956, 3941.763494190358, 3949.269385163754, 3994.9201015979515, 4082.387641853686, 43050.569494304655, 44988.10023799506, 52813.0, 52964.205536916976, 53399.466005340226, 39209.803950980066, 39585.0, 39609.40585891214, 39827.80086099551, 44759.32861007087, 33387.16532086717, 33467.99999999951, 39088.218235635126, 39834.804955851374, 40475.39286910699, 8115.310198632947, 8352.665893364441, 8514.191151840565, 8635.784105397415, 8652.134786521297, 27863.582046269727, 28140.71859281463, 28216.29459263535, 28304.292392690346, 28545.714542854304, 36025.63974360223, 37873.0, 38069.42895856509, 38324.233515330096, 38446.423303649906, 9577.23382129442, 9712.465814380277, 9807.362521436084, 9974.700758977242, 10105.191584673355, 11318.4906679198, 11373.14701397382, 11562.30626162433, 11683.474243658886, 11925.463354148911, 11191.608293709682, 11200.495977680861, 11255.705593856484, 11411.828822567833, 11633.418329083343, 11386.487608057492, 11645.76708465809, 11704.94147529291, 12071.939640301742, 12205.69485762863, 11050.834237486284, 11132.443377831238, 11305.830412543983, 11342.0, 11764.176507644383, 9104.45373277579, 9446.29152813528, 9463.952680236554, 9640.807183856425, 9697.563609637442, 9419.858702119336, 9767.365121267096, 9771.218302535637, 9833.557489913113, 9893.802123957625], "value": 5973.806250059242, "unit": "score"}], "name": "dromaeo_css", "value": 6331.755344710421, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 111.0, 114.0, 114.0, 127.0, 114.0, 116.0, 114.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 140.0, 153.0, 183.0, 136.0, 155.0, 165.0, 141.0, 191.0, 141.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 174.0, 161.0, 165.0, 163.0, 161.0, 163.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 153.0, 78.0, 77.0, 78.0, 77.0, 154.0, 74.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 153.0, 95.0, 95.0, 94.0, 154.0, 97.0, 95.0, 141.0], "value": 111.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 120.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 147.0, 148.0, 148.0, 148.0, 149.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 67.0, 66.0, 66.0, 65.0, 67.0, 65.0, 83.0, 65.0, 64.0], "value": 68.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 64.0, 65.0, 66.0, 64.0, 64.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 81.0, 83.0, 80.0, 80.0, 81.0, 80.0, 81.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 134.0, 137.0, 140.0, 136.0, 141.0, 147.0, 221.0, 141.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 178.0, 186.0, 176.0, 178.0, 181.0, 182.0, 177.0, 183.0, 176.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 75.0, 74.0, 73.0, 72.0, 74.0, 81.0, 73.0], "value": 74.7, "unit": "score"}], "name": "kraken", "value": 1616.3, "alertThreshold": 2.0}]} 13:59:18 INFO - Return code: 0 13:59:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:59:18 ERROR - # TBPL SUCCESS # 13:59:18 INFO - Running post-action listener: _resource_record_post_action 13:59:18 INFO - Running post-run listener: _resource_record_post_run 13:59:19 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7921664; Write bytes: 412524544; Read time: 1544; Write time: 551860 13:59:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 80953344; Read time: 0; Write time: 83392 13:59:19 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 7921664; Write bytes: 331571200; Read time: 1544; Write time: 468468 13:59:19 INFO - Running post-run listener: _upload_blobber_files 13:59:19 INFO - Blob upload gear active. 13:59:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:59:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:59:19 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:59:19 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:59:19 INFO - (blobuploader) - INFO - Open directory for files ... 13:59:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:59:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:59:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:20 INFO - (blobuploader) - INFO - Done attempting. 13:59:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:59:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:59:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:21 INFO - (blobuploader) - INFO - Done attempting. 13:59:21 INFO - (blobuploader) - INFO - Iteration through files over. 13:59:21 INFO - Return code: 0 13:59:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:59:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:59:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6184c85a97649aa2c9d9eacacd5df229ab9bdbce0faa0212427b58054078a9f791d4432d71a8cf953d1fce73113502f4d73be4a880fdef7a6b6f4ee0780886f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c71f45bb7ee69e393108cb0f562d6c12eb9eafce524d06559394380b493440a09f05fbf918ebf082ece9caa0be61466fb6524b32f5ac0d46053d2803325e21b5"} 13:59:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:59:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:59:21 INFO - Contents: 13:59:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6184c85a97649aa2c9d9eacacd5df229ab9bdbce0faa0212427b58054078a9f791d4432d71a8cf953d1fce73113502f4d73be4a880fdef7a6b6f4ee0780886f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c71f45bb7ee69e393108cb0f562d6c12eb9eafce524d06559394380b493440a09f05fbf918ebf082ece9caa0be61466fb6524b32f5ac0d46053d2803325e21b5"} 13:59:21 INFO - Running post-run listener: copy_logs_to_upload_dir 13:59:21 INFO - Copying logs to upload dir... 13:59:21 INFO - mkdir: /builds/slave/test/build/upload/logs 13:59:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.591754 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-21 13:59:21.600760) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 13:59:21.604383) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6184c85a97649aa2c9d9eacacd5df229ab9bdbce0faa0212427b58054078a9f791d4432d71a8cf953d1fce73113502f4d73be4a880fdef7a6b6f4ee0780886f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c71f45bb7ee69e393108cb0f562d6c12eb9eafce524d06559394380b493440a09f05fbf918ebf082ece9caa0be61466fb6524b32f5ac0d46053d2803325e21b5"} build_url:https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/ZlMnzIGGQVyQ6Pnfm8VYPg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b6184c85a97649aa2c9d9eacacd5df229ab9bdbce0faa0212427b58054078a9f791d4432d71a8cf953d1fce73113502f4d73be4a880fdef7a6b6f4ee0780886f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c71f45bb7ee69e393108cb0f562d6c12eb9eafce524d06559394380b493440a09f05fbf918ebf082ece9caa0be61466fb6524b32f5ac0d46053d2803325e21b5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 13:59:21.628949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:59:21.629278) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461269705.25076-1138163645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 13:59:21.713930) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 13:59:21.714255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 13:59:21.714552) ========= ========= Total master_lag: 0.18 =========