builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1461310395.91 results: success (0) buildid: 20160421213436 builduid: d51fcc4d6766495787e83b4e61ba58c5 revision: 2271b0c11307 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:15.911399) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:15.911839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:15.912134) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:15.954372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:15.954725) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 00:33:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-04-22 00:33:16 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107924 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:16.076738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:16.077089) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022118 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:16.127005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:16.127397) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2271b0c11307 --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 2271b0c11307 --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=a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 00:33:16,561 Setting DEBUG logging. 2016-04-22 00:33:16,562 attempt 1/10 2016-04-22 00:33:16,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2271b0c11307?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 00:33:16,817 unpacking tar archive at: fx-team-2271b0c11307/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521416 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:16.662512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:16.663009) ========= script_repo_revision: 2271b0c11307 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:16.663494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:16.663774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 00:33:16.674990) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-22 00:33:16.675423) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:33:17 INFO - MultiFileLogger online at 20160422 00:33:17 in /builds/slave/test 00:33:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:33:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:33:17 INFO - {'append_to_log': False, 00:33:17 INFO - 'base_work_dir': '/builds/slave/test', 00:33:17 INFO - 'blob_upload_branch': 'Fx-Team', 00:33:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:33:17 INFO - 'branch': 'Fx-Team', 00:33:17 INFO - 'buildbot_json_path': 'buildprops.json', 00:33:17 INFO - 'config_files': ('talos/linux_config.py',), 00:33:17 INFO - 'default_actions': ('clobber', 00:33:17 INFO - 'read-buildbot-config', 00:33:17 INFO - 'download-and-extract', 00:33:17 INFO - 'populate-webroot', 00:33:17 INFO - 'create-virtualenv', 00:33:17 INFO - 'install', 00:33:17 INFO - 'run-tests'), 00:33:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:33:17 INFO - 'download_minidump_stackwalk': True, 00:33:17 INFO - 'download_symbols': 'ondemand', 00:33:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:33:17 INFO - 'tooltool.py': '/tools/tooltool.py', 00:33:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:33:17 INFO - '/tools/misc-python/virtualenv.py')}, 00:33:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:33:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:33:17 INFO - 'installer_path': 'installer.exe', 00:33:17 INFO - 'log_level': 'info', 00:33:17 INFO - 'log_name': 'talos', 00:33:17 INFO - 'log_to_console': True, 00:33:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:33:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:33:17 INFO - 'opt_config_files': (), 00:33:17 INFO - 'pip_index': False, 00:33:17 INFO - 'sps_profile': False, 00:33:17 INFO - 'sps_profile_interval': 0, 00:33:17 INFO - 'suite': 'dromaeojs-e10s', 00:33:17 INFO - 'system_bits': '32', 00:33:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:33:17 INFO - 'title': 'talos-linux64-ix-062', 00:33:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:33:17 INFO - 'use_talos_json': True, 00:33:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:33:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:33:17 INFO - 'work_dir': 'build'} 00:33:17 INFO - ##### 00:33:17 INFO - ##### Running clobber step. 00:33:17 INFO - ##### 00:33:17 INFO - Running pre-action listener: _resource_record_pre_action 00:33:17 INFO - Running main action method: clobber 00:33:17 INFO - rmtree: /builds/slave/test/build 00:33:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:33:18 INFO - Running post-action listener: _resource_record_post_action 00:33:18 INFO - ##### 00:33:18 INFO - ##### Running read-buildbot-config step. 00:33:18 INFO - ##### 00:33:18 INFO - Running pre-action listener: _resource_record_pre_action 00:33:18 INFO - Running main action method: read_buildbot_config 00:33:18 INFO - Using buildbot properties: 00:33:18 INFO - { 00:33:18 INFO - "project": "", 00:33:18 INFO - "product": "firefox", 00:33:18 INFO - "script_repo_revision": "production", 00:33:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:33:18 INFO - "repository": "", 00:33:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 00:33:18 INFO - "buildid": "20160421213436", 00:33:18 INFO - "pgo_build": "True", 00:33:18 INFO - "basedir": "/builds/slave/test", 00:33:18 INFO - "buildnumber": 402, 00:33:18 INFO - "slavename": "talos-linux64-ix-062", 00:33:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:33:18 INFO - "platform": "ubuntu64_hw", 00:33:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:33:18 INFO - "branch": "fx-team", 00:33:18 INFO - "repo_path": "integration/fx-team", 00:33:18 INFO - "revision": "2271b0c11307 ", 00:33:18 INFO - "stage_platform": "linux64-pgo", 00:33:18 INFO - "builduid": "d51fcc4d6766495787e83b4e61ba58c5", 00:33:18 INFO - "slavebuilddir": "test" 00:33:18 INFO - } 00:33:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 00:33:18 INFO - Running post-action listener: _resource_record_post_action 00:33:18 INFO - ##### 00:33:18 INFO - ##### Running download-and-extract step. 00:33:18 INFO - ##### 00:33:18 INFO - Running pre-action listener: _resource_record_pre_action 00:33:18 INFO - Running main action method: download_and_extract 00:33:18 INFO - mkdir: /builds/slave/test/build/tests 00:33: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')]} 00:33:18 INFO - https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:33:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:33:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:33:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:33:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:33:20 INFO - Downloaded 1361 bytes. 00:33:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:33:20 INFO - Using the following test package requirements: 00:33:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:33:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:33:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:33:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:20 INFO - u'jsshell-linux-x86_64.zip'], 00:33:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:33:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:33:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:33:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:33:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:33:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:33:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:33:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:33: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')]} 00:33:20 INFO - https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:33:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:33:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:33:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:33:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:33:29 INFO - Downloaded 23853676 bytes. 00:33:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:33:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:33:30 INFO - Return code: 0 00:33:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:33:30 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')]} 00:33:30 INFO - https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:33:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:33:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:33:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:33:35 INFO - Downloaded 23853676 bytes. 00:33:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:33:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:33:36 INFO - Return code: 0 00:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:36 INFO - https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:33:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:33:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:33:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:33:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:33:38 INFO - Downloaded 10845952 bytes. 00:33:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:33:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:33:38 INFO - Return code: 0 00:33:38 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')]} 00:33:38 INFO - https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:33:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:33:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:33:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:33:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:33:39 INFO - Downloaded 58337339 bytes. 00:33:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:33:39 INFO - mkdir: /builds/slave/test/properties 00:33:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:33:39 INFO - Writing to file /builds/slave/test/properties/build_url 00:33:39 INFO - Contents: 00:33:39 INFO - build_url:https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:33:40 INFO - Running post-action listener: _resource_record_post_action 00:33:40 INFO - Running post-action listener: set_extra_try_arguments 00:33:40 INFO - ##### 00:33:40 INFO - ##### Running populate-webroot step. 00:33:40 INFO - ##### 00:33:40 INFO - Running pre-action listener: _resource_record_pre_action 00:33:40 INFO - Running main action method: populate_webroot 00:33:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:33:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:33:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:33:40 INFO - '--tppagecycles', 00:33:40 INFO - '7'], 00:33:40 INFO - 'tests': ['tsvgm']}}, 00:33:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:33:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:33:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:33:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:33:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:33:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:33:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:40 INFO - 'talos_options': ['--disable-e10s'], 00:33:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:33:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:33:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:40 INFO - 'talos_options': ['--disable-e10s'], 00:33:40 INFO - 'tests': ['damp', 'tps']}, 00:33:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:40 INFO - 'tests': ['damp', 'tps']}, 00:33:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:33:40 INFO - 'tests': ['dromaeo_dom']}, 00:33:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:33:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:33:40 INFO - 'tests': ['a11yr', 00:33:40 INFO - 'ts_paint', 00:33:40 INFO - 'tpaint', 00:33:40 INFO - 'sessionrestore', 00:33:40 INFO - 'sessionrestore_no_auto_restore', 00:33:40 INFO - 'tabpaint']}, 00:33:40 INFO - 'other-e10s': {'tests': ['a11yr', 00:33:40 INFO - 'ts_paint', 00:33:40 INFO - 'tpaint', 00:33:40 INFO - 'sessionrestore', 00:33:40 INFO - 'sessionrestore_no_auto_restore', 00:33:40 INFO - 'tabpaint']}, 00:33:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:33:40 INFO - 'ts_paint', 00:33:40 INFO - 'tpaint', 00:33:40 INFO - 'sessionrestore', 00:33:40 INFO - 'sessionrestore_no_auto_restore', 00:33:40 INFO - 'tabpaint']}, 00:33:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:33:40 INFO - 'ts_paint', 00:33:40 INFO - 'tpaint', 00:33:40 INFO - 'sessionrestore', 00:33:40 INFO - 'sessionrestore_no_auto_restore', 00:33:40 INFO - 'tabpaint']}, 00:33:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:33:40 INFO - 'tests': ['a11yr', 00:33:40 INFO - 'ts_paint', 00:33:40 INFO - 'tpaint', 00:33:40 INFO - 'sessionrestore', 00:33:40 INFO - 'sessionrestore_no_auto_restore', 00:33:40 INFO - 'tabpaint']}, 00:33:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:33:40 INFO - 'tests': ['a11yr', 00:33:40 INFO - 'ts_paint', 00:33:40 INFO - 'tpaint', 00:33:40 INFO - 'sessionrestore', 00:33:40 INFO - 'sessionrestore_no_auto_restore', 00:33:40 INFO - 'tabpaint']}, 00:33:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:33:40 INFO - 'tests': ['tsvgx', 00:33:40 INFO - 'tsvgr_opacity', 00:33:40 INFO - 'tart', 00:33:40 INFO - 'tscrollx', 00:33:40 INFO - 'cart']}, 00:33:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:33:40 INFO - 'tsvgr_opacity', 00:33:40 INFO - 'tart', 00:33:40 INFO - 'tscrollx', 00:33:40 INFO - 'cart']}, 00:33:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:40 INFO - 'talos_options': ['--disable-e10s'], 00:33:40 INFO - 'tests': ['tp5o']}, 00:33:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:40 INFO - 'tests': ['tp5o']}, 00:33:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:40 INFO - 'talos_options': ['--disable-e10s', 00:33:40 INFO - '--xperf_path', 00:33:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:33:40 INFO - 'tests': ['tp5n']}, 00:33:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:33:40 INFO - 'talos_options': ['--xperf_path', 00:33:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:33:40 INFO - 'tests': ['tp5n']}}, 00:33:40 INFO - 'talos.zip': {'path': '', 00:33:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:33:40 INFO - Running post-action listener: _resource_record_post_action 00:33:40 INFO - ##### 00:33:40 INFO - ##### Running create-virtualenv step. 00:33:40 INFO - ##### 00:33:40 INFO - Running pre-action listener: _resource_record_pre_action 00:33:40 INFO - Running main action method: create_virtualenv 00:33:40 INFO - Creating virtualenv /builds/slave/test/build/venv 00:33:40 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 00:33:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:33:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:33:40 INFO - Using real prefix '/usr' 00:33:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:33:41 INFO - Installing distribute.............................................................................................................................................................................................done. 00:33:43 INFO - Installing pip.................done. 00:33:43 INFO - Return code: 0 00:33:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:33:43 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')]} 00:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:43 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')]} 00:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:43 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 0x7f70ba353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca410>, '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 0x21cb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', '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 00:33:43 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 00:33:43 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 00:33:43 INFO - Using env: {'DISPLAY': ':0', 00:33:43 INFO - 'HOME': '/home/cltbld', 00:33:43 INFO - 'LANG': 'en_US.UTF-8', 00:33:43 INFO - 'LANGUAGE': 'en_US:en', 00:33:43 INFO - 'LOGNAME': 'cltbld', 00:33:43 INFO - 'MAIL': '/var/mail/cltbld', 00:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:43 INFO - 'MOZ_NO_REMOTE': '1', 00:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:43 INFO - 'NO_EM_RESTART': '1', 00:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:43 INFO - 'PWD': '/builds/slave/test', 00:33:43 INFO - 'SHELL': '/bin/bash', 00:33:43 INFO - 'SHLVL': '1', 00:33:43 INFO - 'TERM': 'linux', 00:33:43 INFO - 'TMOUT': '86400', 00:33:43 INFO - 'USER': 'cltbld', 00:33:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', 00:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:43 INFO - '_': '/tools/buildbot/bin/python'} 00:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:43 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 00:33:43 INFO - Cleaning up... 00:33:43 INFO - Return code: 0 00:33:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:33:43 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')]} 00:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:43 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')]} 00:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:43 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 0x7f70ba353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca410>, '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 0x21cb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', '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 00:33:43 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 00:33:43 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 00:33:43 INFO - Using env: {'DISPLAY': ':0', 00:33:43 INFO - 'HOME': '/home/cltbld', 00:33:43 INFO - 'LANG': 'en_US.UTF-8', 00:33:43 INFO - 'LANGUAGE': 'en_US:en', 00:33:43 INFO - 'LOGNAME': 'cltbld', 00:33:43 INFO - 'MAIL': '/var/mail/cltbld', 00:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:43 INFO - 'MOZ_NO_REMOTE': '1', 00:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:43 INFO - 'NO_EM_RESTART': '1', 00:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:43 INFO - 'PWD': '/builds/slave/test', 00:33:43 INFO - 'SHELL': '/bin/bash', 00:33:43 INFO - 'SHLVL': '1', 00:33:43 INFO - 'TERM': 'linux', 00:33:43 INFO - 'TMOUT': '86400', 00:33:43 INFO - 'USER': 'cltbld', 00:33:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', 00:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:43 INFO - '_': '/tools/buildbot/bin/python'} 00:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:43 INFO - Downloading/unpacking psutil>=0.7.1 00:33:43 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 00:33:43 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 00:33:43 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 00:33:43 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 00:33:43 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 00:33:43 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 00:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:33:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:33:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:33:45 INFO - Installing collected packages: psutil 00:33:45 INFO - Running setup.py install for psutil 00:33:45 INFO - building 'psutil._psutil_linux' extension 00:33:45 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 00:33:45 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 00:33:45 INFO - building 'psutil._psutil_posix' extension 00:33:45 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 00:33:46 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 00:33:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:33:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:33:46 INFO - Successfully installed psutil 00:33:46 INFO - Cleaning up... 00:33:46 INFO - Return code: 0 00:33:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:33:46 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')]} 00:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:46 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')]} 00:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:46 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 0x7f70ba353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca410>, '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 0x21cb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', '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 00:33:46 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 00:33:46 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 00:33:46 INFO - Using env: {'DISPLAY': ':0', 00:33:46 INFO - 'HOME': '/home/cltbld', 00:33:46 INFO - 'LANG': 'en_US.UTF-8', 00:33:46 INFO - 'LANGUAGE': 'en_US:en', 00:33:46 INFO - 'LOGNAME': 'cltbld', 00:33:46 INFO - 'MAIL': '/var/mail/cltbld', 00:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:46 INFO - 'MOZ_NO_REMOTE': '1', 00:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:46 INFO - 'NO_EM_RESTART': '1', 00:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:46 INFO - 'PWD': '/builds/slave/test', 00:33:46 INFO - 'SHELL': '/bin/bash', 00:33:46 INFO - 'SHLVL': '1', 00:33:46 INFO - 'TERM': 'linux', 00:33:46 INFO - 'TMOUT': '86400', 00:33:46 INFO - 'USER': 'cltbld', 00:33:46 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', 00:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:46 INFO - '_': '/tools/buildbot/bin/python'} 00:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:33:46 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 00:33:46 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 00:33:46 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 00:33:46 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 00:33:46 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 00:33:46 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 00:33:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:33:48 INFO - Installing collected packages: mozsystemmonitor 00:33:48 INFO - Running setup.py install for mozsystemmonitor 00:33:48 INFO - Successfully installed mozsystemmonitor 00:33:48 INFO - Cleaning up... 00:33:48 INFO - Return code: 0 00:33:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f70ba353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca410>, '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 0x21cb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', '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 00:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:33:48 INFO - Using env: {'DISPLAY': ':0', 00:33:48 INFO - 'HOME': '/home/cltbld', 00:33:48 INFO - 'LANG': 'en_US.UTF-8', 00:33:48 INFO - 'LANGUAGE': 'en_US:en', 00:33:48 INFO - 'LOGNAME': 'cltbld', 00:33:48 INFO - 'MAIL': '/var/mail/cltbld', 00:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:48 INFO - 'MOZ_NO_REMOTE': '1', 00:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:48 INFO - 'NO_EM_RESTART': '1', 00:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:48 INFO - 'PWD': '/builds/slave/test', 00:33:48 INFO - 'SHELL': '/bin/bash', 00:33:48 INFO - 'SHLVL': '1', 00:33:48 INFO - 'TERM': 'linux', 00:33:48 INFO - 'TMOUT': '86400', 00:33:48 INFO - 'USER': 'cltbld', 00:33:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', 00:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:48 INFO - '_': '/tools/buildbot/bin/python'} 00:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:48 INFO - Downloading/unpacking blobuploader==1.2.4 00:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:50 INFO - Downloading blobuploader-1.2.4.tar.gz 00:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:33:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:33:50 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 00:33:50 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 00:33:50 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 00:33:50 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 00:33:50 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 00:33:50 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 00:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:33:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:33:51 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 00:33:51 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 00:33:51 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 00:33:51 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 00:33:51 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 00:33:51 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 00:33:51 INFO - Downloading docopt-0.6.1.tar.gz 00:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:33:51 INFO - Installing collected packages: blobuploader, requests, docopt 00:33:51 INFO - Running setup.py install for blobuploader 00:33:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:33:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:33:51 INFO - Running setup.py install for requests 00:33:51 INFO - Running setup.py install for docopt 00:33:51 INFO - Successfully installed blobuploader requests docopt 00:33:51 INFO - Cleaning up... 00:33:51 INFO - Return code: 0 00:33:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:33: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')]} 00:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33: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')]} 00:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:51 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 0x7f70ba353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca410>, '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 0x21cb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', '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 00:33:51 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 00:33:51 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 00:33:51 INFO - Using env: {'DISPLAY': ':0', 00:33:51 INFO - 'HOME': '/home/cltbld', 00:33:51 INFO - 'LANG': 'en_US.UTF-8', 00:33:51 INFO - 'LANGUAGE': 'en_US:en', 00:33:51 INFO - 'LOGNAME': 'cltbld', 00:33:51 INFO - 'MAIL': '/var/mail/cltbld', 00:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:51 INFO - 'MOZ_NO_REMOTE': '1', 00:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:51 INFO - 'NO_EM_RESTART': '1', 00:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:51 INFO - 'PWD': '/builds/slave/test', 00:33:51 INFO - 'SHELL': '/bin/bash', 00:33:51 INFO - 'SHLVL': '1', 00:33:51 INFO - 'TERM': 'linux', 00:33:51 INFO - 'TMOUT': '86400', 00:33:51 INFO - 'USER': 'cltbld', 00:33:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', 00:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:51 INFO - '_': '/tools/buildbot/bin/python'} 00:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:33:52 INFO - Running setup.py (path:/tmp/pip-skqgK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:33:52 INFO - Running setup.py (path:/tmp/pip-rn5Kbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:33:52 INFO - Running setup.py (path:/tmp/pip-mjjPnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:33:52 INFO - Running setup.py (path:/tmp/pip-nm_Y_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:33:52 INFO - Running setup.py (path:/tmp/pip-OpHOFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:33:52 INFO - Running setup.py (path:/tmp/pip-ovwKLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:33:52 INFO - Running setup.py (path:/tmp/pip-T0b00z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:33:52 INFO - Running setup.py (path:/tmp/pip-SryvjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:33:52 INFO - Running setup.py (path:/tmp/pip-WbDdXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:33:52 INFO - Running setup.py (path:/tmp/pip-CLuKzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:33:52 INFO - Running setup.py (path:/tmp/pip-KM7IWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:33:53 INFO - Running setup.py (path:/tmp/pip-KcgWYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:33:53 INFO - Running setup.py (path:/tmp/pip-8nfTXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:33:53 INFO - Running setup.py (path:/tmp/pip-z_OeeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:33:53 INFO - Running setup.py (path:/tmp/pip-xlFiXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:33:53 INFO - Running setup.py (path:/tmp/pip-XfFiv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:33:53 INFO - Running setup.py (path:/tmp/pip-ODoApF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:33:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:33:53 INFO - Running setup.py install for manifestparser 00:33:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:33:53 INFO - Running setup.py install for mozcrash 00:33:53 INFO - Running setup.py install for mozdebug 00:33:53 INFO - Running setup.py install for mozdevice 00:33:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:33:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:33:53 INFO - Running setup.py install for mozfile 00:33:53 INFO - Running setup.py install for mozhttpd 00:33:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Running setup.py install for mozinfo 00:33:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Running setup.py install for mozInstall 00:33:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Running setup.py install for mozleak 00:33:54 INFO - Running setup.py install for mozlog 00:33:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Running setup.py install for moznetwork 00:33:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Running setup.py install for mozprocess 00:33:54 INFO - Running setup.py install for mozprofile 00:33:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Running setup.py install for mozrunner 00:33:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:33:54 INFO - Running setup.py install for mozscreenshot 00:33:55 INFO - Running setup.py install for moztest 00:33:55 INFO - Running setup.py install for mozversion 00:33:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:33:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:33:55 INFO - Cleaning up... 00:33:55 INFO - Return code: 0 00:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:33:55 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')]} 00:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:55 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')]} 00:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:55 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 0x7f70ba353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca410>, '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 0x21cb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', '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 00:33:55 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 00:33:55 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 00:33:55 INFO - Using env: {'DISPLAY': ':0', 00:33:55 INFO - 'HOME': '/home/cltbld', 00:33:55 INFO - 'LANG': 'en_US.UTF-8', 00:33:55 INFO - 'LANGUAGE': 'en_US:en', 00:33:55 INFO - 'LOGNAME': 'cltbld', 00:33:55 INFO - 'MAIL': '/var/mail/cltbld', 00:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:55 INFO - 'MOZ_NO_REMOTE': '1', 00:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:55 INFO - 'NO_EM_RESTART': '1', 00:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:55 INFO - 'PWD': '/builds/slave/test', 00:33:55 INFO - 'SHELL': '/bin/bash', 00:33:55 INFO - 'SHLVL': '1', 00:33:55 INFO - 'TERM': 'linux', 00:33:55 INFO - 'TMOUT': '86400', 00:33:55 INFO - 'USER': 'cltbld', 00:33:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', 00:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:55 INFO - '_': '/tools/buildbot/bin/python'} 00:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:33:55 INFO - Running setup.py (path:/tmp/pip-oQcShX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:33:55 INFO - Running setup.py (path:/tmp/pip-_r_WD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:33:55 INFO - Running setup.py (path:/tmp/pip-D6h7gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:33:55 INFO - Running setup.py (path:/tmp/pip-is6_fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:33:55 INFO - Running setup.py (path:/tmp/pip-OHYPbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:33:55 INFO - Running setup.py (path:/tmp/pip-RUd8mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:33:55 INFO - Running setup.py (path:/tmp/pip-sIfYRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:33:55 INFO - Running setup.py (path:/tmp/pip-YOKW5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:33:56 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)) 00:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:33:56 INFO - Running setup.py (path:/tmp/pip-5jbK5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:33:56 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)) 00:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:33:56 INFO - Running setup.py (path:/tmp/pip-ZEHvHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:33:56 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)) 00:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:33:56 INFO - Running setup.py (path:/tmp/pip-CLRICu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:33:56 INFO - Running setup.py (path:/tmp/pip-38QD9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:33:56 INFO - Running setup.py (path:/tmp/pip-NCNfgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:33:56 INFO - Running setup.py (path:/tmp/pip-A3bLjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:33:56 INFO - Running setup.py (path:/tmp/pip-ORkLYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:33:56 INFO - Running setup.py (path:/tmp/pip-cHZ3ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:33:56 INFO - Running setup.py (path:/tmp/pip-SA6eQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:33:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:58 INFO - Downloading blessings-1.6.tar.gz 00:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:33:58 INFO - Installing collected packages: blessings 00:33:58 INFO - Running setup.py install for blessings 00:33:58 INFO - Successfully installed blessings 00:33:58 INFO - Cleaning up... 00:33:58 INFO - Return code: 0 00:33:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:33:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:33:59 INFO - Reading from file tmpfile_stdout 00:33:59 INFO - Current package versions: 00:33:59 INFO - argparse == 1.2.1 00:33:59 INFO - blessings == 1.6 00:33:59 INFO - blobuploader == 1.2.4 00:33:59 INFO - docopt == 0.6.1 00:33:59 INFO - manifestparser == 1.1 00:33:59 INFO - mozInstall == 1.12 00:33:59 INFO - mozcrash == 0.17 00:33:59 INFO - mozdebug == 0.1 00:33:59 INFO - mozdevice == 0.48 00:33:59 INFO - mozfile == 1.2 00:33:59 INFO - mozhttpd == 0.7 00:33:59 INFO - mozinfo == 0.9 00:33:59 INFO - mozleak == 0.1 00:33:59 INFO - mozlog == 3.1 00:33:59 INFO - moznetwork == 0.27 00:33:59 INFO - mozprocess == 0.22 00:33:59 INFO - mozprofile == 0.28 00:33:59 INFO - mozrunner == 6.11 00:33:59 INFO - mozscreenshot == 0.1 00:33:59 INFO - mozsystemmonitor == 0.0 00:33:59 INFO - moztest == 0.7 00:33:59 INFO - mozversion == 1.4 00:33:59 INFO - psutil == 3.1.1 00:33:59 INFO - requests == 1.2.3 00:33:59 INFO - wsgiref == 0.1.2 00:33:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70ba353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca410>, '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 0x21cb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', '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 00:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:33:59 INFO - Using env: {'DISPLAY': ':0', 00:33:59 INFO - 'HOME': '/home/cltbld', 00:33:59 INFO - 'LANG': 'en_US.UTF-8', 00:33:59 INFO - 'LANGUAGE': 'en_US:en', 00:33:59 INFO - 'LOGNAME': 'cltbld', 00:33:59 INFO - 'MAIL': '/var/mail/cltbld', 00:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:59 INFO - 'MOZ_NO_REMOTE': '1', 00:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:59 INFO - 'NO_EM_RESTART': '1', 00:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:59 INFO - 'PWD': '/builds/slave/test', 00:33:59 INFO - 'SHELL': '/bin/bash', 00:33:59 INFO - 'SHLVL': '1', 00:33:59 INFO - 'TERM': 'linux', 00:33:59 INFO - 'TMOUT': '86400', 00:33:59 INFO - 'USER': 'cltbld', 00:33:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', 00:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:59 INFO - '_': '/tools/buildbot/bin/python'} 00:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:33:59 INFO - Cleaning up... 00:33:59 INFO - Return code: 0 00:33:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:33:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70ba353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca410>, '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 0x21cb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', '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 00:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:33:59 INFO - Using env: {'DISPLAY': ':0', 00:33:59 INFO - 'HOME': '/home/cltbld', 00:33:59 INFO - 'LANG': 'en_US.UTF-8', 00:33:59 INFO - 'LANGUAGE': 'en_US:en', 00:33:59 INFO - 'LOGNAME': 'cltbld', 00:33:59 INFO - 'MAIL': '/var/mail/cltbld', 00:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:33:59 INFO - 'MOZ_NO_REMOTE': '1', 00:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:33:59 INFO - 'NO_EM_RESTART': '1', 00:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:33:59 INFO - 'PWD': '/builds/slave/test', 00:33:59 INFO - 'SHELL': '/bin/bash', 00:33:59 INFO - 'SHLVL': '1', 00:33:59 INFO - 'TERM': 'linux', 00:33:59 INFO - 'TMOUT': '86400', 00:33:59 INFO - 'USER': 'cltbld', 00:33:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', 00:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:33:59 INFO - '_': '/tools/buildbot/bin/python'} 00:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:33:59 INFO - Downloading/unpacking jsonschema 00:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:33:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:33:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:34:01 INFO - Downloading/unpacking functools32 (from jsonschema) 00:34:01 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 00:34:01 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 00:34:01 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 00:34:01 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 00:34:01 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 00:34:01 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 00:34:01 INFO - Downloading functools32-3.2.3-2.tar.gz 00:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:34:01 INFO - warning: no files found matching '*.txt' 00:34:01 INFO - no previously-included directories found matching 'build' 00:34:01 INFO - no previously-included directories found matching 'dist' 00:34:01 INFO - no previously-included directories found matching '.git*' 00:34:01 INFO - Installing collected packages: jsonschema, functools32 00:34:01 INFO - Running setup.py install for functools32 00:34:01 INFO - warning: no files found matching '*.txt' 00:34:01 INFO - no previously-included directories found matching 'build' 00:34:01 INFO - no previously-included directories found matching 'dist' 00:34:01 INFO - no previously-included directories found matching '.git*' 00:34:01 INFO - Successfully installed jsonschema functools32 00:34:01 INFO - Cleaning up... 00:34:01 INFO - Return code: 0 00:34:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:01 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 0x7f70ba353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca410>, '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 0x21cb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb7a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', '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 00:34:01 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 00:34:01 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 00:34:01 INFO - Using env: {'DISPLAY': ':0', 00:34:01 INFO - 'HOME': '/home/cltbld', 00:34:01 INFO - 'LANG': 'en_US.UTF-8', 00:34:01 INFO - 'LANGUAGE': 'en_US:en', 00:34:01 INFO - 'LOGNAME': 'cltbld', 00:34:01 INFO - 'MAIL': '/var/mail/cltbld', 00:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:01 INFO - 'MOZ_NO_REMOTE': '1', 00:34:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:01 INFO - 'NO_EM_RESTART': '1', 00:34:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:01 INFO - 'PWD': '/builds/slave/test', 00:34:01 INFO - 'SHELL': '/bin/bash', 00:34:01 INFO - 'SHLVL': '1', 00:34:01 INFO - 'TERM': 'linux', 00:34:01 INFO - 'TMOUT': '86400', 00:34:01 INFO - 'USER': 'cltbld', 00:34:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', 00:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:01 INFO - '_': '/tools/buildbot/bin/python'} 00:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:02 INFO - Downloading/unpacking flake8 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:34:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:34:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:34:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:34:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:34:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:34:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:34:04 INFO - no previously-included directories found matching 'docs/_build' 00:34:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:34:04 INFO - Running setup.py install for pep8 00:34:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:34:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:34:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:34:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:34:04 INFO - no previously-included directories found matching 'docs/_build' 00:34:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:34:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:34:04 INFO - Cleaning up... 00:34:04 INFO - Return code: 0 00:34:04 INFO - Running post-action listener: _resource_record_post_action 00:34:04 INFO - Running post-action listener: _start_resource_monitoring 00:34:04 INFO - Starting resource monitoring. 00:34:04 INFO - ##### 00:34:04 INFO - ##### Running install step. 00:34:04 INFO - ##### 00:34:04 INFO - Running pre-action listener: _resource_record_pre_action 00:34:04 INFO - Running main action method: install 00:34:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:34:05 INFO - Reading from file tmpfile_stdout 00:34:05 INFO - Detecting whether we're running mozinstall >=1.0... 00:34:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:34:05 INFO - Reading from file tmpfile_stdout 00:34:05 INFO - Output received: 00:34:05 INFO - Usage: mozinstall [options] installer 00:34:05 INFO - Options: 00:34:05 INFO - -h, --help show this help message and exit 00:34:05 INFO - -d DEST, --destination=DEST 00:34:05 INFO - Directory to install application into. [default: 00:34:05 INFO - "/builds/slave/test"] 00:34:05 INFO - --app=APP Application being installed. [default: firefox] 00:34:05 INFO - mkdir: /builds/slave/test/build/application 00:34:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:34:21 INFO - Reading from file tmpfile_stdout 00:34:21 INFO - Output received: 00:34:21 INFO - /builds/slave/test/build/application/firefox/firefox 00:34:21 INFO - Running post-action listener: _resource_record_post_action 00:34:21 INFO - ##### 00:34:21 INFO - ##### Running run-tests step. 00:34:21 INFO - ##### 00:34:21 INFO - Running pre-action listener: _resource_record_pre_action 00:34:21 INFO - Running main action method: run_tests 00:34:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:34:21 INFO - Python 2.7.3 00:34:21 INFO - Return code: 0 00:34:21 INFO - grabbing minidump binary from tooltool 00:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:21 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 0x21ca410>, '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 0x21cb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:34:21 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 00:34:21 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 00:34:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:34:21 INFO - Return code: 0 00:34:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:34:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:34:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:34:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:34:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:34:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:34:22 INFO - Return code: 0 00:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 00:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 00:34:22 INFO - Using env: {'DISPLAY': ':0', 00:34:22 INFO - 'HOME': '/home/cltbld', 00:34:22 INFO - 'LANG': 'en_US.UTF-8', 00:34:22 INFO - 'LANGUAGE': 'en_US:en', 00:34:22 INFO - 'LOGNAME': 'cltbld', 00:34:22 INFO - 'MAIL': '/var/mail/cltbld', 00:34:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:34:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:22 INFO - 'MOZ_NO_REMOTE': '1', 00:34:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:22 INFO - 'NO_EM_RESTART': '1', 00:34:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:22 INFO - 'PWD': '/builds/slave/test', 00:34:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:34:22 INFO - 'SHELL': '/bin/bash', 00:34:22 INFO - 'SHLVL': '1', 00:34:22 INFO - 'TERM': 'linux', 00:34:22 INFO - 'TMOUT': '86400', 00:34:22 INFO - 'USER': 'cltbld', 00:34:22 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978', 00:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:22 INFO - '_': '/tools/buildbot/bin/python'} 00:34:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 00:34:23 INFO - mozversion application_buildid: 20160421213436 00:34:23 INFO - mozversion application_changeset: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f 00:34:23 INFO - mozversion application_display_name: Nightly 00:34:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:34:23 INFO - mozversion application_name: Firefox 00:34:23 INFO - mozversion application_remotingname: firefox 00:34:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:34:23 INFO - mozversion application_vendor: Mozilla 00:34:23 INFO - mozversion application_version: 48.0a1 00:34:23 INFO - mozversion platform_buildid: 20160421213436 00:34:23 INFO - mozversion platform_changeset: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f 00:34:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:34:23 INFO - mozversion platform_version: 48.0a1 00:34:23 INFO - using testdate: 1461310463 00:34:23 INFO - actual date: 1461310463 00:34:23 INFO - starting webserver on 'localhost:35497' 00:34:23 INFO - SUITE-START | Running 2 tests 00:34:23 INFO - TEST-START | dromaeo_css 00:34:23 INFO - operating with platform_type : linux_ 00:34:23 INFO - Initialising browser for dromaeo_css test... 00:34:23 INFO - TEST-INFO | started process 20926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaQULHc/profile http://localhost:35497/getInfo.html) 00:34:26 INFO - PROCESS | 20926 | 00:34:26 INFO - PROCESS | 20926 | (process:20997): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:34:27 INFO - PROCESS | 20926 | __metrics Screen width/height:1600/1200 00:34:27 INFO - PROCESS | 20926 | colorDepth:24 00:34:27 INFO - PROCESS | 20926 | Browser inner width/height: 1024/697 00:34:27 INFO - PROCESS | 20926 | __metrics 00:34:27 ERROR - PROCESS | 20926 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 00:34:28 INFO - TEST-INFO | 20926: exit 0 00:34:28 INFO - Browser initialized. 00:34:28 INFO - Running cycle 1/1 for dromaeo_css test... 00:34:28 INFO - TEST-INFO | started process 21048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaQULHc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:34:30 INFO - PROCESS | 21048 | 00:34:30 INFO - PROCESS | 21048 | (process:21112): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:34:40 INFO - PROCESS | 21048 | RSS: Main: 163672064 00:34:40 INFO - PROCESS | 21048 | 00:35:30 INFO - PROCESS | 21048 | 1461310530008 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] 00:37:37 INFO - PROCESS | 21048 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35497/tests/dromaeo/cssquery-ext.html) 00:37:38 INFO - PROCESS | 21048 | RSS: Main: 168775680 00:37:38 INFO - PROCESS | 21048 | 00:40:40 INFO - PROCESS | 21048 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-ext.html (next: http://localhost:35497/tests/dromaeo/cssquery-jquery.html) 00:40:41 INFO - PROCESS | 21048 | RSS: Main: 165232640 00:40:41 INFO - PROCESS | 21048 | 00:43:42 INFO - PROCESS | 21048 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35497/tests/dromaeo/cssquery-mootools.html) 00:43:43 INFO - PROCESS | 21048 | RSS: Main: 164155392 00:43:43 INFO - PROCESS | 21048 | 00:46:45 INFO - PROCESS | 21048 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35497/tests/dromaeo/cssquery-prototype.html) 00:46:45 INFO - PROCESS | 21048 | RSS: Main: 164995072 00:46:45 INFO - PROCESS | 21048 | 00:49:48 INFO - PROCESS | 21048 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35497/tests/dromaeo/cssquery-yui.html) 00:49:48 INFO - PROCESS | 21048 | RSS: Main: 164134912 00:49:48 INFO - PROCESS | 21048 | 00:52:51 INFO - PROCESS | 21048 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-yui.html (next: http://localhost:35497/tests/dromaeo/cssquery-dojo.html) 00:52:51 INFO - PROCESS | 21048 | RSS: Main: 166465536 00:52:51 INFO - PROCESS | 21048 | 00:52:51 INFO - PROCESS | 21048 | __start_tp_report 00:52:51 INFO - PROCESS | 21048 | _x_x_mozilla_page_load 00:52:51 INFO - PROCESS | 21048 | _x_x_mozilla_page_load_details 00:52:51 INFO - PROCESS | 21048 | |i|pagename|runs| 00:52:51 INFO - PROCESS | 21048 | |0;dojo.html;3121.8751249950005;3206.6152061752587;3216.1477208539727;3262.820544870033;3267.820269885157;5450.182472629108;5490.862728431791;5541.778328866845;5553.361363443205;5557.749901254443;5430.511253987141;5537.390887002426;5543;5575.442455754423;5659.688717120557;4968.180250258703;4974.701517908937;5041.369828771403;5047.64666473347;5102.260172275018;829.986645418365;4965.131102057126;5060.06388818068;5072.695638261716;5106.617003724717;5012.248162775612;5054.090263752523;5066.493350664941;5078.923816142761;5093.981203759263;4948.703077815307;5102.6428150029515;5128.84613461593;5129;5151.407588127338;5009.699418034929;5019.121653710586;5023.397192336906;5034.874128146789;5044.319016932741;5457.154141108134;5472.2338872557875;5473.534749546293;5526.281583394133;5556.333240011184;5846.7953621623465;5929.495992840613;5950.404959504058;5957.642541447527;5966.105084237356;5858.619189752695;5922.3781502942;5924.703764811742;5927.525797936198;5998.070299103646;5499.780008799643;5500.22996780451;5502.504774570308;5508.732991411957;5511.255980442669;6005.939940600625;6024.096385542116;6084.239470066242;6112.473085128069;6144.969275153596;5784.855378615568;5786.652800831964;5796.333421656479;5813.157092221689;5845.620034697731;5860.560457965669;5865.472107510259;5868.706564671749;5873.706314684248;5875.911861321998;5720.885582288331;5849.766009359663;5901.645901245853;5929.110633405024;5956.9873121569435;5680.289963754531;5746.856328591735;5806.448387403275;5902.704864756745;5984.491318237911;4437.179121862466;4450.910981780346;4452.755098469615;4471.8434854779925;4501.527339629357;3922.941155882664;3941.2708648900043;3953.8220780064967;3997.8800635980965;4012.799360032045;5631.183478395692;5633.774649013993;5644.350899646511;5656.4060773619;5675.262215911905;5897.587168898136;5942.64344139353;5959;5986.850328741816;5989.191459153046;5578.525825304894;5630.239917611152;5642;5708.20085188074;5743.253377060955;5083.466236045236;5083.923741143886;5090.440051594322;5099.617528685363;5104.846854594368;6084.39156084388;6090.847728806815;6106.267247930188;6136.969315153396;6139.3553676863285;5857.414258574194;5974.253218347707;6025.758969641165;6060.545459090674;6076.331603523698;6151.507322986527;6154.753809847556;6178.196834411498;6206.968965155326;6208.689565521796;5669.858253543694;5846.298444186725;5871.442212989759;5902.4097590240635;5959.73181206838;5955.940440595538;6004.849878753066;6005.549583781147;6006.069059295816;6055.727492262947;5780.653160810365;5801.1878337033695;5820.970895145497;5852.414758524284;5860.619059761102;5540.612157148961;5782.884342313214;5833.883322333614;5845.736941837713;5859.707014649336;5635.802746903839;5654.180143879197;5662.943370566406;5680.289963754531;5769.9711501442225;5746.396628353963;5770.105633626795;5794.420557944172;5814.534837212928;5829.329627092939;5530.834074977757;5657.349404818334;5662.292213473316;5684.7441865117;5762.1644861494015 00:52:51 INFO - PROCESS | 21048 | |1;ext.html;579.4437340153453;613.6502193749562;629.851984783576;637.1398611873974;654.2410803467978;35205.29589408213;36355.45466818;36372.272554548894;36399;36408.27183456329;38569.421458678145;38943.221135577274;39081;39277;39648.405273920915;8331.458455200407;8614.827703445928;8619.353548483889;8622.051574326819;8626.870596941051;8422;8526.658933642648;8565.743027709179;8600.096989816073;8631.136886311382;8771.868421973644;8778.648854045863;8837.160469755363;8839.513826739527;8882.86675699865;8692.608832602547;8711.782205444852;8778.166074222938;8801.735947921541;8814.64741410346;8662.003869554956;8796.956015219946;8812.471251724917;8821.558922053871;8858.247049000842;39177.60822391768;39430.40854387187;39608.207835843124;39683.40474892879;39730.20539589192;3277.2953814929906;3288.3752087103376;3374.3757404880175;3522.788632682047;3775.377062784637;26742.73257267422;28108.859455702794;28763.856180719173;30023;30127.397452051056;3773.9056523586855;3781;3805.6384643458828;3845.239510281688;3912.2371137628174;254033;254821;255125;256920;260201;54131.45868541343;54603.453965460634;54687;54958;55226.72386638041;63420.68289658522;63948.36051639424;64030.35969640244;64328;64758.35241647618;15116.168610726516;15183.089014659156;15216.391344346324;15218.46735364279;15341.386344546094;12294.75410491785;12349.814752778535;12365.505379784889;12385.814212786816;12400.131990760741;18644.254229830654;18731.250749969848;18745.531361716065;18773.249070037047;18777.34279300218;7140;7298.124225093023;7392.445566582528;7397.519161254501;7453.217412171643;1047.5129064984667;1063.9680809575725;1125.2460851229696;1130.9264897781618;1176.3294921894437;29759.363235022283;29872.55191172134;30151.849240753654;30387.696123038928;30697.386052279275;1082.3722241100143;1119.1885882734953;1133.7845809296207;1185.454690842205;1251.3492983648453;16269;16281.430149944932;16417.58956026085;16445.91777041107;16692.58268543296;455332;462975;464315;466994.65026748524;467678;54708.72645636746;55038.724806375714;55129.72435137879;55238.447615524135;55801;1359.2795818216164;1382.7511048011254;1389.7984792205073;1402.1797248609678;1509.539590424931;27776;28335;29191.562126567693;30038.098857034325;30317;48341;49598.25602616036;49623.255651165986;49665.751671241414;49773.50226497689;410389;416354;416916;418142;418365;40742.59257407388;41075.383869241385;41144.588554114074;41256.58743412527;41570;45236;45967.540324596324;46481.76759116183;46518.06963860772;46781;39537.60462395339;40064;40187;40210.79894600625;40394.1921161581;38465;38843.22313553769;38952.80523597364;39005.41491877567;39858.601413986646;38523.42214866835;39515.81452556428;39529;39675;40181;36949.81525092357;38237.235255295294;38489.42265865958;38517.422238667;38898;29960.052596581154;30451;30604.693953060185;31324.530132048494;31463.05610831679 00:52:51 INFO - PROCESS | 21048 | |2;jquery.html;382.8105087981448;388.7881104797884;392.80752431308656;395.4404517607584;403.620596639159;16793.832061679394;18477.815221847777;18755.15601797919;18961.14674839632;19111.52221194471;16324.77564182688;16738.330466781346;17012;17145.399911003118;17218.56953576158;5403.135498320269;5567.66594004359;5574.944250557503;5608.4391560844;5624.268845050137;4440.777961101948;6255.530835187356;6286.874262514747;6296.779612713556;6308.148399966015;6002.609830361012;6144.2319710036245;6227.470664993481;6233.688315584225;6233.7818176363835;6120.806442743667;6176.289726681444;6182.258129024501;6186.752529898821;6229.968850155743;5225.555827754645;5381.48875856793;5388.757505912244;5414.7834086636485;5430.809921652763;16829.747553786703;16869.24088416024;17857.910710446493;21922.342329730134;21987.890060549595;2375.2043065573052;2396.4488167721347;2448.8408253463645;2463.064035666453;2606.2832721001687;8548;9146.954265228698;9306.674266400643;9376.249900007982;14028.789568156486;1819.0904547726136;1860.6557786809483;1887.9339223127124;1922.5097600112022;1960.2061165228106;74733.25266747318;76439.61780191175;77509.22490775076;77551.22448775497;77966;10542.789144217073;10664.520096595672;10726;10729.302595331279;10760.534378233102;14713.190774507291;14753.114813111248;14795.408183672533;14822.629434264014;14841.40634374613;7508.436867234979;7616.314531692175;7739.7678069658;7828.452008359474;7839.764807055797;7252.746153884589;7385.852282954418;7469.589172595451;7484.476086673881;7494.5503269803985;3462.671046250602;4500.617447516997;4539;4562.475315338778;4602.7468489233415;1811.9818801811814;1839.6136811269516;1859.1447933950265;1879.473747350744;1935.9612807743765;844.8310337932438;882.9470231786113;910.8087301666724;911.8495448250965;974.7952929884661;16450;17282;17448.12759362027;17761.822381776015;17770.200340984688;855.7475544714324;875.3916028360355;879.4811061473761;888.8311220868014;931.2224292715658;9613.327067105376;9626.32615716893;9747.3664211826;9835.360701554377;9940.40357578533;371307;375608;377997;380244;464981;78423.60788196023;84303.5784821072;93617;96718;98630;1040.6149724601946;1044.3264094658903;1082.1288862465633;1084.5336505302637;1089.4716062709579;16667.833321667113;17060.573485662957;17170.39903603368;17174;17265.482035538953;37072;37616;38955.610443895195;39331.80334098311;39828;55196.17205741837;55569.444305556426;55713.164302534686;55750.44249557453;55765.16352254638;7868.488548244346;8057.798555035936;8327.541985190872;8334.291585215324;8403.495790252604;8507.319414446953;9652.565634546321;11110.722266939405;13331.466741330627;13656.774502564322;9037.322200835095;10878.531398261133;11482.94258528702;11765.176437649283;11902.940485297519;7712.9614351927885;8920.776980575538;11646.592369267035;11952;12033.278003319829;11340.432978351215;11457.541698331974;11803.940980295043;12025.338606376734;12162.270263784201;7737.690492380242;7977.481463705073;8258.504489730636;8403.369747268856;8612.48325100496;11483.712907177387;11540.94229528847;11554.364509951698;11622.6513204604;11789.646310610695 00:52:51 INFO - PROCESS | 21048 | |3;mootools.html;1415.6319356967188;1468.2071681292102;1604.4705247268403;1751.964960700786;1754.8859324143937;7272.781816545512;8052.677892884285;8215.178482151781;8280.378971577133;8336.999560052802;8186.426950113494;8197.139300373465;8256.711015114472;8260.215279548449;8265.793355166124;2277.077783497682;2306.08909480755;2310;2316.513532158249;2321.338418550705;2112.355731501891;2131.179495894084;2160.2547121243147;2161.5676864627058;2200.0759680934048;2275.2150508074687;2301.091069027733;2307.8153747700226;2309.3072078376504;2324.174917904145;2284.2119468783244;2290.358699564125;2293.5412917416584;2294.609916314222;2308.595995700746;2253.1663284584642;2266.1162146762777;2271.5911135995516;2277.134688818255;2283.828712846543;8220.465669731448;8266.958665206696;8296.377771667148;8310.626021829032;8386.412951093425;4878.56092951636;4975.104481193383;4978.477259887696;4983.327250821129;5036.697798132123;3202.4876019836947;3222.081706713599;3309.255417531036;3336.4161271777343;3340.5657264555693;1069.6309773128257;1074.312440038376;1079.3416016230094;1083.4582708645678;1090.4929207918356;11491.425428728613;11506.654800356002;11513.424328783527;11523.308601483854;11534.423278836024;4358.3244597087505;4493.5281795411665;4628.236341003764;4633.189191891405;4634;9553.665621703207;9651.517424128766;9683.951580242194;9712.465814380135;9750.122488976027;4975.179095449283;4988.127077761377;5021.59827213822;5027.120253955616;5040.193569028937;4165.583441655871;4510.729356238636;4636.721796692209;4674.0885527322525;4674.789634466457;3819.1788765415567;3860.2279544091293;3916.5104361954754;3916.6083391661177;3941.3890846918775;1281.0648226794306;1304.9543265985644;1310.6854354954742;1315.1451556488169;1317.124112465219;991.2813210422386;996.2329006664828;1001.7946321004176;1010.4543546484816;1013.3767732844248;5714.428557144335;5913.113033044991;5934.6142500737315;5987.760489580455;6138.846528836815;418.91412260486527;422.5478737750577;422.7041071250137;991.1723710701501;1053.2732414633879;4111.9177616447505;4130.586941305845;4167.854125105607;4168.916621667549;4169.124483858423;9964.80070398588;10179.898201017895;10226.6420675276;10286.177105831515;10354.689359319233;10025.19798416125;10053.748656283506;10073.59705611782;10202.591896324213;10218.744531386776;7848.215178482106;7904.525728456426;7979.6035693753365;7986.32116270112;7994.760157195294;5760.884782304414;5825.50483208932;5899.528037757055;5979.850503737442;6028.4272994065495;9337.673181438617;9445.386049906734;9681.564329605326;9687.17658998993;9724.659636912675;9868;9982.750431239278;10001.699949001542;10115.544800483849;10180.032896874785;6469.417752402118;6485.740570377321;6761.797146085625;7099.538529995741;7192.31672991065;8032.63853126599;8071.87892181606;8084.312833408991;8105.878411823709;8119;7352.4485663576515;7571;7580.431467640059;7666.731664391719;7687.308142267223;7329.267073292628;7537.472376933562;7550.395968322411;7558.58427786477;7596.696132154652;6712.83217919556;6773.221079575912;6819.454443644596;6827.761028363983;6845.212800528003;5094.083065048327;5141.511556402136;5170.767315470888;5297.311349524537;5364.9731751341;5088.7201203932655;5089.694618322913;5093.592512598909;5110.259012443249;5255.579553635776 00:52:51 INFO - PROCESS | 21048 | |4;prototype.html;319.9168216263771;320.0925376557458;325.08974870362977;330.66107240078924;331.80091944833106;5953.613015154017;6032.788852390167;6070.180525629039;6073.726682299296;6115.480184184344;5915.970420147904;5923.61496502727;5970.313413957396;5984.581079324449;5986.161937328778;4294.269974104402;4441.511433742286;4600.539946005406;4603.8158473661015;4625.213713668668;4590.74750888701;4605.240135377659;4618.8152473901;4620.260758278676;4642.512536183703;4539.931901021488;4563.315502674593;4570.177368073745;4570.611498022656;4586.587207151356;4277.016286254164;4456.621187199092;4514.277715565494;4519.790948426621;4533.818647254106;3905.3165696003084;3910.3156947534353;3912.550056743454;3916.74541154824;3923.6468717815246;5705.486506214419;5715.628484148517;5732.770689172428;5778.7399567019165;5798.304203495565;5083.79664813407;5243.842684719464;5250.553702935255;5276.366835979668;5284.180951952453;6237.376262373772;6248.562600617958;6259.935810912156;6265.154204182422;6297.401746834089;4180.99656082538;4311.28863737483;4323.610875021232;4332.1985432695055;4345.500802223228;6531.346865313478;6559.508036897204;6580.506462015368;6617.305182955816;6620.801375958729;4446.5553444655925;4449.532799056117;4450.065486247924;4463.933041004388;4466.843660471868;4407.427034485497;4515.435570553681;4517.186906356887;4521.502634710179;4526.275795872644;5178.663386879841;5214.765335559909;5216.426193118754;5249.160134378558;5249.370075590953;6308.463780578702;6340.207474065742;6359.523035772336;6360.7137678804565;6387.648679322682;1474.3586539855198;1549.8217704963847;1556.813182418117;1566.3812793946327;1571.5521076493374;944.2351695126832;1011.9747006324901;1014.8224060789332;1034.3173505486343;1049.3546468921559;5999.280086389661;6031.9396806032255;6035.185249991283;6037.637741735422;6086.969565152146;6383.553151279459;6425.775097871646;6462.48300135988;6487.124238227779;6488.772892948724;5977.3126090500145;6014.8195554133445;6039.607425517327;6048.637081775108;6085.148079268906;3424.434968230214;3480.2517458746493;3495.1961048958883;3498.9825050874583;3507.2108775525303;6520.47836173105;6686.4985126115735;6850.040994260808;6861.245263021064;6911.17065952089;6748.325167483213;6776.898346524806;6779.15260592426;6830.248672646005;6841.315868413119;6757.628330441775;6823.509419062007;6830.521863469608;6867.896981545181;6910.723571057101;6577.375149360803;6585.341465853377;6612.570182938093;6628.270890201978;6635.435987940886;6408.647524386203;6440.645764482811;6470.741170353133;6548.770793022221;6598.90101648466;6840.179178498413;6869.484788640972;6881.759138430131;6882.933145362477;6903.240643529308;4397.978010109929;4401.493828209796;4412.3160910059;4428.582853486853;4436.733795972252;6369.808905732835;6458.257300410513;6491.188601424822;6563.638999854863;6586.242582103119;6392.808215753535;6404.231492220963;6419.165508483868;6420.165378500765;6422.807315780534;6234.625922444668;6351.491880649629;6376.139221205263;6413.935860641333;6467.159269294962;6037.913175628253;6263.530235232467;6282.591631544118;6295.307516173309;6322.494200464043;6392.4246817786625;6435.356464353715;6456.677166141768;6467.902981455376;6479.704059188087;5993.250843644544;6216.564840461125;6221.96889015552;6233.719482623203;6271.560990730605 00:52:51 INFO - PROCESS | 21048 | |5;yui.html;739.6893304811979;753.6156560154319;758.5107605594392;761.9923800761992;766.743141047749;12575.308358040304;12636.494540218404;13791.65520861979;14034.578962631125;14716.926415367934;14054.227017514033;14098.859011409882;14109.788353174685;14132.929335353308;14138.151710897328;794.7019867549683;801.1187693537121;805.6092794994423;805.9838803223932;807.2855522862279;778.4861991085885;807.9474834135792;810.9594520273993;811.2941740685612;811.6550466051934;827.7103013945132;835.2065537739172;836.0844874862047;836.4019725895984;839.7648658375665;829.179112678447;829.5893532701291;830.4021104804531;834.9791255218607;839.2111415269658;610.3073012131218;618.1593033474516;618.3816183816184;620.3393386043894;621.9346968568326;13008.934955325258;13138.343082845819;13138.605841824665;13144.474221031147;13154.4080516377;11893.4647940842;11994;12153.149279550435;12311.569095081719;12354.073444491609;11008.174386920933;11035.227534072617;11112.944435277852;11168.760375628748;11343;3718.219173973469;3771.9245615087543;3802.315583195024;3856.2094770571966;3952.940705889414;51944.74027629838;52012.73993630045;52248.47751522474;52477.21284180702;53147.20279195815;10110.292279540508;10140.898591013995;10194.847077293847;10206.285560010729;10423.791524169474;17223.56941076483;17250.913745431193;17308.278720075243;17414.651706966044;17763.378281760077;7470.402367810562;7557.470977031665;7623.885641715267;7657.244324522707;7805.297523222937;4438.068005718836;4570.318693515163;4605.424321959755;4607.9308810367875;4661.650376221729;3127.7654175936896;3165;3167.224030112591;3193.808371497671;3198.4242836289227;563.4196777319368;566.1083793025919;568.2953138108716;568.934572524165;573.0744847071949;680.6358598149966;680.8229860236374;684.4729558240226;685.8833998220315;692.1175501235964;8418;8656.48061116335;8696.478211307342;8886.86669699955;8897.11028897118;526.0557299647143;591.9112133179972;595.9987221467975;604.7611193578512;676.6582875647865;4181.832726690898;4273.914521709548;4333.956660433355;4412.139632771643;4438.289873620205;67898.32101679019;68409.65795170992;69040.65479672569;69239;69599.65200173967;57519;59681;59694.40305596975;59706;59794;43055.35416968748;43778.562214378086;43792.12415751731;44008.3398749019;55817.44182558123;8066;8491.19333663301;8588.484690918565;8802.251808596086;8826.646934122564;31415.685843141277;33167.66832331646;33491.4976275361;33847.66152338445;34187.658123419445;42691;43828.34257486076;44122.11755764931;44131.690123240245;44374.3343849849;11357.54569817198;11495.137864660352;11529.1929564933;11699.649010529698;11806.114541409257;12568.308743018855;12795.360231988177;12971.481140754642;13000.414981325674;13314.201147930768;11650.88349116498;11747.647570572897;11812;11899;11971.461284242405;11822.40887955616;12128.818067728815;12350.38248087574;12405.503779848705;12458.470933389091;11419.771604567695;11731.993633107704;11884.34636095023;11885.108616853599;12265.202761820454;10134.341267817568;10151.54318055704;10463.267571269938;10473.738156546147;10596.576136954436;10033.548490318099;10170.440625765654;10218.693439196835;10227.386356818615;10240.231982601186 00:52:51 INFO - PROCESS | 21048 | __end_tp_report 00:52:51 INFO - PROCESS | 21048 | __start_cc_report 00:52:51 INFO - PROCESS | 21048 | _x_x_mozilla_cycle_collect,317 00:52:51 INFO - PROCESS | 21048 | __end_cc_report 00:52:51 INFO - PROCESS | 21048 | __startTimestamp1461311571442__endTimestamp 00:52:51 INFO - PROCESS | 21048 | 00:52:51 INFO - PROCESS | 21048 | ------- Summary: start ------- 00:52:51 INFO - PROCESS | 21048 | Number of tests: 6 00:52:51 INFO - PROCESS | 21048 | 00:52:51 INFO - PROCESS | 21048 | [#0] dojo.html Cycles:165 Average:5474.43 Median:5684.74 stddev:729.04 (12.8%) stddev-sans-first:707.53 00:52:51 INFO - PROCESS | 21048 | Values: 3121.9 3206.6 3216.1 3262.8 3267.8 5450.2 5490.9 5541.8 5553.4 5557.7 5430.5 5537.4 5543.0 5575.4 5659.7 4968.2 4974.7 5041.4 5047.6 5102.3 830.0 4965.1 5060.1 5072.7 5106.6 5012.2 5054.1 5066.5 5078.9 5094.0 4948.7 5102.6 5128.8 5129.0 5151.4 5009.7 5019.1 5023.4 5034.9 5044.3 5457.2 5472.2 5473.5 5526.3 5556.3 5846.8 5929.5 5950.4 5957.6 5966.1 5858.6 5922.4 5924.7 5927.5 5998.1 5499.8 5500.2 5502.5 5508.7 5511.3 6005.9 6024.1 6084.2 6112.5 6145.0 5784.9 5786.7 5796.3 5813.2 5845.6 5860.6 5865.5 5868.7 5873.7 5875.9 5720.9 5849.8 5901.6 5929.1 5957.0 5680.3 5746.9 5806.4 5902.7 5984.5 4437.2 4450.9 4452.8 4471.8 4501.5 3922.9 3941.3 3953.8 3997.9 4012.8 5631.2 5633.8 5644.4 5656.4 5675.3 5897.6 5942.6 5959.0 5986.9 5989.2 5578.5 5630.2 5642.0 5708.2 5743.3 5083.5 5083.9 5090.4 5099.6 5104.8 6084.4 6090.8 6106.3 6137.0 6139.4 5857.4 5974.3 6025.8 6060.5 6076.3 6151.5 6154.8 6178.2 6207.0 6208.7 5669.9 5846.3 5871.4 5902.4 5959.7 5955.9 6004.8 6005.5 6006.1 6055.7 5780.7 5801.2 5821.0 5852.4 5860.6 5540.6 5782.9 5833.9 5845.7 5859.7 5635.8 5654.2 5662.9 5680.3 5770.0 5746.4 5770.1 5794.4 5814.5 5829.3 5530.8 5657.3 5662.3 5684.7 5762.2 00:52:51 INFO - PROCESS | 21048 | 00:52:51 INFO - PROCESS | 21048 | [#1] ext.html Cycles:180 Average:54499.70 Median:39473.11 stddev:102837.02 (260.5%) stddev-sans-first:103045.82 00:52:51 INFO - PROCESS | 21048 | Values: 579.4 613.7 629.9 637.1 654.2 35205.3 36355.5 36372.3 36399.0 36408.3 38569.4 38943.2 39081.0 39277.0 39648.4 8331.5 8614.8 8619.4 8622.1 8626.9 8422.0 8526.7 8565.7 8600.1 8631.1 8771.9 8778.6 8837.2 8839.5 8882.9 8692.6 8711.8 8778.2 8801.7 8814.6 8662.0 8797.0 8812.5 8821.6 8858.2 39177.6 39430.4 39608.2 39683.4 39730.2 3277.3 3288.4 3374.4 3522.8 3775.4 26742.7 28108.9 28763.9 30023.0 30127.4 3773.9 3781.0 3805.6 3845.2 3912.2 254033.0 254821.0 255125.0 256920.0 260201.0 54131.5 54603.5 54687.0 54958.0 55226.7 63420.7 63948.4 64030.4 64328.0 64758.4 15116.2 15183.1 15216.4 15218.5 15341.4 12294.8 12349.8 12365.5 12385.8 12400.1 18644.3 18731.3 18745.5 18773.2 18777.3 7140.0 7298.1 7392.4 7397.5 7453.2 1047.5 1064.0 1125.2 1130.9 1176.3 29759.4 29872.6 30151.8 30387.7 30697.4 1082.4 1119.2 1133.8 1185.5 1251.3 16269.0 16281.4 16417.6 16445.9 16692.6 455332.0 462975.0 464315.0 466994.7 467678.0 54708.7 55038.7 55129.7 55238.4 55801.0 1359.3 1382.8 1389.8 1402.2 1509.5 27776.0 28335.0 29191.6 30038.1 30317.0 48341.0 49598.3 49623.3 49665.8 49773.5 410389.0 416354.0 416916.0 418142.0 418365.0 40742.6 41075.4 41144.6 41256.6 41570.0 45236.0 45967.5 46481.8 46518.1 46781.0 39537.6 40064.0 40187.0 40210.8 40394.2 38465.0 38843.2 38952.8 39005.4 39858.6 38523.4 39515.8 39529.0 39675.0 40181.0 36949.8 38237.2 38489.4 38517.4 38898.0 29960.1 30451.0 30604.7 31324.5 31463.1 00:52:51 INFO - PROCESS | 21048 | 00:52:51 INFO - PROCESS | 21048 | [#2] jquery.html Cycles:180 Average:25557.30 Median:2422.20 stddev:65785.24 (2715.9%) stddev-sans-first:65942.63 00:52:51 INFO - PROCESS | 21048 | Values: 382.8 388.8 392.8 395.4 403.6 16793.8 18477.8 18755.2 18961.1 19111.5 16324.8 16738.3 17012.0 17145.4 17218.6 5403.1 5567.7 5574.9 5608.4 5624.3 4440.8 6255.5 6286.9 6296.8 6308.1 6002.6 6144.2 6227.5 6233.7 6233.8 6120.8 6176.3 6182.3 6186.8 6230.0 5225.6 5381.5 5388.8 5414.8 5430.8 16829.7 16869.2 17857.9 21922.3 21987.9 2375.2 2396.4 2448.8 2463.1 2606.3 8548.0 9147.0 9306.7 9376.2 14028.8 1819.1 1860.7 1887.9 1922.5 1960.2 74733.3 76439.6 77509.2 77551.2 77966.0 10542.8 10664.5 10726.0 10729.3 10760.5 14713.2 14753.1 14795.4 14822.6 14841.4 7508.4 7616.3 7739.8 7828.5 7839.8 7252.7 7385.9 7469.6 7484.5 7494.6 3462.7 4500.6 4539.0 4562.5 4602.7 1812.0 1839.6 1859.1 1879.5 1936.0 844.8 882.9 910.8 911.8 974.8 16450.0 17282.0 17448.1 17761.8 17770.2 855.7 875.4 879.5 888.8 931.2 9613.3 9626.3 9747.4 9835.4 9940.4 371307.0 375608.0 377997.0 380244.0 464981.0 78423.6 84303.6 93617.0 96718.0 98630.0 1040.6 1044.3 1082.1 1084.5 1089.5 16667.8 17060.6 17170.4 17174.0 17265.5 37072.0 37616.0 38955.6 39331.8 39828.0 55196.2 55569.4 55713.2 55750.4 55765.2 7868.5 8057.8 8327.5 8334.3 8403.5 8507.3 9652.6 11110.7 13331.5 13656.8 9037.3 10878.5 11482.9 11765.2 11902.9 7713.0 8920.8 11646.6 11952.0 12033.3 11340.4 11457.5 11803.9 12025.3 12162.3 7737.7 7977.5 8258.5 8403.4 8612.5 11483.7 11540.9 11554.4 11622.7 11789.6 00:52:51 INFO - PROCESS | 21048 | 00:52:51 INFO - PROCESS | 21048 | [#3] mootools.html Cycles:180 Average:5553.21 Median:4975.14 stddev:3087.08 (62.1%) stddev-sans-first:3080.08 00:52:51 INFO - PROCESS | 21048 | Values: 1415.6 1468.2 1604.5 1752.0 1754.9 7272.8 8052.7 8215.2 8280.4 8337.0 8186.4 8197.1 8256.7 8260.2 8265.8 2277.1 2306.1 2310.0 2316.5 2321.3 2112.4 2131.2 2160.3 2161.6 2200.1 2275.2 2301.1 2307.8 2309.3 2324.2 2284.2 2290.4 2293.5 2294.6 2308.6 2253.2 2266.1 2271.6 2277.1 2283.8 8220.5 8267.0 8296.4 8310.6 8386.4 4878.6 4975.1 4978.5 4983.3 5036.7 3202.5 3222.1 3309.3 3336.4 3340.6 1069.6 1074.3 1079.3 1083.5 1090.5 11491.4 11506.7 11513.4 11523.3 11534.4 4358.3 4493.5 4628.2 4633.2 4634.0 9553.7 9651.5 9684.0 9712.5 9750.1 4975.2 4988.1 5021.6 5027.1 5040.2 4165.6 4510.7 4636.7 4674.1 4674.8 3819.2 3860.2 3916.5 3916.6 3941.4 1281.1 1305.0 1310.7 1315.1 1317.1 991.3 996.2 1001.8 1010.5 1013.4 5714.4 5913.1 5934.6 5987.8 6138.8 418.9 422.5 422.7 991.2 1053.3 4111.9 4130.6 4167.9 4168.9 4169.1 9964.8 10179.9 10226.6 10286.2 10354.7 10025.2 10053.7 10073.6 10202.6 10218.7 7848.2 7904.5 7979.6 7986.3 7994.8 5760.9 5825.5 5899.5 5979.9 6028.4 9337.7 9445.4 9681.6 9687.2 9724.7 9868.0 9982.8 10001.7 10115.5 10180.0 6469.4 6485.7 6761.8 7099.5 7192.3 8032.6 8071.9 8084.3 8105.9 8119.0 7352.4 7571.0 7580.4 7666.7 7687.3 7329.3 7537.5 7550.4 7558.6 7596.7 6712.8 6773.2 6819.5 6827.8 6845.2 5094.1 5141.5 5170.8 5297.3 5365.0 5088.7 5089.7 5093.6 5110.3 5255.6 00:52:51 INFO - PROCESS | 21048 | 00:52:51 INFO - PROCESS | 21048 | [#4] prototype.html Cycles:180 Average:5292.73 Median:6033.99 stddev:1624.75 (26.9%) stddev-sans-first:1585.85 00:52:51 INFO - PROCESS | 21048 | Values: 319.9 320.1 325.1 330.7 331.8 5953.6 6032.8 6070.2 6073.7 6115.5 5916.0 5923.6 5970.3 5984.6 5986.2 4294.3 4441.5 4600.5 4603.8 4625.2 4590.7 4605.2 4618.8 4620.3 4642.5 4539.9 4563.3 4570.2 4570.6 4586.6 4277.0 4456.6 4514.3 4519.8 4533.8 3905.3 3910.3 3912.6 3916.7 3923.6 5705.5 5715.6 5732.8 5778.7 5798.3 5083.8 5243.8 5250.6 5276.4 5284.2 6237.4 6248.6 6259.9 6265.2 6297.4 4181.0 4311.3 4323.6 4332.2 4345.5 6531.3 6559.5 6580.5 6617.3 6620.8 4446.6 4449.5 4450.1 4463.9 4466.8 4407.4 4515.4 4517.2 4521.5 4526.3 5178.7 5214.8 5216.4 5249.2 5249.4 6308.5 6340.2 6359.5 6360.7 6387.6 1474.4 1549.8 1556.8 1566.4 1571.6 944.2 1012.0 1014.8 1034.3 1049.4 5999.3 6031.9 6035.2 6037.6 6087.0 6383.6 6425.8 6462.5 6487.1 6488.8 5977.3 6014.8 6039.6 6048.6 6085.1 3424.4 3480.3 3495.2 3499.0 3507.2 6520.5 6686.5 6850.0 6861.2 6911.2 6748.3 6776.9 6779.2 6830.2 6841.3 6757.6 6823.5 6830.5 6867.9 6910.7 6577.4 6585.3 6612.6 6628.3 6635.4 6408.6 6440.6 6470.7 6548.8 6598.9 6840.2 6869.5 6881.8 6882.9 6903.2 4398.0 4401.5 4412.3 4428.6 4436.7 6369.8 6458.3 6491.2 6563.6 6586.2 6392.8 6404.2 6419.2 6420.2 6422.8 6234.6 6351.5 6376.1 6413.9 6467.2 6037.9 6263.5 6282.6 6295.3 6322.5 6392.4 6435.4 6456.7 6467.9 6479.7 5993.3 6216.6 6222.0 6233.7 6271.6 00:52:51 INFO - PROCESS | 21048 | 00:52:51 INFO - PROCESS | 21048 | [#5] yui.html Cycles:180 Average:14541.72 Median:43785.34 stddev:17536.54 (40.1%) stddev-sans-first:17555.11 00:52:51 INFO - PROCESS | 21048 | Values: 739.7 753.6 758.5 762.0 766.7 12575.3 12636.5 13791.7 14034.6 14716.9 14054.2 14098.9 14109.8 14132.9 14138.2 794.7 801.1 805.6 806.0 807.3 778.5 807.9 811.0 811.3 811.7 827.7 835.2 836.1 836.4 839.8 829.2 829.6 830.4 835.0 839.2 610.3 618.2 618.4 620.3 621.9 13008.9 13138.3 13138.6 13144.5 13154.4 11893.5 11994.0 12153.1 12311.6 12354.1 11008.2 11035.2 11112.9 11168.8 11343.0 3718.2 3771.9 3802.3 3856.2 3952.9 51944.7 52012.7 52248.5 52477.2 53147.2 10110.3 10140.9 10194.8 10206.3 10423.8 17223.6 17250.9 17308.3 17414.7 17763.4 7470.4 7557.5 7623.9 7657.2 7805.3 4438.1 4570.3 4605.4 4607.9 4661.7 3127.8 3165.0 3167.2 3193.8 3198.4 563.4 566.1 568.3 568.9 573.1 680.6 680.8 684.5 685.9 692.1 8418.0 8656.5 8696.5 8886.9 8897.1 526.1 591.9 596.0 604.8 676.7 4181.8 4273.9 4334.0 4412.1 4438.3 67898.3 68409.7 69040.7 69239.0 69599.7 57519.0 59681.0 59694.4 59706.0 59794.0 43055.4 43778.6 43792.1 44008.3 55817.4 8066.0 8491.2 8588.5 8802.3 8826.6 31415.7 33167.7 33491.5 33847.7 34187.7 42691.0 43828.3 44122.1 44131.7 44374.3 11357.5 11495.1 11529.2 11699.6 11806.1 12568.3 12795.4 12971.5 13000.4 13314.2 11650.9 11747.6 11812.0 11899.0 11971.5 11822.4 12128.8 12350.4 12405.5 12458.5 11419.8 11732.0 11884.3 11885.1 12265.2 10134.3 10151.5 10463.3 10473.7 10596.6 10033.5 10170.4 10218.7 10227.4 10240.2 00:52:51 INFO - PROCESS | 21048 | -------- Summary: end -------- 00:52:51 INFO - PROCESS | 21048 | 00:52:52 INFO - TEST-INFO | 21048: exit 0 00:52:52 INFO - TEST-OK | dromaeo_css | took 1109093ms 00:52:52 INFO - TEST-START | kraken 00:52:52 INFO - operating with platform_type : linux_ 00:52:52 INFO - Initialising browser for kraken test... 00:52:52 INFO - TEST-INFO | started process 21284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplcpuw1/profile http://localhost:35497/getInfo.html) 00:52:55 INFO - PROCESS | 21284 | 00:52:55 INFO - PROCESS | 21284 | (process:21353): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:52:56 INFO - PROCESS | 21284 | __metrics Screen width/height:1600/1200 00:52:56 INFO - PROCESS | 21284 | colorDepth:24 00:52:56 INFO - PROCESS | 21284 | Browser inner width/height: 1024/697 00:52:56 INFO - PROCESS | 21284 | __metrics 00:52:56 ERROR - PROCESS | 21284 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 00:52:57 INFO - TEST-INFO | 21284: exit 0 00:52:57 INFO - Browser initialized. 00:52:57 INFO - Running cycle 1/1 for kraken test... 00:52:57 INFO - TEST-INFO | started process 21404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplcpuw1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:52:59 INFO - PROCESS | 21404 | 00:52:59 INFO - PROCESS | 21404 | (process:21464): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:53:09 INFO - PROCESS | 21404 | RSS: Main: 164032512 00:53:09 INFO - PROCESS | 21404 | 00:53:11 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35497/tests/kraken/driver.html?testName=audio-beat-detection) 00:53:12 INFO - PROCESS | 21404 | RSS: Main: 168677376 00:53:12 INFO - PROCESS | 21404 | 00:53:15 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35497/tests/kraken/driver.html?testName=audio-dft) 00:53:16 INFO - PROCESS | 21404 | RSS: Main: 171884544 00:53:16 INFO - PROCESS | 21404 | 00:53:19 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35497/tests/kraken/driver.html?testName=audio-fft) 00:53:19 INFO - PROCESS | 21404 | RSS: Main: 164061184 00:53:19 INFO - PROCESS | 21404 | 00:53:22 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35497/tests/kraken/driver.html?testName=audio-oscillator) 00:53:22 INFO - PROCESS | 21404 | RSS: Main: 164704256 00:53:22 INFO - PROCESS | 21404 | 00:53:24 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35497/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:53:25 INFO - PROCESS | 21404 | RSS: Main: 164782080 00:53:25 INFO - PROCESS | 21404 | 00:53:28 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35497/tests/kraken/driver.html?testName=imaging-darkroom) 00:53:29 INFO - PROCESS | 21404 | RSS: Main: 165056512 00:53:29 INFO - PROCESS | 21404 | 00:53:32 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35497/tests/kraken/driver.html?testName=imaging-desaturate) 00:53:33 INFO - PROCESS | 21404 | RSS: Main: 165068800 00:53:33 INFO - PROCESS | 21404 | 00:53:36 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35497/tests/kraken/driver.html?testName=json-parse-financial) 00:53:36 INFO - PROCESS | 21404 | RSS: Main: 166395904 00:53:36 INFO - PROCESS | 21404 | 00:53:38 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35497/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:53:38 INFO - PROCESS | 21404 | RSS: Main: 166051840 00:53:38 INFO - PROCESS | 21404 | 00:53:40 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:53:41 INFO - PROCESS | 21404 | RSS: Main: 165789696 00:53:41 INFO - PROCESS | 21404 | 00:53:43 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:53:44 INFO - PROCESS | 21404 | RSS: Main: 166232064 00:53:44 INFO - PROCESS | 21404 | 00:53:46 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:53:47 INFO - PROCESS | 21404 | RSS: Main: 167038976 00:53:47 INFO - PROCESS | 21404 | 00:53:50 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:53:50 INFO - PROCESS | 21404 | RSS: Main: 166604800 00:53:50 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35497/tests/kraken/driver.html?testName=ai-astar) 00:53:52 INFO - PROCESS | 21404 | RSS: Main: 168095744 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | __start_tp_report 00:53:52 INFO - PROCESS | 21404 | _x_x_mozilla_page_load 00:53:52 INFO - PROCESS | 21404 | _x_x_mozilla_page_load_details 00:53:52 INFO - PROCESS | 21404 | |i|pagename|runs| 00:53:52 INFO - PROCESS | 21404 | |0;ai-astar;113;107;112;113;112;124;112;110;113;113 00:53:52 INFO - PROCESS | 21404 | |1;audio-beat-detection;164;127;156;188;131;157;159;129;189;129 00:53:52 INFO - PROCESS | 21404 | |2;audio-dft;163;165;163;163;165;176;170;163;165;164 00:53:52 INFO - PROCESS | 21404 | |3;audio-fft;74;74;73;169;77;76;78;77;154;78 00:53:52 INFO - PROCESS | 21404 | |4;audio-oscillator;93;93;146;94;93;93;143;92;93;161 00:53:52 INFO - PROCESS | 21404 | |5;imaging-gaussian-blur;118;118;119;118;118;118;118;118;121;118 00:53:52 INFO - PROCESS | 21404 | |6;imaging-darkroom;146;146;147;150;149;148;148;148;147;147 00:53:52 INFO - PROCESS | 21404 | |7;imaging-desaturate;97;96;95;97;96;96;96;96;96;96 00:53:52 INFO - PROCESS | 21404 | |8;json-parse-financial;57;58;58;57;66;62;64;76;56;55 00:53:52 INFO - PROCESS | 21404 | |9;json-stringify-tinderbox;61;63;62;61;62;62;62;61;62;61 00:53:52 INFO - PROCESS | 21404 | |10;stanford-crypto-aes;77;87;78;79;78;85;77;80;80;78 00:53:52 INFO - PROCESS | 21404 | |11;stanford-crypto-ccm;139;124;121;134;129;125;126;127;174;138 00:53:52 INFO - PROCESS | 21404 | |12;stanford-crypto-pbkdf2;166;165;166;167;181;173;172;164;164;162 00:53:52 INFO - PROCESS | 21404 | |13;stanford-crypto-sha256-iterative;72;70;68;75;69;71;67;67;76;69 00:53:52 INFO - PROCESS | 21404 | __end_tp_report 00:53:52 INFO - PROCESS | 21404 | __start_cc_report 00:53:52 INFO - PROCESS | 21404 | _x_x_mozilla_cycle_collect,833 00:53:52 INFO - PROCESS | 21404 | __end_cc_report 00:53:52 INFO - PROCESS | 21404 | __startTimestamp1461311632638__endTimestamp 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | ------- Summary: start ------- 00:53:52 INFO - PROCESS | 21404 | Number of tests: 14 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:4.33 (3.8%) stddev-sans-first:4.59 00:53:52 INFO - PROCESS | 21404 | Values: 113.0 107.0 112.0 113.0 112.0 124.0 112.0 110.0 113.0 113.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:158.00 stddev:23.61 (14.9%) stddev-sans-first:24.69 00:53:52 INFO - PROCESS | 21404 | Values: 164.0 127.0 156.0 188.0 131.0 157.0 159.0 129.0 189.0 129.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.00 stddev:4.19 (2.5%) stddev-sans-first:4.33 00:53:52 INFO - PROCESS | 21404 | Values: 163.0 165.0 163.0 163.0 165.0 176.0 170.0 163.0 165.0 164.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.50 stddev:36.32 (47.5%) stddev-sans-first:37.86 00:53:52 INFO - PROCESS | 21404 | Values: 74.0 74.0 73.0 169.0 77.0 76.0 78.0 77.0 154.0 78.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.00 stddev:27.91 (30.0%) stddev-sans-first:28.91 00:53:52 INFO - PROCESS | 21404 | Values: 93.0 93.0 146.0 94.0 93.0 93.0 143.0 92.0 93.0 161.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 00:53:52 INFO - PROCESS | 21404 | Values: 118.0 118.0 119.0 118.0 118.0 118.0 118.0 118.0 121.0 118.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.26 (0.9%) stddev-sans-first:1.20 00:53:52 INFO - PROCESS | 21404 | Values: 146.0 146.0 147.0 150.0 149.0 148.0 148.0 148.0 147.0 147.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 00:53:52 INFO - PROCESS | 21404 | Values: 97.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:60.00 stddev:6.42 (10.7%) stddev-sans-first:6.65 00:53:52 INFO - PROCESS | 21404 | Values: 57.0 58.0 58.0 57.0 66.0 62.0 64.0 76.0 56.0 55.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 00:53:52 INFO - PROCESS | 21404 | Values: 61.0 63.0 62.0 61.0 62.0 62.0 62.0 61.0 62.0 61.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:3.41 (4.3%) stddev-sans-first:3.46 00:53:52 INFO - PROCESS | 21404 | Values: 77.0 87.0 78.0 79.0 78.0 85.0 77.0 80.0 80.0 78.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:131.50 stddev:15.38 (11.7%) stddev-sans-first:16.19 00:53:52 INFO - PROCESS | 21404 | Values: 139.0 124.0 121.0 134.0 129.0 125.0 126.0 127.0 174.0 138.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:166.50 stddev:5.73 (3.4%) stddev-sans-first:6.04 00:53:52 INFO - PROCESS | 21404 | Values: 166.0 165.0 166.0 167.0 181.0 173.0 172.0 164.0 164.0 162.0 00:53:52 INFO - PROCESS | 21404 | 00:53:52 INFO - PROCESS | 21404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:3.13 (4.4%) stddev-sans-first:3.27 00:53:52 INFO - PROCESS | 21404 | Values: 72.0 70.0 68.0 75.0 69.0 71.0 67.0 67.0 76.0 69.0 00:53:52 INFO - PROCESS | 21404 | -------- Summary: end -------- 00:53:52 INFO - PROCESS | 21404 | 00:53:53 INFO - TEST-INFO | 21404: exit 0 00:53:53 INFO - TEST-OK | kraken | took 61474ms 00:53:53 INFO - SUITE-END | took 1170s 00:53:53 INFO - Completed test suite (00:19:30) 00:53:53 INFO - javascript benchmark 00:53:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.8751249950005, 3206.6152061752587, 3216.1477208539727, 3262.820544870033, 3267.820269885157, 5450.182472629108, 5490.862728431791, 5541.778328866845, 5553.361363443205, 5557.749901254443, 5430.511253987141, 5537.390887002426, 5543.0, 5575.442455754423, 5659.688717120557, 4968.180250258703, 4974.701517908937, 5041.369828771403, 5047.64666473347, 5102.260172275018, 829.986645418365, 4965.131102057126, 5060.06388818068, 5072.695638261716, 5106.617003724717, 5012.248162775612, 5054.090263752523, 5066.493350664941, 5078.923816142761, 5093.981203759263, 4948.703077815307, 5102.6428150029515, 5128.84613461593, 5129.0, 5151.407588127338, 5009.699418034929, 5019.121653710586, 5023.397192336906, 5034.874128146789, 5044.319016932741, 5457.154141108134, 5472.2338872557875, 5473.534749546293, 5526.281583394133, 5556.333240011184, 5846.7953621623465, 5929.495992840613, 5950.404959504058, 5957.642541447527, 5966.105084237356, 5858.619189752695, 5922.3781502942, 5924.703764811742, 5927.525797936198, 5998.070299103646, 5499.780008799643, 5500.22996780451, 5502.504774570308, 5508.732991411957, 5511.255980442669, 6005.939940600625, 6024.096385542116, 6084.239470066242, 6112.473085128069, 6144.969275153596, 5784.855378615568, 5786.652800831964, 5796.333421656479, 5813.157092221689, 5845.620034697731, 5860.560457965669, 5865.472107510259, 5868.706564671749, 5873.706314684248, 5875.911861321998, 5720.885582288331, 5849.766009359663, 5901.645901245853, 5929.110633405024, 5956.9873121569435, 5680.289963754531, 5746.856328591735, 5806.448387403275, 5902.704864756745, 5984.491318237911, 4437.179121862466, 4450.910981780346, 4452.755098469615, 4471.8434854779925, 4501.527339629357, 3922.941155882664, 3941.2708648900043, 3953.8220780064967, 3997.8800635980965, 4012.799360032045, 5631.183478395692, 5633.774649013993, 5644.350899646511, 5656.4060773619, 5675.262215911905, 5897.587168898136, 5942.64344139353, 5959.0, 5986.850328741816, 5989.191459153046, 5578.525825304894, 5630.239917611152, 5642.0, 5708.20085188074, 5743.253377060955, 5083.466236045236, 5083.923741143886, 5090.440051594322, 5099.617528685363, 5104.846854594368, 6084.39156084388, 6090.847728806815, 6106.267247930188, 6136.969315153396, 6139.3553676863285, 5857.414258574194, 5974.253218347707, 6025.758969641165, 6060.545459090674, 6076.331603523698, 6151.507322986527, 6154.753809847556, 6178.196834411498, 6206.968965155326, 6208.689565521796, 5669.858253543694, 5846.298444186725, 5871.442212989759, 5902.4097590240635, 5959.73181206838, 5955.940440595538, 6004.849878753066, 6005.549583781147, 6006.069059295816, 6055.727492262947, 5780.653160810365, 5801.1878337033695, 5820.970895145497, 5852.414758524284, 5860.619059761102, 5540.612157148961, 5782.884342313214, 5833.883322333614, 5845.736941837713, 5859.707014649336, 5635.802746903839, 5654.180143879197, 5662.943370566406, 5680.289963754531, 5769.9711501442225, 5746.396628353963, 5770.105633626795, 5794.420557944172, 5814.534837212928, 5829.329627092939, 5530.834074977757, 5657.349404818334, 5662.292213473316, 5684.7441865117, 5762.1644861494015], "value": 5426.591603450285, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.4437340153453, 613.6502193749562, 629.851984783576, 637.1398611873974, 654.2410803467978, 35205.29589408213, 36355.45466818, 36372.272554548894, 36399.0, 36408.27183456329, 38569.421458678145, 38943.221135577274, 39081.0, 39277.0, 39648.405273920915, 8331.458455200407, 8614.827703445928, 8619.353548483889, 8622.051574326819, 8626.870596941051, 8422.0, 8526.658933642648, 8565.743027709179, 8600.096989816073, 8631.136886311382, 8771.868421973644, 8778.648854045863, 8837.160469755363, 8839.513826739527, 8882.86675699865, 8692.608832602547, 8711.782205444852, 8778.166074222938, 8801.735947921541, 8814.64741410346, 8662.003869554956, 8796.956015219946, 8812.471251724917, 8821.558922053871, 8858.247049000842, 39177.60822391768, 39430.40854387187, 39608.207835843124, 39683.40474892879, 39730.20539589192, 3277.2953814929906, 3288.3752087103376, 3374.3757404880175, 3522.788632682047, 3775.377062784637, 26742.73257267422, 28108.859455702794, 28763.856180719173, 30023.0, 30127.397452051056, 3773.9056523586855, 3781.0, 3805.6384643458828, 3845.239510281688, 3912.2371137628174, 254033.0, 254821.0, 255125.0, 256920.0, 260201.0, 54131.45868541343, 54603.453965460634, 54687.0, 54958.0, 55226.72386638041, 63420.68289658522, 63948.36051639424, 64030.35969640244, 64328.0, 64758.35241647618, 15116.168610726516, 15183.089014659156, 15216.391344346324, 15218.46735364279, 15341.386344546094, 12294.75410491785, 12349.814752778535, 12365.505379784889, 12385.814212786816, 12400.131990760741, 18644.254229830654, 18731.250749969848, 18745.531361716065, 18773.249070037047, 18777.34279300218, 7140.0, 7298.124225093023, 7392.445566582528, 7397.519161254501, 7453.217412171643, 1047.5129064984667, 1063.9680809575725, 1125.2460851229696, 1130.9264897781618, 1176.3294921894437, 29759.363235022283, 29872.55191172134, 30151.849240753654, 30387.696123038928, 30697.386052279275, 1082.3722241100143, 1119.1885882734953, 1133.7845809296207, 1185.454690842205, 1251.3492983648453, 16269.0, 16281.430149944932, 16417.58956026085, 16445.91777041107, 16692.58268543296, 455332.0, 462975.0, 464315.0, 466994.65026748524, 467678.0, 54708.72645636746, 55038.724806375714, 55129.72435137879, 55238.447615524135, 55801.0, 1359.2795818216164, 1382.7511048011254, 1389.7984792205073, 1402.1797248609678, 1509.539590424931, 27776.0, 28335.0, 29191.562126567693, 30038.098857034325, 30317.0, 48341.0, 49598.25602616036, 49623.255651165986, 49665.751671241414, 49773.50226497689, 410389.0, 416354.0, 416916.0, 418142.0, 418365.0, 40742.59257407388, 41075.383869241385, 41144.588554114074, 41256.58743412527, 41570.0, 45236.0, 45967.540324596324, 46481.76759116183, 46518.06963860772, 46781.0, 39537.60462395339, 40064.0, 40187.0, 40210.79894600625, 40394.1921161581, 38465.0, 38843.22313553769, 38952.80523597364, 39005.41491877567, 39858.601413986646, 38523.42214866835, 39515.81452556428, 39529.0, 39675.0, 40181.0, 36949.81525092357, 38237.235255295294, 38489.42265865958, 38517.422238667, 38898.0, 29960.052596581154, 30451.0, 30604.693953060185, 31324.530132048494, 31463.05610831679], "value": 19524.426337810186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.8105087981448, 388.7881104797884, 392.80752431308656, 395.4404517607584, 403.620596639159, 16793.832061679394, 18477.815221847777, 18755.15601797919, 18961.14674839632, 19111.52221194471, 16324.77564182688, 16738.330466781346, 17012.0, 17145.399911003118, 17218.56953576158, 5403.135498320269, 5567.66594004359, 5574.944250557503, 5608.4391560844, 5624.268845050137, 4440.777961101948, 6255.530835187356, 6286.874262514747, 6296.779612713556, 6308.148399966015, 6002.609830361012, 6144.2319710036245, 6227.470664993481, 6233.688315584225, 6233.7818176363835, 6120.806442743667, 6176.289726681444, 6182.258129024501, 6186.752529898821, 6229.968850155743, 5225.555827754645, 5381.48875856793, 5388.757505912244, 5414.7834086636485, 5430.809921652763, 16829.747553786703, 16869.24088416024, 17857.910710446493, 21922.342329730134, 21987.890060549595, 2375.2043065573052, 2396.4488167721347, 2448.8408253463645, 2463.064035666453, 2606.2832721001687, 8548.0, 9146.954265228698, 9306.674266400643, 9376.249900007982, 14028.789568156486, 1819.0904547726136, 1860.6557786809483, 1887.9339223127124, 1922.5097600112022, 1960.2061165228106, 74733.25266747318, 76439.61780191175, 77509.22490775076, 77551.22448775497, 77966.0, 10542.789144217073, 10664.520096595672, 10726.0, 10729.302595331279, 10760.534378233102, 14713.190774507291, 14753.114813111248, 14795.408183672533, 14822.629434264014, 14841.40634374613, 7508.436867234979, 7616.314531692175, 7739.7678069658, 7828.452008359474, 7839.764807055797, 7252.746153884589, 7385.852282954418, 7469.589172595451, 7484.476086673881, 7494.5503269803985, 3462.671046250602, 4500.617447516997, 4539.0, 4562.475315338778, 4602.7468489233415, 1811.9818801811814, 1839.6136811269516, 1859.1447933950265, 1879.473747350744, 1935.9612807743765, 844.8310337932438, 882.9470231786113, 910.8087301666724, 911.8495448250965, 974.7952929884661, 16450.0, 17282.0, 17448.12759362027, 17761.822381776015, 17770.200340984688, 855.7475544714324, 875.3916028360355, 879.4811061473761, 888.8311220868014, 931.2224292715658, 9613.327067105376, 9626.32615716893, 9747.3664211826, 9835.360701554377, 9940.40357578533, 371307.0, 375608.0, 377997.0, 380244.0, 464981.0, 78423.60788196023, 84303.5784821072, 93617.0, 96718.0, 98630.0, 1040.6149724601946, 1044.3264094658903, 1082.1288862465633, 1084.5336505302637, 1089.4716062709579, 16667.833321667113, 17060.573485662957, 17170.39903603368, 17174.0, 17265.482035538953, 37072.0, 37616.0, 38955.610443895195, 39331.80334098311, 39828.0, 55196.17205741837, 55569.444305556426, 55713.164302534686, 55750.44249557453, 55765.16352254638, 7868.488548244346, 8057.798555035936, 8327.541985190872, 8334.291585215324, 8403.495790252604, 8507.319414446953, 9652.565634546321, 11110.722266939405, 13331.466741330627, 13656.774502564322, 9037.322200835095, 10878.531398261133, 11482.94258528702, 11765.176437649283, 11902.940485297519, 7712.9614351927885, 8920.776980575538, 11646.592369267035, 11952.0, 12033.278003319829, 11340.432978351215, 11457.541698331974, 11803.940980295043, 12025.338606376734, 12162.270263784201, 7737.690492380242, 7977.481463705073, 8258.504489730636, 8403.369747268856, 8612.48325100496, 11483.712907177387, 11540.94229528847, 11554.364509951698, 11622.6513204604, 11789.646310610695], "value": 8781.21827167195, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.6319356967188, 1468.2071681292102, 1604.4705247268403, 1751.964960700786, 1754.8859324143937, 7272.781816545512, 8052.677892884285, 8215.178482151781, 8280.378971577133, 8336.999560052802, 8186.426950113494, 8197.139300373465, 8256.711015114472, 8260.215279548449, 8265.793355166124, 2277.077783497682, 2306.08909480755, 2310.0, 2316.513532158249, 2321.338418550705, 2112.355731501891, 2131.179495894084, 2160.2547121243147, 2161.5676864627058, 2200.0759680934048, 2275.2150508074687, 2301.091069027733, 2307.8153747700226, 2309.3072078376504, 2324.174917904145, 2284.2119468783244, 2290.358699564125, 2293.5412917416584, 2294.609916314222, 2308.595995700746, 2253.1663284584642, 2266.1162146762777, 2271.5911135995516, 2277.134688818255, 2283.828712846543, 8220.465669731448, 8266.958665206696, 8296.377771667148, 8310.626021829032, 8386.412951093425, 4878.56092951636, 4975.104481193383, 4978.477259887696, 4983.327250821129, 5036.697798132123, 3202.4876019836947, 3222.081706713599, 3309.255417531036, 3336.4161271777343, 3340.5657264555693, 1069.6309773128257, 1074.312440038376, 1079.3416016230094, 1083.4582708645678, 1090.4929207918356, 11491.425428728613, 11506.654800356002, 11513.424328783527, 11523.308601483854, 11534.423278836024, 4358.3244597087505, 4493.5281795411665, 4628.236341003764, 4633.189191891405, 4634.0, 9553.665621703207, 9651.517424128766, 9683.951580242194, 9712.465814380135, 9750.122488976027, 4975.179095449283, 4988.127077761377, 5021.59827213822, 5027.120253955616, 5040.193569028937, 4165.583441655871, 4510.729356238636, 4636.721796692209, 4674.0885527322525, 4674.789634466457, 3819.1788765415567, 3860.2279544091293, 3916.5104361954754, 3916.6083391661177, 3941.3890846918775, 1281.0648226794306, 1304.9543265985644, 1310.6854354954742, 1315.1451556488169, 1317.124112465219, 991.2813210422386, 996.2329006664828, 1001.7946321004176, 1010.4543546484816, 1013.3767732844248, 5714.428557144335, 5913.113033044991, 5934.6142500737315, 5987.760489580455, 6138.846528836815, 418.91412260486527, 422.5478737750577, 422.7041071250137, 991.1723710701501, 1053.2732414633879, 4111.9177616447505, 4130.586941305845, 4167.854125105607, 4168.916621667549, 4169.124483858423, 9964.80070398588, 10179.898201017895, 10226.6420675276, 10286.177105831515, 10354.689359319233, 10025.19798416125, 10053.748656283506, 10073.59705611782, 10202.591896324213, 10218.744531386776, 7848.215178482106, 7904.525728456426, 7979.6035693753365, 7986.32116270112, 7994.760157195294, 5760.884782304414, 5825.50483208932, 5899.528037757055, 5979.850503737442, 6028.4272994065495, 9337.673181438617, 9445.386049906734, 9681.564329605326, 9687.17658998993, 9724.659636912675, 9868.0, 9982.750431239278, 10001.699949001542, 10115.544800483849, 10180.032896874785, 6469.417752402118, 6485.740570377321, 6761.797146085625, 7099.538529995741, 7192.31672991065, 8032.63853126599, 8071.87892181606, 8084.312833408991, 8105.878411823709, 8119.0, 7352.4485663576515, 7571.0, 7580.431467640059, 7666.731664391719, 7687.308142267223, 7329.267073292628, 7537.472376933562, 7550.395968322411, 7558.58427786477, 7596.696132154652, 6712.83217919556, 6773.221079575912, 6819.454443644596, 6827.761028363983, 6845.212800528003, 5094.083065048327, 5141.511556402136, 5170.767315470888, 5297.311349524537, 5364.9731751341, 5088.7201203932655, 5089.694618322913, 5093.592512598909, 5110.259012443249, 5255.579553635776], "value": 4457.382483834664, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.9168216263771, 320.0925376557458, 325.08974870362977, 330.66107240078924, 331.80091944833106, 5953.613015154017, 6032.788852390167, 6070.180525629039, 6073.726682299296, 6115.480184184344, 5915.970420147904, 5923.61496502727, 5970.313413957396, 5984.581079324449, 5986.161937328778, 4294.269974104402, 4441.511433742286, 4600.539946005406, 4603.8158473661015, 4625.213713668668, 4590.74750888701, 4605.240135377659, 4618.8152473901, 4620.260758278676, 4642.512536183703, 4539.931901021488, 4563.315502674593, 4570.177368073745, 4570.611498022656, 4586.587207151356, 4277.016286254164, 4456.621187199092, 4514.277715565494, 4519.790948426621, 4533.818647254106, 3905.3165696003084, 3910.3156947534353, 3912.550056743454, 3916.74541154824, 3923.6468717815246, 5705.486506214419, 5715.628484148517, 5732.770689172428, 5778.7399567019165, 5798.304203495565, 5083.79664813407, 5243.842684719464, 5250.553702935255, 5276.366835979668, 5284.180951952453, 6237.376262373772, 6248.562600617958, 6259.935810912156, 6265.154204182422, 6297.401746834089, 4180.99656082538, 4311.28863737483, 4323.610875021232, 4332.1985432695055, 4345.500802223228, 6531.346865313478, 6559.508036897204, 6580.506462015368, 6617.305182955816, 6620.801375958729, 4446.5553444655925, 4449.532799056117, 4450.065486247924, 4463.933041004388, 4466.843660471868, 4407.427034485497, 4515.435570553681, 4517.186906356887, 4521.502634710179, 4526.275795872644, 5178.663386879841, 5214.765335559909, 5216.426193118754, 5249.160134378558, 5249.370075590953, 6308.463780578702, 6340.207474065742, 6359.523035772336, 6360.7137678804565, 6387.648679322682, 1474.3586539855198, 1549.8217704963847, 1556.813182418117, 1566.3812793946327, 1571.5521076493374, 944.2351695126832, 1011.9747006324901, 1014.8224060789332, 1034.3173505486343, 1049.3546468921559, 5999.280086389661, 6031.9396806032255, 6035.185249991283, 6037.637741735422, 6086.969565152146, 6383.553151279459, 6425.775097871646, 6462.48300135988, 6487.124238227779, 6488.772892948724, 5977.3126090500145, 6014.8195554133445, 6039.607425517327, 6048.637081775108, 6085.148079268906, 3424.434968230214, 3480.2517458746493, 3495.1961048958883, 3498.9825050874583, 3507.2108775525303, 6520.47836173105, 6686.4985126115735, 6850.040994260808, 6861.245263021064, 6911.17065952089, 6748.325167483213, 6776.898346524806, 6779.15260592426, 6830.248672646005, 6841.315868413119, 6757.628330441775, 6823.509419062007, 6830.521863469608, 6867.896981545181, 6910.723571057101, 6577.375149360803, 6585.341465853377, 6612.570182938093, 6628.270890201978, 6635.435987940886, 6408.647524386203, 6440.645764482811, 6470.741170353133, 6548.770793022221, 6598.90101648466, 6840.179178498413, 6869.484788640972, 6881.759138430131, 6882.933145362477, 6903.240643529308, 4397.978010109929, 4401.493828209796, 4412.3160910059, 4428.582853486853, 4436.733795972252, 6369.808905732835, 6458.257300410513, 6491.188601424822, 6563.638999854863, 6586.242582103119, 6392.808215753535, 6404.231492220963, 6419.165508483868, 6420.165378500765, 6422.807315780534, 6234.625922444668, 6351.491880649629, 6376.139221205263, 6413.935860641333, 6467.159269294962, 6037.913175628253, 6263.530235232467, 6282.591631544118, 6295.307516173309, 6322.494200464043, 6392.4246817786625, 6435.356464353715, 6456.677166141768, 6467.902981455376, 6479.704059188087, 5993.250843644544, 6216.564840461125, 6221.96889015552, 6233.719482623203, 6271.560990730605], "value": 4754.952495307815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.6893304811979, 753.6156560154319, 758.5107605594392, 761.9923800761992, 766.743141047749, 12575.308358040304, 12636.494540218404, 13791.65520861979, 14034.578962631125, 14716.926415367934, 14054.227017514033, 14098.859011409882, 14109.788353174685, 14132.929335353308, 14138.151710897328, 794.7019867549683, 801.1187693537121, 805.6092794994423, 805.9838803223932, 807.2855522862279, 778.4861991085885, 807.9474834135792, 810.9594520273993, 811.2941740685612, 811.6550466051934, 827.7103013945132, 835.2065537739172, 836.0844874862047, 836.4019725895984, 839.7648658375665, 829.179112678447, 829.5893532701291, 830.4021104804531, 834.9791255218607, 839.2111415269658, 610.3073012131218, 618.1593033474516, 618.3816183816184, 620.3393386043894, 621.9346968568326, 13008.934955325258, 13138.343082845819, 13138.605841824665, 13144.474221031147, 13154.4080516377, 11893.4647940842, 11994.0, 12153.149279550435, 12311.569095081719, 12354.073444491609, 11008.174386920933, 11035.227534072617, 11112.944435277852, 11168.760375628748, 11343.0, 3718.219173973469, 3771.9245615087543, 3802.315583195024, 3856.2094770571966, 3952.940705889414, 51944.74027629838, 52012.73993630045, 52248.47751522474, 52477.21284180702, 53147.20279195815, 10110.292279540508, 10140.898591013995, 10194.847077293847, 10206.285560010729, 10423.791524169474, 17223.56941076483, 17250.913745431193, 17308.278720075243, 17414.651706966044, 17763.378281760077, 7470.402367810562, 7557.470977031665, 7623.885641715267, 7657.244324522707, 7805.297523222937, 4438.068005718836, 4570.318693515163, 4605.424321959755, 4607.9308810367875, 4661.650376221729, 3127.7654175936896, 3165.0, 3167.224030112591, 3193.808371497671, 3198.4242836289227, 563.4196777319368, 566.1083793025919, 568.2953138108716, 568.934572524165, 573.0744847071949, 680.6358598149966, 680.8229860236374, 684.4729558240226, 685.8833998220315, 692.1175501235964, 8418.0, 8656.48061116335, 8696.478211307342, 8886.86669699955, 8897.11028897118, 526.0557299647143, 591.9112133179972, 595.9987221467975, 604.7611193578512, 676.6582875647865, 4181.832726690898, 4273.914521709548, 4333.956660433355, 4412.139632771643, 4438.289873620205, 67898.32101679019, 68409.65795170992, 69040.65479672569, 69239.0, 69599.65200173967, 57519.0, 59681.0, 59694.40305596975, 59706.0, 59794.0, 43055.35416968748, 43778.562214378086, 43792.12415751731, 44008.3398749019, 55817.44182558123, 8066.0, 8491.19333663301, 8588.484690918565, 8802.251808596086, 8826.646934122564, 31415.685843141277, 33167.66832331646, 33491.4976275361, 33847.66152338445, 34187.658123419445, 42691.0, 43828.34257486076, 44122.11755764931, 44131.690123240245, 44374.3343849849, 11357.54569817198, 11495.137864660352, 11529.1929564933, 11699.649010529698, 11806.114541409257, 12568.308743018855, 12795.360231988177, 12971.481140754642, 13000.414981325674, 13314.201147930768, 11650.88349116498, 11747.647570572897, 11812.0, 11899.0, 11971.461284242405, 11822.40887955616, 12128.818067728815, 12350.38248087574, 12405.503779848705, 12458.470933389091, 11419.771604567695, 11731.993633107704, 11884.34636095023, 11885.108616853599, 12265.202761820454, 10134.341267817568, 10151.54318055704, 10463.267571269938, 10473.738156546147, 10596.576136954436, 10033.548490318099, 10170.440625765654, 10218.693439196835, 10227.386356818615, 10240.231982601186], "value": 6471.289516145097, "unit": "score"}], "name": "dromaeo_css", "value": 7095.552940379558, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 112.0, 113.0, 112.0, 124.0, 112.0, 110.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 127.0, 156.0, 188.0, 131.0, 157.0, 159.0, 129.0, 189.0, 129.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 163.0, 165.0, 176.0, 170.0, 163.0, 165.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 169.0, 77.0, 76.0, 78.0, 77.0, 154.0, 78.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 146.0, 94.0, 93.0, 93.0, 143.0, 92.0, 93.0, 161.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 121.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 150.0, 149.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 57.0, 66.0, 62.0, 64.0, 76.0, 56.0, 55.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 87.0, 78.0, 79.0, 78.0, 85.0, 77.0, 80.0, 80.0, 78.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 124.0, 121.0, 134.0, 129.0, 125.0, 126.0, 127.0, 174.0, 138.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 166.0, 167.0, 181.0, 173.0, 172.0, 164.0, 164.0, 162.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 68.0, 75.0, 69.0, 71.0, 67.0, 67.0, 76.0, 69.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1571.3000000000004, "alertThreshold": 2.0}]} 00:53:53 INFO - Return code: 0 00:53:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:53:53 ERROR - # TBPL SUCCESS # 00:53:53 INFO - Running post-action listener: _resource_record_post_action 00:53:53 INFO - Running post-run listener: _resource_record_post_run 00:53:54 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 12288; Write bytes: 536428544; Read time: 232; Write time: 475824 00:53:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 244400128; Read time: 88; Write time: 268780 00:53:55 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292028416; Read time: 144; Write time: 207044 00:53:55 INFO - Running post-run listener: _upload_blobber_files 00:53:55 INFO - Blob upload gear active. 00:53:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:53:55 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 00:53:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:53:55 INFO - (blobuploader) - INFO - Open directory for files ... 00:53:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:53:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:53:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:53:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:53:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:53:56 INFO - (blobuploader) - INFO - Done attempting. 00:53:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:53:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:53:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:53:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:53:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:53:57 INFO - (blobuploader) - INFO - Done attempting. 00:53:57 INFO - (blobuploader) - INFO - Iteration through files over. 00:53:57 INFO - Return code: 0 00:53:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:53:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:53:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e735c4aebf4504d07904214caa6cc345af7468aaed0d10b23e907d669321e3c886dd5187c8cb541504eccdf6e87c9c0339f75f1ae2980fe288f0158256aa360a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f79004f4080bea114544aa4533b8467075364ddf9e7c0163f26d6aef3e9ef493f6d482be98f2e4c9cb38cd8b92c0279b8e16efb294cf4c4477478708fc8c8adf"} 00:53:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:53:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:53:57 INFO - Contents: 00:53:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e735c4aebf4504d07904214caa6cc345af7468aaed0d10b23e907d669321e3c886dd5187c8cb541504eccdf6e87c9c0339f75f1ae2980fe288f0158256aa360a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f79004f4080bea114544aa4533b8467075364ddf9e7c0163f26d6aef3e9ef493f6d482be98f2e4c9cb38cd8b92c0279b8e16efb294cf4c4477478708fc8c8adf"} 00:53:57 INFO - Running post-run listener: copy_logs_to_upload_dir 00:53:57 INFO - Copying logs to upload dir... 00:53:57 INFO - mkdir: /builds/slave/test/build/upload/logs 00:53:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.030737 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-22 00:53:56.737877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 00:53:56.742410) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978 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/sha512/e735c4aebf4504d07904214caa6cc345af7468aaed0d10b23e907d669321e3c886dd5187c8cb541504eccdf6e87c9c0339f75f1ae2980fe288f0158256aa360a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f79004f4080bea114544aa4533b8467075364ddf9e7c0163f26d6aef3e9ef493f6d482be98f2e4c9cb38cd8b92c0279b8e16efb294cf4c4477478708fc8c8adf"} build_url:https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/K2BjGW3ZQoWCVyOoZwRsag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e735c4aebf4504d07904214caa6cc345af7468aaed0d10b23e907d669321e3c886dd5187c8cb541504eccdf6e87c9c0339f75f1ae2980fe288f0158256aa360a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f79004f4080bea114544aa4533b8467075364ddf9e7c0163f26d6aef3e9ef493f6d482be98f2e4c9cb38cd8b92c0279b8e16efb294cf4c4477478708fc8c8adf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 00:53:56.770590) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:53:56.770940) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1461307921.770970-1032543978 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 00:53:56.854010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 00:53:56.854345) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 00:53:56.854661) ========= ========= Total master_lag: 0.18 =========