builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1464028156.41 results: success (0) buildid: 20160523083107 builduid: fdf84cb8792e4c3ebd72a5f3021c2e8c revision: d55c8a642e3aae2913df508d513d83bfa39959fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:16.409183) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:16.409655) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:16.409938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:16.427134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:16.427526) ========= 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=ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 11:29:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 211M=0s 2016-05-23 11:29:17 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084822 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:16.525771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:16.526198) ========= 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=ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017276 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:16.575393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:16.575761) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d55c8a642e3aae2913df508d513d83bfa39959fe --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 d55c8a642e3aae2913df508d513d83bfa39959fe --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=ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 11:29:17,121 truncating revision to first 12 chars 2016-05-23 11:29:17,121 Setting DEBUG logging. 2016-05-23 11:29:17,121 attempt 1/10 2016-05-23 11:29:17,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d55c8a642e3a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 11:29:17,388 unpacking tar archive at: fx-team-d55c8a642e3a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579970 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:17.169142) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:17.169471) ========= script_repo_revision: d55c8a642e3aae2913df508d513d83bfa39959fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:17.169876) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:17.170143) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:29:17.178657) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-23 11:29:17.179033) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:29:17 INFO - MultiFileLogger online at 20160523 11:29:17 in /builds/slave/test 11:29:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:29:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:29:17 INFO - {'append_to_log': False, 11:29:17 INFO - 'base_work_dir': '/builds/slave/test', 11:29:17 INFO - 'blob_upload_branch': 'Fx-Team', 11:29:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:29:17 INFO - 'branch': 'Fx-Team', 11:29:17 INFO - 'buildbot_json_path': 'buildprops.json', 11:29:17 INFO - 'config_files': ('talos/linux_config.py',), 11:29:17 INFO - 'default_actions': ('clobber', 11:29:17 INFO - 'read-buildbot-config', 11:29:17 INFO - 'download-and-extract', 11:29:17 INFO - 'populate-webroot', 11:29:17 INFO - 'create-virtualenv', 11:29:17 INFO - 'install', 11:29:17 INFO - 'run-tests'), 11:29:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:29:17 INFO - 'download_minidump_stackwalk': True, 11:29:17 INFO - 'download_symbols': 'ondemand', 11:29:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:29:17 INFO - 'tooltool.py': '/tools/tooltool.py', 11:29:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:29:17 INFO - '/tools/misc-python/virtualenv.py')}, 11:29:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:29:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:29:17 INFO - 'installer_path': 'installer.exe', 11:29:17 INFO - 'log_level': 'info', 11:29:17 INFO - 'log_name': 'talos', 11:29:17 INFO - 'log_to_console': True, 11:29:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:29:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:29:17 INFO - 'opt_config_files': (), 11:29:17 INFO - 'pip_index': False, 11:29:17 INFO - 'sps_profile': False, 11:29:17 INFO - 'sps_profile_interval': 0, 11:29:17 INFO - 'suite': 'dromaeojs-e10s', 11:29:17 INFO - 'system_bits': '32', 11:29:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:29:17 INFO - 'title': 'talos-linux64-ix-024', 11:29:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:29:17 INFO - 'use_talos_json': True, 11:29:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:29:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:29:17 INFO - 'work_dir': 'build'} 11:29:17 INFO - ##### 11:29:17 INFO - ##### Running clobber step. 11:29:17 INFO - ##### 11:29:17 INFO - Running pre-action listener: _resource_record_pre_action 11:29:17 INFO - Running main action method: clobber 11:29:17 INFO - rmtree: /builds/slave/test/build 11:29:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:29:18 INFO - Running post-action listener: _resource_record_post_action 11:29:18 INFO - ##### 11:29:18 INFO - ##### Finished clobber step (success) 11:29:18 INFO - ##### 11:29:18 INFO - ##### 11:29:18 INFO - ##### Running read-buildbot-config step. 11:29:18 INFO - ##### 11:29:18 INFO - Running pre-action listener: _resource_record_pre_action 11:29:18 INFO - Running main action method: read_buildbot_config 11:29:18 INFO - Using buildbot properties: 11:29:18 INFO - { 11:29:18 INFO - "project": "", 11:29:18 INFO - "product": "firefox", 11:29:18 INFO - "script_repo_revision": "production", 11:29:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:29:18 INFO - "repository": "", 11:29:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:29:18 INFO - "buildid": "20160523083107", 11:29:18 INFO - "pgo_build": "True", 11:29:18 INFO - "basedir": "/builds/slave/test", 11:29:18 INFO - "buildnumber": 363, 11:29:18 INFO - "slavename": "talos-linux64-ix-024", 11:29:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:29:18 INFO - "platform": "ubuntu64_hw", 11:29:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:29:18 INFO - "branch": "fx-team", 11:29:18 INFO - "repo_path": "integration/fx-team", 11:29:18 INFO - "revision": "d55c8a642e3aae2913df508d513d83bfa39959fe", 11:29:18 INFO - "stage_platform": "linux64-pgo", 11:29:18 INFO - "builduid": "fdf84cb8792e4c3ebd72a5f3021c2e8c", 11:29:18 INFO - "slavebuilddir": "test" 11:29:18 INFO - } 11:29:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:29:18 INFO - Running post-action listener: _resource_record_post_action 11:29:18 INFO - ##### 11:29:18 INFO - ##### Finished read-buildbot-config step (success) 11:29:18 INFO - ##### 11:29:18 INFO - ##### 11:29:18 INFO - ##### Running download-and-extract step. 11:29:18 INFO - ##### 11:29:18 INFO - Running pre-action listener: _resource_record_pre_action 11:29:18 INFO - Running main action method: download_and_extract 11:29:18 INFO - mkdir: /builds/slave/test/build/tests 11:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:18 INFO - https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:29:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:29:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:29:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:29:18 INFO - Downloaded 1361 bytes. 11:29:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:29:19 INFO - Using the following test package requirements: 11:29:19 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:29:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:29:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:29:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:19 INFO - u'jsshell-linux-x86_64.zip'], 11:29:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:29:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:29:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:29:19 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:29:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:29:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:29:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:29:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:29: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')]} 11:29:19 INFO - https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:29:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:29:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:29:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:29:20 INFO - Downloaded 24388158 bytes. 11:29:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:29:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:29:21 INFO - Return code: 0 11:29:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:29: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')]} 11:29:21 INFO - https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:29:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:29:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:29:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:29:22 INFO - Downloaded 24388158 bytes. 11:29:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:29:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:29:23 INFO - Return code: 0 11:29:23 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')]} 11:29:23 INFO - https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:29:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:29:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:29:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:29:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:29:24 INFO - Downloaded 10840359 bytes. 11:29:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:29:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:29:24 INFO - Return code: 0 11:29: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')]} 11:29:24 INFO - https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:29:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:29:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:29:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:29:26 INFO - Downloaded 58610420 bytes. 11:29:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:29:26 INFO - mkdir: /builds/slave/test/properties 11:29:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:29:26 INFO - Writing to file /builds/slave/test/properties/build_url 11:29:26 INFO - Contents: 11:29:26 INFO - build_url:https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:29:27 INFO - Running post-action listener: _resource_record_post_action 11:29:27 INFO - Running post-action listener: set_extra_try_arguments 11:29:27 INFO - ##### 11:29:27 INFO - ##### Finished download-and-extract step (success) 11:29:27 INFO - ##### 11:29:27 INFO - ##### 11:29:27 INFO - ##### Running populate-webroot step. 11:29:27 INFO - ##### 11:29:27 INFO - Running pre-action listener: _resource_record_pre_action 11:29:27 INFO - Running main action method: populate_webroot 11:29:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:29:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:29:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:29:27 INFO - '--tppagecycles', 11:29:27 INFO - '7'], 11:29:27 INFO - 'tests': ['tsvgm']}}, 11:29:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:29:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:29:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:29:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:29:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:29:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:29:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:29:27 INFO - 'talos_options': ['--disable-e10s'], 11:29:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:29:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:29:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:29:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:29:27 INFO - 'talos_options': ['--disable-e10s'], 11:29:27 INFO - 'tests': ['damp', 'tps']}, 11:29:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:29:27 INFO - 'tests': ['damp', 'tps']}, 11:29:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:29:27 INFO - 'tests': ['dromaeo_dom']}, 11:29:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:29:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:29:27 INFO - 'tests': ['a11yr', 11:29:27 INFO - 'ts_paint', 11:29:27 INFO - 'tpaint', 11:29:27 INFO - 'sessionrestore', 11:29:27 INFO - 'sessionrestore_no_auto_restore', 11:29:27 INFO - 'tabpaint']}, 11:29:27 INFO - 'other-e10s': {'tests': ['a11yr', 11:29:27 INFO - 'ts_paint', 11:29:27 INFO - 'tpaint', 11:29:27 INFO - 'sessionrestore', 11:29:27 INFO - 'sessionrestore_no_auto_restore', 11:29:27 INFO - 'tabpaint']}, 11:29:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:29:27 INFO - 'ts_paint', 11:29:27 INFO - 'tpaint', 11:29:27 INFO - 'sessionrestore', 11:29:27 INFO - 'sessionrestore_no_auto_restore', 11:29:27 INFO - 'tabpaint']}, 11:29:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:29:27 INFO - 'ts_paint', 11:29:27 INFO - 'tpaint', 11:29:27 INFO - 'sessionrestore', 11:29:27 INFO - 'sessionrestore_no_auto_restore', 11:29:27 INFO - 'tabpaint']}, 11:29:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:29:27 INFO - 'tests': ['a11yr', 11:29:27 INFO - 'ts_paint', 11:29:27 INFO - 'tpaint', 11:29:27 INFO - 'sessionrestore', 11:29:27 INFO - 'sessionrestore_no_auto_restore', 11:29:27 INFO - 'tabpaint']}, 11:29:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:29:27 INFO - 'tests': ['a11yr', 11:29:27 INFO - 'ts_paint', 11:29:27 INFO - 'tpaint', 11:29:27 INFO - 'sessionrestore', 11:29:27 INFO - 'sessionrestore_no_auto_restore', 11:29:27 INFO - 'tabpaint']}, 11:29:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:29:27 INFO - 'tests': ['tsvgx', 11:29:27 INFO - 'tsvgr_opacity', 11:29:27 INFO - 'tart', 11:29:27 INFO - 'tscrollx', 11:29:27 INFO - 'cart']}, 11:29:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:29:27 INFO - 'tsvgr_opacity', 11:29:27 INFO - 'tart', 11:29:27 INFO - 'tscrollx', 11:29:27 INFO - 'cart']}, 11:29:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:29:27 INFO - 'talos_options': ['--disable-e10s'], 11:29:27 INFO - 'tests': ['tp5o']}, 11:29:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:29:27 INFO - 'tests': ['tp5o']}, 11:29:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:29:27 INFO - 'talos_options': ['--disable-e10s', 11:29:27 INFO - '--xperf_path', 11:29:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:29:27 INFO - 'tests': ['tp5n']}, 11:29:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:29:27 INFO - 'talos_options': ['--xperf_path', 11:29:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:29:27 INFO - 'tests': ['tp5n']}}, 11:29:27 INFO - 'talos.zip': {'path': '', 11:29:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:29:27 INFO - Running post-action listener: _resource_record_post_action 11:29:27 INFO - ##### 11:29:27 INFO - ##### Finished populate-webroot step (success) 11:29:27 INFO - ##### 11:29:27 INFO - ##### 11:29:27 INFO - ##### Running create-virtualenv step. 11:29:27 INFO - ##### 11:29:27 INFO - Running pre-action listener: _resource_record_pre_action 11:29:27 INFO - Running main action method: create_virtualenv 11:29:27 INFO - Creating virtualenv /builds/slave/test/build/venv 11:29:27 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 11:29:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:29:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:29:27 INFO - Using real prefix '/usr' 11:29:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:29:27 INFO - Installing distribute.............................................................................................................................................................................................done. 11:29:29 INFO - Installing pip.................done. 11:29:29 INFO - Return code: 0 11:29:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:29:29 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')]} 11:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:29 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')]} 11:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:29 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 0x7fef4af1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26569c0>, '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 0x26578c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2657d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', '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 11:29:29 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 11:29:29 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 11:29:29 INFO - Using env: {'DISPLAY': ':0', 11:29:29 INFO - 'HOME': '/home/cltbld', 11:29:29 INFO - 'LANG': 'en_US.UTF-8', 11:29:29 INFO - 'LANGUAGE': 'en_US:en', 11:29:29 INFO - 'LOGNAME': 'cltbld', 11:29:29 INFO - 'MAIL': '/var/mail/cltbld', 11:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:29 INFO - 'MOZ_NO_REMOTE': '1', 11:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:29 INFO - 'NO_EM_RESTART': '1', 11:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:29 INFO - 'PWD': '/builds/slave/test', 11:29:29 INFO - 'SHELL': '/bin/bash', 11:29:29 INFO - 'SHLVL': '1', 11:29:29 INFO - 'TERM': 'linux', 11:29:29 INFO - 'TMOUT': '86400', 11:29:29 INFO - 'USER': 'cltbld', 11:29:29 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', 11:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:29 INFO - '_': '/tools/buildbot/bin/python'} 11:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:29 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 11:29:29 INFO - Cleaning up... 11:29:29 INFO - Return code: 0 11:29:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:29:29 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')]} 11:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:29 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')]} 11:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:29 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef4af1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26569c0>, '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 0x26578c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2657d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', '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 11:29:29 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>=3.1.1'] in /builds/slave/test/build 11:29:29 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>=3.1.1 11:29:29 INFO - Using env: {'DISPLAY': ':0', 11:29:29 INFO - 'HOME': '/home/cltbld', 11:29:29 INFO - 'LANG': 'en_US.UTF-8', 11:29:29 INFO - 'LANGUAGE': 'en_US:en', 11:29:29 INFO - 'LOGNAME': 'cltbld', 11:29:29 INFO - 'MAIL': '/var/mail/cltbld', 11:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:29 INFO - 'MOZ_NO_REMOTE': '1', 11:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:29 INFO - 'NO_EM_RESTART': '1', 11:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:29 INFO - 'PWD': '/builds/slave/test', 11:29:29 INFO - 'SHELL': '/bin/bash', 11:29:29 INFO - 'SHLVL': '1', 11:29:29 INFO - 'TERM': 'linux', 11:29:29 INFO - 'TMOUT': '86400', 11:29:29 INFO - 'USER': 'cltbld', 11:29:29 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', 11:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:29 INFO - '_': '/tools/buildbot/bin/python'} 11:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:30 INFO - Downloading/unpacking psutil>=3.1.1 11:29:30 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 11:29:30 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 11:29:30 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 11:29:30 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 11:29:30 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 11:29:30 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 11:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:29:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:29:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:29:32 INFO - Installing collected packages: psutil 11:29:32 INFO - Running setup.py install for psutil 11:29:32 INFO - building 'psutil._psutil_linux' extension 11:29:32 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 11:29:32 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 11:29:32 INFO - building 'psutil._psutil_posix' extension 11:29:32 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 11:29:32 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 11:29:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:29:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:29:32 INFO - Successfully installed psutil 11:29:32 INFO - Cleaning up... 11:29:32 INFO - Return code: 0 11:29:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:29: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')]} 11:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29: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')]} 11:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:32 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef4af1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26569c0>, '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 0x26578c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2657d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', '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 11:29:32 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.3'] in /builds/slave/test/build 11:29:32 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.3 11:29:32 INFO - Using env: {'DISPLAY': ':0', 11:29:32 INFO - 'HOME': '/home/cltbld', 11:29:32 INFO - 'LANG': 'en_US.UTF-8', 11:29:32 INFO - 'LANGUAGE': 'en_US:en', 11:29:32 INFO - 'LOGNAME': 'cltbld', 11:29:32 INFO - 'MAIL': '/var/mail/cltbld', 11:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:32 INFO - 'MOZ_NO_REMOTE': '1', 11:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:32 INFO - 'NO_EM_RESTART': '1', 11:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:32 INFO - 'PWD': '/builds/slave/test', 11:29:32 INFO - 'SHELL': '/bin/bash', 11:29:32 INFO - 'SHLVL': '1', 11:29:32 INFO - 'TERM': 'linux', 11:29:32 INFO - 'TMOUT': '86400', 11:29:32 INFO - 'USER': 'cltbld', 11:29:32 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', 11:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:32 INFO - '_': '/tools/buildbot/bin/python'} 11:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:29:32 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 11:29:32 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 11:29:32 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 11:29:32 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 11:29:32 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 11:29:32 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 11:29:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:29:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:29:34 INFO - Installing collected packages: mozsystemmonitor 11:29:34 INFO - Running setup.py install for mozsystemmonitor 11:29:34 INFO - Successfully installed mozsystemmonitor 11:29:34 INFO - Cleaning up... 11:29:34 INFO - Return code: 0 11:29:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:29:34 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')]} 11:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:34 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')]} 11:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:34 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 0x7fef4af1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26569c0>, '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 0x26578c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2657d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', '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 11:29:34 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 11:29:34 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 11:29:34 INFO - Using env: {'DISPLAY': ':0', 11:29:34 INFO - 'HOME': '/home/cltbld', 11:29:34 INFO - 'LANG': 'en_US.UTF-8', 11:29:34 INFO - 'LANGUAGE': 'en_US:en', 11:29:34 INFO - 'LOGNAME': 'cltbld', 11:29:34 INFO - 'MAIL': '/var/mail/cltbld', 11:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:34 INFO - 'MOZ_NO_REMOTE': '1', 11:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:34 INFO - 'NO_EM_RESTART': '1', 11:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:34 INFO - 'PWD': '/builds/slave/test', 11:29:34 INFO - 'SHELL': '/bin/bash', 11:29:34 INFO - 'SHLVL': '1', 11:29:34 INFO - 'TERM': 'linux', 11:29:34 INFO - 'TMOUT': '86400', 11:29:34 INFO - 'USER': 'cltbld', 11:29:34 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', 11:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:34 INFO - '_': '/tools/buildbot/bin/python'} 11:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:35 INFO - Downloading/unpacking blobuploader==1.2.4 11:29:35 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 11:29:35 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 11:29:35 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 11:29:35 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 11:29:35 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 11:29:35 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 11:29:37 INFO - Downloading blobuploader-1.2.4.tar.gz 11:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:29:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:29: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 11:29: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 11:29: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 11:29: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 11:29: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 11:29: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 11:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:29:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:29: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 11:29: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 11:29: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 11:29: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 11:29: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 11:29: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 11:29:37 INFO - Downloading docopt-0.6.1.tar.gz 11:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:29:38 INFO - Installing collected packages: blobuploader, requests, docopt 11:29:38 INFO - Running setup.py install for blobuploader 11:29:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:29:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:29:38 INFO - Running setup.py install for requests 11:29:38 INFO - Running setup.py install for docopt 11:29:38 INFO - Successfully installed blobuploader requests docopt 11:29:38 INFO - Cleaning up... 11:29:38 INFO - Return code: 0 11:29:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:38 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 0x7fef4af1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26569c0>, '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 0x26578c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2657d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', '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 11:29:38 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 11:29:38 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 11:29:38 INFO - Using env: {'DISPLAY': ':0', 11:29:38 INFO - 'HOME': '/home/cltbld', 11:29:38 INFO - 'LANG': 'en_US.UTF-8', 11:29:38 INFO - 'LANGUAGE': 'en_US:en', 11:29:38 INFO - 'LOGNAME': 'cltbld', 11:29:38 INFO - 'MAIL': '/var/mail/cltbld', 11:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:38 INFO - 'MOZ_NO_REMOTE': '1', 11:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:38 INFO - 'NO_EM_RESTART': '1', 11:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:38 INFO - 'PWD': '/builds/slave/test', 11:29:38 INFO - 'SHELL': '/bin/bash', 11:29:38 INFO - 'SHLVL': '1', 11:29:38 INFO - 'TERM': 'linux', 11:29:38 INFO - 'TMOUT': '86400', 11:29:38 INFO - 'USER': 'cltbld', 11:29:38 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', 11:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:38 INFO - '_': '/tools/buildbot/bin/python'} 11:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:29:38 INFO - Running setup.py (path:/tmp/pip-eh1ZXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:29:38 INFO - Running setup.py (path:/tmp/pip-hgx4o7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:29:38 INFO - Running setup.py (path:/tmp/pip-Pbznp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:29:39 INFO - Running setup.py (path:/tmp/pip-CqDXy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:29:39 INFO - Running setup.py (path:/tmp/pip-LA7wsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:29:39 INFO - Running setup.py (path:/tmp/pip-FDcmzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:29:39 INFO - Running setup.py (path:/tmp/pip-ATDbnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:29:39 INFO - Running setup.py (path:/tmp/pip-d9UzXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:29:39 INFO - Running setup.py (path:/tmp/pip-qI8CHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:29:39 INFO - Running setup.py (path:/tmp/pip-_b7HtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:29:39 INFO - Running setup.py (path:/tmp/pip-KF3i7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:29:39 INFO - Running setup.py (path:/tmp/pip-OVw224-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:29:39 INFO - Running setup.py (path:/tmp/pip-P_b7TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:29:39 INFO - Running setup.py (path:/tmp/pip-1L_s6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:39 INFO - Running setup.py (path:/tmp/pip-TKtxzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:29:39 INFO - Running setup.py (path:/tmp/pip-rVQqMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:29:39 INFO - Running setup.py (path:/tmp/pip-8D5Uwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:29:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:29:40 INFO - Running setup.py install for manifestparser 11:29:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:29:40 INFO - Running setup.py install for mozcrash 11:29:40 INFO - Running setup.py install for mozdebug 11:29:40 INFO - Running setup.py install for mozdevice 11:29:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:29:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:29:40 INFO - Running setup.py install for mozfile 11:29:40 INFO - Running setup.py install for mozhttpd 11:29:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:29:40 INFO - Running setup.py install for mozinfo 11:29:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:29:40 INFO - Running setup.py install for mozInstall 11:29:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:29:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:29:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:29:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:29:40 INFO - Running setup.py install for mozleak 11:29:40 INFO - Running setup.py install for mozlog 11:29:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:29:41 INFO - Running setup.py install for moznetwork 11:29:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:29:41 INFO - Running setup.py install for mozprocess 11:29:41 INFO - Running setup.py install for mozprofile 11:29:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:29:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:29:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:29:41 INFO - Running setup.py install for mozrunner 11:29:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:29:41 INFO - Running setup.py install for mozscreenshot 11:29:41 INFO - Running setup.py install for moztest 11:29:41 INFO - Running setup.py install for mozversion 11:29:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:29:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:29:41 INFO - Cleaning up... 11:29:41 INFO - Return code: 0 11:29:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29:41 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')]} 11:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:41 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')]} 11:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:41 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 0x7fef4af1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26569c0>, '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 0x26578c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2657d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', '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 11:29:41 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 11:29:41 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 11:29:41 INFO - Using env: {'DISPLAY': ':0', 11:29:41 INFO - 'HOME': '/home/cltbld', 11:29:41 INFO - 'LANG': 'en_US.UTF-8', 11:29:41 INFO - 'LANGUAGE': 'en_US:en', 11:29:41 INFO - 'LOGNAME': 'cltbld', 11:29:41 INFO - 'MAIL': '/var/mail/cltbld', 11:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:41 INFO - 'MOZ_NO_REMOTE': '1', 11:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:41 INFO - 'NO_EM_RESTART': '1', 11:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:41 INFO - 'PWD': '/builds/slave/test', 11:29:41 INFO - 'SHELL': '/bin/bash', 11:29:41 INFO - 'SHLVL': '1', 11:29:41 INFO - 'TERM': 'linux', 11:29:41 INFO - 'TMOUT': '86400', 11:29:41 INFO - 'USER': 'cltbld', 11:29:41 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', 11:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:41 INFO - '_': '/tools/buildbot/bin/python'} 11:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:29:42 INFO - Running setup.py (path:/tmp/pip-9om_wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:29:42 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:29:42 INFO - Running setup.py (path:/tmp/pip-7JfUYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:29:42 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:29:42 INFO - Running setup.py (path:/tmp/pip-OwYcoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:29:42 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:29:42 INFO - Running setup.py (path:/tmp/pip-aBXv18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:29:42 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:29:42 INFO - Running setup.py (path:/tmp/pip-iGyYFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:29:42 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:29:42 INFO - Running setup.py (path:/tmp/pip-63BNA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:29:42 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:29:42 INFO - Running setup.py (path:/tmp/pip-h9drDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:29:42 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:29:42 INFO - Running setup.py (path:/tmp/pip-atjPQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:29:42 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:29:42 INFO - Running setup.py (path:/tmp/pip-ddDx4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:29:42 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:29:42 INFO - Running setup.py (path:/tmp/pip-Jkyw1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:29:42 INFO - Running setup.py (path:/tmp/pip-i3b2lV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:29:42 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:29:42 INFO - Running setup.py (path:/tmp/pip-04Kcii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:29:42 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)) 11:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:29:42 INFO - Running setup.py (path:/tmp/pip-SHDNWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:29:43 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)) 11:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:29:43 INFO - Running setup.py (path:/tmp/pip-DHBOIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:29:43 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)) 11:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:43 INFO - Running setup.py (path:/tmp/pip-OXnAnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:43 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)) 11:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:29:43 INFO - Running setup.py (path:/tmp/pip-yenMwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:29:43 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)) 11:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:29:43 INFO - Running setup.py (path:/tmp/pip-fTawAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:29:43 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)) 11:29:43 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)) 11:29:43 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)) 11:29:43 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)) 11:29:43 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)) 11:29:43 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)) 11:29:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:45 INFO - Downloading blessings-1.6.tar.gz 11:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:29:45 INFO - Installing collected packages: blessings 11:29:45 INFO - Running setup.py install for blessings 11:29:45 INFO - Successfully installed blessings 11:29:45 INFO - Cleaning up... 11:29:45 INFO - Return code: 0 11:29:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:29:45 INFO - Reading from file tmpfile_stdout 11:29:45 INFO - Current package versions: 11:29:45 INFO - argparse == 1.2.1 11:29:45 INFO - blessings == 1.6 11:29:45 INFO - blobuploader == 1.2.4 11:29:45 INFO - docopt == 0.6.1 11:29:45 INFO - manifestparser == 1.1 11:29:45 INFO - mozInstall == 1.12 11:29:45 INFO - mozcrash == 0.17 11:29:45 INFO - mozdebug == 0.1 11:29:45 INFO - mozdevice == 0.48 11:29:45 INFO - mozfile == 1.2 11:29:45 INFO - mozhttpd == 0.7 11:29:45 INFO - mozinfo == 0.9 11:29:45 INFO - mozleak == 0.1 11:29:45 INFO - mozlog == 3.2 11:29:45 INFO - moznetwork == 0.27 11:29:45 INFO - mozprocess == 0.22 11:29:45 INFO - mozprofile == 0.28 11:29:45 INFO - mozrunner == 6.11 11:29:45 INFO - mozscreenshot == 0.1 11:29:45 INFO - mozsystemmonitor == 0.3 11:29:45 INFO - moztest == 0.7 11:29:45 INFO - mozversion == 1.4 11:29:45 INFO - psutil == 3.1.1 11:29:45 INFO - requests == 1.2.3 11:29:45 INFO - wsgiref == 0.1.2 11:29:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29: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')]} 11:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29: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')]} 11:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:45 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 0x7fef4af1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26569c0>, '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 0x26578c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2657d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', '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 11:29:45 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 11:29:45 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 11:29:45 INFO - Using env: {'DISPLAY': ':0', 11:29:45 INFO - 'HOME': '/home/cltbld', 11:29:45 INFO - 'LANG': 'en_US.UTF-8', 11:29:45 INFO - 'LANGUAGE': 'en_US:en', 11:29:45 INFO - 'LOGNAME': 'cltbld', 11:29:45 INFO - 'MAIL': '/var/mail/cltbld', 11:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:45 INFO - 'MOZ_NO_REMOTE': '1', 11:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:45 INFO - 'NO_EM_RESTART': '1', 11:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:45 INFO - 'PWD': '/builds/slave/test', 11:29:45 INFO - 'SHELL': '/bin/bash', 11:29:45 INFO - 'SHLVL': '1', 11:29:45 INFO - 'TERM': 'linux', 11:29:45 INFO - 'TMOUT': '86400', 11:29:45 INFO - 'USER': 'cltbld', 11:29:45 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', 11:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:45 INFO - '_': '/tools/buildbot/bin/python'} 11:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:45 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)) 11:29:45 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)) 11:29:45 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)) 11:29:45 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)) 11:29:45 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)) 11:29:45 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)) 11:29:45 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)) 11:29:45 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)) 11:29:45 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)) 11:29:45 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)) 11:29:45 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)) 11:29:45 INFO - Cleaning up... 11:29:45 INFO - Return code: 0 11:29:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:29: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')]} 11:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29: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')]} 11:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:45 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 0x7fef4af1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26569c0>, '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 0x26578c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2657d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', '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 11:29:45 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 11:29:45 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 11:29:45 INFO - Using env: {'DISPLAY': ':0', 11:29:45 INFO - 'HOME': '/home/cltbld', 11:29:45 INFO - 'LANG': 'en_US.UTF-8', 11:29:45 INFO - 'LANGUAGE': 'en_US:en', 11:29:45 INFO - 'LOGNAME': 'cltbld', 11:29:45 INFO - 'MAIL': '/var/mail/cltbld', 11:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:45 INFO - 'MOZ_NO_REMOTE': '1', 11:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:45 INFO - 'NO_EM_RESTART': '1', 11:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:45 INFO - 'PWD': '/builds/slave/test', 11:29:45 INFO - 'SHELL': '/bin/bash', 11:29:45 INFO - 'SHLVL': '1', 11:29:45 INFO - 'TERM': 'linux', 11:29:45 INFO - 'TMOUT': '86400', 11:29:45 INFO - 'USER': 'cltbld', 11:29:45 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', 11:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:45 INFO - '_': '/tools/buildbot/bin/python'} 11:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:46 INFO - Downloading/unpacking jsonschema 11:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:29:48 INFO - Downloading/unpacking functools32 (from jsonschema) 11:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:48 INFO - Downloading functools32-3.2.3-2.tar.gz 11:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:29:48 INFO - warning: no files found matching '*.txt' 11:29:48 INFO - no previously-included directories found matching 'build' 11:29:48 INFO - no previously-included directories found matching 'dist' 11:29:48 INFO - no previously-included directories found matching '.git*' 11:29:48 INFO - Installing collected packages: jsonschema, functools32 11:29:48 INFO - Running setup.py install for functools32 11:29:48 INFO - warning: no files found matching '*.txt' 11:29:48 INFO - no previously-included directories found matching 'build' 11:29:48 INFO - no previously-included directories found matching 'dist' 11:29:48 INFO - no previously-included directories found matching '.git*' 11:29:48 INFO - Successfully installed jsonschema functools32 11:29:48 INFO - Cleaning up... 11:29:48 INFO - Return code: 0 11:29:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:29:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef4af1af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26569c0>, '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 0x26578c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2657d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', '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 11:29:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:29:48 INFO - Using env: {'DISPLAY': ':0', 11:29:48 INFO - 'HOME': '/home/cltbld', 11:29:48 INFO - 'LANG': 'en_US.UTF-8', 11:29:48 INFO - 'LANGUAGE': 'en_US:en', 11:29:48 INFO - 'LOGNAME': 'cltbld', 11:29:48 INFO - 'MAIL': '/var/mail/cltbld', 11:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:48 INFO - 'MOZ_NO_REMOTE': '1', 11:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:48 INFO - 'NO_EM_RESTART': '1', 11:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:48 INFO - 'PWD': '/builds/slave/test', 11:29:48 INFO - 'SHELL': '/bin/bash', 11:29:48 INFO - 'SHLVL': '1', 11:29:48 INFO - 'TERM': 'linux', 11:29:48 INFO - 'TMOUT': '86400', 11:29:48 INFO - 'USER': 'cltbld', 11:29:48 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', 11:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:48 INFO - '_': '/tools/buildbot/bin/python'} 11:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:48 INFO - Downloading/unpacking flake8 11:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:29:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:29: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 11:29: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 11:29: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 11:29: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 11:29: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 11:29: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 11:29:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:29:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:29: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 11:29: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 11:29: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 11:29: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 11:29: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 11:29: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 11:29:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:29:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:29:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:29:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:29:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:29:51 INFO - no previously-included directories found matching 'docs/_build' 11:29:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:29:51 INFO - Running setup.py install for pep8 11:29:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:29:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:29:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:29:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:29:51 INFO - no previously-included directories found matching 'docs/_build' 11:29:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:29:51 INFO - Cleaning up... 11:29:51 INFO - Return code: 0 11:29:51 INFO - Running post-action listener: _resource_record_post_action 11:29:51 INFO - Running post-action listener: _start_resource_monitoring 11:29:51 INFO - Starting resource monitoring. 11:29:51 INFO - ##### 11:29:51 INFO - ##### Finished create-virtualenv step (success) 11:29:51 INFO - ##### 11:29:51 INFO - ##### 11:29:51 INFO - ##### Running install step. 11:29:51 INFO - ##### 11:29:51 INFO - Running pre-action listener: _resource_record_pre_action 11:29:51 INFO - Running main action method: install 11:29:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:29:51 INFO - Reading from file tmpfile_stdout 11:29:51 INFO - Detecting whether we're running mozinstall >=1.0... 11:29:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:29:51 INFO - Reading from file tmpfile_stdout 11:29:51 INFO - Output received: 11:29:51 INFO - Usage: mozinstall [options] installer 11:29:51 INFO - Options: 11:29:51 INFO - -h, --help show this help message and exit 11:29:51 INFO - -d DEST, --destination=DEST 11:29:51 INFO - Directory to install application into. [default: 11:29:51 INFO - "/builds/slave/test"] 11:29:51 INFO - --app=APP Application being installed. [default: firefox] 11:29:51 INFO - mkdir: /builds/slave/test/build/application 11:29:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:30:08 INFO - Reading from file tmpfile_stdout 11:30:08 INFO - Output received: 11:30:08 INFO - /builds/slave/test/build/application/firefox/firefox 11:30:08 INFO - Running post-action listener: _resource_record_post_action 11:30:08 INFO - ##### 11:30:08 INFO - ##### Finished install step (success) 11:30:08 INFO - ##### 11:30:08 INFO - ##### 11:30:08 INFO - ##### Running run-tests step. 11:30:08 INFO - ##### 11:30:08 INFO - Running pre-action listener: _resource_record_pre_action 11:30:08 INFO - Running main action method: run_tests 11:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:30:08 INFO - Python 2.7.3 11:30:08 INFO - Return code: 0 11:30:08 INFO - grabbing minidump binary from tooltool 11:30:08 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')]} 11:30:08 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26569c0>, '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 0x26578c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2657d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:30:08 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 11:30:08 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 11:30:08 INFO - Calling ['/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'] with output_timeout 600 11:30:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:30:08 INFO - Return code: 0 11:30:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:30:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:30:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:30:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:30:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:30:09 INFO - Return code: 0 11:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:30:09 INFO - Using env: {'DISPLAY': ':0', 11:30:09 INFO - 'HOME': '/home/cltbld', 11:30:09 INFO - 'LANG': 'en_US.UTF-8', 11:30:09 INFO - 'LANGUAGE': 'en_US:en', 11:30:09 INFO - 'LOGNAME': 'cltbld', 11:30:09 INFO - 'MAIL': '/var/mail/cltbld', 11:30:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:30:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:09 INFO - 'MOZ_NO_REMOTE': '1', 11:30:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:09 INFO - 'NO_EM_RESTART': '1', 11:30:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:09 INFO - 'PWD': '/builds/slave/test', 11:30:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:30:09 INFO - 'SHELL': '/bin/bash', 11:30:09 INFO - 'SHLVL': '1', 11:30:09 INFO - 'TERM': 'linux', 11:30:09 INFO - 'TMOUT': '86400', 11:30:09 INFO - 'USER': 'cltbld', 11:30:09 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499', 11:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:09 INFO - '_': '/tools/buildbot/bin/python'} 11:30:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:30:09 INFO - mozversion application_buildid: 20160523083107 11:30:09 INFO - mozversion application_changeset: d55c8a642e3aae2913df508d513d83bfa39959fe 11:30:09 INFO - mozversion application_display_name: Nightly 11:30:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:30:09 INFO - mozversion application_name: Firefox 11:30:09 INFO - mozversion application_remotingname: firefox 11:30:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:30:09 INFO - mozversion application_vendor: Mozilla 11:30:09 INFO - mozversion application_version: 49.0a1 11:30:09 INFO - mozversion platform_buildid: 20160523083107 11:30:09 INFO - mozversion platform_changeset: d55c8a642e3aae2913df508d513d83bfa39959fe 11:30:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:30:09 INFO - mozversion platform_version: 49.0a1 11:30:09 INFO - using testdate: 1464028209 11:30:09 INFO - actual date: 1464028209 11:30:09 INFO - starting webserver on 'localhost:46753' 11:30:09 INFO - SUITE-START | Running 2 tests 11:30:09 INFO - TEST-START | dromaeo_css 11:30:09 INFO - operating with platform_type : linux_ 11:30:09 INFO - Initialising browser for dromaeo_css test... 11:30:09 INFO - TEST-INFO | started process 29457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS4ElZg/profile http://localhost:46753/getInfo.html) 11:30:13 INFO - PROCESS | 29457 | 11:30:13 INFO - PROCESS | 29457 | (process:29528): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:30:14 INFO - PROCESS | 29457 | __metrics Screen width/height:1600/1200 11:30:14 INFO - PROCESS | 29457 | colorDepth:24 11:30:14 INFO - PROCESS | 29457 | Browser inner width/height: 1024/697 11:30:14 INFO - PROCESS | 29457 | __metrics 11:30:15 ERROR - PROCESS | 29457 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:30:15 INFO - TEST-INFO | 29457: exit 0 11:30:15 INFO - Browser initialized. 11:30:15 INFO - Running cycle 1/1 for dromaeo_css test... 11:30:15 INFO - TEST-INFO | started process 29579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS4ElZg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:30:17 INFO - PROCESS | 29579 | 11:30:17 INFO - PROCESS | 29579 | (process:29639): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:30:27 INFO - PROCESS | 29579 | RSS: Main: 163737600 11:30:27 INFO - PROCESS | 29579 | 11:31:17 INFO - PROCESS | 29579 | 1464028277426 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] 11:33:24 INFO - PROCESS | 29579 | Cycle 1(1): loaded http://localhost:46753/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46753/tests/dromaeo/cssquery-ext.html) 11:33:26 INFO - PROCESS | 29579 | RSS: Main: 167268352 11:33:26 INFO - PROCESS | 29579 | 11:36:28 INFO - PROCESS | 29579 | Cycle 1(1): loaded http://localhost:46753/tests/dromaeo/cssquery-ext.html (next: http://localhost:46753/tests/dromaeo/cssquery-jquery.html) 11:36:28 INFO - PROCESS | 29579 | RSS: Main: 166903808 11:36:28 INFO - PROCESS | 29579 | 11:39:30 INFO - PROCESS | 29579 | Cycle 1(1): loaded http://localhost:46753/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46753/tests/dromaeo/cssquery-mootools.html) 11:39:31 INFO - PROCESS | 29579 | RSS: Main: 168120320 11:39:31 INFO - PROCESS | 29579 | 11:42:32 INFO - PROCESS | 29579 | Cycle 1(1): loaded http://localhost:46753/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46753/tests/dromaeo/cssquery-prototype.html) 11:42:33 INFO - PROCESS | 29579 | RSS: Main: 165961728 11:42:33 INFO - PROCESS | 29579 | 11:45:35 INFO - PROCESS | 29579 | Cycle 1(1): loaded http://localhost:46753/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46753/tests/dromaeo/cssquery-yui.html) 11:45:36 INFO - PROCESS | 29579 | RSS: Main: 166699008 11:45:36 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | Cycle 1(1): loaded http://localhost:46753/tests/dromaeo/cssquery-yui.html (next: http://localhost:46753/tests/dromaeo/cssquery-dojo.html) 11:48:39 INFO - PROCESS | 29579 | RSS: Main: 169103360 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | __start_tp_report 11:48:39 INFO - PROCESS | 29579 | _x_x_mozilla_page_load 11:48:39 INFO - PROCESS | 29579 | _x_x_mozilla_page_load_details 11:48:39 INFO - PROCESS | 29579 | |i|pagename|runs| 11:48:39 INFO - PROCESS | 29579 | |0;dojo.html;3124.0627811656495;3136.8274744889036;3174.3175217328276;3186.7769256152064;3187.1872672468517;5381.56947444204;5405.324334458192;5419.349678038636;5428.995635807373;5433.673979561219;5373.731313434332;5437.102878025131;5445.782168713256;5450.5367043801225;5507.4767897049815;4957.900841983158;4964.578010869062;4982.950170498285;5030.773615187325;5085.110105731482;4938.80244790208;5045.520675535819;5046.470120637336;5065.493450654923;5084.313617661605;753.3011344372075;5031.874203144932;5035.571976381993;5055.823046193384;5068.341115654978;4929.334539837112;4936.062148191868;4940.40715114185;4945.876353091202;4977.352944117278;4841.782119804618;4899.093667671456;4918.508149185089;4925.7783399747095;4926.556609905126;5314.9468505314835;5341.43914888935;5367.382750983647;5377.4084850666395;5397.757100930428;5783.161441590946;5798.507126894219;5827.125931110325;5864.296284445893;5904.763809447617;5925.051991681354;5945.137954996545;5946.494547963428;5970.552208584373;5977.163197152402;5479;5514.696691681956;5541.556675465993;5542.556595472312;5555.138953462219;6029.6683682397015;6052.909206361908;6055.303640081359;6056.9697151513965;6057.606255593372;5676.063449530864;5720.628159169641;5828.388019258002;5836.124581312837;5839;5795.884082318415;5847.853803654858;5854.970725146347;5864.648121112747;5873.794417195378;5830.096335068071;5846.590738648254;5857.062869940789;5858.941410585925;5860.267466566679;5635.887282254332;5745.2818397700285;5790.305163380422;5851.268591426072;5868.618539794899;4389.956100439019;4432.867013989586;4436.334549817489;4438.068005718771;4469.329600559942;3981.22366138606;3993.1813978134414;4025.637692607621;4043.696722745747;4062.898427539335;5521.2270282160525;5568.276124103922;5588.189712491666;5638.830835074954;5651.9152212716845;5894.823155305347;5923.970380148072;5938.465538101505;5980.611260268156;6026.939730602638;5613.045782217033;5616.719164041781;5632.52123569493;5648.152777083388;5657.660540367591;4955.058538877602;5047.596192304607;5066.873328166826;5098.1842905135;5146.768395422215;6093.939060609426;6094.471245618287;6109.375932520363;6117.066276512034;6127.375193257265;5911.467967882739;5919.289685237713;5922.970385148046;5932.822015339547;5952.255968003999;5906.40935906406;6007.279126504847;6043.12374705674;6083.361247068994;6088;5812.070068788974;5837.066069428871;5841.532677385884;5846.1815345852465;5867.501262392744;5915.881682366415;5947.078202878561;5951.345352011362;5964.135200395832;5966.850828729316;5616.971915140398;5657.377688454185;5703.173039909107;5730.111832665943;5797.362290148165;5672.7730890763905;5693.601447898607;5694.288213973254;5694.345150307602;5701.315842098975;5552.50027497511;5577.637453565505;5627.43725627434;5637.295338082739;5647.322321321468;5664.405237450009;5700.743466544099;5758.337791153904;5784.623999440191;5802.390748971297;5634.070378387521;5691.4877661010705;5692.5445964321925;5699.1451282306325;5719.542436605145 11:48:39 INFO - PROCESS | 29579 | |1;ext.html;575.6344721102099;637.4358692557087;644.6003477843738;655.6951017776735;673.2022553274368;39124.41313380298;43299;43314.35028474571;43337.783311083476;43353.34969975453;43488.347674784905;44050;44163.11673766523;44185.7790711046;44193;8716.302695784338;8864.955675221647;8886.822263554724;8887.20015198632;8890.066543012988;8715.651373945035;8778.604962776659;8825.602847871829;8850.601722922453;8869.556522173898;8773.596224604065;8810;8811.162939520767;8838.55807209637;8869.600867960926;8781.56092195391;8823.64705411786;8899.199072083478;8900.554972251362;8903;8665.913340866573;8725.171108744658;8770.079141690157;8780.517071561062;8793.252573531257;41066.79466602678;41578.168436631095;41685.166296673895;41724.58275417237;41785.373219401736;3424.5548078749853;3912.784796836173;3942.6057394260633;4030.1133750574827;4113;31158.376832463226;32060.198495037577;32097.197570060704;32442;32452.350952980807;4172.895677608084;4227.661787057028;4274.187904298174;4359.106383191438;4411.977940110311;242244;243818;244029;244949.99999999822;245250;53649.73175134177;53659.19511207335;54066.45933540693;54234.72882635562;54333;61775.69112154411;61787.382126179065;62020.68989655113;62182;62262.37737622656;14921.552353429415;15079.849201507845;15089;15099.471518496799;15133.243337833064;12072.396380180955;12075.758484830254;12078.69803254908;12102.455389507493;12124.27254364741;12914.741705166032;17261.223244954006;17312.394066207624;17334.739978900325;17467.56331091733;6694.83262918431;6741.764038258638;6803.795886123424;6870.896936545956;6967.163940327092;983.3559018842669;1064.984025239622;1081.3998230981724;1155.653304008794;1160.4081918221598;31888.521672174935;32449;32635.51046734301;32681.50977735336;33077.3384532308;1072.5441687282873;1139.663799179244;1170.169179882293;1197.6886009637558;1215.3376409856648;16718.24767885448;17456.389026384015;17476.563085922953;17520.737188942177;17531.824681753274;525424;528743;531960;532328;532503;57793;57970.4202957965;58125.640576956896;58151.2554623362;58507.70746146242;1360.0411709744606;1398.7272481866141;1417.2842714429148;1442.314900422291;1468.41263494603;31324.843375782973;33661.15847103842;35238;36607.633923660425;36960.44559331666;56870.43129568651;57679.711601441726;57695;57801.421985779605;57805.710971446555;471514;475763;477059.99110057735;477073;477564;43771;45539.772301138284;45983.54016459793;46079;46343.30485042794;49092.58166765008;50098.49901500938;50490.49509504858;50528.24207636962;50592.74703626458;40803.1839363217;42201.78899105485;42555;42837.57162428336;42991.785041074596;40556.59443405528;41255.58744412637;41602.375964359955;41709.58290417057;41900.371494426996;40839.59160408358;41893.37159942542;42117;42161.789191055075;42570.36144457898;35707.28585428329;37401;37478.81260593679;37671.24657506889;37726;29020;29064.418711626073;29106.854465727534;29295.707042929298;29372.706272936997 11:48:39 INFO - PROCESS | 29579 | |2;jquery.html;369.83727160049574;379.46495441427584;380.14277803552983;391.4695587478966;395.6083477357417;17592.296308147674;18626.627467450642;19036.428907132773;19266.90366548169;19351.516212094688;18080.54798630035;18479.815201847978;18758.81241187591;18807.059647017664;18814.52963675909;5300.522952934235;5425.104857698485;5587.636803607773;5609.102543593026;5625.634333768312;5424.430434804348;5504.91742623861;5547.72261386931;5549.278593782823;5555.666660000393;5268.104422248208;5427.6472029318165;5434.701091439969;5437.075697131497;5467.808626698066;5436.700981446039;5436.782528698847;5457.345118585756;5465.262189604392;5483.287172667548;4733.5976442002475;4827.179379505493;4839.927401088987;4854.101991131652;4882.804687812483;21553.24563640265;21799.237026703988;22197.334079977627;22633.77366226333;22796.316110516713;2380.321608341614;2417.589009868309;2450.889709963056;2495.3007986156053;2809.339805145789;13962.720745585133;14188.858111418856;14270.286485675675;14377.496787612488;14399;1910.8949007804565;1913.425972208346;1938.3986838769952;2015.6371853066441;2031.9695204571942;73610.26389736141;76269;76380.61809690972;77030.99999999943;77285;9592.232621390272;9711.514424278757;10055.190670029748;10230.335028223142;10234.846477302697;13490.258035807929;13552.59342219735;13677.31613419325;13745.931270343584;13805.86194138066;7732.381409487228;7840.09838868526;7873.473441500422;7922.326602238874;7946.801329966682;7377.8155546111775;7442.106947166375;7590.658420371096;7753.224677532315;7778.105517865518;6324.229215819578;6339.587926784744;6429.839254018593;6500.674966251669;6587.242467116343;1743.4072415378832;1780.1366337326644;1838.5403649087727;1844.6679597672548;1846.621442604263;975.7219192530094;1044.3003187863997;1078.568572570978;1096.1833434091652;1104.127739086113;18225;18887.92232854385;19344.806551934584;19376.903115484612;19553.315633952745;991.9603215871429;1049.5382031905938;1058.920580956416;1078.82199437092;1117.1230583991528;10761.139108871272;11092.168087393478;11123.777524449628;11180.608678696206;11224.270422422516;448652;459961;470413;470567;471209.79555920063;65432.67283663551;73216.63391683008;75325.24674753292;76319;78804;1009.7576581620505;1016.4765145949842;1022.6114076650825;1030.8299130643509;1030.845373194042;16747.91626041862;17015.149242537576;17241.22414491326;17338.566535836704;17388.73916891273;36715.26569468649;36971.63028369682;37036.62963370332;37249.81375093215;37357.62642373541;46694.76652616851;47118.29322560096;49417;50010.249846253064;50590.747046264536;7940.920590794018;8007.959960200162;8020.759377218693;8374.916250837414;8382.203690649378;12244;12278.508859645513;12339;12526.937365313115;12697.174683645533;10449.738756531147;11002.669919902415;11221.887781122085;11246.493907774333;11272.323660580392;11320.886791131983;11388.202825802446;11475.655730328104;11543.307401555934;11545.884541154817;11325.490352934303;11565.942170289094;11698.47356868926;11722.94138529302;11841.703957401134;7867.921320786719;7894.486858354188;8134.06458257308;8162.142974987541;8194.05768336625;11042.227044106836;11051.778964420828;11306.265092768943;11432.599859004895;11482.081433485135 11:48:39 INFO - PROCESS | 29579 | |3;mootools.html;1513.508109864294;1515.454436402895;1726.2404542001518;1777.3779177287943;1858.4424672598225;8212.260896519312;8762.342824288187;8880.911190888097;9320.254379649628;9422.15200631943;8851.468911865293;9068.954655226731;9070.637174513027;9155.359124861263;9167.633294668205;2403.5072810073893;2434.9756502434925;2436.8537887726793;2440.7681270279295;2446;2384.856908585482;2402.699662542182;2462.5813611685967;2470.407102295454;2474.8886300116446;2396.077510158584;2398.6162214045758;2399.1003373734848;2427.514497100578;2427.9150229741963;2312.2485192312565;2321.9883900580476;2352.776486233805;2375.1449478187837;2404.4589967257402;2329.2429960262984;2336.19401306549;2344.3904584808074;2365.27859003004;2394.5570069537193;8968.05835387288;9031.187193152648;9036.774080648036;9083.7274881753;9113.225375843062;5483.314585676791;5621.550275977912;5640.041192997201;5648.378678345379;5652.858678533028;3299.059767966118;3300.7524435667183;3368.6631336866362;3498.8950331490096;3523.1720545671747;1049.6326285799985;1053.2364036073861;1053.394298278493;1054.2830875004993;1070.8661417322835;12714.682132946658;12815.551455699006;12820.679483012906;12885.291308978003;12931.741365172738;4718.575328220477;4724.598409135262;4798.832040878552;4846.224604063333;4849.199882019428;9994.950025249827;10045.899541004643;10099.44453055089;10103.949480252551;10112.393256404639;5432.02223599748;5462.7268636568015;5486.670799752028;5507.091329930597;5541.473560011793;4623.16782979067;4865.7323847188745;4982.177940639826;5006.724630145304;5116.386033675983;3908.1402091539817;3972.781497017634;4046.838126474967;4056.0671045659074;4164.562720914321;1194.0865238092865;1212.5210541835925;1212.6180253220207;1213.8846809553079;1233.2662066070673;914.4284821986258;977.1498796047484;988.945607991553;1008.2690049713899;1017.3641474078701;5969.492593129546;6060.878782424327;6140;6244.969580019337;6359.650219237894;431.7754767520872;435.80388825028865;441.7150937645201;464.89307459284555;465.8881868351571;3983.103801644607;3983.521977362735;4052.9594704052583;4064.166845796664;4071.206114807584;11360.147988900866;11555.88444115565;11681.357525336018;11688;11746.70633234176;11629;11633.243839150427;11642.01042911345;11725.237859539102;11738;8146.103928567853;8495.575221238912;8502.299540092006;8729.127087291346;8739.825203496022;6090.269167699905;6329.240491141092;6378.298387177314;6392.552521323462;6403.103565500926;10157.492125393554;10644.574217031231;10693.09108725767;10720.35677859331;10931.398773067558;10671.199660025373;10754.085902698358;10791.946040270062;10838.458077095956;10908.072813810915;7528.171901090766;8010.158933312151;8245.381596380415;8269.338452923632;8436.282915952213;9013.233875120688;9065.184133428023;9103.18071373553;9113.498757568397;9179;7944.6822127114265;8008.319292860172;8116.918830811616;8210.671573137008;8265;7883.054033516015;7972.641231144728;7994.440389172702;8053.959730201312;8220.095789463274;6693.196816382066;7202.96398518025;7294.452916031425;7341.669624866787;7351.558906465629;5223.555997740083;5263.631545791758;5307.310049693515;5370.597205209703;5529.502344788988;5396.676199428047;5531.668099914018;5532.557395408438;5544.306961629796;5563.638363506359 11:48:39 INFO - PROCESS | 29579 | |4;prototype.html;312.5483676088052;323.32425231266654;325.43699400037934;327.8131465064914;328.33512137920724;5534.640248383857;5589.804356847511;5609;5629.296337957755;5733.713314334283;5504.2018907258425;5509.669419834812;5526.309211348582;5536.252605898202;5597.160425936112;4253.680973926952;4336.739795612258;4380.233459144645;4380.474343078835;4399.406080179167;4282.379055037018;4302;4323.740575565461;4345.174416860787;4348.30427131659;4279.486461624594;4282.807273672693;4289.721168124078;4289.957100428987;4317.352397140438;4013.2776100301935;4115.506139263278;4243.978780106079;4261.126469073833;4321.611055005049;3753.5871054184017;3763.9811800941093;3767.8492860285555;3786.7159963002887;3796.6772824309965;5341.919871201935;5347.919781203285;5361.651492652965;5374.570034397278;5375.973120134413;4797.52024797521;4891.217405215184;4898.681585696918;4953.157963146274;4964.776585053682;5783.652980821164;5792.189093526909;5797.217375654275;5828.737706803204;5837.824865254049;4157.272477316487;4164.479440069991;4183.435236243099;4187.120704652027;4201.663866890642;5698.886022279573;6003.219581454427;6014.1580178775;6018.247719035165;6077.179580756586;4089.9591004090175;4101.835926562904;4114.526829414595;4134.193832202752;4141.068259641616;4149.91700165995;4175.958240417618;4194.224068547329;4211.241976444269;4212.557681443404;4772.665913386099;4802.615790736732;4853.247746599282;4872.269159626014;4900.950990490121;5842.269716285465;5852.209951656557;5882.294124705063;5893.675847828411;5942.8811423771285;1444.4799872046055;1451.7096580683906;1457.0529156048653;1457.774045023023;1466.7286551987916;906.4787747045475;909.4497828813472;912.2154946745793;917.4266083697689;929.7907970706536;4947.529984651453;5029.748512574357;5065.670731402447;5142.97428512855;5174.197999310113;5320.654157479751;5344;5423.752536916452;5457.536109430664;5459.808906688247;4901.852944411673;5091.9236211456855;5131.692098474104;5603.551715862721;5641;3187.7609179311644;3219.388316219911;3228.4350238708134;3235.266200060945;3249.6676362691182;5945.64326140433;6145.5698101133385;6165.290991536031;6169.951108311508;6187;6078.787242446581;6079.179310792986;6089.908651370233;6132.877342453126;6160.630362178194;6135.926212912812;6221.751129954751;6232.345603711636;6243.8126856194385;6321.683915804191;5815.360310365941;6094.664793436404;6101.2068431105445;6103.786367477294;6116.4495195430845;5920.822375328747;5939.584229103922;5986.730597123227;6026.969865150646;6029.341930968843;6149.385061493815;6161.322254551906;6210.813675589739;6218.81343559694;6263.78076767311;4160.979195104005;4164.583541645932;4213.073123912734;4221.451211342629;4233.978830105953;6066.393360664075;6095.146679464967;6128.50971922254;6162.476189523762;6186.257649082139;5688.345840228427;5850.882982340415;5899.734511947058;5932.110183472513;5941.732622031933;5864.67744274052;5874.765009399747;5883.705814709162;5888.617239879394;5972.940270597239;5557.3331200256225;5756.395578464201;5809.750903555756;5848.736806843787;5850.180974663635;5939.821805345847;5943.346231914399;5955.851103722442;5976.940230597638;5980.37206093354;5791.449812267828;5804;5854.590178687451;5863.618864773776;5892.410758924245 11:48:39 INFO - PROCESS | 29579 | |5;yui.html;817.8895849060377;823.6129019360899;823.8928939237899;828.2214718164925;874.5146443723735;12679.112462127654;14285;14476.13143211408;14528.3462244199;14559.78160327596;13616;14150.080244784107;14664.046836955591;14691.706165876676;15090.320935557898;809.9592024248841;810.5582457560614;818.9918100818975;819.0662644585178;819.4427789103407;804.4610111225493;811.4117264982899;834.7287131682198;835.5905606252953;839.7900524868783;869.9304055675531;875.2910142784365;882.5851849630695;883.377219060564;883.779055236191;876.3383645347785;877.4954401219325;878.4070752242211;880.2825697056878;880.7357792662176;637.4486069549853;638.533870274702;641.8010416770816;642.238946847982;642.3159335307882;13102.672433189151;13192.20846749198;13241.867581324159;13260.602181934557;13274.203547787067;12966.351682415841;13142.671433214246;13150.923213803655;13180.472781088745;13238.205707657475;10255.538500767483;10530.42082685452;10545.261831671785;10663.893361066368;11268.549258029669;3712.6101759315425;3801.144742432958;3858.3247931612136;3876.457295978537;3882.495275614152;59823.40176598222;60957.39042609561;61208.387916120715;61268;61506.07740883935;9002.909970900339;9103.135202155918;9144.497052662167;9426.528673566294;9457.76355591102;19215.615687686168;19516.31692890742;19516.804831951784;19713.605727885362;19750;7467.178610352857;7538.473790041597;7595.126560445509;7658.425618078666;7827.178146294671;4424.093060922503;4453.22068637987;4537.478190008125;4539.614132798683;4633.62930965522;3441.8795342162903;3511.648835116519;3542.1498840278664;3543.0965103898343;3557.6975957043423;636.2174525333866;638.7030031035498;645.1161908185816;645.5997281685385;668.5754545863412;579.8173575323759;616.4267231474682;636.6021236727046;712.4394104018188;758.7041053988949;8474.406791524534;9116.726498205064;9189.770255743526;9258;9290.907090929139;676.6075676107846;685.8422562810482;726.9121110697905;754.9282818132268;766.9539827610362;4395.890102747393;4472.821087156477;4475;4478.798454069574;4490.550944905483;68199.65900170467;68536.6573167131;69547;69691.65154174298;71098.2890171102;56869.43130568724;60797.39202608006;60992;61665.38334616686;63387.68306158532;55461.72269138628;56445.43554564484;57144.57138571569;57355.13967290411;58388;9452.574634141343;9635.13283804461;9834.655787047419;9991.150752185855;9999.150072243941;36524.63475365318;37392.81303593465;37464.812675936446;37522.8123859379;37580.436293456165;44472.33291500565;47520.287195692785;49610.75194624148;49740.253896190865;49877.50122498874;11951.940240298743;12365.381730913597;12422.875771242534;12482.126251162332;12483.93758031204;12984.740305194033;13374.13068150606;13431.597052088453;13680.518885313162;13928.651783705489;13134.60596182116;13228.272445015617;13304.401301941241;13368;13485.797713034117;13002.284874332003;13084.345782710636;13196.670083247996;13367.264800436069;13823.377947992163;11409.771804563696;12416.689582760504;12594;12871.742565148457;13299.734005320033;10067.848982265125;10096.545655445376;10253.692389228336;10269.178465722574;10670.893291067301;10680.39713138504;10792.460376981277;11019.228653994143;11029.889701102886;11183.273087249303 11:48:39 INFO - PROCESS | 29579 | __end_tp_report 11:48:39 INFO - PROCESS | 29579 | __start_cc_report 11:48:39 INFO - PROCESS | 29579 | _x_x_mozilla_cycle_collect,358 11:48:39 INFO - PROCESS | 29579 | __end_cc_report 11:48:39 INFO - PROCESS | 29579 | __startTimestamp1464029319467__endTimestamp 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | ------- Summary: start ------- 11:48:39 INFO - PROCESS | 29579 | Number of tests: 6 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | [#0] dojo.html Cycles:165 Average:5425.98 Median:5657.66 stddev:725.40 (12.8%) stddev-sans-first:704.79 11:48:39 INFO - PROCESS | 29579 | Values: 3124.1 3136.8 3174.3 3186.8 3187.2 5381.6 5405.3 5419.3 5429.0 5433.7 5373.7 5437.1 5445.8 5450.5 5507.5 4957.9 4964.6 4983.0 5030.8 5085.1 4938.8 5045.5 5046.5 5065.5 5084.3 753.3 5031.9 5035.6 5055.8 5068.3 4929.3 4936.1 4940.4 4945.9 4977.4 4841.8 4899.1 4918.5 4925.8 4926.6 5314.9 5341.4 5367.4 5377.4 5397.8 5783.2 5798.5 5827.1 5864.3 5904.8 5925.1 5945.1 5946.5 5970.6 5977.2 5479.0 5514.7 5541.6 5542.6 5555.1 6029.7 6052.9 6055.3 6057.0 6057.6 5676.1 5720.6 5828.4 5836.1 5839.0 5795.9 5847.9 5855.0 5864.6 5873.8 5830.1 5846.6 5857.1 5858.9 5860.3 5635.9 5745.3 5790.3 5851.3 5868.6 4390.0 4432.9 4436.3 4438.1 4469.3 3981.2 3993.2 4025.6 4043.7 4062.9 5521.2 5568.3 5588.2 5638.8 5651.9 5894.8 5924.0 5938.5 5980.6 6026.9 5613.0 5616.7 5632.5 5648.2 5657.7 4955.1 5047.6 5066.9 5098.2 5146.8 6093.9 6094.5 6109.4 6117.1 6127.4 5911.5 5919.3 5923.0 5932.8 5952.3 5906.4 6007.3 6043.1 6083.4 6088.0 5812.1 5837.1 5841.5 5846.2 5867.5 5915.9 5947.1 5951.3 5964.1 5966.9 5617.0 5657.4 5703.2 5730.1 5797.4 5672.8 5693.6 5694.3 5694.3 5701.3 5552.5 5577.6 5627.4 5637.3 5647.3 5664.4 5700.7 5758.3 5784.6 5802.4 5634.1 5691.5 5692.5 5699.1 5719.5 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | [#1] ext.html Cycles:180 Average:58920.56 Median:23555.88 stddev:115528.21 (490.4%) stddev-sans-first:115769.24 11:48:39 INFO - PROCESS | 29579 | Values: 575.6 637.4 644.6 655.7 673.2 39124.4 43299.0 43314.4 43337.8 43353.3 43488.3 44050.0 44163.1 44185.8 44193.0 8716.3 8865.0 8886.8 8887.2 8890.1 8715.7 8778.6 8825.6 8850.6 8869.6 8773.6 8810.0 8811.2 8838.6 8869.6 8781.6 8823.6 8899.2 8900.6 8903.0 8665.9 8725.2 8770.1 8780.5 8793.3 41066.8 41578.2 41685.2 41724.6 41785.4 3424.6 3912.8 3942.6 4030.1 4113.0 31158.4 32060.2 32097.2 32442.0 32452.4 4172.9 4227.7 4274.2 4359.1 4412.0 242244.0 243818.0 244029.0 244950.0 245250.0 53649.7 53659.2 54066.5 54234.7 54333.0 61775.7 61787.4 62020.7 62182.0 62262.4 14921.6 15079.8 15089.0 15099.5 15133.2 12072.4 12075.8 12078.7 12102.5 12124.3 12914.7 17261.2 17312.4 17334.7 17467.6 6694.8 6741.8 6803.8 6870.9 6967.2 983.4 1065.0 1081.4 1155.7 1160.4 31888.5 32449.0 32635.5 32681.5 33077.3 1072.5 1139.7 1170.2 1197.7 1215.3 16718.2 17456.4 17476.6 17520.7 17531.8 525424.0 528743.0 531960.0 532328.0 532503.0 57793.0 57970.4 58125.6 58151.3 58507.7 1360.0 1398.7 1417.3 1442.3 1468.4 31324.8 33661.2 35238.0 36607.6 36960.4 56870.4 57679.7 57695.0 57801.4 57805.7 471514.0 475763.0 477060.0 477073.0 477564.0 43771.0 45539.8 45983.5 46079.0 46343.3 49092.6 50098.5 50490.5 50528.2 50592.7 40803.2 42201.8 42555.0 42837.6 42991.8 40556.6 41255.6 41602.4 41709.6 41900.4 40839.6 41893.4 42117.0 42161.8 42570.4 35707.3 37401.0 37478.8 37671.2 37726.0 29020.0 29064.4 29106.9 29295.7 29372.7 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | [#2] jquery.html Cycles:180 Average:27140.50 Median:12588.32 stddev:76151.74 (604.9%) stddev-sans-first:76338.84 11:48:39 INFO - PROCESS | 29579 | Values: 369.8 379.5 380.1 391.5 395.6 17592.3 18626.6 19036.4 19266.9 19351.5 18080.5 18479.8 18758.8 18807.1 18814.5 5300.5 5425.1 5587.6 5609.1 5625.6 5424.4 5504.9 5547.7 5549.3 5555.7 5268.1 5427.6 5434.7 5437.1 5467.8 5436.7 5436.8 5457.3 5465.3 5483.3 4733.6 4827.2 4839.9 4854.1 4882.8 21553.2 21799.2 22197.3 22633.8 22796.3 2380.3 2417.6 2450.9 2495.3 2809.3 13962.7 14188.9 14270.3 14377.5 14399.0 1910.9 1913.4 1938.4 2015.6 2032.0 73610.3 76269.0 76380.6 77031.0 77285.0 9592.2 9711.5 10055.2 10230.3 10234.8 13490.3 13552.6 13677.3 13745.9 13805.9 7732.4 7840.1 7873.5 7922.3 7946.8 7377.8 7442.1 7590.7 7753.2 7778.1 6324.2 6339.6 6429.8 6500.7 6587.2 1743.4 1780.1 1838.5 1844.7 1846.6 975.7 1044.3 1078.6 1096.2 1104.1 18225.0 18887.9 19344.8 19376.9 19553.3 992.0 1049.5 1058.9 1078.8 1117.1 10761.1 11092.2 11123.8 11180.6 11224.3 448652.0 459961.0 470413.0 470567.0 471209.8 65432.7 73216.6 75325.2 76319.0 78804.0 1009.8 1016.5 1022.6 1030.8 1030.8 16747.9 17015.1 17241.2 17338.6 17388.7 36715.3 36971.6 37036.6 37249.8 37357.6 46694.8 47118.3 49417.0 50010.2 50590.7 7940.9 8008.0 8020.8 8374.9 8382.2 12244.0 12278.5 12339.0 12526.9 12697.2 10449.7 11002.7 11221.9 11246.5 11272.3 11320.9 11388.2 11475.7 11543.3 11545.9 11325.5 11565.9 11698.5 11722.9 11841.7 7867.9 7894.5 8134.1 8162.1 8194.1 11042.2 11051.8 11306.3 11432.6 11482.1 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | [#3] mootools.html Cycles:180 Average:6017.06 Median:465.39 stddev:3484.73 (748.8%) stddev-sans-first:3478.07 11:48:39 INFO - PROCESS | 29579 | Values: 1513.5 1515.5 1726.2 1777.4 1858.4 8212.3 8762.3 8880.9 9320.3 9422.2 8851.5 9069.0 9070.6 9155.4 9167.6 2403.5 2435.0 2436.9 2440.8 2446.0 2384.9 2402.7 2462.6 2470.4 2474.9 2396.1 2398.6 2399.1 2427.5 2427.9 2312.2 2322.0 2352.8 2375.1 2404.5 2329.2 2336.2 2344.4 2365.3 2394.6 8968.1 9031.2 9036.8 9083.7 9113.2 5483.3 5621.6 5640.0 5648.4 5652.9 3299.1 3300.8 3368.7 3498.9 3523.2 1049.6 1053.2 1053.4 1054.3 1070.9 12714.7 12815.6 12820.7 12885.3 12931.7 4718.6 4724.6 4798.8 4846.2 4849.2 9995.0 10045.9 10099.4 10103.9 10112.4 5432.0 5462.7 5486.7 5507.1 5541.5 4623.2 4865.7 4982.2 5006.7 5116.4 3908.1 3972.8 4046.8 4056.1 4164.6 1194.1 1212.5 1212.6 1213.9 1233.3 914.4 977.1 988.9 1008.3 1017.4 5969.5 6060.9 6140.0 6245.0 6359.7 431.8 435.8 441.7 464.9 465.9 3983.1 3983.5 4053.0 4064.2 4071.2 11360.1 11555.9 11681.4 11688.0 11746.7 11629.0 11633.2 11642.0 11725.2 11738.0 8146.1 8495.6 8502.3 8729.1 8739.8 6090.3 6329.2 6378.3 6392.6 6403.1 10157.5 10644.6 10693.1 10720.4 10931.4 10671.2 10754.1 10791.9 10838.5 10908.1 7528.2 8010.2 8245.4 8269.3 8436.3 9013.2 9065.2 9103.2 9113.5 9179.0 7944.7 8008.3 8116.9 8210.7 8265.0 7883.1 7972.6 7994.4 8054.0 8220.1 6693.2 7203.0 7294.5 7341.7 7351.6 5223.6 5263.6 5307.3 5370.6 5529.5 5396.7 5531.7 5532.6 5544.3 5563.6 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | [#4] prototype.html Cycles:180 Average:4870.17 Median:5530.47 stddev:1458.33 (26.4%) stddev-sans-first:1421.73 11:48:39 INFO - PROCESS | 29579 | Values: 312.5 323.3 325.4 327.8 328.3 5534.6 5589.8 5609.0 5629.3 5733.7 5504.2 5509.7 5526.3 5536.3 5597.2 4253.7 4336.7 4380.2 4380.5 4399.4 4282.4 4302.0 4323.7 4345.2 4348.3 4279.5 4282.8 4289.7 4290.0 4317.4 4013.3 4115.5 4244.0 4261.1 4321.6 3753.6 3764.0 3767.8 3786.7 3796.7 5341.9 5347.9 5361.7 5374.6 5376.0 4797.5 4891.2 4898.7 4953.2 4964.8 5783.7 5792.2 5797.2 5828.7 5837.8 4157.3 4164.5 4183.4 4187.1 4201.7 5698.9 6003.2 6014.2 6018.2 6077.2 4090.0 4101.8 4114.5 4134.2 4141.1 4149.9 4176.0 4194.2 4211.2 4212.6 4772.7 4802.6 4853.2 4872.3 4901.0 5842.3 5852.2 5882.3 5893.7 5942.9 1444.5 1451.7 1457.1 1457.8 1466.7 906.5 909.4 912.2 917.4 929.8 4947.5 5029.7 5065.7 5143.0 5174.2 5320.7 5344.0 5423.8 5457.5 5459.8 4901.9 5091.9 5131.7 5603.6 5641.0 3187.8 3219.4 3228.4 3235.3 3249.7 5945.6 6145.6 6165.3 6170.0 6187.0 6078.8 6079.2 6089.9 6132.9 6160.6 6135.9 6221.8 6232.3 6243.8 6321.7 5815.4 6094.7 6101.2 6103.8 6116.4 5920.8 5939.6 5986.7 6027.0 6029.3 6149.4 6161.3 6210.8 6218.8 6263.8 4161.0 4164.6 4213.1 4221.5 4234.0 6066.4 6095.1 6128.5 6162.5 6186.3 5688.3 5850.9 5899.7 5932.1 5941.7 5864.7 5874.8 5883.7 5888.6 5972.9 5557.3 5756.4 5809.8 5848.7 5850.2 5939.8 5943.3 5955.9 5976.9 5980.4 5791.4 5804.0 5854.6 5863.6 5892.4 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | [#5] yui.html Cycles:180 Average:15660.43 Median:26076.96 stddev:19117.39 (73.3%) stddev-sans-first:19138.53 11:48:39 INFO - PROCESS | 29579 | Values: 817.9 823.6 823.9 828.2 874.5 12679.1 14285.0 14476.1 14528.3 14559.8 13616.0 14150.1 14664.0 14691.7 15090.3 810.0 810.6 819.0 819.1 819.4 804.5 811.4 834.7 835.6 839.8 869.9 875.3 882.6 883.4 883.8 876.3 877.5 878.4 880.3 880.7 637.4 638.5 641.8 642.2 642.3 13102.7 13192.2 13241.9 13260.6 13274.2 12966.4 13142.7 13150.9 13180.5 13238.2 10255.5 10530.4 10545.3 10663.9 11268.5 3712.6 3801.1 3858.3 3876.5 3882.5 59823.4 60957.4 61208.4 61268.0 61506.1 9002.9 9103.1 9144.5 9426.5 9457.8 19215.6 19516.3 19516.8 19713.6 19750.0 7467.2 7538.5 7595.1 7658.4 7827.2 4424.1 4453.2 4537.5 4539.6 4633.6 3441.9 3511.6 3542.1 3543.1 3557.7 636.2 638.7 645.1 645.6 668.6 579.8 616.4 636.6 712.4 758.7 8474.4 9116.7 9189.8 9258.0 9290.9 676.6 685.8 726.9 754.9 767.0 4395.9 4472.8 4475.0 4478.8 4490.6 68199.7 68536.7 69547.0 69691.7 71098.3 56869.4 60797.4 60992.0 61665.4 63387.7 55461.7 56445.4 57144.6 57355.1 58388.0 9452.6 9635.1 9834.7 9991.2 9999.2 36524.6 37392.8 37464.8 37522.8 37580.4 44472.3 47520.3 49610.8 49740.3 49877.5 11951.9 12365.4 12422.9 12482.1 12483.9 12984.7 13374.1 13431.6 13680.5 13928.7 13134.6 13228.3 13304.4 13368.0 13485.8 13002.3 13084.3 13196.7 13367.3 13823.4 11409.8 12416.7 12594.0 12871.7 13299.7 10067.8 10096.5 10253.7 10269.2 10670.9 10680.4 10792.5 11019.2 11029.9 11183.3 11:48:39 INFO - PROCESS | 29579 | -------- Summary: end -------- 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | 11:48:39 INFO - PROCESS | 29579 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 11:48:39 INFO - PROCESS | 29579 | 11:48:40 INFO - TEST-INFO | 29579: exit 0 11:48:40 INFO - TEST-OK | dromaeo_css | took 1110376ms 11:48:40 INFO - TEST-START | kraken 11:48:40 INFO - operating with platform_type : linux_ 11:48:40 INFO - Initialising browser for kraken test... 11:48:40 INFO - TEST-INFO | started process 29807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd5kLTj/profile http://localhost:46753/getInfo.html) 11:48:43 INFO - PROCESS | 29807 | 11:48:43 INFO - PROCESS | 29807 | (process:29874): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:48:44 INFO - PROCESS | 29807 | __metrics Screen width/height:1600/1200 11:48:44 INFO - PROCESS | 29807 | colorDepth:24 11:48:44 INFO - PROCESS | 29807 | Browser inner width/height: 1024/697 11:48:44 INFO - PROCESS | 29807 | __metrics 11:48:45 ERROR - PROCESS | 29807 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:48:46 INFO - TEST-INFO | 29807: exit 0 11:48:46 INFO - Browser initialized. 11:48:46 INFO - Running cycle 1/1 for kraken test... 11:48:46 INFO - TEST-INFO | started process 29925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd5kLTj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:48:48 INFO - PROCESS | 29925 | 11:48:48 INFO - PROCESS | 29925 | (process:29988): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:48:58 INFO - PROCESS | 29925 | RSS: Main: 164352000 11:48:58 INFO - PROCESS | 29925 | 11:49:00 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46753/tests/kraken/driver.html?testName=audio-beat-detection) 11:49:01 INFO - PROCESS | 29925 | RSS: Main: 168693760 11:49:01 INFO - PROCESS | 29925 | 11:49:04 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46753/tests/kraken/driver.html?testName=audio-dft) 11:49:04 INFO - PROCESS | 29925 | RSS: Main: 168566784 11:49:04 INFO - PROCESS | 29925 | 11:49:07 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46753/tests/kraken/driver.html?testName=audio-fft) 11:49:08 INFO - PROCESS | 29925 | RSS: Main: 163524608 11:49:08 INFO - PROCESS | 29925 | 11:49:10 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46753/tests/kraken/driver.html?testName=audio-oscillator) 11:49:11 INFO - PROCESS | 29925 | RSS: Main: 163856384 11:49:11 INFO - PROCESS | 29925 | 11:49:13 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46753/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:49:14 INFO - PROCESS | 29925 | RSS: Main: 164757504 11:49:14 INFO - PROCESS | 29925 | 11:49:17 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46753/tests/kraken/driver.html?testName=imaging-darkroom) 11:49:17 INFO - PROCESS | 29925 | RSS: Main: 164495360 11:49:17 INFO - PROCESS | 29925 | 11:49:21 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46753/tests/kraken/driver.html?testName=imaging-desaturate) 11:49:22 INFO - PROCESS | 29925 | RSS: Main: 163094528 11:49:22 INFO - PROCESS | 29925 | 11:49:24 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46753/tests/kraken/driver.html?testName=json-parse-financial) 11:49:25 INFO - PROCESS | 29925 | RSS: Main: 163667968 11:49:25 INFO - PROCESS | 29925 | 11:49:27 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46753/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:49:27 INFO - PROCESS | 29925 | RSS: Main: 163885056 11:49:27 INFO - PROCESS | 29925 | 11:49:29 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46753/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:49:30 INFO - PROCESS | 29925 | RSS: Main: 164040704 11:49:30 INFO - PROCESS | 29925 | 11:49:32 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46753/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:49:33 INFO - PROCESS | 29925 | RSS: Main: 164679680 11:49:33 INFO - PROCESS | 29925 | 11:49:35 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:49:36 INFO - PROCESS | 29925 | RSS: Main: 164581376 11:49:36 INFO - PROCESS | 29925 | 11:49:39 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:49:39 INFO - PROCESS | 29925 | RSS: Main: 164790272 11:49:39 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | Cycle 1(1): loaded http://localhost:46753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46753/tests/kraken/driver.html?testName=ai-astar) 11:49:41 INFO - PROCESS | 29925 | RSS: Main: 166035456 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | __start_tp_report 11:49:41 INFO - PROCESS | 29925 | _x_x_mozilla_page_load 11:49:41 INFO - PROCESS | 29925 | _x_x_mozilla_page_load_details 11:49:41 INFO - PROCESS | 29925 | |i|pagename|runs| 11:49:41 INFO - PROCESS | 29925 | |0;ai-astar;110;107;111;108;109;110;109;108;109;109 11:49:41 INFO - PROCESS | 29925 | |1;audio-beat-detection;155;127;153;210;129;152;151;128;186;132 11:49:41 INFO - PROCESS | 29925 | |2;audio-dft;162;163;161;163;167;167;168;164;162;162 11:49:41 INFO - PROCESS | 29925 | |3;audio-fft;76;74;75;163;76;76;75;76;169;75 11:49:41 INFO - PROCESS | 29925 | |4;audio-oscillator;92;92;180;93;94;98;146;93;92;146 11:49:41 INFO - PROCESS | 29925 | |5;imaging-gaussian-blur;116;117;118;117;118;117;117;118;117;117 11:49:41 INFO - PROCESS | 29925 | |6;imaging-darkroom;146;147;148;146;147;148;146;147;147;147 11:49:41 INFO - PROCESS | 29925 | |7;imaging-desaturate;96;96;96;97;96;95;95;95;95;95 11:49:41 INFO - PROCESS | 29925 | |8;json-parse-financial;56;58;57;63;55;56;56;108;58;55 11:49:41 INFO - PROCESS | 29925 | |9;json-stringify-tinderbox;61;68;62;63;62;62;62;61;62;63 11:49:41 INFO - PROCESS | 29925 | |10;stanford-crypto-aes;79;79;79;79;80;86;79;79;80;80 11:49:41 INFO - PROCESS | 29925 | |11;stanford-crypto-ccm;128;120;128;119;122;131;124;117;191;131 11:49:41 INFO - PROCESS | 29925 | |12;stanford-crypto-pbkdf2;161;165;161;158;157;155;159;160;159;164 11:49:41 INFO - PROCESS | 29925 | |13;stanford-crypto-sha256-iterative;63;64;62;62;62;63;60;63;66;62 11:49:41 INFO - PROCESS | 29925 | __end_tp_report 11:49:41 INFO - PROCESS | 29925 | __start_cc_report 11:49:41 INFO - PROCESS | 29925 | _x_x_mozilla_cycle_collect,899 11:49:41 INFO - PROCESS | 29925 | __end_cc_report 11:49:41 INFO - PROCESS | 29925 | __startTimestamp1464029381796__endTimestamp 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | ------- Summary: start ------- 11:49:41 INFO - PROCESS | 29925 | Number of tests: 14 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.00 stddev:1.15 (1.1%) stddev-sans-first:1.17 11:49:41 INFO - PROCESS | 29925 | Values: 110.0 107.0 111.0 108.0 109.0 110.0 109.0 108.0 109.0 109.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:152.50 stddev:27.20 (17.8%) stddev-sans-first:28.84 11:49:41 INFO - PROCESS | 29925 | Values: 155.0 127.0 153.0 210.0 129.0 152.0 151.0 128.0 186.0 132.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.51 (1.5%) stddev-sans-first:2.57 11:49:41 INFO - PROCESS | 29925 | Values: 162.0 163.0 161.0 163.0 167.0 167.0 168.0 164.0 162.0 162.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.50 stddev:38.24 (50.7%) stddev-sans-first:40.03 11:49:41 INFO - PROCESS | 29925 | Values: 76.0 74.0 75.0 163.0 76.0 76.0 75.0 76.0 169.0 75.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#4] audio-oscillator Cycles:10 Average:112.60 Median:92.50 stddev:32.27 (34.9%) stddev-sans-first:33.36 11:49:41 INFO - PROCESS | 29925 | Values: 92.0 92.0 180.0 93.0 94.0 98.0 146.0 93.0 92.0 146.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 11:49:41 INFO - PROCESS | 29925 | Values: 116.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 11:49:41 INFO - PROCESS | 29925 | Values: 146.0 147.0 148.0 146.0 147.0 148.0 146.0 147.0 147.0 147.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 11:49:41 INFO - PROCESS | 29925 | Values: 96.0 96.0 96.0 97.0 96.0 95.0 95.0 95.0 95.0 95.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:56.50 stddev:16.26 (28.8%) stddev-sans-first:17.09 11:49:41 INFO - PROCESS | 29925 | Values: 56.0 58.0 57.0 63.0 55.0 56.0 56.0 108.0 58.0 55.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.00 stddev:2.01 (3.2%) stddev-sans-first:2.05 11:49:41 INFO - PROCESS | 29925 | Values: 61.0 68.0 62.0 63.0 62.0 62.0 62.0 61.0 62.0 63.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.50 stddev:2.16 (2.7%) stddev-sans-first:2.26 11:49:41 INFO - PROCESS | 29925 | Values: 79.0 79.0 79.0 79.0 80.0 86.0 79.0 79.0 80.0 80.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:128.00 stddev:21.63 (16.9%) stddev-sans-first:22.91 11:49:41 INFO - PROCESS | 29925 | Values: 128.0 120.0 128.0 119.0 122.0 131.0 124.0 117.0 191.0 131.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.50 stddev:3.03 (1.9%) stddev-sans-first:3.19 11:49:41 INFO - PROCESS | 29925 | Values: 161.0 165.0 161.0 158.0 157.0 155.0 159.0 160.0 159.0 164.0 11:49:41 INFO - PROCESS | 29925 | 11:49:41 INFO - PROCESS | 29925 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.57 (2.5%) stddev-sans-first:1.66 11:49:41 INFO - PROCESS | 29925 | Values: 63.0 64.0 62.0 62.0 62.0 63.0 60.0 63.0 66.0 62.0 11:49:41 INFO - PROCESS | 29925 | -------- Summary: end -------- 11:49:41 INFO - PROCESS | 29925 | 11:49:42 INFO - TEST-INFO | 29925: exit 0 11:49:42 INFO - TEST-OK | kraken | took 62627ms 11:49:42 INFO - SUITE-END | took 1173s 11:49:42 INFO - Completed test suite (00:19:33) 11:49:42 INFO - javascript benchmark 11:49:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7197.405867623747, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.0627811656495, 3136.8274744889036, 3174.3175217328276, 3186.7769256152064, 3187.1872672468517, 5381.56947444204, 5405.324334458192, 5419.349678038636, 5428.995635807373, 5433.673979561219, 5373.731313434332, 5437.102878025131, 5445.782168713256, 5450.5367043801225, 5507.4767897049815, 4957.900841983158, 4964.578010869062, 4982.950170498285, 5030.773615187325, 5085.110105731482, 4938.80244790208, 5045.520675535819, 5046.470120637336, 5065.493450654923, 5084.313617661605, 753.3011344372075, 5031.874203144932, 5035.571976381993, 5055.823046193384, 5068.341115654978, 4929.334539837112, 4936.062148191868, 4940.40715114185, 4945.876353091202, 4977.352944117278, 4841.782119804618, 4899.093667671456, 4918.508149185089, 4925.7783399747095, 4926.556609905126, 5314.9468505314835, 5341.43914888935, 5367.382750983647, 5377.4084850666395, 5397.757100930428, 5783.161441590946, 5798.507126894219, 5827.125931110325, 5864.296284445893, 5904.763809447617, 5925.051991681354, 5945.137954996545, 5946.494547963428, 5970.552208584373, 5977.163197152402, 5479.0, 5514.696691681956, 5541.556675465993, 5542.556595472312, 5555.138953462219, 6029.6683682397015, 6052.909206361908, 6055.303640081359, 6056.9697151513965, 6057.606255593372, 5676.063449530864, 5720.628159169641, 5828.388019258002, 5836.124581312837, 5839.0, 5795.884082318415, 5847.853803654858, 5854.970725146347, 5864.648121112747, 5873.794417195378, 5830.096335068071, 5846.590738648254, 5857.062869940789, 5858.941410585925, 5860.267466566679, 5635.887282254332, 5745.2818397700285, 5790.305163380422, 5851.268591426072, 5868.618539794899, 4389.956100439019, 4432.867013989586, 4436.334549817489, 4438.068005718771, 4469.329600559942, 3981.22366138606, 3993.1813978134414, 4025.637692607621, 4043.696722745747, 4062.898427539335, 5521.2270282160525, 5568.276124103922, 5588.189712491666, 5638.830835074954, 5651.9152212716845, 5894.823155305347, 5923.970380148072, 5938.465538101505, 5980.611260268156, 6026.939730602638, 5613.045782217033, 5616.719164041781, 5632.52123569493, 5648.152777083388, 5657.660540367591, 4955.058538877602, 5047.596192304607, 5066.873328166826, 5098.1842905135, 5146.768395422215, 6093.939060609426, 6094.471245618287, 6109.375932520363, 6117.066276512034, 6127.375193257265, 5911.467967882739, 5919.289685237713, 5922.970385148046, 5932.822015339547, 5952.255968003999, 5906.40935906406, 6007.279126504847, 6043.12374705674, 6083.361247068994, 6088.0, 5812.070068788974, 5837.066069428871, 5841.532677385884, 5846.1815345852465, 5867.501262392744, 5915.881682366415, 5947.078202878561, 5951.345352011362, 5964.135200395832, 5966.850828729316, 5616.971915140398, 5657.377688454185, 5703.173039909107, 5730.111832665943, 5797.362290148165, 5672.7730890763905, 5693.601447898607, 5694.288213973254, 5694.345150307602, 5701.315842098975, 5552.50027497511, 5577.637453565505, 5627.43725627434, 5637.295338082739, 5647.322321321468, 5664.405237450009, 5700.743466544099, 5758.337791153904, 5784.623999440191, 5802.390748971297, 5634.070378387521, 5691.4877661010705, 5692.5445964321925, 5699.1451282306325, 5719.542436605145], "value": 5378.581083155369, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.6344721102099, 637.4358692557087, 644.6003477843738, 655.6951017776735, 673.2022553274368, 39124.41313380298, 43299.0, 43314.35028474571, 43337.783311083476, 43353.34969975453, 43488.347674784905, 44050.0, 44163.11673766523, 44185.7790711046, 44193.0, 8716.302695784338, 8864.955675221647, 8886.822263554724, 8887.20015198632, 8890.066543012988, 8715.651373945035, 8778.604962776659, 8825.602847871829, 8850.601722922453, 8869.556522173898, 8773.596224604065, 8810.0, 8811.162939520767, 8838.55807209637, 8869.600867960926, 8781.56092195391, 8823.64705411786, 8899.199072083478, 8900.554972251362, 8903.0, 8665.913340866573, 8725.171108744658, 8770.079141690157, 8780.517071561062, 8793.252573531257, 41066.79466602678, 41578.168436631095, 41685.166296673895, 41724.58275417237, 41785.373219401736, 3424.5548078749853, 3912.784796836173, 3942.6057394260633, 4030.1133750574827, 4113.0, 31158.376832463226, 32060.198495037577, 32097.197570060704, 32442.0, 32452.350952980807, 4172.895677608084, 4227.661787057028, 4274.187904298174, 4359.106383191438, 4411.977940110311, 242244.0, 243818.0, 244029.0, 244949.99999999822, 245250.0, 53649.73175134177, 53659.19511207335, 54066.45933540693, 54234.72882635562, 54333.0, 61775.69112154411, 61787.382126179065, 62020.68989655113, 62182.0, 62262.37737622656, 14921.552353429415, 15079.849201507845, 15089.0, 15099.471518496799, 15133.243337833064, 12072.396380180955, 12075.758484830254, 12078.69803254908, 12102.455389507493, 12124.27254364741, 12914.741705166032, 17261.223244954006, 17312.394066207624, 17334.739978900325, 17467.56331091733, 6694.83262918431, 6741.764038258638, 6803.795886123424, 6870.896936545956, 6967.163940327092, 983.3559018842669, 1064.984025239622, 1081.3998230981724, 1155.653304008794, 1160.4081918221598, 31888.521672174935, 32449.0, 32635.51046734301, 32681.50977735336, 33077.3384532308, 1072.5441687282873, 1139.663799179244, 1170.169179882293, 1197.6886009637558, 1215.3376409856648, 16718.24767885448, 17456.389026384015, 17476.563085922953, 17520.737188942177, 17531.824681753274, 525424.0, 528743.0, 531960.0, 532328.0, 532503.0, 57793.0, 57970.4202957965, 58125.640576956896, 58151.2554623362, 58507.70746146242, 1360.0411709744606, 1398.7272481866141, 1417.2842714429148, 1442.314900422291, 1468.41263494603, 31324.843375782973, 33661.15847103842, 35238.0, 36607.633923660425, 36960.44559331666, 56870.43129568651, 57679.711601441726, 57695.0, 57801.421985779605, 57805.710971446555, 471514.0, 475763.0, 477059.99110057735, 477073.0, 477564.0, 43771.0, 45539.772301138284, 45983.54016459793, 46079.0, 46343.30485042794, 49092.58166765008, 50098.49901500938, 50490.49509504858, 50528.24207636962, 50592.74703626458, 40803.1839363217, 42201.78899105485, 42555.0, 42837.57162428336, 42991.785041074596, 40556.59443405528, 41255.58744412637, 41602.375964359955, 41709.58290417057, 41900.371494426996, 40839.59160408358, 41893.37159942542, 42117.0, 42161.789191055075, 42570.36144457898, 35707.28585428329, 37401.0, 37478.81260593679, 37671.24657506889, 37726.0, 29020.0, 29064.418711626073, 29106.854465727534, 29295.707042929298, 29372.706272936997], "value": 20345.434104701686, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.83727160049574, 379.46495441427584, 380.14277803552983, 391.4695587478966, 395.6083477357417, 17592.296308147674, 18626.627467450642, 19036.428907132773, 19266.90366548169, 19351.516212094688, 18080.54798630035, 18479.815201847978, 18758.81241187591, 18807.059647017664, 18814.52963675909, 5300.522952934235, 5425.104857698485, 5587.636803607773, 5609.102543593026, 5625.634333768312, 5424.430434804348, 5504.91742623861, 5547.72261386931, 5549.278593782823, 5555.666660000393, 5268.104422248208, 5427.6472029318165, 5434.701091439969, 5437.075697131497, 5467.808626698066, 5436.700981446039, 5436.782528698847, 5457.345118585756, 5465.262189604392, 5483.287172667548, 4733.5976442002475, 4827.179379505493, 4839.927401088987, 4854.101991131652, 4882.804687812483, 21553.24563640265, 21799.237026703988, 22197.334079977627, 22633.77366226333, 22796.316110516713, 2380.321608341614, 2417.589009868309, 2450.889709963056, 2495.3007986156053, 2809.339805145789, 13962.720745585133, 14188.858111418856, 14270.286485675675, 14377.496787612488, 14399.0, 1910.8949007804565, 1913.425972208346, 1938.3986838769952, 2015.6371853066441, 2031.9695204571942, 73610.26389736141, 76269.0, 76380.61809690972, 77030.99999999943, 77285.0, 9592.232621390272, 9711.514424278757, 10055.190670029748, 10230.335028223142, 10234.846477302697, 13490.258035807929, 13552.59342219735, 13677.31613419325, 13745.931270343584, 13805.86194138066, 7732.381409487228, 7840.09838868526, 7873.473441500422, 7922.326602238874, 7946.801329966682, 7377.8155546111775, 7442.106947166375, 7590.658420371096, 7753.224677532315, 7778.105517865518, 6324.229215819578, 6339.587926784744, 6429.839254018593, 6500.674966251669, 6587.242467116343, 1743.4072415378832, 1780.1366337326644, 1838.5403649087727, 1844.6679597672548, 1846.621442604263, 975.7219192530094, 1044.3003187863997, 1078.568572570978, 1096.1833434091652, 1104.127739086113, 18225.0, 18887.92232854385, 19344.806551934584, 19376.903115484612, 19553.315633952745, 991.9603215871429, 1049.5382031905938, 1058.920580956416, 1078.82199437092, 1117.1230583991528, 10761.139108871272, 11092.168087393478, 11123.777524449628, 11180.608678696206, 11224.270422422516, 448652.0, 459961.0, 470413.0, 470567.0, 471209.79555920063, 65432.67283663551, 73216.63391683008, 75325.24674753292, 76319.0, 78804.0, 1009.7576581620505, 1016.4765145949842, 1022.6114076650825, 1030.8299130643509, 1030.845373194042, 16747.91626041862, 17015.149242537576, 17241.22414491326, 17338.566535836704, 17388.73916891273, 36715.26569468649, 36971.63028369682, 37036.62963370332, 37249.81375093215, 37357.62642373541, 46694.76652616851, 47118.29322560096, 49417.0, 50010.249846253064, 50590.747046264536, 7940.920590794018, 8007.959960200162, 8020.759377218693, 8374.916250837414, 8382.203690649378, 12244.0, 12278.508859645513, 12339.0, 12526.937365313115, 12697.174683645533, 10449.738756531147, 11002.669919902415, 11221.887781122085, 11246.493907774333, 11272.323660580392, 11320.886791131983, 11388.202825802446, 11475.655730328104, 11543.307401555934, 11545.884541154817, 11325.490352934303, 11565.942170289094, 11698.47356868926, 11722.94138529302, 11841.703957401134, 7867.921320786719, 7894.486858354188, 8134.06458257308, 8162.142974987541, 8194.05768336625, 11042.227044106836, 11051.778964420828, 11306.265092768943, 11432.599859004895, 11482.081433485135], "value": 9001.601402117685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.508109864294, 1515.454436402895, 1726.2404542001518, 1777.3779177287943, 1858.4424672598225, 8212.260896519312, 8762.342824288187, 8880.911190888097, 9320.254379649628, 9422.15200631943, 8851.468911865293, 9068.954655226731, 9070.637174513027, 9155.359124861263, 9167.633294668205, 2403.5072810073893, 2434.9756502434925, 2436.8537887726793, 2440.7681270279295, 2446.0, 2384.856908585482, 2402.699662542182, 2462.5813611685967, 2470.407102295454, 2474.8886300116446, 2396.077510158584, 2398.6162214045758, 2399.1003373734848, 2427.514497100578, 2427.9150229741963, 2312.2485192312565, 2321.9883900580476, 2352.776486233805, 2375.1449478187837, 2404.4589967257402, 2329.2429960262984, 2336.19401306549, 2344.3904584808074, 2365.27859003004, 2394.5570069537193, 8968.05835387288, 9031.187193152648, 9036.774080648036, 9083.7274881753, 9113.225375843062, 5483.314585676791, 5621.550275977912, 5640.041192997201, 5648.378678345379, 5652.858678533028, 3299.059767966118, 3300.7524435667183, 3368.6631336866362, 3498.8950331490096, 3523.1720545671747, 1049.6326285799985, 1053.2364036073861, 1053.394298278493, 1054.2830875004993, 1070.8661417322835, 12714.682132946658, 12815.551455699006, 12820.679483012906, 12885.291308978003, 12931.741365172738, 4718.575328220477, 4724.598409135262, 4798.832040878552, 4846.224604063333, 4849.199882019428, 9994.950025249827, 10045.899541004643, 10099.44453055089, 10103.949480252551, 10112.393256404639, 5432.02223599748, 5462.7268636568015, 5486.670799752028, 5507.091329930597, 5541.473560011793, 4623.16782979067, 4865.7323847188745, 4982.177940639826, 5006.724630145304, 5116.386033675983, 3908.1402091539817, 3972.781497017634, 4046.838126474967, 4056.0671045659074, 4164.562720914321, 1194.0865238092865, 1212.5210541835925, 1212.6180253220207, 1213.8846809553079, 1233.2662066070673, 914.4284821986258, 977.1498796047484, 988.945607991553, 1008.2690049713899, 1017.3641474078701, 5969.492593129546, 6060.878782424327, 6140.0, 6244.969580019337, 6359.650219237894, 431.7754767520872, 435.80388825028865, 441.7150937645201, 464.89307459284555, 465.8881868351571, 3983.103801644607, 3983.521977362735, 4052.9594704052583, 4064.166845796664, 4071.206114807584, 11360.147988900866, 11555.88444115565, 11681.357525336018, 11688.0, 11746.70633234176, 11629.0, 11633.243839150427, 11642.01042911345, 11725.237859539102, 11738.0, 8146.103928567853, 8495.575221238912, 8502.299540092006, 8729.127087291346, 8739.825203496022, 6090.269167699905, 6329.240491141092, 6378.298387177314, 6392.552521323462, 6403.103565500926, 10157.492125393554, 10644.574217031231, 10693.09108725767, 10720.35677859331, 10931.398773067558, 10671.199660025373, 10754.085902698358, 10791.946040270062, 10838.458077095956, 10908.072813810915, 7528.171901090766, 8010.158933312151, 8245.381596380415, 8269.338452923632, 8436.282915952213, 9013.233875120688, 9065.184133428023, 9103.18071373553, 9113.498757568397, 9179.0, 7944.6822127114265, 8008.319292860172, 8116.918830811616, 8210.671573137008, 8265.0, 7883.054033516015, 7972.641231144728, 7994.440389172702, 8053.959730201312, 8220.095789463274, 6693.196816382066, 7202.96398518025, 7294.452916031425, 7341.669624866787, 7351.558906465629, 5223.555997740083, 5263.631545791758, 5307.310049693515, 5370.597205209703, 5529.502344788988, 5396.676199428047, 5531.668099914018, 5532.557395408438, 5544.306961629796, 5563.638363506359], "value": 4692.638325311924, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.5483676088052, 323.32425231266654, 325.43699400037934, 327.8131465064914, 328.33512137920724, 5534.640248383857, 5589.804356847511, 5609.0, 5629.296337957755, 5733.713314334283, 5504.2018907258425, 5509.669419834812, 5526.309211348582, 5536.252605898202, 5597.160425936112, 4253.680973926952, 4336.739795612258, 4380.233459144645, 4380.474343078835, 4399.406080179167, 4282.379055037018, 4302.0, 4323.740575565461, 4345.174416860787, 4348.30427131659, 4279.486461624594, 4282.807273672693, 4289.721168124078, 4289.957100428987, 4317.352397140438, 4013.2776100301935, 4115.506139263278, 4243.978780106079, 4261.126469073833, 4321.611055005049, 3753.5871054184017, 3763.9811800941093, 3767.8492860285555, 3786.7159963002887, 3796.6772824309965, 5341.919871201935, 5347.919781203285, 5361.651492652965, 5374.570034397278, 5375.973120134413, 4797.52024797521, 4891.217405215184, 4898.681585696918, 4953.157963146274, 4964.776585053682, 5783.652980821164, 5792.189093526909, 5797.217375654275, 5828.737706803204, 5837.824865254049, 4157.272477316487, 4164.479440069991, 4183.435236243099, 4187.120704652027, 4201.663866890642, 5698.886022279573, 6003.219581454427, 6014.1580178775, 6018.247719035165, 6077.179580756586, 4089.9591004090175, 4101.835926562904, 4114.526829414595, 4134.193832202752, 4141.068259641616, 4149.91700165995, 4175.958240417618, 4194.224068547329, 4211.241976444269, 4212.557681443404, 4772.665913386099, 4802.615790736732, 4853.247746599282, 4872.269159626014, 4900.950990490121, 5842.269716285465, 5852.209951656557, 5882.294124705063, 5893.675847828411, 5942.8811423771285, 1444.4799872046055, 1451.7096580683906, 1457.0529156048653, 1457.774045023023, 1466.7286551987916, 906.4787747045475, 909.4497828813472, 912.2154946745793, 917.4266083697689, 929.7907970706536, 4947.529984651453, 5029.748512574357, 5065.670731402447, 5142.97428512855, 5174.197999310113, 5320.654157479751, 5344.0, 5423.752536916452, 5457.536109430664, 5459.808906688247, 4901.852944411673, 5091.9236211456855, 5131.692098474104, 5603.551715862721, 5641.0, 3187.7609179311644, 3219.388316219911, 3228.4350238708134, 3235.266200060945, 3249.6676362691182, 5945.64326140433, 6145.5698101133385, 6165.290991536031, 6169.951108311508, 6187.0, 6078.787242446581, 6079.179310792986, 6089.908651370233, 6132.877342453126, 6160.630362178194, 6135.926212912812, 6221.751129954751, 6232.345603711636, 6243.8126856194385, 6321.683915804191, 5815.360310365941, 6094.664793436404, 6101.2068431105445, 6103.786367477294, 6116.4495195430845, 5920.822375328747, 5939.584229103922, 5986.730597123227, 6026.969865150646, 6029.341930968843, 6149.385061493815, 6161.322254551906, 6210.813675589739, 6218.81343559694, 6263.78076767311, 4160.979195104005, 4164.583541645932, 4213.073123912734, 4221.451211342629, 4233.978830105953, 6066.393360664075, 6095.146679464967, 6128.50971922254, 6162.476189523762, 6186.257649082139, 5688.345840228427, 5850.882982340415, 5899.734511947058, 5932.110183472513, 5941.732622031933, 5864.67744274052, 5874.765009399747, 5883.705814709162, 5888.617239879394, 5972.940270597239, 5557.3331200256225, 5756.395578464201, 5809.750903555756, 5848.736806843787, 5850.180974663635, 5939.821805345847, 5943.346231914399, 5955.851103722442, 5976.940230597638, 5980.37206093354, 5791.449812267828, 5804.0, 5854.590178687451, 5863.618864773776, 5892.410758924245], "value": 4394.0729109287995, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.8895849060377, 823.6129019360899, 823.8928939237899, 828.2214718164925, 874.5146443723735, 12679.112462127654, 14285.0, 14476.13143211408, 14528.3462244199, 14559.78160327596, 13616.0, 14150.080244784107, 14664.046836955591, 14691.706165876676, 15090.320935557898, 809.9592024248841, 810.5582457560614, 818.9918100818975, 819.0662644585178, 819.4427789103407, 804.4610111225493, 811.4117264982899, 834.7287131682198, 835.5905606252953, 839.7900524868783, 869.9304055675531, 875.2910142784365, 882.5851849630695, 883.377219060564, 883.779055236191, 876.3383645347785, 877.4954401219325, 878.4070752242211, 880.2825697056878, 880.7357792662176, 637.4486069549853, 638.533870274702, 641.8010416770816, 642.238946847982, 642.3159335307882, 13102.672433189151, 13192.20846749198, 13241.867581324159, 13260.602181934557, 13274.203547787067, 12966.351682415841, 13142.671433214246, 13150.923213803655, 13180.472781088745, 13238.205707657475, 10255.538500767483, 10530.42082685452, 10545.261831671785, 10663.893361066368, 11268.549258029669, 3712.6101759315425, 3801.144742432958, 3858.3247931612136, 3876.457295978537, 3882.495275614152, 59823.40176598222, 60957.39042609561, 61208.387916120715, 61268.0, 61506.07740883935, 9002.909970900339, 9103.135202155918, 9144.497052662167, 9426.528673566294, 9457.76355591102, 19215.615687686168, 19516.31692890742, 19516.804831951784, 19713.605727885362, 19750.0, 7467.178610352857, 7538.473790041597, 7595.126560445509, 7658.425618078666, 7827.178146294671, 4424.093060922503, 4453.22068637987, 4537.478190008125, 4539.614132798683, 4633.62930965522, 3441.8795342162903, 3511.648835116519, 3542.1498840278664, 3543.0965103898343, 3557.6975957043423, 636.2174525333866, 638.7030031035498, 645.1161908185816, 645.5997281685385, 668.5754545863412, 579.8173575323759, 616.4267231474682, 636.6021236727046, 712.4394104018188, 758.7041053988949, 8474.406791524534, 9116.726498205064, 9189.770255743526, 9258.0, 9290.907090929139, 676.6075676107846, 685.8422562810482, 726.9121110697905, 754.9282818132268, 766.9539827610362, 4395.890102747393, 4472.821087156477, 4475.0, 4478.798454069574, 4490.550944905483, 68199.65900170467, 68536.6573167131, 69547.0, 69691.65154174298, 71098.2890171102, 56869.43130568724, 60797.39202608006, 60992.0, 61665.38334616686, 63387.68306158532, 55461.72269138628, 56445.43554564484, 57144.57138571569, 57355.13967290411, 58388.0, 9452.574634141343, 9635.13283804461, 9834.655787047419, 9991.150752185855, 9999.150072243941, 36524.63475365318, 37392.81303593465, 37464.812675936446, 37522.8123859379, 37580.436293456165, 44472.33291500565, 47520.287195692785, 49610.75194624148, 49740.253896190865, 49877.50122498874, 11951.940240298743, 12365.381730913597, 12422.875771242534, 12482.126251162332, 12483.93758031204, 12984.740305194033, 13374.13068150606, 13431.597052088453, 13680.518885313162, 13928.651783705489, 13134.60596182116, 13228.272445015617, 13304.401301941241, 13368.0, 13485.797713034117, 13002.284874332003, 13084.345782710636, 13196.670083247996, 13367.264800436069, 13823.377947992163, 11409.771804563696, 12416.689582760504, 12594.0, 12871.742565148457, 13299.734005320033, 10067.848982265125, 10096.545655445376, 10253.692389228336, 10269.178465722574, 10670.893291067301, 10680.39713138504, 10792.460376981277, 11019.228653994143, 11029.889701102886, 11183.273087249303], "value": 6843.433175560234, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 111.0, 108.0, 109.0, 110.0, 109.0, 108.0, 109.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 153.0, 210.0, 129.0, 152.0, 151.0, 128.0, 186.0, 132.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 167.0, 167.0, 168.0, 164.0, 162.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 163.0, 76.0, 76.0, 75.0, 76.0, 169.0, 75.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 180.0, 93.0, 94.0, 98.0, 146.0, 93.0, 92.0, 146.0], "value": 112.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 63.0, 55.0, 56.0, 56.0, 108.0, 58.0, 55.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 68.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 62.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 80.0, 86.0, 79.0, 79.0, 80.0, 80.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 120.0, 128.0, 119.0, 122.0, 131.0, 124.0, 117.0, 191.0, 131.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 161.0, 158.0, 157.0, 155.0, 159.0, 160.0, 159.0, 164.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 62.0, 62.0, 63.0, 60.0, 63.0, 66.0, 62.0], "value": 62.7, "unit": "score"}]}]} 11:49:43 INFO - Return code: 0 11:49:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:49:43 ERROR - # TBPL SUCCESS # 11:49:43 INFO - Running post-action listener: _resource_record_post_action 11:49:43 INFO - ##### 11:49:43 INFO - ##### Finished run-tests step (success) 11:49:43 INFO - ##### 11:49:43 INFO - Running post-run listener: _resource_record_post_run 11:49:43 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 538902528; Read time: 0; Write time: 375640 11:49:43 INFO - TinderboxPrint: CPU usage
13.4% 11:49:43 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:49:43 INFO - TinderboxPrint: I/O write bytes / time
538,902,528 / 375,640 11:49:43 INFO - TinderboxPrint: CPU idle
8,233.6 (86.6%) 11:49:43 INFO - TinderboxPrint: CPU user
1,219.7 (12.8%) 11:49:43 INFO - TinderboxPrint: Swap in / out
0 / 0 11:49:43 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247209984; Read time: 0; Write time: 222748 11:49:43 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 291692544; Read time: 0; Write time: 152892 11:49:43 INFO - Running post-run listener: _upload_blobber_files 11:49:43 INFO - Blob upload gear active. 11:49:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:49:43 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 11:49:43 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'] 11:49:43 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 11:49:44 INFO - (blobuploader) - INFO - Open directory for files ... 11:49:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:49:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:49:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:49:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:49:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:49:47 INFO - (blobuploader) - INFO - Done attempting. 11:49:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:49:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:49:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:49:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:49:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:49:48 INFO - (blobuploader) - INFO - Done attempting. 11:49:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:49:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:49:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:49:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:49:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:49:49 INFO - (blobuploader) - INFO - Done attempting. 11:49:49 INFO - (blobuploader) - INFO - Iteration through files over. 11:49:49 INFO - Return code: 0 11:49:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:49:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:49:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2bc75d50142e77ad14a2881ae13887a9b725c004fd542f416bec88330b5bf39bcbb614ab471c375c8ec5f70782b6eadac3e89d7dbd4bd24828410365ce452090", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28c8fb00121ec1bf963049e63d993e4caec1f33ec828decfc01faace6764b2dda8bb876ac3839e57365d11b8315bfee745aa8f03cd0ac3d00b484e3f3046320a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81598b6fd8355f95d7e34066d837607ad7b729c834cd0a109998ba08e8ba9b35e11c3205f94e47186e29a9dbbd8bbba08c71899ea667feb82131ac294e82348c"} 11:49:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:49:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:49:49 INFO - Contents: 11:49:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2bc75d50142e77ad14a2881ae13887a9b725c004fd542f416bec88330b5bf39bcbb614ab471c375c8ec5f70782b6eadac3e89d7dbd4bd24828410365ce452090", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28c8fb00121ec1bf963049e63d993e4caec1f33ec828decfc01faace6764b2dda8bb876ac3839e57365d11b8315bfee745aa8f03cd0ac3d00b484e3f3046320a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81598b6fd8355f95d7e34066d837607ad7b729c834cd0a109998ba08e8ba9b35e11c3205f94e47186e29a9dbbd8bbba08c71899ea667feb82131ac294e82348c"} 11:49:49 INFO - Running post-run listener: copy_logs_to_upload_dir 11:49:49 INFO - Copying logs to upload dir... 11:49:49 INFO - mkdir: /builds/slave/test/build/upload/logs 11:49:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.991938 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-23 11:49:49.193090) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:49:49.196911) ========= 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=ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2bc75d50142e77ad14a2881ae13887a9b725c004fd542f416bec88330b5bf39bcbb614ab471c375c8ec5f70782b6eadac3e89d7dbd4bd24828410365ce452090", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28c8fb00121ec1bf963049e63d993e4caec1f33ec828decfc01faace6764b2dda8bb876ac3839e57365d11b8315bfee745aa8f03cd0ac3d00b484e3f3046320a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81598b6fd8355f95d7e34066d837607ad7b729c834cd0a109998ba08e8ba9b35e11c3205f94e47186e29a9dbbd8bbba08c71899ea667feb82131ac294e82348c"} build_url:https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/MP8bdczQTVuxWpbbOw_ZFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2bc75d50142e77ad14a2881ae13887a9b725c004fd542f416bec88330b5bf39bcbb614ab471c375c8ec5f70782b6eadac3e89d7dbd4bd24828410365ce452090", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28c8fb00121ec1bf963049e63d993e4caec1f33ec828decfc01faace6764b2dda8bb876ac3839e57365d11b8315bfee745aa8f03cd0ac3d00b484e3f3046320a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81598b6fd8355f95d7e34066d837607ad7b729c834cd0a109998ba08e8ba9b35e11c3205f94e47186e29a9dbbd8bbba08c71899ea667feb82131ac294e82348c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:49:49.222543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:49:49.222903) ========= 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=ea34ab03e80221fdf844251c000001a3-1464028156.321841-720923499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:49:49.306432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:49:49.306761) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:49:49.307054) ========= ========= Total master_lag: 0.17 =========