builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1460667618.03 results: success (0) buildid: 20160414113023 builduid: 217139d6c37f45b3a8cb45b7f1ca307b revision: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.027764) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.028371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.028782) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.046359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.046996) ========= 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=8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 14:00:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-14 14:00:18 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124011 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.185209) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.185548) ========= 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=8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022724 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.235238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.235652) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1bce3f1720e66a9cdc1a1699d3fd24a598641969 --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 1bce3f1720e66a9cdc1a1699d3fd24a598641969 --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=8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 14:00:18,466 truncating revision to first 12 chars 2016-04-14 14:00:18,466 Setting DEBUG logging. 2016-04-14 14:00:18,466 attempt 1/10 2016-04-14 14:00:18,467 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1bce3f1720e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 14:00:18,729 unpacking tar archive at: fx-team-1bce3f1720e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522174 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.770943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.771266) ========= script_repo_revision: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.771807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.772095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 14:00:18.781635) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-14 14:00:18.782124) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:00:19 INFO - MultiFileLogger online at 20160414 14:00:19 in /builds/slave/test 14:00:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:00:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:00:19 INFO - {'append_to_log': False, 14:00:19 INFO - 'base_work_dir': '/builds/slave/test', 14:00:19 INFO - 'blob_upload_branch': 'Fx-Team', 14:00:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:00:19 INFO - 'branch': 'Fx-Team', 14:00:19 INFO - 'buildbot_json_path': 'buildprops.json', 14:00:19 INFO - 'config_files': ('talos/linux_config.py',), 14:00:19 INFO - 'default_actions': ('clobber', 14:00:19 INFO - 'read-buildbot-config', 14:00:19 INFO - 'download-and-extract', 14:00:19 INFO - 'populate-webroot', 14:00:19 INFO - 'create-virtualenv', 14:00:19 INFO - 'install', 14:00:19 INFO - 'run-tests'), 14:00:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:00:19 INFO - 'download_minidump_stackwalk': True, 14:00:19 INFO - 'download_symbols': 'ondemand', 14:00:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:00:19 INFO - 'tooltool.py': '/tools/tooltool.py', 14:00:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:00:19 INFO - '/tools/misc-python/virtualenv.py')}, 14:00:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:00:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:00:19 INFO - 'installer_path': 'installer.exe', 14:00:19 INFO - 'log_level': 'info', 14:00:19 INFO - 'log_name': 'talos', 14:00:19 INFO - 'log_to_console': True, 14:00:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:00:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:00:19 INFO - 'opt_config_files': (), 14:00:19 INFO - 'pip_index': False, 14:00:19 INFO - 'sps_profile': False, 14:00:19 INFO - 'sps_profile_interval': 0, 14:00:19 INFO - 'suite': 'dromaeojs', 14:00:19 INFO - 'system_bits': '32', 14:00:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:00:19 INFO - 'title': 'talos-linux64-ix-038', 14:00:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:00:19 INFO - 'use_talos_json': True, 14:00:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:00:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:00:19 INFO - 'work_dir': 'build'} 14:00:19 INFO - ##### 14:00:19 INFO - ##### Running clobber step. 14:00:19 INFO - ##### 14:00:19 INFO - Running pre-action listener: _resource_record_pre_action 14:00:19 INFO - Running main action method: clobber 14:00:19 INFO - rmtree: /builds/slave/test/build 14:00:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:00:20 INFO - Running post-action listener: _resource_record_post_action 14:00:20 INFO - ##### 14:00:20 INFO - ##### Running read-buildbot-config step. 14:00:20 INFO - ##### 14:00:20 INFO - Running pre-action listener: _resource_record_pre_action 14:00:20 INFO - Running main action method: read_buildbot_config 14:00:20 INFO - Using buildbot properties: 14:00:20 INFO - { 14:00:20 INFO - "project": "", 14:00:20 INFO - "product": "firefox", 14:00:20 INFO - "script_repo_revision": "production", 14:00:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:00:20 INFO - "repository": "", 14:00:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:00:20 INFO - "buildid": "20160414113023", 14:00:20 INFO - "pgo_build": "True", 14:00:20 INFO - "basedir": "/builds/slave/test", 14:00:20 INFO - "buildnumber": 25, 14:00:20 INFO - "slavename": "talos-linux64-ix-038", 14:00:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:00:20 INFO - "platform": "ubuntu64_hw", 14:00:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:00:20 INFO - "branch": "fx-team", 14:00:20 INFO - "repo_path": "integration/fx-team", 14:00:20 INFO - "revision": "1bce3f1720e66a9cdc1a1699d3fd24a598641969", 14:00:20 INFO - "stage_platform": "linux64-pgo", 14:00:20 INFO - "builduid": "217139d6c37f45b3a8cb45b7f1ca307b", 14:00:20 INFO - "slavebuilddir": "test" 14:00:20 INFO - } 14:00:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:00:20 INFO - Running post-action listener: _resource_record_post_action 14:00:20 INFO - ##### 14:00:20 INFO - ##### Running download-and-extract step. 14:00:20 INFO - ##### 14:00:20 INFO - Running pre-action listener: _resource_record_pre_action 14:00:20 INFO - Running main action method: download_and_extract 14:00:20 INFO - mkdir: /builds/slave/test/build/tests 14:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:20 INFO - https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:22 INFO - Downloaded 1361 bytes. 14:00:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:00:22 INFO - Using the following test package requirements: 14:00:22 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:00:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:00:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:22 INFO - u'jsshell-linux-x86_64.zip'], 14:00:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:00:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:00:22 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:00:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:00:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:00:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:22 INFO - https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:45 INFO - Downloaded 23774556 bytes. 14:00:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:00:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:00:46 INFO - Return code: 0 14:00:46 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 14:00: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')]} 14:00:46 INFO - https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:00:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:51 INFO - Downloaded 23774556 bytes. 14:00:51 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'] 14:00:51 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 14:00:52 INFO - Return code: 0 14:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:52 INFO - https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:00:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:00:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:00:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:54 INFO - Downloaded 10841076 bytes. 14:00:54 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'] 14:00:54 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 14:00:54 INFO - Return code: 0 14:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:54 INFO - https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:00:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:00:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:00:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LZj-7sJkSWOU5MyUvPR6og/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 14:00:56 INFO - Downloaded 58153627 bytes. 14:00:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:00:56 INFO - mkdir: /builds/slave/test/properties 14:00:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:00:56 INFO - Writing to file /builds/slave/test/properties/build_url 14:00:56 INFO - Contents: 14:00:56 INFO - build_url:https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:00:57 INFO - Running post-action listener: _resource_record_post_action 14:00:57 INFO - Running post-action listener: set_extra_try_arguments 14:00:57 INFO - ##### 14:00:57 INFO - ##### Running populate-webroot step. 14:00:57 INFO - ##### 14:00:57 INFO - Running pre-action listener: _resource_record_pre_action 14:00:57 INFO - Running main action method: populate_webroot 14:00:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:00:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:00:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:00:57 INFO - '--tppagecycles', 14:00:57 INFO - '7'], 14:00:57 INFO - 'tests': ['tsvgm']}}, 14:00:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:00:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:00:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:00:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:00:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:00:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:00:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:57 INFO - 'talos_options': ['--disable-e10s'], 14:00:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:57 INFO - 'talos_options': ['--disable-e10s'], 14:00:57 INFO - 'tests': ['damp', 'tps']}, 14:00:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:57 INFO - 'tests': ['damp', 'tps']}, 14:00:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:00:57 INFO - 'tests': ['dromaeo_dom']}, 14:00:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:00:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:00:57 INFO - 'tests': ['a11yr', 14:00:57 INFO - 'ts_paint', 14:00:57 INFO - 'tpaint', 14:00:57 INFO - 'sessionrestore', 14:00:57 INFO - 'sessionrestore_no_auto_restore', 14:00:57 INFO - 'tabpaint']}, 14:00:57 INFO - 'other-e10s': {'tests': ['a11yr', 14:00:57 INFO - 'ts_paint', 14:00:57 INFO - 'tpaint', 14:00:57 INFO - 'sessionrestore', 14:00:57 INFO - 'sessionrestore_no_auto_restore', 14:00:57 INFO - 'tabpaint']}, 14:00:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:00:57 INFO - 'ts_paint', 14:00:57 INFO - 'tpaint', 14:00:57 INFO - 'sessionrestore', 14:00:57 INFO - 'sessionrestore_no_auto_restore', 14:00:57 INFO - 'tabpaint']}, 14:00:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:00:57 INFO - 'ts_paint', 14:00:57 INFO - 'tpaint', 14:00:57 INFO - 'sessionrestore', 14:00:57 INFO - 'sessionrestore_no_auto_restore', 14:00:57 INFO - 'tabpaint']}, 14:00:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:00:57 INFO - 'tests': ['a11yr', 14:00:57 INFO - 'ts_paint', 14:00:57 INFO - 'tpaint', 14:00:57 INFO - 'sessionrestore', 14:00:57 INFO - 'sessionrestore_no_auto_restore', 14:00:57 INFO - 'tabpaint']}, 14:00:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:00:57 INFO - 'tests': ['a11yr', 14:00:57 INFO - 'ts_paint', 14:00:57 INFO - 'tpaint', 14:00:57 INFO - 'sessionrestore', 14:00:57 INFO - 'sessionrestore_no_auto_restore', 14:00:57 INFO - 'tabpaint']}, 14:00:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:00:57 INFO - 'tests': ['tsvgx', 14:00:57 INFO - 'tsvgr_opacity', 14:00:57 INFO - 'tart', 14:00:57 INFO - 'tscrollx', 14:00:57 INFO - 'cart']}, 14:00:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:00:57 INFO - 'tsvgr_opacity', 14:00:57 INFO - 'tart', 14:00:57 INFO - 'tscrollx', 14:00:57 INFO - 'cart']}, 14:00:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:57 INFO - 'talos_options': ['--disable-e10s'], 14:00:57 INFO - 'tests': ['tp5o']}, 14:00:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:57 INFO - 'tests': ['tp5o']}, 14:00:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:57 INFO - 'talos_options': ['--disable-e10s', 14:00:57 INFO - '--xperf_path', 14:00:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:57 INFO - 'tests': ['tp5n']}, 14:00:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:57 INFO - 'talos_options': ['--xperf_path', 14:00:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:57 INFO - 'tests': ['tp5n']}}, 14:00:57 INFO - 'talos.zip': {'path': '', 14:00:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:00:57 INFO - Running post-action listener: _resource_record_post_action 14:00:57 INFO - ##### 14:00:57 INFO - ##### Running create-virtualenv step. 14:00:57 INFO - ##### 14:00:57 INFO - Running pre-action listener: _resource_record_pre_action 14:00:57 INFO - Running main action method: create_virtualenv 14:00:57 INFO - Creating virtualenv /builds/slave/test/build/venv 14:00:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:00:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:00:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:00:57 INFO - Using real prefix '/usr' 14:00:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:00:58 INFO - Installing distribute.............................................................................................................................................................................................done. 14:01:00 INFO - Installing pip.................done. 14:01:00 INFO - Return code: 0 14:01:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f46fe884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009810>, '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 0x100a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aba0>, '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': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:01:00 INFO - Using env: {'DISPLAY': ':0', 14:01:00 INFO - 'HOME': '/home/cltbld', 14:01:00 INFO - 'LANG': 'en_US.UTF-8', 14:01:00 INFO - 'LANGUAGE': 'en_US:en', 14:01:00 INFO - 'LOGNAME': 'cltbld', 14:01:00 INFO - 'MAIL': '/var/mail/cltbld', 14:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:00 INFO - 'MOZ_NO_REMOTE': '1', 14:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:00 INFO - 'NO_EM_RESTART': '1', 14:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:00 INFO - 'PWD': '/builds/slave/test', 14:01:00 INFO - 'SHELL': '/bin/bash', 14:01:00 INFO - 'SHLVL': '1', 14:01:00 INFO - 'TERM': 'linux', 14:01:00 INFO - 'TMOUT': '86400', 14:01:00 INFO - 'USER': 'cltbld', 14:01:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 14:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:00 INFO - '_': '/tools/buildbot/bin/python'} 14:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:01:00 INFO - Cleaning up... 14:01:00 INFO - Return code: 0 14:01:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f46fe884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009810>, '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 0x100a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aba0>, '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': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:01:00 INFO - Using env: {'DISPLAY': ':0', 14:01:00 INFO - 'HOME': '/home/cltbld', 14:01:00 INFO - 'LANG': 'en_US.UTF-8', 14:01:00 INFO - 'LANGUAGE': 'en_US:en', 14:01:00 INFO - 'LOGNAME': 'cltbld', 14:01:00 INFO - 'MAIL': '/var/mail/cltbld', 14:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:00 INFO - 'MOZ_NO_REMOTE': '1', 14:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:00 INFO - 'NO_EM_RESTART': '1', 14:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:00 INFO - 'PWD': '/builds/slave/test', 14:01:00 INFO - 'SHELL': '/bin/bash', 14:01:00 INFO - 'SHLVL': '1', 14:01:00 INFO - 'TERM': 'linux', 14:01:00 INFO - 'TMOUT': '86400', 14:01:00 INFO - 'USER': 'cltbld', 14:01:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 14:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:00 INFO - '_': '/tools/buildbot/bin/python'} 14:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:00 INFO - Downloading/unpacking psutil>=0.7.1 14:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:01:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:02 INFO - Installing collected packages: psutil 14:01:02 INFO - Running setup.py install for psutil 14:01:03 INFO - building 'psutil._psutil_linux' extension 14:01:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:01:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:01:03 INFO - building 'psutil._psutil_posix' extension 14:01:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:01:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:01:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:03 INFO - Successfully installed psutil 14:01:03 INFO - Cleaning up... 14:01:03 INFO - Return code: 0 14:01:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:03 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 0x7f46fe884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009810>, '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 0x100a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aba0>, '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': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:01:03 INFO - Using env: {'DISPLAY': ':0', 14:01:03 INFO - 'HOME': '/home/cltbld', 14:01:03 INFO - 'LANG': 'en_US.UTF-8', 14:01:03 INFO - 'LANGUAGE': 'en_US:en', 14:01:03 INFO - 'LOGNAME': 'cltbld', 14:01:03 INFO - 'MAIL': '/var/mail/cltbld', 14:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:03 INFO - 'MOZ_NO_REMOTE': '1', 14:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:03 INFO - 'NO_EM_RESTART': '1', 14:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:03 INFO - 'PWD': '/builds/slave/test', 14:01:03 INFO - 'SHELL': '/bin/bash', 14:01:03 INFO - 'SHLVL': '1', 14:01:03 INFO - 'TERM': 'linux', 14:01:03 INFO - 'TMOUT': '86400', 14:01:03 INFO - 'USER': 'cltbld', 14:01:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 14:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:03 INFO - '_': '/tools/buildbot/bin/python'} 14:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:01:05 INFO - Installing collected packages: mozsystemmonitor 14:01:05 INFO - Running setup.py install for mozsystemmonitor 14:01:05 INFO - Successfully installed mozsystemmonitor 14:01:05 INFO - Cleaning up... 14:01:05 INFO - Return code: 0 14:01:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f46fe884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009810>, '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 0x100a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aba0>, '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': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:01:05 INFO - Using env: {'DISPLAY': ':0', 14:01:05 INFO - 'HOME': '/home/cltbld', 14:01:05 INFO - 'LANG': 'en_US.UTF-8', 14:01:05 INFO - 'LANGUAGE': 'en_US:en', 14:01:05 INFO - 'LOGNAME': 'cltbld', 14:01:05 INFO - 'MAIL': '/var/mail/cltbld', 14:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:05 INFO - 'MOZ_NO_REMOTE': '1', 14:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:05 INFO - 'NO_EM_RESTART': '1', 14:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:05 INFO - 'PWD': '/builds/slave/test', 14:01:05 INFO - 'SHELL': '/bin/bash', 14:01:05 INFO - 'SHLVL': '1', 14:01:05 INFO - 'TERM': 'linux', 14:01:05 INFO - 'TMOUT': '86400', 14:01:05 INFO - 'USER': 'cltbld', 14:01:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 14:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:05 INFO - '_': '/tools/buildbot/bin/python'} 14:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:07 INFO - Downloading blobuploader-1.2.4.tar.gz 14:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:01:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:01:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:08 INFO - Downloading docopt-0.6.1.tar.gz 14:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:01:08 INFO - Installing collected packages: blobuploader, requests, docopt 14:01:08 INFO - Running setup.py install for blobuploader 14:01:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:01:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:01:08 INFO - Running setup.py install for requests 14:01:09 INFO - Running setup.py install for docopt 14:01:09 INFO - Successfully installed blobuploader requests docopt 14:01:09 INFO - Cleaning up... 14:01:09 INFO - Return code: 0 14:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:09 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 0x7f46fe884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009810>, '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 0x100a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aba0>, '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': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:01:09 INFO - Using env: {'DISPLAY': ':0', 14:01:09 INFO - 'HOME': '/home/cltbld', 14:01:09 INFO - 'LANG': 'en_US.UTF-8', 14:01:09 INFO - 'LANGUAGE': 'en_US:en', 14:01:09 INFO - 'LOGNAME': 'cltbld', 14:01:09 INFO - 'MAIL': '/var/mail/cltbld', 14:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:09 INFO - 'MOZ_NO_REMOTE': '1', 14:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:09 INFO - 'NO_EM_RESTART': '1', 14:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:09 INFO - 'PWD': '/builds/slave/test', 14:01:09 INFO - 'SHELL': '/bin/bash', 14:01:09 INFO - 'SHLVL': '1', 14:01:09 INFO - 'TERM': 'linux', 14:01:09 INFO - 'TMOUT': '86400', 14:01:09 INFO - 'USER': 'cltbld', 14:01:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 14:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:09 INFO - '_': '/tools/buildbot/bin/python'} 14:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:01:09 INFO - Running setup.py (path:/tmp/pip-ZQ3y_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:01:09 INFO - Running setup.py (path:/tmp/pip-xZfHXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:01:09 INFO - Running setup.py (path:/tmp/pip-YUssWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:01:09 INFO - Running setup.py (path:/tmp/pip-nuW7VF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:01:09 INFO - Running setup.py (path:/tmp/pip-MBcH3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:01:09 INFO - Running setup.py (path:/tmp/pip-W0uFix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:01:09 INFO - Running setup.py (path:/tmp/pip-paTsT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:01:09 INFO - Running setup.py (path:/tmp/pip-G91PQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:01:10 INFO - Running setup.py (path:/tmp/pip-tUv_uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:01:10 INFO - Running setup.py (path:/tmp/pip-fkL_FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:01:10 INFO - Running setup.py (path:/tmp/pip-EJXV3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:01:10 INFO - Running setup.py (path:/tmp/pip-_v0LxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:01:10 INFO - Running setup.py (path:/tmp/pip-W03GNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:01:10 INFO - Running setup.py (path:/tmp/pip-shK4Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:10 INFO - Running setup.py (path:/tmp/pip-0umjH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:01:10 INFO - Running setup.py (path:/tmp/pip-cYSZ21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:01:10 INFO - Running setup.py (path:/tmp/pip-dvRgZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:01:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:01:10 INFO - Running setup.py install for manifestparser 14:01:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:01:10 INFO - Running setup.py install for mozcrash 14:01:10 INFO - Running setup.py install for mozdebug 14:01:10 INFO - Running setup.py install for mozdevice 14:01:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:01:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:01:11 INFO - Running setup.py install for mozfile 14:01:11 INFO - Running setup.py install for mozhttpd 14:01:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:01:11 INFO - Running setup.py install for mozinfo 14:01:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:01:11 INFO - Running setup.py install for mozInstall 14:01:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:01:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:01:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:01:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:01:11 INFO - Running setup.py install for mozleak 14:01:11 INFO - Running setup.py install for mozlog 14:01:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:01:11 INFO - Running setup.py install for moznetwork 14:01:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:01:11 INFO - Running setup.py install for mozprocess 14:01:11 INFO - Running setup.py install for mozprofile 14:01:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:01:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:01:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:01:12 INFO - Running setup.py install for mozrunner 14:01:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:01:12 INFO - Running setup.py install for mozscreenshot 14:01:12 INFO - Running setup.py install for moztest 14:01:12 INFO - Running setup.py install for mozversion 14:01:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:01:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:01:12 INFO - Cleaning up... 14:01:12 INFO - Return code: 0 14:01:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:12 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 0x7f46fe884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009810>, '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 0x100a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aba0>, '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': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:01:12 INFO - Using env: {'DISPLAY': ':0', 14:01:12 INFO - 'HOME': '/home/cltbld', 14:01:12 INFO - 'LANG': 'en_US.UTF-8', 14:01:12 INFO - 'LANGUAGE': 'en_US:en', 14:01:12 INFO - 'LOGNAME': 'cltbld', 14:01:12 INFO - 'MAIL': '/var/mail/cltbld', 14:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:12 INFO - 'MOZ_NO_REMOTE': '1', 14:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:12 INFO - 'NO_EM_RESTART': '1', 14:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:12 INFO - 'PWD': '/builds/slave/test', 14:01:12 INFO - 'SHELL': '/bin/bash', 14:01:12 INFO - 'SHLVL': '1', 14:01:12 INFO - 'TERM': 'linux', 14:01:12 INFO - 'TMOUT': '86400', 14:01:12 INFO - 'USER': 'cltbld', 14:01:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 14:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:12 INFO - '_': '/tools/buildbot/bin/python'} 14:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:01:12 INFO - Running setup.py (path:/tmp/pip-CdSzvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:01:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:01:12 INFO - Running setup.py (path:/tmp/pip-TVCRAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:01:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:01:12 INFO - Running setup.py (path:/tmp/pip-dTp1Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:01:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:01:12 INFO - Running setup.py (path:/tmp/pip-ns9mP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:01:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:01:12 INFO - Running setup.py (path:/tmp/pip-rJTwa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:01:13 INFO - Running setup.py (path:/tmp/pip-XdSG6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:01:13 INFO - Running setup.py (path:/tmp/pip-IxiRtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:01:13 INFO - Running setup.py (path:/tmp/pip-8_u3up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:01:13 INFO - Running setup.py (path:/tmp/pip-hnxL1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:01:13 INFO - Running setup.py (path:/tmp/pip-LL_rCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:01:13 INFO - Running setup.py (path:/tmp/pip-S1wWHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:01:13 INFO - Running setup.py (path:/tmp/pip-sglGNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:01:13 INFO - Running setup.py (path:/tmp/pip-WUOf3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:01:13 INFO - Running setup.py (path:/tmp/pip-4UP2WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:13 INFO - Running setup.py (path:/tmp/pip-oT9z5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:01:13 INFO - Running setup.py (path:/tmp/pip-JkCMTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:01:13 INFO - Running setup.py (path:/tmp/pip-_BtIjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:01:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:01:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:15 INFO - Downloading blessings-1.6.tar.gz 14:01:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:01:15 INFO - Installing collected packages: blessings 14:01:15 INFO - Running setup.py install for blessings 14:01:15 INFO - Successfully installed blessings 14:01:15 INFO - Cleaning up... 14:01:16 INFO - Return code: 0 14:01:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:01:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:01:16 INFO - Reading from file tmpfile_stdout 14:01:16 INFO - Current package versions: 14:01:16 INFO - argparse == 1.2.1 14:01:16 INFO - blessings == 1.6 14:01:16 INFO - blobuploader == 1.2.4 14:01:16 INFO - docopt == 0.6.1 14:01:16 INFO - manifestparser == 1.1 14:01:16 INFO - mozInstall == 1.12 14:01:16 INFO - mozcrash == 0.17 14:01:16 INFO - mozdebug == 0.1 14:01:16 INFO - mozdevice == 0.48 14:01:16 INFO - mozfile == 1.2 14:01:16 INFO - mozhttpd == 0.7 14:01:16 INFO - mozinfo == 0.9 14:01:16 INFO - mozleak == 0.1 14:01:16 INFO - mozlog == 3.1 14:01:16 INFO - moznetwork == 0.27 14:01:16 INFO - mozprocess == 0.22 14:01:16 INFO - mozprofile == 0.28 14:01:16 INFO - mozrunner == 6.11 14:01:16 INFO - mozscreenshot == 0.1 14:01:16 INFO - mozsystemmonitor == 0.0 14:01:16 INFO - moztest == 0.7 14:01:16 INFO - mozversion == 1.4 14:01:16 INFO - psutil == 3.1.1 14:01:16 INFO - requests == 1.2.3 14:01:16 INFO - wsgiref == 0.1.2 14:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:16 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 0x7f46fe884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009810>, '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 0x100a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aba0>, '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': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:01:16 INFO - Using env: {'DISPLAY': ':0', 14:01:16 INFO - 'HOME': '/home/cltbld', 14:01:16 INFO - 'LANG': 'en_US.UTF-8', 14:01:16 INFO - 'LANGUAGE': 'en_US:en', 14:01:16 INFO - 'LOGNAME': 'cltbld', 14:01:16 INFO - 'MAIL': '/var/mail/cltbld', 14:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:16 INFO - 'MOZ_NO_REMOTE': '1', 14:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:16 INFO - 'NO_EM_RESTART': '1', 14:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:16 INFO - 'PWD': '/builds/slave/test', 14:01:16 INFO - 'SHELL': '/bin/bash', 14:01:16 INFO - 'SHLVL': '1', 14:01:16 INFO - 'TERM': 'linux', 14:01:16 INFO - 'TMOUT': '86400', 14:01:16 INFO - 'USER': 'cltbld', 14:01:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 14:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:16 INFO - '_': '/tools/buildbot/bin/python'} 14:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:01:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:01:16 INFO - Cleaning up... 14:01:16 INFO - Return code: 0 14:01:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:16 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 0x7f46fe884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009810>, '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 0x100a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aba0>, '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': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:01:16 INFO - Using env: {'DISPLAY': ':0', 14:01:16 INFO - 'HOME': '/home/cltbld', 14:01:16 INFO - 'LANG': 'en_US.UTF-8', 14:01:16 INFO - 'LANGUAGE': 'en_US:en', 14:01:16 INFO - 'LOGNAME': 'cltbld', 14:01:16 INFO - 'MAIL': '/var/mail/cltbld', 14:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:16 INFO - 'MOZ_NO_REMOTE': '1', 14:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:16 INFO - 'NO_EM_RESTART': '1', 14:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:16 INFO - 'PWD': '/builds/slave/test', 14:01:16 INFO - 'SHELL': '/bin/bash', 14:01:16 INFO - 'SHLVL': '1', 14:01:16 INFO - 'TERM': 'linux', 14:01:16 INFO - 'TMOUT': '86400', 14:01:16 INFO - 'USER': 'cltbld', 14:01:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 14:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:16 INFO - '_': '/tools/buildbot/bin/python'} 14:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:16 INFO - Downloading/unpacking jsonschema 14:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:01:18 INFO - Downloading/unpacking functools32 (from jsonschema) 14:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:18 INFO - Downloading functools32-3.2.3-2.tar.gz 14:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:01:18 INFO - warning: no files found matching '*.txt' 14:01:18 INFO - no previously-included directories found matching 'build' 14:01:18 INFO - no previously-included directories found matching 'dist' 14:01:18 INFO - no previously-included directories found matching '.git*' 14:01:18 INFO - Installing collected packages: jsonschema, functools32 14:01:18 INFO - Running setup.py install for functools32 14:01:18 INFO - warning: no files found matching '*.txt' 14:01:18 INFO - no previously-included directories found matching 'build' 14:01:18 INFO - no previously-included directories found matching 'dist' 14:01:18 INFO - no previously-included directories found matching '.git*' 14:01:19 INFO - Successfully installed jsonschema functools32 14:01:19 INFO - Cleaning up... 14:01:19 INFO - Return code: 0 14:01:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:19 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 0x7f46fe884f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009810>, '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 0x100a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aba0>, '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': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:01:19 INFO - Using env: {'DISPLAY': ':0', 14:01:19 INFO - 'HOME': '/home/cltbld', 14:01:19 INFO - 'LANG': 'en_US.UTF-8', 14:01:19 INFO - 'LANGUAGE': 'en_US:en', 14:01:19 INFO - 'LOGNAME': 'cltbld', 14:01:19 INFO - 'MAIL': '/var/mail/cltbld', 14:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:19 INFO - 'MOZ_NO_REMOTE': '1', 14:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:19 INFO - 'NO_EM_RESTART': '1', 14:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:19 INFO - 'PWD': '/builds/slave/test', 14:01:19 INFO - 'SHELL': '/bin/bash', 14:01:19 INFO - 'SHLVL': '1', 14:01:19 INFO - 'TERM': 'linux', 14:01:19 INFO - 'TMOUT': '86400', 14:01:19 INFO - 'USER': 'cltbld', 14:01:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 14:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:19 INFO - '_': '/tools/buildbot/bin/python'} 14:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:19 INFO - Downloading/unpacking flake8 14:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:01:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:01:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:01:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:21 INFO - no previously-included directories found matching 'docs/_build' 14:01:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:01:21 INFO - Running setup.py install for pep8 14:01:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:22 INFO - no previously-included directories found matching 'docs/_build' 14:01:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:01:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:01:22 INFO - Cleaning up... 14:01:22 INFO - Return code: 0 14:01:22 INFO - Running post-action listener: _resource_record_post_action 14:01:22 INFO - Running post-action listener: _start_resource_monitoring 14:01:22 INFO - Starting resource monitoring. 14:01:22 INFO - ##### 14:01:22 INFO - ##### Running install step. 14:01:22 INFO - ##### 14:01:22 INFO - Running pre-action listener: _resource_record_pre_action 14:01:22 INFO - Running main action method: install 14:01:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:01:22 INFO - Reading from file tmpfile_stdout 14:01:22 INFO - Detecting whether we're running mozinstall >=1.0... 14:01:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:01:22 INFO - Reading from file tmpfile_stdout 14:01:22 INFO - Output received: 14:01:22 INFO - Usage: mozinstall [options] installer 14:01:22 INFO - Options: 14:01:22 INFO - -h, --help show this help message and exit 14:01:22 INFO - -d DEST, --destination=DEST 14:01:22 INFO - Directory to install application into. [default: 14:01:22 INFO - "/builds/slave/test"] 14:01:22 INFO - --app=APP Application being installed. [default: firefox] 14:01:22 INFO - mkdir: /builds/slave/test/build/application 14:01:22 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'] 14:01:22 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 14:01:38 INFO - Reading from file tmpfile_stdout 14:01:38 INFO - Output received: 14:01:38 INFO - /builds/slave/test/build/application/firefox/firefox 14:01:38 INFO - Running post-action listener: _resource_record_post_action 14:01:38 INFO - ##### 14:01:38 INFO - ##### Running run-tests step. 14:01:38 INFO - ##### 14:01:38 INFO - Running pre-action listener: _resource_record_pre_action 14:01:38 INFO - Running main action method: run_tests 14:01:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:01:38 INFO - Python 2.7.3 14:01:38 INFO - Return code: 0 14:01:38 INFO - grabbing minidump binary from tooltool 14:01: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')]} 14:01:38 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 0x1009810>, '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 0x100a710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:01:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:01:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:01:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:01:38 INFO - Return code: 0 14:01:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:01:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:01:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:01:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:01:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:01:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:01:39 INFO - Return code: 0 14:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:01:39 INFO - Using env: {'DISPLAY': ':0', 14:01:39 INFO - 'HOME': '/home/cltbld', 14:01:39 INFO - 'LANG': 'en_US.UTF-8', 14:01:39 INFO - 'LANGUAGE': 'en_US:en', 14:01:39 INFO - 'LOGNAME': 'cltbld', 14:01:39 INFO - 'MAIL': '/var/mail/cltbld', 14:01:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:01:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:39 INFO - 'MOZ_NO_REMOTE': '1', 14:01:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:39 INFO - 'NO_EM_RESTART': '1', 14:01:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:39 INFO - 'PWD': '/builds/slave/test', 14:01:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:01:39 INFO - 'SHELL': '/bin/bash', 14:01:39 INFO - 'SHLVL': '1', 14:01:39 INFO - 'TERM': 'linux', 14:01:39 INFO - 'TMOUT': '86400', 14:01:39 INFO - 'USER': 'cltbld', 14:01:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063', 14:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:39 INFO - '_': '/tools/buildbot/bin/python'} 14:01:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:01:40 INFO - mozversion application_buildid: 20160414113023 14:01:40 INFO - mozversion application_changeset: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 14:01:40 INFO - mozversion application_display_name: Nightly 14:01:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:01:40 INFO - mozversion application_name: Firefox 14:01:40 INFO - mozversion application_remotingname: firefox 14:01:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:01:40 INFO - mozversion application_vendor: Mozilla 14:01:40 INFO - mozversion application_version: 48.0a1 14:01:40 INFO - mozversion platform_buildid: 20160414113023 14:01:40 INFO - mozversion platform_changeset: 1bce3f1720e66a9cdc1a1699d3fd24a598641969 14:01:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:01:40 INFO - mozversion platform_version: 48.0a1 14:01:40 INFO - using testdate: 1460667700 14:01:40 INFO - actual date: 1460667700 14:01:40 INFO - starting webserver on 'localhost:34784' 14:01:40 INFO - SUITE-START | Running 2 tests 14:01:40 INFO - TEST-START | dromaeo_css 14:01:40 INFO - operating with platform_type : linux_ 14:01:40 INFO - Initialising browser for dromaeo_css test... 14:01:40 INFO - TEST-INFO | started process 30872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJs5poc/profile http://localhost:34784/getInfo.html) 14:01:44 INFO - PROCESS | 30872 | __metrics Screen width/height:1600/1200 14:01:44 INFO - PROCESS | 30872 | colorDepth:24 14:01:44 INFO - PROCESS | 30872 | Browser inner width/height: 1024/697 14:01:44 INFO - PROCESS | 30872 | __metrics 14:01:45 ERROR - PROCESS | 30872 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:01:46 INFO - TEST-INFO | 30872: exit 0 14:01:46 INFO - Browser initialized. 14:01:46 INFO - Running cycle 1/1 for dromaeo_css test... 14:01:46 INFO - TEST-INFO | started process 30958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJs5poc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:58 INFO - PROCESS | 30958 | RSS: Main: 153178112 14:01:58 INFO - PROCESS | 30958 | 14:02:48 INFO - PROCESS | 30958 | 1460667768949 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:04:57 INFO - PROCESS | 30958 | Cycle 1(1): loaded http://localhost:34784/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34784/tests/dromaeo/cssquery-ext.html) 14:04:58 INFO - PROCESS | 30958 | RSS: Main: 252719104 14:04:58 INFO - PROCESS | 30958 | 14:08:00 INFO - PROCESS | 30958 | Cycle 1(1): loaded http://localhost:34784/tests/dromaeo/cssquery-ext.html (next: http://localhost:34784/tests/dromaeo/cssquery-jquery.html) 14:08:00 INFO - PROCESS | 30958 | RSS: Main: 233283584 14:08:00 INFO - PROCESS | 30958 | 14:11:02 INFO - PROCESS | 30958 | Cycle 1(1): loaded http://localhost:34784/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34784/tests/dromaeo/cssquery-mootools.html) 14:11:03 INFO - PROCESS | 30958 | RSS: Main: 233422848 14:11:03 INFO - PROCESS | 30958 | 14:14:05 INFO - PROCESS | 30958 | Cycle 1(1): loaded http://localhost:34784/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34784/tests/dromaeo/cssquery-prototype.html) 14:14:05 INFO - PROCESS | 30958 | RSS: Main: 233484288 14:14:05 INFO - PROCESS | 30958 | 14:17:08 INFO - PROCESS | 30958 | Cycle 1(1): loaded http://localhost:34784/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34784/tests/dromaeo/cssquery-yui.html) 14:17:08 INFO - PROCESS | 30958 | RSS: Main: 218767360 14:17:08 INFO - PROCESS | 30958 | 14:20:11 INFO - PROCESS | 30958 | Cycle 1(1): loaded http://localhost:34784/tests/dromaeo/cssquery-yui.html (next: http://localhost:34784/tests/dromaeo/cssquery-dojo.html) 14:20:11 INFO - PROCESS | 30958 | RSS: Main: 253288448 14:20:11 INFO - PROCESS | 30958 | 14:20:11 INFO - PROCESS | 30958 | __start_tp_report 14:20:11 INFO - PROCESS | 30958 | _x_x_mozilla_page_load 14:20:11 INFO - PROCESS | 30958 | _x_x_mozilla_page_load_details 14:20:11 INFO - PROCESS | 30958 | |i|pagename|runs| 14:20:11 INFO - PROCESS | 30958 | |0;dojo.html;3069.432155051315;3130.2800355918152;3156.9210769730767;3165.5251712243175;3195.6644552322005;5053.115704751672;5279.023380674573;5285.497877701612;5285.867853303669;5317.867053323664;5277.86805329866;5298.7350632468415;5322.308099947001;5338.893222135555;5339.5728341732665;4745.59662428694;4753.14443400187;4773.451053128882;4818.71087734737;4986.202207646777;4950.504949505057;4953.281774142747;4962.206047032458;4963.1810751226;4988;4775.761211939389;4852.636052296057;4853.053654537367;4880.780364883589;4949.579285760715;4755.714657120584;4757.429108506966;4760.0479904018985;4766.022965292107;4767.570918617341;4725.31482934976;4737.620990320766;4745;4747.810087596492;4757.809687612491;5205.921911171297;5210.166373380241;5228.294180285651;5234.502722241381;5235.921461178085;5666.886662266732;5679.460451257124;5680.801171959003;5681.062624666925;5686.601937864351;5629.9437005629825;5676.517496012844;5705.4579814917515;5768.163616275617;5773.307203135609;5340.62615616907;5364.892702145935;5373.865653358697;5378.058839703075;5406.702631355274;5845.7369418376275;5855.795047173414;5859.736311865891;5860.794872179454;5862.472377486047;5479.808206712746;5517.062099443105;5572.637778544382;5582.581306402036;5620.91568626471;5636.830895073154;5637.9718101409235;5648.85877853057;5650.152477128464;5666.575006874501;5633.6619802811965;5636.126400407943;5638.605297629127;5640.182173584889;5645.379008309083;5483.8080667177255;5620.044592419298;5679.2333035040565;5721.342045664718;5724.599278050497;4273.230818452646;4279.229738647011;4279.443672322578;4281.100968796525;4312.633426158812;3799.4490798834013;3856.5950575189763;3862.806859657006;3888.591697871739;3903.9609603903596;5349.491798279158;5402.054640437907;5408.4050754416985;5418.349798024262;5435.592330575223;5641.746121424546;5672.120821272627;5677.37548869624;5678.432156784371;5680;5343.19852022192;5349.190157490126;5349.652272602269;5351.357837059578;5399.271098401666;4812.639052071108;4877.487863774323;4892.730899800474;4931.876703082452;4937.8271760488215;5910.1725758392995;5929.525637948954;5943.55423343251;5943.70281485924;5944.821655350346;5664.971675141598;5732.71336433185;5734.340550836624;5755.1942728017275;5759.798407055733;5811.796587119599;5827.24245848037;5828.184054232495;5863.355030946507;5881.911771323348;5540.667559946416;5589.524890384363;5592.636478628876;5594.300712410949;5606.411326810626;5599.076152434803;5691.146328050825;5694.316681998021;5694.943050569441;5743.827685169452;5541.556675465872;5546.528545073714;5547.44525547442;5565.220869078251;5603.831885043455;5487.039768040497;5491.450854914477;5502.2296878437855;5503.367112781922;5503.587230957774;5423.186522021729;5435.809746658848;5464.863378415572;5501.972490137524;5587.888242235052;5612.466815652507;5618.85952851182;5630.0991841305195;5630.0991841305195;5639;5447.291852059207;5504.614676972574;5505.146702261156;5507.091329930517;5509.0359187141285 14:20:11 INFO - PROCESS | 30958 | |1;ext.html;614.3917521653561;661.7452280871864;666.2937286476332;670.8255853478096;685.9314068593138;29853.55219671704;30525.542116868266;37711.81144094282;38348.42477362835;38390.80804595973;39626.40560391589;40246;40266.39600405996;40370.79814600923;40403.595964040425;8560.571971401421;8732.08313127122;8741.25699315559;8751.649934002633;8752.343574231927;8610.913890861106;8732.08313127122;8733.95633021834;8735.1701588349;8747.431416957908;8722.956385218065;8800.823983520326;8934.151255630704;8953.328500362499;8958.86561701575;8841.5579221039;8882.11178882113;8901.510416927067;8903.866442003342;8904.51025193614;8754.649814007433;8857.335699822475;8862.468251904906;8872.423292485968;8872.822543549157;39439.60560394388;39798;39908.40137397941;40038.19923601541;40052.59947400547;3473.0796338970194;3483.1814523586936;3505.0536355184213;3508.8771892983877;3624.655657712513;30159.849200754074;30609.675678916115;30762;30984.53523197154;31190.22024449384;4230.196262710076;4251.87244382669;4287.549807270254;4305.31115021595;4337.175936572073;269179;270817;271718;271973;272601;35091;36199.4570081449;57267.71366143226;57633;57682;34671.30657386838;34731;34803;34814.30371392558;34856.12859678528;15021.849781502264;15196.392144314104;15200.087994720352;15201.391944322324;15214;12031;12034;12039.75920481603;12040.096992725581;12042.277463352228;8439.113893041265;8498.150184981576;8505.53219572917;8544.444611100258;8553.315734741205;3213.5661685672135;3313.4201514734823;3314.287428202948;3338.0486561329903;3341.9498707519406;1033.4367769565604;1068.572570971602;1100.741325788439;1120.1318977792275;1189.0903458853984;32355.19112022218;32595.348093038006;32912.835435822664;33453.49819752706;33544.16139596481;1076.8869268726828;1085.2457542008228;1158.102470585303;1201.8017027190415;1212.854457465092;14906.552803415914;15253.542393727985;15470;15724.528264152093;15741.842581574267;404386;409344;410080;410263;413278;54607.72696136494;55250.44749552533;55440.44559554433;55478.72260638671;55524;1269.4985480735058;1346.7441186174594;1361.8161548191065;1393.909395889264;1450.0129732750568;29946.850265748533;31514.36971260608;31799.841000794848;31987;31997.520037198996;46706.53293467022;47377.76311118422;48042.27936581024;48049.279260810414;48173;393457;399712;403082;403270;405035;37464;43349.78325108354;43500.564994349654;44406.3339049908;44864.32703509515;42946.570534295504;43761;43970.560294396644;44228.33657495076;44260.336094959246;39096.7529256637;39786;40415.59584404236;40800;41035.1792964145;39642.40536391899;39721;40297.395539066354;40923.59076409317;41467.1706565873;40619.390709138796;41182.794086029375;41365.37951930783;41604.79197603992;41826.1634767309;35090.824545877105;36335;36388.636113639586;36448.81775591105;37004.25991480209;28219.57670634901;28274;28332.291692707848;28368.29079272952;28377.432451350443 14:20:11 INFO - PROCESS | 30958 | |2;jquery.html;385.2218518592442;389.6765684481882;390.44408033984587;396.0692372923628;403.37275536540676;14358.71282574348;14604.999999999973;16900.154992250384;17795.822041779593;17828.910855445738;17017;17558;17880.552986175353;18002.189901454432;18537.90731046343;5567.972160139204;5669.546436285087;5727.713614319288;5765.164051212571;5770.682612456313;5540.418256083114;5725.656460612356;5738.512226460756;5754.079347304432;5757.050086735683;5664;5697.316322041361;5700.173474846145;5706.572007099463;5707.3721890592005;5565.30433695788;5640.379558248589;5691.146328050784;5694.629849059818;5697.230873832042;4928.28539861718;5009.524095210949;5020;5025.824096156617;5142.408623008365;22907.885460572757;22969.196078137185;23082.307530774102;23257.88371058134;23560.88219558891;2266.88665566721;2282.691836602054;2345.0033735662446;2610.699769526491;2717.8992508034275;14136.363863626162;14240.786388204186;14312.28438578067;14339.354729037113;14748.041377310441;1922.1542521290728;1941.4758015335922;1963.852711046663;1975.4863735428748;2003.4390370696228;72794;74459.25540744577;74831.25168748297;75057.24942750557;75992;10050.09549140581;10101.898981010096;10297.794044119075;10562.841557376645;10953.34279943206;14332.641683957776;14372;14412.351444184827;14423.134611923319;14435.711285774225;7744;7884.093329267208;7887.290143886963;7974.681012759424;8068.354531637455;7584.393248540104;7626.923730762733;7639.274268944552;7688.38492920565;7941.047074351115;6441.549091563639;6460.3862633049785;6476.060971159155;6480.222373315232;6581.506387020897;1841.6408800283816;1851.4260579220215;1854.6290741851415;1899.2972600137762;1915.0711904726197;970.1026550440955;990.6186118344489;1020.9642662506776;1055.4300677633992;1118.3178261260625;17956.640867182585;18779.81220187808;19640;20173.293934712507;20200.191992320437;990.7721224118493;1003.242551873331;1004.3521928356315;1028.573142146016;1035.3529044347283;10662.520186591622;11291.887081129084;11333.716657083638;11429.542818287175;11433.485493152828;419442;427553;429710;450237;480044;79631.60184199158;80210.19789802143;80677;82495.17504824995;83010.16989830145;1091.1161958813386;1117.7708569743345;1156.3755571991198;1157.311399717167;1162.6686394377562;16411.58971025734;17017.574560636083;17223.65552688964;17326.566835829206;17578.384756533458;35734.28531429409;36314.8184259077;36812;36812.079698007765;37246.255074898894;49105.263421047996;49660.503394965584;49908;50021.749891250314;50040.249396258354;8404.285635720787;8485.193906578865;8558.957205213934;8590.09803970599;8810.074942130985;11359.829602556134;12375.844159739208;13694.109882857583;13741;13972.650683732989;11933.462994165457;11960.880391195977;12137.271763694207;12262.570810021607;12333;9199.862002070107;11727.237729547553;11932.164748467523;12043.935862822596;12122.878771212529;12406;12427.565035223724;12552.43514041852;12652.873471265537;12897.871021289668;8549.444286121383;8663.48019118855;8742.038375778786;8847.911520884967;8888.11118888132;11324.716882078013;11831.11266654987;11896.167268291136;11925.105617078927;12107.878921210675 14:20:11 INFO - PROCESS | 30958 | |3;mootools.html;1344.193483909655;1536.4852774320602;1564.7183506968747;1731.5930756272273;1854.7310639957207;7967.92032079679;8320.126386729396;8320.251177394033;8332.50004999699;8341.916580834197;8007.719729809458;8229.67081316748;8232.753017409472;8240.752777416672;8260.173982601751;2015.8084981926693;2260.762619924905;2275.9089636414524;2343.414146463384;2371.288613415977;2355.1756885090253;2375.2161786610377;2377.3937645900273;2377.8811059446957;2379.4765151666693;2289.9656505152434;2338.7778161074757;2342.5666251743396;2345.5692027863074;2348.013834189636;1979.980200197994;2205.2502149269167;2263.094762095175;2269.4439862233694;2271.0234599122373;2270.2167752125492;2283.1666441748807;2288.187693368863;2296.253717541789;2297.448612333045;8372.16278372164;8458.66165353385;8482.660693572312;8493.830123397498;8498.150184981514;4979.427365852937;5123;5133.948660513422;5136.5890728741615;5175.301334319856;3245.8863939761995;3259.054874086512;3310.486874534451;3338.6160591532043;3344.5986481622117;1085.8154113800672;1101.4547798839626;1101.9889801101967;1103.536514663835;1139.5840518210875;11270.380129092897;11478.885211147865;11515.884841151565;11517.712057198552;11521.193516453852;4378.496472905656;4393.143337049245;4546.522615125365;4572.245579479349;4592.10453961481;9871.950640246752;9881.802363952824;9891.455969921722;9894.06006429388;9904.356216845881;4641.582257596832;5099.719515426613;5105.795768169306;5114.207297868837;5131.409887862944;4669.766511674403;4772.737499437495;4779.211430114062;4787.0904528139545;4848.5636292733825;3801.6578507933864;3836.2135762168687;3887.7667339959125;3914.4911161548816;3949.3878448840474;1285.3830161522521;1289.4842063174806;1297.8247936528637;1304.2174695182814;1304.5955753716378;952.9475878826593;962.8892677342195;966.7486453522135;990.2523594685966;995.1740055753708;5690.857728556819;5691.971540142273;5706.115552089433;5828.067509198508;5855.502282306052;1015.7663737340305;1019.4138370437029;1028.7428142964259;1043.108142538119;1093.4423444043596;3830.8084595770656;3957.604239576019;3980.144268982183;4015.277250095011;4020.2160578686876;10015.298929075041;10307.020833020852;10367.844482332772;10486.737831554272;10518.894811051945;10353.43056131905;10397.636082737068;10429.5828166874;10438.739031524121;10459.372437653765;7870.842583148305;7892.684292628345;7927.286544210933;7948.364130869517;7979.601019948979;5575.553955683455;5636.4927156556105;5685.033544297562;5713.428657134254;5813.157092221689;9463.763405914908;9564.56959436841;9669.98465161148;9687.176589989647;9700;9417.340786144903;9552.95223523878;9688.321817472992;9799.265055120752;9807.06832850878;6452.903206451813;6656.201255849329;6667.799966001027;7142.107236595426;7256.1655409628565;7493.363064139609;7660.616969151632;7674.846503070019;7688.807779805549;7694.576798276148;7128.108986376703;7322.96338518304;7384.704611815468;7494.063242094739;7614.581198034161;7360.07999000125;7377.225391333833;7398.11222653285;7406.370458511087;7451.478396512192;6517.478601711947;6582.506312026521;6588.143541339595;6592.7033283503315;6606.735730570724;4815;4901.607871370353;4994.775235114356;5086.415062267886;5097.92353114711;4845.709257444423;4935.777889995031;4984.127777638826;5004.049230646166;5059.721715305694 14:20:11 INFO - PROCESS | 30958 | |4;prototype.html;322.01784557100837;324.4209086780098;324.73534069733165;330.13175348832584;330.8081312838554;5671.432856714327;5724.112762521805;5756.251687280653;5780.335261444935;5785.797497087603;5646.887062258752;5659.547236221092;5664.631798933066;5669.291338582677;5691.117876729103;4152.57074611352;4179.979100104495;4313.82744690212;4386.7367957922625;4386.868393948171;4340.804663790137;4358.389825424443;4367.890802729926;4373.890652733691;4382.9342559861625;4113.239050775616;4315.848945286915;4344.348347747831;4345.69580129391;4357.520672725997;4208.326667733163;4315.072259464199;4317.827286908504;4332.870013899588;4333.653307735373;3775.8112094395447;3777.6411240932343;3784.4701741756176;3785.3754130568423;3788.45067465216;5359.785608575652;5428.267183930158;5434.266374039494;5439;5455.699936503491;4970.676906001135;4979.053979743837;4985.651004429691;4985.975070124626;5005.57452616528;5857.326407463111;5876.29484461863;5903.114532820068;5910.763569457216;5918.549955260989;4048.4939382577177;4173.853915112987;4177.811998460076;4183.205191013728;4189.97905010473;6120;6142.078688196806;6148.815535533941;6163.445289923929;6180;4240.194363071007;4243.915121697611;4251.659867210616;4252.723572967747;4253.128108737763;4197.811098500575;4300.849470268526;4301.827926882889;4307.956920430818;4322.762248076323;4946.650341087954;4953.90092198154;4967.329410529533;4970.801167953314;4990.725510096907;5891.263592050994;5906.143609176645;5934.287885453773;5944.970275148597;5957.940420595825;1479.289940828387;1492.3508273900889;1509.8565636264536;1511.8261399939147;1514.3412615512068;948.7106432538142;989.2827699917502;1019.6125472320471;1028.8662473878348;1032.5353590884133;5598.692071936082;5686.857828554319;5692.857678558069;5697.3448053474385;5699.116636921284;6002.039673652194;6075.665838378844;6085.117657939662;6085.300190478063;6095.634261944208;5520.834374968757;5555.748153944487;5597.552195824324;5636.633618814764;5715.057015592381;3232.272738633789;3239.0282915125367;3244.588603957286;3253.1541799132397;3265.6734326567152;6168.753249870045;6207.96896015517;6275.780347687809;6279.591826531261;6292.182016337847;6209;6225.159603453566;6248.968755156195;6252.874942501125;6261.686915654199;6180.907286390618;6212.223472065992;6267.435930766253;6269.523538202476;6275.152854364694;6013.909791353046;6069.150318955438;6089.238845144357;6092.573519853568;6108.602940809011;5948.078047902582;5972.104184372205;5998.7300571473515;6025.3070896845675;6036;6037.305709843425;6226.377362263737;6280;6282.874342513032;6285.585743207925;4279.144171165717;4303.655707543327;4307.39696442492;4311.1808756336195;4321.913561728811;5941.551000886881;6038.275406951194;6049.122877182872;6060.575759696779;6101.694915254308;5835.241418615553;5902.38025007368;5904.940950590439;5926;5938.376470470538;5903.793367232298;5930.495907847881;5950.434708702666;5953.345132035559;5959.284885813557;4990.251462280687;5401.756920938488;5739.770409183753;5827.475527202572;5883.146943693226;5984;6012.488938440281;6013.158157857991;6021.849453763691;6085.482733967662;5865.237519122486;5870.236869207147;5879.441453061952;5903.203067585992;5903.557233207441 14:20:11 INFO - PROCESS | 30958 | |5;yui.html;720.9243029481904;729.6497681113066;805.5368163306097;870.9608067636956;871.3377832847034;14583;14979.700405991887;15024.17367044812;15047;15059.548213553611;15581.065136091815;15611;15651.92174039131;15661.686766264667;15728.764068538982;698.7519430602139;819.8524265632184;844.3835999720193;845.3828705045321;851.093585331623;837.9078301386843;842.4061036968923;842.8609279468881;843.4096132707099;845.0366582096415;870;871.3551971541077;871.5729292646621;872.0973792125152;872.8036191856845;719.9424046076301;855.2217482091329;870.1298701298701;876.3821505838368;877.7805548612847;648.844277373427;649.8018104478132;650.4893658478119;651.1144843013498;651.5048563092037;14650.340734666966;14693.632659183499;14713.337899794535;14720.705585888329;14724.337404816702;14073.71852562943;14139.929300353535;14163.64590885236;14164.85835141656;14171.149731016068;11470.713232169179;11614.593489227836;11683.299002059819;11743.412829358498;11795.351255680935;3770.9434358484646;3773.3585290500682;3859.8842034739005;3871.9032024199337;3911.061345277113;55544.444555554735;55810.44189558134;56247.71876140634;56656.71671641615;56701.14948275821;10775.299605525615;10858.891411085788;11109.111271098454;11171;11348.489317980711;19039.333623323117;19329.323473678352;19342.516437089187;19376;19389.22443102288;8144.796380090426;8358.122397148212;8375.288100511525;8669.653213871501;8706.347023973227;4388.648908087345;4788.377510923558;4912.582430493377;4922.4339200992345;4940.802367905316;3357.0600231935096;3631.1466805300734;3815.751976121543;3817.6373244541724;3840.251151025523;530.2205757536416;631.996840015797;663.8041777675597;664.4186336955164;666.7066490744057;679.3546131175403;698.5215127637584;725.6299287363377;757.5454727163768;792.9405294602927;8840.071792461827;8843.646254149762;9046.715911359526;9291.256699464027;9330.440173589606;602.7890238416607;726.989095163573;741.9443541734391;758.2303961479104;774.7404619452547;4400.46843055916;4594.173048851172;4658.767061646972;4709.858704238878;4741.431028276629;59474.21577352686;61930;62154;62854.371456285764;63093.684531577965;52459;53297.73351133297;54359.45640543623;54647;55728.44271557314;49440;49757.50242497529;50032.499675002786;51037.48962510402;52318.47681523136;8653.783655408664;8658.264047556027;8737.21365077146;8955.149260820212;9053.502057386908;32091.50718899309;32734;33364.1658958528;33658.01027232123;34081.31837363289;42275;43666.56333436625;46123.30815037844;46555.53444465648;47181;11225.382603956861;11347.546098156312;11438.256513326607;11443.713907152387;11572;10685.358878467317;10818.891811082103;10873.565057397933;10912.181586380895;11151.83272250933;11377.772444550897;11458.140639451907;11639.825402619137;11683.474243659226;11737.706557336134;11801.586944456903;11852.348120853436;11924;12044.096692747904;12197.390130493617;11494.425278735862;11606.535738570363;11657.242279251821;11666.300021998708;11740.471678774305;9495.477748723886;9521.381110227812;9733.610655573697;9841.311108222355;10119.291649584458;9357.719268421959;10048.497958898759;10055.547500362647;10075.754193270024;10140.188784897044 14:20:11 INFO - PROCESS | 30958 | __end_tp_report 14:20:11 INFO - PROCESS | 30958 | __start_cc_report 14:20:11 INFO - PROCESS | 30958 | _x_x_mozilla_cycle_collect,862 14:20:11 INFO - PROCESS | 30958 | __end_cc_report 14:20:11 INFO - PROCESS | 30958 | __startTimestamp1460668811692__endTimestamp 14:20:11 INFO - PROCESS | 30958 | 14:20:11 INFO - PROCESS | 30958 | ------- Summary: start ------- 14:20:11 INFO - PROCESS | 30958 | Number of tests: 6 14:20:11 INFO - PROCESS | 30958 | 14:20:11 INFO - PROCESS | 30958 | [#0] dojo.html Cycles:165 Average:5275.30 Median:5491.45 stddev:596.99 (10.9%) stddev-sans-first:573.20 14:20:11 INFO - PROCESS | 30958 | Values: 3069.4 3130.3 3156.9 3165.5 3195.7 5053.1 5279.0 5285.5 5285.9 5317.9 5277.9 5298.7 5322.3 5338.9 5339.6 4745.6 4753.1 4773.5 4818.7 4986.2 4950.5 4953.3 4962.2 4963.2 4988.0 4775.8 4852.6 4853.1 4880.8 4949.6 4755.7 4757.4 4760.0 4766.0 4767.6 4725.3 4737.6 4745.0 4747.8 4757.8 5205.9 5210.2 5228.3 5234.5 5235.9 5666.9 5679.5 5680.8 5681.1 5686.6 5629.9 5676.5 5705.5 5768.2 5773.3 5340.6 5364.9 5373.9 5378.1 5406.7 5845.7 5855.8 5859.7 5860.8 5862.5 5479.8 5517.1 5572.6 5582.6 5620.9 5636.8 5638.0 5648.9 5650.2 5666.6 5633.7 5636.1 5638.6 5640.2 5645.4 5483.8 5620.0 5679.2 5721.3 5724.6 4273.2 4279.2 4279.4 4281.1 4312.6 3799.4 3856.6 3862.8 3888.6 3904.0 5349.5 5402.1 5408.4 5418.3 5435.6 5641.7 5672.1 5677.4 5678.4 5680.0 5343.2 5349.2 5349.7 5351.4 5399.3 4812.6 4877.5 4892.7 4931.9 4937.8 5910.2 5929.5 5943.6 5943.7 5944.8 5665.0 5732.7 5734.3 5755.2 5759.8 5811.8 5827.2 5828.2 5863.4 5881.9 5540.7 5589.5 5592.6 5594.3 5606.4 5599.1 5691.1 5694.3 5694.9 5743.8 5541.6 5546.5 5547.4 5565.2 5603.8 5487.0 5491.5 5502.2 5503.4 5503.6 5423.2 5435.8 5464.9 5502.0 5587.9 5612.5 5618.9 5630.1 5630.1 5639.0 5447.3 5504.6 5505.1 5507.1 5509.0 14:20:11 INFO - PROCESS | 30958 | 14:20:11 INFO - PROCESS | 30958 | [#1] ext.html Cycles:180 Average:51719.09 Median:39853.20 stddev:96611.48 (242.4%) stddev-sans-first:96806.31 14:20:11 INFO - PROCESS | 30958 | Values: 614.4 661.7 666.3 670.8 685.9 29853.6 30525.5 37711.8 38348.4 38390.8 39626.4 40246.0 40266.4 40370.8 40403.6 8560.6 8732.1 8741.3 8751.6 8752.3 8610.9 8732.1 8734.0 8735.2 8747.4 8723.0 8800.8 8934.2 8953.3 8958.9 8841.6 8882.1 8901.5 8903.9 8904.5 8754.6 8857.3 8862.5 8872.4 8872.8 39439.6 39798.0 39908.4 40038.2 40052.6 3473.1 3483.2 3505.1 3508.9 3624.7 30159.8 30609.7 30762.0 30984.5 31190.2 4230.2 4251.9 4287.5 4305.3 4337.2 269179.0 270817.0 271718.0 271973.0 272601.0 35091.0 36199.5 57267.7 57633.0 57682.0 34671.3 34731.0 34803.0 34814.3 34856.1 15021.8 15196.4 15200.1 15201.4 15214.0 12031.0 12034.0 12039.8 12040.1 12042.3 8439.1 8498.2 8505.5 8544.4 8553.3 3213.6 3313.4 3314.3 3338.0 3341.9 1033.4 1068.6 1100.7 1120.1 1189.1 32355.2 32595.3 32912.8 33453.5 33544.2 1076.9 1085.2 1158.1 1201.8 1212.9 14906.6 15253.5 15470.0 15724.5 15741.8 404386.0 409344.0 410080.0 410263.0 413278.0 54607.7 55250.4 55440.4 55478.7 55524.0 1269.5 1346.7 1361.8 1393.9 1450.0 29946.9 31514.4 31799.8 31987.0 31997.5 46706.5 47377.8 48042.3 48049.3 48173.0 393457.0 399712.0 403082.0 403270.0 405035.0 37464.0 43349.8 43500.6 44406.3 44864.3 42946.6 43761.0 43970.6 44228.3 44260.3 39096.8 39786.0 40415.6 40800.0 41035.2 39642.4 39721.0 40297.4 40923.6 41467.2 40619.4 41182.8 41365.4 41604.8 41826.2 35090.8 36335.0 36388.6 36448.8 37004.3 28219.6 28274.0 28332.3 28368.3 28377.4 14:20:11 INFO - PROCESS | 30958 | 14:20:11 INFO - PROCESS | 30958 | [#2] jquery.html Cycles:180 Average:26823.56 Median:23170.10 stddev:72669.62 (313.6%) stddev-sans-first:72846.36 14:20:11 INFO - PROCESS | 30958 | Values: 385.2 389.7 390.4 396.1 403.4 14358.7 14605.0 16900.2 17795.8 17828.9 17017.0 17558.0 17880.6 18002.2 18537.9 5568.0 5669.5 5727.7 5765.2 5770.7 5540.4 5725.7 5738.5 5754.1 5757.1 5664.0 5697.3 5700.2 5706.6 5707.4 5565.3 5640.4 5691.1 5694.6 5697.2 4928.3 5009.5 5020.0 5025.8 5142.4 22907.9 22969.2 23082.3 23257.9 23560.9 2266.9 2282.7 2345.0 2610.7 2717.9 14136.4 14240.8 14312.3 14339.4 14748.0 1922.2 1941.5 1963.9 1975.5 2003.4 72794.0 74459.3 74831.3 75057.2 75992.0 10050.1 10101.9 10297.8 10562.8 10953.3 14332.6 14372.0 14412.4 14423.1 14435.7 7744.0 7884.1 7887.3 7974.7 8068.4 7584.4 7626.9 7639.3 7688.4 7941.0 6441.5 6460.4 6476.1 6480.2 6581.5 1841.6 1851.4 1854.6 1899.3 1915.1 970.1 990.6 1021.0 1055.4 1118.3 17956.6 18779.8 19640.0 20173.3 20200.2 990.8 1003.2 1004.4 1028.6 1035.4 10662.5 11291.9 11333.7 11429.5 11433.5 419442.0 427553.0 429710.0 450237.0 480044.0 79631.6 80210.2 80677.0 82495.2 83010.2 1091.1 1117.8 1156.4 1157.3 1162.7 16411.6 17017.6 17223.7 17326.6 17578.4 35734.3 36314.8 36812.0 36812.1 37246.3 49105.3 49660.5 49908.0 50021.7 50040.2 8404.3 8485.2 8559.0 8590.1 8810.1 11359.8 12375.8 13694.1 13741.0 13972.7 11933.5 11960.9 12137.3 12262.6 12333.0 9199.9 11727.2 11932.2 12043.9 12122.9 12406.0 12427.6 12552.4 12652.9 12897.9 8549.4 8663.5 8742.0 8847.9 8888.1 11324.7 11831.1 11896.2 11925.1 12107.9 14:20:11 INFO - PROCESS | 30958 | 14:20:11 INFO - PROCESS | 30958 | [#3] mootools.html Cycles:180 Average:5539.96 Median:4981.78 stddev:3070.93 (61.6%) stddev-sans-first:3063.36 14:20:11 INFO - PROCESS | 30958 | Values: 1344.2 1536.5 1564.7 1731.6 1854.7 7967.9 8320.1 8320.3 8332.5 8341.9 8007.7 8229.7 8232.8 8240.8 8260.2 2015.8 2260.8 2275.9 2343.4 2371.3 2355.2 2375.2 2377.4 2377.9 2379.5 2290.0 2338.8 2342.6 2345.6 2348.0 1980.0 2205.3 2263.1 2269.4 2271.0 2270.2 2283.2 2288.2 2296.3 2297.4 8372.2 8458.7 8482.7 8493.8 8498.2 4979.4 5123.0 5133.9 5136.6 5175.3 3245.9 3259.1 3310.5 3338.6 3344.6 1085.8 1101.5 1102.0 1103.5 1139.6 11270.4 11478.9 11515.9 11517.7 11521.2 4378.5 4393.1 4546.5 4572.2 4592.1 9872.0 9881.8 9891.5 9894.1 9904.4 4641.6 5099.7 5105.8 5114.2 5131.4 4669.8 4772.7 4779.2 4787.1 4848.6 3801.7 3836.2 3887.8 3914.5 3949.4 1285.4 1289.5 1297.8 1304.2 1304.6 952.9 962.9 966.7 990.3 995.2 5690.9 5692.0 5706.1 5828.1 5855.5 1015.8 1019.4 1028.7 1043.1 1093.4 3830.8 3957.6 3980.1 4015.3 4020.2 10015.3 10307.0 10367.8 10486.7 10518.9 10353.4 10397.6 10429.6 10438.7 10459.4 7870.8 7892.7 7927.3 7948.4 7979.6 5575.6 5636.5 5685.0 5713.4 5813.2 9463.8 9564.6 9670.0 9687.2 9700.0 9417.3 9553.0 9688.3 9799.3 9807.1 6452.9 6656.2 6667.8 7142.1 7256.2 7493.4 7660.6 7674.8 7688.8 7694.6 7128.1 7323.0 7384.7 7494.1 7614.6 7360.1 7377.2 7398.1 7406.4 7451.5 6517.5 6582.5 6588.1 6592.7 6606.7 4815.0 4901.6 4994.8 5086.4 5097.9 4845.7 4935.8 4984.1 5004.0 5059.7 14:20:11 INFO - PROCESS | 30958 | 14:20:11 INFO - PROCESS | 30958 | [#4] prototype.html Cycles:180 Average:4960.53 Median:5688.99 stddev:1478.08 (26.0%) stddev-sans-first:1440.64 14:20:11 INFO - PROCESS | 30958 | Values: 322.0 324.4 324.7 330.1 330.8 5671.4 5724.1 5756.3 5780.3 5785.8 5646.9 5659.5 5664.6 5669.3 5691.1 4152.6 4180.0 4313.8 4386.7 4386.9 4340.8 4358.4 4367.9 4373.9 4382.9 4113.2 4315.8 4344.3 4345.7 4357.5 4208.3 4315.1 4317.8 4332.9 4333.7 3775.8 3777.6 3784.5 3785.4 3788.5 5359.8 5428.3 5434.3 5439.0 5455.7 4970.7 4979.1 4985.7 4986.0 5005.6 5857.3 5876.3 5903.1 5910.8 5918.5 4048.5 4173.9 4177.8 4183.2 4190.0 6120.0 6142.1 6148.8 6163.4 6180.0 4240.2 4243.9 4251.7 4252.7 4253.1 4197.8 4300.8 4301.8 4308.0 4322.8 4946.7 4953.9 4967.3 4970.8 4990.7 5891.3 5906.1 5934.3 5945.0 5957.9 1479.3 1492.4 1509.9 1511.8 1514.3 948.7 989.3 1019.6 1028.9 1032.5 5598.7 5686.9 5692.9 5697.3 5699.1 6002.0 6075.7 6085.1 6085.3 6095.6 5520.8 5555.7 5597.6 5636.6 5715.1 3232.3 3239.0 3244.6 3253.2 3265.7 6168.8 6208.0 6275.8 6279.6 6292.2 6209.0 6225.2 6249.0 6252.9 6261.7 6180.9 6212.2 6267.4 6269.5 6275.2 6013.9 6069.2 6089.2 6092.6 6108.6 5948.1 5972.1 5998.7 6025.3 6036.0 6037.3 6226.4 6280.0 6282.9 6285.6 4279.1 4303.7 4307.4 4311.2 4321.9 5941.6 6038.3 6049.1 6060.6 6101.7 5835.2 5902.4 5904.9 5926.0 5938.4 5903.8 5930.5 5950.4 5953.3 5959.3 4990.3 5401.8 5739.8 5827.5 5883.1 5984.0 6012.5 6013.2 6021.8 6085.5 5865.2 5870.2 5879.4 5903.2 5903.6 14:20:11 INFO - PROCESS | 30958 | 14:20:11 INFO - PROCESS | 30958 | [#5] yui.html Cycles:180 Average:14717.05 Median:4764.90 stddev:17124.98 (359.4%) stddev-sans-first:17140.77 14:20:11 INFO - PROCESS | 30958 | Values: 720.9 729.6 805.5 871.0 871.3 14583.0 14979.7 15024.2 15047.0 15059.5 15581.1 15611.0 15651.9 15661.7 15728.8 698.8 819.9 844.4 845.4 851.1 837.9 842.4 842.9 843.4 845.0 870.0 871.4 871.6 872.1 872.8 719.9 855.2 870.1 876.4 877.8 648.8 649.8 650.5 651.1 651.5 14650.3 14693.6 14713.3 14720.7 14724.3 14073.7 14139.9 14163.6 14164.9 14171.1 11470.7 11614.6 11683.3 11743.4 11795.4 3770.9 3773.4 3859.9 3871.9 3911.1 55544.4 55810.4 56247.7 56656.7 56701.1 10775.3 10858.9 11109.1 11171.0 11348.5 19039.3 19329.3 19342.5 19376.0 19389.2 8144.8 8358.1 8375.3 8669.7 8706.3 4388.6 4788.4 4912.6 4922.4 4940.8 3357.1 3631.1 3815.8 3817.6 3840.3 530.2 632.0 663.8 664.4 666.7 679.4 698.5 725.6 757.5 792.9 8840.1 8843.6 9046.7 9291.3 9330.4 602.8 727.0 741.9 758.2 774.7 4400.5 4594.2 4658.8 4709.9 4741.4 59474.2 61930.0 62154.0 62854.4 63093.7 52459.0 53297.7 54359.5 54647.0 55728.4 49440.0 49757.5 50032.5 51037.5 52318.5 8653.8 8658.3 8737.2 8955.1 9053.5 32091.5 32734.0 33364.2 33658.0 34081.3 42275.0 43666.6 46123.3 46555.5 47181.0 11225.4 11347.5 11438.3 11443.7 11572.0 10685.4 10818.9 10873.6 10912.2 11151.8 11377.8 11458.1 11639.8 11683.5 11737.7 11801.6 11852.3 11924.0 12044.1 12197.4 11494.4 11606.5 11657.2 11666.3 11740.5 9495.5 9521.4 9733.6 9841.3 10119.3 9357.7 10048.5 10055.5 10075.8 10140.2 14:20:11 INFO - PROCESS | 30958 | -------- Summary: end -------- 14:20:11 INFO - PROCESS | 30958 | 14:20:12 INFO - TEST-INFO | 30958: exit 0 14:20:12 INFO - TEST-OK | dromaeo_css | took 1112316ms 14:20:12 INFO - TEST-START | kraken 14:20:12 INFO - operating with platform_type : linux_ 14:20:12 INFO - Initialising browser for kraken test... 14:20:12 INFO - TEST-INFO | started process 31142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9zsluk/profile http://localhost:34784/getInfo.html) 14:20:16 INFO - PROCESS | 31142 | __metrics Screen width/height:1600/1200 14:20:16 INFO - PROCESS | 31142 | colorDepth:24 14:20:16 INFO - PROCESS | 31142 | Browser inner width/height: 1024/697 14:20:16 INFO - PROCESS | 31142 | __metrics 14:20:17 ERROR - PROCESS | 31142 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:20:18 INFO - TEST-INFO | 31142: exit 0 14:20:18 INFO - Browser initialized. 14:20:18 INFO - Running cycle 1/1 for kraken test... 14:20:18 INFO - TEST-INFO | started process 31222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9zsluk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:30 INFO - PROCESS | 31222 | RSS: Main: 152518656 14:20:30 INFO - PROCESS | 31222 | 14:20:32 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34784/tests/kraken/driver.html?testName=audio-beat-detection) 14:20:33 INFO - PROCESS | 31222 | RSS: Main: 207896576 14:20:33 INFO - PROCESS | 31222 | 14:20:36 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34784/tests/kraken/driver.html?testName=audio-dft) 14:20:36 INFO - PROCESS | 31222 | RSS: Main: 193875968 14:20:36 INFO - PROCESS | 31222 | 14:20:40 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34784/tests/kraken/driver.html?testName=audio-fft) 14:20:40 INFO - PROCESS | 31222 | RSS: Main: 264437760 14:20:40 INFO - PROCESS | 31222 | 14:20:42 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34784/tests/kraken/driver.html?testName=audio-oscillator) 14:20:43 INFO - PROCESS | 31222 | RSS: Main: 172593152 14:20:43 INFO - PROCESS | 31222 | 14:20:45 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34784/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:20:46 INFO - PROCESS | 31222 | RSS: Main: 176574464 14:20:46 INFO - PROCESS | 31222 | 14:20:49 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34784/tests/kraken/driver.html?testName=imaging-darkroom) 14:20:49 INFO - PROCESS | 31222 | RSS: Main: 212738048 14:20:49 INFO - PROCESS | 31222 | 14:20:53 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34784/tests/kraken/driver.html?testName=imaging-desaturate) 14:20:53 INFO - PROCESS | 31222 | RSS: Main: 213487616 14:20:53 INFO - PROCESS | 31222 | 14:20:56 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34784/tests/kraken/driver.html?testName=json-parse-financial) 14:20:57 INFO - PROCESS | 31222 | RSS: Main: 213905408 14:20:57 INFO - PROCESS | 31222 | 14:20:58 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34784/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:20:59 INFO - PROCESS | 31222 | RSS: Main: 201773056 14:20:59 INFO - PROCESS | 31222 | 14:21:00 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34784/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:21:01 INFO - PROCESS | 31222 | RSS: Main: 203567104 14:21:01 INFO - PROCESS | 31222 | 14:21:03 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34784/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:21:04 INFO - PROCESS | 31222 | RSS: Main: 217776128 14:21:04 INFO - PROCESS | 31222 | 14:21:06 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:21:07 INFO - PROCESS | 31222 | RSS: Main: 222883840 14:21:07 INFO - PROCESS | 31222 | 14:21:10 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:21:10 INFO - PROCESS | 31222 | RSS: Main: 219086848 14:21:10 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | Cycle 1(1): loaded http://localhost:34784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34784/tests/kraken/driver.html?testName=ai-astar) 14:21:12 INFO - PROCESS | 31222 | RSS: Main: 282607616 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | __start_tp_report 14:21:12 INFO - PROCESS | 31222 | _x_x_mozilla_page_load 14:21:12 INFO - PROCESS | 31222 | _x_x_mozilla_page_load_details 14:21:12 INFO - PROCESS | 31222 | |i|pagename|runs| 14:21:12 INFO - PROCESS | 31222 | |0;ai-astar;111;113;105;112;111;112;100;111;110;112 14:21:12 INFO - PROCESS | 31222 | |1;audio-beat-detection;161;128;153;186;128;160;147;128;181;134 14:21:12 INFO - PROCESS | 31222 | |2;audio-dft;160;161;160;161;160;161;161;161;162;162 14:21:12 INFO - PROCESS | 31222 | |3;audio-fft;73;75;107;108;76;73;76;117;106;72 14:21:12 INFO - PROCESS | 31222 | |4;audio-oscillator;93;91;159;92;92;93;148;92;92;154 14:21:12 INFO - PROCESS | 31222 | |5;imaging-gaussian-blur;116;117;116;116;117;117;116;117;116;117 14:21:12 INFO - PROCESS | 31222 | |6;imaging-darkroom;146;145;145;145;145;145;145;145;145;145 14:21:12 INFO - PROCESS | 31222 | |7;imaging-desaturate;96;95;95;96;96;95;95;95;95;95 14:21:12 INFO - PROCESS | 31222 | |8;json-parse-financial;58;59;57;58;58;57;58;77;55;55 14:21:12 INFO - PROCESS | 31222 | |9;json-stringify-tinderbox;62;61;60;61;61;61;61;61;61;61 14:21:12 INFO - PROCESS | 31222 | |10;stanford-crypto-aes;80;81;79;79;81;81;81;82;81;82 14:21:12 INFO - PROCESS | 31222 | |11;stanford-crypto-ccm;129;128;128;128;130;127;126;126;160;130 14:21:12 INFO - PROCESS | 31222 | |12;stanford-crypto-pbkdf2;162;166;166;170;163;163;169;159;164;162 14:21:12 INFO - PROCESS | 31222 | |13;stanford-crypto-sha256-iterative;67;66;67;67;67;66;68;68;68;66 14:21:12 INFO - PROCESS | 31222 | __end_tp_report 14:21:12 INFO - PROCESS | 31222 | __start_cc_report 14:21:12 INFO - PROCESS | 31222 | _x_x_mozilla_cycle_collect,1630 14:21:12 INFO - PROCESS | 31222 | __end_cc_report 14:21:12 INFO - PROCESS | 31222 | __startTimestamp1460668872646__endTimestamp 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | ------- Summary: start ------- 14:21:12 INFO - PROCESS | 31222 | Number of tests: 14 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.50 stddev:4.06 (3.6%) stddev-sans-first:4.28 14:21:12 INFO - PROCESS | 31222 | Values: 111.0 113.0 105.0 112.0 111.0 112.0 100.0 111.0 110.0 112.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:156.50 stddev:21.60 (13.8%) stddev-sans-first:22.58 14:21:12 INFO - PROCESS | 31222 | Values: 161.0 128.0 153.0 186.0 128.0 160.0 147.0 128.0 181.0 134.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 14:21:12 INFO - PROCESS | 31222 | Values: 160.0 161.0 160.0 161.0 160.0 161.0 161.0 161.0 162.0 162.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#3] audio-fft Cycles:10 Average:88.30 Median:73.00 stddev:18.52 (25.4%) stddev-sans-first:18.80 14:21:12 INFO - PROCESS | 31222 | Values: 73.0 75.0 107.0 108.0 76.0 73.0 76.0 117.0 106.0 72.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:92.00 stddev:29.84 (32.4%) stddev-sans-first:30.96 14:21:12 INFO - PROCESS | 31222 | Values: 93.0 91.0 159.0 92.0 92.0 93.0 148.0 92.0 92.0 154.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:21:12 INFO - PROCESS | 31222 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 14:21:12 INFO - PROCESS | 31222 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 14:21:12 INFO - PROCESS | 31222 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:58.00 stddev:6.39 (11.0%) stddev-sans-first:6.76 14:21:12 INFO - PROCESS | 31222 | Values: 58.0 59.0 57.0 58.0 58.0 57.0 58.0 77.0 55.0 55.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 14:21:12 INFO - PROCESS | 31222 | Values: 62.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:81.00 stddev:1.06 (1.3%) stddev-sans-first:1.09 14:21:12 INFO - PROCESS | 31222 | Values: 80.0 81.0 79.0 79.0 81.0 81.0 81.0 82.0 81.0 82.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:128.50 stddev:10.22 (8.0%) stddev-sans-first:10.81 14:21:12 INFO - PROCESS | 31222 | Values: 129.0 128.0 128.0 128.0 130.0 127.0 126.0 126.0 160.0 130.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:165.00 stddev:3.37 (2.0%) stddev-sans-first:3.46 14:21:12 INFO - PROCESS | 31222 | Values: 162.0 166.0 166.0 170.0 163.0 163.0 169.0 159.0 164.0 162.0 14:21:12 INFO - PROCESS | 31222 | 14:21:12 INFO - PROCESS | 31222 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 14:21:12 INFO - PROCESS | 31222 | Values: 67.0 66.0 67.0 67.0 67.0 66.0 68.0 68.0 68.0 66.0 14:21:12 INFO - PROCESS | 31222 | -------- Summary: end -------- 14:21:12 INFO - PROCESS | 31222 | 14:21:13 INFO - TEST-INFO | 31222: exit 0 14:21:13 INFO - TEST-OK | kraken | took 61067ms 14:21:13 INFO - SUITE-END | took 1173s 14:21:13 INFO - Completed test suite (00:19:33) 14:21:13 INFO - javascript benchmark 14:21:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.432155051315, 3130.2800355918152, 3156.9210769730767, 3165.5251712243175, 3195.6644552322005, 5053.115704751672, 5279.023380674573, 5285.497877701612, 5285.867853303669, 5317.867053323664, 5277.86805329866, 5298.7350632468415, 5322.308099947001, 5338.893222135555, 5339.5728341732665, 4745.59662428694, 4753.14443400187, 4773.451053128882, 4818.71087734737, 4986.202207646777, 4950.504949505057, 4953.281774142747, 4962.206047032458, 4963.1810751226, 4988.0, 4775.761211939389, 4852.636052296057, 4853.053654537367, 4880.780364883589, 4949.579285760715, 4755.714657120584, 4757.429108506966, 4760.0479904018985, 4766.022965292107, 4767.570918617341, 4725.31482934976, 4737.620990320766, 4745.0, 4747.810087596492, 4757.809687612491, 5205.921911171297, 5210.166373380241, 5228.294180285651, 5234.502722241381, 5235.921461178085, 5666.886662266732, 5679.460451257124, 5680.801171959003, 5681.062624666925, 5686.601937864351, 5629.9437005629825, 5676.517496012844, 5705.4579814917515, 5768.163616275617, 5773.307203135609, 5340.62615616907, 5364.892702145935, 5373.865653358697, 5378.058839703075, 5406.702631355274, 5845.7369418376275, 5855.795047173414, 5859.736311865891, 5860.794872179454, 5862.472377486047, 5479.808206712746, 5517.062099443105, 5572.637778544382, 5582.581306402036, 5620.91568626471, 5636.830895073154, 5637.9718101409235, 5648.85877853057, 5650.152477128464, 5666.575006874501, 5633.6619802811965, 5636.126400407943, 5638.605297629127, 5640.182173584889, 5645.379008309083, 5483.8080667177255, 5620.044592419298, 5679.2333035040565, 5721.342045664718, 5724.599278050497, 4273.230818452646, 4279.229738647011, 4279.443672322578, 4281.100968796525, 4312.633426158812, 3799.4490798834013, 3856.5950575189763, 3862.806859657006, 3888.591697871739, 3903.9609603903596, 5349.491798279158, 5402.054640437907, 5408.4050754416985, 5418.349798024262, 5435.592330575223, 5641.746121424546, 5672.120821272627, 5677.37548869624, 5678.432156784371, 5680.0, 5343.19852022192, 5349.190157490126, 5349.652272602269, 5351.357837059578, 5399.271098401666, 4812.639052071108, 4877.487863774323, 4892.730899800474, 4931.876703082452, 4937.8271760488215, 5910.1725758392995, 5929.525637948954, 5943.55423343251, 5943.70281485924, 5944.821655350346, 5664.971675141598, 5732.71336433185, 5734.340550836624, 5755.1942728017275, 5759.798407055733, 5811.796587119599, 5827.24245848037, 5828.184054232495, 5863.355030946507, 5881.911771323348, 5540.667559946416, 5589.524890384363, 5592.636478628876, 5594.300712410949, 5606.411326810626, 5599.076152434803, 5691.146328050825, 5694.316681998021, 5694.943050569441, 5743.827685169452, 5541.556675465872, 5546.528545073714, 5547.44525547442, 5565.220869078251, 5603.831885043455, 5487.039768040497, 5491.450854914477, 5502.2296878437855, 5503.367112781922, 5503.587230957774, 5423.186522021729, 5435.809746658848, 5464.863378415572, 5501.972490137524, 5587.888242235052, 5612.466815652507, 5618.85952851182, 5630.0991841305195, 5630.0991841305195, 5639.0, 5447.291852059207, 5504.614676972574, 5505.146702261156, 5507.091329930517, 5509.0359187141285], "value": 5235.476791800033, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.3917521653561, 661.7452280871864, 666.2937286476332, 670.8255853478096, 685.9314068593138, 29853.55219671704, 30525.542116868266, 37711.81144094282, 38348.42477362835, 38390.80804595973, 39626.40560391589, 40246.0, 40266.39600405996, 40370.79814600923, 40403.595964040425, 8560.571971401421, 8732.08313127122, 8741.25699315559, 8751.649934002633, 8752.343574231927, 8610.913890861106, 8732.08313127122, 8733.95633021834, 8735.1701588349, 8747.431416957908, 8722.956385218065, 8800.823983520326, 8934.151255630704, 8953.328500362499, 8958.86561701575, 8841.5579221039, 8882.11178882113, 8901.510416927067, 8903.866442003342, 8904.51025193614, 8754.649814007433, 8857.335699822475, 8862.468251904906, 8872.423292485968, 8872.822543549157, 39439.60560394388, 39798.0, 39908.40137397941, 40038.19923601541, 40052.59947400547, 3473.0796338970194, 3483.1814523586936, 3505.0536355184213, 3508.8771892983877, 3624.655657712513, 30159.849200754074, 30609.675678916115, 30762.0, 30984.53523197154, 31190.22024449384, 4230.196262710076, 4251.87244382669, 4287.549807270254, 4305.31115021595, 4337.175936572073, 269179.0, 270817.0, 271718.0, 271973.0, 272601.0, 35091.0, 36199.4570081449, 57267.71366143226, 57633.0, 57682.0, 34671.30657386838, 34731.0, 34803.0, 34814.30371392558, 34856.12859678528, 15021.849781502264, 15196.392144314104, 15200.087994720352, 15201.391944322324, 15214.0, 12031.0, 12034.0, 12039.75920481603, 12040.096992725581, 12042.277463352228, 8439.113893041265, 8498.150184981576, 8505.53219572917, 8544.444611100258, 8553.315734741205, 3213.5661685672135, 3313.4201514734823, 3314.287428202948, 3338.0486561329903, 3341.9498707519406, 1033.4367769565604, 1068.572570971602, 1100.741325788439, 1120.1318977792275, 1189.0903458853984, 32355.19112022218, 32595.348093038006, 32912.835435822664, 33453.49819752706, 33544.16139596481, 1076.8869268726828, 1085.2457542008228, 1158.102470585303, 1201.8017027190415, 1212.854457465092, 14906.552803415914, 15253.542393727985, 15470.0, 15724.528264152093, 15741.842581574267, 404386.0, 409344.0, 410080.0, 410263.0, 413278.0, 54607.72696136494, 55250.44749552533, 55440.44559554433, 55478.72260638671, 55524.0, 1269.4985480735058, 1346.7441186174594, 1361.8161548191065, 1393.909395889264, 1450.0129732750568, 29946.850265748533, 31514.36971260608, 31799.841000794848, 31987.0, 31997.520037198996, 46706.53293467022, 47377.76311118422, 48042.27936581024, 48049.279260810414, 48173.0, 393457.0, 399712.0, 403082.0, 403270.0, 405035.0, 37464.0, 43349.78325108354, 43500.564994349654, 44406.3339049908, 44864.32703509515, 42946.570534295504, 43761.0, 43970.560294396644, 44228.33657495076, 44260.336094959246, 39096.7529256637, 39786.0, 40415.59584404236, 40800.0, 41035.1792964145, 39642.40536391899, 39721.0, 40297.395539066354, 40923.59076409317, 41467.1706565873, 40619.390709138796, 41182.794086029375, 41365.37951930783, 41604.79197603992, 41826.1634767309, 35090.824545877105, 36335.0, 36388.636113639586, 36448.81775591105, 37004.25991480209, 28219.57670634901, 28274.0, 28332.291692707848, 28368.29079272952, 28377.432451350443], "value": 18383.47146903197, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.2218518592442, 389.6765684481882, 390.44408033984587, 396.0692372923628, 403.37275536540676, 14358.71282574348, 14604.999999999973, 16900.154992250384, 17795.822041779593, 17828.910855445738, 17017.0, 17558.0, 17880.552986175353, 18002.189901454432, 18537.90731046343, 5567.972160139204, 5669.546436285087, 5727.713614319288, 5765.164051212571, 5770.682612456313, 5540.418256083114, 5725.656460612356, 5738.512226460756, 5754.079347304432, 5757.050086735683, 5664.0, 5697.316322041361, 5700.173474846145, 5706.572007099463, 5707.3721890592005, 5565.30433695788, 5640.379558248589, 5691.146328050784, 5694.629849059818, 5697.230873832042, 4928.28539861718, 5009.524095210949, 5020.0, 5025.824096156617, 5142.408623008365, 22907.885460572757, 22969.196078137185, 23082.307530774102, 23257.88371058134, 23560.88219558891, 2266.88665566721, 2282.691836602054, 2345.0033735662446, 2610.699769526491, 2717.8992508034275, 14136.363863626162, 14240.786388204186, 14312.28438578067, 14339.354729037113, 14748.041377310441, 1922.1542521290728, 1941.4758015335922, 1963.852711046663, 1975.4863735428748, 2003.4390370696228, 72794.0, 74459.25540744577, 74831.25168748297, 75057.24942750557, 75992.0, 10050.09549140581, 10101.898981010096, 10297.794044119075, 10562.841557376645, 10953.34279943206, 14332.641683957776, 14372.0, 14412.351444184827, 14423.134611923319, 14435.711285774225, 7744.0, 7884.093329267208, 7887.290143886963, 7974.681012759424, 8068.354531637455, 7584.393248540104, 7626.923730762733, 7639.274268944552, 7688.38492920565, 7941.047074351115, 6441.549091563639, 6460.3862633049785, 6476.060971159155, 6480.222373315232, 6581.506387020897, 1841.6408800283816, 1851.4260579220215, 1854.6290741851415, 1899.2972600137762, 1915.0711904726197, 970.1026550440955, 990.6186118344489, 1020.9642662506776, 1055.4300677633992, 1118.3178261260625, 17956.640867182585, 18779.81220187808, 19640.0, 20173.293934712507, 20200.191992320437, 990.7721224118493, 1003.242551873331, 1004.3521928356315, 1028.573142146016, 1035.3529044347283, 10662.520186591622, 11291.887081129084, 11333.716657083638, 11429.542818287175, 11433.485493152828, 419442.0, 427553.0, 429710.0, 450237.0, 480044.0, 79631.60184199158, 80210.19789802143, 80677.0, 82495.17504824995, 83010.16989830145, 1091.1161958813386, 1117.7708569743345, 1156.3755571991198, 1157.311399717167, 1162.6686394377562, 16411.58971025734, 17017.574560636083, 17223.65552688964, 17326.566835829206, 17578.384756533458, 35734.28531429409, 36314.8184259077, 36812.0, 36812.079698007765, 37246.255074898894, 49105.263421047996, 49660.503394965584, 49908.0, 50021.749891250314, 50040.249396258354, 8404.285635720787, 8485.193906578865, 8558.957205213934, 8590.09803970599, 8810.074942130985, 11359.829602556134, 12375.844159739208, 13694.109882857583, 13741.0, 13972.650683732989, 11933.462994165457, 11960.880391195977, 12137.271763694207, 12262.570810021607, 12333.0, 9199.862002070107, 11727.237729547553, 11932.164748467523, 12043.935862822596, 12122.878771212529, 12406.0, 12427.565035223724, 12552.43514041852, 12652.873471265537, 12897.871021289668, 8549.444286121383, 8663.48019118855, 8742.038375778786, 8847.911520884967, 8888.11118888132, 11324.716882078013, 11831.11266654987, 11896.167268291136, 11925.105617078927, 12107.878921210675], "value": 9179.635849845903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.193483909655, 1536.4852774320602, 1564.7183506968747, 1731.5930756272273, 1854.7310639957207, 7967.92032079679, 8320.126386729396, 8320.251177394033, 8332.50004999699, 8341.916580834197, 8007.719729809458, 8229.67081316748, 8232.753017409472, 8240.752777416672, 8260.173982601751, 2015.8084981926693, 2260.762619924905, 2275.9089636414524, 2343.414146463384, 2371.288613415977, 2355.1756885090253, 2375.2161786610377, 2377.3937645900273, 2377.8811059446957, 2379.4765151666693, 2289.9656505152434, 2338.7778161074757, 2342.5666251743396, 2345.5692027863074, 2348.013834189636, 1979.980200197994, 2205.2502149269167, 2263.094762095175, 2269.4439862233694, 2271.0234599122373, 2270.2167752125492, 2283.1666441748807, 2288.187693368863, 2296.253717541789, 2297.448612333045, 8372.16278372164, 8458.66165353385, 8482.660693572312, 8493.830123397498, 8498.150184981514, 4979.427365852937, 5123.0, 5133.948660513422, 5136.5890728741615, 5175.301334319856, 3245.8863939761995, 3259.054874086512, 3310.486874534451, 3338.6160591532043, 3344.5986481622117, 1085.8154113800672, 1101.4547798839626, 1101.9889801101967, 1103.536514663835, 1139.5840518210875, 11270.380129092897, 11478.885211147865, 11515.884841151565, 11517.712057198552, 11521.193516453852, 4378.496472905656, 4393.143337049245, 4546.522615125365, 4572.245579479349, 4592.10453961481, 9871.950640246752, 9881.802363952824, 9891.455969921722, 9894.06006429388, 9904.356216845881, 4641.582257596832, 5099.719515426613, 5105.795768169306, 5114.207297868837, 5131.409887862944, 4669.766511674403, 4772.737499437495, 4779.211430114062, 4787.0904528139545, 4848.5636292733825, 3801.6578507933864, 3836.2135762168687, 3887.7667339959125, 3914.4911161548816, 3949.3878448840474, 1285.3830161522521, 1289.4842063174806, 1297.8247936528637, 1304.2174695182814, 1304.5955753716378, 952.9475878826593, 962.8892677342195, 966.7486453522135, 990.2523594685966, 995.1740055753708, 5690.857728556819, 5691.971540142273, 5706.115552089433, 5828.067509198508, 5855.502282306052, 1015.7663737340305, 1019.4138370437029, 1028.7428142964259, 1043.108142538119, 1093.4423444043596, 3830.8084595770656, 3957.604239576019, 3980.144268982183, 4015.277250095011, 4020.2160578686876, 10015.298929075041, 10307.020833020852, 10367.844482332772, 10486.737831554272, 10518.894811051945, 10353.43056131905, 10397.636082737068, 10429.5828166874, 10438.739031524121, 10459.372437653765, 7870.842583148305, 7892.684292628345, 7927.286544210933, 7948.364130869517, 7979.601019948979, 5575.553955683455, 5636.4927156556105, 5685.033544297562, 5713.428657134254, 5813.157092221689, 9463.763405914908, 9564.56959436841, 9669.98465161148, 9687.176589989647, 9700.0, 9417.340786144903, 9552.95223523878, 9688.321817472992, 9799.265055120752, 9807.06832850878, 6452.903206451813, 6656.201255849329, 6667.799966001027, 7142.107236595426, 7256.1655409628565, 7493.363064139609, 7660.616969151632, 7674.846503070019, 7688.807779805549, 7694.576798276148, 7128.108986376703, 7322.96338518304, 7384.704611815468, 7494.063242094739, 7614.581198034161, 7360.07999000125, 7377.225391333833, 7398.11222653285, 7406.370458511087, 7451.478396512192, 6517.478601711947, 6582.506312026521, 6588.143541339595, 6592.7033283503315, 6606.735730570724, 4815.0, 4901.607871370353, 4994.775235114356, 5086.415062267886, 5097.92353114711, 4845.709257444423, 4935.777889995031, 4984.127777638826, 5004.049230646166, 5059.721715305694], "value": 4496.731676581463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.01784557100837, 324.4209086780098, 324.73534069733165, 330.13175348832584, 330.8081312838554, 5671.432856714327, 5724.112762521805, 5756.251687280653, 5780.335261444935, 5785.797497087603, 5646.887062258752, 5659.547236221092, 5664.631798933066, 5669.291338582677, 5691.117876729103, 4152.57074611352, 4179.979100104495, 4313.82744690212, 4386.7367957922625, 4386.868393948171, 4340.804663790137, 4358.389825424443, 4367.890802729926, 4373.890652733691, 4382.9342559861625, 4113.239050775616, 4315.848945286915, 4344.348347747831, 4345.69580129391, 4357.520672725997, 4208.326667733163, 4315.072259464199, 4317.827286908504, 4332.870013899588, 4333.653307735373, 3775.8112094395447, 3777.6411240932343, 3784.4701741756176, 3785.3754130568423, 3788.45067465216, 5359.785608575652, 5428.267183930158, 5434.266374039494, 5439.0, 5455.699936503491, 4970.676906001135, 4979.053979743837, 4985.651004429691, 4985.975070124626, 5005.57452616528, 5857.326407463111, 5876.29484461863, 5903.114532820068, 5910.763569457216, 5918.549955260989, 4048.4939382577177, 4173.853915112987, 4177.811998460076, 4183.205191013728, 4189.97905010473, 6120.0, 6142.078688196806, 6148.815535533941, 6163.445289923929, 6180.0, 4240.194363071007, 4243.915121697611, 4251.659867210616, 4252.723572967747, 4253.128108737763, 4197.811098500575, 4300.849470268526, 4301.827926882889, 4307.956920430818, 4322.762248076323, 4946.650341087954, 4953.90092198154, 4967.329410529533, 4970.801167953314, 4990.725510096907, 5891.263592050994, 5906.143609176645, 5934.287885453773, 5944.970275148597, 5957.940420595825, 1479.289940828387, 1492.3508273900889, 1509.8565636264536, 1511.8261399939147, 1514.3412615512068, 948.7106432538142, 989.2827699917502, 1019.6125472320471, 1028.8662473878348, 1032.5353590884133, 5598.692071936082, 5686.857828554319, 5692.857678558069, 5697.3448053474385, 5699.116636921284, 6002.039673652194, 6075.665838378844, 6085.117657939662, 6085.300190478063, 6095.634261944208, 5520.834374968757, 5555.748153944487, 5597.552195824324, 5636.633618814764, 5715.057015592381, 3232.272738633789, 3239.0282915125367, 3244.588603957286, 3253.1541799132397, 3265.6734326567152, 6168.753249870045, 6207.96896015517, 6275.780347687809, 6279.591826531261, 6292.182016337847, 6209.0, 6225.159603453566, 6248.968755156195, 6252.874942501125, 6261.686915654199, 6180.907286390618, 6212.223472065992, 6267.435930766253, 6269.523538202476, 6275.152854364694, 6013.909791353046, 6069.150318955438, 6089.238845144357, 6092.573519853568, 6108.602940809011, 5948.078047902582, 5972.104184372205, 5998.7300571473515, 6025.3070896845675, 6036.0, 6037.305709843425, 6226.377362263737, 6280.0, 6282.874342513032, 6285.585743207925, 4279.144171165717, 4303.655707543327, 4307.39696442492, 4311.1808756336195, 4321.913561728811, 5941.551000886881, 6038.275406951194, 6049.122877182872, 6060.575759696779, 6101.694915254308, 5835.241418615553, 5902.38025007368, 5904.940950590439, 5926.0, 5938.376470470538, 5903.793367232298, 5930.495907847881, 5950.434708702666, 5953.345132035559, 5959.284885813557, 4990.251462280687, 5401.756920938488, 5739.770409183753, 5827.475527202572, 5883.146943693226, 5984.0, 6012.488938440281, 6013.158157857991, 6021.849453763691, 6085.482733967662, 5865.237519122486, 5870.236869207147, 5879.441453061952, 5903.203067585992, 5903.557233207441], "value": 4482.3271846523185, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.9243029481904, 729.6497681113066, 805.5368163306097, 870.9608067636956, 871.3377832847034, 14583.0, 14979.700405991887, 15024.17367044812, 15047.0, 15059.548213553611, 15581.065136091815, 15611.0, 15651.92174039131, 15661.686766264667, 15728.764068538982, 698.7519430602139, 819.8524265632184, 844.3835999720193, 845.3828705045321, 851.093585331623, 837.9078301386843, 842.4061036968923, 842.8609279468881, 843.4096132707099, 845.0366582096415, 870.0, 871.3551971541077, 871.5729292646621, 872.0973792125152, 872.8036191856845, 719.9424046076301, 855.2217482091329, 870.1298701298701, 876.3821505838368, 877.7805548612847, 648.844277373427, 649.8018104478132, 650.4893658478119, 651.1144843013498, 651.5048563092037, 14650.340734666966, 14693.632659183499, 14713.337899794535, 14720.705585888329, 14724.337404816702, 14073.71852562943, 14139.929300353535, 14163.64590885236, 14164.85835141656, 14171.149731016068, 11470.713232169179, 11614.593489227836, 11683.299002059819, 11743.412829358498, 11795.351255680935, 3770.9434358484646, 3773.3585290500682, 3859.8842034739005, 3871.9032024199337, 3911.061345277113, 55544.444555554735, 55810.44189558134, 56247.71876140634, 56656.71671641615, 56701.14948275821, 10775.299605525615, 10858.891411085788, 11109.111271098454, 11171.0, 11348.489317980711, 19039.333623323117, 19329.323473678352, 19342.516437089187, 19376.0, 19389.22443102288, 8144.796380090426, 8358.122397148212, 8375.288100511525, 8669.653213871501, 8706.347023973227, 4388.648908087345, 4788.377510923558, 4912.582430493377, 4922.4339200992345, 4940.802367905316, 3357.0600231935096, 3631.1466805300734, 3815.751976121543, 3817.6373244541724, 3840.251151025523, 530.2205757536416, 631.996840015797, 663.8041777675597, 664.4186336955164, 666.7066490744057, 679.3546131175403, 698.5215127637584, 725.6299287363377, 757.5454727163768, 792.9405294602927, 8840.071792461827, 8843.646254149762, 9046.715911359526, 9291.256699464027, 9330.440173589606, 602.7890238416607, 726.989095163573, 741.9443541734391, 758.2303961479104, 774.7404619452547, 4400.46843055916, 4594.173048851172, 4658.767061646972, 4709.858704238878, 4741.431028276629, 59474.21577352686, 61930.0, 62154.0, 62854.371456285764, 63093.684531577965, 52459.0, 53297.73351133297, 54359.45640543623, 54647.0, 55728.44271557314, 49440.0, 49757.50242497529, 50032.499675002786, 51037.48962510402, 52318.47681523136, 8653.783655408664, 8658.264047556027, 8737.21365077146, 8955.149260820212, 9053.502057386908, 32091.50718899309, 32734.0, 33364.1658958528, 33658.01027232123, 34081.31837363289, 42275.0, 43666.56333436625, 46123.30815037844, 46555.53444465648, 47181.0, 11225.382603956861, 11347.546098156312, 11438.256513326607, 11443.713907152387, 11572.0, 10685.358878467317, 10818.891811082103, 10873.565057397933, 10912.181586380895, 11151.83272250933, 11377.772444550897, 11458.140639451907, 11639.825402619137, 11683.474243659226, 11737.706557336134, 11801.586944456903, 11852.348120853436, 11924.0, 12044.096692747904, 12197.390130493617, 11494.425278735862, 11606.535738570363, 11657.242279251821, 11666.300021998708, 11740.471678774305, 9495.477748723886, 9521.381110227812, 9733.610655573697, 9841.311108222355, 10119.291649584458, 9357.719268421959, 10048.497958898759, 10055.547500362647, 10075.754193270024, 10140.188784897044], "value": 6722.333900414191, "unit": "score"}], "name": "dromaeo_css", "value": 7020.398547505355, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 105.0, 112.0, 111.0, 112.0, 100.0, 111.0, 110.0, 112.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 128.0, 153.0, 186.0, 128.0, 160.0, 147.0, 128.0, 181.0, 134.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 107.0, 108.0, 76.0, 73.0, 76.0, 117.0, 106.0, 72.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 159.0, 92.0, 92.0, 93.0, 148.0, 92.0, 92.0, 154.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 58.0, 58.0, 57.0, 58.0, 77.0, 55.0, 55.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 79.0, 81.0, 81.0, 81.0, 82.0, 81.0, 82.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 128.0, 128.0, 130.0, 127.0, 126.0, 126.0, 160.0, 130.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 166.0, 170.0, 163.0, 163.0, 169.0, 159.0, 164.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 68.0, 68.0, 68.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1540.5000000000002, "alertThreshold": 2.0}]} 14:21:13 INFO - Return code: 0 14:21:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:21:13 ERROR - # TBPL SUCCESS # 14:21:13 INFO - Running post-action listener: _resource_record_post_action 14:21:13 INFO - Running post-run listener: _resource_record_post_run 14:21:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533794816; Read time: 12; Write time: 905804 14:21:14 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250601472; Read time: 0; Write time: 437076 14:21:15 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283193344; Read time: 12; Write time: 468728 14:21:15 INFO - Running post-run listener: _upload_blobber_files 14:21:15 INFO - Blob upload gear active. 14:21:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:21:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:21:15 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'] 14:21:15 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 14:21:15 INFO - (blobuploader) - INFO - Open directory for files ... 14:21:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:21:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:21:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:16 INFO - (blobuploader) - INFO - Done attempting. 14:21:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:21:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:21:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:17 INFO - (blobuploader) - INFO - Done attempting. 14:21:17 INFO - (blobuploader) - INFO - Iteration through files over. 14:21:17 INFO - Return code: 0 14:21:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:21:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:21:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8cb82f4038f143df5d1eaf85f4c6a2cdbedfd65bbc3985436d042268e5f449fadcbda00e85164db598926f43fd593b1f6ac3a2083142386555c02df30ced56c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61ee994e2fbca70e2b9815c97371b33a77e3c8e4cdf73ea781ef69bf5170b8cd68c6323500b7ca27dcd446d4321fc7bc98b321c30759606dea64857683948db3"} 14:21:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:21:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:21:17 INFO - Contents: 14:21:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8cb82f4038f143df5d1eaf85f4c6a2cdbedfd65bbc3985436d042268e5f449fadcbda00e85164db598926f43fd593b1f6ac3a2083142386555c02df30ced56c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61ee994e2fbca70e2b9815c97371b33a77e3c8e4cdf73ea781ef69bf5170b8cd68c6323500b7ca27dcd446d4321fc7bc98b321c30759606dea64857683948db3"} 14:21:17 INFO - Running post-run listener: copy_logs_to_upload_dir 14:21:17 INFO - Copying logs to upload dir... 14:21:17 INFO - mkdir: /builds/slave/test/build/upload/logs 14:21:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.181542 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-14 14:21:16.986800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 14:21:16.989872) ========= 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=8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8cb82f4038f143df5d1eaf85f4c6a2cdbedfd65bbc3985436d042268e5f449fadcbda00e85164db598926f43fd593b1f6ac3a2083142386555c02df30ced56c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61ee994e2fbca70e2b9815c97371b33a77e3c8e4cdf73ea781ef69bf5170b8cd68c6323500b7ca27dcd446d4321fc7bc98b321c30759606dea64857683948db3"} build_url:https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010997 build_url: 'https://queue.taskcluster.net/v1/task/LZj-7sJkSWOU5MyUvPR6og/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8cb82f4038f143df5d1eaf85f4c6a2cdbedfd65bbc3985436d042268e5f449fadcbda00e85164db598926f43fd593b1f6ac3a2083142386555c02df30ced56c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61ee994e2fbca70e2b9815c97371b33a77e3c8e4cdf73ea781ef69bf5170b8cd68c6323500b7ca27dcd446d4321fc7bc98b321c30759606dea64857683948db3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 14:21:17.014272) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:21:17.014603) ========= 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=8783db0840cc980e80bb0bd400000236-1460665422.94613-1307962063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:21:17.099112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 14:21:17.099445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 14:21:17.099857) ========= ========= Total master_lag: 0.17 =========