builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1464328592.94 results: success (0) buildid: 20160526203033 builduid: ec42c199b77a4615b5d92b49bd65bc77 revision: f2125a888d23ff0a5b6df4c31bc66f0132610750 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:32.938423) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:32.939642) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:32.940120) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:33.003634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:33.004189) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 22:56:33-- 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% 43.1M=0s 2016-05-26 22:56:33 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100298 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:33.118163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:33.118464) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018202 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:33.169382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:33.169957) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f2125a888d23ff0a5b6df4c31bc66f0132610750 --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 f2125a888d23ff0a5b6df4c31bc66f0132610750 --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=d6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 22:56:33,563 truncating revision to first 12 chars 2016-05-26 22:56:33,563 Setting DEBUG logging. 2016-05-26 22:56:33,563 attempt 1/10 2016-05-26 22:56:33,563 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f2125a888d23?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 22:56:33,876 unpacking tar archive at: fx-team-f2125a888d23/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616675 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:33.853536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:33.853801) ========= script_repo_revision: f2125a888d23ff0a5b6df4c31bc66f0132610750 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:33.854169) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:33.854430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 22:56:33.868623) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-26 22:56:33.868886) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:56:34 INFO - MultiFileLogger online at 20160526 22:56:34 in /builds/slave/test 22:56:34 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 22:56:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:56:34 INFO - {'append_to_log': False, 22:56:34 INFO - 'base_work_dir': '/builds/slave/test', 22:56:34 INFO - 'blob_upload_branch': 'Fx-Team', 22:56:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:56:34 INFO - 'branch': 'Fx-Team', 22:56:34 INFO - 'buildbot_json_path': 'buildprops.json', 22:56:34 INFO - 'config_files': ('talos/linux_config.py',), 22:56:34 INFO - 'default_actions': ('clobber', 22:56:34 INFO - 'read-buildbot-config', 22:56:34 INFO - 'download-and-extract', 22:56:34 INFO - 'populate-webroot', 22:56:34 INFO - 'create-virtualenv', 22:56:34 INFO - 'install', 22:56:34 INFO - 'run-tests'), 22:56:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:56:34 INFO - 'download_minidump_stackwalk': True, 22:56:34 INFO - 'download_symbols': 'ondemand', 22:56:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:56:34 INFO - 'tooltool.py': '/tools/tooltool.py', 22:56:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:56:34 INFO - '/tools/misc-python/virtualenv.py')}, 22:56:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:56:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:56:34 INFO - 'installer_path': 'installer.exe', 22:56:34 INFO - 'log_level': 'info', 22:56:34 INFO - 'log_name': 'talos', 22:56:34 INFO - 'log_to_console': True, 22:56:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:56:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:56:34 INFO - 'opt_config_files': (), 22:56:34 INFO - 'pip_index': False, 22:56:34 INFO - 'sps_profile': False, 22:56:34 INFO - 'sps_profile_interval': 0, 22:56:34 INFO - 'suite': 'dromaeojs-e10s', 22:56:34 INFO - 'system_bits': '32', 22:56:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:56:34 INFO - 'title': 'talos-linux64-ix-034', 22:56:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:56:34 INFO - 'use_talos_json': True, 22:56:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:56:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:56:34 INFO - 'work_dir': 'build'} 22:56:34 INFO - ##### 22:56:34 INFO - ##### Running clobber step. 22:56:34 INFO - ##### 22:56:34 INFO - Running pre-action listener: _resource_record_pre_action 22:56:34 INFO - Running main action method: clobber 22:56:34 INFO - rmtree: /builds/slave/test/build 22:56:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:56:34 INFO - Running post-action listener: _resource_record_post_action 22:56:34 INFO - ##### 22:56:34 INFO - ##### Finished clobber step (success) 22:56:34 INFO - ##### 22:56:34 INFO - ##### 22:56:34 INFO - ##### Running read-buildbot-config step. 22:56:34 INFO - ##### 22:56:34 INFO - Running pre-action listener: _resource_record_pre_action 22:56:34 INFO - Running main action method: read_buildbot_config 22:56:34 INFO - Using buildbot properties: 22:56:34 INFO - { 22:56:34 INFO - "project": "", 22:56:34 INFO - "product": "firefox", 22:56:34 INFO - "script_repo_revision": "production", 22:56:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:56:34 INFO - "repository": "", 22:56:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:56:34 INFO - "buildid": "20160526203033", 22:56:34 INFO - "pgo_build": "True", 22:56:34 INFO - "basedir": "/builds/slave/test", 22:56:34 INFO - "buildnumber": 503, 22:56:34 INFO - "slavename": "talos-linux64-ix-034", 22:56:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:56:34 INFO - "platform": "ubuntu64_hw", 22:56:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:56:34 INFO - "branch": "fx-team", 22:56:34 INFO - "repo_path": "integration/fx-team", 22:56:34 INFO - "revision": "f2125a888d23ff0a5b6df4c31bc66f0132610750", 22:56:34 INFO - "stage_platform": "linux64-pgo", 22:56:34 INFO - "builduid": "ec42c199b77a4615b5d92b49bd65bc77", 22:56:34 INFO - "slavebuilddir": "test" 22:56:34 INFO - } 22:56:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:56:34 INFO - Running post-action listener: _resource_record_post_action 22:56:34 INFO - ##### 22:56:34 INFO - ##### Finished read-buildbot-config step (success) 22:56:34 INFO - ##### 22:56:34 INFO - ##### 22:56:34 INFO - ##### Running download-and-extract step. 22:56:34 INFO - ##### 22:56:34 INFO - Running pre-action listener: _resource_record_pre_action 22:56:34 INFO - Running main action method: download_and_extract 22:56:34 INFO - mkdir: /builds/slave/test/build/tests 22:56: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')]} 22:56:34 INFO - https://queue.taskcluster.net/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/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 22:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/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 22:56:35 INFO - Downloaded 1361 bytes. 22:56:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:56:35 INFO - Using the following test package requirements: 22:56:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:56:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:56:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:56:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:35 INFO - u'jsshell-linux-x86_64.zip'], 22:56:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:56:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:56:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:56:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:56:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:56:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:56:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:56:35 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')]} 22:56:35 INFO - https://queue.taskcluster.net/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/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 22:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/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 22:56:36 INFO - Downloaded 24410781 bytes. 22:56:36 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'] 22:56:36 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 22:56:37 INFO - Return code: 0 22:56:37 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 22:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:37 INFO - https://queue.taskcluster.net/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/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 22:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/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 22:56:39 INFO - Downloaded 24410781 bytes. 22:56:39 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'] 22:56:39 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 22:56:40 INFO - Return code: 0 22:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:40 INFO - https://queue.taskcluster.net/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/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 22:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/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 22:56:41 INFO - Downloaded 10834034 bytes. 22:56:41 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'] 22:56:41 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 22:56:42 INFO - Return code: 0 22:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:42 INFO - https://queue.taskcluster.net/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:56:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:56:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:56:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/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 22:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JJttUPQVRKWpZSNCN0uiWw/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 22:56:43 INFO - Downloaded 58702468 bytes. 22:56:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:56:43 INFO - mkdir: /builds/slave/test/properties 22:56:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:56:43 INFO - Writing to file /builds/slave/test/properties/build_url 22:56:43 INFO - Contents: 22:56:43 INFO - build_url:https://queue.taskcluster.net/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:56:44 INFO - Running post-action listener: _resource_record_post_action 22:56:44 INFO - Running post-action listener: set_extra_try_arguments 22:56:44 INFO - ##### 22:56:44 INFO - ##### Finished download-and-extract step (success) 22:56:44 INFO - ##### 22:56:44 INFO - ##### 22:56:44 INFO - ##### Running populate-webroot step. 22:56:44 INFO - ##### 22:56:44 INFO - Running pre-action listener: _resource_record_pre_action 22:56:44 INFO - Running main action method: populate_webroot 22:56:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:56:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:56:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:56:44 INFO - '--tppagecycles', 22:56:44 INFO - '7'], 22:56:44 INFO - 'tests': ['tsvgm']}}, 22:56:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:56:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:56:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:56:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:56:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:56:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:56:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:44 INFO - 'talos_options': ['--disable-e10s'], 22:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:56:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:56:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:44 INFO - 'talos_options': ['--disable-e10s'], 22:56:44 INFO - 'tests': ['damp', 'tps']}, 22:56:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:44 INFO - 'tests': ['damp', 'tps']}, 22:56:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:56:44 INFO - 'tests': ['dromaeo_dom']}, 22:56:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:56:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:56:44 INFO - 'tests': ['a11yr', 22:56:44 INFO - 'ts_paint', 22:56:44 INFO - 'tpaint', 22:56:44 INFO - 'sessionrestore', 22:56:44 INFO - 'sessionrestore_no_auto_restore', 22:56:44 INFO - 'tabpaint']}, 22:56:44 INFO - 'other-e10s': {'tests': ['a11yr', 22:56:44 INFO - 'ts_paint', 22:56:44 INFO - 'tpaint', 22:56:44 INFO - 'sessionrestore', 22:56:44 INFO - 'sessionrestore_no_auto_restore', 22:56:44 INFO - 'tabpaint']}, 22:56:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:56:44 INFO - 'ts_paint', 22:56:44 INFO - 'tpaint', 22:56:44 INFO - 'sessionrestore', 22:56:44 INFO - 'sessionrestore_no_auto_restore', 22:56:44 INFO - 'tabpaint']}, 22:56:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:56:44 INFO - 'ts_paint', 22:56:44 INFO - 'tpaint', 22:56:44 INFO - 'sessionrestore', 22:56:44 INFO - 'sessionrestore_no_auto_restore', 22:56:44 INFO - 'tabpaint']}, 22:56:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:56:44 INFO - 'tests': ['a11yr', 22:56:44 INFO - 'ts_paint', 22:56:44 INFO - 'tpaint', 22:56:44 INFO - 'sessionrestore', 22:56:44 INFO - 'sessionrestore_no_auto_restore', 22:56:44 INFO - 'tabpaint']}, 22:56:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:56:44 INFO - 'tests': ['a11yr', 22:56:44 INFO - 'ts_paint', 22:56:44 INFO - 'tpaint', 22:56:44 INFO - 'sessionrestore', 22:56:44 INFO - 'sessionrestore_no_auto_restore', 22:56:44 INFO - 'tabpaint']}, 22:56:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:56:44 INFO - 'tests': ['tsvgx', 22:56:44 INFO - 'tsvgr_opacity', 22:56:44 INFO - 'tart', 22:56:44 INFO - 'tscrollx', 22:56:44 INFO - 'cart']}, 22:56:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:56:44 INFO - 'tsvgr_opacity', 22:56:44 INFO - 'tart', 22:56:44 INFO - 'tscrollx', 22:56:44 INFO - 'cart']}, 22:56:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:44 INFO - 'talos_options': ['--disable-e10s'], 22:56:44 INFO - 'tests': ['tp5o']}, 22:56:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:44 INFO - 'tests': ['tp5o']}, 22:56:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:44 INFO - 'talos_options': ['--disable-e10s', 22:56:44 INFO - '--xperf_path', 22:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:56:44 INFO - 'tests': ['tp5n']}, 22:56:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:56:44 INFO - 'talos_options': ['--xperf_path', 22:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:56:44 INFO - 'tests': ['tp5n']}}, 22:56:44 INFO - 'talos.zip': {'path': '', 22:56:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:56:44 INFO - Running post-action listener: _resource_record_post_action 22:56:44 INFO - ##### 22:56:44 INFO - ##### Finished populate-webroot step (success) 22:56:44 INFO - ##### 22:56:44 INFO - ##### 22:56:44 INFO - ##### Running create-virtualenv step. 22:56:44 INFO - ##### 22:56:44 INFO - Running pre-action listener: _resource_record_pre_action 22:56:44 INFO - Running main action method: create_virtualenv 22:56:44 INFO - Creating virtualenv /builds/slave/test/build/venv 22:56:44 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 22:56:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:56:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:56:44 INFO - Using real prefix '/usr' 22:56:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:56:44 INFO - Installing distribute.............................................................................................................................................................................................done. 22:56:46 INFO - Installing pip.................done. 22:56:46 INFO - Return code: 0 22:56:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d5a0dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17679c0>, '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 0x17688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1768d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', '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 22:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:56:46 INFO - Using env: {'DISPLAY': ':0', 22:56:46 INFO - 'HOME': '/home/cltbld', 22:56:46 INFO - 'LANG': 'en_US.UTF-8', 22:56:46 INFO - 'LANGUAGE': 'en_US:en', 22:56:46 INFO - 'LOGNAME': 'cltbld', 22:56:46 INFO - 'MAIL': '/var/mail/cltbld', 22:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:46 INFO - 'MOZ_NO_REMOTE': '1', 22:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:46 INFO - 'NO_EM_RESTART': '1', 22:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:46 INFO - 'PWD': '/builds/slave/test', 22:56:46 INFO - 'SHELL': '/bin/bash', 22:56:46 INFO - 'SHLVL': '1', 22:56:46 INFO - 'TERM': 'linux', 22:56:46 INFO - 'TMOUT': '86400', 22:56:46 INFO - 'USER': 'cltbld', 22:56:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', 22:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:46 INFO - '_': '/tools/buildbot/bin/python'} 22:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:46 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 22:56:46 INFO - Cleaning up... 22:56:46 INFO - Return code: 0 22:56:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d5a0dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17679c0>, '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 0x17688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1768d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', '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 22:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:56:46 INFO - Using env: {'DISPLAY': ':0', 22:56:46 INFO - 'HOME': '/home/cltbld', 22:56:46 INFO - 'LANG': 'en_US.UTF-8', 22:56:46 INFO - 'LANGUAGE': 'en_US:en', 22:56:46 INFO - 'LOGNAME': 'cltbld', 22:56:46 INFO - 'MAIL': '/var/mail/cltbld', 22:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:46 INFO - 'MOZ_NO_REMOTE': '1', 22:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:46 INFO - 'NO_EM_RESTART': '1', 22:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:46 INFO - 'PWD': '/builds/slave/test', 22:56:46 INFO - 'SHELL': '/bin/bash', 22:56:46 INFO - 'SHLVL': '1', 22:56:46 INFO - 'TERM': 'linux', 22:56:46 INFO - 'TMOUT': '86400', 22:56:46 INFO - 'USER': 'cltbld', 22:56:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', 22:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:46 INFO - '_': '/tools/buildbot/bin/python'} 22:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:47 INFO - Downloading/unpacking psutil>=3.1.1 22:56:47 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 22:56:47 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 22:56:47 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 22:56:47 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 22:56:47 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 22:56:47 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 22:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:56:49 INFO - Installing collected packages: psutil 22:56:49 INFO - Running setup.py install for psutil 22:56:49 INFO - building 'psutil._psutil_linux' extension 22:56:49 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 22:56:49 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 22:56:49 INFO - building 'psutil._psutil_posix' extension 22:56:49 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 22:56:49 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 22:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:56:49 INFO - Successfully installed psutil 22:56:49 INFO - Cleaning up... 22:56:49 INFO - Return code: 0 22:56:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:49 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 0x7f2d5a0dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17679c0>, '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 0x17688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1768d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', '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 22:56:49 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 22:56:49 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 22:56:49 INFO - Using env: {'DISPLAY': ':0', 22:56:49 INFO - 'HOME': '/home/cltbld', 22:56:49 INFO - 'LANG': 'en_US.UTF-8', 22:56:49 INFO - 'LANGUAGE': 'en_US:en', 22:56:49 INFO - 'LOGNAME': 'cltbld', 22:56:49 INFO - 'MAIL': '/var/mail/cltbld', 22:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:49 INFO - 'MOZ_NO_REMOTE': '1', 22:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:49 INFO - 'NO_EM_RESTART': '1', 22:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:49 INFO - 'PWD': '/builds/slave/test', 22:56:49 INFO - 'SHELL': '/bin/bash', 22:56:49 INFO - 'SHLVL': '1', 22:56:49 INFO - 'TERM': 'linux', 22:56:49 INFO - 'TMOUT': '86400', 22:56:49 INFO - 'USER': 'cltbld', 22:56:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', 22:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:49 INFO - '_': '/tools/buildbot/bin/python'} 22:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:56:49 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 22:56:49 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 22:56:49 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 22:56:49 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 22:56:49 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 22:56:49 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 22:56:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:56:51 INFO - Installing collected packages: mozsystemmonitor 22:56:51 INFO - Running setup.py install for mozsystemmonitor 22:56:51 INFO - Successfully installed mozsystemmonitor 22:56:51 INFO - Cleaning up... 22:56:52 INFO - Return code: 0 22:56:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:52 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 0x7f2d5a0dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17679c0>, '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 0x17688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1768d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', '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 22:56:52 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 22:56:52 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 22:56:52 INFO - Using env: {'DISPLAY': ':0', 22:56:52 INFO - 'HOME': '/home/cltbld', 22:56:52 INFO - 'LANG': 'en_US.UTF-8', 22:56:52 INFO - 'LANGUAGE': 'en_US:en', 22:56:52 INFO - 'LOGNAME': 'cltbld', 22:56:52 INFO - 'MAIL': '/var/mail/cltbld', 22:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:52 INFO - 'MOZ_NO_REMOTE': '1', 22:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:52 INFO - 'NO_EM_RESTART': '1', 22:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:52 INFO - 'PWD': '/builds/slave/test', 22:56:52 INFO - 'SHELL': '/bin/bash', 22:56:52 INFO - 'SHLVL': '1', 22:56:52 INFO - 'TERM': 'linux', 22:56:52 INFO - 'TMOUT': '86400', 22:56:52 INFO - 'USER': 'cltbld', 22:56:52 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', 22:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:52 INFO - '_': '/tools/buildbot/bin/python'} 22:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:56:52 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 22:56:52 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 22:56:52 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 22:56:52 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 22:56:52 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 22:56:52 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 22:56:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:56:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:56:54 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 22:56:54 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 22:56:54 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 22:56:54 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 22:56:54 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 22:56:54 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 22:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:56:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:56:54 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 22:56:54 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 22:56:54 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 22:56:54 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 22:56:54 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 22:56:54 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 22:56:54 INFO - Downloading docopt-0.6.1.tar.gz 22:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:56:54 INFO - Installing collected packages: blobuploader, requests, docopt 22:56:54 INFO - Running setup.py install for blobuploader 22:56:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:56:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:56:54 INFO - Running setup.py install for requests 22:56:55 INFO - Running setup.py install for docopt 22:56:55 INFO - Successfully installed blobuploader requests docopt 22:56:55 INFO - Cleaning up... 22:56:55 INFO - Return code: 0 22:56:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:55 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 0x7f2d5a0dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17679c0>, '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 0x17688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1768d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', '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 22:56:55 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 22:56:55 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 22:56:55 INFO - Using env: {'DISPLAY': ':0', 22:56:55 INFO - 'HOME': '/home/cltbld', 22:56:55 INFO - 'LANG': 'en_US.UTF-8', 22:56:55 INFO - 'LANGUAGE': 'en_US:en', 22:56:55 INFO - 'LOGNAME': 'cltbld', 22:56:55 INFO - 'MAIL': '/var/mail/cltbld', 22:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:55 INFO - 'MOZ_NO_REMOTE': '1', 22:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:55 INFO - 'NO_EM_RESTART': '1', 22:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:55 INFO - 'PWD': '/builds/slave/test', 22:56:55 INFO - 'SHELL': '/bin/bash', 22:56:55 INFO - 'SHLVL': '1', 22:56:55 INFO - 'TERM': 'linux', 22:56:55 INFO - 'TMOUT': '86400', 22:56:55 INFO - 'USER': 'cltbld', 22:56:55 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', 22:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:55 INFO - '_': '/tools/buildbot/bin/python'} 22:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:56:55 INFO - Running setup.py (path:/tmp/pip-wEmMQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:56:55 INFO - Running setup.py (path:/tmp/pip-n1ina5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:56:55 INFO - Running setup.py (path:/tmp/pip-CekSJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:56:55 INFO - Running setup.py (path:/tmp/pip-0St1Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:56:55 INFO - Running setup.py (path:/tmp/pip-8txbJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:56:56 INFO - Running setup.py (path:/tmp/pip-mprC9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:56:56 INFO - Running setup.py (path:/tmp/pip-GxpzDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:56:56 INFO - Running setup.py (path:/tmp/pip-dm0jAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:56:56 INFO - Running setup.py (path:/tmp/pip-gPhX7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:56:56 INFO - Running setup.py (path:/tmp/pip-YriXnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:56:56 INFO - Running setup.py (path:/tmp/pip-EwtuSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:56:56 INFO - Running setup.py (path:/tmp/pip-l0Yddl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:56:56 INFO - Running setup.py (path:/tmp/pip-u2A8Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:56:56 INFO - Running setup.py (path:/tmp/pip-WkpUKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:56 INFO - Running setup.py (path:/tmp/pip-963qQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:56:56 INFO - Running setup.py (path:/tmp/pip-_fvC1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:56:56 INFO - Running setup.py (path:/tmp/pip-kNfcLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:56:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:56:56 INFO - Running setup.py install for manifestparser 22:56:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:56:56 INFO - Running setup.py install for mozcrash 22:56:57 INFO - Running setup.py install for mozdebug 22:56:57 INFO - Running setup.py install for mozdevice 22:56:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:56:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:56:57 INFO - Running setup.py install for mozfile 22:56:57 INFO - Running setup.py install for mozhttpd 22:56:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:56:57 INFO - Running setup.py install for mozinfo 22:56:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:56:57 INFO - Running setup.py install for mozInstall 22:56:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:56:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:56:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:56:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:56:57 INFO - Running setup.py install for mozleak 22:56:57 INFO - Running setup.py install for mozlog 22:56:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:56:57 INFO - Running setup.py install for moznetwork 22:56:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:56:57 INFO - Running setup.py install for mozprocess 22:56:58 INFO - Running setup.py install for mozprofile 22:56:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:56:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:56:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:56:58 INFO - Running setup.py install for mozrunner 22:56:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:56:58 INFO - Running setup.py install for mozscreenshot 22:56:58 INFO - Running setup.py install for moztest 22:56:58 INFO - Running setup.py install for mozversion 22:56:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:56:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:56:58 INFO - Cleaning up... 22:56:58 INFO - Return code: 0 22:56:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:56:58 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')]} 22:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:58 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')]} 22:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:58 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 0x7f2d5a0dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17679c0>, '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 0x17688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1768d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', '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 22:56:58 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 22:56:58 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 22:56:58 INFO - Using env: {'DISPLAY': ':0', 22:56:58 INFO - 'HOME': '/home/cltbld', 22:56:58 INFO - 'LANG': 'en_US.UTF-8', 22:56:58 INFO - 'LANGUAGE': 'en_US:en', 22:56:58 INFO - 'LOGNAME': 'cltbld', 22:56:58 INFO - 'MAIL': '/var/mail/cltbld', 22:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:58 INFO - 'MOZ_NO_REMOTE': '1', 22:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:58 INFO - 'NO_EM_RESTART': '1', 22:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:56:58 INFO - 'PWD': '/builds/slave/test', 22:56:58 INFO - 'SHELL': '/bin/bash', 22:56:58 INFO - 'SHLVL': '1', 22:56:58 INFO - 'TERM': 'linux', 22:56:58 INFO - 'TMOUT': '86400', 22:56:58 INFO - 'USER': 'cltbld', 22:56:58 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', 22:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:58 INFO - '_': '/tools/buildbot/bin/python'} 22:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:56:58 INFO - Running setup.py (path:/tmp/pip-fCll6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:56:58 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)) 22:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:56:58 INFO - Running setup.py (path:/tmp/pip-bB1yDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:56:59 INFO - Running setup.py (path:/tmp/pip-NAwxnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:56:59 INFO - Running setup.py (path:/tmp/pip-4UxCS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:56:59 INFO - Running setup.py (path:/tmp/pip-lAWhX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:56:59 INFO - Running setup.py (path:/tmp/pip-G8TzW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:56:59 INFO - Running setup.py (path:/tmp/pip-lNUFXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:56:59 INFO - Running setup.py (path:/tmp/pip-PydMsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:56:59 INFO - Running setup.py (path:/tmp/pip-yvqPJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:56:59 INFO - Running setup.py (path:/tmp/pip-gMIgYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:56:59 INFO - Running setup.py (path:/tmp/pip-yt9f6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:56:59 INFO - Running setup.py (path:/tmp/pip-zwWgxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:56:59 INFO - Running setup.py (path:/tmp/pip-OoarsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:56:59 INFO - Running setup.py (path:/tmp/pip-0y8_rA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:59 INFO - Running setup.py (path:/tmp/pip-VwhMQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:56:59 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)) 22:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:56:59 INFO - Running setup.py (path:/tmp/pip-Vk8ctV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:57:00 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)) 22:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:57:00 INFO - Running setup.py (path:/tmp/pip-ccpRXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:57:00 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)) 22:57:00 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)) 22:57:00 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)) 22:57:00 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)) 22:57:00 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)) 22:57:00 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)) 22:57:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:02 INFO - Downloading blessings-1.6.tar.gz 22:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:57:02 INFO - Installing collected packages: blessings 22:57:02 INFO - Running setup.py install for blessings 22:57:02 INFO - Successfully installed blessings 22:57:02 INFO - Cleaning up... 22:57:02 INFO - Return code: 0 22:57:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:57:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:57:02 INFO - Reading from file tmpfile_stdout 22:57:02 INFO - Current package versions: 22:57:02 INFO - argparse == 1.2.1 22:57:02 INFO - blessings == 1.6 22:57:02 INFO - blobuploader == 1.2.4 22:57:02 INFO - docopt == 0.6.1 22:57:02 INFO - manifestparser == 1.1 22:57:02 INFO - mozInstall == 1.12 22:57:02 INFO - mozcrash == 0.17 22:57:02 INFO - mozdebug == 0.1 22:57:02 INFO - mozdevice == 0.48 22:57:02 INFO - mozfile == 1.2 22:57:02 INFO - mozhttpd == 0.7 22:57:02 INFO - mozinfo == 0.9 22:57:02 INFO - mozleak == 0.1 22:57:02 INFO - mozlog == 3.2 22:57:02 INFO - moznetwork == 0.27 22:57:02 INFO - mozprocess == 0.22 22:57:02 INFO - mozprofile == 0.28 22:57:02 INFO - mozrunner == 6.11 22:57:02 INFO - mozscreenshot == 0.1 22:57:02 INFO - mozsystemmonitor == 0.3 22:57:02 INFO - moztest == 0.7 22:57:02 INFO - mozversion == 1.4 22:57:02 INFO - psutil == 3.1.1 22:57:02 INFO - requests == 1.2.3 22:57:02 INFO - wsgiref == 0.1.2 22:57:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:02 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 0x7f2d5a0dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17679c0>, '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 0x17688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1768d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', '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 22:57:02 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 22:57:02 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 22:57:02 INFO - Using env: {'DISPLAY': ':0', 22:57:02 INFO - 'HOME': '/home/cltbld', 22:57:02 INFO - 'LANG': 'en_US.UTF-8', 22:57:02 INFO - 'LANGUAGE': 'en_US:en', 22:57:02 INFO - 'LOGNAME': 'cltbld', 22:57:02 INFO - 'MAIL': '/var/mail/cltbld', 22:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:02 INFO - 'MOZ_NO_REMOTE': '1', 22:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:02 INFO - 'NO_EM_RESTART': '1', 22:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:02 INFO - 'PWD': '/builds/slave/test', 22:57:02 INFO - 'SHELL': '/bin/bash', 22:57:02 INFO - 'SHLVL': '1', 22:57:02 INFO - 'TERM': 'linux', 22:57:02 INFO - 'TMOUT': '86400', 22:57:02 INFO - 'USER': 'cltbld', 22:57:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', 22:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:02 INFO - '_': '/tools/buildbot/bin/python'} 22:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:02 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)) 22:57:02 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)) 22:57:02 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)) 22:57:02 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)) 22:57:02 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)) 22:57:02 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)) 22:57:02 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)) 22:57:02 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)) 22:57:02 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)) 22:57:02 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)) 22:57:02 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)) 22:57:02 INFO - Cleaning up... 22:57:02 INFO - Return code: 0 22:57:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d5a0dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17679c0>, '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 0x17688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1768d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', '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 22:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:57:02 INFO - Using env: {'DISPLAY': ':0', 22:57:02 INFO - 'HOME': '/home/cltbld', 22:57:02 INFO - 'LANG': 'en_US.UTF-8', 22:57:02 INFO - 'LANGUAGE': 'en_US:en', 22:57:02 INFO - 'LOGNAME': 'cltbld', 22:57:02 INFO - 'MAIL': '/var/mail/cltbld', 22:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:02 INFO - 'MOZ_NO_REMOTE': '1', 22:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:02 INFO - 'NO_EM_RESTART': '1', 22:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:02 INFO - 'PWD': '/builds/slave/test', 22:57:02 INFO - 'SHELL': '/bin/bash', 22:57:02 INFO - 'SHLVL': '1', 22:57:02 INFO - 'TERM': 'linux', 22:57:02 INFO - 'TMOUT': '86400', 22:57:02 INFO - 'USER': 'cltbld', 22:57:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', 22:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:02 INFO - '_': '/tools/buildbot/bin/python'} 22:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:02 INFO - Downloading/unpacking jsonschema 22:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:57:04 INFO - Downloading/unpacking functools32 (from jsonschema) 22:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:57:05 INFO - warning: no files found matching '*.txt' 22:57:05 INFO - no previously-included directories found matching 'build' 22:57:05 INFO - no previously-included directories found matching 'dist' 22:57:05 INFO - no previously-included directories found matching '.git*' 22:57:05 INFO - Installing collected packages: jsonschema, functools32 22:57:05 INFO - Running setup.py install for functools32 22:57:05 INFO - warning: no files found matching '*.txt' 22:57:05 INFO - no previously-included directories found matching 'build' 22:57:05 INFO - no previously-included directories found matching 'dist' 22:57:05 INFO - no previously-included directories found matching '.git*' 22:57:05 INFO - Successfully installed jsonschema functools32 22:57:05 INFO - Cleaning up... 22:57:05 INFO - Return code: 0 22:57:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d5a0dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17679c0>, '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 0x17688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1768d50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', '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 22:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:57:05 INFO - Using env: {'DISPLAY': ':0', 22:57:05 INFO - 'HOME': '/home/cltbld', 22:57:05 INFO - 'LANG': 'en_US.UTF-8', 22:57:05 INFO - 'LANGUAGE': 'en_US:en', 22:57:05 INFO - 'LOGNAME': 'cltbld', 22:57:05 INFO - 'MAIL': '/var/mail/cltbld', 22:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:05 INFO - 'MOZ_NO_REMOTE': '1', 22:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:05 INFO - 'NO_EM_RESTART': '1', 22:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:05 INFO - 'PWD': '/builds/slave/test', 22:57:05 INFO - 'SHELL': '/bin/bash', 22:57:05 INFO - 'SHLVL': '1', 22:57:05 INFO - 'TERM': 'linux', 22:57:05 INFO - 'TMOUT': '86400', 22:57:05 INFO - 'USER': 'cltbld', 22:57:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', 22:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:05 INFO - '_': '/tools/buildbot/bin/python'} 22:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:05 INFO - Downloading/unpacking flake8 22:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:57:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:57:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:57:08 INFO - no previously-included directories found matching 'docs/_build' 22:57:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:57:08 INFO - Running setup.py install for pep8 22:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:57:08 INFO - no previously-included directories found matching 'docs/_build' 22:57:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:57:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:57:08 INFO - Cleaning up... 22:57:08 INFO - Return code: 0 22:57:08 INFO - Running post-action listener: _resource_record_post_action 22:57:08 INFO - Running post-action listener: _start_resource_monitoring 22:57:08 INFO - Starting resource monitoring. 22:57:08 INFO - ##### 22:57:08 INFO - ##### Finished create-virtualenv step (success) 22:57:08 INFO - ##### 22:57:08 INFO - ##### 22:57:08 INFO - ##### Running install step. 22:57:08 INFO - ##### 22:57:08 INFO - Running pre-action listener: _resource_record_pre_action 22:57:08 INFO - Running main action method: install 22:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:57:08 INFO - Reading from file tmpfile_stdout 22:57:08 INFO - Detecting whether we're running mozinstall >=1.0... 22:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:57:08 INFO - Reading from file tmpfile_stdout 22:57:08 INFO - Output received: 22:57:08 INFO - Usage: mozinstall [options] installer 22:57:08 INFO - Options: 22:57:08 INFO - -h, --help show this help message and exit 22:57:08 INFO - -d DEST, --destination=DEST 22:57:08 INFO - Directory to install application into. [default: 22:57:08 INFO - "/builds/slave/test"] 22:57:08 INFO - --app=APP Application being installed. [default: firefox] 22:57:08 INFO - mkdir: /builds/slave/test/build/application 22:57:08 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'] 22:57:08 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 22:57:25 INFO - Reading from file tmpfile_stdout 22:57:25 INFO - Output received: 22:57:25 INFO - /builds/slave/test/build/application/firefox/firefox 22:57:25 INFO - Running post-action listener: _resource_record_post_action 22:57:25 INFO - ##### 22:57:25 INFO - ##### Finished install step (success) 22:57:25 INFO - ##### 22:57:25 INFO - ##### 22:57:25 INFO - ##### Running run-tests step. 22:57:25 INFO - ##### 22:57:25 INFO - Running pre-action listener: _resource_record_pre_action 22:57:25 INFO - Running main action method: run_tests 22:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:57:25 INFO - Python 2.7.3 22:57:25 INFO - Return code: 0 22:57:25 INFO - grabbing minidump binary from tooltool 22:57:25 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')]} 22:57:25 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 0x17679c0>, '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 0x17688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1768d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:57:25 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 22:57:25 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 22:57:25 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 22:57:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:57:25 INFO - Return code: 0 22:57:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:57:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:57:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:57:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:57:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:57:26 INFO - Return code: 0 22:57:26 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/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 22:57:26 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/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 22:57:26 INFO - Using env: {'DISPLAY': ':0', 22:57:26 INFO - 'HOME': '/home/cltbld', 22:57:26 INFO - 'LANG': 'en_US.UTF-8', 22:57:26 INFO - 'LANGUAGE': 'en_US:en', 22:57:26 INFO - 'LOGNAME': 'cltbld', 22:57:26 INFO - 'MAIL': '/var/mail/cltbld', 22:57:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:57:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:26 INFO - 'MOZ_NO_REMOTE': '1', 22:57:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:26 INFO - 'NO_EM_RESTART': '1', 22:57:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:26 INFO - 'PWD': '/builds/slave/test', 22:57:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:57:26 INFO - 'SHELL': '/bin/bash', 22:57:26 INFO - 'SHLVL': '1', 22:57:26 INFO - 'TERM': 'linux', 22:57:26 INFO - 'TMOUT': '86400', 22:57:26 INFO - 'USER': 'cltbld', 22:57:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861', 22:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:26 INFO - '_': '/tools/buildbot/bin/python'} 22:57:26 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/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 22:57:26 INFO - mozversion application_buildid: 20160526203033 22:57:26 INFO - mozversion application_changeset: f2125a888d23ff0a5b6df4c31bc66f0132610750 22:57:26 INFO - mozversion application_display_name: Nightly 22:57:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:57:26 INFO - mozversion application_name: Firefox 22:57:26 INFO - mozversion application_remotingname: firefox 22:57:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:57:26 INFO - mozversion application_vendor: Mozilla 22:57:26 INFO - mozversion application_version: 49.0a1 22:57:26 INFO - mozversion platform_buildid: 20160526203033 22:57:26 INFO - mozversion platform_changeset: f2125a888d23ff0a5b6df4c31bc66f0132610750 22:57:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:57:26 INFO - mozversion platform_version: 49.0a1 22:57:26 INFO - using testdate: 1464328646 22:57:26 INFO - actual date: 1464328646 22:57:26 INFO - starting webserver on 'localhost:57770' 22:57:26 INFO - SUITE-START | Running 2 tests 22:57:26 INFO - TEST-START | dromaeo_css 22:57:26 INFO - operating with platform_type : linux_ 22:57:26 INFO - Initialising browser for dromaeo_css test... 22:57:26 INFO - TEST-INFO | started process 27929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnbhp6w/profile http://localhost:57770/getInfo.html) 22:57:30 INFO - PROCESS | 27929 | 22:57:30 INFO - PROCESS | 27929 | (process:27997): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:57:31 INFO - PROCESS | 27929 | __metrics Screen width/height:1600/1200 22:57:31 INFO - PROCESS | 27929 | colorDepth:24 22:57:31 INFO - PROCESS | 27929 | Browser inner width/height: 1024/697 22:57:31 INFO - PROCESS | 27929 | __metrics 22:57:31 ERROR - PROCESS | 27929 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 22:57:32 INFO - TEST-INFO | 27929: exit 0 22:57:32 INFO - Browser initialized. 22:57:32 INFO - Running cycle 1/1 for dromaeo_css test... 22:57:32 INFO - TEST-INFO | started process 28048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnbhp6w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:57:34 INFO - PROCESS | 28048 | 22:57:34 INFO - PROCESS | 28048 | (process:28109): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:57:44 INFO - PROCESS | 28048 | RSS: Main: 166309888 22:57:44 INFO - PROCESS | 28048 | 22:58:34 INFO - PROCESS | 28048 | 1464328714195 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] 23:00:41 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:57770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57770/tests/dromaeo/cssquery-ext.html) 23:00:42 INFO - PROCESS | 28048 | RSS: Main: 170082304 23:00:42 INFO - PROCESS | 28048 | 23:03:44 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:57770/tests/dromaeo/cssquery-ext.html (next: http://localhost:57770/tests/dromaeo/cssquery-jquery.html) 23:03:45 INFO - PROCESS | 28048 | RSS: Main: 169082880 23:03:45 INFO - PROCESS | 28048 | 23:06:47 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:57770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57770/tests/dromaeo/cssquery-mootools.html) 23:06:48 INFO - PROCESS | 28048 | RSS: Main: 170184704 23:06:48 INFO - PROCESS | 28048 | 23:09:49 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:57770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57770/tests/dromaeo/cssquery-prototype.html) 23:09:50 INFO - PROCESS | 28048 | RSS: Main: 167665664 23:09:50 INFO - PROCESS | 28048 | 23:12:52 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:57770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57770/tests/dromaeo/cssquery-yui.html) 23:12:53 INFO - PROCESS | 28048 | RSS: Main: 169369600 23:12:53 INFO - PROCESS | 28048 | 23:15:55 INFO - PROCESS | 28048 | Cycle 1(1): loaded http://localhost:57770/tests/dromaeo/cssquery-yui.html (next: http://localhost:57770/tests/dromaeo/cssquery-dojo.html) 23:15:56 INFO - PROCESS | 28048 | RSS: Main: 171008000 23:15:56 INFO - PROCESS | 28048 | 23:15:56 INFO - PROCESS | 28048 | __start_tp_report 23:15:56 INFO - PROCESS | 28048 | _x_x_mozilla_page_load 23:15:56 INFO - PROCESS | 28048 | _x_x_mozilla_page_load_details 23:15:56 INFO - PROCESS | 28048 | |i|pagename|runs| 23:15:56 INFO - PROCESS | 28048 | |0;dojo.html;3084.6452657944337;3186.3627274545083;3189.585353903995;3191.441497737896;3226.4192445359827;5457.672539647624;5497.890042199154;5509.476599723025;5510.91733623996;5537.224788529599;5397.946020539794;5404.054290499157;5449.918251226235;5505.944940550593;5510.173473978895;4882.218844984812;4929.088118698034;5062.569681577071;5075.9492405076035;5134.512221338967;732.361242331821;4909.926351104737;4958.380202474691;5046.343975283226;5051.469595692454;4993.575546078588;4996.250562415648;5004.12427825131;5005.924911126336;5010.173321401982;5024.4473107958465;5024.874378140576;5044.747762611892;5046.116929537353;5049.394072711261;4917.606591472673;4943.826966056171;4984.102861484931;4989.57588604969;4995.325631039799;5384.515393614554;5418.83743487696;5426.158945363475;5449.073657478239;5449.427810079964;5664.0937450007805;5716.71416429181;5888.352281249059;5893.410658934073;5924.822255332347;5919.052951527735;5952.375000624916;5954.255718035246;5956.255468066492;6009.369016253318;5561.944380556223;5566.137248726453;5574.944250557523;5575.832725018216;5576.247206627094;5893.3222679391565;5995.730192141364;6087.908681369783;6092.908606370908;6098.32918378978;5672.177534257509;5723.484886360165;5730.083186690193;5733.254676891977;5847.1229315603;5826.300843898759;5869.589128761031;5871.442212989759;5871.9706401468575;5876.970615146983;5831.912521312183;5866.325372582208;5878.941210587925;5881.676507792027;5884.205632239678;5874.676892770939;5892.322382925932;5896.734646940898;5930.318013428425;5932.110183472428;4480;4482.932756008662;4484.1031793641405;4487.685861989629;4496.100779844044;3883.3980732986433;3891.610838916086;3935.0752573145287;3954.149857780591;3987.302222111177;5660.433956604306;5668.234788303609;5671.574631902624;5674.858128546819;5758.539316854642;6013.789517366871;6049.062395328731;6058.303295121029;6059.424354686298;6064.9090263646085;5533.142362933751;5556.555475561945;5610.102383618601;5634.52106570946;5655.886882262414;5001.974990125026;5052.141136006888;5057.519535644108;5059.139946209153;5075.720835354091;5935.436133567304;6087.756489740449;6093.207882975274;6096.512279017757;6103.908441373383;5819.214406055128;5862.091375836752;5873.559483038704;5909.6158749681135;5941.168236446814;6066.545009124245;6092.238470191226;6092.756289748538;6097.871893699502;6117.807027629569;5671.914921276101;5714.171445140349;5729.1119876419225;5755.798547050833;5835.416458354131;5980.282366116094;6013.548983826318;6021.277446706424;6038.215032045981;6049.274087109575;5785.190073389813;5831.94168058314;5842.240508734008;5861.472467477947;5874.471297583238;5593.440655934537;5615.18579805934;5630.831075067755;5832.533397328289;5833.766649333979;5531.363893152339;5553.6390134641115;5560.638558493685;5589.5807814413265;5591.412901645269;5710.8001219957105;5717.799877004285;5735.283089613798;5736.971315143398;5752.338481074563;5501.889962200654;5602.075657516464;5652.491275785199;5663.66018038919;5704.914426283526 23:15:56 INFO - PROCESS | 28048 | |1;ext.html;570.6845720613986;620.5376994139366;622.1911515030462;641.67595364341;641.6919878458343;31860.68139318606;43237.56762432375;43911.12177756451;44072.55927440725;44258.33612495815;43827;43915.12169756611;44173.77913110438;44181.77909110458;44182.11635767283;8706.65173393065;8940.955295223515;8943.821123577525;8953.552322383888;8964.327675424336;8726.476411415304;8819.559022048905;8871.68949086782;8873.68942087027;8882.555872206396;8885.95557022214;8936.910630893673;8938.4190027648;8951.731448056536;8960.641574337018;8860.069692682273;8876.778080547974;8901.02088770238;8936.508492032935;8967.820643587156;8820.2061814437;8884.333674974403;8890.73327800167;8909.643614255421;8918;42274;42728.57271427308;42769.35845962313;42769.35845962313;42869.57130428687;3462.6593897050616;3722.4788529605876;3761.492198553188;4011.197760447893;4011.7392369495888;33260.50109248363;33485.665143348495;33654.6634533654;33971.32057358839;34680.479792803126;4379.474463064421;4391.956080439219;4399.978000110011;4425.977870110629;4469.396631454744;367168;368493;369487;369703.1514842436;371858;32140.839295803373;33675;57990;58571;58686.70656646689;36036;36092.91721248367;36188.638113619054;36334.454983175274;36493.27013459716;15193.164375959208;15375.384984600714;15384.923075384551;15440.922795385952;15490.148041857581;12988.155769874928;13003.804942925864;13052.934735326262;13095.214287142802;13117.540886068942;8381.958090209631;8403.243708066304;8424.536650484282;8497.915020849712;8529.786755331043;3210.775245732823;3241.5299781531544;3263.3473305339026;3265.689759472846;3310.2551925816497;1037.9740506487246;1084.7125511739396;1093.9443437083253;1111.8999290063932;1195.6413076077142;33142;33914;33973.66026339705;33975;34220.48669269963;1096.2819353323587;1175.8059920113258;1190.4523918997186;1197.1260979485025;1211.3700875544666;17416.82583174152;17547.47357579275;17693;17698.734518982226;17705.468835934684;507543;508928;512713.23720576137;512978;516995;60071.69964150151;60083;60937.39062609406;60952;61044.38955610387;1351.7228968061524;1392.1299188007495;1392.4778208172138;1398.1121987537783;1409.3023953143054;30513.38973220479;33093;33516.664833352326;33714.662853371156;33784.831075844464;51842;52340.21489677734;52582.73708631432;52699;52787.472125278255;417196;419262;420445;421145;421169;28618.713812861606;28744.568831467128;28858.567121493616;29859.70140298569;29908.252293692833;49876;49895.75052124716;50323.49676503335;50441;50523;41388.586114138474;42900.57099429091;43024;43053.56946430621;43212.567874320855;41987.1602567953;42187.7890610545;42241.78879105585;42881;43109.35335970025;40865;42199.7890010548;42330;42689.35965960451;44924;33564;37423.25153496969;37910;39697.60302397054;40394.59605403908;29108.417831643674;29121;29266.70733292725;29674.258143546584;29837 23:15:56 INFO - PROCESS | 28048 | |2;jquery.html;400.90578714002214;407.64534854676435;409.1898041877083;409.8258240247896;418.4998926283091;13644.795328070088;17591.82408175918;18617.627647447043;19379.903100484495;19451.221951121974;18681.346152884653;18858.151383187756;18981.14584843682;19765.209391624354;19903.40289791305;5676.943230567683;5780.335261444925;5896.734646940877;5899.734511946951;5948.851278718045;5806.419358064202;5807.622504537213;5829.387914269004;5854.092615644582;5874.471297583216;5811.535077193836;5965.3736357682255;6257.843553911166;6311.147995020682;6416.871662566746;5251.422343542226;5582.330120385539;5590.440955904418;6348.841278968017;6358.141650877142;5302.814401495968;5464.016477034133;5488.69812160331;5498.917516237259;5780.826575202708;14285.500007499688;14309.928450357682;14477.71044579113;14479.710405791931;19662.70505942412;2167.924122655715;2302.8503147295373;2307.8384513084093;2376.085207195225;2547.1339744486963;10637.308574942605;10651.094656954168;10686.465676716132;10908.127349812075;14791;1935.332310352926;1977.5945931084093;1991.2632326039313;2003.5592169722638;2027.1992562937558;81556;84562.57718711367;86060;86608.13391866126;87019;10603.787924241473;10650.786984260272;10812.135029197645;11017.779644407226;11988.22076565038;15368.385264589515;15436.073835569678;15453.690926181413;15484.458043968407;15542.300596473186;7839.176886426957;8027.03675558925;8086.7169649062;8173.591320433955;8176.713815016446;7601;7633.2366763323225;7687.885256637756;7762.223777622193;7780.572068536285;4710.764461776897;4718.457377401574;4733.928991065137;4808.3989501312335;4827.300041494034;2023.9696404553943;2035.4097311779715;2076.09689784944;2082.4377418097333;2138.7968143026387;1002.9197664186847;1008.7881544875512;1059.280085534397;1068.2415485005733;1087.8531398261134;17015;18311;19339.613207735765;19554.902225488782;19813.900930495256;1028.2545154762738;1044.6343779677052;1060.204846365226;1087.0488322717622;1096.2545469080942;10464.424456654957;11009.229353945148;11025.062869656169;11046.944765276123;11084.279521831055;503790;504817.066518557;505184;508531;511892;60215.698921505114;78942.60528697434;93607;96349.51825240969;98076.50961745289;959.203860795538;964.6912987843823;978.1490103609905;996.0885789502669;1012.089119792193;17550.822507360102;17681.823181768017;18193.636127277645;18300.90849545797;18472.630547388708;41733.37399939064;43001.3549796747;43328.350074749535;43607.34588981231;45335.77332113318;60199.69900150471;62388.37611624007;62428.375716242255;63373;63385.683071584346;8475;8565.700200493202;8664.740057798275;8679.913200868163;9019.413738107001;9237.12247336502;9258.861117083114;9726.854097188407;12436.689082773004;12610.306433146265;11042.889571104186;11112.722181945515;11386.829197561878;11536.59621913229;11650.88349116532;10985.670429887115;11061.5022323994;11090.667279981613;11186.32882027081;11283.13091490492;11620.5351785931;11665.533378664759;11667.474963626826;11792.646220613395;11994.940025299818;7578.810529736801;7991.520508769492;8080.63637136342;8292.917070829215;8838.602262898057;10926.399048052433;12154.513819447124;12183.329916854304;12196.451159698012;12259.754804903674 23:15:56 INFO - PROCESS | 28048 | |3;mootools.html;1499.3702644889145;1508.8868334874883;1669.1821007706228;1761.38351576948;1832.7525784019163;8055.234752698499;8139;8721.520316382597;8756;8780.341474389423;8748.8687669685;8967.058458861824;9096.317776166781;9098.31762617803;9124.589393477292;2323.152049501932;2364.196173301077;2366.7988221001237;2380.833341666084;2382.0709923129994;2357.127862690807;2364.527094581082;2383.2492764779126;2400.12395475651;2409.1567951217107;2316.837821352506;2317.073170731704;2339.7426283108844;2356.634721618152;2367.4318163640773;2252.155441709359;2273.238465114189;2294.736105347881;2300.6664033715183;2350.2126787526026;2327.185485080225;2334.3813889319345;2358.3396648938324;2360.634101714237;2368.526294741059;9029.864552031724;9087.954560227157;9135.451872887581;9173.128552787475;9192.816143677155;5086.694798312114;5306.681599104066;5343.412224655285;5353.652012619206;5358.035553600351;3419.7777144485776;3517.6834084932225;3596.2627661329366;3596.9100772480638;3648.1062139775927;1131.8528591283164;1154.1516985016005;1156.849609550753;1179.286531648349;1209.0931801149138;12902.35488225585;12937.417816198295;12941.158824676366;12943.22340659554;12944.935275323658;4621.653375996813;4659.930101048487;4680.087382960358;4693.507181745936;4835.032993401263;10824.13406927444;10840.295380800222;10851.837222441669;10859.511321990529;10877.728056798644;5498.230247765316;5499.835004949858;5502.9174562381595;5503.972480137654;5505.614606977473;4328.242557552416;4642.837500687459;4755.976220118877;4773.09311230865;5016.097102521581;4028.798560071985;4062.5937406259727;4117.814698338582;4143.357779544175;4164.729292595972;1308.5550912689732;1330.4678128748578;1340.6581321762887;1342.3154191362476;1347.5889853594747;878.6485405837716;879.5162660536807;940.4216406909838;960.9663661771945;975.9512024398751;5929.584929055011;6246.281677607042;6255.311915689271;6256.562040657111;6262.091996660459;449.7076900014951;452.2944207037033;463.6267804417409;464.7560030983693;473.01612645696866;4233.280342341809;4291.892702682396;4301.78491075445;4339.34909763538;4353.412289340962;11015.504302306415;11270.267432616854;11290.661280161608;11362.375069371099;11368.602098926498;11144.442777861075;11158.107351411867;11249.156313276537;11265.831012534818;11266.943665281786;8194.959025204837;8409;8410.663573457115;8446.070932197454;8526;6003.159557661844;6009.759609615567;6065.090236464565;6097.329293777592;6125;10290.845637315297;10403.843942341022;10421;10520.263581549218;10525.315854469742;10300.175985921258;10461.895381046397;10798.946005270238;10804.567817287221;10808.675739727822;7248.96375518119;7806.765797026098;8023.759287221393;8062.7581172564915;8153.918460815553;8898.976617689048;8906.73279801607;8926.464412135292;9028.142326478974;9036.638534458549;7556.168821429748;7910.762677119696;8073.798155045936;8085.312748416215;8233.423660343718;7593.620318984139;7671.38628909697;7740.1098873628;7749.7675069748;7897.447178697436;7218.675159617935;7262.346388825031;7278.126624805057;7296.96351518239;7314.08573928259;5280.260763493191;5350.598705097211;5375.543078838343;5456.809011684572;5541.473560011793;5401.513863752281;5452.727363631723;5460.126379779216;5477.370102438112;5480.835574932758 23:15:56 INFO - PROCESS | 28048 | |4;prototype.html;340.4518724852986;346.0466415026603;347.7913252048771;352.9153003279214;354.3161697923009;5585.888282234353;5619.971900140504;5621.859453513664;5625.859353516164;5632.577556683244;5495.807646732365;5508.256385387971;5533.806316778913;5538.47384498472;5539.750711217995;4158.251514727355;4234.407182994383;4327.221100201962;4333.761643109628;4367.781610919441;4346.456692913386;4377.781110944456;4385.320275357309;4394.560543945596;4399.582039706239;4292.248856450125;4337.522872484024;4369.169857727037;4384.123175364924;4389.934150987738;4227.450431443924;4333.631641310492;4341.370501277297;4341.761203133827;4342.630876375511;3830.80845957701;3831.348670725983;3847.211321679049;3860.575336712959;3873.283442563135;5392.865178370533;5424.972875135639;5454.154606036071;5516.200150978086;5517.475839795213;4846.975765121187;4937.111319962405;4972.950270497321;5033.974830125862;5077;5787.482445136337;5799.159121927339;5877.853818505393;5900;5916.97041514794;4229.36559516072;4241.1941731071;4241.893952651178;4248.723832950879;4259.87220383389;6001.879962400772;6050.610009046446;6054.364291749347;6088.847778805521;6146.1395404642935;4314.417553630283;4319.762413067311;4338.609525142752;4349.869034051169;4356.259435895842;4349.499422699164;4359.8228478310675;4390.385346051556;4391.626711729475;4405.493368262691;4688.882777930579;4934.383202099738;4939.481354457802;4964.8758781030765;4976.527229913225;6007.699615019232;6010.0083486224285;6034.818955431344;6038.245219347582;6058.242719660043;1477.6158198868156;1484.3097959448908;1488.9404423822925;1490.8658220759967;1491.843356447579;926.4672813132341;943.9852158929178;990.8018396320765;996.8454889492141;1020.5101551255439;5750.5112065474905;5750.6262092963825;5758.510526605201;5795.275590551181;5845.941540584539;6052.394760523913;6062.939370606237;6129.172561704202;6201.937980620226;6206.906896396557;5649.576281778883;5670.2705674769595;5733.168690539848;5747.39652336507;5749.568782341341;3241.286916878283;3245.6916592923635;3247.1882029492626;3265.265315304085;3286.1784553861535;6054.062699936067;6158.753649853956;6243.500519958392;6245.28179259391;6246.531510136667;6086.786962456293;6128.26460824695;6145.293291271471;6145.938540614537;6158;6105.297890742532;6324.683765811691;6341.239051313872;6363.981762917911;6372.808815735535;6047.820674968515;6061;6088.786892458743;6094.611879446791;6112.908306375497;5995.100734889801;6042.637441753509;6059.212302400836;6061.636301821904;6063.818085457443;5955.344912059757;6144.662043587646;6278.927953775152;6323.36766323364;6335.208098987627;4299.161663475592;4305.56944305567;4307.676924230633;4322.1787860307695;4339.566043395762;5835.241418615553;6050.183225264533;6053.334133245427;6053.424924632153;6165.784197553064;5857.26784151981;5863.384344643751;5864.67744274069;5879.235699359056;5892.469677729025;5852.912206316993;5860.2967643883;5882.205902203148;5911.349751527415;5914.260717410324;5659.915101273402;5674.631148975303;5723.627964182315;5909.349971503218;5916.230889984275;5973.044312909914;6036.7887123952205;6037.78867739627;6048.758049677964;6067.0282158299615;5549.5837812165055;5935.100767754449;5961.91057134152;5975.820725378246;5989.861926234002 23:15:56 INFO - PROCESS | 28048 | |5;yui.html;732.7545272333768;734.7648752399234;795.8010497375656;798.9880151797722;845.6617353058775;13721.176729396218;13743.106698064645;13759.380827862746;13759.380827862758;13857.237851918153;13929.512467063654;14313.069650472711;14369.712605747878;14597.27013649316;14663.486777962773;820.6676296100075;826.1696994520498;829.5147338806805;830.6386721776047;832.8792325112855;814.9714759983402;817.3134566963749;824.2458150792019;824.8226631274305;825.6944930375739;848.3298194426395;855.6962278391175;859.2481578618708;859.3812455032398;859.6045818923303;850.961706723199;851.7955690634203;852.8763329317276;854.1543871567166;855.1662129423793;612.7671484835734;617.5306766857221;619.201230412767;620.5594028239955;623.4544773323342;13004.479820807157;13970.650733731636;14030.017898747092;14070.648233794134;14142.646433839134;12386.81419778704;12816.359182040955;13043.413046412934;13181.472741090345;13334;10634.680959571226;10718.249722519427;10736.463176841205;10879.945600272027;10910.945445272802;3690.0959264979983;3713.1830997180577;3735.4396840473873;3742.6818720408796;3767.8492860285555;63412;64488.67755661238;65264;66378.3362166377;66977.33022669809;10256.948715256525;10307.484625768682;10334.793304133875;10414.635487757892;11163.274387164809;20120;20282.290119845733;20317.390478285673;20443.4889127773;20470.18119275242;7680.769576912589;7837.412194085467;7861.921380786233;7891.763247102596;8035.718749843727;4586.151561961048;4629.745364004944;4644.303354496852;4711.646626502958;4814.927776083362;3431.227973705896;3484.581850177995;3493.8602455901478;3508.736844736655;3513.0865974846724;658.8188248231775;661.7915356662636;664.9332089478111;671.1342368344781;687.1788213085315;680.4114441008492;744.5495475237511;748.9325960663457;760.5778792769955;773.2306355176635;8852.911470885338;8974.730758077269;9103.772405689911;9177.311701622404;9259.814803704023;722.8012296618472;736.2527035059419;742.5507567921438;752.4845480845638;756.7805336452367;4463.62059224963;4565.246734288805;4610.884727881829;4616.76916154191;4633.397658304399;72423.63788181025;72879.27120728725;73457;77278.61360693161;77477;63291.683541581995;64013.35986640167;64538;68107;69257.30742692508;59649;60002.69998650066;60018.09972850411;60666.393336066954;62436;9459.716208513755;9579.233661307218;9664.71005869825;9675.806483870143;9709.36889102206;38843.223135536566;39307.6069239304;40102.39846402248;40194.39708404318;40880.79559602183;48529.27206091841;51516.93932242818;53555.92888142293;53757;54619.18071228855;10984.340939543654;11198.552057917592;11417.657470275904;11716.94141529287;11739.178257521891;12077.456514457046;12326.630201093982;12461.688457788629;12598.181118227652;12783.16909400886;11498.425078745862;11791.646250612495;12150;12763.361831908182;12841.165324253894;11651.184417090722;12131.45408456604;12297;12461.376931153225;13082.607521774362;11913.344766037952;12079.939600302294;12265.754684906431;12584.119111662096;12859.292738899076;9614.855777163208;9774.609015639295;10178.592856285666;10683.25217234786;10689.9465502672;10284.228682848667;10702.946485267525;10911.78176436451;10926.562937482411;10929.234953553176 23:15:56 INFO - PROCESS | 28048 | __end_tp_report 23:15:56 INFO - PROCESS | 28048 | __start_cc_report 23:15:56 INFO - PROCESS | 28048 | _x_x_mozilla_cycle_collect,345 23:15:56 INFO - PROCESS | 28048 | __end_cc_report 23:15:56 INFO - PROCESS | 28048 | __startTimestamp1464329756106__endTimestamp 23:15:56 INFO - PROCESS | 28048 | 23:15:56 INFO - PROCESS | 28048 | ------- Summary: start ------- 23:15:56 INFO - PROCESS | 28048 | Number of tests: 6 23:15:56 INFO - PROCESS | 28048 | 23:15:56 INFO - PROCESS | 28048 | [#0] dojo.html Cycles:165 Average:5440.59 Median:5664.09 stddev:732.65 (12.9%) stddev-sans-first:711.21 23:15:56 INFO - PROCESS | 28048 | Values: 3084.6 3186.4 3189.6 3191.4 3226.4 5457.7 5497.9 5509.5 5510.9 5537.2 5397.9 5404.1 5449.9 5505.9 5510.2 4882.2 4929.1 5062.6 5075.9 5134.5 732.4 4909.9 4958.4 5046.3 5051.5 4993.6 4996.3 5004.1 5005.9 5010.2 5024.4 5024.9 5044.7 5046.1 5049.4 4917.6 4943.8 4984.1 4989.6 4995.3 5384.5 5418.8 5426.2 5449.1 5449.4 5664.1 5716.7 5888.4 5893.4 5924.8 5919.1 5952.4 5954.3 5956.3 6009.4 5561.9 5566.1 5574.9 5575.8 5576.2 5893.3 5995.7 6087.9 6092.9 6098.3 5672.2 5723.5 5730.1 5733.3 5847.1 5826.3 5869.6 5871.4 5872.0 5877.0 5831.9 5866.3 5878.9 5881.7 5884.2 5874.7 5892.3 5896.7 5930.3 5932.1 4480.0 4482.9 4484.1 4487.7 4496.1 3883.4 3891.6 3935.1 3954.1 3987.3 5660.4 5668.2 5671.6 5674.9 5758.5 6013.8 6049.1 6058.3 6059.4 6064.9 5533.1 5556.6 5610.1 5634.5 5655.9 5002.0 5052.1 5057.5 5059.1 5075.7 5935.4 6087.8 6093.2 6096.5 6103.9 5819.2 5862.1 5873.6 5909.6 5941.2 6066.5 6092.2 6092.8 6097.9 6117.8 5671.9 5714.2 5729.1 5755.8 5835.4 5980.3 6013.5 6021.3 6038.2 6049.3 5785.2 5831.9 5842.2 5861.5 5874.5 5593.4 5615.2 5630.8 5832.5 5833.8 5531.4 5553.6 5560.6 5589.6 5591.4 5710.8 5717.8 5735.3 5737.0 5752.3 5501.9 5602.1 5652.5 5663.7 5704.9 23:15:56 INFO - PROCESS | 28048 | 23:15:56 INFO - PROCESS | 28048 | [#1] ext.html Cycles:180 Average:58789.61 Median:231678.39 stddev:115996.71 (50.1%) stddev-sans-first:116239.75 23:15:56 INFO - PROCESS | 28048 | Values: 570.7 620.5 622.2 641.7 641.7 31860.7 43237.6 43911.1 44072.6 44258.3 43827.0 43915.1 44173.8 44181.8 44182.1 8706.7 8941.0 8943.8 8953.6 8964.3 8726.5 8819.6 8871.7 8873.7 8882.6 8886.0 8936.9 8938.4 8951.7 8960.6 8860.1 8876.8 8901.0 8936.5 8967.8 8820.2 8884.3 8890.7 8909.6 8918.0 42274.0 42728.6 42769.4 42769.4 42869.6 3462.7 3722.5 3761.5 4011.2 4011.7 33260.5 33485.7 33654.7 33971.3 34680.5 4379.5 4392.0 4400.0 4426.0 4469.4 367168.0 368493.0 369487.0 369703.2 371858.0 32140.8 33675.0 57990.0 58571.0 58686.7 36036.0 36092.9 36188.6 36334.5 36493.3 15193.2 15375.4 15384.9 15440.9 15490.1 12988.2 13003.8 13052.9 13095.2 13117.5 8382.0 8403.2 8424.5 8497.9 8529.8 3210.8 3241.5 3263.3 3265.7 3310.3 1038.0 1084.7 1093.9 1111.9 1195.6 33142.0 33914.0 33973.7 33975.0 34220.5 1096.3 1175.8 1190.5 1197.1 1211.4 17416.8 17547.5 17693.0 17698.7 17705.5 507543.0 508928.0 512713.2 512978.0 516995.0 60071.7 60083.0 60937.4 60952.0 61044.4 1351.7 1392.1 1392.5 1398.1 1409.3 30513.4 33093.0 33516.7 33714.7 33784.8 51842.0 52340.2 52582.7 52699.0 52787.5 417196.0 419262.0 420445.0 421145.0 421169.0 28618.7 28744.6 28858.6 29859.7 29908.3 49876.0 49895.8 50323.5 50441.0 50523.0 41388.6 42900.6 43024.0 43053.6 43212.6 41987.2 42187.8 42241.8 42881.0 43109.4 40865.0 42199.8 42330.0 42689.4 44924.0 33564.0 37423.3 37910.0 39697.6 40394.6 29108.4 29121.0 29266.7 29674.3 29837.0 23:15:56 INFO - PROCESS | 28048 | 23:15:56 INFO - PROCESS | 28048 | [#2] jquery.html Cycles:180 Average:29294.99 Median:2341.96 stddev:83547.94 (3567.4%) stddev-sans-first:83754.14 23:15:56 INFO - PROCESS | 28048 | Values: 400.9 407.6 409.2 409.8 418.5 13644.8 17591.8 18617.6 19379.9 19451.2 18681.3 18858.2 18981.1 19765.2 19903.4 5676.9 5780.3 5896.7 5899.7 5948.9 5806.4 5807.6 5829.4 5854.1 5874.5 5811.5 5965.4 6257.8 6311.1 6416.9 5251.4 5582.3 5590.4 6348.8 6358.1 5302.8 5464.0 5488.7 5498.9 5780.8 14285.5 14309.9 14477.7 14479.7 19662.7 2167.9 2302.9 2307.8 2376.1 2547.1 10637.3 10651.1 10686.5 10908.1 14791.0 1935.3 1977.6 1991.3 2003.6 2027.2 81556.0 84562.6 86060.0 86608.1 87019.0 10603.8 10650.8 10812.1 11017.8 11988.2 15368.4 15436.1 15453.7 15484.5 15542.3 7839.2 8027.0 8086.7 8173.6 8176.7 7601.0 7633.2 7687.9 7762.2 7780.6 4710.8 4718.5 4733.9 4808.4 4827.3 2024.0 2035.4 2076.1 2082.4 2138.8 1002.9 1008.8 1059.3 1068.2 1087.9 17015.0 18311.0 19339.6 19554.9 19813.9 1028.3 1044.6 1060.2 1087.0 1096.3 10464.4 11009.2 11025.1 11046.9 11084.3 503790.0 504817.1 505184.0 508531.0 511892.0 60215.7 78942.6 93607.0 96349.5 98076.5 959.2 964.7 978.1 996.1 1012.1 17550.8 17681.8 18193.6 18300.9 18472.6 41733.4 43001.4 43328.4 43607.3 45335.8 60199.7 62388.4 62428.4 63373.0 63385.7 8475.0 8565.7 8664.7 8679.9 9019.4 9237.1 9258.9 9726.9 12436.7 12610.3 11042.9 11112.7 11386.8 11536.6 11650.9 10985.7 11061.5 11090.7 11186.3 11283.1 11620.5 11665.5 11667.5 11792.6 11994.9 7578.8 7991.5 8080.6 8292.9 8838.6 10926.4 12154.5 12183.3 12196.5 12259.8 23:15:56 INFO - PROCESS | 28048 | 23:15:56 INFO - PROCESS | 28048 | [#3] mootools.html Cycles:180 Average:5963.26 Median:2553.80 stddev:3441.65 (134.8%) stddev-sans-first:3434.95 23:15:56 INFO - PROCESS | 28048 | Values: 1499.4 1508.9 1669.2 1761.4 1832.8 8055.2 8139.0 8721.5 8756.0 8780.3 8748.9 8967.1 9096.3 9098.3 9124.6 2323.2 2364.2 2366.8 2380.8 2382.1 2357.1 2364.5 2383.2 2400.1 2409.2 2316.8 2317.1 2339.7 2356.6 2367.4 2252.2 2273.2 2294.7 2300.7 2350.2 2327.2 2334.4 2358.3 2360.6 2368.5 9029.9 9088.0 9135.5 9173.1 9192.8 5086.7 5306.7 5343.4 5353.7 5358.0 3419.8 3517.7 3596.3 3596.9 3648.1 1131.9 1154.2 1156.8 1179.3 1209.1 12902.4 12937.4 12941.2 12943.2 12944.9 4621.7 4659.9 4680.1 4693.5 4835.0 10824.1 10840.3 10851.8 10859.5 10877.7 5498.2 5499.8 5502.9 5504.0 5505.6 4328.2 4642.8 4756.0 4773.1 5016.1 4028.8 4062.6 4117.8 4143.4 4164.7 1308.6 1330.5 1340.7 1342.3 1347.6 878.6 879.5 940.4 961.0 976.0 5929.6 6246.3 6255.3 6256.6 6262.1 449.7 452.3 463.6 464.8 473.0 4233.3 4291.9 4301.8 4339.3 4353.4 11015.5 11270.3 11290.7 11362.4 11368.6 11144.4 11158.1 11249.2 11265.8 11266.9 8195.0 8409.0 8410.7 8446.1 8526.0 6003.2 6009.8 6065.1 6097.3 6125.0 10290.8 10403.8 10421.0 10520.3 10525.3 10300.2 10461.9 10798.9 10804.6 10808.7 7249.0 7806.8 8023.8 8062.8 8153.9 8899.0 8906.7 8926.5 9028.1 9036.6 7556.2 7910.8 8073.8 8085.3 8233.4 7593.6 7671.4 7740.1 7749.8 7897.4 7218.7 7262.3 7278.1 7297.0 7314.1 5280.3 5350.6 5375.5 5456.8 5541.5 5401.5 5452.7 5460.1 5477.4 5480.8 23:15:56 INFO - PROCESS | 28048 | 23:15:56 INFO - PROCESS | 28048 | [#4] prototype.html Cycles:180 Average:4972.64 Median:5699.13 stddev:1472.89 (25.8%) stddev-sans-first:1435.40 23:15:56 INFO - PROCESS | 28048 | Values: 340.5 346.0 347.8 352.9 354.3 5585.9 5620.0 5621.9 5625.9 5632.6 5495.8 5508.3 5533.8 5538.5 5539.8 4158.3 4234.4 4327.2 4333.8 4367.8 4346.5 4377.8 4385.3 4394.6 4399.6 4292.2 4337.5 4369.2 4384.1 4389.9 4227.5 4333.6 4341.4 4341.8 4342.6 3830.8 3831.3 3847.2 3860.6 3873.3 5392.9 5425.0 5454.2 5516.2 5517.5 4847.0 4937.1 4973.0 5034.0 5077.0 5787.5 5799.2 5877.9 5900.0 5917.0 4229.4 4241.2 4241.9 4248.7 4259.9 6001.9 6050.6 6054.4 6088.8 6146.1 4314.4 4319.8 4338.6 4349.9 4356.3 4349.5 4359.8 4390.4 4391.6 4405.5 4688.9 4934.4 4939.5 4964.9 4976.5 6007.7 6010.0 6034.8 6038.2 6058.2 1477.6 1484.3 1488.9 1490.9 1491.8 926.5 944.0 990.8 996.8 1020.5 5750.5 5750.6 5758.5 5795.3 5845.9 6052.4 6062.9 6129.2 6201.9 6206.9 5649.6 5670.3 5733.2 5747.4 5749.6 3241.3 3245.7 3247.2 3265.3 3286.2 6054.1 6158.8 6243.5 6245.3 6246.5 6086.8 6128.3 6145.3 6145.9 6158.0 6105.3 6324.7 6341.2 6364.0 6372.8 6047.8 6061.0 6088.8 6094.6 6112.9 5995.1 6042.6 6059.2 6061.6 6063.8 5955.3 6144.7 6278.9 6323.4 6335.2 4299.2 4305.6 4307.7 4322.2 4339.6 5835.2 6050.2 6053.3 6053.4 6165.8 5857.3 5863.4 5864.7 5879.2 5892.5 5852.9 5860.3 5882.2 5911.3 5914.3 5659.9 5674.6 5723.6 5909.3 5916.2 5973.0 6036.8 6037.8 6048.8 6067.0 5549.6 5935.1 5961.9 5975.8 5989.9 23:15:56 INFO - PROCESS | 28048 | 23:15:56 INFO - PROCESS | 28048 | [#5] yui.html Cycles:180 Average:16300.32 Median:4677.97 stddev:20673.24 (441.9%) stddev-sans-first:20698.18 23:15:56 INFO - PROCESS | 28048 | Values: 732.8 734.8 795.8 799.0 845.7 13721.2 13743.1 13759.4 13759.4 13857.2 13929.5 14313.1 14369.7 14597.3 14663.5 820.7 826.2 829.5 830.6 832.9 815.0 817.3 824.2 824.8 825.7 848.3 855.7 859.2 859.4 859.6 851.0 851.8 852.9 854.2 855.2 612.8 617.5 619.2 620.6 623.5 13004.5 13970.7 14030.0 14070.6 14142.6 12386.8 12816.4 13043.4 13181.5 13334.0 10634.7 10718.2 10736.5 10879.9 10910.9 3690.1 3713.2 3735.4 3742.7 3767.8 63412.0 64488.7 65264.0 66378.3 66977.3 10256.9 10307.5 10334.8 10414.6 11163.3 20120.0 20282.3 20317.4 20443.5 20470.2 7680.8 7837.4 7861.9 7891.8 8035.7 4586.2 4629.7 4644.3 4711.6 4814.9 3431.2 3484.6 3493.9 3508.7 3513.1 658.8 661.8 664.9 671.1 687.2 680.4 744.5 748.9 760.6 773.2 8852.9 8974.7 9103.8 9177.3 9259.8 722.8 736.3 742.6 752.5 756.8 4463.6 4565.2 4610.9 4616.8 4633.4 72423.6 72879.3 73457.0 77278.6 77477.0 63291.7 64013.4 64538.0 68107.0 69257.3 59649.0 60002.7 60018.1 60666.4 62436.0 9459.7 9579.2 9664.7 9675.8 9709.4 38843.2 39307.6 40102.4 40194.4 40880.8 48529.3 51516.9 53555.9 53757.0 54619.2 10984.3 11198.6 11417.7 11716.9 11739.2 12077.5 12326.6 12461.7 12598.2 12783.2 11498.4 11791.6 12150.0 12763.4 12841.2 11651.2 12131.5 12297.0 12461.4 13082.6 11913.3 12079.9 12265.8 12584.1 12859.3 9614.9 9774.6 10178.6 10683.3 10689.9 10284.2 10702.9 10911.8 10926.6 10929.2 23:15:56 INFO - PROCESS | 28048 | -------- Summary: end -------- 23:15:56 INFO - PROCESS | 28048 | 23:15:56 INFO - TEST-INFO | 28048: exit 0 23:15:56 INFO - TEST-OK | dromaeo_css | took 1110231ms 23:15:56 INFO - TEST-START | kraken 23:15:56 INFO - operating with platform_type : linux_ 23:15:56 INFO - Initialising browser for kraken test... 23:15:56 INFO - TEST-INFO | started process 28282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3EO1kw/profile http://localhost:57770/getInfo.html) 23:16:00 INFO - PROCESS | 28282 | 23:16:00 INFO - PROCESS | 28282 | (process:28352): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:16:01 INFO - PROCESS | 28282 | __metrics Screen width/height:1600/1200 23:16:01 INFO - PROCESS | 28282 | colorDepth:24 23:16:01 INFO - PROCESS | 28282 | Browser inner width/height: 1024/697 23:16:01 INFO - PROCESS | 28282 | __metrics 23:16:01 ERROR - PROCESS | 28282 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:16:02 INFO - TEST-INFO | 28282: exit 0 23:16:02 INFO - Browser initialized. 23:16:02 INFO - Running cycle 1/1 for kraken test... 23:16:02 INFO - TEST-INFO | started process 28403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3EO1kw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:16:04 INFO - PROCESS | 28403 | 23:16:04 INFO - PROCESS | 28403 | (process:28464): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:16:14 INFO - PROCESS | 28403 | RSS: Main: 166653952 23:16:14 INFO - PROCESS | 28403 | 23:16:17 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57770/tests/kraken/driver.html?testName=audio-beat-detection) 23:16:17 INFO - PROCESS | 28403 | RSS: Main: 172027904 23:16:17 INFO - PROCESS | 28403 | 23:16:20 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57770/tests/kraken/driver.html?testName=audio-dft) 23:16:21 INFO - PROCESS | 28403 | RSS: Main: 171397120 23:16:21 INFO - PROCESS | 28403 | 23:16:24 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57770/tests/kraken/driver.html?testName=audio-fft) 23:16:24 INFO - PROCESS | 28403 | RSS: Main: 166293504 23:16:24 INFO - PROCESS | 28403 | 23:16:26 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57770/tests/kraken/driver.html?testName=audio-oscillator) 23:16:27 INFO - PROCESS | 28403 | RSS: Main: 167153664 23:16:27 INFO - PROCESS | 28403 | 23:16:29 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:16:30 INFO - PROCESS | 28403 | RSS: Main: 167170048 23:16:30 INFO - PROCESS | 28403 | 23:16:33 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57770/tests/kraken/driver.html?testName=imaging-darkroom) 23:16:33 INFO - PROCESS | 28403 | RSS: Main: 167182336 23:16:33 INFO - PROCESS | 28403 | 23:16:37 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57770/tests/kraken/driver.html?testName=imaging-desaturate) 23:16:37 INFO - PROCESS | 28403 | RSS: Main: 167526400 23:16:37 INFO - PROCESS | 28403 | 23:16:40 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57770/tests/kraken/driver.html?testName=json-parse-financial) 23:16:41 INFO - PROCESS | 28403 | RSS: Main: 168472576 23:16:41 INFO - PROCESS | 28403 | 23:16:42 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:16:43 INFO - PROCESS | 28403 | RSS: Main: 167849984 23:16:43 INFO - PROCESS | 28403 | 23:16:45 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57770/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:16:45 INFO - PROCESS | 28403 | RSS: Main: 168017920 23:16:45 INFO - PROCESS | 28403 | 23:16:48 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:16:48 INFO - PROCESS | 28403 | RSS: Main: 168448000 23:16:48 INFO - PROCESS | 28403 | 23:16:51 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:16:51 INFO - PROCESS | 28403 | RSS: Main: 168108032 23:16:51 INFO - PROCESS | 28403 | 23:16:54 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:16:55 INFO - PROCESS | 28403 | RSS: Main: 167862272 23:16:55 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | Cycle 1(1): loaded http://localhost:57770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57770/tests/kraken/driver.html?testName=ai-astar) 23:16:57 INFO - PROCESS | 28403 | RSS: Main: 168976384 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | __start_tp_report 23:16:57 INFO - PROCESS | 28403 | _x_x_mozilla_page_load 23:16:57 INFO - PROCESS | 28403 | _x_x_mozilla_page_load_details 23:16:57 INFO - PROCESS | 28403 | |i|pagename|runs| 23:16:57 INFO - PROCESS | 28403 | |0;ai-astar;112;107;111;112;112;112;112;113;114;111 23:16:57 INFO - PROCESS | 28403 | |1;audio-beat-detection;152;125;160;171;132;163;160;125;178;127 23:16:57 INFO - PROCESS | 28403 | |2;audio-dft;162;163;162;161;163;165;169;162;162;165 23:16:57 INFO - PROCESS | 28403 | |3;audio-fft;77;74;74;155;75;77;74;74;161;77 23:16:57 INFO - PROCESS | 28403 | |4;audio-oscillator;84;84;148;83;84;84;146;83;84;155 23:16:57 INFO - PROCESS | 28403 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;118;118 23:16:57 INFO - PROCESS | 28403 | |6;imaging-darkroom;147;146;147;146;146;146;148;146;146;147 23:16:57 INFO - PROCESS | 28403 | |7;imaging-desaturate;100;96;95;96;95;96;95;95;95;95 23:16:57 INFO - PROCESS | 28403 | |8;json-parse-financial;56;54;55;54;54;58;53;55;54;59 23:16:57 INFO - PROCESS | 28403 | |9;json-stringify-tinderbox;60;64;61;62;62;60;61;61;61;62 23:16:57 INFO - PROCESS | 28403 | |10;stanford-crypto-aes;79;78;79;84;85;81;80;81;116;79 23:16:57 INFO - PROCESS | 28403 | |11;stanford-crypto-ccm;122;130;129;124;128;131;129;124;134;134 23:16:57 INFO - PROCESS | 28403 | |12;stanford-crypto-pbkdf2;163;164;159;168;159;162;165;160;161;159 23:16:57 INFO - PROCESS | 28403 | |13;stanford-crypto-sha256-iterative;64;63;64;63;66;63;63;64;62;66 23:16:57 INFO - PROCESS | 28403 | __end_tp_report 23:16:57 INFO - PROCESS | 28403 | __start_cc_report 23:16:57 INFO - PROCESS | 28403 | _x_x_mozilla_cycle_collect,863 23:16:57 INFO - PROCESS | 28403 | __end_cc_report 23:16:57 INFO - PROCESS | 28403 | __startTimestamp1464329817257__endTimestamp 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | ------- Summary: start ------- 23:16:57 INFO - PROCESS | 28403 | Number of tests: 14 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.84 (1.6%) stddev-sans-first:1.94 23:16:57 INFO - PROCESS | 28403 | Values: 112.0 107.0 111.0 112.0 112.0 112.0 112.0 113.0 114.0 111.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:160.00 stddev:20.27 (12.7%) stddev-sans-first:21.47 23:16:57 INFO - PROCESS | 28403 | Values: 152.0 125.0 160.0 171.0 132.0 163.0 160.0 125.0 178.0 127.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.37 (1.5%) stddev-sans-first:2.46 23:16:57 INFO - PROCESS | 28403 | Values: 162.0 163.0 162.0 161.0 163.0 165.0 169.0 162.0 162.0 165.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#3] audio-fft Cycles:10 Average:91.80 Median:74.50 stddev:34.94 (46.9%) stddev-sans-first:36.65 23:16:57 INFO - PROCESS | 28403 | Values: 77.0 74.0 74.0 155.0 75.0 77.0 74.0 74.0 161.0 77.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:84.00 stddev:31.94 (38.0%) stddev-sans-first:33.09 23:16:57 INFO - PROCESS | 28403 | Values: 84.0 84.0 148.0 83.0 84.0 84.0 146.0 83.0 84.0 155.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:16:57 INFO - PROCESS | 28403 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 23:16:57 INFO - PROCESS | 28403 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 148.0 146.0 146.0 147.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.55 (1.6%) stddev-sans-first:0.50 23:16:57 INFO - PROCESS | 28403 | Values: 100.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.93 (3.5%) stddev-sans-first:2.03 23:16:57 INFO - PROCESS | 28403 | Values: 56.0 54.0 55.0 54.0 54.0 58.0 53.0 55.0 54.0 59.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:1.17 (1.9%) stddev-sans-first:1.13 23:16:57 INFO - PROCESS | 28403 | Values: 60.0 64.0 61.0 62.0 62.0 60.0 61.0 61.0 61.0 62.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:80.50 stddev:11.40 (14.2%) stddev-sans-first:11.94 23:16:57 INFO - PROCESS | 28403 | Values: 79.0 78.0 79.0 84.0 85.0 81.0 80.0 81.0 116.0 79.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:129.50 stddev:4.12 (3.2%) stddev-sans-first:3.63 23:16:57 INFO - PROCESS | 28403 | Values: 122.0 130.0 129.0 124.0 128.0 131.0 129.0 124.0 134.0 134.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.50 stddev:3.02 (1.9%) stddev-sans-first:3.18 23:16:57 INFO - PROCESS | 28403 | Values: 163.0 164.0 159.0 168.0 159.0 162.0 165.0 160.0 161.0 159.0 23:16:57 INFO - PROCESS | 28403 | 23:16:57 INFO - PROCESS | 28403 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.32 (2.1%) stddev-sans-first:1.39 23:16:57 INFO - PROCESS | 28403 | Values: 64.0 63.0 64.0 63.0 66.0 63.0 63.0 64.0 62.0 66.0 23:16:57 INFO - PROCESS | 28403 | -------- Summary: end -------- 23:16:57 INFO - PROCESS | 28403 | 23:16:58 INFO - TEST-INFO | 28403: exit 0 23:16:58 INFO - TEST-OK | kraken | took 61441ms 23:16:58 INFO - SUITE-END | took 1171s 23:16:58 INFO - Completed test suite (00:19:31) 23:16:58 INFO - javascript benchmark 23:16:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7188.661429015003, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.6452657944337, 3186.3627274545083, 3189.585353903995, 3191.441497737896, 3226.4192445359827, 5457.672539647624, 5497.890042199154, 5509.476599723025, 5510.91733623996, 5537.224788529599, 5397.946020539794, 5404.054290499157, 5449.918251226235, 5505.944940550593, 5510.173473978895, 4882.218844984812, 4929.088118698034, 5062.569681577071, 5075.9492405076035, 5134.512221338967, 732.361242331821, 4909.926351104737, 4958.380202474691, 5046.343975283226, 5051.469595692454, 4993.575546078588, 4996.250562415648, 5004.12427825131, 5005.924911126336, 5010.173321401982, 5024.4473107958465, 5024.874378140576, 5044.747762611892, 5046.116929537353, 5049.394072711261, 4917.606591472673, 4943.826966056171, 4984.102861484931, 4989.57588604969, 4995.325631039799, 5384.515393614554, 5418.83743487696, 5426.158945363475, 5449.073657478239, 5449.427810079964, 5664.0937450007805, 5716.71416429181, 5888.352281249059, 5893.410658934073, 5924.822255332347, 5919.052951527735, 5952.375000624916, 5954.255718035246, 5956.255468066492, 6009.369016253318, 5561.944380556223, 5566.137248726453, 5574.944250557523, 5575.832725018216, 5576.247206627094, 5893.3222679391565, 5995.730192141364, 6087.908681369783, 6092.908606370908, 6098.32918378978, 5672.177534257509, 5723.484886360165, 5730.083186690193, 5733.254676891977, 5847.1229315603, 5826.300843898759, 5869.589128761031, 5871.442212989759, 5871.9706401468575, 5876.970615146983, 5831.912521312183, 5866.325372582208, 5878.941210587925, 5881.676507792027, 5884.205632239678, 5874.676892770939, 5892.322382925932, 5896.734646940898, 5930.318013428425, 5932.110183472428, 4480.0, 4482.932756008662, 4484.1031793641405, 4487.685861989629, 4496.100779844044, 3883.3980732986433, 3891.610838916086, 3935.0752573145287, 3954.149857780591, 3987.302222111177, 5660.433956604306, 5668.234788303609, 5671.574631902624, 5674.858128546819, 5758.539316854642, 6013.789517366871, 6049.062395328731, 6058.303295121029, 6059.424354686298, 6064.9090263646085, 5533.142362933751, 5556.555475561945, 5610.102383618601, 5634.52106570946, 5655.886882262414, 5001.974990125026, 5052.141136006888, 5057.519535644108, 5059.139946209153, 5075.720835354091, 5935.436133567304, 6087.756489740449, 6093.207882975274, 6096.512279017757, 6103.908441373383, 5819.214406055128, 5862.091375836752, 5873.559483038704, 5909.6158749681135, 5941.168236446814, 6066.545009124245, 6092.238470191226, 6092.756289748538, 6097.871893699502, 6117.807027629569, 5671.914921276101, 5714.171445140349, 5729.1119876419225, 5755.798547050833, 5835.416458354131, 5980.282366116094, 6013.548983826318, 6021.277446706424, 6038.215032045981, 6049.274087109575, 5785.190073389813, 5831.94168058314, 5842.240508734008, 5861.472467477947, 5874.471297583238, 5593.440655934537, 5615.18579805934, 5630.831075067755, 5832.533397328289, 5833.766649333979, 5531.363893152339, 5553.6390134641115, 5560.638558493685, 5589.5807814413265, 5591.412901645269, 5710.8001219957105, 5717.799877004285, 5735.283089613798, 5736.971315143398, 5752.338481074563, 5501.889962200654, 5602.075657516464, 5652.491275785199, 5663.66018038919, 5704.914426283526], "value": 5391.941228078582, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6845720613986, 620.5376994139366, 622.1911515030462, 641.67595364341, 641.6919878458343, 31860.68139318606, 43237.56762432375, 43911.12177756451, 44072.55927440725, 44258.33612495815, 43827.0, 43915.12169756611, 44173.77913110438, 44181.77909110458, 44182.11635767283, 8706.65173393065, 8940.955295223515, 8943.821123577525, 8953.552322383888, 8964.327675424336, 8726.476411415304, 8819.559022048905, 8871.68949086782, 8873.68942087027, 8882.555872206396, 8885.95557022214, 8936.910630893673, 8938.4190027648, 8951.731448056536, 8960.641574337018, 8860.069692682273, 8876.778080547974, 8901.02088770238, 8936.508492032935, 8967.820643587156, 8820.2061814437, 8884.333674974403, 8890.73327800167, 8909.643614255421, 8918.0, 42274.0, 42728.57271427308, 42769.35845962313, 42769.35845962313, 42869.57130428687, 3462.6593897050616, 3722.4788529605876, 3761.492198553188, 4011.197760447893, 4011.7392369495888, 33260.50109248363, 33485.665143348495, 33654.6634533654, 33971.32057358839, 34680.479792803126, 4379.474463064421, 4391.956080439219, 4399.978000110011, 4425.977870110629, 4469.396631454744, 367168.0, 368493.0, 369487.0, 369703.1514842436, 371858.0, 32140.839295803373, 33675.0, 57990.0, 58571.0, 58686.70656646689, 36036.0, 36092.91721248367, 36188.638113619054, 36334.454983175274, 36493.27013459716, 15193.164375959208, 15375.384984600714, 15384.923075384551, 15440.922795385952, 15490.148041857581, 12988.155769874928, 13003.804942925864, 13052.934735326262, 13095.214287142802, 13117.540886068942, 8381.958090209631, 8403.243708066304, 8424.536650484282, 8497.915020849712, 8529.786755331043, 3210.775245732823, 3241.5299781531544, 3263.3473305339026, 3265.689759472846, 3310.2551925816497, 1037.9740506487246, 1084.7125511739396, 1093.9443437083253, 1111.8999290063932, 1195.6413076077142, 33142.0, 33914.0, 33973.66026339705, 33975.0, 34220.48669269963, 1096.2819353323587, 1175.8059920113258, 1190.4523918997186, 1197.1260979485025, 1211.3700875544666, 17416.82583174152, 17547.47357579275, 17693.0, 17698.734518982226, 17705.468835934684, 507543.0, 508928.0, 512713.23720576137, 512978.0, 516995.0, 60071.69964150151, 60083.0, 60937.39062609406, 60952.0, 61044.38955610387, 1351.7228968061524, 1392.1299188007495, 1392.4778208172138, 1398.1121987537783, 1409.3023953143054, 30513.38973220479, 33093.0, 33516.664833352326, 33714.662853371156, 33784.831075844464, 51842.0, 52340.21489677734, 52582.73708631432, 52699.0, 52787.472125278255, 417196.0, 419262.0, 420445.0, 421145.0, 421169.0, 28618.713812861606, 28744.568831467128, 28858.567121493616, 29859.70140298569, 29908.252293692833, 49876.0, 49895.75052124716, 50323.49676503335, 50441.0, 50523.0, 41388.586114138474, 42900.57099429091, 43024.0, 43053.56946430621, 43212.567874320855, 41987.1602567953, 42187.7890610545, 42241.78879105585, 42881.0, 43109.35335970025, 40865.0, 42199.7890010548, 42330.0, 42689.35965960451, 44924.0, 33564.0, 37423.25153496969, 37910.0, 39697.60302397054, 40394.59605403908, 29108.417831643674, 29121.0, 29266.70733292725, 29674.258143546584, 29837.0], "value": 19224.838443106106, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.90578714002214, 407.64534854676435, 409.1898041877083, 409.8258240247896, 418.4998926283091, 13644.795328070088, 17591.82408175918, 18617.627647447043, 19379.903100484495, 19451.221951121974, 18681.346152884653, 18858.151383187756, 18981.14584843682, 19765.209391624354, 19903.40289791305, 5676.943230567683, 5780.335261444925, 5896.734646940877, 5899.734511946951, 5948.851278718045, 5806.419358064202, 5807.622504537213, 5829.387914269004, 5854.092615644582, 5874.471297583216, 5811.535077193836, 5965.3736357682255, 6257.843553911166, 6311.147995020682, 6416.871662566746, 5251.422343542226, 5582.330120385539, 5590.440955904418, 6348.841278968017, 6358.141650877142, 5302.814401495968, 5464.016477034133, 5488.69812160331, 5498.917516237259, 5780.826575202708, 14285.500007499688, 14309.928450357682, 14477.71044579113, 14479.710405791931, 19662.70505942412, 2167.924122655715, 2302.8503147295373, 2307.8384513084093, 2376.085207195225, 2547.1339744486963, 10637.308574942605, 10651.094656954168, 10686.465676716132, 10908.127349812075, 14791.0, 1935.332310352926, 1977.5945931084093, 1991.2632326039313, 2003.5592169722638, 2027.1992562937558, 81556.0, 84562.57718711367, 86060.0, 86608.13391866126, 87019.0, 10603.787924241473, 10650.786984260272, 10812.135029197645, 11017.779644407226, 11988.22076565038, 15368.385264589515, 15436.073835569678, 15453.690926181413, 15484.458043968407, 15542.300596473186, 7839.176886426957, 8027.03675558925, 8086.7169649062, 8173.591320433955, 8176.713815016446, 7601.0, 7633.2366763323225, 7687.885256637756, 7762.223777622193, 7780.572068536285, 4710.764461776897, 4718.457377401574, 4733.928991065137, 4808.3989501312335, 4827.300041494034, 2023.9696404553943, 2035.4097311779715, 2076.09689784944, 2082.4377418097333, 2138.7968143026387, 1002.9197664186847, 1008.7881544875512, 1059.280085534397, 1068.2415485005733, 1087.8531398261134, 17015.0, 18311.0, 19339.613207735765, 19554.902225488782, 19813.900930495256, 1028.2545154762738, 1044.6343779677052, 1060.204846365226, 1087.0488322717622, 1096.2545469080942, 10464.424456654957, 11009.229353945148, 11025.062869656169, 11046.944765276123, 11084.279521831055, 503790.0, 504817.066518557, 505184.0, 508531.0, 511892.0, 60215.698921505114, 78942.60528697434, 93607.0, 96349.51825240969, 98076.50961745289, 959.203860795538, 964.6912987843823, 978.1490103609905, 996.0885789502669, 1012.089119792193, 17550.822507360102, 17681.823181768017, 18193.636127277645, 18300.90849545797, 18472.630547388708, 41733.37399939064, 43001.3549796747, 43328.350074749535, 43607.34588981231, 45335.77332113318, 60199.69900150471, 62388.37611624007, 62428.375716242255, 63373.0, 63385.683071584346, 8475.0, 8565.700200493202, 8664.740057798275, 8679.913200868163, 9019.413738107001, 9237.12247336502, 9258.861117083114, 9726.854097188407, 12436.689082773004, 12610.306433146265, 11042.889571104186, 11112.722181945515, 11386.829197561878, 11536.59621913229, 11650.88349116532, 10985.670429887115, 11061.5022323994, 11090.667279981613, 11186.32882027081, 11283.13091490492, 11620.5351785931, 11665.533378664759, 11667.474963626826, 11792.646220613395, 11994.940025299818, 7578.810529736801, 7991.520508769492, 8080.63637136342, 8292.917070829215, 8838.602262898057, 10926.399048052433, 12154.513819447124, 12183.329916854304, 12196.451159698012, 12259.754804903674], "value": 9168.506042336561, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.3702644889145, 1508.8868334874883, 1669.1821007706228, 1761.38351576948, 1832.7525784019163, 8055.234752698499, 8139.0, 8721.520316382597, 8756.0, 8780.341474389423, 8748.8687669685, 8967.058458861824, 9096.317776166781, 9098.31762617803, 9124.589393477292, 2323.152049501932, 2364.196173301077, 2366.7988221001237, 2380.833341666084, 2382.0709923129994, 2357.127862690807, 2364.527094581082, 2383.2492764779126, 2400.12395475651, 2409.1567951217107, 2316.837821352506, 2317.073170731704, 2339.7426283108844, 2356.634721618152, 2367.4318163640773, 2252.155441709359, 2273.238465114189, 2294.736105347881, 2300.6664033715183, 2350.2126787526026, 2327.185485080225, 2334.3813889319345, 2358.3396648938324, 2360.634101714237, 2368.526294741059, 9029.864552031724, 9087.954560227157, 9135.451872887581, 9173.128552787475, 9192.816143677155, 5086.694798312114, 5306.681599104066, 5343.412224655285, 5353.652012619206, 5358.035553600351, 3419.7777144485776, 3517.6834084932225, 3596.2627661329366, 3596.9100772480638, 3648.1062139775927, 1131.8528591283164, 1154.1516985016005, 1156.849609550753, 1179.286531648349, 1209.0931801149138, 12902.35488225585, 12937.417816198295, 12941.158824676366, 12943.22340659554, 12944.935275323658, 4621.653375996813, 4659.930101048487, 4680.087382960358, 4693.507181745936, 4835.032993401263, 10824.13406927444, 10840.295380800222, 10851.837222441669, 10859.511321990529, 10877.728056798644, 5498.230247765316, 5499.835004949858, 5502.9174562381595, 5503.972480137654, 5505.614606977473, 4328.242557552416, 4642.837500687459, 4755.976220118877, 4773.09311230865, 5016.097102521581, 4028.798560071985, 4062.5937406259727, 4117.814698338582, 4143.357779544175, 4164.729292595972, 1308.5550912689732, 1330.4678128748578, 1340.6581321762887, 1342.3154191362476, 1347.5889853594747, 878.6485405837716, 879.5162660536807, 940.4216406909838, 960.9663661771945, 975.9512024398751, 5929.584929055011, 6246.281677607042, 6255.311915689271, 6256.562040657111, 6262.091996660459, 449.7076900014951, 452.2944207037033, 463.6267804417409, 464.7560030983693, 473.01612645696866, 4233.280342341809, 4291.892702682396, 4301.78491075445, 4339.34909763538, 4353.412289340962, 11015.504302306415, 11270.267432616854, 11290.661280161608, 11362.375069371099, 11368.602098926498, 11144.442777861075, 11158.107351411867, 11249.156313276537, 11265.831012534818, 11266.943665281786, 8194.959025204837, 8409.0, 8410.663573457115, 8446.070932197454, 8526.0, 6003.159557661844, 6009.759609615567, 6065.090236464565, 6097.329293777592, 6125.0, 10290.845637315297, 10403.843942341022, 10421.0, 10520.263581549218, 10525.315854469742, 10300.175985921258, 10461.895381046397, 10798.946005270238, 10804.567817287221, 10808.675739727822, 7248.96375518119, 7806.765797026098, 8023.759287221393, 8062.7581172564915, 8153.918460815553, 8898.976617689048, 8906.73279801607, 8926.464412135292, 9028.142326478974, 9036.638534458549, 7556.168821429748, 7910.762677119696, 8073.798155045936, 8085.312748416215, 8233.423660343718, 7593.620318984139, 7671.38628909697, 7740.1098873628, 7749.7675069748, 7897.447178697436, 7218.675159617935, 7262.346388825031, 7278.126624805057, 7296.96351518239, 7314.08573928259, 5280.260763493191, 5350.598705097211, 5375.543078838343, 5456.809011684572, 5541.473560011793, 5401.513863752281, 5452.727363631723, 5460.126379779216, 5477.370102438112, 5480.835574932758], "value": 4672.726847351042, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.4518724852986, 346.0466415026603, 347.7913252048771, 352.9153003279214, 354.3161697923009, 5585.888282234353, 5619.971900140504, 5621.859453513664, 5625.859353516164, 5632.577556683244, 5495.807646732365, 5508.256385387971, 5533.806316778913, 5538.47384498472, 5539.750711217995, 4158.251514727355, 4234.407182994383, 4327.221100201962, 4333.761643109628, 4367.781610919441, 4346.456692913386, 4377.781110944456, 4385.320275357309, 4394.560543945596, 4399.582039706239, 4292.248856450125, 4337.522872484024, 4369.169857727037, 4384.123175364924, 4389.934150987738, 4227.450431443924, 4333.631641310492, 4341.370501277297, 4341.761203133827, 4342.630876375511, 3830.80845957701, 3831.348670725983, 3847.211321679049, 3860.575336712959, 3873.283442563135, 5392.865178370533, 5424.972875135639, 5454.154606036071, 5516.200150978086, 5517.475839795213, 4846.975765121187, 4937.111319962405, 4972.950270497321, 5033.974830125862, 5077.0, 5787.482445136337, 5799.159121927339, 5877.853818505393, 5900.0, 5916.97041514794, 4229.36559516072, 4241.1941731071, 4241.893952651178, 4248.723832950879, 4259.87220383389, 6001.879962400772, 6050.610009046446, 6054.364291749347, 6088.847778805521, 6146.1395404642935, 4314.417553630283, 4319.762413067311, 4338.609525142752, 4349.869034051169, 4356.259435895842, 4349.499422699164, 4359.8228478310675, 4390.385346051556, 4391.626711729475, 4405.493368262691, 4688.882777930579, 4934.383202099738, 4939.481354457802, 4964.8758781030765, 4976.527229913225, 6007.699615019232, 6010.0083486224285, 6034.818955431344, 6038.245219347582, 6058.242719660043, 1477.6158198868156, 1484.3097959448908, 1488.9404423822925, 1490.8658220759967, 1491.843356447579, 926.4672813132341, 943.9852158929178, 990.8018396320765, 996.8454889492141, 1020.5101551255439, 5750.5112065474905, 5750.6262092963825, 5758.510526605201, 5795.275590551181, 5845.941540584539, 6052.394760523913, 6062.939370606237, 6129.172561704202, 6201.937980620226, 6206.906896396557, 5649.576281778883, 5670.2705674769595, 5733.168690539848, 5747.39652336507, 5749.568782341341, 3241.286916878283, 3245.6916592923635, 3247.1882029492626, 3265.265315304085, 3286.1784553861535, 6054.062699936067, 6158.753649853956, 6243.500519958392, 6245.28179259391, 6246.531510136667, 6086.786962456293, 6128.26460824695, 6145.293291271471, 6145.938540614537, 6158.0, 6105.297890742532, 6324.683765811691, 6341.239051313872, 6363.981762917911, 6372.808815735535, 6047.820674968515, 6061.0, 6088.786892458743, 6094.611879446791, 6112.908306375497, 5995.100734889801, 6042.637441753509, 6059.212302400836, 6061.636301821904, 6063.818085457443, 5955.344912059757, 6144.662043587646, 6278.927953775152, 6323.36766323364, 6335.208098987627, 4299.161663475592, 4305.56944305567, 4307.676924230633, 4322.1787860307695, 4339.566043395762, 5835.241418615553, 6050.183225264533, 6053.334133245427, 6053.424924632153, 6165.784197553064, 5857.26784151981, 5863.384344643751, 5864.67744274069, 5879.235699359056, 5892.469677729025, 5852.912206316993, 5860.2967643883, 5882.205902203148, 5911.349751527415, 5914.260717410324, 5659.915101273402, 5674.631148975303, 5723.627964182315, 5909.349971503218, 5916.230889984275, 5973.044312909914, 6036.7887123952205, 6037.78867739627, 6048.758049677964, 6067.0282158299615, 5549.5837812165055, 5935.100767754449, 5961.91057134152, 5975.820725378246, 5989.861926234002], "value": 4499.07169330978, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.7545272333768, 734.7648752399234, 795.8010497375656, 798.9880151797722, 845.6617353058775, 13721.176729396218, 13743.106698064645, 13759.380827862746, 13759.380827862758, 13857.237851918153, 13929.512467063654, 14313.069650472711, 14369.712605747878, 14597.27013649316, 14663.486777962773, 820.6676296100075, 826.1696994520498, 829.5147338806805, 830.6386721776047, 832.8792325112855, 814.9714759983402, 817.3134566963749, 824.2458150792019, 824.8226631274305, 825.6944930375739, 848.3298194426395, 855.6962278391175, 859.2481578618708, 859.3812455032398, 859.6045818923303, 850.961706723199, 851.7955690634203, 852.8763329317276, 854.1543871567166, 855.1662129423793, 612.7671484835734, 617.5306766857221, 619.201230412767, 620.5594028239955, 623.4544773323342, 13004.479820807157, 13970.650733731636, 14030.017898747092, 14070.648233794134, 14142.646433839134, 12386.81419778704, 12816.359182040955, 13043.413046412934, 13181.472741090345, 13334.0, 10634.680959571226, 10718.249722519427, 10736.463176841205, 10879.945600272027, 10910.945445272802, 3690.0959264979983, 3713.1830997180577, 3735.4396840473873, 3742.6818720408796, 3767.8492860285555, 63412.0, 64488.67755661238, 65264.0, 66378.3362166377, 66977.33022669809, 10256.948715256525, 10307.484625768682, 10334.793304133875, 10414.635487757892, 11163.274387164809, 20120.0, 20282.290119845733, 20317.390478285673, 20443.4889127773, 20470.18119275242, 7680.769576912589, 7837.412194085467, 7861.921380786233, 7891.763247102596, 8035.718749843727, 4586.151561961048, 4629.745364004944, 4644.303354496852, 4711.646626502958, 4814.927776083362, 3431.227973705896, 3484.581850177995, 3493.8602455901478, 3508.736844736655, 3513.0865974846724, 658.8188248231775, 661.7915356662636, 664.9332089478111, 671.1342368344781, 687.1788213085315, 680.4114441008492, 744.5495475237511, 748.9325960663457, 760.5778792769955, 773.2306355176635, 8852.911470885338, 8974.730758077269, 9103.772405689911, 9177.311701622404, 9259.814803704023, 722.8012296618472, 736.2527035059419, 742.5507567921438, 752.4845480845638, 756.7805336452367, 4463.62059224963, 4565.246734288805, 4610.884727881829, 4616.76916154191, 4633.397658304399, 72423.63788181025, 72879.27120728725, 73457.0, 77278.61360693161, 77477.0, 63291.683541581995, 64013.35986640167, 64538.0, 68107.0, 69257.30742692508, 59649.0, 60002.69998650066, 60018.09972850411, 60666.393336066954, 62436.0, 9459.716208513755, 9579.233661307218, 9664.71005869825, 9675.806483870143, 9709.36889102206, 38843.223135536566, 39307.6069239304, 40102.39846402248, 40194.39708404318, 40880.79559602183, 48529.27206091841, 51516.93932242818, 53555.92888142293, 53757.0, 54619.18071228855, 10984.340939543654, 11198.552057917592, 11417.657470275904, 11716.94141529287, 11739.178257521891, 12077.456514457046, 12326.630201093982, 12461.688457788629, 12598.181118227652, 12783.16909400886, 11498.425078745862, 11791.646250612495, 12150.0, 12763.361831908182, 12841.165324253894, 11651.184417090722, 12131.45408456604, 12297.0, 12461.376931153225, 13082.607521774362, 11913.344766037952, 12079.939600302294, 12265.754684906431, 12584.119111662096, 12859.292738899076, 9614.855777163208, 9774.609015639295, 10178.592856285666, 10683.25217234786, 10689.9465502672, 10284.228682848667, 10702.946485267525, 10911.78176436451, 10926.562937482411, 10929.234953553176], "value": 6906.341998562579, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 112.0, 112.0, 112.0, 112.0, 113.0, 114.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 160.0, 171.0, 132.0, 163.0, 160.0, 125.0, 178.0, 127.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 165.0, 169.0, 162.0, 162.0, 165.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 155.0, 75.0, 77.0, 74.0, 74.0, 161.0, 77.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 148.0, 83.0, 84.0, 84.0, 146.0, 83.0, 84.0, 155.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 54.0, 54.0, 58.0, 53.0, 55.0, 54.0, 59.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 61.0, 62.0, 62.0, 60.0, 61.0, 61.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 84.0, 85.0, 81.0, 80.0, 81.0, 116.0, 79.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 129.0, 124.0, 128.0, 131.0, 129.0, 124.0, 134.0, 134.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 159.0, 168.0, 159.0, 162.0, 165.0, 160.0, 161.0, 159.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 66.0, 63.0, 63.0, 64.0, 62.0, 66.0], "value": 63.8, "unit": "score"}]}]} 23:16:58 INFO - Return code: 0 23:16:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:16:58 ERROR - # TBPL SUCCESS # 23:16:58 INFO - Running post-action listener: _resource_record_post_action 23:16:58 INFO - ##### 23:16:58 INFO - ##### Finished run-tests step (success) 23:16:58 INFO - ##### 23:16:58 INFO - Running post-run listener: _resource_record_post_run 23:16:58 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 550727680; Read time: 0; Write time: 624852 23:16:58 INFO - TinderboxPrint: CPU usage
13.4% 23:16:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:16:58 INFO - TinderboxPrint: I/O write bytes / time
550,727,680 / 624,852 23:16:58 INFO - TinderboxPrint: CPU idle
8,217.5 (86.5%) 23:16:58 INFO - TinderboxPrint: CPU user
1,221.5 (12.9%) 23:16:58 INFO - TinderboxPrint: Swap in / out
0 / 0 23:16:58 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 256851968; Read time: 0; Write time: 377080 23:16:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 293875712; Read time: 0; Write time: 247772 23:16:59 INFO - Running post-run listener: _upload_blobber_files 23:16:59 INFO - Blob upload gear active. 23:16:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:16:59 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 23:16:59 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'] 23:16:59 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 23:16:59 INFO - (blobuploader) - INFO - Open directory for files ... 23:16:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:16:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:16:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:00 INFO - (blobuploader) - INFO - Done attempting. 23:17:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:17:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:17:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:01 INFO - (blobuploader) - INFO - Done attempting. 23:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:17:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:04 INFO - (blobuploader) - INFO - Done attempting. 23:17:04 INFO - (blobuploader) - INFO - Iteration through files over. 23:17:04 INFO - Return code: 0 23:17:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:17:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:17:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cd89893553f93f26c7a28ed28e97486fa58abb4eda299ba21de8eeb16797fe6ac184cd443b65036263d5c62b4154a6dbaa6e51e04f308f78954505c0a0d760b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85f0e443973fd369efbb9ec43a33c3361359ea9ca997d9730898ebcc0e2a99dcd29c7c6786ce85f553cf31d42328773c6fb2bf7651adc825d81589da559e7c2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f3f4d805e102c77e7794b971198cf4302480f20d3e998751a1df66203b8ec4cd16f5ff15e709ac43b5c2f58ea7be4a86e520fd5d57805812d150931f8131eb8"} 23:17:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:17:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:17:04 INFO - Contents: 23:17:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2cd89893553f93f26c7a28ed28e97486fa58abb4eda299ba21de8eeb16797fe6ac184cd443b65036263d5c62b4154a6dbaa6e51e04f308f78954505c0a0d760b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85f0e443973fd369efbb9ec43a33c3361359ea9ca997d9730898ebcc0e2a99dcd29c7c6786ce85f553cf31d42328773c6fb2bf7651adc825d81589da559e7c2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f3f4d805e102c77e7794b971198cf4302480f20d3e998751a1df66203b8ec4cd16f5ff15e709ac43b5c2f58ea7be4a86e520fd5d57805812d150931f8131eb8"} 23:17:04 INFO - Running post-run listener: copy_logs_to_upload_dir 23:17:04 INFO - Copying logs to upload dir... 23:17:04 INFO - mkdir: /builds/slave/test/build/upload/logs 23:17:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.562961 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-26 23:17:04.451205) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 23:17:04.455105) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861 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/2cd89893553f93f26c7a28ed28e97486fa58abb4eda299ba21de8eeb16797fe6ac184cd443b65036263d5c62b4154a6dbaa6e51e04f308f78954505c0a0d760b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85f0e443973fd369efbb9ec43a33c3361359ea9ca997d9730898ebcc0e2a99dcd29c7c6786ce85f553cf31d42328773c6fb2bf7651adc825d81589da559e7c2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f3f4d805e102c77e7794b971198cf4302480f20d3e998751a1df66203b8ec4cd16f5ff15e709ac43b5c2f58ea7be4a86e520fd5d57805812d150931f8131eb8"} build_url:https://queue.taskcluster.net/v1/task/JJttUPQVRKWpZSNCN0uiWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/JJttUPQVRKWpZSNCN0uiWw/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/2cd89893553f93f26c7a28ed28e97486fa58abb4eda299ba21de8eeb16797fe6ac184cd443b65036263d5c62b4154a6dbaa6e51e04f308f78954505c0a0d760b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85f0e443973fd369efbb9ec43a33c3361359ea9ca997d9730898ebcc0e2a99dcd29c7c6786ce85f553cf31d42328773c6fb2bf7651adc825d81589da559e7c2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f3f4d805e102c77e7794b971198cf4302480f20d3e998751a1df66203b8ec4cd16f5ff15e709ac43b5c2f58ea7be4a86e520fd5d57805812d150931f8131eb8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 23:17:04.480710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 23:17:04.481032) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1464326020.687516-961672861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 23:17:04.571143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 23:17:04.571628) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 23:17:04.571965) ========= ========= Total master_lag: 0.23 =========