builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1460981177.56 results: success (0) buildid: 20160418023526 builduid: 52c72749b3234e44af725b2f58548fed revision: 0ddbde569eb2bf0de98ca85452c5ac071bb3def8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:17.558373) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:17.558867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:17.559168) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:17.592795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:17.593191) ========= 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=a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 05:06:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-04-18 05:06:17 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113772 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:17.723862) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:17.724416) ========= 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=a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019887 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:17.779118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:17.779500) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ddbde569eb2bf0de98ca85452c5ac071bb3def8 --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 0ddbde569eb2bf0de98ca85452c5ac071bb3def8 --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=a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 05:06:18,120 truncating revision to first 12 chars 2016-04-18 05:06:18,120 Setting DEBUG logging. 2016-04-18 05:06:18,120 attempt 1/10 2016-04-18 05:06:18,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ddbde569eb2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 05:06:18,518 unpacking tar archive at: fx-team-0ddbde569eb2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:18.515148) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:18.515463) ========= script_repo_revision: 0ddbde569eb2bf0de98ca85452c5ac071bb3def8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:18.515865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:18.516474) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 05:06:18.524498) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-18 05:06:18.524853) ========= /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=a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:06:18 INFO - MultiFileLogger online at 20160418 05:06:18 in /builds/slave/test 05:06:18 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 05:06:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:06:18 INFO - {'append_to_log': False, 05:06:18 INFO - 'base_work_dir': '/builds/slave/test', 05:06:18 INFO - 'blob_upload_branch': 'Fx-Team', 05:06:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:06:18 INFO - 'branch': 'Fx-Team', 05:06:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:06:18 INFO - 'config_files': ('talos/linux_config.py',), 05:06:18 INFO - 'default_actions': ('clobber', 05:06:18 INFO - 'read-buildbot-config', 05:06:18 INFO - 'download-and-extract', 05:06:18 INFO - 'populate-webroot', 05:06:18 INFO - 'create-virtualenv', 05:06:18 INFO - 'install', 05:06:18 INFO - 'run-tests'), 05:06:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:06:18 INFO - 'download_minidump_stackwalk': True, 05:06:18 INFO - 'download_symbols': 'ondemand', 05:06:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:06:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:06:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:06:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:06:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:06:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:06:18 INFO - 'installer_path': 'installer.exe', 05:06:18 INFO - 'log_level': 'info', 05:06:18 INFO - 'log_name': 'talos', 05:06:18 INFO - 'log_to_console': True, 05:06:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:06:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:06:18 INFO - 'opt_config_files': (), 05:06:18 INFO - 'pip_index': False, 05:06:18 INFO - 'sps_profile': False, 05:06:18 INFO - 'sps_profile_interval': 0, 05:06:18 INFO - 'suite': 'dromaeojs', 05:06:18 INFO - 'system_bits': '32', 05:06:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:06:18 INFO - 'title': 'talos-linux64-ix-002', 05:06:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:06:18 INFO - 'use_talos_json': True, 05:06:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:06:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:06:18 INFO - 'work_dir': 'build'} 05:06:18 INFO - ##### 05:06:18 INFO - ##### Running clobber step. 05:06:18 INFO - ##### 05:06:18 INFO - Running pre-action listener: _resource_record_pre_action 05:06:18 INFO - Running main action method: clobber 05:06:18 INFO - rmtree: /builds/slave/test/build 05:06:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:06:19 INFO - Running post-action listener: _resource_record_post_action 05:06:19 INFO - ##### 05:06:19 INFO - ##### Running read-buildbot-config step. 05:06:19 INFO - ##### 05:06:19 INFO - Running pre-action listener: _resource_record_pre_action 05:06:19 INFO - Running main action method: read_buildbot_config 05:06:19 INFO - Using buildbot properties: 05:06:19 INFO - { 05:06:19 INFO - "project": "", 05:06:19 INFO - "product": "firefox", 05:06:19 INFO - "script_repo_revision": "production", 05:06:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:06:19 INFO - "repository": "", 05:06:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:06:19 INFO - "buildid": "20160418023526", 05:06:19 INFO - "pgo_build": "True", 05:06:19 INFO - "basedir": "/builds/slave/test", 05:06:19 INFO - "buildnumber": 584, 05:06:19 INFO - "slavename": "talos-linux64-ix-002", 05:06:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:06:19 INFO - "platform": "ubuntu64_hw", 05:06:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:06:19 INFO - "branch": "fx-team", 05:06:19 INFO - "repo_path": "integration/fx-team", 05:06:19 INFO - "revision": "0ddbde569eb2bf0de98ca85452c5ac071bb3def8", 05:06:19 INFO - "stage_platform": "linux64-pgo", 05:06:19 INFO - "builduid": "52c72749b3234e44af725b2f58548fed", 05:06:19 INFO - "slavebuilddir": "test" 05:06:19 INFO - } 05:06:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:06:19 INFO - Running post-action listener: _resource_record_post_action 05:06:19 INFO - ##### 05:06:19 INFO - ##### Running download-and-extract step. 05:06:19 INFO - ##### 05:06:19 INFO - Running pre-action listener: _resource_record_pre_action 05:06:19 INFO - Running main action method: download_and_extract 05:06:19 INFO - mkdir: /builds/slave/test/build/tests 05:06: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')]} 05:06:19 INFO - https://queue.taskcluster.net/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:06:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:06:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:06:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/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 05:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/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 05:06:21 INFO - Downloaded 1361 bytes. 05:06:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:06:21 INFO - Using the following test package requirements: 05:06:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:06:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:06:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:21 INFO - u'jsshell-linux-x86_64.zip'], 05:06:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:06:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:06:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:06:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:06:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:06:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:21 INFO - https://queue.taskcluster.net/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/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 05:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/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 05:06:23 INFO - Downloaded 23774970 bytes. 05:06:23 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'] 05:06:23 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 05:06:24 INFO - Return code: 0 05:06:24 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 05:06:24 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')]} 05:06:24 INFO - https://queue.taskcluster.net/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:06:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:06:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/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 05:06:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/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 05:06:29 INFO - Downloaded 23774970 bytes. 05:06:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:06:30 INFO - Return code: 0 05:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:30 INFO - https://queue.taskcluster.net/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/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 05:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/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 05:06:32 INFO - Downloaded 10841076 bytes. 05:06:32 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'] 05:06:32 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 05:06:32 INFO - Return code: 0 05:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:32 INFO - https://queue.taskcluster.net/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:06:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:06:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:06:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/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 05:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YoCdXpe7TRSXyMVOUHAbAA/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 05:06:33 INFO - Downloaded 58231487 bytes. 05:06:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:06:33 INFO - mkdir: /builds/slave/test/properties 05:06:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:33 INFO - Contents: 05:06:33 INFO - build_url:https://queue.taskcluster.net/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:06:34 INFO - Running post-action listener: _resource_record_post_action 05:06:34 INFO - Running post-action listener: set_extra_try_arguments 05:06:34 INFO - ##### 05:06:34 INFO - ##### Running populate-webroot step. 05:06:34 INFO - ##### 05:06:34 INFO - Running pre-action listener: _resource_record_pre_action 05:06:34 INFO - Running main action method: populate_webroot 05:06:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:06:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:06:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:06:34 INFO - '--tppagecycles', 05:06:34 INFO - '7'], 05:06:34 INFO - 'tests': ['tsvgm']}}, 05:06:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:06:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:06:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:06:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:06:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:06:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:06:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:34 INFO - 'talos_options': ['--disable-e10s'], 05:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:34 INFO - 'talos_options': ['--disable-e10s'], 05:06:34 INFO - 'tests': ['damp', 'tps']}, 05:06:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:34 INFO - 'tests': ['damp', 'tps']}, 05:06:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:06:34 INFO - 'tests': ['dromaeo_dom']}, 05:06:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:06:34 INFO - 'tests': ['a11yr', 05:06:34 INFO - 'ts_paint', 05:06:34 INFO - 'tpaint', 05:06:34 INFO - 'sessionrestore', 05:06:34 INFO - 'sessionrestore_no_auto_restore', 05:06:34 INFO - 'tabpaint']}, 05:06:34 INFO - 'other-e10s': {'tests': ['a11yr', 05:06:34 INFO - 'ts_paint', 05:06:34 INFO - 'tpaint', 05:06:34 INFO - 'sessionrestore', 05:06:34 INFO - 'sessionrestore_no_auto_restore', 05:06:34 INFO - 'tabpaint']}, 05:06:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:06:34 INFO - 'ts_paint', 05:06:34 INFO - 'tpaint', 05:06:34 INFO - 'sessionrestore', 05:06:34 INFO - 'sessionrestore_no_auto_restore', 05:06:34 INFO - 'tabpaint']}, 05:06:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:06:34 INFO - 'ts_paint', 05:06:34 INFO - 'tpaint', 05:06:34 INFO - 'sessionrestore', 05:06:34 INFO - 'sessionrestore_no_auto_restore', 05:06:34 INFO - 'tabpaint']}, 05:06:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:06:34 INFO - 'tests': ['a11yr', 05:06:34 INFO - 'ts_paint', 05:06:34 INFO - 'tpaint', 05:06:34 INFO - 'sessionrestore', 05:06:34 INFO - 'sessionrestore_no_auto_restore', 05:06:34 INFO - 'tabpaint']}, 05:06:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:06:34 INFO - 'tests': ['a11yr', 05:06:34 INFO - 'ts_paint', 05:06:34 INFO - 'tpaint', 05:06:34 INFO - 'sessionrestore', 05:06:34 INFO - 'sessionrestore_no_auto_restore', 05:06:34 INFO - 'tabpaint']}, 05:06:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:06:34 INFO - 'tests': ['tsvgx', 05:06:34 INFO - 'tsvgr_opacity', 05:06:34 INFO - 'tart', 05:06:34 INFO - 'tscrollx', 05:06:34 INFO - 'cart']}, 05:06:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:06:34 INFO - 'tsvgr_opacity', 05:06:34 INFO - 'tart', 05:06:34 INFO - 'tscrollx', 05:06:34 INFO - 'cart']}, 05:06:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:34 INFO - 'talos_options': ['--disable-e10s'], 05:06:34 INFO - 'tests': ['tp5o']}, 05:06:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:34 INFO - 'tests': ['tp5o']}, 05:06:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:34 INFO - 'talos_options': ['--disable-e10s', 05:06:34 INFO - '--xperf_path', 05:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:34 INFO - 'tests': ['tp5n']}, 05:06:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:34 INFO - 'talos_options': ['--xperf_path', 05:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:34 INFO - 'tests': ['tp5n']}}, 05:06:34 INFO - 'talos.zip': {'path': '', 05:06:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:06:34 INFO - Running post-action listener: _resource_record_post_action 05:06:34 INFO - ##### 05:06:34 INFO - ##### Running create-virtualenv step. 05:06:34 INFO - ##### 05:06:34 INFO - Running pre-action listener: _resource_record_pre_action 05:06:34 INFO - Running main action method: create_virtualenv 05:06:34 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:34 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 05:06:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:34 INFO - Using real prefix '/usr' 05:06:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:37 INFO - Installing pip.................done. 05:06:37 INFO - Return code: 0 05:06:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:37 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')]} 05:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:37 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')]} 05:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:37 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 0x7fe6a9feaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c810>, '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 0x1a3d710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3dba0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', '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 05:06:37 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 05:06:37 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 05:06:37 INFO - Using env: {'DISPLAY': ':0', 05:06:37 INFO - 'HOME': '/home/cltbld', 05:06:37 INFO - 'LANG': 'en_US.UTF-8', 05:06:37 INFO - 'LANGUAGE': 'en_US:en', 05:06:37 INFO - 'LOGNAME': 'cltbld', 05:06:37 INFO - 'MAIL': '/var/mail/cltbld', 05:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:37 INFO - 'MOZ_NO_REMOTE': '1', 05:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:37 INFO - 'NO_EM_RESTART': '1', 05:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:37 INFO - 'PWD': '/builds/slave/test', 05:06:37 INFO - 'SHELL': '/bin/bash', 05:06:37 INFO - 'SHLVL': '1', 05:06:37 INFO - 'TERM': 'linux', 05:06:37 INFO - 'TMOUT': '86400', 05:06:37 INFO - 'USER': 'cltbld', 05:06:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', 05:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:37 INFO - '_': '/tools/buildbot/bin/python'} 05:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:37 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 05:06:37 INFO - Cleaning up... 05:06:37 INFO - Return code: 0 05:06:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:06:37 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')]} 05:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:37 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')]} 05:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:37 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 0x7fe6a9feaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c810>, '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 0x1a3d710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3dba0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', '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 05:06:37 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 05:06:37 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 05:06:37 INFO - Using env: {'DISPLAY': ':0', 05:06:37 INFO - 'HOME': '/home/cltbld', 05:06:37 INFO - 'LANG': 'en_US.UTF-8', 05:06:37 INFO - 'LANGUAGE': 'en_US:en', 05:06:37 INFO - 'LOGNAME': 'cltbld', 05:06:37 INFO - 'MAIL': '/var/mail/cltbld', 05:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:37 INFO - 'MOZ_NO_REMOTE': '1', 05:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:37 INFO - 'NO_EM_RESTART': '1', 05:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:37 INFO - 'PWD': '/builds/slave/test', 05:06:37 INFO - 'SHELL': '/bin/bash', 05:06:37 INFO - 'SHLVL': '1', 05:06:37 INFO - 'TERM': 'linux', 05:06:37 INFO - 'TMOUT': '86400', 05:06:37 INFO - 'USER': 'cltbld', 05:06:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', 05:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:37 INFO - '_': '/tools/buildbot/bin/python'} 05:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:37 INFO - Downloading/unpacking psutil>=0.7.1 05:06:37 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 05:06:37 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 05:06:37 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 05:06:37 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 05:06:37 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 05:06:37 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 05:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:39 INFO - Installing collected packages: psutil 05:06:39 INFO - Running setup.py install for psutil 05:06:39 INFO - building 'psutil._psutil_linux' extension 05:06:39 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 05:06:39 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 05:06:39 INFO - building 'psutil._psutil_posix' extension 05:06:39 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 05:06:40 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 05:06:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:40 INFO - Successfully installed psutil 05:06:40 INFO - Cleaning up... 05:06:40 INFO - Return code: 0 05:06:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:40 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 0x7fe6a9feaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c810>, '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 0x1a3d710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3dba0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', '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 05:06:40 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 05:06:40 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 05:06:40 INFO - Using env: {'DISPLAY': ':0', 05:06:40 INFO - 'HOME': '/home/cltbld', 05:06:40 INFO - 'LANG': 'en_US.UTF-8', 05:06:40 INFO - 'LANGUAGE': 'en_US:en', 05:06:40 INFO - 'LOGNAME': 'cltbld', 05:06:40 INFO - 'MAIL': '/var/mail/cltbld', 05:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:40 INFO - 'MOZ_NO_REMOTE': '1', 05:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:40 INFO - 'NO_EM_RESTART': '1', 05:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:40 INFO - 'PWD': '/builds/slave/test', 05:06:40 INFO - 'SHELL': '/bin/bash', 05:06:40 INFO - 'SHLVL': '1', 05:06:40 INFO - 'TERM': 'linux', 05:06:40 INFO - 'TMOUT': '86400', 05:06:40 INFO - 'USER': 'cltbld', 05:06:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', 05:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:40 INFO - '_': '/tools/buildbot/bin/python'} 05:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:06:40 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 05:06:40 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 05:06:40 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 05:06:40 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 05:06:40 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 05:06:40 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 05:06:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:06:42 INFO - Installing collected packages: mozsystemmonitor 05:06:42 INFO - Running setup.py install for mozsystemmonitor 05:06:42 INFO - Successfully installed mozsystemmonitor 05:06:42 INFO - Cleaning up... 05:06:42 INFO - Return code: 0 05:06:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:42 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')]} 05:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:42 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')]} 05:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:42 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 0x7fe6a9feaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c810>, '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 0x1a3d710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3dba0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', '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 05:06:42 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 05:06:42 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 05:06:42 INFO - Using env: {'DISPLAY': ':0', 05:06:42 INFO - 'HOME': '/home/cltbld', 05:06:42 INFO - 'LANG': 'en_US.UTF-8', 05:06:42 INFO - 'LANGUAGE': 'en_US:en', 05:06:42 INFO - 'LOGNAME': 'cltbld', 05:06:42 INFO - 'MAIL': '/var/mail/cltbld', 05:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:42 INFO - 'MOZ_NO_REMOTE': '1', 05:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:42 INFO - 'NO_EM_RESTART': '1', 05:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:42 INFO - 'PWD': '/builds/slave/test', 05:06:42 INFO - 'SHELL': '/bin/bash', 05:06:42 INFO - 'SHLVL': '1', 05:06:42 INFO - 'TERM': 'linux', 05:06:42 INFO - 'TMOUT': '86400', 05:06:42 INFO - 'USER': 'cltbld', 05:06:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', 05:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:42 INFO - '_': '/tools/buildbot/bin/python'} 05:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:42 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 05:06:42 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 05:06:42 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 05:06:42 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 05:06:42 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 05:06:42 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 05:06:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06:44 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 05:06:44 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 05:06:44 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 05:06:44 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 05:06:44 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 05:06:44 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 05:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06:44 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 05:06:44 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 05:06:44 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 05:06:44 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 05:06:44 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 05:06:44 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 05:06:45 INFO - Downloading docopt-0.6.1.tar.gz 05:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:45 INFO - Running setup.py install for blobuploader 05:06:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:45 INFO - Running setup.py install for requests 05:06:45 INFO - Running setup.py install for docopt 05:06:45 INFO - Successfully installed blobuploader requests docopt 05:06:45 INFO - Cleaning up... 05:06:45 INFO - Return code: 0 05:06:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:45 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')]} 05:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:45 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')]} 05:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:45 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 0x7fe6a9feaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c810>, '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 0x1a3d710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3dba0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', '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 05:06:45 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 05:06:45 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 05:06:45 INFO - Using env: {'DISPLAY': ':0', 05:06:45 INFO - 'HOME': '/home/cltbld', 05:06:45 INFO - 'LANG': 'en_US.UTF-8', 05:06:45 INFO - 'LANGUAGE': 'en_US:en', 05:06:45 INFO - 'LOGNAME': 'cltbld', 05:06:45 INFO - 'MAIL': '/var/mail/cltbld', 05:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:45 INFO - 'MOZ_NO_REMOTE': '1', 05:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:45 INFO - 'NO_EM_RESTART': '1', 05:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:45 INFO - 'PWD': '/builds/slave/test', 05:06:45 INFO - 'SHELL': '/bin/bash', 05:06:45 INFO - 'SHLVL': '1', 05:06:45 INFO - 'TERM': 'linux', 05:06:45 INFO - 'TMOUT': '86400', 05:06:45 INFO - 'USER': 'cltbld', 05:06:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', 05:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:45 INFO - '_': '/tools/buildbot/bin/python'} 05:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:46 INFO - Running setup.py (path:/tmp/pip-BwgkKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:46 INFO - Running setup.py (path:/tmp/pip-i4lZDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:46 INFO - Running setup.py (path:/tmp/pip-V4L0ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:46 INFO - Running setup.py (path:/tmp/pip-D2Yq9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:46 INFO - Running setup.py (path:/tmp/pip-dr13eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:46 INFO - Running setup.py (path:/tmp/pip-VUsnqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:46 INFO - Running setup.py (path:/tmp/pip-rl0cTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:46 INFO - Running setup.py (path:/tmp/pip-tE7gtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:46 INFO - Running setup.py (path:/tmp/pip-srY0ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:46 INFO - Running setup.py (path:/tmp/pip-LJvFrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:46 INFO - Running setup.py (path:/tmp/pip-jMNKRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:46 INFO - Running setup.py (path:/tmp/pip-34UG34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:46 INFO - Running setup.py (path:/tmp/pip-5s0W1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:47 INFO - Running setup.py (path:/tmp/pip-iveBcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:47 INFO - Running setup.py (path:/tmp/pip-_JGs6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:47 INFO - Running setup.py (path:/tmp/pip-LKrX1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:47 INFO - Running setup.py (path:/tmp/pip-KSYuPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:47 INFO - Running setup.py install for manifestparser 05:06:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:47 INFO - Running setup.py install for mozcrash 05:06:47 INFO - Running setup.py install for mozdebug 05:06:47 INFO - Running setup.py install for mozdevice 05:06:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:47 INFO - Running setup.py install for mozfile 05:06:47 INFO - Running setup.py install for mozhttpd 05:06:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:47 INFO - Running setup.py install for mozinfo 05:06:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:48 INFO - Running setup.py install for mozInstall 05:06:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:48 INFO - Running setup.py install for mozleak 05:06:48 INFO - Running setup.py install for mozlog 05:06:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:48 INFO - Running setup.py install for moznetwork 05:06:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:48 INFO - Running setup.py install for mozprocess 05:06:48 INFO - Running setup.py install for mozprofile 05:06:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:48 INFO - Running setup.py install for mozrunner 05:06:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:48 INFO - Running setup.py install for mozscreenshot 05:06:48 INFO - Running setup.py install for moztest 05:06:48 INFO - Running setup.py install for mozversion 05:06:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:49 INFO - Cleaning up... 05:06:49 INFO - Return code: 0 05:06:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:49 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')]} 05:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:49 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')]} 05:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:49 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 0x7fe6a9feaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c810>, '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 0x1a3d710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3dba0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', '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 05:06:49 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 05:06:49 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 05:06:49 INFO - Using env: {'DISPLAY': ':0', 05:06:49 INFO - 'HOME': '/home/cltbld', 05:06:49 INFO - 'LANG': 'en_US.UTF-8', 05:06:49 INFO - 'LANGUAGE': 'en_US:en', 05:06:49 INFO - 'LOGNAME': 'cltbld', 05:06:49 INFO - 'MAIL': '/var/mail/cltbld', 05:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:49 INFO - 'MOZ_NO_REMOTE': '1', 05:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:49 INFO - 'NO_EM_RESTART': '1', 05:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:49 INFO - 'PWD': '/builds/slave/test', 05:06:49 INFO - 'SHELL': '/bin/bash', 05:06:49 INFO - 'SHLVL': '1', 05:06:49 INFO - 'TERM': 'linux', 05:06:49 INFO - 'TMOUT': '86400', 05:06:49 INFO - 'USER': 'cltbld', 05:06:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', 05:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:49 INFO - '_': '/tools/buildbot/bin/python'} 05:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:49 INFO - Running setup.py (path:/tmp/pip-9aZzXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:49 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)) 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:49 INFO - Running setup.py (path:/tmp/pip-tnWddr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:49 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)) 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:49 INFO - Running setup.py (path:/tmp/pip-JBeEPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:49 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)) 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:49 INFO - Running setup.py (path:/tmp/pip-_GgTt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:49 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)) 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:49 INFO - Running setup.py (path:/tmp/pip-InFbVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:49 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)) 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:49 INFO - Running setup.py (path:/tmp/pip-U5Jigr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:49 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)) 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:49 INFO - Running setup.py (path:/tmp/pip-m467eX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:49 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)) 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:49 INFO - Running setup.py (path:/tmp/pip-luZ3g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:49 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)) 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:49 INFO - Running setup.py (path:/tmp/pip-XAlQWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:49 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)) 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:49 INFO - Running setup.py (path:/tmp/pip-P_dI_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:50 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)) 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:50 INFO - Running setup.py (path:/tmp/pip-Trgcu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:50 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)) 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:50 INFO - Running setup.py (path:/tmp/pip-EO1NE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:50 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)) 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:50 INFO - Running setup.py (path:/tmp/pip-ADHlvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:50 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)) 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:50 INFO - Running setup.py (path:/tmp/pip-E5I7bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:50 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)) 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:50 INFO - Running setup.py (path:/tmp/pip-1akvH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:50 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)) 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:50 INFO - Running setup.py (path:/tmp/pip-vKh0Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:50 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)) 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:50 INFO - Running setup.py (path:/tmp/pip-8qipy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:50 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)) 05:06:50 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)) 05:06:50 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)) 05:06:50 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)) 05:06:50 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)) 05:06:50 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)) 05:06:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:52 INFO - Downloading blessings-1.6.tar.gz 05:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:52 INFO - Installing collected packages: blessings 05:06:52 INFO - Running setup.py install for blessings 05:06:52 INFO - Successfully installed blessings 05:06:52 INFO - Cleaning up... 05:06:52 INFO - Return code: 0 05:06:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:52 INFO - Reading from file tmpfile_stdout 05:06:52 INFO - Current package versions: 05:06:52 INFO - argparse == 1.2.1 05:06:52 INFO - blessings == 1.6 05:06:52 INFO - blobuploader == 1.2.4 05:06:52 INFO - docopt == 0.6.1 05:06:52 INFO - manifestparser == 1.1 05:06:52 INFO - mozInstall == 1.12 05:06:52 INFO - mozcrash == 0.17 05:06:52 INFO - mozdebug == 0.1 05:06:52 INFO - mozdevice == 0.48 05:06:52 INFO - mozfile == 1.2 05:06:52 INFO - mozhttpd == 0.7 05:06:52 INFO - mozinfo == 0.9 05:06:52 INFO - mozleak == 0.1 05:06:52 INFO - mozlog == 3.1 05:06:52 INFO - moznetwork == 0.27 05:06:52 INFO - mozprocess == 0.22 05:06:52 INFO - mozprofile == 0.28 05:06:52 INFO - mozrunner == 6.11 05:06:52 INFO - mozscreenshot == 0.1 05:06:52 INFO - mozsystemmonitor == 0.0 05:06:52 INFO - moztest == 0.7 05:06:52 INFO - mozversion == 1.4 05:06:52 INFO - psutil == 3.1.1 05:06:52 INFO - requests == 1.2.3 05:06:52 INFO - wsgiref == 0.1.2 05:06:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:52 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 0x7fe6a9feaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c810>, '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 0x1a3d710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3dba0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', '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 05:06:52 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 05:06:52 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 05:06:52 INFO - Using env: {'DISPLAY': ':0', 05:06:52 INFO - 'HOME': '/home/cltbld', 05:06:52 INFO - 'LANG': 'en_US.UTF-8', 05:06:52 INFO - 'LANGUAGE': 'en_US:en', 05:06:52 INFO - 'LOGNAME': 'cltbld', 05:06:52 INFO - 'MAIL': '/var/mail/cltbld', 05:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:52 INFO - 'MOZ_NO_REMOTE': '1', 05:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:52 INFO - 'NO_EM_RESTART': '1', 05:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:52 INFO - 'PWD': '/builds/slave/test', 05:06:52 INFO - 'SHELL': '/bin/bash', 05:06:52 INFO - 'SHLVL': '1', 05:06:52 INFO - 'TERM': 'linux', 05:06:52 INFO - 'TMOUT': '86400', 05:06:52 INFO - 'USER': 'cltbld', 05:06:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', 05:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:52 INFO - '_': '/tools/buildbot/bin/python'} 05:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:53 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)) 05:06:53 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)) 05:06:53 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)) 05:06:53 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)) 05:06:53 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)) 05:06:53 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)) 05:06:53 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)) 05:06:53 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)) 05:06:53 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)) 05:06:53 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)) 05:06:53 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)) 05:06:53 INFO - Cleaning up... 05:06:53 INFO - Return code: 0 05:06:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6a9feaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c810>, '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 0x1a3d710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3dba0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', '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 05:06:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:06:53 INFO - Using env: {'DISPLAY': ':0', 05:06:53 INFO - 'HOME': '/home/cltbld', 05:06:53 INFO - 'LANG': 'en_US.UTF-8', 05:06:53 INFO - 'LANGUAGE': 'en_US:en', 05:06:53 INFO - 'LOGNAME': 'cltbld', 05:06:53 INFO - 'MAIL': '/var/mail/cltbld', 05:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:53 INFO - 'MOZ_NO_REMOTE': '1', 05:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:53 INFO - 'NO_EM_RESTART': '1', 05:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:53 INFO - 'PWD': '/builds/slave/test', 05:06:53 INFO - 'SHELL': '/bin/bash', 05:06:53 INFO - 'SHLVL': '1', 05:06:53 INFO - 'TERM': 'linux', 05:06:53 INFO - 'TMOUT': '86400', 05:06:53 INFO - 'USER': 'cltbld', 05:06:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', 05:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:53 INFO - '_': '/tools/buildbot/bin/python'} 05:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:53 INFO - Downloading/unpacking jsonschema 05:06:53 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 05:06:53 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 05:06:53 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 05:06:53 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 05:06:53 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 05:06:53 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 05:06:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:55 INFO - Downloading/unpacking functools32 (from jsonschema) 05:06:55 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 05:06:55 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 05:06:55 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 05:06:55 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 05:06:55 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 05:06:55 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 05:06:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:55 INFO - warning: no files found matching '*.txt' 05:06:55 INFO - no previously-included directories found matching 'build' 05:06:55 INFO - no previously-included directories found matching 'dist' 05:06:55 INFO - no previously-included directories found matching '.git*' 05:06:55 INFO - Installing collected packages: jsonschema, functools32 05:06:55 INFO - Running setup.py install for functools32 05:06:55 INFO - warning: no files found matching '*.txt' 05:06:55 INFO - no previously-included directories found matching 'build' 05:06:55 INFO - no previously-included directories found matching 'dist' 05:06:55 INFO - no previously-included directories found matching '.git*' 05:06:55 INFO - Successfully installed jsonschema functools32 05:06:55 INFO - Cleaning up... 05:06:55 INFO - Return code: 0 05:06:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:55 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 0x7fe6a9feaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ad9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3c810>, '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 0x1a3d710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3dba0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', '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 05:06:55 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 05:06:55 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 05:06:55 INFO - Using env: {'DISPLAY': ':0', 05:06:55 INFO - 'HOME': '/home/cltbld', 05:06:55 INFO - 'LANG': 'en_US.UTF-8', 05:06:55 INFO - 'LANGUAGE': 'en_US:en', 05:06:55 INFO - 'LOGNAME': 'cltbld', 05:06:55 INFO - 'MAIL': '/var/mail/cltbld', 05:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:55 INFO - 'MOZ_NO_REMOTE': '1', 05:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:55 INFO - 'NO_EM_RESTART': '1', 05:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:55 INFO - 'PWD': '/builds/slave/test', 05:06:55 INFO - 'SHELL': '/bin/bash', 05:06:55 INFO - 'SHLVL': '1', 05:06:55 INFO - 'TERM': 'linux', 05:06:55 INFO - 'TMOUT': '86400', 05:06:55 INFO - 'USER': 'cltbld', 05:06:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', 05:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:55 INFO - '_': '/tools/buildbot/bin/python'} 05:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:55 INFO - Downloading/unpacking flake8 05:06:55 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 05:06:55 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 05:06:55 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 05:06:55 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 05:06:55 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 05:06:55 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 05:06:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:06:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:06:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:06:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:58 INFO - no previously-included directories found matching 'docs/_build' 05:06:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:06:58 INFO - Running setup.py install for pep8 05:06:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:58 INFO - no previously-included directories found matching 'docs/_build' 05:06:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:06:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:06:58 INFO - Cleaning up... 05:06:58 INFO - Return code: 0 05:06:58 INFO - Running post-action listener: _resource_record_post_action 05:06:58 INFO - Running post-action listener: _start_resource_monitoring 05:06:58 INFO - Starting resource monitoring. 05:06:58 INFO - ##### 05:06:58 INFO - ##### Running install step. 05:06:58 INFO - ##### 05:06:58 INFO - Running pre-action listener: _resource_record_pre_action 05:06:58 INFO - Running main action method: install 05:06:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:58 INFO - Reading from file tmpfile_stdout 05:06:58 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:59 INFO - Reading from file tmpfile_stdout 05:06:59 INFO - Output received: 05:06:59 INFO - Usage: mozinstall [options] installer 05:06:59 INFO - Options: 05:06:59 INFO - -h, --help show this help message and exit 05:06:59 INFO - -d DEST, --destination=DEST 05:06:59 INFO - Directory to install application into. [default: 05:06:59 INFO - "/builds/slave/test"] 05:06:59 INFO - --app=APP Application being installed. [default: firefox] 05:06:59 INFO - mkdir: /builds/slave/test/build/application 05:06:59 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'] 05:06:59 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 05:07:15 INFO - Reading from file tmpfile_stdout 05:07:15 INFO - Output received: 05:07:15 INFO - /builds/slave/test/build/application/firefox/firefox 05:07:15 INFO - Running post-action listener: _resource_record_post_action 05:07:15 INFO - ##### 05:07:15 INFO - ##### Running run-tests step. 05:07:15 INFO - ##### 05:07:15 INFO - Running pre-action listener: _resource_record_pre_action 05:07:15 INFO - Running main action method: run_tests 05:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:07:15 INFO - Python 2.7.3 05:07:15 INFO - Return code: 0 05:07:15 INFO - grabbing minidump binary from tooltool 05:07:15 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')]} 05:07:15 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 0x1a3c810>, '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 0x1a3d710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3dba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:07:15 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 05:07:15 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 05:07:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:07:15 INFO - Return code: 0 05:07:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:07:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:07:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:07:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:07:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:07:16 INFO - Return code: 0 05:07:16 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/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 05:07:16 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/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 05:07:16 INFO - Using env: {'DISPLAY': ':0', 05:07:16 INFO - 'HOME': '/home/cltbld', 05:07:16 INFO - 'LANG': 'en_US.UTF-8', 05:07:16 INFO - 'LANGUAGE': 'en_US:en', 05:07:16 INFO - 'LOGNAME': 'cltbld', 05:07:16 INFO - 'MAIL': '/var/mail/cltbld', 05:07:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:07:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:16 INFO - 'MOZ_NO_REMOTE': '1', 05:07:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:16 INFO - 'NO_EM_RESTART': '1', 05:07:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:16 INFO - 'PWD': '/builds/slave/test', 05:07:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:07:16 INFO - 'SHELL': '/bin/bash', 05:07:16 INFO - 'SHLVL': '1', 05:07:16 INFO - 'TERM': 'linux', 05:07:16 INFO - 'TMOUT': '86400', 05:07:16 INFO - 'USER': 'cltbld', 05:07:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431', 05:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:16 INFO - '_': '/tools/buildbot/bin/python'} 05:07:16 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/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 05:07:16 INFO - mozversion application_buildid: 20160418023526 05:07:16 INFO - mozversion application_changeset: 0ddbde569eb2bf0de98ca85452c5ac071bb3def8 05:07:16 INFO - mozversion application_display_name: Nightly 05:07:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:07:16 INFO - mozversion application_name: Firefox 05:07:16 INFO - mozversion application_remotingname: firefox 05:07:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:07:16 INFO - mozversion application_vendor: Mozilla 05:07:16 INFO - mozversion application_version: 48.0a1 05:07:16 INFO - mozversion platform_buildid: 20160418023526 05:07:16 INFO - mozversion platform_changeset: 0ddbde569eb2bf0de98ca85452c5ac071bb3def8 05:07:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:07:16 INFO - mozversion platform_version: 48.0a1 05:07:16 INFO - using testdate: 1460981236 05:07:16 INFO - actual date: 1460981236 05:07:16 INFO - starting webserver on 'localhost:53945' 05:07:16 INFO - SUITE-START | Running 2 tests 05:07:16 INFO - TEST-START | dromaeo_css 05:07:16 INFO - operating with platform_type : linux_ 05:07:16 INFO - Initialising browser for dromaeo_css test... 05:07:16 INFO - TEST-INFO | started process 23313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGbL2pH/profile http://localhost:53945/getInfo.html) 05:07:20 INFO - PROCESS | 23313 | __metrics Screen width/height:1600/1200 05:07:20 INFO - PROCESS | 23313 | colorDepth:24 05:07:20 INFO - PROCESS | 23313 | Browser inner width/height: 1024/697 05:07:20 INFO - PROCESS | 23313 | __metrics 05:07:22 ERROR - PROCESS | 23313 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:07:22 INFO - TEST-INFO | 23313: exit 0 05:07:22 INFO - Browser initialized. 05:07:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:22 INFO - TEST-INFO | started process 23394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGbL2pH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:34 INFO - PROCESS | 23394 | RSS: Main: 153210880 05:07:34 INFO - PROCESS | 23394 | 05:08:25 INFO - PROCESS | 23394 | 1460981305656 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] 05:10:33 INFO - PROCESS | 23394 | Cycle 1(1): loaded http://localhost:53945/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53945/tests/dromaeo/cssquery-ext.html) 05:10:34 INFO - PROCESS | 23394 | RSS: Main: 252407808 05:10:34 INFO - PROCESS | 23394 | 05:13:36 INFO - PROCESS | 23394 | Cycle 1(1): loaded http://localhost:53945/tests/dromaeo/cssquery-ext.html (next: http://localhost:53945/tests/dromaeo/cssquery-jquery.html) 05:13:37 INFO - PROCESS | 23394 | RSS: Main: 234434560 05:13:37 INFO - PROCESS | 23394 | 05:16:38 INFO - PROCESS | 23394 | Cycle 1(1): loaded http://localhost:53945/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53945/tests/dromaeo/cssquery-mootools.html) 05:16:39 INFO - PROCESS | 23394 | RSS: Main: 228622336 05:16:39 INFO - PROCESS | 23394 | 05:19:41 INFO - PROCESS | 23394 | Cycle 1(1): loaded http://localhost:53945/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53945/tests/dromaeo/cssquery-prototype.html) 05:19:42 INFO - PROCESS | 23394 | RSS: Main: 227553280 05:19:42 INFO - PROCESS | 23394 | 05:22:44 INFO - PROCESS | 23394 | Cycle 1(1): loaded http://localhost:53945/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53945/tests/dromaeo/cssquery-yui.html) 05:22:45 INFO - PROCESS | 23394 | RSS: Main: 221851648 05:22:45 INFO - PROCESS | 23394 | 05:25:47 INFO - PROCESS | 23394 | Cycle 1(1): loaded http://localhost:53945/tests/dromaeo/cssquery-yui.html (next: http://localhost:53945/tests/dromaeo/cssquery-dojo.html) 05:25:47 INFO - PROCESS | 23394 | RSS: Main: 262090752 05:25:47 INFO - PROCESS | 23394 | 05:25:47 INFO - PROCESS | 23394 | __start_tp_report 05:25:47 INFO - PROCESS | 23394 | _x_x_mozilla_page_load 05:25:47 INFO - PROCESS | 23394 | _x_x_mozilla_page_load_details 05:25:47 INFO - PROCESS | 23394 | |i|pagename|runs| 05:25:47 INFO - PROCESS | 23394 | |0;dojo.html;3020.622422197225;3070.4473194824923;3105.0684794561625;3108.4870996285613;3131.4833052546333;5185.870353241171;5237.214417837322;5269.367675878891;5273.841784746459;5290.180022096576;5237.9785941741375;5276.023935571922;5281.287026251455;5287.154055351145;5349.010433069885;4703.176944034797;4747.477777444478;4795.0889331027165;4800.135975524404;4855.854324370274;4756.90486190276;4783.545563171493;4787.71273723576;4828.420589529262;4870.391201099863;4660.930086048712;4676.064787042588;4742.691725037878;4777.06847164803;4783.473817880031;4698.483166851644;4719.032598317371;4723.598494128003;4725.196716558159;4751.857444276678;4639.072185562901;4684.648651351163;4690.413698287714;4714.269288260325;4736.076465089309;5130.51260130287;5158.174692049254;5159.14874045782;5178.482151784829;5200.479952004807;5502.614816962814;5534.059209934321;5536.363318218416;5542.307211598551;5546.084895992157;5510.366307874566;5563.527100196488;5577.581681373913;5585.525230355424;5622.437756224344;5164.561012313995;5169.405518365398;5179.974100129513;5220.112580861262;5227.660202086852;5641.633293835887;5642.125470552071;5645.379008309083;5652.717364131777;5660;5359.410464848864;5409.377921539073;5413.729313534308;5496.6701997880255;5522.447755224526;5482.122860342326;5501.834944951658;5505.421930697299;5513.917291240635;5515.779368825202;5447.591430642718;5450.264214331094;5458.6724796512335;5480.04099282624;5504.80733174345;5403.621746477787;5511.807086751945;5559.555235581144;5589.413111623302;5621.297337832771;4215.873523794291;4221.598948099926;4223.113146239262;4226.894327641833;4255.404243405926;3716.3867961786004;3800.4299355096955;3803.2773772983046;3823.4264860270628;3840.116773142193;5165.741712914414;5276.472352764693;5332.626716129911;5351.598630102758;5354.330708661418;5578.995780759502;5619.100943849046;5620.100783874561;5623.353314368818;5623.887522249532;5106.46382129871;5264.341957255343;5286.682799032071;5287.259783630295;5290.497402746733;4631.606313463326;4700.600448961876;4707.929381059287;4740.739259340769;4744.786484608201;5744.281964754406;5768.885877687643;5772.740226689809;5776.797812076557;5782.537397008229;5421.810236641699;5542.445755424425;5584.3857175711455;5588.580856435865;5611.158326251013;5830.53355731549;5831.475167234969;5832.825015249379;5861.003629383101;5897.262842144732;5513.3108361454815;5516.365617953987;5517.034518959246;5517.475839795213;5534.695591742493;5506.779728810963;5583.134614134816;5587.664740115606;5608;5681.573881958952;5354.7858085676135;5364.30264065669;5372.919406208832;5374.892502149857;5429.837104886859;5362.865928351823;5370;5371.742303840619;5377.650452720561;5412.97153540826;5186.507281808223;5308.654937429209;5317.1226747586215;5410.729463526886;5448.291722076105;5412.810551630674;5422.701751403552;5439.972800135974;5457.508824205841;5458.836234912959;5326.760295786777;5369.624126311121;5374.516293533601;5376.731163441734;5393.271908292487 05:25:47 INFO - PROCESS | 23394 | |1;ext.html;602.3705228036702;630.051772083015;641.3041849593191;653.6372313366081;666.9666516674168;29035;29741.107766767003;29777.106686799405;38170.23659526808;39085.60914390855;40817;41414.17171656565;41529.37705934406;41598;41656.37515437271;8456.154384561556;8635.266002389804;8656.437331573428;8658.307335413183;8662.30701543878;8417.45286556375;8508.064112947572;8514.148585141467;8520.360972927025;8521.616527256288;8495.405321627488;8585;8596.183362580576;8752.168543988342;8780.385373023892;8658.264047555935;8712.954445466521;8718.389712720113;8728.869066964;8732.476051436903;8601.225889669897;8688.478691278544;8705.564721763949;8711.695090671796;8712.172343627346;40778.592214078075;41164.1767164658;41304.586954130675;41352;41414;3407.114150320934;3502.439609662442;3573.910652233689;3646.7994260315672;3877.3990031545154;26711.732882671313;27274.181774546796;28001.57997630037;31781;32524.674753252402;4189.685773566995;4191.706580539333;4203.789810509462;4233.534311225762;4289.678274129453;260015;260696;261058;261818;263023;35267.29465410677;36287.911362659164;54162.45837541574;54320;54665.726671367185;35839.28321433609;35934.82032589873;36046.09884752902;36099;36133.63866361355;13664.31678416095;13769.105008174436;13831.30843457823;13935.163890166623;14071.226082565558;12701.872981270253;12717.10980231375;12742.68143296425;12743.745125097446;12746.36268186587;8416.452930559617;8479.830403391898;8544.914550854537;8550;8597.441166324168;3224.774265801418;3277.2298509850166;3307.140143562643;3327.93344133116;3334.683205095512;1057.7778666479971;1064.8562444070105;1070.9625163119254;1079.1420820447763;1141.8572678415198;32503.34993300121;32840;32842.50736238958;33195.50206746901;33506;1150.5340337163295;1191.440023189117;1214.3867346989714;1229.2133034857698;1251.0804558649386;15929.920350398406;16941.661166776594;16992.490225293262;16993.660126797397;17354.826451735575;482861;487683;488834;489185;490143;55481.722591387595;56384;56448;56471.71764141153;56497;1313.481174935895;1405.501047128275;1409.3446547355325;1460.890433217513;1506.5555661079788;28465.715342846306;30300.848495758262;30536.621638369066;30644.84677576598;30772.692273076984;45675.31487027764;46054.76972615116;46246.306305404774;46350.76824615855;46470.07059858716;273936;274168;276379;276655;277044;25431.36421589475;28548.57177142303;29207.269818254714;29240.853795730884;29512.557311639914;40168.75109213886;40656.1868762629;41709.374359384026;41741.165176695686;41950.79024604857;37369;37833.243335133695;38080.80959595184;38262.2347553053;38354.80822595869;37230.25539489249;37930.43104353382;38439.423408648334;38694.80652596719;38904.41643375295;39363.2127357457;39526.60473395344;40272;40366.1926761469;40433.797831010655;32606.34787304288;34515.4822677655;34860.47709284312;35196;35293.294134117685;26707.59938600884;27320.863395682893;27328.863355683094;27744.260637216463;27915.581266280617 05:25:47 INFO - PROCESS | 23394 | |2;jquery.html;398.852424602897;402.6979765176118;404.37120277967784;408.3486838492604;413.68973270047445;17573.297068117277;18179;18216.180271887763;18264.269429222815;19114.426567202972;17664.911675441635;17878.642427151448;18232.81767182328;19097.427077187705;19111.42665720027;5621.690807005613;5629.408912064236;5768.163616275638;5775.884482310351;5787.652740835542;5580.888382232373;5734.254546908896;5741.224934633813;5745.885082298351;5756.827295181151;5236.554892834114;5516.227728118067;5522.447755224465;5716.542676585884;5721.713914304289;5480.287562616854;5518.889622207574;5534.972325138388;5535.806246781343;5563.693996830173;5248.370195576517;5564.4713752193475;5691.630044047124;5693.800716974927;5736.3403208631125;12769.61691149267;12978.675533111653;13077.934610326982;13089.41097650608;13306.334683265797;2310.975398174813;2381.8451800633075;2448.7428819973825;2493.488834788864;2862.184277480908;9343.859842102374;9837.655682051165;9880.12277667241;10073.798524029551;10176.54205560744;1918.7793403758608;1920.7118932160288;1933.168737442899;2101.359085478928;2109.251215818393;56768.43231567673;68857.65571172163;69913.3008669912;73789.63105184493;79678.60160699218;9608.231341492663;9980.900190998142;10381.84427233592;10451.477426128815;10668.413237271869;14707.485238016618;14798.408063677332;14826.703465930621;14828.184449855145;14953.551393458214;8001.839963200703;8009.439339246197;8057.838843223103;8188.099309075997;8224.547649879314;7755.2632499912415;7766;7787.532748035136;7860.960695196487;7940.404469664682;4645.883852903637;4671.15919134559;4725.976370118127;4814.879628009257;4874.075554667243;1923.5479662279354;1949.3274820187012;1972.3195497553609;1986.309224073049;2058.0944384470786;933.4585940154694;953.6566835939057;972.8151651186251;997.2769741937037;999.2455695949511;11231.494582743633;11459.541618335174;17715;18487.260509579468;19395;433.5859254412029;450.1851648516131;455.9430071241095;458.40407470288494;471.87495313741886;5657.773689052474;5796.9855275326645;5912.044673198078;6044.516438684895;6221.06683997395;487730;491468;492878;506535;509830;85424;86839.56580217059;87117.56441217754;87520;88521;480.4786806315187;493.2527221259794;494.3301826025755;494.5573711528162;496.76155445386416;10585.311954722918;10907.727306817393;10929.836052459379;10973;11068.501917413574;37402.625973739916;37945.81027094957;38157.427638586;38227.80886095552;38400.6159938397;47980.280295794895;52566.73716631392;54801.725991369785;54850;54883.45116548784;8332.750017499484;8516.574171291535;8607.18231767981;8819.294456443597;8826.470411775314;12594.24434533931;12693.048021398248;12803.743925121631;13483.123596966558;13582.388792504164;11701.2979221247;11946.940265298617;11947;12133.453994570089;12133.453994570442;6625.900611490735;9152.627105933896;11357.602483913024;11403.600873969703;11482.138839586898;11918.523259069887;12129.332886691316;12255.448504817483;12330.260184388966;12333.303410235609;8350.290225330915;8473.745787626382;8647.654093836176;8699.782505437415;9199.172074513059;8401.53791541471;10969.451527423438;11725;11808.468618912342;11906.880931190924 05:25:47 INFO - PROCESS | 23394 | |3;mootools.html;1334.6196334044798;1473.4253641079981;1493.1712899340866;1576.3064251729238;1670.3986564836664;7568.508046976949;7890.684372625103;7906.44654874159;7906.92093079069;7908.762737117889;7795.92204077959;7925.524468531878;7928.16754240805;7929.603519824;7939.801504962379;1930.855185861066;2200.4938864061273;2240.327901629513;2269.704938358011;2273.2611901132113;2260.547890421914;2267.5351552931693;2269.8297627677907;2272.693186419837;2277.0436416704943;2217.345882964529;2259.8757068361233;2266.841321107523;2267.206477732797;2267.648514480258;1963.528753099253;2188.3325585696357;2249.2914731859414;2255.954880902389;2257.977420225793;2178.3900507857825;2196;2199.637059885117;2204.0081963116663;2218.3344996501146;7777.494462859952;7857.664197086509;7892.368610511203;7899.249571290718;7903.3282171015535;4712.151812673717;4847.030593881238;4879.8780030499165;4888.584470320027;4935.111679897617;3261.5433839262523;3263.4125857345666;3319.8008119512665;3324.6176689680515;3348.96651033489;1065.9360438373722;1078.320657985472;1091.230682368928;1096.5832983466312;1110.317154949708;10929.508172132193;10964.780704385947;10989.230753847154;10992.17558683094;11003.559857605685;4282.935755963663;4302.913941721148;4450.332450132441;4476.283794592915;4479.686421950432;9343.505039193697;9348.532573371303;9353;9354.111359420844;9359.064093590723;4349.217140914602;4984.37695288089;4988.850334489971;5010;5017.0216807722145;4418.5802348776815;4497.347884556721;4504.684672072924;4510.954890451119;4544.522825103317;3766.491523644273;3850.152966347399;3916.1776027034643;4022.4368588397647;4052.675785937118;1262.7600755856542;1263.5451237554473;1291.3865913691109;1297.6366617347157;1307.405130665564;948.6869333120054;968.0174622757906;976.8876579193342;982.3614650477247;993.60752502761;5577.8047768327915;5613.101903695389;5613.578981576398;5692.743826527816;5706.857328566819;409.4084048549876;415.33961002006953;429.9871003869889;430.5393229244678;430.6167510915288;3976.2445135424755;4000.2799496090984;4025.75845449274;4032.2338755636333;4131.566185550534;9531.47576883278;9840.261980351359;9895.752606184758;9932.950335248277;9934;9828.164606008426;9831.80336393268;9833.45915974614;9835.311528192959;9861.161801246832;7415.443841711894;7482.738104166437;7586.165521792598;7609.885851712229;7622.885656715153;5365.946340536545;5401.378841433286;5457.808976685797;5465.453454654503;5644;8978.191962723125;9074.410163339362;9083.04628014049;9135.177833994972;9213.493257870881;8695.782605434915;8913.509756963429;8939.374243803131;9027.954860225656;9033.141851524095;6535.215774107138;6858.142732158481;7029.156501219886;7038.472114591528;7182.245864184186;7346.412287017132;7351.8162045949275;7439.55362678241;7441.739539116105;7453.813654658677;6831.59010459374;6963.651817409211;7030.3321184487395;7030.437564994891;7111.359977601834;6933.5493192942295;6948.791536253718;6969.30306969299;6979.232284448808;7102.14774227096;6158.199434073542;6223.471004964629;6224.346443623354;6233.532485063548;6306.054091886253;4887.462379138221;4991.700497970133;5003.399592048978;5007.949920500894;5011.624128190473;4929.679570827885;4943.77753001123;5052.9747351263;5065.468125846733;5177.171652535576 05:25:47 INFO - PROCESS | 23394 | |4;prototype.html;318.65426012776135;323.652074020428;325.5913828145677;329.5402912936455;331.59545354667296;5563.888722225558;5575.330960284767;5663.235463212465;5673.290838645169;5675.2338434311405;5535.972320138394;5565.220869078322;5575.69333686648;5589;5617.101263797793;4113;4154.984832356305;4279.33670281107;4306.1172459645695;4319.6760242981745;4300.440942677463;4308.879691280274;4309.870703878889;4310.784460776964;4315.870523884289;4056.553779084298;4278.679099067567;4279.572042795711;4281.593248641389;4285.30730361507;4195.85314513992;4309.159713855799;4312.417823593806;4318.265894797892;4327.350897365389;3768.378217594121;3771.1891943232063;3772.1135533149686;3778.5843557208686;3785.3943369060817;5310.20346947957;5396.946030539723;5399.271098401705;5402.189671549259;5413.729313534308;4919.3358896549225;4932.482089380635;4950.3069570260195;4951;4956.083124621957;5782.248307720011;5842.766289348421;5843.357230704619;5867.11993201019;5871.647701137946;4077.143799802045;4164.68764842638;4177.394277829698;4184.769837658928;4185.602367775056;6114.785982490592;6139.355367686373;6151.507879369639;6156.599821011665;6158.538109641795;4248.4493159997;4274.059706864485;4275.593818587229;4276.935845962313;4289.1850548395705;4160.83356665736;4312.417823593837;4332.480102387671;4334.891627709332;4341.2402829505345;4928.359313289249;4948.604111671058;4952.62855285855;4967.428745694219;4970.801167953241;5889.116632505073;5915.467607915309;5921.134842524591;5946.316173640087;5960.7780405016865;1480.3412481445869;1487.523992322468;1504.3305728950731;1504.6990601879668;1518.7494063479403;951.752544338477;992.7766252593253;1007.9546420410952;1023.4371095897227;1023.8822535408375;5633.183188437653;5651.15232715096;5651.689157096317;5657.349404818498;5673.8297851064535;6029.487493563096;6035.1249068885645;6042.516598672096;6057.273127224761;6082.878342433127;5485.561155107662;5645.322561292589;5713.114467257582;5773.1051686988585;5774.682392468455;3271.1985563537087;3304.669533046676;3306.8015919044933;3309.983450082734;3310.2717402171966;6292.968535157386;6411.935880641134;6418.358164183638;6419.656825258747;6420.0690899819265;6207.410296021871;6232.8130156095385;6233.438990490878;6236.937630623726;6247.250329960434;6193.938060619426;6312.842178945563;6319.747210111544;6338.207724034496;6356.300806911236;6106.1146133811235;6106.847328816815;6112.419320164578;6118.479929206067;6133.539984501091;6027.758889644365;6062.787802426894;6065.120557519047;6079.574429789872;6084.209052823105;5992.610480318765;6347.5239357047485;6371.267304260069;6405.967970160119;6442.387973142544;4118.19695159453;4146.66826653861;4149.564295749024;4161.937570936499;4162.188373267184;5961.344252132175;6119.541034422347;6176.876462470816;6177.320494745484;6218.9378106218355;5926.496247818984;5955.731992060454;5958.255218097738;5980.820575382745;5981.162637230704;5884.58807883444;5888.528917686489;5900.940990590211;5913.2608423947;5914.201582786269;5718.828435146952;5821.27234095738;5833.183354330482;5837.211976383303;5848.853778655397;5921.792737254348;5938.406159384027;5948.762049518144;5966.433188847052;5969.492593129459;5635.746391412315;5862.391235899983;5887.087501437284;5895.941040589711;5915.112733090071 05:25:47 INFO - PROCESS | 23394 | |5;yui.html;726.0851327327566;730.7734602273295;766.2490759056125;777.6694904665516;785.4423359414817;13386.397612107454;13430.462781488754;13460.057795954288;13502.12236204646;14288.214148221856;13088.73822523549;13151.013673974467;13176.604701858936;13193.208407495533;13195.142315749494;645.3353046362231;764.5068930539799;783.4124406694979;784.6704384158638;788.3377962511504;781.5388920536882;784.7528028670979;787.8660627693278;788.8264581791997;789.1989630525022;825.8885050518163;832.1262674192104;832.8792325112855;833.2875391540236;834.0783434305097;675.6689222281096;791.8020494876281;820.8358328334357;825.9958700206521;830.0910502999207;603.0261128277843;604.6341963112297;604.6523249131723;608.0514397539852;608.0969759906579;13620.795688064687;13682.726345473035;13721;13732.862671373357;13737.725245495134;12168.57409990655;12763.042771792152;12808.10343275971;12811.423485943062;12874.420651070724;11179.83230251547;11273.661790146309;11330.320180789178;11366.26119302251;11401.885981140165;3760.4735337052834;3767;3814.408766641175;3867.903302417434;3902.824372903226;55125.12889664485;56028;56110.15834762441;56577.43422565763;56631.433685663025;9589.760255993517;9736.75658108553;9805.55874985613;9839.458829764288;9909.306348555676;18660.906695466707;18840.717389239173;18852.717209241873;18896.622067558572;18940.526486837665;7209.783706488814;7240.601766902765;7424.888626670604;7533.773986780406;7760.107587627495;4129.359949207877;4249.851255206115;4288.914221715549;4300.204462174508;4369.08249267651;3245.983770081182;3300.3564304960782;3334.283129127249;3334.3831391192707;3339.1151344893624;562.5302872101759;618.7184830901929;627.244170774216;632.2949910849462;635.0791352538837;641.7497176101324;719.1406269507993;733.2081352139676;755.8299382638862;789.7946533901227;9163.404378715362;9199.632014719336;9284.48935308551;9536.475493847905;9650.131488166098;631.9905201421982;658.4699317049821;675.1493118670412;739.1684355100512;740.7222291640635;4514.977425112854;4537.3647689323525;4545.886352841139;4586;4621.8844528886375;56894.43105568974;62672.373276267565;63028.684856575426;63837.680811595645;64699.67650161813;51321.743391282806;52363.476365236624;52443.475565244626;52502.94994100173;54226.45773542293;45458.31812522815;46563.76718116388;46732.5326746735;47816;48368;8828.867566986371;9022.86465703028;9254.722358329262;9284.257259419095;9307.20888724439;32971.67028329782;33254.33491330208;33355;33862;34428.655713442546;42501.57498424976;45706.54293457023;45968;46372.53627463682;46507.76746116383;10755.623553175601;11045.33727976324;11128.221024528206;11221.71945701364;11269.887301126884;12073.39633018328;12187.329696866758;12544.184627999151;12556.372181391076;12778;12406.875931240933;12410.627681169579;12439.626811195678;12584.811227831773;12794.744105118032;11661.883381166419;11749.412529373669;12377.504899803907;12524;12928.741425171633;12689.23864568129;12829.87170128324;12863.871361286267;13039.674008149872;13420.932895335462;10478.528466219192;10658;10670.30643008202;10963.50664220096;10996;10834.783304334027;10857.457127143769;11079.72300692489;11094.057005154329;11127.221094523306 05:25:47 INFO - PROCESS | 23394 | __end_tp_report 05:25:47 INFO - PROCESS | 23394 | __start_cc_report 05:25:47 INFO - PROCESS | 23394 | _x_x_mozilla_cycle_collect,819 05:25:47 INFO - PROCESS | 23394 | __end_cc_report 05:25:47 INFO - PROCESS | 23394 | __startTimestamp1460982347807__endTimestamp 05:25:47 INFO - PROCESS | 23394 | 05:25:47 INFO - PROCESS | 23394 | ------- Summary: start ------- 05:25:47 INFO - PROCESS | 23394 | Number of tests: 6 05:25:47 INFO - PROCESS | 23394 | 05:25:47 INFO - PROCESS | 23394 | [#0] dojo.html Cycles:165 Average:5166.16 Median:5364.30 stddev:577.87 (10.8%) stddev-sans-first:554.59 05:25:47 INFO - PROCESS | 23394 | Values: 3020.6 3070.4 3105.1 3108.5 3131.5 5185.9 5237.2 5269.4 5273.8 5290.2 5238.0 5276.0 5281.3 5287.2 5349.0 4703.2 4747.5 4795.1 4800.1 4855.9 4756.9 4783.5 4787.7 4828.4 4870.4 4660.9 4676.1 4742.7 4777.1 4783.5 4698.5 4719.0 4723.6 4725.2 4751.9 4639.1 4684.6 4690.4 4714.3 4736.1 5130.5 5158.2 5159.1 5178.5 5200.5 5502.6 5534.1 5536.4 5542.3 5546.1 5510.4 5563.5 5577.6 5585.5 5622.4 5164.6 5169.4 5180.0 5220.1 5227.7 5641.6 5642.1 5645.4 5652.7 5660.0 5359.4 5409.4 5413.7 5496.7 5522.4 5482.1 5501.8 5505.4 5513.9 5515.8 5447.6 5450.3 5458.7 5480.0 5504.8 5403.6 5511.8 5559.6 5589.4 5621.3 4215.9 4221.6 4223.1 4226.9 4255.4 3716.4 3800.4 3803.3 3823.4 3840.1 5165.7 5276.5 5332.6 5351.6 5354.3 5579.0 5619.1 5620.1 5623.4 5623.9 5106.5 5264.3 5286.7 5287.3 5290.5 4631.6 4700.6 4707.9 4740.7 4744.8 5744.3 5768.9 5772.7 5776.8 5782.5 5421.8 5542.4 5584.4 5588.6 5611.2 5830.5 5831.5 5832.8 5861.0 5897.3 5513.3 5516.4 5517.0 5517.5 5534.7 5506.8 5583.1 5587.7 5608.0 5681.6 5354.8 5364.3 5372.9 5374.9 5429.8 5362.9 5370.0 5371.7 5377.7 5413.0 5186.5 5308.7 5317.1 5410.7 5448.3 5412.8 5422.7 5440.0 5457.5 5458.8 5326.8 5369.6 5374.5 5376.7 5393.3 05:25:47 INFO - PROCESS | 23394 | 05:25:47 INFO - PROCESS | 23394 | [#1] ext.html Cycles:180 Average:49347.62 Median:37601.12 stddev:94670.07 (251.8%) stddev-sans-first:94864.90 05:25:47 INFO - PROCESS | 23394 | Values: 602.4 630.1 641.3 653.6 667.0 29035.0 29741.1 29777.1 38170.2 39085.6 40817.0 41414.2 41529.4 41598.0 41656.4 8456.2 8635.3 8656.4 8658.3 8662.3 8417.5 8508.1 8514.1 8520.4 8521.6 8495.4 8585.0 8596.2 8752.2 8780.4 8658.3 8713.0 8718.4 8728.9 8732.5 8601.2 8688.5 8705.6 8711.7 8712.2 40778.6 41164.2 41304.6 41352.0 41414.0 3407.1 3502.4 3573.9 3646.8 3877.4 26711.7 27274.2 28001.6 31781.0 32524.7 4189.7 4191.7 4203.8 4233.5 4289.7 260015.0 260696.0 261058.0 261818.0 263023.0 35267.3 36287.9 54162.5 54320.0 54665.7 35839.3 35934.8 36046.1 36099.0 36133.6 13664.3 13769.1 13831.3 13935.2 14071.2 12701.9 12717.1 12742.7 12743.7 12746.4 8416.5 8479.8 8544.9 8550.0 8597.4 3224.8 3277.2 3307.1 3327.9 3334.7 1057.8 1064.9 1071.0 1079.1 1141.9 32503.3 32840.0 32842.5 33195.5 33506.0 1150.5 1191.4 1214.4 1229.2 1251.1 15929.9 16941.7 16992.5 16993.7 17354.8 482861.0 487683.0 488834.0 489185.0 490143.0 55481.7 56384.0 56448.0 56471.7 56497.0 1313.5 1405.5 1409.3 1460.9 1506.6 28465.7 30300.8 30536.6 30644.8 30772.7 45675.3 46054.8 46246.3 46350.8 46470.1 273936.0 274168.0 276379.0 276655.0 277044.0 25431.4 28548.6 29207.3 29240.9 29512.6 40168.8 40656.2 41709.4 41741.2 41950.8 37369.0 37833.2 38080.8 38262.2 38354.8 37230.3 37930.4 38439.4 38694.8 38904.4 39363.2 39526.6 40272.0 40366.2 40433.8 32606.3 34515.5 34860.5 35196.0 35293.3 26707.6 27320.9 27328.9 27744.3 27915.6 05:25:47 INFO - PROCESS | 23394 | 05:25:47 INFO - PROCESS | 23394 | [#2] jquery.html Cycles:180 Average:27658.71 Median:24230.38 stddev:81850.99 (337.8%) stddev-sans-first:82055.01 05:25:47 INFO - PROCESS | 23394 | Values: 398.9 402.7 404.4 408.3 413.7 17573.3 18179.0 18216.2 18264.3 19114.4 17664.9 17878.6 18232.8 19097.4 19111.4 5621.7 5629.4 5768.2 5775.9 5787.7 5580.9 5734.3 5741.2 5745.9 5756.8 5236.6 5516.2 5522.4 5716.5 5721.7 5480.3 5518.9 5535.0 5535.8 5563.7 5248.4 5564.5 5691.6 5693.8 5736.3 12769.6 12978.7 13077.9 13089.4 13306.3 2311.0 2381.8 2448.7 2493.5 2862.2 9343.9 9837.7 9880.1 10073.8 10176.5 1918.8 1920.7 1933.2 2101.4 2109.3 56768.4 68857.7 69913.3 73789.6 79678.6 9608.2 9980.9 10381.8 10451.5 10668.4 14707.5 14798.4 14826.7 14828.2 14953.6 8001.8 8009.4 8057.8 8188.1 8224.5 7755.3 7766.0 7787.5 7861.0 7940.4 4645.9 4671.2 4726.0 4814.9 4874.1 1923.5 1949.3 1972.3 1986.3 2058.1 933.5 953.7 972.8 997.3 999.2 11231.5 11459.5 17715.0 18487.3 19395.0 433.6 450.2 455.9 458.4 471.9 5657.8 5797.0 5912.0 6044.5 6221.1 487730.0 491468.0 492878.0 506535.0 509830.0 85424.0 86839.6 87117.6 87520.0 88521.0 480.5 493.3 494.3 494.6 496.8 10585.3 10907.7 10929.8 10973.0 11068.5 37402.6 37945.8 38157.4 38227.8 38400.6 47980.3 52566.7 54801.7 54850.0 54883.5 8332.8 8516.6 8607.2 8819.3 8826.5 12594.2 12693.0 12803.7 13483.1 13582.4 11701.3 11946.9 11947.0 12133.5 12133.5 6625.9 9152.6 11357.6 11403.6 11482.1 11918.5 12129.3 12255.4 12330.3 12333.3 8350.3 8473.7 8647.7 8699.8 9199.2 8401.5 10969.5 11725.0 11808.5 11906.9 05:25:47 INFO - PROCESS | 23394 | 05:25:47 INFO - PROCESS | 23394 | [#3] mootools.html Cycles:180 Average:5307.55 Median:5014.32 stddev:2913.69 (58.1%) stddev-sans-first:2906.56 05:25:47 INFO - PROCESS | 23394 | Values: 1334.6 1473.4 1493.2 1576.3 1670.4 7568.5 7890.7 7906.4 7906.9 7908.8 7795.9 7925.5 7928.2 7929.6 7939.8 1930.9 2200.5 2240.3 2269.7 2273.3 2260.5 2267.5 2269.8 2272.7 2277.0 2217.3 2259.9 2266.8 2267.2 2267.6 1963.5 2188.3 2249.3 2256.0 2258.0 2178.4 2196.0 2199.6 2204.0 2218.3 7777.5 7857.7 7892.4 7899.2 7903.3 4712.2 4847.0 4879.9 4888.6 4935.1 3261.5 3263.4 3319.8 3324.6 3349.0 1065.9 1078.3 1091.2 1096.6 1110.3 10929.5 10964.8 10989.2 10992.2 11003.6 4282.9 4302.9 4450.3 4476.3 4479.7 9343.5 9348.5 9353.0 9354.1 9359.1 4349.2 4984.4 4988.9 5010.0 5017.0 4418.6 4497.3 4504.7 4511.0 4544.5 3766.5 3850.2 3916.2 4022.4 4052.7 1262.8 1263.5 1291.4 1297.6 1307.4 948.7 968.0 976.9 982.4 993.6 5577.8 5613.1 5613.6 5692.7 5706.9 409.4 415.3 430.0 430.5 430.6 3976.2 4000.3 4025.8 4032.2 4131.6 9531.5 9840.3 9895.8 9933.0 9934.0 9828.2 9831.8 9833.5 9835.3 9861.2 7415.4 7482.7 7586.2 7609.9 7622.9 5365.9 5401.4 5457.8 5465.5 5644.0 8978.2 9074.4 9083.0 9135.2 9213.5 8695.8 8913.5 8939.4 9028.0 9033.1 6535.2 6858.1 7029.2 7038.5 7182.2 7346.4 7351.8 7439.6 7441.7 7453.8 6831.6 6963.7 7030.3 7030.4 7111.4 6933.5 6948.8 6969.3 6979.2 7102.1 6158.2 6223.5 6224.3 6233.5 6306.1 4887.5 4991.7 5003.4 5007.9 5011.6 4929.7 4943.8 5053.0 5065.5 5177.2 05:25:47 INFO - PROCESS | 23394 | 05:25:47 INFO - PROCESS | 23394 | [#4] prototype.html Cycles:180 Average:4962.21 Median:5654.52 stddev:1489.48 (26.3%) stddev-sans-first:1452.31 05:25:47 INFO - PROCESS | 23394 | Values: 318.7 323.7 325.6 329.5 331.6 5563.9 5575.3 5663.2 5673.3 5675.2 5536.0 5565.2 5575.7 5589.0 5617.1 4113.0 4155.0 4279.3 4306.1 4319.7 4300.4 4308.9 4309.9 4310.8 4315.9 4056.6 4278.7 4279.6 4281.6 4285.3 4195.9 4309.2 4312.4 4318.3 4327.4 3768.4 3771.2 3772.1 3778.6 3785.4 5310.2 5396.9 5399.3 5402.2 5413.7 4919.3 4932.5 4950.3 4951.0 4956.1 5782.2 5842.8 5843.4 5867.1 5871.6 4077.1 4164.7 4177.4 4184.8 4185.6 6114.8 6139.4 6151.5 6156.6 6158.5 4248.4 4274.1 4275.6 4276.9 4289.2 4160.8 4312.4 4332.5 4334.9 4341.2 4928.4 4948.6 4952.6 4967.4 4970.8 5889.1 5915.5 5921.1 5946.3 5960.8 1480.3 1487.5 1504.3 1504.7 1518.7 951.8 992.8 1008.0 1023.4 1023.9 5633.2 5651.2 5651.7 5657.3 5673.8 6029.5 6035.1 6042.5 6057.3 6082.9 5485.6 5645.3 5713.1 5773.1 5774.7 3271.2 3304.7 3306.8 3310.0 3310.3 6293.0 6411.9 6418.4 6419.7 6420.1 6207.4 6232.8 6233.4 6236.9 6247.3 6193.9 6312.8 6319.7 6338.2 6356.3 6106.1 6106.8 6112.4 6118.5 6133.5 6027.8 6062.8 6065.1 6079.6 6084.2 5992.6 6347.5 6371.3 6406.0 6442.4 4118.2 4146.7 4149.6 4161.9 4162.2 5961.3 6119.5 6176.9 6177.3 6218.9 5926.5 5955.7 5958.3 5980.8 5981.2 5884.6 5888.5 5900.9 5913.3 5914.2 5718.8 5821.3 5833.2 5837.2 5848.9 5921.8 5938.4 5948.8 5966.4 5969.5 5635.7 5862.4 5887.1 5895.9 5915.1 05:25:47 INFO - PROCESS | 23394 | 05:25:47 INFO - PROCESS | 23394 | [#5] yui.html Cycles:180 Average:14483.76 Median:25146.27 stddev:16888.80 (67.2%) stddev-sans-first:16904.58 05:25:47 INFO - PROCESS | 23394 | Values: 726.1 730.8 766.2 777.7 785.4 13386.4 13430.5 13460.1 13502.1 14288.2 13088.7 13151.0 13176.6 13193.2 13195.1 645.3 764.5 783.4 784.7 788.3 781.5 784.8 787.9 788.8 789.2 825.9 832.1 832.9 833.3 834.1 675.7 791.8 820.8 826.0 830.1 603.0 604.6 604.7 608.1 608.1 13620.8 13682.7 13721.0 13732.9 13737.7 12168.6 12763.0 12808.1 12811.4 12874.4 11179.8 11273.7 11330.3 11366.3 11401.9 3760.5 3767.0 3814.4 3867.9 3902.8 55125.1 56028.0 56110.2 56577.4 56631.4 9589.8 9736.8 9805.6 9839.5 9909.3 18660.9 18840.7 18852.7 18896.6 18940.5 7209.8 7240.6 7424.9 7533.8 7760.1 4129.4 4249.9 4288.9 4300.2 4369.1 3246.0 3300.4 3334.3 3334.4 3339.1 562.5 618.7 627.2 632.3 635.1 641.7 719.1 733.2 755.8 789.8 9163.4 9199.6 9284.5 9536.5 9650.1 632.0 658.5 675.1 739.2 740.7 4515.0 4537.4 4545.9 4586.0 4621.9 56894.4 62672.4 63028.7 63837.7 64699.7 51321.7 52363.5 52443.5 52502.9 54226.5 45458.3 46563.8 46732.5 47816.0 48368.0 8828.9 9022.9 9254.7 9284.3 9307.2 32971.7 33254.3 33355.0 33862.0 34428.7 42501.6 45706.5 45968.0 46372.5 46507.8 10755.6 11045.3 11128.2 11221.7 11269.9 12073.4 12187.3 12544.2 12556.4 12778.0 12406.9 12410.6 12439.6 12584.8 12794.7 11661.9 11749.4 12377.5 12524.0 12928.7 12689.2 12829.9 12863.9 13039.7 13420.9 10478.5 10658.0 10670.3 10963.5 10996.0 10834.8 10857.5 11079.7 11094.1 11127.2 05:25:47 INFO - PROCESS | 23394 | -------- Summary: end -------- 05:25:47 INFO - PROCESS | 23394 | 05:25:48 INFO - TEST-INFO | 23394: exit 0 05:25:48 INFO - TEST-OK | dromaeo_css | took 1111638ms 05:25:48 INFO - TEST-START | kraken 05:25:48 INFO - operating with platform_type : linux_ 05:25:48 INFO - Initialising browser for kraken test... 05:25:48 INFO - TEST-INFO | started process 23585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgTD4tB/profile http://localhost:53945/getInfo.html) 05:25:52 INFO - PROCESS | 23585 | __metrics Screen width/height:1600/1200 05:25:52 INFO - PROCESS | 23585 | colorDepth:24 05:25:52 INFO - PROCESS | 23585 | Browser inner width/height: 1024/697 05:25:52 INFO - PROCESS | 23585 | __metrics 05:25:53 ERROR - PROCESS | 23585 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:25:54 INFO - TEST-INFO | 23585: exit 0 05:25:54 INFO - Browser initialized. 05:25:54 INFO - Running cycle 1/1 for kraken test... 05:25:54 INFO - TEST-INFO | started process 23668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgTD4tB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:06 INFO - PROCESS | 23668 | RSS: Main: 153239552 05:26:06 INFO - PROCESS | 23668 | 05:26:08 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53945/tests/kraken/driver.html?testName=audio-beat-detection) 05:26:09 INFO - PROCESS | 23668 | RSS: Main: 207908864 05:26:09 INFO - PROCESS | 23668 | 05:26:12 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53945/tests/kraken/driver.html?testName=audio-dft) 05:26:12 INFO - PROCESS | 23668 | RSS: Main: 193585152 05:26:12 INFO - PROCESS | 23668 | 05:26:15 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53945/tests/kraken/driver.html?testName=audio-fft) 05:26:16 INFO - PROCESS | 23668 | RSS: Main: 264454144 05:26:16 INFO - PROCESS | 23668 | 05:26:18 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53945/tests/kraken/driver.html?testName=audio-oscillator) 05:26:19 INFO - PROCESS | 23668 | RSS: Main: 172761088 05:26:19 INFO - PROCESS | 23668 | 05:26:21 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53945/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:22 INFO - PROCESS | 23668 | RSS: Main: 177586176 05:26:22 INFO - PROCESS | 23668 | 05:26:25 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53945/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:25 INFO - PROCESS | 23668 | RSS: Main: 213729280 05:26:25 INFO - PROCESS | 23668 | 05:26:28 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53945/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:29 INFO - PROCESS | 23668 | RSS: Main: 213970944 05:26:29 INFO - PROCESS | 23668 | 05:26:32 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53945/tests/kraken/driver.html?testName=json-parse-financial) 05:26:32 INFO - PROCESS | 23668 | RSS: Main: 214310912 05:26:32 INFO - PROCESS | 23668 | 05:26:34 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53945/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:35 INFO - PROCESS | 23668 | RSS: Main: 203825152 05:26:35 INFO - PROCESS | 23668 | 05:26:36 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53945/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:37 INFO - PROCESS | 23668 | RSS: Main: 203829248 05:26:37 INFO - PROCESS | 23668 | 05:26:39 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53945/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:40 INFO - PROCESS | 23668 | RSS: Main: 217513984 05:26:40 INFO - PROCESS | 23668 | 05:26:42 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:43 INFO - PROCESS | 23668 | RSS: Main: 222965760 05:26:43 INFO - PROCESS | 23668 | 05:26:46 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:46 INFO - PROCESS | 23668 | RSS: Main: 220655616 05:26:46 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | Cycle 1(1): loaded http://localhost:53945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53945/tests/kraken/driver.html?testName=ai-astar) 05:26:48 INFO - PROCESS | 23668 | RSS: Main: 284454912 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | __start_tp_report 05:26:48 INFO - PROCESS | 23668 | _x_x_mozilla_page_load 05:26:48 INFO - PROCESS | 23668 | _x_x_mozilla_page_load_details 05:26:48 INFO - PROCESS | 23668 | |i|pagename|runs| 05:26:48 INFO - PROCESS | 23668 | |0;ai-astar;109;111;106;109;112;111;101;110;111;110 05:26:48 INFO - PROCESS | 23668 | |1;audio-beat-detection;158;126;170;194;136;158;159;131;179;132 05:26:48 INFO - PROCESS | 23668 | |2;audio-dft;161;162;160;161;159;161;162;163;162;163 05:26:48 INFO - PROCESS | 23668 | |3;audio-fft;76;73;94;107;75;72;73;138;106;76 05:26:48 INFO - PROCESS | 23668 | |4;audio-oscillator;93;92;150;93;93;94;148;92;93;143 05:26:48 INFO - PROCESS | 23668 | |5;imaging-gaussian-blur;117;116;116;117;118;117;117;117;117;117 05:26:48 INFO - PROCESS | 23668 | |6;imaging-darkroom;145;146;146;146;146;146;145;147;146;146 05:26:48 INFO - PROCESS | 23668 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;95 05:26:48 INFO - PROCESS | 23668 | |8;json-parse-financial;56;56;56;57;59;58;57;74;55;52 05:26:48 INFO - PROCESS | 23668 | |9;json-stringify-tinderbox;60;60;60;60;60;63;60;60;65;61 05:26:48 INFO - PROCESS | 23668 | |10;stanford-crypto-aes;75;79;76;75;78;78;77;79;78;77 05:26:48 INFO - PROCESS | 23668 | |11;stanford-crypto-ccm;126;129;133;121;127;121;122;122;158;134 05:26:48 INFO - PROCESS | 23668 | |12;stanford-crypto-pbkdf2;173;172;166;175;166;164;168;167;163;163 05:26:48 INFO - PROCESS | 23668 | |13;stanford-crypto-sha256-iterative;67;71;68;66;68;66;68;68;68;65 05:26:48 INFO - PROCESS | 23668 | __end_tp_report 05:26:48 INFO - PROCESS | 23668 | __start_cc_report 05:26:48 INFO - PROCESS | 23668 | _x_x_mozilla_cycle_collect,1639 05:26:48 INFO - PROCESS | 23668 | __end_cc_report 05:26:48 INFO - PROCESS | 23668 | __startTimestamp1460982408574__endTimestamp 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | ------- Summary: start ------- 05:26:48 INFO - PROCESS | 23668 | Number of tests: 14 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.27 (3.0%) stddev-sans-first:3.46 05:26:48 INFO - PROCESS | 23668 | Values: 109.0 111.0 106.0 109.0 112.0 111.0 101.0 110.0 111.0 110.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:158.50 stddev:22.75 (14.4%) stddev-sans-first:24.09 05:26:48 INFO - PROCESS | 23668 | Values: 158.0 126.0 170.0 194.0 136.0 158.0 159.0 131.0 179.0 132.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 05:26:48 INFO - PROCESS | 23668 | Values: 161.0 162.0 160.0 161.0 159.0 161.0 162.0 163.0 162.0 163.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#3] audio-fft Cycles:10 Average:89.00 Median:74.00 stddev:22.05 (29.8%) stddev-sans-first:22.88 05:26:48 INFO - PROCESS | 23668 | Values: 76.0 73.0 94.0 107.0 75.0 72.0 73.0 138.0 106.0 76.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:93.00 stddev:26.21 (28.2%) stddev-sans-first:27.15 05:26:48 INFO - PROCESS | 23668 | Values: 93.0 92.0 150.0 93.0 93.0 94.0 148.0 92.0 93.0 143.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:26:48 INFO - PROCESS | 23668 | Values: 117.0 116.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 05:26:48 INFO - PROCESS | 23668 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:26:48 INFO - PROCESS | 23668 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:5.93 (10.4%) stddev-sans-first:6.24 05:26:48 INFO - PROCESS | 23668 | Values: 56.0 56.0 56.0 57.0 59.0 58.0 57.0 74.0 55.0 52.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:60.00 stddev:1.73 (2.9%) stddev-sans-first:1.80 05:26:48 INFO - PROCESS | 23668 | Values: 60.0 60.0 60.0 60.0 60.0 63.0 60.0 60.0 65.0 61.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:78.00 stddev:1.48 (1.9%) stddev-sans-first:1.33 05:26:48 INFO - PROCESS | 23668 | Values: 75.0 79.0 76.0 75.0 78.0 78.0 77.0 79.0 78.0 77.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:128.00 stddev:11.16 (8.7%) stddev-sans-first:11.77 05:26:48 INFO - PROCESS | 23668 | Values: 126.0 129.0 133.0 121.0 127.0 121.0 122.0 122.0 158.0 134.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:167.50 stddev:4.27 (2.5%) stddev-sans-first:4.08 05:26:48 INFO - PROCESS | 23668 | Values: 173.0 172.0 166.0 175.0 166.0 164.0 168.0 167.0 163.0 163.0 05:26:48 INFO - PROCESS | 23668 | 05:26:48 INFO - PROCESS | 23668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.74 05:26:48 INFO - PROCESS | 23668 | Values: 67.0 71.0 68.0 66.0 68.0 66.0 68.0 68.0 68.0 65.0 05:26:48 INFO - PROCESS | 23668 | -------- Summary: end -------- 05:26:48 INFO - PROCESS | 23668 | 05:26:49 INFO - TEST-INFO | 23668: exit 0 05:26:49 INFO - TEST-OK | kraken | took 61029ms 05:26:49 INFO - SUITE-END | took 1172s 05:26:49 INFO - Completed test suite (00:19:32) 05:26:49 INFO - javascript benchmark 05:26:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3020.622422197225, 3070.4473194824923, 3105.0684794561625, 3108.4870996285613, 3131.4833052546333, 5185.870353241171, 5237.214417837322, 5269.367675878891, 5273.841784746459, 5290.180022096576, 5237.9785941741375, 5276.023935571922, 5281.287026251455, 5287.154055351145, 5349.010433069885, 4703.176944034797, 4747.477777444478, 4795.0889331027165, 4800.135975524404, 4855.854324370274, 4756.90486190276, 4783.545563171493, 4787.71273723576, 4828.420589529262, 4870.391201099863, 4660.930086048712, 4676.064787042588, 4742.691725037878, 4777.06847164803, 4783.473817880031, 4698.483166851644, 4719.032598317371, 4723.598494128003, 4725.196716558159, 4751.857444276678, 4639.072185562901, 4684.648651351163, 4690.413698287714, 4714.269288260325, 4736.076465089309, 5130.51260130287, 5158.174692049254, 5159.14874045782, 5178.482151784829, 5200.479952004807, 5502.614816962814, 5534.059209934321, 5536.363318218416, 5542.307211598551, 5546.084895992157, 5510.366307874566, 5563.527100196488, 5577.581681373913, 5585.525230355424, 5622.437756224344, 5164.561012313995, 5169.405518365398, 5179.974100129513, 5220.112580861262, 5227.660202086852, 5641.633293835887, 5642.125470552071, 5645.379008309083, 5652.717364131777, 5660.0, 5359.410464848864, 5409.377921539073, 5413.729313534308, 5496.6701997880255, 5522.447755224526, 5482.122860342326, 5501.834944951658, 5505.421930697299, 5513.917291240635, 5515.779368825202, 5447.591430642718, 5450.264214331094, 5458.6724796512335, 5480.04099282624, 5504.80733174345, 5403.621746477787, 5511.807086751945, 5559.555235581144, 5589.413111623302, 5621.297337832771, 4215.873523794291, 4221.598948099926, 4223.113146239262, 4226.894327641833, 4255.404243405926, 3716.3867961786004, 3800.4299355096955, 3803.2773772983046, 3823.4264860270628, 3840.116773142193, 5165.741712914414, 5276.472352764693, 5332.626716129911, 5351.598630102758, 5354.330708661418, 5578.995780759502, 5619.100943849046, 5620.100783874561, 5623.353314368818, 5623.887522249532, 5106.46382129871, 5264.341957255343, 5286.682799032071, 5287.259783630295, 5290.497402746733, 4631.606313463326, 4700.600448961876, 4707.929381059287, 4740.739259340769, 4744.786484608201, 5744.281964754406, 5768.885877687643, 5772.740226689809, 5776.797812076557, 5782.537397008229, 5421.810236641699, 5542.445755424425, 5584.3857175711455, 5588.580856435865, 5611.158326251013, 5830.53355731549, 5831.475167234969, 5832.825015249379, 5861.003629383101, 5897.262842144732, 5513.3108361454815, 5516.365617953987, 5517.034518959246, 5517.475839795213, 5534.695591742493, 5506.779728810963, 5583.134614134816, 5587.664740115606, 5608.0, 5681.573881958952, 5354.7858085676135, 5364.30264065669, 5372.919406208832, 5374.892502149857, 5429.837104886859, 5362.865928351823, 5370.0, 5371.742303840619, 5377.650452720561, 5412.97153540826, 5186.507281808223, 5308.654937429209, 5317.1226747586215, 5410.729463526886, 5448.291722076105, 5412.810551630674, 5422.701751403552, 5439.972800135974, 5457.508824205841, 5458.836234912959, 5326.760295786777, 5369.624126311121, 5374.516293533601, 5376.731163441734, 5393.271908292487], "value": 5128.094211845199, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.3705228036702, 630.051772083015, 641.3041849593191, 653.6372313366081, 666.9666516674168, 29035.0, 29741.107766767003, 29777.106686799405, 38170.23659526808, 39085.60914390855, 40817.0, 41414.17171656565, 41529.37705934406, 41598.0, 41656.37515437271, 8456.154384561556, 8635.266002389804, 8656.437331573428, 8658.307335413183, 8662.30701543878, 8417.45286556375, 8508.064112947572, 8514.148585141467, 8520.360972927025, 8521.616527256288, 8495.405321627488, 8585.0, 8596.183362580576, 8752.168543988342, 8780.385373023892, 8658.264047555935, 8712.954445466521, 8718.389712720113, 8728.869066964, 8732.476051436903, 8601.225889669897, 8688.478691278544, 8705.564721763949, 8711.695090671796, 8712.172343627346, 40778.592214078075, 41164.1767164658, 41304.586954130675, 41352.0, 41414.0, 3407.114150320934, 3502.439609662442, 3573.910652233689, 3646.7994260315672, 3877.3990031545154, 26711.732882671313, 27274.181774546796, 28001.57997630037, 31781.0, 32524.674753252402, 4189.685773566995, 4191.706580539333, 4203.789810509462, 4233.534311225762, 4289.678274129453, 260015.0, 260696.0, 261058.0, 261818.0, 263023.0, 35267.29465410677, 36287.911362659164, 54162.45837541574, 54320.0, 54665.726671367185, 35839.28321433609, 35934.82032589873, 36046.09884752902, 36099.0, 36133.63866361355, 13664.31678416095, 13769.105008174436, 13831.30843457823, 13935.163890166623, 14071.226082565558, 12701.872981270253, 12717.10980231375, 12742.68143296425, 12743.745125097446, 12746.36268186587, 8416.452930559617, 8479.830403391898, 8544.914550854537, 8550.0, 8597.441166324168, 3224.774265801418, 3277.2298509850166, 3307.140143562643, 3327.93344133116, 3334.683205095512, 1057.7778666479971, 1064.8562444070105, 1070.9625163119254, 1079.1420820447763, 1141.8572678415198, 32503.34993300121, 32840.0, 32842.50736238958, 33195.50206746901, 33506.0, 1150.5340337163295, 1191.440023189117, 1214.3867346989714, 1229.2133034857698, 1251.0804558649386, 15929.920350398406, 16941.661166776594, 16992.490225293262, 16993.660126797397, 17354.826451735575, 482861.0, 487683.0, 488834.0, 489185.0, 490143.0, 55481.722591387595, 56384.0, 56448.0, 56471.71764141153, 56497.0, 1313.481174935895, 1405.501047128275, 1409.3446547355325, 1460.890433217513, 1506.5555661079788, 28465.715342846306, 30300.848495758262, 30536.621638369066, 30644.84677576598, 30772.692273076984, 45675.31487027764, 46054.76972615116, 46246.306305404774, 46350.76824615855, 46470.07059858716, 273936.0, 274168.0, 276379.0, 276655.0, 277044.0, 25431.36421589475, 28548.57177142303, 29207.269818254714, 29240.853795730884, 29512.557311639914, 40168.75109213886, 40656.1868762629, 41709.374359384026, 41741.165176695686, 41950.79024604857, 37369.0, 37833.243335133695, 38080.80959595184, 38262.2347553053, 38354.80822595869, 37230.25539489249, 37930.43104353382, 38439.423408648334, 38694.80652596719, 38904.41643375295, 39363.2127357457, 39526.60473395344, 40272.0, 40366.1926761469, 40433.797831010655, 32606.34787304288, 34515.4822677655, 34860.47709284312, 35196.0, 35293.294134117685, 26707.59938600884, 27320.863395682893, 27328.863355683094, 27744.260637216463, 27915.581266280617], "value": 17863.55670396811, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.852424602897, 402.6979765176118, 404.37120277967784, 408.3486838492604, 413.68973270047445, 17573.297068117277, 18179.0, 18216.180271887763, 18264.269429222815, 19114.426567202972, 17664.911675441635, 17878.642427151448, 18232.81767182328, 19097.427077187705, 19111.42665720027, 5621.690807005613, 5629.408912064236, 5768.163616275638, 5775.884482310351, 5787.652740835542, 5580.888382232373, 5734.254546908896, 5741.224934633813, 5745.885082298351, 5756.827295181151, 5236.554892834114, 5516.227728118067, 5522.447755224465, 5716.542676585884, 5721.713914304289, 5480.287562616854, 5518.889622207574, 5534.972325138388, 5535.806246781343, 5563.693996830173, 5248.370195576517, 5564.4713752193475, 5691.630044047124, 5693.800716974927, 5736.3403208631125, 12769.61691149267, 12978.675533111653, 13077.934610326982, 13089.41097650608, 13306.334683265797, 2310.975398174813, 2381.8451800633075, 2448.7428819973825, 2493.488834788864, 2862.184277480908, 9343.859842102374, 9837.655682051165, 9880.12277667241, 10073.798524029551, 10176.54205560744, 1918.7793403758608, 1920.7118932160288, 1933.168737442899, 2101.359085478928, 2109.251215818393, 56768.43231567673, 68857.65571172163, 69913.3008669912, 73789.63105184493, 79678.60160699218, 9608.231341492663, 9980.900190998142, 10381.84427233592, 10451.477426128815, 10668.413237271869, 14707.485238016618, 14798.408063677332, 14826.703465930621, 14828.184449855145, 14953.551393458214, 8001.839963200703, 8009.439339246197, 8057.838843223103, 8188.099309075997, 8224.547649879314, 7755.2632499912415, 7766.0, 7787.532748035136, 7860.960695196487, 7940.404469664682, 4645.883852903637, 4671.15919134559, 4725.976370118127, 4814.879628009257, 4874.075554667243, 1923.5479662279354, 1949.3274820187012, 1972.3195497553609, 1986.309224073049, 2058.0944384470786, 933.4585940154694, 953.6566835939057, 972.8151651186251, 997.2769741937037, 999.2455695949511, 11231.494582743633, 11459.541618335174, 17715.0, 18487.260509579468, 19395.0, 433.5859254412029, 450.1851648516131, 455.9430071241095, 458.40407470288494, 471.87495313741886, 5657.773689052474, 5796.9855275326645, 5912.044673198078, 6044.516438684895, 6221.06683997395, 487730.0, 491468.0, 492878.0, 506535.0, 509830.0, 85424.0, 86839.56580217059, 87117.56441217754, 87520.0, 88521.0, 480.4786806315187, 493.2527221259794, 494.3301826025755, 494.5573711528162, 496.76155445386416, 10585.311954722918, 10907.727306817393, 10929.836052459379, 10973.0, 11068.501917413574, 37402.625973739916, 37945.81027094957, 38157.427638586, 38227.80886095552, 38400.6159938397, 47980.280295794895, 52566.73716631392, 54801.725991369785, 54850.0, 54883.45116548784, 8332.750017499484, 8516.574171291535, 8607.18231767981, 8819.294456443597, 8826.470411775314, 12594.24434533931, 12693.048021398248, 12803.743925121631, 13483.123596966558, 13582.388792504164, 11701.2979221247, 11946.940265298617, 11947.0, 12133.453994570089, 12133.453994570442, 6625.900611490735, 9152.627105933896, 11357.602483913024, 11403.600873969703, 11482.138839586898, 11918.523259069887, 12129.332886691316, 12255.448504817483, 12330.260184388966, 12333.303410235609, 8350.290225330915, 8473.745787626382, 8647.654093836176, 8699.782505437415, 9199.172074513059, 8401.53791541471, 10969.451527423438, 11725.0, 11808.468618912342, 11906.880931190924], "value": 8236.382961760231, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.6196334044798, 1473.4253641079981, 1493.1712899340866, 1576.3064251729238, 1670.3986564836664, 7568.508046976949, 7890.684372625103, 7906.44654874159, 7906.92093079069, 7908.762737117889, 7795.92204077959, 7925.524468531878, 7928.16754240805, 7929.603519824, 7939.801504962379, 1930.855185861066, 2200.4938864061273, 2240.327901629513, 2269.704938358011, 2273.2611901132113, 2260.547890421914, 2267.5351552931693, 2269.8297627677907, 2272.693186419837, 2277.0436416704943, 2217.345882964529, 2259.8757068361233, 2266.841321107523, 2267.206477732797, 2267.648514480258, 1963.528753099253, 2188.3325585696357, 2249.2914731859414, 2255.954880902389, 2257.977420225793, 2178.3900507857825, 2196.0, 2199.637059885117, 2204.0081963116663, 2218.3344996501146, 7777.494462859952, 7857.664197086509, 7892.368610511203, 7899.249571290718, 7903.3282171015535, 4712.151812673717, 4847.030593881238, 4879.8780030499165, 4888.584470320027, 4935.111679897617, 3261.5433839262523, 3263.4125857345666, 3319.8008119512665, 3324.6176689680515, 3348.96651033489, 1065.9360438373722, 1078.320657985472, 1091.230682368928, 1096.5832983466312, 1110.317154949708, 10929.508172132193, 10964.780704385947, 10989.230753847154, 10992.17558683094, 11003.559857605685, 4282.935755963663, 4302.913941721148, 4450.332450132441, 4476.283794592915, 4479.686421950432, 9343.505039193697, 9348.532573371303, 9353.0, 9354.111359420844, 9359.064093590723, 4349.217140914602, 4984.37695288089, 4988.850334489971, 5010.0, 5017.0216807722145, 4418.5802348776815, 4497.347884556721, 4504.684672072924, 4510.954890451119, 4544.522825103317, 3766.491523644273, 3850.152966347399, 3916.1776027034643, 4022.4368588397647, 4052.675785937118, 1262.7600755856542, 1263.5451237554473, 1291.3865913691109, 1297.6366617347157, 1307.405130665564, 948.6869333120054, 968.0174622757906, 976.8876579193342, 982.3614650477247, 993.60752502761, 5577.8047768327915, 5613.101903695389, 5613.578981576398, 5692.743826527816, 5706.857328566819, 409.4084048549876, 415.33961002006953, 429.9871003869889, 430.5393229244678, 430.6167510915288, 3976.2445135424755, 4000.2799496090984, 4025.75845449274, 4032.2338755636333, 4131.566185550534, 9531.47576883278, 9840.261980351359, 9895.752606184758, 9932.950335248277, 9934.0, 9828.164606008426, 9831.80336393268, 9833.45915974614, 9835.311528192959, 9861.161801246832, 7415.443841711894, 7482.738104166437, 7586.165521792598, 7609.885851712229, 7622.885656715153, 5365.946340536545, 5401.378841433286, 5457.808976685797, 5465.453454654503, 5644.0, 8978.191962723125, 9074.410163339362, 9083.04628014049, 9135.177833994972, 9213.493257870881, 8695.782605434915, 8913.509756963429, 8939.374243803131, 9027.954860225656, 9033.141851524095, 6535.215774107138, 6858.142732158481, 7029.156501219886, 7038.472114591528, 7182.245864184186, 7346.412287017132, 7351.8162045949275, 7439.55362678241, 7441.739539116105, 7453.813654658677, 6831.59010459374, 6963.651817409211, 7030.3321184487395, 7030.437564994891, 7111.359977601834, 6933.5493192942295, 6948.791536253718, 6969.30306969299, 6979.232284448808, 7102.14774227096, 6158.199434073542, 6223.471004964629, 6224.346443623354, 6233.532485063548, 6306.054091886253, 4887.462379138221, 4991.700497970133, 5003.399592048978, 5007.949920500894, 5011.624128190473, 4929.679570827885, 4943.77753001123, 5052.9747351263, 5065.468125846733, 5177.171652535576], "value": 4247.161898237842, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.65426012776135, 323.652074020428, 325.5913828145677, 329.5402912936455, 331.59545354667296, 5563.888722225558, 5575.330960284767, 5663.235463212465, 5673.290838645169, 5675.2338434311405, 5535.972320138394, 5565.220869078322, 5575.69333686648, 5589.0, 5617.101263797793, 4113.0, 4154.984832356305, 4279.33670281107, 4306.1172459645695, 4319.6760242981745, 4300.440942677463, 4308.879691280274, 4309.870703878889, 4310.784460776964, 4315.870523884289, 4056.553779084298, 4278.679099067567, 4279.572042795711, 4281.593248641389, 4285.30730361507, 4195.85314513992, 4309.159713855799, 4312.417823593806, 4318.265894797892, 4327.350897365389, 3768.378217594121, 3771.1891943232063, 3772.1135533149686, 3778.5843557208686, 3785.3943369060817, 5310.20346947957, 5396.946030539723, 5399.271098401705, 5402.189671549259, 5413.729313534308, 4919.3358896549225, 4932.482089380635, 4950.3069570260195, 4951.0, 4956.083124621957, 5782.248307720011, 5842.766289348421, 5843.357230704619, 5867.11993201019, 5871.647701137946, 4077.143799802045, 4164.68764842638, 4177.394277829698, 4184.769837658928, 4185.602367775056, 6114.785982490592, 6139.355367686373, 6151.507879369639, 6156.599821011665, 6158.538109641795, 4248.4493159997, 4274.059706864485, 4275.593818587229, 4276.935845962313, 4289.1850548395705, 4160.83356665736, 4312.417823593837, 4332.480102387671, 4334.891627709332, 4341.2402829505345, 4928.359313289249, 4948.604111671058, 4952.62855285855, 4967.428745694219, 4970.801167953241, 5889.116632505073, 5915.467607915309, 5921.134842524591, 5946.316173640087, 5960.7780405016865, 1480.3412481445869, 1487.523992322468, 1504.3305728950731, 1504.6990601879668, 1518.7494063479403, 951.752544338477, 992.7766252593253, 1007.9546420410952, 1023.4371095897227, 1023.8822535408375, 5633.183188437653, 5651.15232715096, 5651.689157096317, 5657.349404818498, 5673.8297851064535, 6029.487493563096, 6035.1249068885645, 6042.516598672096, 6057.273127224761, 6082.878342433127, 5485.561155107662, 5645.322561292589, 5713.114467257582, 5773.1051686988585, 5774.682392468455, 3271.1985563537087, 3304.669533046676, 3306.8015919044933, 3309.983450082734, 3310.2717402171966, 6292.968535157386, 6411.935880641134, 6418.358164183638, 6419.656825258747, 6420.0690899819265, 6207.410296021871, 6232.8130156095385, 6233.438990490878, 6236.937630623726, 6247.250329960434, 6193.938060619426, 6312.842178945563, 6319.747210111544, 6338.207724034496, 6356.300806911236, 6106.1146133811235, 6106.847328816815, 6112.419320164578, 6118.479929206067, 6133.539984501091, 6027.758889644365, 6062.787802426894, 6065.120557519047, 6079.574429789872, 6084.209052823105, 5992.610480318765, 6347.5239357047485, 6371.267304260069, 6405.967970160119, 6442.387973142544, 4118.19695159453, 4146.66826653861, 4149.564295749024, 4161.937570936499, 4162.188373267184, 5961.344252132175, 6119.541034422347, 6176.876462470816, 6177.320494745484, 6218.9378106218355, 5926.496247818984, 5955.731992060454, 5958.255218097738, 5980.820575382745, 5981.162637230704, 5884.58807883444, 5888.528917686489, 5900.940990590211, 5913.2608423947, 5914.201582786269, 5718.828435146952, 5821.27234095738, 5833.183354330482, 5837.211976383303, 5848.853778655397, 5921.792737254348, 5938.406159384027, 5948.762049518144, 5966.433188847052, 5969.492593129459, 5635.746391412315, 5862.391235899983, 5887.087501437284, 5895.941040589711, 5915.112733090071], "value": 4480.568108579625, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.0851327327566, 730.7734602273295, 766.2490759056125, 777.6694904665516, 785.4423359414817, 13386.397612107454, 13430.462781488754, 13460.057795954288, 13502.12236204646, 14288.214148221856, 13088.73822523549, 13151.013673974467, 13176.604701858936, 13193.208407495533, 13195.142315749494, 645.3353046362231, 764.5068930539799, 783.4124406694979, 784.6704384158638, 788.3377962511504, 781.5388920536882, 784.7528028670979, 787.8660627693278, 788.8264581791997, 789.1989630525022, 825.8885050518163, 832.1262674192104, 832.8792325112855, 833.2875391540236, 834.0783434305097, 675.6689222281096, 791.8020494876281, 820.8358328334357, 825.9958700206521, 830.0910502999207, 603.0261128277843, 604.6341963112297, 604.6523249131723, 608.0514397539852, 608.0969759906579, 13620.795688064687, 13682.726345473035, 13721.0, 13732.862671373357, 13737.725245495134, 12168.57409990655, 12763.042771792152, 12808.10343275971, 12811.423485943062, 12874.420651070724, 11179.83230251547, 11273.661790146309, 11330.320180789178, 11366.26119302251, 11401.885981140165, 3760.4735337052834, 3767.0, 3814.408766641175, 3867.903302417434, 3902.824372903226, 55125.12889664485, 56028.0, 56110.15834762441, 56577.43422565763, 56631.433685663025, 9589.760255993517, 9736.75658108553, 9805.55874985613, 9839.458829764288, 9909.306348555676, 18660.906695466707, 18840.717389239173, 18852.717209241873, 18896.622067558572, 18940.526486837665, 7209.783706488814, 7240.601766902765, 7424.888626670604, 7533.773986780406, 7760.107587627495, 4129.359949207877, 4249.851255206115, 4288.914221715549, 4300.204462174508, 4369.08249267651, 3245.983770081182, 3300.3564304960782, 3334.283129127249, 3334.3831391192707, 3339.1151344893624, 562.5302872101759, 618.7184830901929, 627.244170774216, 632.2949910849462, 635.0791352538837, 641.7497176101324, 719.1406269507993, 733.2081352139676, 755.8299382638862, 789.7946533901227, 9163.404378715362, 9199.632014719336, 9284.48935308551, 9536.475493847905, 9650.131488166098, 631.9905201421982, 658.4699317049821, 675.1493118670412, 739.1684355100512, 740.7222291640635, 4514.977425112854, 4537.3647689323525, 4545.886352841139, 4586.0, 4621.8844528886375, 56894.43105568974, 62672.373276267565, 63028.684856575426, 63837.680811595645, 64699.67650161813, 51321.743391282806, 52363.476365236624, 52443.475565244626, 52502.94994100173, 54226.45773542293, 45458.31812522815, 46563.76718116388, 46732.5326746735, 47816.0, 48368.0, 8828.867566986371, 9022.86465703028, 9254.722358329262, 9284.257259419095, 9307.20888724439, 32971.67028329782, 33254.33491330208, 33355.0, 33862.0, 34428.655713442546, 42501.57498424976, 45706.54293457023, 45968.0, 46372.53627463682, 46507.76746116383, 10755.623553175601, 11045.33727976324, 11128.221024528206, 11221.71945701364, 11269.887301126884, 12073.39633018328, 12187.329696866758, 12544.184627999151, 12556.372181391076, 12778.0, 12406.875931240933, 12410.627681169579, 12439.626811195678, 12584.811227831773, 12794.744105118032, 11661.883381166419, 11749.412529373669, 12377.504899803907, 12524.0, 12928.741425171633, 12689.23864568129, 12829.87170128324, 12863.871361286267, 13039.674008149872, 13420.932895335462, 10478.528466219192, 10658.0, 10670.30643008202, 10963.50664220096, 10996.0, 10834.783304334027, 10857.457127143769, 11079.72300692489, 11094.057005154329, 11127.221094523306], "value": 6548.6273755677985, "unit": "score"}], "name": "dromaeo_css", "value": 6743.425655183289, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 106.0, 109.0, 112.0, 111.0, 101.0, 110.0, 111.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 170.0, 194.0, 136.0, 158.0, 159.0, 131.0, 179.0, 132.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 159.0, 161.0, 162.0, 163.0, 162.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 94.0, 107.0, 75.0, 72.0, 73.0, 138.0, 106.0, 76.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 150.0, 93.0, 93.0, 94.0, 148.0, 92.0, 93.0, 143.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 59.0, 58.0, 57.0, 74.0, 55.0, 52.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 63.0, 60.0, 60.0, 65.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 76.0, 75.0, 78.0, 78.0, 77.0, 79.0, 78.0, 77.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 133.0, 121.0, 127.0, 121.0, 122.0, 122.0, 158.0, 134.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 166.0, 175.0, 166.0, 164.0, 168.0, 167.0, 163.0, 163.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 68.0, 66.0, 68.0, 66.0, 68.0, 68.0, 68.0, 65.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1541.0000000000002, "alertThreshold": 2.0}]} 05:26:49 INFO - Return code: 0 05:26:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:26:49 ERROR - # TBPL SUCCESS # 05:26:49 INFO - Running post-action listener: _resource_record_post_action 05:26:49 INFO - Running post-run listener: _resource_record_post_run 05:26:50 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534552576; Read time: 12; Write time: 497444 05:26:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244264960; Read time: 0; Write time: 349824 05:26:50 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290287616; Read time: 12; Write time: 147620 05:26:50 INFO - Running post-run listener: _upload_blobber_files 05:26:50 INFO - Blob upload gear active. 05:26:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:50 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 05:26:50 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'] 05:26:50 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 05:26:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:26:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:26:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:52 INFO - (blobuploader) - INFO - Done attempting. 05:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:53 INFO - (blobuploader) - INFO - Done attempting. 05:26:53 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:53 INFO - Return code: 0 05:26:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d085e50761772b22afa9107019b8ca41734b24a06406ea844f301903d71bef6f2a333e81940a0f4382a6d3d5e1271636839590f5ff0c4f685b72e2a78f1cdbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8ca29a4220625a6a6fdbe4542dda2ef5995c311a62cdc74687ac2aa2664aad6de94adb817290445221cba46b10928e5d544cd6210c732bde0de63f01453ffd"} 05:26:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:53 INFO - Contents: 05:26:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d085e50761772b22afa9107019b8ca41734b24a06406ea844f301903d71bef6f2a333e81940a0f4382a6d3d5e1271636839590f5ff0c4f685b72e2a78f1cdbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8ca29a4220625a6a6fdbe4542dda2ef5995c311a62cdc74687ac2aa2664aad6de94adb817290445221cba46b10928e5d544cd6210c732bde0de63f01453ffd"} 05:26:53 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:53 INFO - Copying logs to upload dir... 05:26:53 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.367016 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-18 05:26:52.927549) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 05:26:52.932533) ========= 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=a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431 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/2d085e50761772b22afa9107019b8ca41734b24a06406ea844f301903d71bef6f2a333e81940a0f4382a6d3d5e1271636839590f5ff0c4f685b72e2a78f1cdbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8ca29a4220625a6a6fdbe4542dda2ef5995c311a62cdc74687ac2aa2664aad6de94adb817290445221cba46b10928e5d544cd6210c732bde0de63f01453ffd"} build_url:https://queue.taskcluster.net/v1/task/YoCdXpe7TRSXyMVOUHAbAA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/YoCdXpe7TRSXyMVOUHAbAA/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/2d085e50761772b22afa9107019b8ca41734b24a06406ea844f301903d71bef6f2a333e81940a0f4382a6d3d5e1271636839590f5ff0c4f685b72e2a78f1cdbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce8ca29a4220625a6a6fdbe4542dda2ef5995c311a62cdc74687ac2aa2664aad6de94adb817290445221cba46b10928e5d544cd6210c732bde0de63f01453ffd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 05:26:52.965595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 05:26:52.966044) ========= 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=a0d2d2de893abaa8702a9954000001a7-1460979205.574677-1435561431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 05:26:53.046805) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 05:26:53.050287) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 05:26:53.050718) ========= ========= Total master_lag: 0.20 =========