builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1462484148.11 results: success (0) buildid: 20160505140156 builduid: 9458d54a13c0444ab42a90916cef74b2 revision: d7f05bf878f48b70a52c8ee5b355491766e34a52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:48.109656) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:48.110449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:48.110977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:48.129200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:48.129632) ========= 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=523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 14:35:48-- 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% 112M=0s 2016-05-05 14:35:48 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086965 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:48.230321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:48.230651) ========= 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=523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015618 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:48.280757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 14:35:48.281129) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d7f05bf878f48b70a52c8ee5b355491766e34a52 --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 d7f05bf878f48b70a52c8ee5b355491766e34a52 --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=523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 14:35:48,633 truncating revision to first 12 chars 2016-05-05 14:35:48,633 Setting DEBUG logging. 2016-05-05 14:35:48,633 attempt 1/10 2016-05-05 14:35:48,633 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d7f05bf878f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 14:35:49,452 unpacking tar archive at: fx-team-d7f05bf878f4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.104458 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 14:35:49.401005) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:49.401662) ========= script_repo_revision: d7f05bf878f48b70a52c8ee5b355491766e34a52 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:49.402411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:49.402934) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 14:35:49.414382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-05 14:35:49.415112) ========= /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=523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:35:49 INFO - MultiFileLogger online at 20160505 14:35:49 in /builds/slave/test 14:35:49 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 14:35:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:35:49 INFO - {'append_to_log': False, 14:35:49 INFO - 'base_work_dir': '/builds/slave/test', 14:35:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:35:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:35:49 INFO - 'branch': 'Fx-Team-Non-PGO', 14:35:49 INFO - 'buildbot_json_path': 'buildprops.json', 14:35:49 INFO - 'config_files': ('talos/linux_config.py',), 14:35:49 INFO - 'default_actions': ('clobber', 14:35:49 INFO - 'read-buildbot-config', 14:35:49 INFO - 'download-and-extract', 14:35:49 INFO - 'populate-webroot', 14:35:49 INFO - 'create-virtualenv', 14:35:49 INFO - 'install', 14:35:49 INFO - 'run-tests'), 14:35:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:35:49 INFO - 'download_minidump_stackwalk': True, 14:35:49 INFO - 'download_symbols': 'ondemand', 14:35:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:35:49 INFO - 'tooltool.py': '/tools/tooltool.py', 14:35:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:35:49 INFO - '/tools/misc-python/virtualenv.py')}, 14:35:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:35:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:35:49 INFO - 'installer_path': 'installer.exe', 14:35:49 INFO - 'log_level': 'info', 14:35:49 INFO - 'log_name': 'talos', 14:35:49 INFO - 'log_to_console': True, 14:35:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:35:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:35:49 INFO - 'opt_config_files': (), 14:35:49 INFO - 'pip_index': False, 14:35:49 INFO - 'sps_profile': False, 14:35:49 INFO - 'sps_profile_interval': 0, 14:35:49 INFO - 'suite': 'dromaeojs-e10s', 14:35:49 INFO - 'system_bits': '32', 14:35:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:35:49 INFO - 'title': 'talos-linux64-ix-065', 14:35:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:35:49 INFO - 'use_talos_json': True, 14:35:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:35:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:35:49 INFO - 'work_dir': 'build'} 14:35:49 INFO - ##### 14:35:49 INFO - ##### Running clobber step. 14:35:49 INFO - ##### 14:35:49 INFO - Running pre-action listener: _resource_record_pre_action 14:35:49 INFO - Running main action method: clobber 14:35:49 INFO - rmtree: /builds/slave/test/build 14:35:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:35:50 INFO - Running post-action listener: _resource_record_post_action 14:35:50 INFO - ##### 14:35:50 INFO - ##### Running read-buildbot-config step. 14:35:50 INFO - ##### 14:35:50 INFO - Running pre-action listener: _resource_record_pre_action 14:35:50 INFO - Running main action method: read_buildbot_config 14:35:50 INFO - Using buildbot properties: 14:35:50 INFO - { 14:35:50 INFO - "project": "", 14:35:50 INFO - "product": "firefox", 14:35:50 INFO - "script_repo_revision": "production", 14:35:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:35:50 INFO - "repository": "", 14:35:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:35:50 INFO - "buildid": "20160505140156", 14:35:50 INFO - "pgo_build": "False", 14:35:50 INFO - "basedir": "/builds/slave/test", 14:35:50 INFO - "buildnumber": 1479, 14:35:50 INFO - "slavename": "talos-linux64-ix-065", 14:35:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:35:50 INFO - "platform": "ubuntu64_hw", 14:35:50 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:35:50 INFO - "branch": "fx-team", 14:35:50 INFO - "repo_path": "integration/fx-team", 14:35:50 INFO - "revision": "d7f05bf878f48b70a52c8ee5b355491766e34a52", 14:35:50 INFO - "stage_platform": "linux64", 14:35:50 INFO - "builduid": "9458d54a13c0444ab42a90916cef74b2", 14:35:50 INFO - "slavebuilddir": "test" 14:35:50 INFO - } 14:35:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:35:50 INFO - Running post-action listener: _resource_record_post_action 14:35:50 INFO - ##### 14:35:50 INFO - ##### Running download-and-extract step. 14:35:50 INFO - ##### 14:35:50 INFO - Running pre-action listener: _resource_record_pre_action 14:35:50 INFO - Running main action method: download_and_extract 14:35:50 INFO - mkdir: /builds/slave/test/build/tests 14:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:50 INFO - https://queue.taskcluster.net/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:35:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:35:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:35:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:35:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:35:51 INFO - Downloaded 1361 bytes. 14:35:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:35:51 INFO - Using the following test package requirements: 14:35:51 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:35:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:35:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:35:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:51 INFO - u'jsshell-linux-x86_64.zip'], 14:35:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:35:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:35:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:35:51 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:35:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:35:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:35:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:35:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:35:51 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')]} 14:35:51 INFO - https://queue.taskcluster.net/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:35:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:35:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:35:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:35:52 INFO - Downloaded 22321567 bytes. 14:35:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:35:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:35:53 INFO - Return code: 0 14:35:53 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:35: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')]} 14:35:53 INFO - https://queue.taskcluster.net/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:35:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:35:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:35:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:35:55 INFO - Downloaded 22321567 bytes. 14:35:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:35:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:35:56 INFO - Return code: 0 14:35:56 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')]} 14:35:56 INFO - https://queue.taskcluster.net/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:35:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:35:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:35:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:35:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:35:57 INFO - Downloaded 10840152 bytes. 14:35:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:35:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:35:57 INFO - Return code: 0 14:35: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')]} 14:35:57 INFO - https://queue.taskcluster.net/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:35:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:35:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:35:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:35:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:35:59 INFO - Downloaded 54834726 bytes. 14:35:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:35:59 INFO - mkdir: /builds/slave/test/properties 14:35:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:35:59 INFO - Writing to file /builds/slave/test/properties/build_url 14:35:59 INFO - Contents: 14:35:59 INFO - build_url:https://queue.taskcluster.net/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:35:59 INFO - Running post-action listener: _resource_record_post_action 14:35:59 INFO - Running post-action listener: set_extra_try_arguments 14:35:59 INFO - ##### 14:35:59 INFO - ##### Running populate-webroot step. 14:35:59 INFO - ##### 14:35:59 INFO - Running pre-action listener: _resource_record_pre_action 14:35:59 INFO - Running main action method: populate_webroot 14:35:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:35:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:35:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:35:59 INFO - '--tppagecycles', 14:35:59 INFO - '7'], 14:35:59 INFO - 'tests': ['tsvgm']}}, 14:35:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:35:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:35:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:35:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:35:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:35:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:35:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:59 INFO - 'talos_options': ['--disable-e10s'], 14:35:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:59 INFO - 'talos_options': ['--disable-e10s'], 14:35:59 INFO - 'tests': ['damp', 'tps']}, 14:35:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:59 INFO - 'tests': ['damp', 'tps']}, 14:35:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:35:59 INFO - 'tests': ['dromaeo_dom']}, 14:35:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:35:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:35:59 INFO - 'tests': ['a11yr', 14:35:59 INFO - 'ts_paint', 14:35:59 INFO - 'tpaint', 14:35:59 INFO - 'sessionrestore', 14:35:59 INFO - 'sessionrestore_no_auto_restore', 14:35:59 INFO - 'tabpaint']}, 14:35:59 INFO - 'other-e10s': {'tests': ['a11yr', 14:35:59 INFO - 'ts_paint', 14:35:59 INFO - 'tpaint', 14:35:59 INFO - 'sessionrestore', 14:35:59 INFO - 'sessionrestore_no_auto_restore', 14:35:59 INFO - 'tabpaint']}, 14:35:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:35:59 INFO - 'ts_paint', 14:35:59 INFO - 'tpaint', 14:35:59 INFO - 'sessionrestore', 14:35:59 INFO - 'sessionrestore_no_auto_restore', 14:35:59 INFO - 'tabpaint']}, 14:35:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:35:59 INFO - 'ts_paint', 14:35:59 INFO - 'tpaint', 14:35:59 INFO - 'sessionrestore', 14:35:59 INFO - 'sessionrestore_no_auto_restore', 14:35:59 INFO - 'tabpaint']}, 14:35:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:35:59 INFO - 'tests': ['a11yr', 14:35:59 INFO - 'ts_paint', 14:35:59 INFO - 'tpaint', 14:35:59 INFO - 'sessionrestore', 14:35:59 INFO - 'sessionrestore_no_auto_restore', 14:35:59 INFO - 'tabpaint']}, 14:35:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:35:59 INFO - 'tests': ['a11yr', 14:35:59 INFO - 'ts_paint', 14:35:59 INFO - 'tpaint', 14:35:59 INFO - 'sessionrestore', 14:35:59 INFO - 'sessionrestore_no_auto_restore', 14:35:59 INFO - 'tabpaint']}, 14:35:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:35:59 INFO - 'tests': ['tsvgx', 14:35:59 INFO - 'tsvgr_opacity', 14:35:59 INFO - 'tart', 14:35:59 INFO - 'tscrollx', 14:35:59 INFO - 'cart']}, 14:35:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:35:59 INFO - 'tsvgr_opacity', 14:35:59 INFO - 'tart', 14:35:59 INFO - 'tscrollx', 14:35:59 INFO - 'cart']}, 14:35:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:59 INFO - 'talos_options': ['--disable-e10s'], 14:35:59 INFO - 'tests': ['tp5o']}, 14:35:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:59 INFO - 'tests': ['tp5o']}, 14:35:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:59 INFO - 'talos_options': ['--disable-e10s', 14:35:59 INFO - '--xperf_path', 14:35:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:59 INFO - 'tests': ['tp5n']}, 14:35:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:59 INFO - 'talos_options': ['--xperf_path', 14:35:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:59 INFO - 'tests': ['tp5n']}}, 14:35:59 INFO - 'talos.zip': {'path': '', 14:35:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:35:59 INFO - Running post-action listener: _resource_record_post_action 14:35:59 INFO - ##### 14:35:59 INFO - ##### Running create-virtualenv step. 14:35:59 INFO - ##### 14:35:59 INFO - Running pre-action listener: _resource_record_pre_action 14:35:59 INFO - Running main action method: create_virtualenv 14:35:59 INFO - Creating virtualenv /builds/slave/test/build/venv 14:35:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:35:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:35:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:35:59 INFO - Using real prefix '/usr' 14:35:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:36:00 INFO - Installing distribute.............................................................................................................................................................................................done. 14:36:02 INFO - Installing pip.................done. 14:36:02 INFO - Return code: 0 14:36:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84a154bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774410>, '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 0x2775310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27757a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', '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 14:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:36:02 INFO - Using env: {'DISPLAY': ':0', 14:36:02 INFO - 'HOME': '/home/cltbld', 14:36:02 INFO - 'LANG': 'en_US.UTF-8', 14:36:02 INFO - 'LANGUAGE': 'en_US:en', 14:36:02 INFO - 'LOGNAME': 'cltbld', 14:36:02 INFO - 'MAIL': '/var/mail/cltbld', 14:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:02 INFO - 'MOZ_NO_REMOTE': '1', 14:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:02 INFO - 'NO_EM_RESTART': '1', 14:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:02 INFO - 'PWD': '/builds/slave/test', 14:36:02 INFO - 'SHELL': '/bin/bash', 14:36:02 INFO - 'SHLVL': '1', 14:36:02 INFO - 'TERM': 'linux', 14:36:02 INFO - 'TMOUT': '86400', 14:36:02 INFO - 'USER': 'cltbld', 14:36:02 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', 14:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:02 INFO - '_': '/tools/buildbot/bin/python'} 14:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:02 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 14:36:02 INFO - Cleaning up... 14:36:02 INFO - Return code: 0 14:36:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f84a154bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774410>, '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 0x2775310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27757a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', '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 14:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:36:02 INFO - Using env: {'DISPLAY': ':0', 14:36:02 INFO - 'HOME': '/home/cltbld', 14:36:02 INFO - 'LANG': 'en_US.UTF-8', 14:36:02 INFO - 'LANGUAGE': 'en_US:en', 14:36:02 INFO - 'LOGNAME': 'cltbld', 14:36:02 INFO - 'MAIL': '/var/mail/cltbld', 14:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:02 INFO - 'MOZ_NO_REMOTE': '1', 14:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:02 INFO - 'NO_EM_RESTART': '1', 14:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:02 INFO - 'PWD': '/builds/slave/test', 14:36:02 INFO - 'SHELL': '/bin/bash', 14:36:02 INFO - 'SHLVL': '1', 14:36:02 INFO - 'TERM': 'linux', 14:36:02 INFO - 'TMOUT': '86400', 14:36:02 INFO - 'USER': 'cltbld', 14:36:02 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', 14:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:02 INFO - '_': '/tools/buildbot/bin/python'} 14:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:02 INFO - Downloading/unpacking psutil>=0.7.1 14:36: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 14:36: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 14:36: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 14:36: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 14:36: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 14:36: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 14:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:36:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:36:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:36:04 INFO - Installing collected packages: psutil 14:36:04 INFO - Running setup.py install for psutil 14:36:04 INFO - building 'psutil._psutil_linux' extension 14:36:04 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 14:36:05 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 14:36:05 INFO - building 'psutil._psutil_posix' extension 14:36:05 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 14:36:05 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 14:36:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:36:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:36:05 INFO - Successfully installed psutil 14:36:05 INFO - Cleaning up... 14:36:05 INFO - Return code: 0 14:36:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f84a154bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774410>, '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 0x2775310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27757a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', '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 14:36:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:36:05 INFO - Using env: {'DISPLAY': ':0', 14:36:05 INFO - 'HOME': '/home/cltbld', 14:36:05 INFO - 'LANG': 'en_US.UTF-8', 14:36:05 INFO - 'LANGUAGE': 'en_US:en', 14:36:05 INFO - 'LOGNAME': 'cltbld', 14:36:05 INFO - 'MAIL': '/var/mail/cltbld', 14:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:05 INFO - 'MOZ_NO_REMOTE': '1', 14:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:05 INFO - 'NO_EM_RESTART': '1', 14:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:05 INFO - 'PWD': '/builds/slave/test', 14:36:05 INFO - 'SHELL': '/bin/bash', 14:36:05 INFO - 'SHLVL': '1', 14:36:05 INFO - 'TERM': 'linux', 14:36:05 INFO - 'TMOUT': '86400', 14:36:05 INFO - 'USER': 'cltbld', 14:36:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', 14:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:05 INFO - '_': '/tools/buildbot/bin/python'} 14:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:36:07 INFO - Installing collected packages: mozsystemmonitor 14:36:07 INFO - Running setup.py install for mozsystemmonitor 14:36:07 INFO - Successfully installed mozsystemmonitor 14:36:07 INFO - Cleaning up... 14:36:07 INFO - Return code: 0 14:36:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f84a154bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774410>, '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 0x2775310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27757a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', '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 14:36:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:36:07 INFO - Using env: {'DISPLAY': ':0', 14:36:07 INFO - 'HOME': '/home/cltbld', 14:36:07 INFO - 'LANG': 'en_US.UTF-8', 14:36:07 INFO - 'LANGUAGE': 'en_US:en', 14:36:07 INFO - 'LOGNAME': 'cltbld', 14:36:07 INFO - 'MAIL': '/var/mail/cltbld', 14:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:07 INFO - 'MOZ_NO_REMOTE': '1', 14:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:07 INFO - 'NO_EM_RESTART': '1', 14:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:07 INFO - 'PWD': '/builds/slave/test', 14:36:07 INFO - 'SHELL': '/bin/bash', 14:36:07 INFO - 'SHLVL': '1', 14:36:07 INFO - 'TERM': 'linux', 14:36:07 INFO - 'TMOUT': '86400', 14:36:07 INFO - 'USER': 'cltbld', 14:36:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', 14:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:07 INFO - '_': '/tools/buildbot/bin/python'} 14:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:09 INFO - Downloading blobuploader-1.2.4.tar.gz 14:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:36:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:36:09 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 14:36:09 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 14:36:09 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 14:36:09 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 14:36:09 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 14:36:09 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 14:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:36:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:10 INFO - Downloading docopt-0.6.1.tar.gz 14:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:36:10 INFO - Installing collected packages: blobuploader, requests, docopt 14:36:10 INFO - Running setup.py install for blobuploader 14:36:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:36:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:36:10 INFO - Running setup.py install for requests 14:36:10 INFO - Running setup.py install for docopt 14:36:10 INFO - Successfully installed blobuploader requests docopt 14:36:10 INFO - Cleaning up... 14:36:11 INFO - Return code: 0 14:36:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:11 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 0x7f84a154bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774410>, '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 0x2775310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27757a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', '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 14:36:11 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 14:36:11 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 14:36:11 INFO - Using env: {'DISPLAY': ':0', 14:36:11 INFO - 'HOME': '/home/cltbld', 14:36:11 INFO - 'LANG': 'en_US.UTF-8', 14:36:11 INFO - 'LANGUAGE': 'en_US:en', 14:36:11 INFO - 'LOGNAME': 'cltbld', 14:36:11 INFO - 'MAIL': '/var/mail/cltbld', 14:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:11 INFO - 'MOZ_NO_REMOTE': '1', 14:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:11 INFO - 'NO_EM_RESTART': '1', 14:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:11 INFO - 'PWD': '/builds/slave/test', 14:36:11 INFO - 'SHELL': '/bin/bash', 14:36:11 INFO - 'SHLVL': '1', 14:36:11 INFO - 'TERM': 'linux', 14:36:11 INFO - 'TMOUT': '86400', 14:36:11 INFO - 'USER': 'cltbld', 14:36:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', 14:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:11 INFO - '_': '/tools/buildbot/bin/python'} 14:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:36:11 INFO - Running setup.py (path:/tmp/pip-MZWMZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:36:11 INFO - Running setup.py (path:/tmp/pip-WlhVNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:36:11 INFO - Running setup.py (path:/tmp/pip-r6I8fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:36:11 INFO - Running setup.py (path:/tmp/pip-IYZ6Dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:36:11 INFO - Running setup.py (path:/tmp/pip-MCxRkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:36:11 INFO - Running setup.py (path:/tmp/pip-PjUK1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:36:11 INFO - Running setup.py (path:/tmp/pip-2zmvTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:36:11 INFO - Running setup.py (path:/tmp/pip-ItfiKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:36:11 INFO - Running setup.py (path:/tmp/pip-8hAtau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:36:11 INFO - Running setup.py (path:/tmp/pip-5dsHm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:36:11 INFO - Running setup.py (path:/tmp/pip-gHJixi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:36:12 INFO - Running setup.py (path:/tmp/pip-HYibku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:36:12 INFO - Running setup.py (path:/tmp/pip-yUS1rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:36:12 INFO - Running setup.py (path:/tmp/pip-fCgR1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:12 INFO - Running setup.py (path:/tmp/pip-LmGGyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:36:12 INFO - Running setup.py (path:/tmp/pip-bagLlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:36:12 INFO - Running setup.py (path:/tmp/pip-ks_7F7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:36:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:36:12 INFO - Running setup.py install for manifestparser 14:36:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:36:12 INFO - Running setup.py install for mozcrash 14:36:12 INFO - Running setup.py install for mozdebug 14:36:12 INFO - Running setup.py install for mozdevice 14:36:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:36:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:36:12 INFO - Running setup.py install for mozfile 14:36:13 INFO - Running setup.py install for mozhttpd 14:36:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Running setup.py install for mozinfo 14:36:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Running setup.py install for mozInstall 14:36:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Running setup.py install for mozleak 14:36:13 INFO - Running setup.py install for mozlog 14:36:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Running setup.py install for moznetwork 14:36:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Running setup.py install for mozprocess 14:36:13 INFO - Running setup.py install for mozprofile 14:36:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Running setup.py install for mozrunner 14:36:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:36:13 INFO - Running setup.py install for mozscreenshot 14:36:14 INFO - Running setup.py install for moztest 14:36:14 INFO - Running setup.py install for mozversion 14:36:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:36:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:36:14 INFO - Cleaning up... 14:36:14 INFO - Return code: 0 14:36:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:36:14 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')]} 14:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:14 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')]} 14:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:14 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 0x7f84a154bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774410>, '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 0x2775310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27757a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', '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 14:36:14 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 14:36:14 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 14:36:14 INFO - Using env: {'DISPLAY': ':0', 14:36:14 INFO - 'HOME': '/home/cltbld', 14:36:14 INFO - 'LANG': 'en_US.UTF-8', 14:36:14 INFO - 'LANGUAGE': 'en_US:en', 14:36:14 INFO - 'LOGNAME': 'cltbld', 14:36:14 INFO - 'MAIL': '/var/mail/cltbld', 14:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:14 INFO - 'MOZ_NO_REMOTE': '1', 14:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:14 INFO - 'NO_EM_RESTART': '1', 14:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:14 INFO - 'PWD': '/builds/slave/test', 14:36:14 INFO - 'SHELL': '/bin/bash', 14:36:14 INFO - 'SHLVL': '1', 14:36:14 INFO - 'TERM': 'linux', 14:36:14 INFO - 'TMOUT': '86400', 14:36:14 INFO - 'USER': 'cltbld', 14:36:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', 14:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:14 INFO - '_': '/tools/buildbot/bin/python'} 14:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:36:14 INFO - Running setup.py (path:/tmp/pip-F9QGDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:36:14 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)) 14:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:36:14 INFO - Running setup.py (path:/tmp/pip-qpfLmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:36:14 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)) 14:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:36:14 INFO - Running setup.py (path:/tmp/pip-snjFW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:36:14 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)) 14:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:36:14 INFO - Running setup.py (path:/tmp/pip-I7UCDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:36:14 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)) 14:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:36:14 INFO - Running setup.py (path:/tmp/pip-181maE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:36:14 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)) 14:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:36:14 INFO - Running setup.py (path:/tmp/pip-J2IKDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:36:14 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)) 14:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:36:14 INFO - Running setup.py (path:/tmp/pip-tMqVfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:36:14 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)) 14:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:36:14 INFO - Running setup.py (path:/tmp/pip-Km6_kA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:36:15 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)) 14:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:36:15 INFO - Running setup.py (path:/tmp/pip-_B0_w1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:36:15 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)) 14:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:36:15 INFO - Running setup.py (path:/tmp/pip-GRExhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:36:15 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)) 14:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:36:15 INFO - Running setup.py (path:/tmp/pip-NFckqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:36:15 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)) 14:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:36:15 INFO - Running setup.py (path:/tmp/pip-RlEa60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:36:15 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)) 14:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:36:15 INFO - Running setup.py (path:/tmp/pip-MZXZ5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:36:15 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)) 14:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:36:15 INFO - Running setup.py (path:/tmp/pip-u34OMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:36:15 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)) 14:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:15 INFO - Running setup.py (path:/tmp/pip-KTuTXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:36:15 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)) 14:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:36:15 INFO - Running setup.py (path:/tmp/pip-lHeQtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:36:15 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)) 14:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:36:15 INFO - Running setup.py (path:/tmp/pip-t6oldP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:36:15 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)) 14:36:15 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)) 14:36:15 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)) 14:36:15 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)) 14:36:15 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)) 14:36:15 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)) 14:36:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:36: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 14:36: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 14:36: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 14:36: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 14:36: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 14:36: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 14:36:17 INFO - Downloading blessings-1.6.tar.gz 14:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:36:17 INFO - Installing collected packages: blessings 14:36:17 INFO - Running setup.py install for blessings 14:36:17 INFO - Successfully installed blessings 14:36:17 INFO - Cleaning up... 14:36:17 INFO - Return code: 0 14:36:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:36:18 INFO - Reading from file tmpfile_stdout 14:36:18 INFO - Current package versions: 14:36:18 INFO - argparse == 1.2.1 14:36:18 INFO - blessings == 1.6 14:36:18 INFO - blobuploader == 1.2.4 14:36:18 INFO - docopt == 0.6.1 14:36:18 INFO - manifestparser == 1.1 14:36:18 INFO - mozInstall == 1.12 14:36:18 INFO - mozcrash == 0.17 14:36:18 INFO - mozdebug == 0.1 14:36:18 INFO - mozdevice == 0.48 14:36:18 INFO - mozfile == 1.2 14:36:18 INFO - mozhttpd == 0.7 14:36:18 INFO - mozinfo == 0.9 14:36:18 INFO - mozleak == 0.1 14:36:18 INFO - mozlog == 3.1 14:36:18 INFO - moznetwork == 0.27 14:36:18 INFO - mozprocess == 0.22 14:36:18 INFO - mozprofile == 0.28 14:36:18 INFO - mozrunner == 6.11 14:36:18 INFO - mozscreenshot == 0.1 14:36:18 INFO - mozsystemmonitor == 0.0 14:36:18 INFO - moztest == 0.7 14:36:18 INFO - mozversion == 1.4 14:36:18 INFO - psutil == 3.1.1 14:36:18 INFO - requests == 1.2.3 14:36:18 INFO - wsgiref == 0.1.2 14:36:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:18 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 0x7f84a154bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774410>, '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 0x2775310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27757a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', '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 14:36:18 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 14:36:18 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 14:36:18 INFO - Using env: {'DISPLAY': ':0', 14:36:18 INFO - 'HOME': '/home/cltbld', 14:36:18 INFO - 'LANG': 'en_US.UTF-8', 14:36:18 INFO - 'LANGUAGE': 'en_US:en', 14:36:18 INFO - 'LOGNAME': 'cltbld', 14:36:18 INFO - 'MAIL': '/var/mail/cltbld', 14:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:18 INFO - 'MOZ_NO_REMOTE': '1', 14:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:18 INFO - 'NO_EM_RESTART': '1', 14:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:18 INFO - 'PWD': '/builds/slave/test', 14:36:18 INFO - 'SHELL': '/bin/bash', 14:36:18 INFO - 'SHLVL': '1', 14:36:18 INFO - 'TERM': 'linux', 14:36:18 INFO - 'TMOUT': '86400', 14:36:18 INFO - 'USER': 'cltbld', 14:36:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', 14:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:18 INFO - '_': '/tools/buildbot/bin/python'} 14:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:18 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)) 14:36:18 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)) 14:36:18 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)) 14:36:18 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)) 14:36:18 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)) 14:36:18 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)) 14:36:18 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)) 14:36:18 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)) 14:36:18 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)) 14:36:18 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)) 14:36:18 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)) 14:36:18 INFO - Cleaning up... 14:36:18 INFO - Return code: 0 14:36:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84a154bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774410>, '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 0x2775310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27757a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', '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 14:36:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:36:18 INFO - Using env: {'DISPLAY': ':0', 14:36:18 INFO - 'HOME': '/home/cltbld', 14:36:18 INFO - 'LANG': 'en_US.UTF-8', 14:36:18 INFO - 'LANGUAGE': 'en_US:en', 14:36:18 INFO - 'LOGNAME': 'cltbld', 14:36:18 INFO - 'MAIL': '/var/mail/cltbld', 14:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:18 INFO - 'MOZ_NO_REMOTE': '1', 14:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:18 INFO - 'NO_EM_RESTART': '1', 14:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:18 INFO - 'PWD': '/builds/slave/test', 14:36:18 INFO - 'SHELL': '/bin/bash', 14:36:18 INFO - 'SHLVL': '1', 14:36:18 INFO - 'TERM': 'linux', 14:36:18 INFO - 'TMOUT': '86400', 14:36:18 INFO - 'USER': 'cltbld', 14:36:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', 14:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:18 INFO - '_': '/tools/buildbot/bin/python'} 14:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:18 INFO - Downloading/unpacking jsonschema 14:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:36:20 INFO - Downloading/unpacking functools32 (from jsonschema) 14:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:20 INFO - Downloading functools32-3.2.3-2.tar.gz 14:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:36:20 INFO - warning: no files found matching '*.txt' 14:36:20 INFO - no previously-included directories found matching 'build' 14:36:20 INFO - no previously-included directories found matching 'dist' 14:36:20 INFO - no previously-included directories found matching '.git*' 14:36:20 INFO - Installing collected packages: jsonschema, functools32 14:36:20 INFO - Running setup.py install for functools32 14:36:20 INFO - warning: no files found matching '*.txt' 14:36:20 INFO - no previously-included directories found matching 'build' 14:36:20 INFO - no previously-included directories found matching 'dist' 14:36:20 INFO - no previously-included directories found matching '.git*' 14:36:20 INFO - Successfully installed jsonschema functools32 14:36:20 INFO - Cleaning up... 14:36:20 INFO - Return code: 0 14:36:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:36:20 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 0x7f84a154bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774410>, '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 0x2775310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27757a0>, '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': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', '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 14:36:20 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 14:36:20 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 14:36:20 INFO - Using env: {'DISPLAY': ':0', 14:36:20 INFO - 'HOME': '/home/cltbld', 14:36:20 INFO - 'LANG': 'en_US.UTF-8', 14:36:20 INFO - 'LANGUAGE': 'en_US:en', 14:36:20 INFO - 'LOGNAME': 'cltbld', 14:36:20 INFO - 'MAIL': '/var/mail/cltbld', 14:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:20 INFO - 'MOZ_NO_REMOTE': '1', 14:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:20 INFO - 'NO_EM_RESTART': '1', 14:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:20 INFO - 'PWD': '/builds/slave/test', 14:36:20 INFO - 'SHELL': '/bin/bash', 14:36:20 INFO - 'SHLVL': '1', 14:36:20 INFO - 'TERM': 'linux', 14:36:20 INFO - 'TMOUT': '86400', 14:36:20 INFO - 'USER': 'cltbld', 14:36:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', 14:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:20 INFO - '_': '/tools/buildbot/bin/python'} 14:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:36:21 INFO - Downloading/unpacking flake8 14:36:21 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 14:36:21 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 14:36:21 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 14:36:21 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 14:36:21 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 14:36:21 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 14:36:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:36:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:36:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:36:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:36:23 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 14:36:23 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 14:36:23 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 14:36:23 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 14:36:23 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 14:36:23 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 14:36:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:36:23 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 14:36:23 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 14:36:23 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 14:36:23 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 14:36:23 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 14:36:23 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 14:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:36:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:36:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:36:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:36:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:36:23 INFO - no previously-included directories found matching 'docs/_build' 14:36:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:36:23 INFO - Running setup.py install for pep8 14:36:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:36:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:36:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:36:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:36:23 INFO - no previously-included directories found matching 'docs/_build' 14:36:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:36:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:36:23 INFO - Cleaning up... 14:36:23 INFO - Return code: 0 14:36:23 INFO - Running post-action listener: _resource_record_post_action 14:36:23 INFO - Running post-action listener: _start_resource_monitoring 14:36:23 INFO - Starting resource monitoring. 14:36:23 INFO - ##### 14:36:23 INFO - ##### Running install step. 14:36:23 INFO - ##### 14:36:23 INFO - Running pre-action listener: _resource_record_pre_action 14:36:23 INFO - Running main action method: install 14:36:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:36:24 INFO - Reading from file tmpfile_stdout 14:36:24 INFO - Detecting whether we're running mozinstall >=1.0... 14:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:36:24 INFO - Reading from file tmpfile_stdout 14:36:24 INFO - Output received: 14:36:24 INFO - Usage: mozinstall [options] installer 14:36:24 INFO - Options: 14:36:24 INFO - -h, --help show this help message and exit 14:36:24 INFO - -d DEST, --destination=DEST 14:36:24 INFO - Directory to install application into. [default: 14:36:24 INFO - "/builds/slave/test"] 14:36:24 INFO - --app=APP Application being installed. [default: firefox] 14:36:24 INFO - mkdir: /builds/slave/test/build/application 14:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:36:40 INFO - Reading from file tmpfile_stdout 14:36:40 INFO - Output received: 14:36:40 INFO - /builds/slave/test/build/application/firefox/firefox 14:36:40 INFO - Running post-action listener: _resource_record_post_action 14:36:40 INFO - ##### 14:36:40 INFO - ##### Running run-tests step. 14:36:40 INFO - ##### 14:36:40 INFO - Running pre-action listener: _resource_record_pre_action 14:36:40 INFO - Running main action method: run_tests 14:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:36:40 INFO - Python 2.7.3 14:36:40 INFO - Return code: 0 14:36:40 INFO - grabbing minidump binary from tooltool 14:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:36:40 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 0x2774410>, '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 0x2775310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27757a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:36:40 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 14:36:40 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 14:36:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:36:40 INFO - Return code: 0 14:36:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:36:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:36:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:36:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:36:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:36:41 INFO - Return code: 0 14:36:41 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/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 14:36:41 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/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 14:36:41 INFO - Using env: {'DISPLAY': ':0', 14:36:41 INFO - 'HOME': '/home/cltbld', 14:36:41 INFO - 'LANG': 'en_US.UTF-8', 14:36:41 INFO - 'LANGUAGE': 'en_US:en', 14:36:41 INFO - 'LOGNAME': 'cltbld', 14:36:41 INFO - 'MAIL': '/var/mail/cltbld', 14:36:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:36:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:41 INFO - 'MOZ_NO_REMOTE': '1', 14:36:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:36:41 INFO - 'NO_EM_RESTART': '1', 14:36:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:41 INFO - 'PWD': '/builds/slave/test', 14:36:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:36:41 INFO - 'SHELL': '/bin/bash', 14:36:41 INFO - 'SHLVL': '1', 14:36:41 INFO - 'TERM': 'linux', 14:36:41 INFO - 'TMOUT': '86400', 14:36:41 INFO - 'USER': 'cltbld', 14:36:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770', 14:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:41 INFO - '_': '/tools/buildbot/bin/python'} 14:36:41 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/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 14:36:41 INFO - mozversion application_buildid: 20160505140156 14:36:41 INFO - mozversion application_changeset: d7f05bf878f48b70a52c8ee5b355491766e34a52 14:36:41 INFO - mozversion application_display_name: Nightly 14:36:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:36:41 INFO - mozversion application_name: Firefox 14:36:41 INFO - mozversion application_remotingname: firefox 14:36:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:36:41 INFO - mozversion application_vendor: Mozilla 14:36:41 INFO - mozversion application_version: 49.0a1 14:36:41 INFO - mozversion platform_buildid: 20160505140156 14:36:41 INFO - mozversion platform_changeset: d7f05bf878f48b70a52c8ee5b355491766e34a52 14:36:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:36:41 INFO - mozversion platform_version: 49.0a1 14:36:41 INFO - using testdate: 1462484201 14:36:41 INFO - actual date: 1462484201 14:36:41 INFO - starting webserver on 'localhost:41253' 14:36:41 INFO - SUITE-START | Running 2 tests 14:36:41 INFO - TEST-START | dromaeo_css 14:36:41 INFO - operating with platform_type : linux_ 14:36:41 INFO - Initialising browser for dromaeo_css test... 14:36:41 INFO - TEST-INFO | started process 15008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCVUR_j/profile http://localhost:41253/getInfo.html) 14:36:45 INFO - PROCESS | 15008 | 14:36:45 INFO - PROCESS | 15008 | (process:15078): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:36:46 INFO - PROCESS | 15008 | __metrics Screen width/height:1600/1200 14:36:46 INFO - PROCESS | 15008 | colorDepth:24 14:36:46 INFO - PROCESS | 15008 | Browser inner width/height: 1024/697 14:36:46 INFO - PROCESS | 15008 | __metrics 14:36:46 ERROR - PROCESS | 15008 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2945: TypeError: this.tabs is undefined 14:36:47 INFO - TEST-INFO | 15008: exit 0 14:36:47 INFO - Browser initialized. 14:36:47 INFO - Running cycle 1/1 for dromaeo_css test... 14:36:47 INFO - TEST-INFO | started process 15129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCVUR_j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:49 INFO - PROCESS | 15129 | 14:36:49 INFO - PROCESS | 15129 | (process:15191): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:36:59 INFO - PROCESS | 15129 | RSS: Main: 164466688 14:36:59 INFO - PROCESS | 15129 | 14:37:49 INFO - PROCESS | 15129 | 1462484269269 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] 14:40:01 INFO - PROCESS | 15129 | Cycle 1(1): loaded http://localhost:41253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41253/tests/dromaeo/cssquery-ext.html) 14:40:02 INFO - PROCESS | 15129 | RSS: Main: 165187584 14:40:02 INFO - PROCESS | 15129 | 14:43:04 INFO - PROCESS | 15129 | Cycle 1(1): loaded http://localhost:41253/tests/dromaeo/cssquery-ext.html (next: http://localhost:41253/tests/dromaeo/cssquery-jquery.html) 14:43:05 INFO - PROCESS | 15129 | RSS: Main: 165924864 14:43:05 INFO - PROCESS | 15129 | 14:46:07 INFO - PROCESS | 15129 | Cycle 1(1): loaded http://localhost:41253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41253/tests/dromaeo/cssquery-mootools.html) 14:46:07 INFO - PROCESS | 15129 | RSS: Main: 167448576 14:46:07 INFO - PROCESS | 15129 | 14:49:09 INFO - PROCESS | 15129 | Cycle 1(1): loaded http://localhost:41253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41253/tests/dromaeo/cssquery-prototype.html) 14:49:10 INFO - PROCESS | 15129 | RSS: Main: 164958208 14:49:10 INFO - PROCESS | 15129 | 14:52:12 INFO - PROCESS | 15129 | Cycle 1(1): loaded http://localhost:41253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41253/tests/dromaeo/cssquery-yui.html) 14:52:13 INFO - PROCESS | 15129 | RSS: Main: 165797888 14:52:13 INFO - PROCESS | 15129 | 14:55:16 INFO - PROCESS | 15129 | Cycle 1(1): loaded http://localhost:41253/tests/dromaeo/cssquery-yui.html (next: http://localhost:41253/tests/dromaeo/cssquery-dojo.html) 14:55:16 INFO - PROCESS | 15129 | RSS: Main: 168263680 14:55:16 INFO - PROCESS | 15129 | 14:55:16 INFO - PROCESS | 15129 | __start_tp_report 14:55:16 INFO - PROCESS | 15129 | _x_x_mozilla_page_load 14:55:16 INFO - PROCESS | 15129 | _x_x_mozilla_page_load_details 14:55:16 INFO - PROCESS | 15129 | |i|pagename|runs| 14:55:16 INFO - PROCESS | 15129 | |0;dojo.html;2659.082616497308;2739.3973325868315;2747.519184142776;2756.3247004483906;2762.5856121581774;4750.524947505248;4761.8809529761775;4801.711897286165;4851.1267971765155;4895.241237608177;4729.432468103823;4795.3526273953;4804.591609713169;4860.562549370556;4873.122837889178;4428.601425871663;4463.977680111595;4506.391637128979;4512.232920403523;4520.457545094593;4436.844710435135;4456.6657500687415;4469.173202957463;4496.730196188223;4520.864374068783;4504.256797628404;4512.503624601291;4517.548245175489;4560.110778398213;4568.748718820463;4426.22541055314;4488.438945131858;4513.638908887281;4535.614472769818;4536.387587675655;4376.124775045004;4462.219111655448;4477.955220447787;4490.416245888046;4492.955070449287;4732.456841432229;4740.881477963044;4742.620590352798;4757.762111894392;4809.75951202442;5018.623603229772;5271.472852714736;5284.4187139414635;5291.894162116774;5341.893162136736;5162.174052151638;5194;5207.895842083137;5219.478052194788;5224.216367544861;4845.4185497740145;4887.535684110039;4928.359313289249;4929.704217746947;4972.204447288416;5349.22436246742;5367.221752845816;5390.326209223847;5403.702796346239;5407.567394608501;5181.4559471255725;5206.947930520722;5213.113770658997;5213.765380557884;5251.186066159675;5233.633645644844;5290.127129023745;5295.311609490742;5305.071612467803;5341.973290133525;5041.697498150123;5146.742662866842;5159.458256883048;5214.087534681492;5230.08473517133;5158.484151584887;5166.405863325691;5174.663646862942;5188.351456067991;5199.272101905736;4464.732116073046;4476.7090139140855;4479.888002799891;4523.11799199153;4531.025829446685;3748.756330838487;3778.7543809652284;3838.654521093059;3890.0469385000856;3908.804559772;4474.172278128557;4495.213337665896;4495.887602809956;4528.705634133771;4589.128065667513;5295.232191332312;5297.178937264653;5299.39057008449;5306.8407947761625;5308.23030660552;4354.586314300136;4440;4470.530594287618;4509;4523.479799822997;4666.1834179019215;4701.858944231679;4709.434867815884;4713.929291060636;4758.3100450434495;4950.480199579064;4962.751862406937;4962.998234231957;4977.477364876709;5013.047520971004;5117.488251175002;5214.270002199619;5247.816326428557;5268.367795864521;5288.048151332797;4965.627577931597;4988.401391833003;4996.125678006261;4997.150484417585;5033.521815427529;5073.644844860824;5208.921866172086;5216.347956505437;5218.8956220876125;5231.032259032091;5232.215167724872;5244.213367994831;5269.499397557226;5284.233786100917;5287.603429742708;5119.974400127976;5126.923096153486;5145.408278048072;5162.6902385856965;5180.300659410931;4839.1531481989805;4928.162212423825;5056.873578160576;5107.131787596043;5131.589472842089;4908.558229759339;4955.355803745634;4961.280614310833;4966.056449274626;5076.36545431821;5112.156494178419;5112.258722485144;5124.282600435868;5128.282040514406;5187.092258854761;4994.550490455877;5000.324956130876;5019.146745053423;5040.647154699136;5068.493150684902 14:55:16 INFO - PROCESS | 15129 | |1;ext.html;554.8169104195613;591.1339887065449;609.3790517224181;610.1122866229637;635.2186810223428;35528.584924994866;39688.20623587527;39877.202455950865;39999.600003999985;40115;41292;41505.792471037676;41618.37572436416;41843;41894.37158442618;7938.999999999985;8028.919710802905;8043.3163181129385;8048.074471435772;8072.838543229132;7850.214978502161;7874.330681892046;7954.363650907942;7969.083555391117;7978;7929.405294602899;7990.400719945998;8013.2387423194705;8021.318187954031;8028.919710802905;7903.249191326815;7917.960410197969;7956.443048986574;7959.164287749761;7974.202579742037;7770.611469426506;7821.2960833524685;7829;7844.803879902991;7849.5290282582655;37632.24735505274;37916.24167516634;37928.620713792785;37993.430098548546;38056;3285.227971426713;3313.90058298249;3369.9494507582162;3433.8626454941773;3767.792771397572;27024.864875675692;30199.245018874484;30454.695453045628;30496.8475157625;31700.524492132638;3334.6498617645284;3347.8493467794005;3356.9496457553155;3370.5449764282;3400.60892997306;248267;249865;250000.74999625067;250887;252988;29576.112716618536;30614;30688.47082585531;52528;52781.47218527842;31191.376172476423;31356.686433135375;31462.37075258482;31561.526577101362;31727;13738.381772820247;13921.373538190603;13928.233947132801;13945.58163255104;13950.860491395159;12246.816297755362;12304.138710290374;12305.138640295094;12310.322932238634;12351.135420520477;8345.165483451607;8358.331333493306;8367;8422.747317580483;8455.323574114056;3240.1251662051586;3311.185492331499;3324.8171350575467;3329.7336213102894;3350.8492117854266;932.4125800745487;938.9530523473799;944.1927152284698;994.7612572982432;1111.9777604448027;28617.57073643897;29415.705842941297;29570;29949;30201.697983019887;989.2975987049132;1019.1846522781893;1022.4274406332478;1110.2838669058413;1126.718320419895;14791.482298119514;15239.61900952463;15394.459274366734;16523.421680241136;16541.172941352885;363298;363695;365558;365953;368320;54145;54592;54825.45174548283;54892.72553637206;54960;1286.8391451068617;1289.7871851144644;1328.0769864943964;1332.486992507872;1333.5665908579751;28929;30319.053949482808;30697.53953690741;30720.692793072678;30758;45381.77309113433;46036.76981615071;46285.53714462812;46286;46380;331340;332154;332301;332773;333669;26143.607845881947;26650;26810.463790724465;26828.195154145407;27049.729502704722;44454;44503;45037;45250;45321.147702444345;37461.43807842939;37746.245075098894;37931.2413751729;38010.23979520449;38778.4183237246;36983.59606625561;37697.81151094227;37917.241655167294;38102.61897381102;38553.2289354217;35554;37160.62839371571;38312.04219894413;41302.79348603238;42196.367054493596;32519.674803251666;33756.66243337535;33808.66191338055;33844.492332615526;34038.829805850815;25594;25912.352191194615;26167.607485887347;26178;26225.344366390993 14:55:16 INFO - PROCESS | 15129 | |2;jquery.html;380.63078813550857;381.7652143931482;382.4664592892916;390.63085384311836;390.9706771992101;16230.10734409607;17252;17430.564235894108;17911.73132403015;17933.193006314716;15433.305501252442;15822.44621438247;15835.049897006158;15884;16310.184490775473;5071.873203169923;5271.578273738091;5292.735363231843;5340.62615616907;5343.118385466393;3694.5751238607636;5757.856053598652;6061.878552467785;6083.391660833903;6177.629342239457;4901.65688401812;6093.268807743077;6099.512039036888;6131.601445906024;6140.969295153541;5155.7679904404395;5186.170212765939;5234.58123350133;5241.31862857826;5243.2659427680155;4891.853244402673;5379.838604841861;5382.757775900055;5394.568434525228;5414.296141501619;11815.527378904833;12041.879581204163;12125.09061820367;15688;20984.16063357464;1921.788603253641;1952.3557226115347;2041.3263623004373;2065.328768150357;2248;8757.649694012296;8918;9105.36262461628;9503.952480237624;10095.848562271573;1682.2513981278337;1705.5736065983504;1766.3023105873108;1789.4452719656817;1849.4821449994024;73861.63069184619;74438.25561744421;75297.62351188209;75936.62031689806;76129.23870761276;9894.109530142321;9978.253805583994;10186.643467478603;10207.132393746615;10214.131798797185;14234.288285585679;14300.570982870531;14321.212333321768;14339.067960582528;14355.497557585435;7664.616769161519;7754.302112809874;7884.85669577908;7887.2112788721815;7922.405819563556;7326.597037163007;7524.435667324972;7676.002119724511;7697.653605587762;7698.42261830365;4256.829726810893;4291.463567054118;4354.934675979863;4393.868183954486;4454.064646424223;1606.5742578216782;1674.5980964568416;1846.22458567402;1847.233398139757;1851.9166637501344;868.8436081505263;882.6822343956171;912.9406588571721;947.0624082158613;981.9361741486781;15655.68688626221;16236.1070141141;16545.6690866182;17263.309467621406;17353.132343382782;880.6257340630207;891.7503099132254;915.2952226785338;921.6820197032014;925.4678559828126;9608.75978100553;9733.367331123454;9750;9764.51177441125;9821.607135714492;385244;390614;391230;399232;401169;75392;77848.61075694585;80105;81303;81584;961.5384615384654;965.9855102173473;969.3505351414569;976.702105857706;990.2672022703292;15262.3895044197;15434.768478472608;15488.922555387151;15494.5351639451;15591.376344946075;32211.677883221804;33095.66904331022;34389;34741;34743.305133896676;47888.281675775586;49728.75135624299;50294.245586315505;50333.24500132428;50680;4377.409049778366;5367.973160134331;5469.42571030052;7418.591977441292;7876.251756083163;9470.57382417779;10300.639477618248;10502.4223667699;10698.62554810578;11172.21794474379;9157.450552966844;9173.678921237724;9346.953265233631;9482.099200575934;10484.42335671515;9508.572114255014;9703.417794932328;9807.509624518889;10252.128569071414;10628.84056739165;10243.23175761806;10390.220733445172;10485.266031378036;10620.15038796879;10652;7770.883436748566;7777.300042996158;7783.688652453839;7852.960735196516;7908.802279942817;8310.21052999964;9710.75723106928;9908.306418550632;9936.20510359155;10112.79774404493 14:55:16 INFO - PROCESS | 15129 | |3;mootools.html;1520.0347779160234;1520.2094910646465;1734.3496188929153;1838.4760343302162;1882.6987681970888;6672;7459.179490256074;7464.925350746491;7971.960140199298;7973.720919767802;7516.849663006737;7729.381649468043;7741.729039483619;7747.1090824555195;7768.766936991885;2170.1319472211126;2202.592520383734;2204.459907322708;2209.8784566848817;2210.4694873230387;2143.228437762404;2143.474848662072;2192.27654873892;2199.593075281078;2206.2609025976317;2171.6091103601348;2182.0508078985613;2197.505561248722;2209.4476380904775;2227.7438094619165;2137.8396620253466;2139.358192542231;2142.9892850535803;2145.7639659637425;2149.8280137589036;2140.3792900058966;2145.10977944153;2145.8605190662556;2150.655895056799;2161.0383379396176;7673.155952845183;7741.651625676858;7761.805954851174;7766;7783.494072885244;4574.290984897346;4649.139909116824;4673.88315292117;4684.789184486706;4703.905921881577;2813.4795062913427;2897.043975488105;2955;2960.6299212598424;2974.3307755755;951.2770294576103;974.639383428129;993.344392700814;1002.3785253143025;1016.7254841192911;10289.588416463332;10359.689209323657;10368;10381.273310868242;10389.168866490663;4107.54816970133;4126.938095928564;4178.101708132705;4228.217779710763;4244.957550424456;8808.075152109064;8851.778705532413;8852.734417967471;8896.688615898413;8926.553672316359;4459.063596644676;4535.705179163344;4592.931106033412;4637.39713837199;4727.361806156194;3561.287742451468;4139.110091330378;4277.636400905958;4278.44380230568;4278.930267433142;3633.454981752758;3666.431703086026;3726.31063253299;3790.1472168761807;3879.650831425185;1201.891829735328;1216.6532538226563;1222.1200735470447;1222.8043513038049;1223.6390264871884;892.1078921078921;916.5096673279763;922.377395258198;934.1685899549407;936.8875734911854;5154.226865970059;5187.403448603383;5332.173513105475;5438.5377242934;5451.836444906659;925.5418567808844;930.2836815652046;963.9807203855884;1033.8294181460126;1036.8807587127426;3728.5339332583426;3839.9040023999623;3860;3887.6501114899793;3922.6077392260545;9367.156955874005;9484.31355894093;9607.039296070338;9666.75833104164;9696.95151524252;9604.135627793392;9629.566669499889;9637.084476974676;9647.951760241294;9650.75873103164;6596.4393026592315;7319.963400182965;7423.591702456309;7428.888566671504;7485;5198.844034678966;5309.230161626465;5337.466253374631;5349.037173308841;5356.973215133899;8230.341572674291;8348.373871959506;8627.568621569022;8664.91335086641;8704.042555318783;8746.781330466789;8864.556772161237;9048.954755226181;9059.139381758723;9089;6453.225612926291;7140.8214794628475;7272.163701174432;7319.670614822452;7470.178280389261;7552.735654252075;7555.886661700189;7582.886256706043;7633.618319084135;7640.930269762127;6625.933740662532;6966.651667416508;7011.649417529001;7040;7101.502894797522;6730.4952128589575;6801.455883529405;6808.217055038734;6826.556273842184;6869.484788640772;6113.694315284129;6322.462590679844;6351.333110023381;6436.034594810629;6445.871082578416;4620.5148459411275;4749.382580264543;4810.086083644096;4826.131296366688;4852.660313778002;4826.855194344175;4860.902781944412;4862.197737373293;4874.098291816025;4909.1899836528 14:55:16 INFO - PROCESS | 15129 | |4;prototype.html;297.6755336683016;299.2085932707989;300.0398724082935;303.9376927729815;306.72854523746486;5061.4938506149365;5100.209467532529;5110.4123025851995;5128.948710512894;5133.153029750087;5007.824726134586;5021.297018417425;5026.486756621689;5048.772805223764;5055.873603159923;3682.6869716074166;3787.9431808522895;3894.201688653833;3894.3184942635066;3915.177812659345;3878.728489005771;3887.300285948528;3905.33609286422;3908.7263891527464;3923.6272554107313;3871.9672172109586;3879.12719638082;3905.4532365468717;3908.553835081024;3920;3841.8655347063;3876.0697432616253;3906.628870257335;3912.5500567434683;3915.275674000319;3456.3432947740102;3475.4439289713523;3478.2521757821937;3487.738419618539;3493.6331685172945;4739.9526004739855;4791.832285870013;4793.952060479385;4807.134715751164;4831.589314908237;4400.811780819161;4495.820167193308;4505.053938672882;4531.048479819242;4536.659750518725;5189.820275484306;5195.740212989335;5203.349581302337;5208;5225.2162175673575;3761.887143385703;3806.467094606757;3811.4663947047434;3828.406596977473;3835.520559930009;5469.15228139639;5487.42382049883;5496.587755918322;5500.257465242181;5504.339479262514;3568.946465803015;3737.7757334560015;3739.7569158004644;3749.9625003750157;3768.171002379472;3773.5660399053913;3775.1505911170316;3803.486529318562;3803.505544279226;3804.391297392404;4361.124716371927;4372;4379.474463064389;4391.780410979438;4439.446193832133;5097.8725531862;5272.261883336336;5283.313169287968;5285.788568457218;5332.68003919766;1277.2272774971195;1285.3573213393304;1289.6711338608595;1294.2816736711027;1296.6434230586665;817.3747083481142;860.423516244118;873.8645509945968;894.4677916639589;895.5790778334173;4507.4365704286965;4600.171969045537;4628.791704373311;4630.4443466784205;4646.97676511622;5403.43300442875;5452.40023597404;5466.508014278734;5477.972610136924;5492.725363731797;4387.517373088957;4567.3377360282575;4594.701344412602;4621.560951709582;4661.766911654404;2759.0962236057057;2804.7982333867817;2824.742989369711;2825.293676580855;2832.6175966244705;4907.312976183337;4932.8520144395725;4940.90118197634;4958.702477851269;4973.850784476472;5225.921611175835;5324.600654950894;5391.649542779707;5405.4324295949145;5627.606067575231;5102.642815002914;5107.157319042391;5128.333316668809;5128.461511541234;5140.485951404829;5454.481824226851;5455.236266922713;5476.507114359727;5498.3127109111365;5502.147167189092;5247.107991641354;5284.682919024871;5332.466753324637;5377.489138531833;5388.919166212431;5107.284980102863;5107.361579802525;5123.538881500683;5143.691378517301;5158.632962264927;3789.1663833956486;3811.7141214409585;3813.447050177653;3840.9039774005873;3848.5574158972076;5272.261883336259;5392.379876314274;5423.349198096096;5432.402435732145;5509.449055094618;5219.8434046978655;5221.738913054408;5236.816711415235;5254.633795213195;5265.210218467108;5288.65623734456;5293.311869456946;5294.947050529599;5314.5216930476445;5321.680699158062;4982.98529389714;5165.173572228426;5193.143131383431;5207.713575753219;5228.555572776357;5083.644144909968;5110.131277682728;5287.365516138088;5308.442613525524;5317.43135774955;5171.896562068813;5176.482351764794;5179.585633149414;5188.922166167586;5192.714400707846 14:55:16 INFO - PROCESS | 15129 | |5;yui.html;763.2901401696423;798.3453568074178;803.5781214862196;806.5402720449346;807.7213361390318;12834.550790722327;13116.081874268804;13190.670233244162;13205.405756740945;13267.668308292297;14019.92990035051;14047.086939348936;14134.081284716487;14138.858611413883;14139.717205655881;695.3672158335916;879.2614204068581;881.925036371906;885.2563846369048;891.0421297105605;872.2237208884098;904.7466709321401;904.7873749668822;906.2251774732574;906.2613969614775;916.2852974679727;916.8349697054527;919.1773362840254;920.742192186189;921.1617428140394;913.6391125505454;918.2241006349624;919.2737737187614;921.1111277617098;924.4545718026363;676.1480534526532;681.3152781454656;681.6932380428827;681.7307163670372;682.1847891769338;12970.351482425842;13037.152585082034;13046.804297935538;13065.804012939814;13078.346082695922;12769.425375858016;12782.808257876139;12888.54890078852;12938;13166.473341066347;9903.80192396148;9997.950010249975;10049.598016079348;10070.04334588213;10129.949350253275;3327.7504187185814;3330.333933213367;3384.76306658534;3427.3145370925913;3494;45800.312995305096;46060.53939460596;46272.30591541129;46300.3054954176;46711;10177.592896284214;10318.071373576415;10319.587216511405;10544.420056896792;10598.364098154136;18260.360887369145;18405.81594184068;18407.447776566725;18454;18630;6907.412869906014;6918.342757438136;7040.3663670269925;7043.894341584881;7129.394001509826;3825.6556909878245;3860.1121741999495;3864.9033774155873;3888.902777430587;3897.512810898638;2769.556870900646;2830.5188118019987;2850.458412901542;2854;2856.300206449433;502.13632552010483;507.85272271041725;508.3493128795148;510.8722819295176;513.5942605341738;607.5170239659482;640.5260107520402;644.3105876711874;646.1470858466779;658.4600627485416;6663.86672266552;6979.336962988508;7070.328318809808;7323.2676732326345;7360.705571777176;526.9973650131725;529.5022678682027;538.2222688215569;615.2801222569605;630.9936900630935;3820.8853734388013;3825.540935087807;3899.122697393064;3948.723589348718;3998.632776701718;51618.741906290226;53725.462745372824;53771.731141344826;53921.730391347795;53959.73020134953;46814.76592617015;47454.5254547457;47968.520314796406;48509;49168.26247606217;42978.355324670156;44345.334819977084;44435.777821110685;44764;45079.32381014287;7568.583727894798;7660.923390766021;7771.72798952034;7932.960335198518;7944.6822127114265;27618.309542261602;29314.560281595368;29857.85071074631;30331;30541.847290763402;35041.824790875886;38678.80660596679;38738.6126138735;39563.406548901214;39934.60065399309;10734.055833801756;10802.297850639683;10886.945565272123;11151.776964460827;11204.271722338022;11542.249753765978;11823.408829558315;11870.406479675808;12071.101293972108;12230.266184028987;10939;11066.28069175501;11102.666919992413;11107.500162492546;11529.884701152881;10808.661245103529;10982.505787239754;11023.393713345522;11058;11091.223614346918;10898.836517452086;10927.672169834917;11011.339319640847;11263.155263355116;11264.211505194886;8088.859588664771;8205.753827385188;8332.541710205754;8343.499390036617;9583.952080239555;8249.257566819015;8278.30954939635;8317.542535160625;8399.622017009371;8561.871571926302 14:55:16 INFO - PROCESS | 15129 | __end_tp_report 14:55:16 INFO - PROCESS | 15129 | __start_cc_report 14:55:16 INFO - PROCESS | 15129 | _x_x_mozilla_cycle_collect,396 14:55:16 INFO - PROCESS | 15129 | __end_cc_report 14:55:16 INFO - PROCESS | 15129 | __startTimestamp1462485316297__endTimestamp 14:55:16 INFO - PROCESS | 15129 | 14:55:16 INFO - PROCESS | 15129 | ------- Summary: start ------- 14:55:16 INFO - PROCESS | 15129 | Number of tests: 6 14:55:16 INFO - PROCESS | 15129 | 14:55:16 INFO - PROCESS | 15129 | [#0] dojo.html Cycles:165 Average:4830.53 Median:4965.63 stddev:513.55 (10.3%) stddev-sans-first:486.06 14:55:16 INFO - PROCESS | 15129 | Values: 2659.1 2739.4 2747.5 2756.3 2762.6 4750.5 4761.9 4801.7 4851.1 4895.2 4729.4 4795.4 4804.6 4860.6 4873.1 4428.6 4464.0 4506.4 4512.2 4520.5 4436.8 4456.7 4469.2 4496.7 4520.9 4504.3 4512.5 4517.5 4560.1 4568.7 4426.2 4488.4 4513.6 4535.6 4536.4 4376.1 4462.2 4478.0 4490.4 4493.0 4732.5 4740.9 4742.6 4757.8 4809.8 5018.6 5271.5 5284.4 5291.9 5341.9 5162.2 5194.0 5207.9 5219.5 5224.2 4845.4 4887.5 4928.4 4929.7 4972.2 5349.2 5367.2 5390.3 5403.7 5407.6 5181.5 5206.9 5213.1 5213.8 5251.2 5233.6 5290.1 5295.3 5305.1 5342.0 5041.7 5146.7 5159.5 5214.1 5230.1 5158.5 5166.4 5174.7 5188.4 5199.3 4464.7 4476.7 4479.9 4523.1 4531.0 3748.8 3778.8 3838.7 3890.0 3908.8 4474.2 4495.2 4495.9 4528.7 4589.1 5295.2 5297.2 5299.4 5306.8 5308.2 4354.6 4440.0 4470.5 4509.0 4523.5 4666.2 4701.9 4709.4 4713.9 4758.3 4950.5 4962.8 4963.0 4977.5 5013.0 5117.5 5214.3 5247.8 5268.4 5288.0 4965.6 4988.4 4996.1 4997.2 5033.5 5073.6 5208.9 5216.3 5218.9 5231.0 5232.2 5244.2 5269.5 5284.2 5287.6 5120.0 5126.9 5145.4 5162.7 5180.3 4839.2 4928.2 5056.9 5107.1 5131.6 4908.6 4955.4 4961.3 4966.1 5076.4 5112.2 5112.3 5124.3 5128.3 5187.1 4994.6 5000.3 5019.1 5040.6 5068.5 14:55:16 INFO - PROCESS | 15129 | 14:55:16 INFO - PROCESS | 15129 | [#1] ext.html Cycles:180 Average:46613.29 Median:364626.50 stddev:84165.08 (23.1%) stddev-sans-first:84330.14 14:55:16 INFO - PROCESS | 15129 | Values: 554.8 591.1 609.4 610.1 635.2 35528.6 39688.2 39877.2 39999.6 40115.0 41292.0 41505.8 41618.4 41843.0 41894.4 7939.0 8028.9 8043.3 8048.1 8072.8 7850.2 7874.3 7954.4 7969.1 7978.0 7929.4 7990.4 8013.2 8021.3 8028.9 7903.2 7918.0 7956.4 7959.2 7974.2 7770.6 7821.3 7829.0 7844.8 7849.5 37632.2 37916.2 37928.6 37993.4 38056.0 3285.2 3313.9 3369.9 3433.9 3767.8 27024.9 30199.2 30454.7 30496.8 31700.5 3334.6 3347.8 3356.9 3370.5 3400.6 248267.0 249865.0 250000.7 250887.0 252988.0 29576.1 30614.0 30688.5 52528.0 52781.5 31191.4 31356.7 31462.4 31561.5 31727.0 13738.4 13921.4 13928.2 13945.6 13950.9 12246.8 12304.1 12305.1 12310.3 12351.1 8345.2 8358.3 8367.0 8422.7 8455.3 3240.1 3311.2 3324.8 3329.7 3350.8 932.4 939.0 944.2 994.8 1112.0 28617.6 29415.7 29570.0 29949.0 30201.7 989.3 1019.2 1022.4 1110.3 1126.7 14791.5 15239.6 15394.5 16523.4 16541.2 363298.0 363695.0 365558.0 365953.0 368320.0 54145.0 54592.0 54825.5 54892.7 54960.0 1286.8 1289.8 1328.1 1332.5 1333.6 28929.0 30319.1 30697.5 30720.7 30758.0 45381.8 46036.8 46285.5 46286.0 46380.0 331340.0 332154.0 332301.0 332773.0 333669.0 26143.6 26650.0 26810.5 26828.2 27049.7 44454.0 44503.0 45037.0 45250.0 45321.1 37461.4 37746.2 37931.2 38010.2 38778.4 36983.6 37697.8 37917.2 38102.6 38553.2 35554.0 37160.6 38312.0 41302.8 42196.4 32519.7 33756.7 33808.7 33844.5 34038.8 25594.0 25912.4 26167.6 26178.0 26225.3 14:55:16 INFO - PROCESS | 15129 | 14:55:16 INFO - PROCESS | 15129 | [#2] jquery.html Cycles:180 Average:24287.81 Median:27875.94 stddev:65133.64 (233.7%) stddev-sans-first:65291.62 14:55:16 INFO - PROCESS | 15129 | Values: 380.6 381.8 382.5 390.6 391.0 16230.1 17252.0 17430.6 17911.7 17933.2 15433.3 15822.4 15835.0 15884.0 16310.2 5071.9 5271.6 5292.7 5340.6 5343.1 3694.6 5757.9 6061.9 6083.4 6177.6 4901.7 6093.3 6099.5 6131.6 6141.0 5155.8 5186.2 5234.6 5241.3 5243.3 4891.9 5379.8 5382.8 5394.6 5414.3 11815.5 12041.9 12125.1 15688.0 20984.2 1921.8 1952.4 2041.3 2065.3 2248.0 8757.6 8918.0 9105.4 9504.0 10095.8 1682.3 1705.6 1766.3 1789.4 1849.5 73861.6 74438.3 75297.6 75936.6 76129.2 9894.1 9978.3 10186.6 10207.1 10214.1 14234.3 14300.6 14321.2 14339.1 14355.5 7664.6 7754.3 7884.9 7887.2 7922.4 7326.6 7524.4 7676.0 7697.7 7698.4 4256.8 4291.5 4354.9 4393.9 4454.1 1606.6 1674.6 1846.2 1847.2 1851.9 868.8 882.7 912.9 947.1 981.9 15655.7 16236.1 16545.7 17263.3 17353.1 880.6 891.8 915.3 921.7 925.5 9608.8 9733.4 9750.0 9764.5 9821.6 385244.0 390614.0 391230.0 399232.0 401169.0 75392.0 77848.6 80105.0 81303.0 81584.0 961.5 966.0 969.4 976.7 990.3 15262.4 15434.8 15488.9 15494.5 15591.4 32211.7 33095.7 34389.0 34741.0 34743.3 47888.3 49728.8 50294.2 50333.2 50680.0 4377.4 5368.0 5469.4 7418.6 7876.3 9470.6 10300.6 10502.4 10698.6 11172.2 9157.5 9173.7 9347.0 9482.1 10484.4 9508.6 9703.4 9807.5 10252.1 10628.8 10243.2 10390.2 10485.3 10620.2 10652.0 7770.9 7777.3 7783.7 7853.0 7908.8 8310.2 9710.8 9908.3 9936.2 10112.8 14:55:16 INFO - PROCESS | 15129 | 14:55:16 INFO - PROCESS | 15129 | [#3] mootools.html Cycles:180 Average:5163.58 Median:5193.12 stddev:2813.82 (54.2%) stddev-sans-first:2808.39 14:55:16 INFO - PROCESS | 15129 | Values: 1520.0 1520.2 1734.3 1838.5 1882.7 6672.0 7459.2 7464.9 7972.0 7973.7 7516.8 7729.4 7741.7 7747.1 7768.8 2170.1 2202.6 2204.5 2209.9 2210.5 2143.2 2143.5 2192.3 2199.6 2206.3 2171.6 2182.1 2197.5 2209.4 2227.7 2137.8 2139.4 2143.0 2145.8 2149.8 2140.4 2145.1 2145.9 2150.7 2161.0 7673.2 7741.7 7761.8 7766.0 7783.5 4574.3 4649.1 4673.9 4684.8 4703.9 2813.5 2897.0 2955.0 2960.6 2974.3 951.3 974.6 993.3 1002.4 1016.7 10289.6 10359.7 10368.0 10381.3 10389.2 4107.5 4126.9 4178.1 4228.2 4245.0 8808.1 8851.8 8852.7 8896.7 8926.6 4459.1 4535.7 4592.9 4637.4 4727.4 3561.3 4139.1 4277.6 4278.4 4278.9 3633.5 3666.4 3726.3 3790.1 3879.7 1201.9 1216.7 1222.1 1222.8 1223.6 892.1 916.5 922.4 934.2 936.9 5154.2 5187.4 5332.2 5438.5 5451.8 925.5 930.3 964.0 1033.8 1036.9 3728.5 3839.9 3860.0 3887.7 3922.6 9367.2 9484.3 9607.0 9666.8 9697.0 9604.1 9629.6 9637.1 9648.0 9650.8 6596.4 7320.0 7423.6 7428.9 7485.0 5198.8 5309.2 5337.5 5349.0 5357.0 8230.3 8348.4 8627.6 8664.9 8704.0 8746.8 8864.6 9049.0 9059.1 9089.0 6453.2 7140.8 7272.2 7319.7 7470.2 7552.7 7555.9 7582.9 7633.6 7640.9 6625.9 6966.7 7011.6 7040.0 7101.5 6730.5 6801.5 6808.2 6826.6 6869.5 6113.7 6322.5 6351.3 6436.0 6445.9 4620.5 4749.4 4810.1 4826.1 4852.7 4826.9 4860.9 4862.2 4874.1 4909.2 14:55:16 INFO - PROCESS | 15129 | 14:55:16 INFO - PROCESS | 15129 | [#4] prototype.html Cycles:180 Average:4352.62 Median:4995.41 stddev:1278.41 (25.6%) stddev-sans-first:1245.24 14:55:16 INFO - PROCESS | 15129 | Values: 297.7 299.2 300.0 303.9 306.7 5061.5 5100.2 5110.4 5128.9 5133.2 5007.8 5021.3 5026.5 5048.8 5055.9 3682.7 3787.9 3894.2 3894.3 3915.2 3878.7 3887.3 3905.3 3908.7 3923.6 3872.0 3879.1 3905.5 3908.6 3920.0 3841.9 3876.1 3906.6 3912.6 3915.3 3456.3 3475.4 3478.3 3487.7 3493.6 4740.0 4791.8 4794.0 4807.1 4831.6 4400.8 4495.8 4505.1 4531.0 4536.7 5189.8 5195.7 5203.3 5208.0 5225.2 3761.9 3806.5 3811.5 3828.4 3835.5 5469.2 5487.4 5496.6 5500.3 5504.3 3568.9 3737.8 3739.8 3750.0 3768.2 3773.6 3775.2 3803.5 3803.5 3804.4 4361.1 4372.0 4379.5 4391.8 4439.4 5097.9 5272.3 5283.3 5285.8 5332.7 1277.2 1285.4 1289.7 1294.3 1296.6 817.4 860.4 873.9 894.5 895.6 4507.4 4600.2 4628.8 4630.4 4647.0 5403.4 5452.4 5466.5 5478.0 5492.7 4387.5 4567.3 4594.7 4621.6 4661.8 2759.1 2804.8 2824.7 2825.3 2832.6 4907.3 4932.9 4940.9 4958.7 4973.9 5225.9 5324.6 5391.6 5405.4 5627.6 5102.6 5107.2 5128.3 5128.5 5140.5 5454.5 5455.2 5476.5 5498.3 5502.1 5247.1 5284.7 5332.5 5377.5 5388.9 5107.3 5107.4 5123.5 5143.7 5158.6 3789.2 3811.7 3813.4 3840.9 3848.6 5272.3 5392.4 5423.3 5432.4 5509.4 5219.8 5221.7 5236.8 5254.6 5265.2 5288.7 5293.3 5294.9 5314.5 5321.7 4983.0 5165.2 5193.1 5207.7 5228.6 5083.6 5110.1 5287.4 5308.4 5317.4 5171.9 5176.5 5179.6 5188.9 5192.7 14:55:16 INFO - PROCESS | 15129 | 14:55:16 INFO - PROCESS | 15129 | [#5] yui.html Cycles:180 Average:12984.94 Median:44599.89 stddev:14742.53 (33.1%) stddev-sans-first:14755.31 14:55:16 INFO - PROCESS | 15129 | Values: 763.3 798.3 803.6 806.5 807.7 12834.6 13116.1 13190.7 13205.4 13267.7 14019.9 14047.1 14134.1 14138.9 14139.7 695.4 879.3 881.9 885.3 891.0 872.2 904.7 904.8 906.2 906.3 916.3 916.8 919.2 920.7 921.2 913.6 918.2 919.3 921.1 924.5 676.1 681.3 681.7 681.7 682.2 12970.4 13037.2 13046.8 13065.8 13078.3 12769.4 12782.8 12888.5 12938.0 13166.5 9903.8 9998.0 10049.6 10070.0 10129.9 3327.8 3330.3 3384.8 3427.3 3494.0 45800.3 46060.5 46272.3 46300.3 46711.0 10177.6 10318.1 10319.6 10544.4 10598.4 18260.4 18405.8 18407.4 18454.0 18630.0 6907.4 6918.3 7040.4 7043.9 7129.4 3825.7 3860.1 3864.9 3888.9 3897.5 2769.6 2830.5 2850.5 2854.0 2856.3 502.1 507.9 508.3 510.9 513.6 607.5 640.5 644.3 646.1 658.5 6663.9 6979.3 7070.3 7323.3 7360.7 527.0 529.5 538.2 615.3 631.0 3820.9 3825.5 3899.1 3948.7 3998.6 51618.7 53725.5 53771.7 53921.7 53959.7 46814.8 47454.5 47968.5 48509.0 49168.3 42978.4 44345.3 44435.8 44764.0 45079.3 7568.6 7660.9 7771.7 7933.0 7944.7 27618.3 29314.6 29857.9 30331.0 30541.8 35041.8 38678.8 38738.6 39563.4 39934.6 10734.1 10802.3 10886.9 11151.8 11204.3 11542.2 11823.4 11870.4 12071.1 12230.3 10939.0 11066.3 11102.7 11107.5 11529.9 10808.7 10982.5 11023.4 11058.0 11091.2 10898.8 10927.7 11011.3 11263.2 11264.2 8088.9 8205.8 8332.5 8343.5 9584.0 8249.3 8278.3 8317.5 8399.6 8561.9 14:55:16 INFO - PROCESS | 15129 | -------- Summary: end -------- 14:55:16 INFO - PROCESS | 15129 | 14:55:17 INFO - TEST-INFO | 15129: exit 0 14:55:17 INFO - TEST-OK | dromaeo_css | took 1115823ms 14:55:17 INFO - TEST-START | kraken 14:55:17 INFO - operating with platform_type : linux_ 14:55:17 INFO - Initialising browser for kraken test... 14:55:17 INFO - TEST-INFO | started process 15367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDPf6Is/profile http://localhost:41253/getInfo.html) 14:55:21 INFO - PROCESS | 15367 | 14:55:21 INFO - PROCESS | 15367 | (process:15435): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:55:21 INFO - PROCESS | 15367 | __metrics Screen width/height:1600/1200 14:55:21 INFO - PROCESS | 15367 | colorDepth:24 14:55:21 INFO - PROCESS | 15367 | Browser inner width/height: 1024/697 14:55:21 INFO - PROCESS | 15367 | __metrics 14:55:22 ERROR - PROCESS | 15367 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2945: TypeError: this.tabs is undefined 14:55:23 INFO - TEST-INFO | 15367: exit 0 14:55:23 INFO - Browser initialized. 14:55:23 INFO - Running cycle 1/1 for kraken test... 14:55:23 INFO - TEST-INFO | started process 15486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDPf6Is/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:55:25 INFO - PROCESS | 15486 | 14:55:25 INFO - PROCESS | 15486 | (process:15547): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:55:35 INFO - PROCESS | 15486 | RSS: Main: 164532224 14:55:35 INFO - PROCESS | 15486 | 14:55:38 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41253/tests/kraken/driver.html?testName=audio-beat-detection) 14:55:39 INFO - PROCESS | 15486 | RSS: Main: 168898560 14:55:39 INFO - PROCESS | 15486 | 14:55:41 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41253/tests/kraken/driver.html?testName=audio-dft) 14:55:42 INFO - PROCESS | 15486 | RSS: Main: 168992768 14:55:42 INFO - PROCESS | 15486 | 14:55:45 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41253/tests/kraken/driver.html?testName=audio-fft) 14:55:46 INFO - PROCESS | 15486 | RSS: Main: 163782656 14:55:46 INFO - PROCESS | 15486 | 14:55:48 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41253/tests/kraken/driver.html?testName=audio-oscillator) 14:55:48 INFO - PROCESS | 15486 | RSS: Main: 164302848 14:55:48 INFO - PROCESS | 15486 | 14:55:51 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:55:51 INFO - PROCESS | 15486 | RSS: Main: 164556800 14:55:51 INFO - PROCESS | 15486 | 14:55:54 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41253/tests/kraken/driver.html?testName=imaging-darkroom) 14:55:55 INFO - PROCESS | 15486 | RSS: Main: 164835328 14:55:55 INFO - PROCESS | 15486 | 14:55:59 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41253/tests/kraken/driver.html?testName=imaging-desaturate) 14:55:59 INFO - PROCESS | 15486 | RSS: Main: 163094528 14:55:59 INFO - PROCESS | 15486 | 14:56:02 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41253/tests/kraken/driver.html?testName=json-parse-financial) 14:56:03 INFO - PROCESS | 15486 | RSS: Main: 163864576 14:56:03 INFO - PROCESS | 15486 | 14:56:04 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:56:05 INFO - PROCESS | 15486 | RSS: Main: 164257792 14:56:05 INFO - PROCESS | 15486 | 14:56:07 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41253/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:56:08 INFO - PROCESS | 15486 | RSS: Main: 164139008 14:56:08 INFO - PROCESS | 15486 | 14:56:10 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:56:11 INFO - PROCESS | 15486 | RSS: Main: 164397056 14:56:11 INFO - PROCESS | 15486 | 14:56:13 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:56:14 INFO - PROCESS | 15486 | RSS: Main: 164556800 14:56:14 INFO - PROCESS | 15486 | 14:56:17 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:56:18 INFO - PROCESS | 15486 | RSS: Main: 164098048 14:56:18 INFO - PROCESS | 15486 | 14:56:19 INFO - PROCESS | 15486 | Cycle 1(1): loaded http://localhost:41253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41253/tests/kraken/driver.html?testName=ai-astar) 14:56:20 INFO - PROCESS | 15486 | RSS: Main: 165937152 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | __start_tp_report 14:56:20 INFO - PROCESS | 15486 | _x_x_mozilla_page_load 14:56:20 INFO - PROCESS | 15486 | _x_x_mozilla_page_load_details 14:56:20 INFO - PROCESS | 15486 | |i|pagename|runs| 14:56:20 INFO - PROCESS | 15486 | |0;ai-astar;112;117;107;115;119;116;111;114;115;115 14:56:20 INFO - PROCESS | 15486 | |1;audio-beat-detection;156;135;154;201;135;156;156;135;189;141 14:56:20 INFO - PROCESS | 15486 | |2;audio-dft;162;163;164;174;162;163;163;164;162;163 14:56:20 INFO - PROCESS | 15486 | |3;audio-fft;75;77;76;157;78;76;76;77;169;78 14:56:20 INFO - PROCESS | 15486 | |4;audio-oscillator;94;93;138;93;95;93;148;93;93;146 14:56:20 INFO - PROCESS | 15486 | |5;imaging-gaussian-blur;118;118;118;118;117;118;118;117;118;118 14:56:20 INFO - PROCESS | 15486 | |6;imaging-darkroom;147;148;147;146;147;148;147;148;147;147 14:56:20 INFO - PROCESS | 15486 | |7;imaging-desaturate;95;96;96;95;96;96;96;96;96;96 14:56:20 INFO - PROCESS | 15486 | |8;json-parse-financial;67;68;67;67;67;66;66;90;65;66 14:56:20 INFO - PROCESS | 15486 | |9;json-stringify-tinderbox;63;64;64;64;64;64;63;63;67;64 14:56:20 INFO - PROCESS | 15486 | |10;stanford-crypto-aes;84;82;83;91;83;85;84;84;84;83 14:56:20 INFO - PROCESS | 15486 | |11;stanford-crypto-ccm;136;143;131;136;144;152;134;136;212;138 14:56:20 INFO - PROCESS | 15486 | |12;stanford-crypto-pbkdf2;176;176;183;179;180;177;175;177;174;176 14:56:20 INFO - PROCESS | 15486 | |13;stanford-crypto-sha256-iterative;68;72;68;68;71;68;68;68;68;68 14:56:20 INFO - PROCESS | 15486 | __end_tp_report 14:56:20 INFO - PROCESS | 15486 | __start_cc_report 14:56:20 INFO - PROCESS | 15486 | _x_x_mozilla_cycle_collect,965 14:56:20 INFO - PROCESS | 15486 | __end_cc_report 14:56:20 INFO - PROCESS | 15486 | __startTimestamp1462485380012__endTimestamp 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | ------- Summary: start ------- 14:56:20 INFO - PROCESS | 15486 | Number of tests: 14 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:3.38 (2.9%) stddev-sans-first:3.50 14:56:20 INFO - PROCESS | 15486 | Values: 112.0 117.0 107.0 115.0 119.0 116.0 111.0 114.0 115.0 115.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:156.00 stddev:22.77 (14.6%) stddev-sans-first:24.15 14:56:20 INFO - PROCESS | 15486 | Values: 156.0 135.0 154.0 201.0 135.0 156.0 156.0 135.0 189.0 141.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:3.59 (2.2%) stddev-sans-first:3.73 14:56:20 INFO - PROCESS | 15486 | Values: 162.0 163.0 164.0 174.0 162.0 163.0 163.0 164.0 162.0 163.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.50 stddev:36.54 (47.8%) stddev-sans-first:38.11 14:56:20 INFO - PROCESS | 15486 | Values: 75.0 77.0 76.0 157.0 78.0 76.0 76.0 77.0 169.0 78.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.00 stddev:24.56 (26.4%) stddev-sans-first:25.48 14:56:20 INFO - PROCESS | 15486 | Values: 94.0 93.0 138.0 93.0 95.0 93.0 148.0 93.0 93.0 146.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:56:20 INFO - PROCESS | 15486 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:56:20 INFO - PROCESS | 15486 | Values: 147.0 148.0 147.0 146.0 147.0 148.0 147.0 148.0 147.0 147.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:56:20 INFO - PROCESS | 15486 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:67.00 stddev:7.46 (11.1%) stddev-sans-first:7.88 14:56:20 INFO - PROCESS | 15486 | Values: 67.0 68.0 67.0 67.0 67.0 66.0 66.0 90.0 65.0 66.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:1.15 (1.8%) stddev-sans-first:1.17 14:56:20 INFO - PROCESS | 15486 | Values: 63.0 64.0 64.0 64.0 64.0 64.0 63.0 63.0 67.0 64.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:2.50 (3.0%) stddev-sans-first:2.65 14:56:20 INFO - PROCESS | 15486 | Values: 84.0 82.0 83.0 91.0 83.0 85.0 84.0 84.0 84.0 83.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:140.50 stddev:23.89 (17.0%) stddev-sans-first:25.05 14:56:20 INFO - PROCESS | 15486 | Values: 136.0 143.0 131.0 136.0 144.0 152.0 134.0 136.0 212.0 138.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:177.00 stddev:2.67 (1.5%) stddev-sans-first:2.79 14:56:20 INFO - PROCESS | 15486 | Values: 176.0 176.0 183.0 179.0 180.0 177.0 175.0 177.0 174.0 176.0 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - PROCESS | 15486 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:1.49 (2.2%) stddev-sans-first:1.56 14:56:20 INFO - PROCESS | 15486 | Values: 68.0 72.0 68.0 68.0 71.0 68.0 68.0 68.0 68.0 68.0 14:56:20 INFO - PROCESS | 15486 | -------- Summary: end -------- 14:56:20 INFO - PROCESS | 15486 | 14:56:20 INFO - TEST-INFO | 15486: exit 0 14:56:21 INFO - TEST-OK | kraken | took 64017ms 14:56:21 INFO - SUITE-END | took 1179s 14:56:21 INFO - Completed test suite (00:19:39) 14:56:21 INFO - javascript benchmark 14:56:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.082616497308, 2739.3973325868315, 2747.519184142776, 2756.3247004483906, 2762.5856121581774, 4750.524947505248, 4761.8809529761775, 4801.711897286165, 4851.1267971765155, 4895.241237608177, 4729.432468103823, 4795.3526273953, 4804.591609713169, 4860.562549370556, 4873.122837889178, 4428.601425871663, 4463.977680111595, 4506.391637128979, 4512.232920403523, 4520.457545094593, 4436.844710435135, 4456.6657500687415, 4469.173202957463, 4496.730196188223, 4520.864374068783, 4504.256797628404, 4512.503624601291, 4517.548245175489, 4560.110778398213, 4568.748718820463, 4426.22541055314, 4488.438945131858, 4513.638908887281, 4535.614472769818, 4536.387587675655, 4376.124775045004, 4462.219111655448, 4477.955220447787, 4490.416245888046, 4492.955070449287, 4732.456841432229, 4740.881477963044, 4742.620590352798, 4757.762111894392, 4809.75951202442, 5018.623603229772, 5271.472852714736, 5284.4187139414635, 5291.894162116774, 5341.893162136736, 5162.174052151638, 5194.0, 5207.895842083137, 5219.478052194788, 5224.216367544861, 4845.4185497740145, 4887.535684110039, 4928.359313289249, 4929.704217746947, 4972.204447288416, 5349.22436246742, 5367.221752845816, 5390.326209223847, 5403.702796346239, 5407.567394608501, 5181.4559471255725, 5206.947930520722, 5213.113770658997, 5213.765380557884, 5251.186066159675, 5233.633645644844, 5290.127129023745, 5295.311609490742, 5305.071612467803, 5341.973290133525, 5041.697498150123, 5146.742662866842, 5159.458256883048, 5214.087534681492, 5230.08473517133, 5158.484151584887, 5166.405863325691, 5174.663646862942, 5188.351456067991, 5199.272101905736, 4464.732116073046, 4476.7090139140855, 4479.888002799891, 4523.11799199153, 4531.025829446685, 3748.756330838487, 3778.7543809652284, 3838.654521093059, 3890.0469385000856, 3908.804559772, 4474.172278128557, 4495.213337665896, 4495.887602809956, 4528.705634133771, 4589.128065667513, 5295.232191332312, 5297.178937264653, 5299.39057008449, 5306.8407947761625, 5308.23030660552, 4354.586314300136, 4440.0, 4470.530594287618, 4509.0, 4523.479799822997, 4666.1834179019215, 4701.858944231679, 4709.434867815884, 4713.929291060636, 4758.3100450434495, 4950.480199579064, 4962.751862406937, 4962.998234231957, 4977.477364876709, 5013.047520971004, 5117.488251175002, 5214.270002199619, 5247.816326428557, 5268.367795864521, 5288.048151332797, 4965.627577931597, 4988.401391833003, 4996.125678006261, 4997.150484417585, 5033.521815427529, 5073.644844860824, 5208.921866172086, 5216.347956505437, 5218.8956220876125, 5231.032259032091, 5232.215167724872, 5244.213367994831, 5269.499397557226, 5284.233786100917, 5287.603429742708, 5119.974400127976, 5126.923096153486, 5145.408278048072, 5162.6902385856965, 5180.300659410931, 4839.1531481989805, 4928.162212423825, 5056.873578160576, 5107.131787596043, 5131.589472842089, 4908.558229759339, 4955.355803745634, 4961.280614310833, 4966.056449274626, 5076.36545431821, 5112.156494178419, 5112.258722485144, 5124.282600435868, 5128.282040514406, 5187.092258854761, 4994.550490455877, 5000.324956130876, 5019.146745053423, 5040.647154699136, 5068.493150684902], "value": 4797.445804420292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.8169104195613, 591.1339887065449, 609.3790517224181, 610.1122866229637, 635.2186810223428, 35528.584924994866, 39688.20623587527, 39877.202455950865, 39999.600003999985, 40115.0, 41292.0, 41505.792471037676, 41618.37572436416, 41843.0, 41894.37158442618, 7938.999999999985, 8028.919710802905, 8043.3163181129385, 8048.074471435772, 8072.838543229132, 7850.214978502161, 7874.330681892046, 7954.363650907942, 7969.083555391117, 7978.0, 7929.405294602899, 7990.400719945998, 8013.2387423194705, 8021.318187954031, 8028.919710802905, 7903.249191326815, 7917.960410197969, 7956.443048986574, 7959.164287749761, 7974.202579742037, 7770.611469426506, 7821.2960833524685, 7829.0, 7844.803879902991, 7849.5290282582655, 37632.24735505274, 37916.24167516634, 37928.620713792785, 37993.430098548546, 38056.0, 3285.227971426713, 3313.90058298249, 3369.9494507582162, 3433.8626454941773, 3767.792771397572, 27024.864875675692, 30199.245018874484, 30454.695453045628, 30496.8475157625, 31700.524492132638, 3334.6498617645284, 3347.8493467794005, 3356.9496457553155, 3370.5449764282, 3400.60892997306, 248267.0, 249865.0, 250000.74999625067, 250887.0, 252988.0, 29576.112716618536, 30614.0, 30688.47082585531, 52528.0, 52781.47218527842, 31191.376172476423, 31356.686433135375, 31462.37075258482, 31561.526577101362, 31727.0, 13738.381772820247, 13921.373538190603, 13928.233947132801, 13945.58163255104, 13950.860491395159, 12246.816297755362, 12304.138710290374, 12305.138640295094, 12310.322932238634, 12351.135420520477, 8345.165483451607, 8358.331333493306, 8367.0, 8422.747317580483, 8455.323574114056, 3240.1251662051586, 3311.185492331499, 3324.8171350575467, 3329.7336213102894, 3350.8492117854266, 932.4125800745487, 938.9530523473799, 944.1927152284698, 994.7612572982432, 1111.9777604448027, 28617.57073643897, 29415.705842941297, 29570.0, 29949.0, 30201.697983019887, 989.2975987049132, 1019.1846522781893, 1022.4274406332478, 1110.2838669058413, 1126.718320419895, 14791.482298119514, 15239.61900952463, 15394.459274366734, 16523.421680241136, 16541.172941352885, 363298.0, 363695.0, 365558.0, 365953.0, 368320.0, 54145.0, 54592.0, 54825.45174548283, 54892.72553637206, 54960.0, 1286.8391451068617, 1289.7871851144644, 1328.0769864943964, 1332.486992507872, 1333.5665908579751, 28929.0, 30319.053949482808, 30697.53953690741, 30720.692793072678, 30758.0, 45381.77309113433, 46036.76981615071, 46285.53714462812, 46286.0, 46380.0, 331340.0, 332154.0, 332301.0, 332773.0, 333669.0, 26143.607845881947, 26650.0, 26810.463790724465, 26828.195154145407, 27049.729502704722, 44454.0, 44503.0, 45037.0, 45250.0, 45321.147702444345, 37461.43807842939, 37746.245075098894, 37931.2413751729, 38010.23979520449, 38778.4183237246, 36983.59606625561, 37697.81151094227, 37917.241655167294, 38102.61897381102, 38553.2289354217, 35554.0, 37160.62839371571, 38312.04219894413, 41302.79348603238, 42196.367054493596, 32519.674803251666, 33756.66243337535, 33808.66191338055, 33844.492332615526, 34038.829805850815, 25594.0, 25912.352191194615, 26167.607485887347, 26178.0, 26225.344366390993], "value": 17016.759861373725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.63078813550857, 381.7652143931482, 382.4664592892916, 390.63085384311836, 390.9706771992101, 16230.10734409607, 17252.0, 17430.564235894108, 17911.73132403015, 17933.193006314716, 15433.305501252442, 15822.44621438247, 15835.049897006158, 15884.0, 16310.184490775473, 5071.873203169923, 5271.578273738091, 5292.735363231843, 5340.62615616907, 5343.118385466393, 3694.5751238607636, 5757.856053598652, 6061.878552467785, 6083.391660833903, 6177.629342239457, 4901.65688401812, 6093.268807743077, 6099.512039036888, 6131.601445906024, 6140.969295153541, 5155.7679904404395, 5186.170212765939, 5234.58123350133, 5241.31862857826, 5243.2659427680155, 4891.853244402673, 5379.838604841861, 5382.757775900055, 5394.568434525228, 5414.296141501619, 11815.527378904833, 12041.879581204163, 12125.09061820367, 15688.0, 20984.16063357464, 1921.788603253641, 1952.3557226115347, 2041.3263623004373, 2065.328768150357, 2248.0, 8757.649694012296, 8918.0, 9105.36262461628, 9503.952480237624, 10095.848562271573, 1682.2513981278337, 1705.5736065983504, 1766.3023105873108, 1789.4452719656817, 1849.4821449994024, 73861.63069184619, 74438.25561744421, 75297.62351188209, 75936.62031689806, 76129.23870761276, 9894.109530142321, 9978.253805583994, 10186.643467478603, 10207.132393746615, 10214.131798797185, 14234.288285585679, 14300.570982870531, 14321.212333321768, 14339.067960582528, 14355.497557585435, 7664.616769161519, 7754.302112809874, 7884.85669577908, 7887.2112788721815, 7922.405819563556, 7326.597037163007, 7524.435667324972, 7676.002119724511, 7697.653605587762, 7698.42261830365, 4256.829726810893, 4291.463567054118, 4354.934675979863, 4393.868183954486, 4454.064646424223, 1606.5742578216782, 1674.5980964568416, 1846.22458567402, 1847.233398139757, 1851.9166637501344, 868.8436081505263, 882.6822343956171, 912.9406588571721, 947.0624082158613, 981.9361741486781, 15655.68688626221, 16236.1070141141, 16545.6690866182, 17263.309467621406, 17353.132343382782, 880.6257340630207, 891.7503099132254, 915.2952226785338, 921.6820197032014, 925.4678559828126, 9608.75978100553, 9733.367331123454, 9750.0, 9764.51177441125, 9821.607135714492, 385244.0, 390614.0, 391230.0, 399232.0, 401169.0, 75392.0, 77848.61075694585, 80105.0, 81303.0, 81584.0, 961.5384615384654, 965.9855102173473, 969.3505351414569, 976.702105857706, 990.2672022703292, 15262.3895044197, 15434.768478472608, 15488.922555387151, 15494.5351639451, 15591.376344946075, 32211.677883221804, 33095.66904331022, 34389.0, 34741.0, 34743.305133896676, 47888.281675775586, 49728.75135624299, 50294.245586315505, 50333.24500132428, 50680.0, 4377.409049778366, 5367.973160134331, 5469.42571030052, 7418.591977441292, 7876.251756083163, 9470.57382417779, 10300.639477618248, 10502.4223667699, 10698.62554810578, 11172.21794474379, 9157.450552966844, 9173.678921237724, 9346.953265233631, 9482.099200575934, 10484.42335671515, 9508.572114255014, 9703.417794932328, 9807.509624518889, 10252.128569071414, 10628.84056739165, 10243.23175761806, 10390.220733445172, 10485.266031378036, 10620.15038796879, 10652.0, 7770.883436748566, 7777.300042996158, 7783.688652453839, 7852.960735196516, 7908.802279942817, 8310.21052999964, 9710.75723106928, 9908.306418550632, 9936.20510359155, 10112.79774404493], "value": 8142.787417964342, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.0347779160234, 1520.2094910646465, 1734.3496188929153, 1838.4760343302162, 1882.6987681970888, 6672.0, 7459.179490256074, 7464.925350746491, 7971.960140199298, 7973.720919767802, 7516.849663006737, 7729.381649468043, 7741.729039483619, 7747.1090824555195, 7768.766936991885, 2170.1319472211126, 2202.592520383734, 2204.459907322708, 2209.8784566848817, 2210.4694873230387, 2143.228437762404, 2143.474848662072, 2192.27654873892, 2199.593075281078, 2206.2609025976317, 2171.6091103601348, 2182.0508078985613, 2197.505561248722, 2209.4476380904775, 2227.7438094619165, 2137.8396620253466, 2139.358192542231, 2142.9892850535803, 2145.7639659637425, 2149.8280137589036, 2140.3792900058966, 2145.10977944153, 2145.8605190662556, 2150.655895056799, 2161.0383379396176, 7673.155952845183, 7741.651625676858, 7761.805954851174, 7766.0, 7783.494072885244, 4574.290984897346, 4649.139909116824, 4673.88315292117, 4684.789184486706, 4703.905921881577, 2813.4795062913427, 2897.043975488105, 2955.0, 2960.6299212598424, 2974.3307755755, 951.2770294576103, 974.639383428129, 993.344392700814, 1002.3785253143025, 1016.7254841192911, 10289.588416463332, 10359.689209323657, 10368.0, 10381.273310868242, 10389.168866490663, 4107.54816970133, 4126.938095928564, 4178.101708132705, 4228.217779710763, 4244.957550424456, 8808.075152109064, 8851.778705532413, 8852.734417967471, 8896.688615898413, 8926.553672316359, 4459.063596644676, 4535.705179163344, 4592.931106033412, 4637.39713837199, 4727.361806156194, 3561.287742451468, 4139.110091330378, 4277.636400905958, 4278.44380230568, 4278.930267433142, 3633.454981752758, 3666.431703086026, 3726.31063253299, 3790.1472168761807, 3879.650831425185, 1201.891829735328, 1216.6532538226563, 1222.1200735470447, 1222.8043513038049, 1223.6390264871884, 892.1078921078921, 916.5096673279763, 922.377395258198, 934.1685899549407, 936.8875734911854, 5154.226865970059, 5187.403448603383, 5332.173513105475, 5438.5377242934, 5451.836444906659, 925.5418567808844, 930.2836815652046, 963.9807203855884, 1033.8294181460126, 1036.8807587127426, 3728.5339332583426, 3839.9040023999623, 3860.0, 3887.6501114899793, 3922.6077392260545, 9367.156955874005, 9484.31355894093, 9607.039296070338, 9666.75833104164, 9696.95151524252, 9604.135627793392, 9629.566669499889, 9637.084476974676, 9647.951760241294, 9650.75873103164, 6596.4393026592315, 7319.963400182965, 7423.591702456309, 7428.888566671504, 7485.0, 5198.844034678966, 5309.230161626465, 5337.466253374631, 5349.037173308841, 5356.973215133899, 8230.341572674291, 8348.373871959506, 8627.568621569022, 8664.91335086641, 8704.042555318783, 8746.781330466789, 8864.556772161237, 9048.954755226181, 9059.139381758723, 9089.0, 6453.225612926291, 7140.8214794628475, 7272.163701174432, 7319.670614822452, 7470.178280389261, 7552.735654252075, 7555.886661700189, 7582.886256706043, 7633.618319084135, 7640.930269762127, 6625.933740662532, 6966.651667416508, 7011.649417529001, 7040.0, 7101.502894797522, 6730.4952128589575, 6801.455883529405, 6808.217055038734, 6826.556273842184, 6869.484788640772, 6113.694315284129, 6322.462590679844, 6351.333110023381, 6436.034594810629, 6445.871082578416, 4620.5148459411275, 4749.382580264543, 4810.086083644096, 4826.131296366688, 4852.660313778002, 4826.855194344175, 4860.902781944412, 4862.197737373293, 4874.098291816025, 4909.1899836528], "value": 4213.480482227122, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.6755336683016, 299.2085932707989, 300.0398724082935, 303.9376927729815, 306.72854523746486, 5061.4938506149365, 5100.209467532529, 5110.4123025851995, 5128.948710512894, 5133.153029750087, 5007.824726134586, 5021.297018417425, 5026.486756621689, 5048.772805223764, 5055.873603159923, 3682.6869716074166, 3787.9431808522895, 3894.201688653833, 3894.3184942635066, 3915.177812659345, 3878.728489005771, 3887.300285948528, 3905.33609286422, 3908.7263891527464, 3923.6272554107313, 3871.9672172109586, 3879.12719638082, 3905.4532365468717, 3908.553835081024, 3920.0, 3841.8655347063, 3876.0697432616253, 3906.628870257335, 3912.5500567434683, 3915.275674000319, 3456.3432947740102, 3475.4439289713523, 3478.2521757821937, 3487.738419618539, 3493.6331685172945, 4739.9526004739855, 4791.832285870013, 4793.952060479385, 4807.134715751164, 4831.589314908237, 4400.811780819161, 4495.820167193308, 4505.053938672882, 4531.048479819242, 4536.659750518725, 5189.820275484306, 5195.740212989335, 5203.349581302337, 5208.0, 5225.2162175673575, 3761.887143385703, 3806.467094606757, 3811.4663947047434, 3828.406596977473, 3835.520559930009, 5469.15228139639, 5487.42382049883, 5496.587755918322, 5500.257465242181, 5504.339479262514, 3568.946465803015, 3737.7757334560015, 3739.7569158004644, 3749.9625003750157, 3768.171002379472, 3773.5660399053913, 3775.1505911170316, 3803.486529318562, 3803.505544279226, 3804.391297392404, 4361.124716371927, 4372.0, 4379.474463064389, 4391.780410979438, 4439.446193832133, 5097.8725531862, 5272.261883336336, 5283.313169287968, 5285.788568457218, 5332.68003919766, 1277.2272774971195, 1285.3573213393304, 1289.6711338608595, 1294.2816736711027, 1296.6434230586665, 817.3747083481142, 860.423516244118, 873.8645509945968, 894.4677916639589, 895.5790778334173, 4507.4365704286965, 4600.171969045537, 4628.791704373311, 4630.4443466784205, 4646.97676511622, 5403.43300442875, 5452.40023597404, 5466.508014278734, 5477.972610136924, 5492.725363731797, 4387.517373088957, 4567.3377360282575, 4594.701344412602, 4621.560951709582, 4661.766911654404, 2759.0962236057057, 2804.7982333867817, 2824.742989369711, 2825.293676580855, 2832.6175966244705, 4907.312976183337, 4932.8520144395725, 4940.90118197634, 4958.702477851269, 4973.850784476472, 5225.921611175835, 5324.600654950894, 5391.649542779707, 5405.4324295949145, 5627.606067575231, 5102.642815002914, 5107.157319042391, 5128.333316668809, 5128.461511541234, 5140.485951404829, 5454.481824226851, 5455.236266922713, 5476.507114359727, 5498.3127109111365, 5502.147167189092, 5247.107991641354, 5284.682919024871, 5332.466753324637, 5377.489138531833, 5388.919166212431, 5107.284980102863, 5107.361579802525, 5123.538881500683, 5143.691378517301, 5158.632962264927, 3789.1663833956486, 3811.7141214409585, 3813.447050177653, 3840.9039774005873, 3848.5574158972076, 5272.261883336259, 5392.379876314274, 5423.349198096096, 5432.402435732145, 5509.449055094618, 5219.8434046978655, 5221.738913054408, 5236.816711415235, 5254.633795213195, 5265.210218467108, 5288.65623734456, 5293.311869456946, 5294.947050529599, 5314.5216930476445, 5321.680699158062, 4982.98529389714, 5165.173572228426, 5193.143131383431, 5207.713575753219, 5228.555572776357, 5083.644144909968, 5110.131277682728, 5287.365516138088, 5308.442613525524, 5317.43135774955, 5171.896562068813, 5176.482351764794, 5179.585633149414, 5188.922166167586, 5192.714400707846], "value": 3940.527368754167, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.2901401696423, 798.3453568074178, 803.5781214862196, 806.5402720449346, 807.7213361390318, 12834.550790722327, 13116.081874268804, 13190.670233244162, 13205.405756740945, 13267.668308292297, 14019.92990035051, 14047.086939348936, 14134.081284716487, 14138.858611413883, 14139.717205655881, 695.3672158335916, 879.2614204068581, 881.925036371906, 885.2563846369048, 891.0421297105605, 872.2237208884098, 904.7466709321401, 904.7873749668822, 906.2251774732574, 906.2613969614775, 916.2852974679727, 916.8349697054527, 919.1773362840254, 920.742192186189, 921.1617428140394, 913.6391125505454, 918.2241006349624, 919.2737737187614, 921.1111277617098, 924.4545718026363, 676.1480534526532, 681.3152781454656, 681.6932380428827, 681.7307163670372, 682.1847891769338, 12970.351482425842, 13037.152585082034, 13046.804297935538, 13065.804012939814, 13078.346082695922, 12769.425375858016, 12782.808257876139, 12888.54890078852, 12938.0, 13166.473341066347, 9903.80192396148, 9997.950010249975, 10049.598016079348, 10070.04334588213, 10129.949350253275, 3327.7504187185814, 3330.333933213367, 3384.76306658534, 3427.3145370925913, 3494.0, 45800.312995305096, 46060.53939460596, 46272.30591541129, 46300.3054954176, 46711.0, 10177.592896284214, 10318.071373576415, 10319.587216511405, 10544.420056896792, 10598.364098154136, 18260.360887369145, 18405.81594184068, 18407.447776566725, 18454.0, 18630.0, 6907.412869906014, 6918.342757438136, 7040.3663670269925, 7043.894341584881, 7129.394001509826, 3825.6556909878245, 3860.1121741999495, 3864.9033774155873, 3888.902777430587, 3897.512810898638, 2769.556870900646, 2830.5188118019987, 2850.458412901542, 2854.0, 2856.300206449433, 502.13632552010483, 507.85272271041725, 508.3493128795148, 510.8722819295176, 513.5942605341738, 607.5170239659482, 640.5260107520402, 644.3105876711874, 646.1470858466779, 658.4600627485416, 6663.86672266552, 6979.336962988508, 7070.328318809808, 7323.2676732326345, 7360.705571777176, 526.9973650131725, 529.5022678682027, 538.2222688215569, 615.2801222569605, 630.9936900630935, 3820.8853734388013, 3825.540935087807, 3899.122697393064, 3948.723589348718, 3998.632776701718, 51618.741906290226, 53725.462745372824, 53771.731141344826, 53921.730391347795, 53959.73020134953, 46814.76592617015, 47454.5254547457, 47968.520314796406, 48509.0, 49168.26247606217, 42978.355324670156, 44345.334819977084, 44435.777821110685, 44764.0, 45079.32381014287, 7568.583727894798, 7660.923390766021, 7771.72798952034, 7932.960335198518, 7944.6822127114265, 27618.309542261602, 29314.560281595368, 29857.85071074631, 30331.0, 30541.847290763402, 35041.824790875886, 38678.80660596679, 38738.6126138735, 39563.406548901214, 39934.60065399309, 10734.055833801756, 10802.297850639683, 10886.945565272123, 11151.776964460827, 11204.271722338022, 11542.249753765978, 11823.408829558315, 11870.406479675808, 12071.101293972108, 12230.266184028987, 10939.0, 11066.28069175501, 11102.666919992413, 11107.500162492546, 11529.884701152881, 10808.661245103529, 10982.505787239754, 11023.393713345522, 11058.0, 11091.223614346918, 10898.836517452086, 10927.672169834917, 11011.339319640847, 11263.155263355116, 11264.211505194886, 8088.859588664771, 8205.753827385188, 8332.541710205754, 8343.499390036617, 9583.952080239555, 8249.257566819015, 8278.30954939635, 8317.542535160625, 8399.622017009371, 8561.871571926302], "value": 6076.589926596353, "unit": "score"}], "name": "dromaeo_css", "value": 6374.215945968398, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 107.0, 115.0, 119.0, 116.0, 111.0, 114.0, 115.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 135.0, 154.0, 201.0, 135.0, 156.0, 156.0, 135.0, 189.0, 141.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 174.0, 162.0, 163.0, 163.0, 164.0, 162.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 157.0, 78.0, 76.0, 76.0, 77.0, 169.0, 78.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 138.0, 93.0, 95.0, 93.0, 148.0, 93.0, 93.0, 146.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 90.0, 65.0, 66.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 67.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 83.0, 91.0, 83.0, 85.0, 84.0, 84.0, 84.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 143.0, 131.0, 136.0, 144.0, 152.0, 134.0, 136.0, 212.0, 138.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 183.0, 179.0, 180.0, 177.0, 175.0, 177.0, 174.0, 176.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 68.0, 68.0, 71.0, 68.0, 68.0, 68.0, 68.0, 68.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1606.6, "alertThreshold": 2.0}]} 14:56:21 INFO - Return code: 0 14:56:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:56:21 ERROR - # TBPL SUCCESS # 14:56:21 INFO - Running post-action listener: _resource_record_post_action 14:56:21 INFO - Running post-run listener: _resource_record_post_run 14:56:22 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 16384; Write bytes: 541425664; Read time: 396; Write time: 526516 14:56:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 234971136; Read time: 180; Write time: 265016 14:56:22 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 12288; Write bytes: 285360128; Read time: 216; Write time: 253468 14:56:22 INFO - Running post-run listener: _upload_blobber_files 14:56:22 INFO - Blob upload gear active. 14:56:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:56:22 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 14:56:22 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'] 14:56:22 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 14:56:22 INFO - (blobuploader) - INFO - Open directory for files ... 14:56:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:56:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:56:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:56:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:56:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:56:23 INFO - (blobuploader) - INFO - Done attempting. 14:56:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:56:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:56:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:56:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:56:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:56:24 INFO - (blobuploader) - INFO - Done attempting. 14:56:24 INFO - (blobuploader) - INFO - Iteration through files over. 14:56:24 INFO - Return code: 0 14:56:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:56:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:56:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4bce63600dc0b5ea2636fc7bedc53e746f4354f73ae21c2b852a3f0667eba4059b31af097f121347abde7578f70ec3787026a1d7e695dd578483ef4641ac2e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/582c76bfca2155acd879a9cd4d8d61b876e26c273d22bcbdbf5d4ed844885ab16d13afbf351440b0be2f7e76823963e3813c2c83af823026eaf56155ae913022"} 14:56:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:56:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:56:24 INFO - Contents: 14:56:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4bce63600dc0b5ea2636fc7bedc53e746f4354f73ae21c2b852a3f0667eba4059b31af097f121347abde7578f70ec3787026a1d7e695dd578483ef4641ac2e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/582c76bfca2155acd879a9cd4d8d61b876e26c273d22bcbdbf5d4ed844885ab16d13afbf351440b0be2f7e76823963e3813c2c83af823026eaf56155ae913022"} 14:56:24 INFO - Running post-run listener: copy_logs_to_upload_dir 14:56:24 INFO - Copying logs to upload dir... 14:56:24 INFO - mkdir: /builds/slave/test/build/upload/logs 14:56:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.897043 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-05 14:56:24.315510) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 14:56:24.319126) ========= 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=523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770 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/c4bce63600dc0b5ea2636fc7bedc53e746f4354f73ae21c2b852a3f0667eba4059b31af097f121347abde7578f70ec3787026a1d7e695dd578483ef4641ac2e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/582c76bfca2155acd879a9cd4d8d61b876e26c273d22bcbdbf5d4ed844885ab16d13afbf351440b0be2f7e76823963e3813c2c83af823026eaf56155ae913022"} build_url:https://queue.taskcluster.net/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011513 build_url: 'https://queue.taskcluster.net/v1/task/K_cK5eGsTw6ygkczFSFoyQ/artifacts/public/build/firefox-49.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/c4bce63600dc0b5ea2636fc7bedc53e746f4354f73ae21c2b852a3f0667eba4059b31af097f121347abde7578f70ec3787026a1d7e695dd578483ef4641ac2e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/582c76bfca2155acd879a9cd4d8d61b876e26c273d22bcbdbf5d4ed844885ab16d13afbf351440b0be2f7e76823963e3813c2c83af823026eaf56155ae913022"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 14:56:24.343766) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:56:24.344129) ========= 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=523ca41ca1e0623de333ad52000001bf-1462484147.691066-766964770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:56:24.429069) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 14:56:24.429436) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 14:56:24.429815) ========= ========= Total master_lag: 0.16 =========