builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1464394577.8 results: success (0) buildid: 20160527143015 builduid: 3d1c5d5012584dd9bed5423f7774708b revision: 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:17.797372) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:17.797971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:17.798376) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:17.816187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:17.816589) ========= 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=33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 17:16:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 87.7M=0s 2016-05-27 17:16:18 (87.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.261376 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:18.092107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:18.092440) ========= 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=33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023030 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:18.143005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 17:16:18.143365) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d --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 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d --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=33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 17:16:18,747 truncating revision to first 12 chars 2016-05-27 17:16:18,747 Setting DEBUG logging. 2016-05-27 17:16:18,747 attempt 1/10 2016-05-27 17:16:18,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e1d7c5d1a58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 17:16:19,774 unpacking tar archive at: fx-team-3e1d7c5d1a58/testing/mozharness/ program finished with exit code 0 elapsedTime=1.345396 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 17:16:19.504266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:19.504713) ========= script_repo_revision: 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:19.505290) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:19.505694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 17:16:19.517118) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-27 17:16:19.517795) ========= /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=33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:16:20 INFO - MultiFileLogger online at 20160527 17:16:20 in /builds/slave/test 17:16:20 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 17:16:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:16:20 INFO - {'append_to_log': False, 17:16:20 INFO - 'base_work_dir': '/builds/slave/test', 17:16:20 INFO - 'blob_upload_branch': 'Fx-Team', 17:16:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:16:20 INFO - 'branch': 'Fx-Team', 17:16:20 INFO - 'buildbot_json_path': 'buildprops.json', 17:16:20 INFO - 'config_files': ('talos/linux_config.py',), 17:16:20 INFO - 'default_actions': ('clobber', 17:16:20 INFO - 'read-buildbot-config', 17:16:20 INFO - 'download-and-extract', 17:16:20 INFO - 'populate-webroot', 17:16:20 INFO - 'create-virtualenv', 17:16:20 INFO - 'install', 17:16:20 INFO - 'run-tests'), 17:16:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:16:20 INFO - 'download_minidump_stackwalk': True, 17:16:20 INFO - 'download_symbols': 'ondemand', 17:16:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:16:20 INFO - 'tooltool.py': '/tools/tooltool.py', 17:16:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:16:20 INFO - '/tools/misc-python/virtualenv.py')}, 17:16:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:16:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:16:20 INFO - 'installer_path': 'installer.exe', 17:16:20 INFO - 'log_level': 'info', 17:16:20 INFO - 'log_name': 'talos', 17:16:20 INFO - 'log_to_console': True, 17:16:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:16:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:16:20 INFO - 'opt_config_files': (), 17:16:20 INFO - 'pip_index': False, 17:16:20 INFO - 'sps_profile': False, 17:16:20 INFO - 'sps_profile_interval': 0, 17:16:20 INFO - 'suite': 'dromaeojs-e10s', 17:16:20 INFO - 'system_bits': '32', 17:16:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:16:20 INFO - 'title': 'talos-linux64-ix-063', 17:16:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:16:20 INFO - 'use_talos_json': True, 17:16:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:16:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:16:20 INFO - 'work_dir': 'build'} 17:16:20 INFO - ##### 17:16:20 INFO - ##### Running clobber step. 17:16:20 INFO - ##### 17:16:20 INFO - Running pre-action listener: _resource_record_pre_action 17:16:20 INFO - Running main action method: clobber 17:16:20 INFO - rmtree: /builds/slave/test/build 17:16:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:16:20 INFO - Running post-action listener: _resource_record_post_action 17:16:20 INFO - ##### 17:16:20 INFO - ##### Finished clobber step (success) 17:16:20 INFO - ##### 17:16:20 INFO - ##### 17:16:20 INFO - ##### Running read-buildbot-config step. 17:16:20 INFO - ##### 17:16:20 INFO - Running pre-action listener: _resource_record_pre_action 17:16:20 INFO - Running main action method: read_buildbot_config 17:16:20 INFO - Using buildbot properties: 17:16:20 INFO - { 17:16:20 INFO - "project": "", 17:16:20 INFO - "product": "firefox", 17:16:20 INFO - "script_repo_revision": "production", 17:16:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:16:20 INFO - "repository": "", 17:16:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:16:20 INFO - "buildid": "20160527143015", 17:16:20 INFO - "pgo_build": "True", 17:16:20 INFO - "basedir": "/builds/slave/test", 17:16:20 INFO - "buildnumber": 385, 17:16:20 INFO - "slavename": "talos-linux64-ix-063", 17:16:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:16:20 INFO - "platform": "ubuntu64_hw", 17:16:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:16:20 INFO - "branch": "fx-team", 17:16:20 INFO - "repo_path": "integration/fx-team", 17:16:20 INFO - "revision": "3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d", 17:16:20 INFO - "stage_platform": "linux64-pgo", 17:16:20 INFO - "builduid": "3d1c5d5012584dd9bed5423f7774708b", 17:16:20 INFO - "slavebuilddir": "test" 17:16:20 INFO - } 17:16:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:16:20 INFO - Running post-action listener: _resource_record_post_action 17:16:20 INFO - ##### 17:16:20 INFO - ##### Finished read-buildbot-config step (success) 17:16:20 INFO - ##### 17:16:20 INFO - ##### 17:16:20 INFO - ##### Running download-and-extract step. 17:16:20 INFO - ##### 17:16:20 INFO - Running pre-action listener: _resource_record_pre_action 17:16:20 INFO - Running main action method: download_and_extract 17:16:20 INFO - mkdir: /builds/slave/test/build/tests 17:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:20 INFO - https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:16:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:16:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:16:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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 17:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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 17:16:22 INFO - Downloaded 1361 bytes. 17:16:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:16:22 INFO - Using the following test package requirements: 17:16:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:16:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:16:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:16:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'jsshell-linux-x86_64.zip'], 17:16:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:16:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:16:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:16:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:16:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:16:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:16:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:16:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:22 INFO - https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:16:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:16:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:16:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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 17:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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 17:16:24 INFO - Downloaded 24410534 bytes. 17:16:24 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'] 17:16:24 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 17:16:25 INFO - Return code: 0 17:16:25 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 17:16: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')]} 17:16:25 INFO - https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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 17:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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 17:16:26 INFO - Downloaded 24410534 bytes. 17:16:26 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'] 17:16:26 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 17:16:28 INFO - Return code: 0 17:16:28 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')]} 17:16:28 INFO - https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:16:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:16:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:16:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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 17:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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 17:16:29 INFO - Downloaded 10834034 bytes. 17:16:29 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'] 17:16:29 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 17:16:29 INFO - Return code: 0 17:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:29 INFO - https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:16:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:16:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:16:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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 17:16:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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 17:16:31 INFO - Downloaded 58741812 bytes. 17:16:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:16:31 INFO - mkdir: /builds/slave/test/properties 17:16:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:16:31 INFO - Writing to file /builds/slave/test/properties/build_url 17:16:31 INFO - Contents: 17:16:31 INFO - build_url:https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:16:32 INFO - Running post-action listener: _resource_record_post_action 17:16:32 INFO - Running post-action listener: set_extra_try_arguments 17:16:32 INFO - ##### 17:16:32 INFO - ##### Finished download-and-extract step (success) 17:16:32 INFO - ##### 17:16:32 INFO - ##### 17:16:32 INFO - ##### Running populate-webroot step. 17:16:32 INFO - ##### 17:16:32 INFO - Running pre-action listener: _resource_record_pre_action 17:16:32 INFO - Running main action method: populate_webroot 17:16:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:16:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:16:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:16:32 INFO - '--tppagecycles', 17:16:32 INFO - '7'], 17:16:32 INFO - 'tests': ['tsvgm']}}, 17:16:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:16:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:16:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:16:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:16:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['damp', 'tps']}, 17:16:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'tests': ['damp', 'tps']}, 17:16:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['dromaeo_dom']}, 17:16:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:16:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'other-e10s': {'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['a11yr', 17:16:32 INFO - 'ts_paint', 17:16:32 INFO - 'tpaint', 17:16:32 INFO - 'sessionrestore', 17:16:32 INFO - 'sessionrestore_no_auto_restore', 17:16:32 INFO - 'tabpaint']}, 17:16:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['tsvgx', 17:16:32 INFO - 'tsvgr_opacity', 17:16:32 INFO - 'tart', 17:16:32 INFO - 'tscrollx', 17:16:32 INFO - 'cart']}, 17:16:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:16:32 INFO - 'tsvgr_opacity', 17:16:32 INFO - 'tart', 17:16:32 INFO - 'tscrollx', 17:16:32 INFO - 'cart']}, 17:16:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'talos_options': ['--disable-e10s'], 17:16:32 INFO - 'tests': ['tp5o']}, 17:16:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'tests': ['tp5o']}, 17:16:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'talos_options': ['--disable-e10s', 17:16:32 INFO - '--xperf_path', 17:16:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:32 INFO - 'tests': ['tp5n']}, 17:16:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:32 INFO - 'talos_options': ['--xperf_path', 17:16:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:32 INFO - 'tests': ['tp5n']}}, 17:16:32 INFO - 'talos.zip': {'path': '', 17:16:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:16:32 INFO - Running post-action listener: _resource_record_post_action 17:16:32 INFO - ##### 17:16:32 INFO - ##### Finished populate-webroot step (success) 17:16:32 INFO - ##### 17:16:32 INFO - ##### 17:16:32 INFO - ##### Running create-virtualenv step. 17:16:32 INFO - ##### 17:16:32 INFO - Running pre-action listener: _resource_record_pre_action 17:16:32 INFO - Running main action method: create_virtualenv 17:16:32 INFO - Creating virtualenv /builds/slave/test/build/venv 17:16:32 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 17:16:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:16:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:16:32 INFO - Using real prefix '/usr' 17:16:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:16:32 INFO - Installing distribute.............................................................................................................................................................................................done. 17:16:34 INFO - Installing pip.................done. 17:16:34 INFO - Return code: 0 17:16:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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')]} 17:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5a8722ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207c9c0>, '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 0x207d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207dd50>, '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': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', '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 17:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:16:34 INFO - Using env: {'DISPLAY': ':0', 17:16:34 INFO - 'HOME': '/home/cltbld', 17:16:34 INFO - 'LANG': 'en_US.UTF-8', 17:16:34 INFO - 'LANGUAGE': 'en_US:en', 17:16:34 INFO - 'LOGNAME': 'cltbld', 17:16:34 INFO - 'MAIL': '/var/mail/cltbld', 17:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:34 INFO - 'MOZ_NO_REMOTE': '1', 17:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:34 INFO - 'NO_EM_RESTART': '1', 17:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:34 INFO - 'PWD': '/builds/slave/test', 17:16:34 INFO - 'SHELL': '/bin/bash', 17:16:34 INFO - 'SHLVL': '1', 17:16:34 INFO - 'TERM': 'linux', 17:16:34 INFO - 'TMOUT': '86400', 17:16:34 INFO - 'USER': 'cltbld', 17:16:34 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', 17:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:34 INFO - '_': '/tools/buildbot/bin/python'} 17:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:34 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 17:16:34 INFO - Cleaning up... 17:16:34 INFO - Return code: 0 17:16:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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')]} 17:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5a8722ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207c9c0>, '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 0x207d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207dd50>, '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': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', '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 17:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:16:34 INFO - Using env: {'DISPLAY': ':0', 17:16:34 INFO - 'HOME': '/home/cltbld', 17:16:34 INFO - 'LANG': 'en_US.UTF-8', 17:16:34 INFO - 'LANGUAGE': 'en_US:en', 17:16:34 INFO - 'LOGNAME': 'cltbld', 17:16:34 INFO - 'MAIL': '/var/mail/cltbld', 17:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:34 INFO - 'MOZ_NO_REMOTE': '1', 17:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:34 INFO - 'NO_EM_RESTART': '1', 17:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:34 INFO - 'PWD': '/builds/slave/test', 17:16:34 INFO - 'SHELL': '/bin/bash', 17:16:34 INFO - 'SHLVL': '1', 17:16:34 INFO - 'TERM': 'linux', 17:16:34 INFO - 'TMOUT': '86400', 17:16:34 INFO - 'USER': 'cltbld', 17:16:34 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', 17:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:34 INFO - '_': '/tools/buildbot/bin/python'} 17:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:35 INFO - Downloading/unpacking psutil>=3.1.1 17:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:16:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:37 INFO - Installing collected packages: psutil 17:16:37 INFO - Running setup.py install for psutil 17:16:37 INFO - building 'psutil._psutil_linux' extension 17:16:37 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 17:16:37 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 17:16:37 INFO - building 'psutil._psutil_posix' extension 17:16:37 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 17:16:37 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 17:16:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:37 INFO - Successfully installed psutil 17:16:37 INFO - Cleaning up... 17:16:37 INFO - Return code: 0 17:16:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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')]} 17:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5a8722ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207c9c0>, '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 0x207d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207dd50>, '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': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', '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 17:16:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:16:37 INFO - Using env: {'DISPLAY': ':0', 17:16:37 INFO - 'HOME': '/home/cltbld', 17:16:37 INFO - 'LANG': 'en_US.UTF-8', 17:16:37 INFO - 'LANGUAGE': 'en_US:en', 17:16:37 INFO - 'LOGNAME': 'cltbld', 17:16:37 INFO - 'MAIL': '/var/mail/cltbld', 17:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:37 INFO - 'MOZ_NO_REMOTE': '1', 17:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:37 INFO - 'NO_EM_RESTART': '1', 17:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:37 INFO - 'PWD': '/builds/slave/test', 17:16:37 INFO - 'SHELL': '/bin/bash', 17:16:37 INFO - 'SHLVL': '1', 17:16:37 INFO - 'TERM': 'linux', 17:16:37 INFO - 'TMOUT': '86400', 17:16:37 INFO - 'USER': 'cltbld', 17:16:37 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', 17:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:37 INFO - '_': '/tools/buildbot/bin/python'} 17:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:16:39 INFO - Installing collected packages: mozsystemmonitor 17:16:39 INFO - Running setup.py install for mozsystemmonitor 17:16:39 INFO - Successfully installed mozsystemmonitor 17:16:39 INFO - Cleaning up... 17:16:39 INFO - Return code: 0 17:16:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:16:39 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')]} 17:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:39 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')]} 17:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:39 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 0x7f5a8722ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207c9c0>, '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 0x207d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207dd50>, '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': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', '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 17:16:39 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 17:16:39 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 17:16:39 INFO - Using env: {'DISPLAY': ':0', 17:16:39 INFO - 'HOME': '/home/cltbld', 17:16:39 INFO - 'LANG': 'en_US.UTF-8', 17:16:39 INFO - 'LANGUAGE': 'en_US:en', 17:16:39 INFO - 'LOGNAME': 'cltbld', 17:16:39 INFO - 'MAIL': '/var/mail/cltbld', 17:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:39 INFO - 'MOZ_NO_REMOTE': '1', 17:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:39 INFO - 'NO_EM_RESTART': '1', 17:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:39 INFO - 'PWD': '/builds/slave/test', 17:16:39 INFO - 'SHELL': '/bin/bash', 17:16:39 INFO - 'SHLVL': '1', 17:16:39 INFO - 'TERM': 'linux', 17:16:39 INFO - 'TMOUT': '86400', 17:16:39 INFO - 'USER': 'cltbld', 17:16:39 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', 17:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:39 INFO - '_': '/tools/buildbot/bin/python'} 17:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:40 INFO - Downloading/unpacking blobuploader==1.2.4 17:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - Downloading blobuploader-1.2.4.tar.gz 17:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:16:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:16:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:42 INFO - Downloading docopt-0.6.1.tar.gz 17:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:16:43 INFO - Installing collected packages: blobuploader, requests, docopt 17:16:43 INFO - Running setup.py install for blobuploader 17:16:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:16:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:16:43 INFO - Running setup.py install for requests 17:16:43 INFO - Running setup.py install for docopt 17:16:43 INFO - Successfully installed blobuploader requests docopt 17:16:43 INFO - Cleaning up... 17:16:43 INFO - Return code: 0 17:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:43 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 0x7f5a8722ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207c9c0>, '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 0x207d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207dd50>, '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': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', '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 17:16:43 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 17:16:43 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 17:16:43 INFO - Using env: {'DISPLAY': ':0', 17:16:43 INFO - 'HOME': '/home/cltbld', 17:16:43 INFO - 'LANG': 'en_US.UTF-8', 17:16:43 INFO - 'LANGUAGE': 'en_US:en', 17:16:43 INFO - 'LOGNAME': 'cltbld', 17:16:43 INFO - 'MAIL': '/var/mail/cltbld', 17:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:43 INFO - 'MOZ_NO_REMOTE': '1', 17:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:43 INFO - 'NO_EM_RESTART': '1', 17:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:43 INFO - 'PWD': '/builds/slave/test', 17:16:43 INFO - 'SHELL': '/bin/bash', 17:16:43 INFO - 'SHLVL': '1', 17:16:43 INFO - 'TERM': 'linux', 17:16:43 INFO - 'TMOUT': '86400', 17:16:43 INFO - 'USER': 'cltbld', 17:16:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', 17:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:43 INFO - '_': '/tools/buildbot/bin/python'} 17:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:43 INFO - Running setup.py (path:/tmp/pip-WZdk5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:43 INFO - Running setup.py (path:/tmp/pip-P4NHIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:43 INFO - Running setup.py (path:/tmp/pip-6oZC0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:44 INFO - Running setup.py (path:/tmp/pip-2dEadD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:44 INFO - Running setup.py (path:/tmp/pip-dxm0FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:44 INFO - Running setup.py (path:/tmp/pip-CgNwTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:44 INFO - Running setup.py (path:/tmp/pip-T2Yhct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:44 INFO - Running setup.py (path:/tmp/pip-D9yaSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:44 INFO - Running setup.py (path:/tmp/pip-qzoMJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:44 INFO - Running setup.py (path:/tmp/pip-M22MyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:44 INFO - Running setup.py (path:/tmp/pip-gIuK0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:44 INFO - Running setup.py (path:/tmp/pip-V_X2NW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:44 INFO - Running setup.py (path:/tmp/pip-XntcHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:44 INFO - Running setup.py (path:/tmp/pip-dVKQP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:44 INFO - Running setup.py (path:/tmp/pip-1PC88k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:44 INFO - Running setup.py (path:/tmp/pip-LPSbCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:44 INFO - Running setup.py (path:/tmp/pip-IFsuc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:16:45 INFO - Running setup.py install for manifestparser 17:16:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Running setup.py install for mozcrash 17:16:45 INFO - Running setup.py install for mozdebug 17:16:45 INFO - Running setup.py install for mozdevice 17:16:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Running setup.py install for mozfile 17:16:45 INFO - Running setup.py install for mozhttpd 17:16:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Running setup.py install for mozinfo 17:16:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Running setup.py install for mozInstall 17:16:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:16:45 INFO - Running setup.py install for mozleak 17:16:45 INFO - Running setup.py install for mozlog 17:16:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Running setup.py install for moznetwork 17:16:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Running setup.py install for mozprocess 17:16:46 INFO - Running setup.py install for mozprofile 17:16:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Running setup.py install for mozrunner 17:16:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Running setup.py install for mozscreenshot 17:16:46 INFO - Running setup.py install for moztest 17:16:46 INFO - Running setup.py install for mozversion 17:16:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:16:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:16:46 INFO - Cleaning up... 17:16:46 INFO - Return code: 0 17:16:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16: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')]} 17:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16: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')]} 17:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:46 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 0x7f5a8722ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207c9c0>, '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 0x207d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207dd50>, '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': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', '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 17:16:46 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 17:16:46 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 17:16:46 INFO - Using env: {'DISPLAY': ':0', 17:16:46 INFO - 'HOME': '/home/cltbld', 17:16:46 INFO - 'LANG': 'en_US.UTF-8', 17:16:46 INFO - 'LANGUAGE': 'en_US:en', 17:16:46 INFO - 'LOGNAME': 'cltbld', 17:16:46 INFO - 'MAIL': '/var/mail/cltbld', 17:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:46 INFO - 'MOZ_NO_REMOTE': '1', 17:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:46 INFO - 'NO_EM_RESTART': '1', 17:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:46 INFO - 'PWD': '/builds/slave/test', 17:16:46 INFO - 'SHELL': '/bin/bash', 17:16:46 INFO - 'SHLVL': '1', 17:16:46 INFO - 'TERM': 'linux', 17:16:46 INFO - 'TMOUT': '86400', 17:16:46 INFO - 'USER': 'cltbld', 17:16:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', 17:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:46 INFO - '_': '/tools/buildbot/bin/python'} 17:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:47 INFO - Running setup.py (path:/tmp/pip-r9eqdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:47 INFO - Running setup.py (path:/tmp/pip-hSuFOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:47 INFO - Running setup.py (path:/tmp/pip-XZsdPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:47 INFO - Running setup.py (path:/tmp/pip-kqdKxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:47 INFO - Running setup.py (path:/tmp/pip-nvlCgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:47 INFO - Running setup.py (path:/tmp/pip-svPEmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:47 INFO - Running setup.py (path:/tmp/pip-zvGt2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:47 INFO - Running setup.py (path:/tmp/pip-Yeb259-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:47 INFO - Running setup.py (path:/tmp/pip-BFlxEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:47 INFO - Running setup.py (path:/tmp/pip-lvA9Qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:47 INFO - Running setup.py (path:/tmp/pip-qjl4yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:47 INFO - Running setup.py (path:/tmp/pip-9hMV1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:47 INFO - Running setup.py (path:/tmp/pip-4_xP6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:47 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)) 17:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:47 INFO - Running setup.py (path:/tmp/pip-yh15p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:48 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)) 17:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:48 INFO - Running setup.py (path:/tmp/pip-gdse07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:48 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)) 17:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:48 INFO - Running setup.py (path:/tmp/pip-ipx5HZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:48 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)) 17:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:48 INFO - Running setup.py (path:/tmp/pip-UZHBbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:48 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)) 17:16:48 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)) 17:16:48 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)) 17:16:48 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)) 17:16:48 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)) 17:16:48 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)) 17:16:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:50 INFO - Downloading blessings-1.6.tar.gz 17:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:16:50 INFO - Installing collected packages: blessings 17:16:50 INFO - Running setup.py install for blessings 17:16:50 INFO - Successfully installed blessings 17:16:50 INFO - Cleaning up... 17:16:50 INFO - Return code: 0 17:16:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:16:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:50 INFO - Reading from file tmpfile_stdout 17:16:50 INFO - Current package versions: 17:16:50 INFO - argparse == 1.2.1 17:16:50 INFO - blessings == 1.6 17:16:50 INFO - blobuploader == 1.2.4 17:16:50 INFO - docopt == 0.6.1 17:16:50 INFO - manifestparser == 1.1 17:16:50 INFO - mozInstall == 1.12 17:16:50 INFO - mozcrash == 0.17 17:16:50 INFO - mozdebug == 0.1 17:16:50 INFO - mozdevice == 0.48 17:16:50 INFO - mozfile == 1.2 17:16:50 INFO - mozhttpd == 0.7 17:16:50 INFO - mozinfo == 0.9 17:16:50 INFO - mozleak == 0.1 17:16:50 INFO - mozlog == 3.2 17:16:50 INFO - moznetwork == 0.27 17:16:50 INFO - mozprocess == 0.22 17:16:50 INFO - mozprofile == 0.28 17:16:50 INFO - mozrunner == 6.11 17:16:50 INFO - mozscreenshot == 0.1 17:16:50 INFO - mozsystemmonitor == 0.3 17:16:50 INFO - moztest == 0.7 17:16:50 INFO - mozversion == 1.4 17:16:50 INFO - psutil == 3.1.1 17:16:50 INFO - requests == 1.2.3 17:16:50 INFO - wsgiref == 0.1.2 17:16:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:50 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')]} 17:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:50 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')]} 17:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:50 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 0x7f5a8722ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207c9c0>, '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 0x207d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207dd50>, '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': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', '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 17:16:50 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 17:16:50 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 17:16:50 INFO - Using env: {'DISPLAY': ':0', 17:16:50 INFO - 'HOME': '/home/cltbld', 17:16:50 INFO - 'LANG': 'en_US.UTF-8', 17:16:50 INFO - 'LANGUAGE': 'en_US:en', 17:16:50 INFO - 'LOGNAME': 'cltbld', 17:16:50 INFO - 'MAIL': '/var/mail/cltbld', 17:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:50 INFO - 'MOZ_NO_REMOTE': '1', 17:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:50 INFO - 'NO_EM_RESTART': '1', 17:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:50 INFO - 'PWD': '/builds/slave/test', 17:16:50 INFO - 'SHELL': '/bin/bash', 17:16:50 INFO - 'SHLVL': '1', 17:16:50 INFO - 'TERM': 'linux', 17:16:50 INFO - 'TMOUT': '86400', 17:16:50 INFO - 'USER': 'cltbld', 17:16:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', 17:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:50 INFO - '_': '/tools/buildbot/bin/python'} 17:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 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)) 17:16:50 INFO - Cleaning up... 17:16:50 INFO - Return code: 0 17:16:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:16:50 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')]} 17:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:50 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')]} 17:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:50 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 0x7f5a8722ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207c9c0>, '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 0x207d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207dd50>, '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': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', '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 17:16:50 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 17:16:50 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 17:16:50 INFO - Using env: {'DISPLAY': ':0', 17:16:50 INFO - 'HOME': '/home/cltbld', 17:16:50 INFO - 'LANG': 'en_US.UTF-8', 17:16:50 INFO - 'LANGUAGE': 'en_US:en', 17:16:50 INFO - 'LOGNAME': 'cltbld', 17:16:50 INFO - 'MAIL': '/var/mail/cltbld', 17:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:50 INFO - 'MOZ_NO_REMOTE': '1', 17:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:50 INFO - 'NO_EM_RESTART': '1', 17:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:50 INFO - 'PWD': '/builds/slave/test', 17:16:50 INFO - 'SHELL': '/bin/bash', 17:16:50 INFO - 'SHLVL': '1', 17:16:50 INFO - 'TERM': 'linux', 17:16:50 INFO - 'TMOUT': '86400', 17:16:50 INFO - 'USER': 'cltbld', 17:16:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', 17:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:50 INFO - '_': '/tools/buildbot/bin/python'} 17:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:51 INFO - Downloading/unpacking jsonschema 17:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:16:52 INFO - Downloading/unpacking functools32 (from jsonschema) 17:16: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 17:16: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 17:16: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 17:16: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 17:16: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 17:16: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 17:16:53 INFO - Downloading functools32-3.2.3-2.tar.gz 17:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:16:53 INFO - warning: no files found matching '*.txt' 17:16:53 INFO - no previously-included directories found matching 'build' 17:16:53 INFO - no previously-included directories found matching 'dist' 17:16:53 INFO - no previously-included directories found matching '.git*' 17:16:53 INFO - Installing collected packages: jsonschema, functools32 17:16:53 INFO - Running setup.py install for functools32 17:16:53 INFO - warning: no files found matching '*.txt' 17:16:53 INFO - no previously-included directories found matching 'build' 17:16:53 INFO - no previously-included directories found matching 'dist' 17:16:53 INFO - no previously-included directories found matching '.git*' 17:16:53 INFO - Successfully installed jsonschema functools32 17:16:53 INFO - Cleaning up... 17:16:53 INFO - Return code: 0 17:16:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5a8722ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207c9c0>, '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 0x207d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207dd50>, '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': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', '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 17:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:16:53 INFO - Using env: {'DISPLAY': ':0', 17:16:53 INFO - 'HOME': '/home/cltbld', 17:16:53 INFO - 'LANG': 'en_US.UTF-8', 17:16:53 INFO - 'LANGUAGE': 'en_US:en', 17:16:53 INFO - 'LOGNAME': 'cltbld', 17:16:53 INFO - 'MAIL': '/var/mail/cltbld', 17:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:53 INFO - 'MOZ_NO_REMOTE': '1', 17:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:53 INFO - 'NO_EM_RESTART': '1', 17:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:53 INFO - 'PWD': '/builds/slave/test', 17:16:53 INFO - 'SHELL': '/bin/bash', 17:16:53 INFO - 'SHLVL': '1', 17:16:53 INFO - 'TERM': 'linux', 17:16:53 INFO - 'TMOUT': '86400', 17:16:53 INFO - 'USER': 'cltbld', 17:16:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', 17:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:53 INFO - '_': '/tools/buildbot/bin/python'} 17:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:53 INFO - Downloading/unpacking flake8 17:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:16:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:16:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:16:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:56 INFO - no previously-included directories found matching 'docs/_build' 17:16:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:16:56 INFO - Running setup.py install for pep8 17:16:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:56 INFO - no previously-included directories found matching 'docs/_build' 17:16:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:16:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:16:56 INFO - Cleaning up... 17:16:56 INFO - Return code: 0 17:16:56 INFO - Running post-action listener: _resource_record_post_action 17:16:56 INFO - Running post-action listener: _start_resource_monitoring 17:16:56 INFO - Starting resource monitoring. 17:16:56 INFO - ##### 17:16:56 INFO - ##### Finished create-virtualenv step (success) 17:16:56 INFO - ##### 17:16:56 INFO - ##### 17:16:56 INFO - ##### Running install step. 17:16:56 INFO - ##### 17:16:56 INFO - Running pre-action listener: _resource_record_pre_action 17:16:56 INFO - Running main action method: install 17:16:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:56 INFO - Reading from file tmpfile_stdout 17:16:56 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:16:56 INFO - Reading from file tmpfile_stdout 17:16:56 INFO - Output received: 17:16:56 INFO - Usage: mozinstall [options] installer 17:16:56 INFO - Options: 17:16:56 INFO - -h, --help show this help message and exit 17:16:56 INFO - -d DEST, --destination=DEST 17:16:56 INFO - Directory to install application into. [default: 17:16:56 INFO - "/builds/slave/test"] 17:16:56 INFO - --app=APP Application being installed. [default: firefox] 17:16:56 INFO - mkdir: /builds/slave/test/build/application 17:16:56 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'] 17:16:56 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 17:17:19 INFO - Reading from file tmpfile_stdout 17:17:19 INFO - Output received: 17:17:19 INFO - /builds/slave/test/build/application/firefox/firefox 17:17:19 INFO - Running post-action listener: _resource_record_post_action 17:17:19 INFO - ##### 17:17:19 INFO - ##### Finished install step (success) 17:17:19 INFO - ##### 17:17:19 INFO - ##### 17:17:19 INFO - ##### Running run-tests step. 17:17:19 INFO - ##### 17:17:19 INFO - Running pre-action listener: _resource_record_pre_action 17:17:19 INFO - Running main action method: run_tests 17:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:17:19 INFO - Python 2.7.3 17:17:19 INFO - Return code: 0 17:17:19 INFO - grabbing minidump binary from tooltool 17:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:19 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 0x207c9c0>, '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 0x207d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:17:19 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 17:17:19 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 17:17:19 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 17:17:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:17:19 INFO - Return code: 0 17:17:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:17:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:17:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:17:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:17:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:17:22 INFO - Return code: 0 17:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 17:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 17:17:22 INFO - Using env: {'DISPLAY': ':0', 17:17:22 INFO - 'HOME': '/home/cltbld', 17:17:22 INFO - 'LANG': 'en_US.UTF-8', 17:17:22 INFO - 'LANGUAGE': 'en_US:en', 17:17:22 INFO - 'LOGNAME': 'cltbld', 17:17:22 INFO - 'MAIL': '/var/mail/cltbld', 17:17:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:17:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:22 INFO - 'MOZ_NO_REMOTE': '1', 17:17:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:22 INFO - 'NO_EM_RESTART': '1', 17:17:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:22 INFO - 'PWD': '/builds/slave/test', 17:17:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:17:22 INFO - 'SHELL': '/bin/bash', 17:17:22 INFO - 'SHLVL': '1', 17:17:22 INFO - 'TERM': 'linux', 17:17:22 INFO - 'TMOUT': '86400', 17:17:22 INFO - 'USER': 'cltbld', 17:17:22 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589', 17:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:22 INFO - '_': '/tools/buildbot/bin/python'} 17:17:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 17:17:23 INFO - mozversion application_buildid: 20160527143015 17:17:23 INFO - mozversion application_changeset: 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d 17:17:23 INFO - mozversion application_display_name: Nightly 17:17:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:17:23 INFO - mozversion application_name: Firefox 17:17:23 INFO - mozversion application_remotingname: firefox 17:17:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:17:23 INFO - mozversion application_vendor: Mozilla 17:17:23 INFO - mozversion application_version: 49.0a1 17:17:23 INFO - mozversion platform_buildid: 20160527143015 17:17:23 INFO - mozversion platform_changeset: 3e1d7c5d1a58cb1763a2a78de02f96c6bcd2f06d 17:17:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:17:23 INFO - mozversion platform_version: 49.0a1 17:17:23 INFO - using testdate: 1464394643 17:17:23 INFO - actual date: 1464394643 17:17:23 INFO - starting webserver on 'localhost:53550' 17:17:23 INFO - SUITE-START | Running 2 tests 17:17:23 INFO - TEST-START | dromaeo_css 17:17:23 INFO - operating with platform_type : linux_ 17:17:23 INFO - Initialising browser for dromaeo_css test... 17:17:23 INFO - TEST-INFO | started process 14001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiHsiE7/profile http://localhost:53550/getInfo.html) 17:17:29 INFO - PROCESS | 14001 | 17:17:29 INFO - PROCESS | 14001 | (process:14069): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:17:30 INFO - PROCESS | 14001 | __metrics Screen width/height:1600/1200 17:17:30 INFO - PROCESS | 14001 | colorDepth:24 17:17:30 INFO - PROCESS | 14001 | Browser inner width/height: 1024/697 17:17:30 INFO - PROCESS | 14001 | __metrics 17:17:32 ERROR - PROCESS | 14001 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 17:17:33 INFO - TEST-INFO | 14001: exit 0 17:17:33 INFO - Browser initialized. 17:17:33 INFO - Running cycle 1/1 for dromaeo_css test... 17:17:33 INFO - TEST-INFO | started process 14122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiHsiE7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:35 INFO - PROCESS | 14122 | 17:17:35 INFO - PROCESS | 14122 | (process:14182): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:17:45 INFO - PROCESS | 14122 | RSS: Main: 166174720 17:17:45 INFO - PROCESS | 14122 | 17:18:34 INFO - PROCESS | 14122 | 1464394714733 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] 17:20:42 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:53550/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53550/tests/dromaeo/cssquery-ext.html) 17:20:43 INFO - PROCESS | 14122 | RSS: Main: 170258432 17:20:43 INFO - PROCESS | 14122 | 17:23:45 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:53550/tests/dromaeo/cssquery-ext.html (next: http://localhost:53550/tests/dromaeo/cssquery-jquery.html) 17:23:45 INFO - PROCESS | 14122 | RSS: Main: 169234432 17:23:45 INFO - PROCESS | 14122 | 17:26:47 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:53550/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53550/tests/dromaeo/cssquery-mootools.html) 17:26:48 INFO - PROCESS | 14122 | RSS: Main: 170926080 17:26:48 INFO - PROCESS | 14122 | 17:29:49 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:53550/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53550/tests/dromaeo/cssquery-prototype.html) 17:29:50 INFO - PROCESS | 14122 | RSS: Main: 168542208 17:29:50 INFO - PROCESS | 14122 | 17:32:52 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:53550/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53550/tests/dromaeo/cssquery-yui.html) 17:32:53 INFO - PROCESS | 14122 | RSS: Main: 170213376 17:32:53 INFO - PROCESS | 14122 | 17:35:56 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:53550/tests/dromaeo/cssquery-yui.html (next: http://localhost:53550/tests/dromaeo/cssquery-dojo.html) 17:35:56 INFO - PROCESS | 14122 | RSS: Main: 171745280 17:35:56 INFO - PROCESS | 14122 | 17:35:56 INFO - PROCESS | 14122 | __start_tp_report 17:35:56 INFO - PROCESS | 14122 | _x_x_mozilla_page_load 17:35:56 INFO - PROCESS | 14122 | _x_x_mozilla_page_load_details 17:35:56 INFO - PROCESS | 14122 | |i|pagename|runs| 17:35:56 INFO - PROCESS | 14122 | |0;dojo.html;3153.148649864536;3159.1786135604734;3174.2381828361194;3181;3207.502837060255;5592.105263157896;5613.46672066154;5619.6066275360745;5620.91568626471;5643.5767317451255;5475.945240547603;5579.804706835262;5580.581456390777;5585.609007369486;5604.663720176782;4965.131102057144;5026.29631851541;5128.53843154116;5168.689878607277;5235.319408476893;94.07270271161696;5132.538071573557;5157.5100365465405;5166.018456493273;5212.139996900507;5008.924866127011;5033.823816166453;5053.343065401493;5074.517920797518;5091.719955402451;5019.64862459628;5062.721550314731;5067.467915868854;5078.873028174288;5108.6168537359845;4977.50224977503;4991.725455099968;4995.050940321364;5046.419661738873;5048.520390562928;5494.752736126884;5502.8349149525575;5506.256655351556;5553;5615.859603509904;5879.647221166701;5903.52771778261;6021;6023.909641355383;6033.48715359195;5987.37132601075;6020.4280593343565;6048.39516048396;6051.4553690168095;6109.022556390956;5574.749136288877;5606.775728970836;5619.353774315965;5623.803166889139;5626.7186640668215;5996.220491336186;6126.509879209652;6127.556056270658;6144.446999770043;6180.8763824723255;5981.700914954235;5990.73041713124;5996.130561068708;5999.760009599654;6044.455998960115;6069.3020302665755;6075.726592303357;6097.054956481752;6098.481629061491;6112.8777424452155;5724.112762521816;5938.020226662638;5956.434138756811;6006.249218847644;6028.758849646053;5860.472557469848;5911.40885911414;5940.376260492672;5977.491913187341;6061.939380606137;4465.12929978651;4513.638908887281;4535.092981403733;4554.567316104964;4573.153966516139;3963.3856752203455;3964.801759911993;3965.6827453803626;4005.5193376794386;4014.0366312085475;5685.118806584986;5707.571932105026;5708.857278568069;5725.055365864669;5751.942480575224;5920.644761314249;5970.223870896755;6027.246594175728;6046.425589569072;6046.486048685911;5524.558035357162;5734.168545560954;5764.798232061858;5794.246747922827;5805.158252053428;5000.39995200571;5023.120953833065;5032.3961124665275;5040.49595040493;5062.721550314768;6063.090536419572;6280.528960327993;6302.810915672537;6305.684715764193;6306.432421082125;6048.183495228088;6083.878322433527;6115.143879856734;6117.784998161762;6156.5998210116195;6293.496520278458;6293.905591416224;6311.589746666452;6321.494280457644;6328.9050664240995;5828.76684932598;5900.940990590039;5967.31375891778;5985.670788106696;5988.790392336247;6010.789622363196;6070.150178974859;6138.416850399205;6148.077788331786;6159.784407545714;5891.823245302648;5912.793052243151;5957.434043765836;5973.850653733518;6002.549808764273;5716.371199168171;5816.476517113311;5852.970735146297;5938.970305148447;5946.821595352147;5689.914651280317;5713.9428605715075;5728.828135155952;5752.769889204553;5844.444777746107;5909.23179986599;5924.674142922181;5925.614835035709;5930.229070220844;5944.405559444021;5638.351589567253;5710.743016564347;5719.428057194247;5777.422257774189;5823.475887170175 17:35:56 INFO - PROCESS | 14122 | |1;ext.html;578.756922092721;624.2103738770456;641.0224407778138;642.7043559962418;647.9805605831821;42063.78968105159;42532.78733606335;42929;43244;46774;45057.32414013784;45620.54379456204;45659.54340456594;45778;45897.31154032692;8747.475151490915;8868.246199073086;8874.467531948072;8921.420107692978;8946.507942063185;8668.523231222312;8761;8803.383763136582;8816.559172041372;8820.73537793864;8811.251043661296;8858.202761751441;8865;8898.110188981114;8924.152205540464;8765.737027889174;8799.384043116985;8830;8849.115088491164;8883;8819.470831750115;8838.337124715608;8910.797042399257;8937.955310223473;8951.86572201411;41341.58658413407;41776.58223417757;41802;41810;41816.581834181874;3453.6546345365514;3578.284956343514;3591.407417776064;3775.7923314217705;4076.0421300994244;28915.277118072005;29043.70956290452;29096.854515727497;29181.854090729412;33621.49567756485;4517.322401639747;4546.38623785788;4636.605888499448;4675.485696573374;4744.33579298895;343434;348397;348858;349985;350255;34750.13124671904;59857.401425986056;59892.70053649704;60167.09749353763;60314;35584;37112;37112.25775484475;37120.628793711716;37131.25737485289;14142.222177780115;14202.147871127765;14354.49759258421;14389.42442302317;14412.42350305997;12456;12611.30637814929;12615.36923153857;12624.684382890502;12630.81053784194;8440.53577053268;8555.657773689107;8558.57207139653;8589.098144694843;8606.483610983361;3261.4292498812615;3293.061477478907;3319.13702437368;3319.6514365991707;3328.8834890778708;1035.2649618770606;1050.753073027838;1127.0307535519446;1143.874173840877;1184.9407529623484;32392;32700.345993080005;32894.427815449766;33005.834970824995;33203.83398082994;1126.1047467263545;1130.5816847766214;1139.8290256461596;1194;1250.843644544432;17083.145842707814;17185.914070429568;17426.302947882195;17487.562810929576;17526.561835953948;520420;528269;528897;529367;530847;55910.440895590524;57067.42932570704;57321;57418.13872791828;57585.712071439375;1357.911735737174;1377.5109836008073;1382.9446822127204;1389.8818600419077;1397.4480080368198;30096.23884413506;31598.36803263968;31924.68075319217;32264;32424.757524247387;49677.25484117813;49737;49801.50198497969;49953.75023124861;50045.24932126094;427005;428006;429445.4110917827;429484;430363;27816.72183278141;27822.3044423891;28339.291517711397;28633.570496442153;28647.14058578246;43971.24115035491;44153.55846441494;47105;47148;47714;39276.41085383664;39879.80060099681;40108.59891401049;40333.1933361337;40848.59151408448;38352.42471362876;39306;39916.401253980635;40360.79819600883;40372.192556148126;39310.41034384429;39787.80106099451;40689.59310406858;41219;41328.58671413247;35685.64314356823;36015;36767;36882.44676329804;37014.44478332773;27763.58354624642;28447.857760711893;28546;28583.14250572486;28603.284917876386 17:35:56 INFO - PROCESS | 14122 | |2;jquery.html;400.9117994041311;404.89472737088346;406.7640768354353;407.45604617835187;419.8551499732593;14503.782443263359;18142.18360173792;19877.900610496927;19918;20066.297679581217;18630.25478980839;18813.341533046347;19322.71015934762;19357;19375.709364359547;5533.391326954032;5606.467385598372;5747.137929310595;5747.310322761254;5760.0783874580075;5625.268715067035;5637.154426835967;5664.915026274609;5678.148277758328;5701.600887937846;5362.946370536303;5607.54203906983;5611.719414029302;5641.68970706611;5711.685857277848;5486.890262194774;5674.205611214434;5679.488846003859;5867.295924489089;5879.1475236090955;5674.09214525678;5714.51426628737;5715.942840571624;5718.313802343745;5728.083506638959;13373;13826.516071937434;13954.58136255914;14003.229822359766;14056;2128.521082756383;2240.7535171131162;2245.6182448983714;2266.933947088369;2296.0586159674453;10175.949120254425;11535.077193824558;11655.813163142406;14083.788743168861;14462;1919.1651631540324;1944.202876820511;1994.5213148844318;2000.2099170827441;2091.4144039668918;81257.18742812556;83759;84289;84610;85547.57226213829;10972.506237219184;11025.669229923114;11218.887811121947;11434.714132146597;11499.71250718722;15428.305726242346;15495.767563486557;15560.533184004498;15584.454544090902;15642.2178891055;8139;8226.506409615442;8233.423660343838;8295.709650162215;8411.579421028924;7798.922010779933;7858.410619203582;7876.763697089096;8033.959830200812;8095.919040809516;4692.0850434165695;4817.927731084036;4824.49342819006;4833.3958255218095;4855.75721213945;2004.2884775904636;2006.9598608027757;2009.6483115454737;2009.7990200979784;2015.9798402016086;953.3469573342283;1013.7719013221966;1065.1478816946412;1085.3433672627946;1131.3947038334452;17517.474475765746;19147.712784308245;19543.609127817363;19635.21459141647;19915;974.7173319737196;990.6384169777979;1028.3521381529588;1064.984025239622;1103.167108832826;11035.72410689723;11363.204575679623;11414.942925285486;11457.312561246352;11520.193586448868;516301;518584;520314;526473;535483;54884.451155488736;69598.65200673965;90188;90538.54730726437;92646;1015.0509273829141;1020.1634659579222;1023.0230130225765;1045.6340280901622;1059.6767985764416;17590.384336548672;17690;18127.456176314732;18191.909040454713;18244.17901194423;40445.797771010955;41502;41879.58120418757;41911.58088419077;42398;55212;57138;57230.680467338665;57726;58441.4155858453;6108.45023947829;8186.83626327482;8376.12050734664;8453.492790432594;8548.016978047355;11679;11835.940820295844;11998.700032499257;12356.135070544975;12482.812757808459;10990.285631433931;11367.829482557603;11983.161178717406;12125;12223.083268755057;7418.851622967402;8652.567371631267;11215.66353009411;11715.648530544097;12099;11983.400829958293;12028;12055;12176.512939482676;12210;8493.235608795238;8647.178518040777;8683.609237584451;8765.254953329038;8784.297256219359;8308.418410711192;11784.941075294568;11857.466414011218;12085.697857553632;12108 17:35:56 INFO - PROCESS | 14122 | |3;mootools.html;1512.2514355394082;1540.0836502281143;1711.144427786107;1833.44080055583;1842.5854182808878;7849.136594974549;8734;8787.95606021969;9421.387609805366;9432.339736218459;8846.24806891415;9083.909160908406;9122.27021838253;9141.771455713593;9143.131402516767;2413.131272741816;2455.1897873701637;2469.6912885889265;2476.021971321327;2476.2199907029317;2389.0443822470975;2428.9757102429016;2433.4403087289934;2433.6957880264968;2435.512897420514;2388.940276493084;2397.9640305395346;2403.9879800600975;2407.2898494944034;2416.3355077353694;2372.822038347122;2400.099962514057;2402.8077753779658;2423;2445.6209287560278;2375.9406014849596;2389.3787615220167;2401.219603628828;2404.1825779235146;2411.445367565452;9069.18377346042;9105.544722763836;9119.81760364789;9125.77185570366;9180.540972951325;5512.145617429305;5525.060739674265;5570.944290557083;5581.944180558224;5598.58010649203;3407.369636617234;3484.494748261488;3544.8227588620725;3558.733095017858;3568.946465803015;1087.2932593814005;1089.4443833644818;1091.9508622112023;1144.9026832719228;1163.877792831749;12579.685507862285;12631.557895473707;12639.49442022318;12643.74712505754;12651.493940242379;4870.4155501339355;4919.311296418504;4948.430930443045;4952.90094198114;4985.675931064469;10617.150627949746;10728;10775.568977240822;10780.730481737863;10782.73043173927;5557.666540007613;5563.944360556424;5571.8885622288135;5597.076482380362;5597.552195824405;4496.078303947683;4971.403431588233;5052.166392545262;5134.204198349262;5159.226116082617;4139.275626765304;4152.190322887008;4183.518895327076;4203.222403855236;4208.431861698631;1316.1182008054627;1322.9206247624982;1323.9205647661172;1330.7937269723209;1341.155072304442;1061.3843970497094;1070.272214893864;1072.5120070367964;1074.435921141407;1099.780043991205;6132.2947860996555;6382.489400847921;6486.967565162144;6505.869882602321;6533.1180290661105;986.4722373530127;1052.231870734353;1083.2417307884512;1088.7985722641338;1105.0606984063481;4444.11117776446;4559.38448309474;4593.770311484413;4723.929141062887;4792.4249090108715;11533.76932461346;11672.824907626393;11727.237729547553;11757.294562326117;11761.823572646417;11270.887291127148;11313.434328283553;11576.479058442223;11589.536418543164;11754.88245117555;8374.204450577185;8474.703385381483;8577.656893724181;8596.91403085961;8605;6437.8390540235;6458.741650333934;6491;6598.307177746459;6641.203055633355;10408.271421000458;10425.218108642033;10429.217808664229;10810.729731756768;10811.135109191404;10423.322484038514;10485.318454300446;10649.361038337725;10885.238033337908;10899.618513351994;7387.667554959932;7916.406269529693;7992.440529162903;8040.5979701015885;8239.95880020596;8928.330375221754;9021.142991415805;9095.909040909506;9122.95086065111;9183.586738596645;7938.920610793818;8069.273765361146;8247.051589067334;8308.750737477885;8359.707410240855;7984.600769961363;8091.878621820795;8111.594420278844;8148.307393871587;8219;7416.147143078615;7427.145878223857;7476.065491813523;7563.130240022248;7624.5425274483705;5486.149646804752;5507;5571.60998730085;5595.916061259003;5671.780567178076;5611.158326250932;5643;5699.715014249188;5700.828975130753;5723.8855222896145 17:35:56 INFO - PROCESS | 14122 | |4;prototype.html;314.72776048717867;321.7554658459571;323.71351354051666;324.6915430341175;333.9448990916499;5405.297311349519;5480.561555075595;5572.526335261503;5640.520555752761;5675;5488.835334939949;5492.780288788444;5570.972145139269;5580.302462192226;5586.385497595261;4332.133573285356;4343.435353404061;4350.086481838817;4369.235383807821;4383.890402739941;4036.2734707752593;4255;4282.97858510707;4354.629856462205;4368;4225.408442818008;4232.49210094789;4233.322668373061;4244.214820258262;4258.638015768648;4268.743875367457;4276.187524370375;4304.677149213821;4305.698601097924;4316.820005897033;3497.4928635347987;3749.512563366745;3756.1924186300075;3774.414965680324;3799.2781371539318;5305.283786688825;5325.760340784674;5330.680159190461;5340.982344975077;5364.946350536484;4885.5358740919555;4891.657583969123;4911.45973942866;4931.506849315076;4933.582544553143;5569.384878385264;5766.826995190151;5784.322546461521;5792.652440853562;5806.59353845231;4045.817938192759;4080.0819815541267;4087.2847251731127;4093.529244136903;4106.897327566835;5926.4666180044005;6033.245844269466;6057.363976782419;6109.5112391008615;6123.173371594822;3947.486826712509;4185.560516145822;4196.391523229115;4216.47294088239;4244.660427165819;4231.703780735319;4235.830566777356;4254.085371645111;4275.273203555403;4280.957190428118;4911.705297682151;4923.261510773413;4929.3345398371475;4937.481564435682;4955.950440495549;5563.304586926634;5901;5909.852253693606;5911.940880591225;5942.346341902387;1445.3206992713617;1460.189594774889;1470.8161479815024;1480.5780352599456;1487.6429656882488;921.4614807671661;930.1489137439303;935.0555938502162;944.6032666280041;952.4237836109193;5029.497050294941;5034.244863270465;5059.72171530562;5136.486351364833;5138.2292656101135;5332.440093790096;5339.626226164209;5359.464053594609;5402.243685883979;5473.534749546254;5053.519915608012;5081.364829396325;5144.0997825381155;5298.97350513245;5740.56945729072;3179.3800208959033;3193.1538142392283;3201.199700074981;3219.8712051517678;3260.467580237285;6121.96939015311;6274.6548939808745;6294.937050629435;6321.273053598803;6324.430801227912;6093.6039157454625;6109.572329936862;6142.539309551801;6159.798839226308;6169.629822210682;6169.3163473889;6176.845578860474;6183.783567575113;6218.844528886723;6236.03341482071;5801.477866991991;5997.820065398045;6003.219581454383;6009.759609615567;6023.48800351975;5976.62537616342;5988.311344195299;6004.729787159676;6005.099235114593;6013.30846952606;6002.969985150046;6227.1282020516255;6230.376962303733;6254.874902502015;6269.811905642838;4168.979155104205;4190.895227619334;4200.3618588749805;4206.275427074885;4216.76807775563;5826.76692932278;5946.97026514882;5986.16193732869;6042.818715438544;6099.4510494053975;5854.946109700125;5857.50211232033;5882.823515294548;5908.291005079418;5914.260717410324;5858.8242352729485;5877.588568800143;5884.675553156394;5885.087811389241;5894.20428242199;5583;5802.448767367094;5803.448672376117;5804.21643078179;5810.389909059657;5914.911276330945;5927.911081333697;5960.552958528041;5985.371535988658;5995.61028533144;5659.858503537444;5668.384510414512;5782.797602083907;5791;5794.362620111869 17:35:56 INFO - PROCESS | 14122 | |5;yui.html;740.4927624577164;764.9617519124042;800.383704547498;844.4764246167373;866.3762091294268;14819.851801481982;15314.846851531482;15347.539573812803;15860.603484912883;16450.670986580262;15400.61498462539;15517.922410387931;15551.300191491382;15578.53264402067;15647.921760391182;662.5428454366472;805.0982899152942;813.5281536708695;813.772143799737;814.8370325934807;799.1369321133162;818.3984771193168;820.9055958564752;823.6540652925755;828.6850996621275;850.9702160424387;852.7953291210127;852.86780549015;854.0221446443818;859.2395729779159;854.9358798090105;855.9700410485634;858.9398742088025;859.7205908079868;860.4407135362002;620.5035971223049;625.0280813335307;625.140431906129;627.9920727232771;630.397969938712;14434.566962991126;14559.78160327596;14582.197979111144;14607.196604186765;14612.634684132876;12919.547815826494;13047.804282935764;13425.328733563381;13472.595822125351;13497.527586534425;11745.236559623683;11896.940515297454;11950.940245298805;12055.517779288817;12119.697007574792;3828.636279553438;3833.7288372185963;3876.1666241757875;3878.553966293856;3996.800159991989;62514.374856251314;62790.37209627891;62930.370696292906;64014.67992660007;64112.679436602986;11147.219694621299;11215.66353009411;11291.378974156336;11433.199676022765;11448.855114488484;19768.40694779159;19935.800641993683;19950.50123746918;19951.401457956286;19974.201031958848;8122.187781221831;8494.702685406104;8498.74503764888;8650.78373040679;8791.912080879238;4752.073345697556;4826.396700412449;4842.15262329091;4846.660733748674;4867.634927380461;3527.3474407234744;3576.481410195507;3655.049687081378;3655.926881462356;3660.9816950915074;670.0518765946229;674.0159367323664;684.9897251541231;685.533836990851;687.1067612104245;782.3467404717011;793.3653077538062;795.3358945280755;811.6185392865344;821.4167940762006;9793.608255669837;9884.406935583887;9955.203583713286;9968.501574921225;10176.949115254525;779.1351599724302;781.6951388958311;792.4571668407159;799.8240387114826;800.2197857089292;4852.927206091911;4946.925796113062;4953.380827396575;4958.553730164303;4980.12847751642;65609.34390656128;69248.6537567309;71782.28217717861;71932.64033679798;72125.63937180281;61582.69208654018;61930.071048934304;63178;63340.36659633345;64172.358276416635;56446.15330770042;58487.415125849046;58722.41277587255;58832;58842.11736824037;9461.574229159567;9497;9533.484642754482;9550;9605.279604029585;38317.80841095777;38531.80734096424;38660.80669596634;38780.80609596934;38898;46623;51003.74498127485;52433.47566524438;52757;53079.469205307454;12053.457594408097;12085.577004804789;12133.514659413524;12218.633440996784;12297;11988.940055299669;13545.322733863464;13547.864521355055;14261.144331339738;14401.567952961428;13332.333383330988;13801.171929684251;13869.237191954539;14136.22250776176;14172.716545669235;12967.740645186856;13264.938804895392;13628.727425451634;13943.163410195015;14155.929220354245;12126.211796233216;13206;13806.17162970225;14173.078749881224;14250.073745206528;11199.552017919517;11400.144989126014;11514.30914145154;11604.88395116038;11630;11146.442677866236;11969.64091077269;12068.336241506802;12256.693582660148;12304.446299916704 17:35:56 INFO - PROCESS | 14122 | __end_tp_report 17:35:56 INFO - PROCESS | 14122 | __start_cc_report 17:35:56 INFO - PROCESS | 14122 | _x_x_mozilla_cycle_collect,349 17:35:56 INFO - PROCESS | 14122 | __end_cc_report 17:35:56 INFO - PROCESS | 14122 | __startTimestamp1464395756255__endTimestamp 17:35:56 INFO - PROCESS | 14122 | 17:35:56 INFO - PROCESS | 14122 | ------- Summary: start ------- 17:35:56 INFO - PROCESS | 14122 | Number of tests: 6 17:35:56 INFO - PROCESS | 14122 | 17:35:56 INFO - PROCESS | 14122 | [#0] dojo.html Cycles:165 Average:5542.33 Median:5794.25 stddev:793.52 (13.7%) stddev-sans-first:773.50 17:35:56 INFO - PROCESS | 14122 | Values: 3153.1 3159.2 3174.2 3181.0 3207.5 5592.1 5613.5 5619.6 5620.9 5643.6 5475.9 5579.8 5580.6 5585.6 5604.7 4965.1 5026.3 5128.5 5168.7 5235.3 94.1 5132.5 5157.5 5166.0 5212.1 5008.9 5033.8 5053.3 5074.5 5091.7 5019.6 5062.7 5067.5 5078.9 5108.6 4977.5 4991.7 4995.1 5046.4 5048.5 5494.8 5502.8 5506.3 5553.0 5615.9 5879.6 5903.5 6021.0 6023.9 6033.5 5987.4 6020.4 6048.4 6051.5 6109.0 5574.7 5606.8 5619.4 5623.8 5626.7 5996.2 6126.5 6127.6 6144.4 6180.9 5981.7 5990.7 5996.1 5999.8 6044.5 6069.3 6075.7 6097.1 6098.5 6112.9 5724.1 5938.0 5956.4 6006.2 6028.8 5860.5 5911.4 5940.4 5977.5 6061.9 4465.1 4513.6 4535.1 4554.6 4573.2 3963.4 3964.8 3965.7 4005.5 4014.0 5685.1 5707.6 5708.9 5725.1 5751.9 5920.6 5970.2 6027.2 6046.4 6046.5 5524.6 5734.2 5764.8 5794.2 5805.2 5000.4 5023.1 5032.4 5040.5 5062.7 6063.1 6280.5 6302.8 6305.7 6306.4 6048.2 6083.9 6115.1 6117.8 6156.6 6293.5 6293.9 6311.6 6321.5 6328.9 5828.8 5900.9 5967.3 5985.7 5988.8 6010.8 6070.2 6138.4 6148.1 6159.8 5891.8 5912.8 5957.4 5973.9 6002.5 5716.4 5816.5 5853.0 5939.0 5946.8 5689.9 5713.9 5728.8 5752.8 5844.4 5909.2 5924.7 5925.6 5930.2 5944.4 5638.4 5710.7 5719.4 5777.4 5823.5 17:35:56 INFO - PROCESS | 14122 | 17:35:56 INFO - PROCESS | 14122 | [#1] ext.html Cycles:180 Average:58357.88 Median:40530.89 stddev:117095.62 (288.9%) stddev-sans-first:117343.74 17:35:56 INFO - PROCESS | 14122 | Values: 578.8 624.2 641.0 642.7 648.0 42063.8 42532.8 42929.0 43244.0 46774.0 45057.3 45620.5 45659.5 45778.0 45897.3 8747.5 8868.2 8874.5 8921.4 8946.5 8668.5 8761.0 8803.4 8816.6 8820.7 8811.3 8858.2 8865.0 8898.1 8924.2 8765.7 8799.4 8830.0 8849.1 8883.0 8819.5 8838.3 8910.8 8938.0 8951.9 41341.6 41776.6 41802.0 41810.0 41816.6 3453.7 3578.3 3591.4 3775.8 4076.0 28915.3 29043.7 29096.9 29181.9 33621.5 4517.3 4546.4 4636.6 4675.5 4744.3 343434.0 348397.0 348858.0 349985.0 350255.0 34750.1 59857.4 59892.7 60167.1 60314.0 35584.0 37112.0 37112.3 37120.6 37131.3 14142.2 14202.1 14354.5 14389.4 14412.4 12456.0 12611.3 12615.4 12624.7 12630.8 8440.5 8555.7 8558.6 8589.1 8606.5 3261.4 3293.1 3319.1 3319.7 3328.9 1035.3 1050.8 1127.0 1143.9 1184.9 32392.0 32700.3 32894.4 33005.8 33203.8 1126.1 1130.6 1139.8 1194.0 1250.8 17083.1 17185.9 17426.3 17487.6 17526.6 520420.0 528269.0 528897.0 529367.0 530847.0 55910.4 57067.4 57321.0 57418.1 57585.7 1357.9 1377.5 1382.9 1389.9 1397.4 30096.2 31598.4 31924.7 32264.0 32424.8 49677.3 49737.0 49801.5 49953.8 50045.2 427005.0 428006.0 429445.4 429484.0 430363.0 27816.7 27822.3 28339.3 28633.6 28647.1 43971.2 44153.6 47105.0 47148.0 47714.0 39276.4 39879.8 40108.6 40333.2 40848.6 38352.4 39306.0 39916.4 40360.8 40372.2 39310.4 39787.8 40689.6 41219.0 41328.6 35685.6 36015.0 36767.0 36882.4 37014.4 27763.6 28447.9 28546.0 28583.1 28603.3 17:35:56 INFO - PROCESS | 14122 | 17:35:56 INFO - PROCESS | 14122 | [#2] jquery.html Cycles:180 Average:29383.85 Median:2243.19 stddev:86023.73 (3834.9%) stddev-sans-first:86237.52 17:35:56 INFO - PROCESS | 14122 | Values: 400.9 404.9 406.8 407.5 419.9 14503.8 18142.2 19877.9 19918.0 20066.3 18630.3 18813.3 19322.7 19357.0 19375.7 5533.4 5606.5 5747.1 5747.3 5760.1 5625.3 5637.2 5664.9 5678.1 5701.6 5362.9 5607.5 5611.7 5641.7 5711.7 5486.9 5674.2 5679.5 5867.3 5879.1 5674.1 5714.5 5715.9 5718.3 5728.1 13373.0 13826.5 13954.6 14003.2 14056.0 2128.5 2240.8 2245.6 2266.9 2296.1 10175.9 11535.1 11655.8 14083.8 14462.0 1919.2 1944.2 1994.5 2000.2 2091.4 81257.2 83759.0 84289.0 84610.0 85547.6 10972.5 11025.7 11218.9 11434.7 11499.7 15428.3 15495.8 15560.5 15584.5 15642.2 8139.0 8226.5 8233.4 8295.7 8411.6 7798.9 7858.4 7876.8 8034.0 8095.9 4692.1 4817.9 4824.5 4833.4 4855.8 2004.3 2007.0 2009.6 2009.8 2016.0 953.3 1013.8 1065.1 1085.3 1131.4 17517.5 19147.7 19543.6 19635.2 19915.0 974.7 990.6 1028.4 1065.0 1103.2 11035.7 11363.2 11414.9 11457.3 11520.2 516301.0 518584.0 520314.0 526473.0 535483.0 54884.5 69598.7 90188.0 90538.5 92646.0 1015.1 1020.2 1023.0 1045.6 1059.7 17590.4 17690.0 18127.5 18191.9 18244.2 40445.8 41502.0 41879.6 41911.6 42398.0 55212.0 57138.0 57230.7 57726.0 58441.4 6108.5 8186.8 8376.1 8453.5 8548.0 11679.0 11835.9 11998.7 12356.1 12482.8 10990.3 11367.8 11983.2 12125.0 12223.1 7418.9 8652.6 11215.7 11715.6 12099.0 11983.4 12028.0 12055.0 12176.5 12210.0 8493.2 8647.2 8683.6 8765.3 8784.3 8308.4 11784.9 11857.5 12085.7 12108.0 17:35:56 INFO - PROCESS | 14122 | 17:35:56 INFO - PROCESS | 14122 | [#3] mootools.html Cycles:180 Average:6111.84 Median:4527.73 stddev:3433.54 (75.8%) stddev-sans-first:3425.77 17:35:56 INFO - PROCESS | 14122 | Values: 1512.3 1540.1 1711.1 1833.4 1842.6 7849.1 8734.0 8788.0 9421.4 9432.3 8846.2 9083.9 9122.3 9141.8 9143.1 2413.1 2455.2 2469.7 2476.0 2476.2 2389.0 2429.0 2433.4 2433.7 2435.5 2388.9 2398.0 2404.0 2407.3 2416.3 2372.8 2400.1 2402.8 2423.0 2445.6 2375.9 2389.4 2401.2 2404.2 2411.4 9069.2 9105.5 9119.8 9125.8 9180.5 5512.1 5525.1 5570.9 5581.9 5598.6 3407.4 3484.5 3544.8 3558.7 3568.9 1087.3 1089.4 1092.0 1144.9 1163.9 12579.7 12631.6 12639.5 12643.7 12651.5 4870.4 4919.3 4948.4 4952.9 4985.7 10617.2 10728.0 10775.6 10780.7 10782.7 5557.7 5563.9 5571.9 5597.1 5597.6 4496.1 4971.4 5052.2 5134.2 5159.2 4139.3 4152.2 4183.5 4203.2 4208.4 1316.1 1322.9 1323.9 1330.8 1341.2 1061.4 1070.3 1072.5 1074.4 1099.8 6132.3 6382.5 6487.0 6505.9 6533.1 986.5 1052.2 1083.2 1088.8 1105.1 4444.1 4559.4 4593.8 4723.9 4792.4 11533.8 11672.8 11727.2 11757.3 11761.8 11270.9 11313.4 11576.5 11589.5 11754.9 8374.2 8474.7 8577.7 8596.9 8605.0 6437.8 6458.7 6491.0 6598.3 6641.2 10408.3 10425.2 10429.2 10810.7 10811.1 10423.3 10485.3 10649.4 10885.2 10899.6 7387.7 7916.4 7992.4 8040.6 8240.0 8928.3 9021.1 9095.9 9123.0 9183.6 7938.9 8069.3 8247.1 8308.8 8359.7 7984.6 8091.9 8111.6 8148.3 8219.0 7416.1 7427.1 7476.1 7563.1 7624.5 5486.1 5507.0 5571.6 5595.9 5671.8 5611.2 5643.0 5699.7 5700.8 5723.9 17:35:56 INFO - PROCESS | 14122 | 17:35:56 INFO - PROCESS | 14122 | [#4] prototype.html Cycles:180 Average:4863.84 Median:5484.70 stddev:1453.09 (26.5%) stddev-sans-first:1416.48 17:35:56 INFO - PROCESS | 14122 | Values: 314.7 321.8 323.7 324.7 333.9 5405.3 5480.6 5572.5 5640.5 5675.0 5488.8 5492.8 5571.0 5580.3 5586.4 4332.1 4343.4 4350.1 4369.2 4383.9 4036.3 4255.0 4283.0 4354.6 4368.0 4225.4 4232.5 4233.3 4244.2 4258.6 4268.7 4276.2 4304.7 4305.7 4316.8 3497.5 3749.5 3756.2 3774.4 3799.3 5305.3 5325.8 5330.7 5341.0 5364.9 4885.5 4891.7 4911.5 4931.5 4933.6 5569.4 5766.8 5784.3 5792.7 5806.6 4045.8 4080.1 4087.3 4093.5 4106.9 5926.5 6033.2 6057.4 6109.5 6123.2 3947.5 4185.6 4196.4 4216.5 4244.7 4231.7 4235.8 4254.1 4275.3 4281.0 4911.7 4923.3 4929.3 4937.5 4956.0 5563.3 5901.0 5909.9 5911.9 5942.3 1445.3 1460.2 1470.8 1480.6 1487.6 921.5 930.1 935.1 944.6 952.4 5029.5 5034.2 5059.7 5136.5 5138.2 5332.4 5339.6 5359.5 5402.2 5473.5 5053.5 5081.4 5144.1 5299.0 5740.6 3179.4 3193.2 3201.2 3219.9 3260.5 6122.0 6274.7 6294.9 6321.3 6324.4 6093.6 6109.6 6142.5 6159.8 6169.6 6169.3 6176.8 6183.8 6218.8 6236.0 5801.5 5997.8 6003.2 6009.8 6023.5 5976.6 5988.3 6004.7 6005.1 6013.3 6003.0 6227.1 6230.4 6254.9 6269.8 4169.0 4190.9 4200.4 4206.3 4216.8 5826.8 5947.0 5986.2 6042.8 6099.5 5854.9 5857.5 5882.8 5908.3 5914.3 5858.8 5877.6 5884.7 5885.1 5894.2 5583.0 5802.4 5803.4 5804.2 5810.4 5914.9 5927.9 5960.6 5985.4 5995.6 5659.9 5668.4 5782.8 5791.0 5794.4 17:35:56 INFO - PROCESS | 14122 | 17:35:56 INFO - PROCESS | 14122 | [#5] yui.html Cycles:180 Average:16355.79 Median:4849.79 stddev:19642.86 (405.0%) stddev-sans-first:19662.97 17:35:56 INFO - PROCESS | 14122 | Values: 740.5 765.0 800.4 844.5 866.4 14819.9 15314.8 15347.5 15860.6 16450.7 15400.6 15517.9 15551.3 15578.5 15647.9 662.5 805.1 813.5 813.8 814.8 799.1 818.4 820.9 823.7 828.7 851.0 852.8 852.9 854.0 859.2 854.9 856.0 858.9 859.7 860.4 620.5 625.0 625.1 628.0 630.4 14434.6 14559.8 14582.2 14607.2 14612.6 12919.5 13047.8 13425.3 13472.6 13497.5 11745.2 11896.9 11950.9 12055.5 12119.7 3828.6 3833.7 3876.2 3878.6 3996.8 62514.4 62790.4 62930.4 64014.7 64112.7 11147.2 11215.7 11291.4 11433.2 11448.9 19768.4 19935.8 19950.5 19951.4 19974.2 8122.2 8494.7 8498.7 8650.8 8791.9 4752.1 4826.4 4842.2 4846.7 4867.6 3527.3 3576.5 3655.0 3655.9 3661.0 670.1 674.0 685.0 685.5 687.1 782.3 793.4 795.3 811.6 821.4 9793.6 9884.4 9955.2 9968.5 10176.9 779.1 781.7 792.5 799.8 800.2 4852.9 4946.9 4953.4 4958.6 4980.1 65609.3 69248.7 71782.3 71932.6 72125.6 61582.7 61930.1 63178.0 63340.4 64172.4 56446.2 58487.4 58722.4 58832.0 58842.1 9461.6 9497.0 9533.5 9550.0 9605.3 38317.8 38531.8 38660.8 38780.8 38898.0 46623.0 51003.7 52433.5 52757.0 53079.5 12053.5 12085.6 12133.5 12218.6 12297.0 11988.9 13545.3 13547.9 14261.1 14401.6 13332.3 13801.2 13869.2 14136.2 14172.7 12967.7 13264.9 13628.7 13943.2 14155.9 12126.2 13206.0 13806.2 14173.1 14250.1 11199.6 11400.1 11514.3 11604.9 11630.0 11146.4 11969.6 12068.3 12256.7 12304.4 17:35:56 INFO - PROCESS | 14122 | -------- Summary: end -------- 17:35:56 INFO - PROCESS | 14122 | 17:35:57 INFO - TEST-INFO | 14122: exit 0 17:35:57 INFO - TEST-OK | dromaeo_css | took 1113824ms 17:35:57 INFO - TEST-START | kraken 17:35:57 INFO - operating with platform_type : linux_ 17:35:57 INFO - Initialising browser for kraken test... 17:35:57 INFO - TEST-INFO | started process 14354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNSMTW/profile http://localhost:53550/getInfo.html) 17:36:02 INFO - PROCESS | 14354 | 17:36:02 INFO - PROCESS | 14354 | (process:14422): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:36:04 INFO - PROCESS | 14354 | __metrics Screen width/height:1600/1200 17:36:04 INFO - PROCESS | 14354 | colorDepth:24 17:36:04 INFO - PROCESS | 14354 | Browser inner width/height: 1024/697 17:36:04 INFO - PROCESS | 14354 | __metrics 17:36:05 ERROR - PROCESS | 14354 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 17:36:06 INFO - TEST-INFO | 14354: exit 0 17:36:06 INFO - Browser initialized. 17:36:06 INFO - Running cycle 1/1 for kraken test... 17:36:06 INFO - TEST-INFO | started process 14475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNSMTW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:08 INFO - PROCESS | 14475 | 17:36:08 INFO - PROCESS | 14475 | (process:14535): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:36:18 INFO - PROCESS | 14475 | RSS: Main: 167235584 17:36:18 INFO - PROCESS | 14475 | 17:36:21 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53550/tests/kraken/driver.html?testName=audio-beat-detection) 17:36:21 INFO - PROCESS | 14475 | RSS: Main: 172134400 17:36:21 INFO - PROCESS | 14475 | 17:36:24 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53550/tests/kraken/driver.html?testName=audio-dft) 17:36:25 INFO - PROCESS | 14475 | RSS: Main: 171995136 17:36:25 INFO - PROCESS | 14475 | 17:36:28 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53550/tests/kraken/driver.html?testName=audio-fft) 17:36:28 INFO - PROCESS | 14475 | RSS: Main: 166526976 17:36:28 INFO - PROCESS | 14475 | 17:36:30 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53550/tests/kraken/driver.html?testName=audio-oscillator) 17:36:31 INFO - PROCESS | 14475 | RSS: Main: 167829504 17:36:31 INFO - PROCESS | 14475 | 17:36:33 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53550/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:36:34 INFO - PROCESS | 14475 | RSS: Main: 167407616 17:36:34 INFO - PROCESS | 14475 | 17:36:37 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53550/tests/kraken/driver.html?testName=imaging-darkroom) 17:36:38 INFO - PROCESS | 14475 | RSS: Main: 167505920 17:36:38 INFO - PROCESS | 14475 | 17:36:41 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53550/tests/kraken/driver.html?testName=imaging-desaturate) 17:36:42 INFO - PROCESS | 14475 | RSS: Main: 167542784 17:36:42 INFO - PROCESS | 14475 | 17:36:44 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53550/tests/kraken/driver.html?testName=json-parse-financial) 17:36:45 INFO - PROCESS | 14475 | RSS: Main: 167878656 17:36:45 INFO - PROCESS | 14475 | 17:36:47 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53550/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:36:47 INFO - PROCESS | 14475 | RSS: Main: 168001536 17:36:47 INFO - PROCESS | 14475 | 17:36:49 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53550/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:36:50 INFO - PROCESS | 14475 | RSS: Main: 168198144 17:36:50 INFO - PROCESS | 14475 | 17:36:52 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53550/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:36:52 INFO - PROCESS | 14475 | RSS: Main: 168501248 17:36:52 INFO - PROCESS | 14475 | 17:36:55 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:36:56 INFO - PROCESS | 14475 | RSS: Main: 168685568 17:36:56 INFO - PROCESS | 14475 | 17:36:58 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:36:59 INFO - PROCESS | 14475 | RSS: Main: 168615936 17:36:59 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | Cycle 1(1): loaded http://localhost:53550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53550/tests/kraken/driver.html?testName=ai-astar) 17:37:01 INFO - PROCESS | 14475 | RSS: Main: 169205760 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | __start_tp_report 17:37:01 INFO - PROCESS | 14475 | _x_x_mozilla_page_load 17:37:01 INFO - PROCESS | 14475 | _x_x_mozilla_page_load_details 17:37:01 INFO - PROCESS | 14475 | |i|pagename|runs| 17:37:01 INFO - PROCESS | 14475 | |0;ai-astar;112;105;112;111;111;110;110;109;113;112 17:37:01 INFO - PROCESS | 14475 | |1;audio-beat-detection;156;127;158;185;130;157;148;124;169;133 17:37:01 INFO - PROCESS | 14475 | |2;audio-dft;161;162;162;163;162;164;174;167;163;162 17:37:01 INFO - PROCESS | 14475 | |3;audio-fft;74;75;74;170;75;75;76;75;164;76 17:37:01 INFO - PROCESS | 14475 | |4;audio-oscillator;83;83;153;84;84;84;141;84;84;153 17:37:01 INFO - PROCESS | 14475 | |5;imaging-gaussian-blur;117;118;117;120;117;120;120;118;117;117 17:37:01 INFO - PROCESS | 14475 | |6;imaging-darkroom;147;147;147;148;149;147;148;149;147;148 17:37:01 INFO - PROCESS | 14475 | |7;imaging-desaturate;95;97;95;96;95;96;95;96;96;96 17:37:01 INFO - PROCESS | 14475 | |8;json-parse-financial;56;54;53;55;55;56;56;56;55;53 17:37:01 INFO - PROCESS | 14475 | |9;json-stringify-tinderbox;62;63;62;62;62;63;63;62;61;61 17:37:01 INFO - PROCESS | 14475 | |10;stanford-crypto-aes;80;79;79;79;80;82;81;81;111;81 17:37:01 INFO - PROCESS | 14475 | |11;stanford-crypto-ccm;143;123;126;126;122;120;122;131;128;122 17:37:01 INFO - PROCESS | 14475 | |12;stanford-crypto-pbkdf2;167;162;160;161;164;165;165;165;155;163 17:37:01 INFO - PROCESS | 14475 | |13;stanford-crypto-sha256-iterative;66;63;66;71;67;62;64;64;63;64 17:37:01 INFO - PROCESS | 14475 | __end_tp_report 17:37:01 INFO - PROCESS | 14475 | __start_cc_report 17:37:01 INFO - PROCESS | 14475 | _x_x_mozilla_cycle_collect,868 17:37:01 INFO - PROCESS | 14475 | __end_cc_report 17:37:01 INFO - PROCESS | 14475 | __startTimestamp1464395821304__endTimestamp 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | ------- Summary: start ------- 17:37:01 INFO - PROCESS | 14475 | Number of tests: 14 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.27 (2.0%) stddev-sans-first:2.35 17:37:01 INFO - PROCESS | 14475 | Values: 112.0 105.0 112.0 111.0 111.0 110.0 110.0 109.0 113.0 112.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:156.50 stddev:20.04 (12.8%) stddev-sans-first:21.09 17:37:01 INFO - PROCESS | 14475 | Values: 156.0 127.0 158.0 185.0 130.0 157.0 148.0 124.0 169.0 133.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:3.89 (2.4%) stddev-sans-first:3.97 17:37:01 INFO - PROCESS | 14475 | Values: 161.0 162.0 162.0 163.0 162.0 164.0 174.0 167.0 163.0 162.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:38.82 (51.8%) stddev-sans-first:40.54 17:37:01 INFO - PROCESS | 14475 | Values: 74.0 75.0 74.0 170.0 75.0 75.0 76.0 75.0 164.0 76.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:84.00 stddev:31.71 (37.7%) stddev-sans-first:32.77 17:37:01 INFO - PROCESS | 14475 | Values: 83.0 83.0 153.0 84.0 84.0 84.0 141.0 84.0 84.0 153.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.37 (1.2%) stddev-sans-first:1.39 17:37:01 INFO - PROCESS | 14475 | Values: 117.0 118.0 117.0 120.0 117.0 120.0 120.0 118.0 117.0 117.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 17:37:01 INFO - PROCESS | 14475 | Values: 147.0 147.0 147.0 148.0 149.0 147.0 148.0 149.0 147.0 148.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 17:37:01 INFO - PROCESS | 14475 | Values: 95.0 97.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.50 stddev:1.20 (2.2%) stddev-sans-first:1.20 17:37:01 INFO - PROCESS | 14475 | Values: 56.0 54.0 53.0 55.0 55.0 56.0 56.0 56.0 55.0 53.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 17:37:01 INFO - PROCESS | 14475 | Values: 62.0 63.0 62.0 62.0 62.0 63.0 63.0 62.0 61.0 61.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:80.50 stddev:9.79 (12.2%) stddev-sans-first:10.31 17:37:01 INFO - PROCESS | 14475 | Values: 80.0 79.0 79.0 79.0 80.0 82.0 81.0 81.0 111.0 81.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:126.00 stddev:6.75 (5.4%) stddev-sans-first:3.54 17:37:01 INFO - PROCESS | 14475 | Values: 143.0 123.0 126.0 126.0 122.0 120.0 122.0 131.0 128.0 122.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:164.50 stddev:3.43 (2.1%) stddev-sans-first:3.27 17:37:01 INFO - PROCESS | 14475 | Values: 167.0 162.0 160.0 161.0 164.0 165.0 165.0 165.0 155.0 163.0 17:37:01 INFO - PROCESS | 14475 | 17:37:01 INFO - PROCESS | 14475 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.62 (4.0%) stddev-sans-first:2.76 17:37:01 INFO - PROCESS | 14475 | Values: 66.0 63.0 66.0 71.0 67.0 62.0 64.0 64.0 63.0 64.0 17:37:01 INFO - PROCESS | 14475 | -------- Summary: end -------- 17:37:01 INFO - PROCESS | 14475 | 17:37:03 INFO - TEST-INFO | 14475: exit 0 17:37:03 INFO - TEST-OK | kraken | took 66079ms 17:37:03 INFO - SUITE-END | took 1179s 17:37:03 INFO - Completed test suite (00:19:40) 17:37:03 INFO - javascript benchmark 17:37:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7259.088831014273, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.148649864536, 3159.1786135604734, 3174.2381828361194, 3181.0, 3207.502837060255, 5592.105263157896, 5613.46672066154, 5619.6066275360745, 5620.91568626471, 5643.5767317451255, 5475.945240547603, 5579.804706835262, 5580.581456390777, 5585.609007369486, 5604.663720176782, 4965.131102057144, 5026.29631851541, 5128.53843154116, 5168.689878607277, 5235.319408476893, 94.07270271161696, 5132.538071573557, 5157.5100365465405, 5166.018456493273, 5212.139996900507, 5008.924866127011, 5033.823816166453, 5053.343065401493, 5074.517920797518, 5091.719955402451, 5019.64862459628, 5062.721550314731, 5067.467915868854, 5078.873028174288, 5108.6168537359845, 4977.50224977503, 4991.725455099968, 4995.050940321364, 5046.419661738873, 5048.520390562928, 5494.752736126884, 5502.8349149525575, 5506.256655351556, 5553.0, 5615.859603509904, 5879.647221166701, 5903.52771778261, 6021.0, 6023.909641355383, 6033.48715359195, 5987.37132601075, 6020.4280593343565, 6048.39516048396, 6051.4553690168095, 6109.022556390956, 5574.749136288877, 5606.775728970836, 5619.353774315965, 5623.803166889139, 5626.7186640668215, 5996.220491336186, 6126.509879209652, 6127.556056270658, 6144.446999770043, 6180.8763824723255, 5981.700914954235, 5990.73041713124, 5996.130561068708, 5999.760009599654, 6044.455998960115, 6069.3020302665755, 6075.726592303357, 6097.054956481752, 6098.481629061491, 6112.8777424452155, 5724.112762521816, 5938.020226662638, 5956.434138756811, 6006.249218847644, 6028.758849646053, 5860.472557469848, 5911.40885911414, 5940.376260492672, 5977.491913187341, 6061.939380606137, 4465.12929978651, 4513.638908887281, 4535.092981403733, 4554.567316104964, 4573.153966516139, 3963.3856752203455, 3964.801759911993, 3965.6827453803626, 4005.5193376794386, 4014.0366312085475, 5685.118806584986, 5707.571932105026, 5708.857278568069, 5725.055365864669, 5751.942480575224, 5920.644761314249, 5970.223870896755, 6027.246594175728, 6046.425589569072, 6046.486048685911, 5524.558035357162, 5734.168545560954, 5764.798232061858, 5794.246747922827, 5805.158252053428, 5000.39995200571, 5023.120953833065, 5032.3961124665275, 5040.49595040493, 5062.721550314768, 6063.090536419572, 6280.528960327993, 6302.810915672537, 6305.684715764193, 6306.432421082125, 6048.183495228088, 6083.878322433527, 6115.143879856734, 6117.784998161762, 6156.5998210116195, 6293.496520278458, 6293.905591416224, 6311.589746666452, 6321.494280457644, 6328.9050664240995, 5828.76684932598, 5900.940990590039, 5967.31375891778, 5985.670788106696, 5988.790392336247, 6010.789622363196, 6070.150178974859, 6138.416850399205, 6148.077788331786, 6159.784407545714, 5891.823245302648, 5912.793052243151, 5957.434043765836, 5973.850653733518, 6002.549808764273, 5716.371199168171, 5816.476517113311, 5852.970735146297, 5938.970305148447, 5946.821595352147, 5689.914651280317, 5713.9428605715075, 5728.828135155952, 5752.769889204553, 5844.444777746107, 5909.23179986599, 5924.674142922181, 5925.614835035709, 5930.229070220844, 5944.405559444021, 5638.351589567253, 5710.743016564347, 5719.428057194247, 5777.422257774189, 5823.475887170175], "value": 5488.560112751179, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.756922092721, 624.2103738770456, 641.0224407778138, 642.7043559962418, 647.9805605831821, 42063.78968105159, 42532.78733606335, 42929.0, 43244.0, 46774.0, 45057.32414013784, 45620.54379456204, 45659.54340456594, 45778.0, 45897.31154032692, 8747.475151490915, 8868.246199073086, 8874.467531948072, 8921.420107692978, 8946.507942063185, 8668.523231222312, 8761.0, 8803.383763136582, 8816.559172041372, 8820.73537793864, 8811.251043661296, 8858.202761751441, 8865.0, 8898.110188981114, 8924.152205540464, 8765.737027889174, 8799.384043116985, 8830.0, 8849.115088491164, 8883.0, 8819.470831750115, 8838.337124715608, 8910.797042399257, 8937.955310223473, 8951.86572201411, 41341.58658413407, 41776.58223417757, 41802.0, 41810.0, 41816.581834181874, 3453.6546345365514, 3578.284956343514, 3591.407417776064, 3775.7923314217705, 4076.0421300994244, 28915.277118072005, 29043.70956290452, 29096.854515727497, 29181.854090729412, 33621.49567756485, 4517.322401639747, 4546.38623785788, 4636.605888499448, 4675.485696573374, 4744.33579298895, 343434.0, 348397.0, 348858.0, 349985.0, 350255.0, 34750.13124671904, 59857.401425986056, 59892.70053649704, 60167.09749353763, 60314.0, 35584.0, 37112.0, 37112.25775484475, 37120.628793711716, 37131.25737485289, 14142.222177780115, 14202.147871127765, 14354.49759258421, 14389.42442302317, 14412.42350305997, 12456.0, 12611.30637814929, 12615.36923153857, 12624.684382890502, 12630.81053784194, 8440.53577053268, 8555.657773689107, 8558.57207139653, 8589.098144694843, 8606.483610983361, 3261.4292498812615, 3293.061477478907, 3319.13702437368, 3319.6514365991707, 3328.8834890778708, 1035.2649618770606, 1050.753073027838, 1127.0307535519446, 1143.874173840877, 1184.9407529623484, 32392.0, 32700.345993080005, 32894.427815449766, 33005.834970824995, 33203.83398082994, 1126.1047467263545, 1130.5816847766214, 1139.8290256461596, 1194.0, 1250.843644544432, 17083.145842707814, 17185.914070429568, 17426.302947882195, 17487.562810929576, 17526.561835953948, 520420.0, 528269.0, 528897.0, 529367.0, 530847.0, 55910.440895590524, 57067.42932570704, 57321.0, 57418.13872791828, 57585.712071439375, 1357.911735737174, 1377.5109836008073, 1382.9446822127204, 1389.8818600419077, 1397.4480080368198, 30096.23884413506, 31598.36803263968, 31924.68075319217, 32264.0, 32424.757524247387, 49677.25484117813, 49737.0, 49801.50198497969, 49953.75023124861, 50045.24932126094, 427005.0, 428006.0, 429445.4110917827, 429484.0, 430363.0, 27816.72183278141, 27822.3044423891, 28339.291517711397, 28633.570496442153, 28647.14058578246, 43971.24115035491, 44153.55846441494, 47105.0, 47148.0, 47714.0, 39276.41085383664, 39879.80060099681, 40108.59891401049, 40333.1933361337, 40848.59151408448, 38352.42471362876, 39306.0, 39916.401253980635, 40360.79819600883, 40372.192556148126, 39310.41034384429, 39787.80106099451, 40689.59310406858, 41219.0, 41328.58671413247, 35685.64314356823, 36015.0, 36767.0, 36882.44676329804, 37014.44478332773, 27763.58354624642, 28447.857760711893, 28546.0, 28583.14250572486, 28603.284917876386], "value": 18920.110540883757, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.9117994041311, 404.89472737088346, 406.7640768354353, 407.45604617835187, 419.8551499732593, 14503.782443263359, 18142.18360173792, 19877.900610496927, 19918.0, 20066.297679581217, 18630.25478980839, 18813.341533046347, 19322.71015934762, 19357.0, 19375.709364359547, 5533.391326954032, 5606.467385598372, 5747.137929310595, 5747.310322761254, 5760.0783874580075, 5625.268715067035, 5637.154426835967, 5664.915026274609, 5678.148277758328, 5701.600887937846, 5362.946370536303, 5607.54203906983, 5611.719414029302, 5641.68970706611, 5711.685857277848, 5486.890262194774, 5674.205611214434, 5679.488846003859, 5867.295924489089, 5879.1475236090955, 5674.09214525678, 5714.51426628737, 5715.942840571624, 5718.313802343745, 5728.083506638959, 13373.0, 13826.516071937434, 13954.58136255914, 14003.229822359766, 14056.0, 2128.521082756383, 2240.7535171131162, 2245.6182448983714, 2266.933947088369, 2296.0586159674453, 10175.949120254425, 11535.077193824558, 11655.813163142406, 14083.788743168861, 14462.0, 1919.1651631540324, 1944.202876820511, 1994.5213148844318, 2000.2099170827441, 2091.4144039668918, 81257.18742812556, 83759.0, 84289.0, 84610.0, 85547.57226213829, 10972.506237219184, 11025.669229923114, 11218.887811121947, 11434.714132146597, 11499.71250718722, 15428.305726242346, 15495.767563486557, 15560.533184004498, 15584.454544090902, 15642.2178891055, 8139.0, 8226.506409615442, 8233.423660343838, 8295.709650162215, 8411.579421028924, 7798.922010779933, 7858.410619203582, 7876.763697089096, 8033.959830200812, 8095.919040809516, 4692.0850434165695, 4817.927731084036, 4824.49342819006, 4833.3958255218095, 4855.75721213945, 2004.2884775904636, 2006.9598608027757, 2009.6483115454737, 2009.7990200979784, 2015.9798402016086, 953.3469573342283, 1013.7719013221966, 1065.1478816946412, 1085.3433672627946, 1131.3947038334452, 17517.474475765746, 19147.712784308245, 19543.609127817363, 19635.21459141647, 19915.0, 974.7173319737196, 990.6384169777979, 1028.3521381529588, 1064.984025239622, 1103.167108832826, 11035.72410689723, 11363.204575679623, 11414.942925285486, 11457.312561246352, 11520.193586448868, 516301.0, 518584.0, 520314.0, 526473.0, 535483.0, 54884.451155488736, 69598.65200673965, 90188.0, 90538.54730726437, 92646.0, 1015.0509273829141, 1020.1634659579222, 1023.0230130225765, 1045.6340280901622, 1059.6767985764416, 17590.384336548672, 17690.0, 18127.456176314732, 18191.909040454713, 18244.17901194423, 40445.797771010955, 41502.0, 41879.58120418757, 41911.58088419077, 42398.0, 55212.0, 57138.0, 57230.680467338665, 57726.0, 58441.4155858453, 6108.45023947829, 8186.83626327482, 8376.12050734664, 8453.492790432594, 8548.016978047355, 11679.0, 11835.940820295844, 11998.700032499257, 12356.135070544975, 12482.812757808459, 10990.285631433931, 11367.829482557603, 11983.161178717406, 12125.0, 12223.083268755057, 7418.851622967402, 8652.567371631267, 11215.66353009411, 11715.648530544097, 12099.0, 11983.400829958293, 12028.0, 12055.0, 12176.512939482676, 12210.0, 8493.235608795238, 8647.178518040777, 8683.609237584451, 8765.254953329038, 8784.297256219359, 8308.418410711192, 11784.941075294568, 11857.466414011218, 12085.697857553632, 12108.0], "value": 9112.461463602576, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.2514355394082, 1540.0836502281143, 1711.144427786107, 1833.44080055583, 1842.5854182808878, 7849.136594974549, 8734.0, 8787.95606021969, 9421.387609805366, 9432.339736218459, 8846.24806891415, 9083.909160908406, 9122.27021838253, 9141.771455713593, 9143.131402516767, 2413.131272741816, 2455.1897873701637, 2469.6912885889265, 2476.021971321327, 2476.2199907029317, 2389.0443822470975, 2428.9757102429016, 2433.4403087289934, 2433.6957880264968, 2435.512897420514, 2388.940276493084, 2397.9640305395346, 2403.9879800600975, 2407.2898494944034, 2416.3355077353694, 2372.822038347122, 2400.099962514057, 2402.8077753779658, 2423.0, 2445.6209287560278, 2375.9406014849596, 2389.3787615220167, 2401.219603628828, 2404.1825779235146, 2411.445367565452, 9069.18377346042, 9105.544722763836, 9119.81760364789, 9125.77185570366, 9180.540972951325, 5512.145617429305, 5525.060739674265, 5570.944290557083, 5581.944180558224, 5598.58010649203, 3407.369636617234, 3484.494748261488, 3544.8227588620725, 3558.733095017858, 3568.946465803015, 1087.2932593814005, 1089.4443833644818, 1091.9508622112023, 1144.9026832719228, 1163.877792831749, 12579.685507862285, 12631.557895473707, 12639.49442022318, 12643.74712505754, 12651.493940242379, 4870.4155501339355, 4919.311296418504, 4948.430930443045, 4952.90094198114, 4985.675931064469, 10617.150627949746, 10728.0, 10775.568977240822, 10780.730481737863, 10782.73043173927, 5557.666540007613, 5563.944360556424, 5571.8885622288135, 5597.076482380362, 5597.552195824405, 4496.078303947683, 4971.403431588233, 5052.166392545262, 5134.204198349262, 5159.226116082617, 4139.275626765304, 4152.190322887008, 4183.518895327076, 4203.222403855236, 4208.431861698631, 1316.1182008054627, 1322.9206247624982, 1323.9205647661172, 1330.7937269723209, 1341.155072304442, 1061.3843970497094, 1070.272214893864, 1072.5120070367964, 1074.435921141407, 1099.780043991205, 6132.2947860996555, 6382.489400847921, 6486.967565162144, 6505.869882602321, 6533.1180290661105, 986.4722373530127, 1052.231870734353, 1083.2417307884512, 1088.7985722641338, 1105.0606984063481, 4444.11117776446, 4559.38448309474, 4593.770311484413, 4723.929141062887, 4792.4249090108715, 11533.76932461346, 11672.824907626393, 11727.237729547553, 11757.294562326117, 11761.823572646417, 11270.887291127148, 11313.434328283553, 11576.479058442223, 11589.536418543164, 11754.88245117555, 8374.204450577185, 8474.703385381483, 8577.656893724181, 8596.91403085961, 8605.0, 6437.8390540235, 6458.741650333934, 6491.0, 6598.307177746459, 6641.203055633355, 10408.271421000458, 10425.218108642033, 10429.217808664229, 10810.729731756768, 10811.135109191404, 10423.322484038514, 10485.318454300446, 10649.361038337725, 10885.238033337908, 10899.618513351994, 7387.667554959932, 7916.406269529693, 7992.440529162903, 8040.5979701015885, 8239.95880020596, 8928.330375221754, 9021.142991415805, 9095.909040909506, 9122.95086065111, 9183.586738596645, 7938.920610793818, 8069.273765361146, 8247.051589067334, 8308.750737477885, 8359.707410240855, 7984.600769961363, 8091.878621820795, 8111.594420278844, 8148.307393871587, 8219.0, 7416.147143078615, 7427.145878223857, 7476.065491813523, 7563.130240022248, 7624.5425274483705, 5486.149646804752, 5507.0, 5571.60998730085, 5595.916061259003, 5671.780567178076, 5611.158326250932, 5643.0, 5699.715014249188, 5700.828975130753, 5723.8855222896145], "value": 4906.7761672481665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.72776048717867, 321.7554658459571, 323.71351354051666, 324.6915430341175, 333.9448990916499, 5405.297311349519, 5480.561555075595, 5572.526335261503, 5640.520555752761, 5675.0, 5488.835334939949, 5492.780288788444, 5570.972145139269, 5580.302462192226, 5586.385497595261, 4332.133573285356, 4343.435353404061, 4350.086481838817, 4369.235383807821, 4383.890402739941, 4036.2734707752593, 4255.0, 4282.97858510707, 4354.629856462205, 4368.0, 4225.408442818008, 4232.49210094789, 4233.322668373061, 4244.214820258262, 4258.638015768648, 4268.743875367457, 4276.187524370375, 4304.677149213821, 4305.698601097924, 4316.820005897033, 3497.4928635347987, 3749.512563366745, 3756.1924186300075, 3774.414965680324, 3799.2781371539318, 5305.283786688825, 5325.760340784674, 5330.680159190461, 5340.982344975077, 5364.946350536484, 4885.5358740919555, 4891.657583969123, 4911.45973942866, 4931.506849315076, 4933.582544553143, 5569.384878385264, 5766.826995190151, 5784.322546461521, 5792.652440853562, 5806.59353845231, 4045.817938192759, 4080.0819815541267, 4087.2847251731127, 4093.529244136903, 4106.897327566835, 5926.4666180044005, 6033.245844269466, 6057.363976782419, 6109.5112391008615, 6123.173371594822, 3947.486826712509, 4185.560516145822, 4196.391523229115, 4216.47294088239, 4244.660427165819, 4231.703780735319, 4235.830566777356, 4254.085371645111, 4275.273203555403, 4280.957190428118, 4911.705297682151, 4923.261510773413, 4929.3345398371475, 4937.481564435682, 4955.950440495549, 5563.304586926634, 5901.0, 5909.852253693606, 5911.940880591225, 5942.346341902387, 1445.3206992713617, 1460.189594774889, 1470.8161479815024, 1480.5780352599456, 1487.6429656882488, 921.4614807671661, 930.1489137439303, 935.0555938502162, 944.6032666280041, 952.4237836109193, 5029.497050294941, 5034.244863270465, 5059.72171530562, 5136.486351364833, 5138.2292656101135, 5332.440093790096, 5339.626226164209, 5359.464053594609, 5402.243685883979, 5473.534749546254, 5053.519915608012, 5081.364829396325, 5144.0997825381155, 5298.97350513245, 5740.56945729072, 3179.3800208959033, 3193.1538142392283, 3201.199700074981, 3219.8712051517678, 3260.467580237285, 6121.96939015311, 6274.6548939808745, 6294.937050629435, 6321.273053598803, 6324.430801227912, 6093.6039157454625, 6109.572329936862, 6142.539309551801, 6159.798839226308, 6169.629822210682, 6169.3163473889, 6176.845578860474, 6183.783567575113, 6218.844528886723, 6236.03341482071, 5801.477866991991, 5997.820065398045, 6003.219581454383, 6009.759609615567, 6023.48800351975, 5976.62537616342, 5988.311344195299, 6004.729787159676, 6005.099235114593, 6013.30846952606, 6002.969985150046, 6227.1282020516255, 6230.376962303733, 6254.874902502015, 6269.811905642838, 4168.979155104205, 4190.895227619334, 4200.3618588749805, 4206.275427074885, 4216.76807775563, 5826.76692932278, 5946.97026514882, 5986.16193732869, 6042.818715438544, 6099.4510494053975, 5854.946109700125, 5857.50211232033, 5882.823515294548, 5908.291005079418, 5914.260717410324, 5858.8242352729485, 5877.588568800143, 5884.675553156394, 5885.087811389241, 5894.20428242199, 5583.0, 5802.448767367094, 5803.448672376117, 5804.21643078179, 5810.389909059657, 5914.911276330945, 5927.911081333697, 5960.552958528041, 5985.371535988658, 5995.61028533144, 5659.858503537444, 5668.384510414512, 5782.797602083907, 5791.0, 5794.362620111869], "value": 4391.950626669611, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.4927624577164, 764.9617519124042, 800.383704547498, 844.4764246167373, 866.3762091294268, 14819.851801481982, 15314.846851531482, 15347.539573812803, 15860.603484912883, 16450.670986580262, 15400.61498462539, 15517.922410387931, 15551.300191491382, 15578.53264402067, 15647.921760391182, 662.5428454366472, 805.0982899152942, 813.5281536708695, 813.772143799737, 814.8370325934807, 799.1369321133162, 818.3984771193168, 820.9055958564752, 823.6540652925755, 828.6850996621275, 850.9702160424387, 852.7953291210127, 852.86780549015, 854.0221446443818, 859.2395729779159, 854.9358798090105, 855.9700410485634, 858.9398742088025, 859.7205908079868, 860.4407135362002, 620.5035971223049, 625.0280813335307, 625.140431906129, 627.9920727232771, 630.397969938712, 14434.566962991126, 14559.78160327596, 14582.197979111144, 14607.196604186765, 14612.634684132876, 12919.547815826494, 13047.804282935764, 13425.328733563381, 13472.595822125351, 13497.527586534425, 11745.236559623683, 11896.940515297454, 11950.940245298805, 12055.517779288817, 12119.697007574792, 3828.636279553438, 3833.7288372185963, 3876.1666241757875, 3878.553966293856, 3996.800159991989, 62514.374856251314, 62790.37209627891, 62930.370696292906, 64014.67992660007, 64112.679436602986, 11147.219694621299, 11215.66353009411, 11291.378974156336, 11433.199676022765, 11448.855114488484, 19768.40694779159, 19935.800641993683, 19950.50123746918, 19951.401457956286, 19974.201031958848, 8122.187781221831, 8494.702685406104, 8498.74503764888, 8650.78373040679, 8791.912080879238, 4752.073345697556, 4826.396700412449, 4842.15262329091, 4846.660733748674, 4867.634927380461, 3527.3474407234744, 3576.481410195507, 3655.049687081378, 3655.926881462356, 3660.9816950915074, 670.0518765946229, 674.0159367323664, 684.9897251541231, 685.533836990851, 687.1067612104245, 782.3467404717011, 793.3653077538062, 795.3358945280755, 811.6185392865344, 821.4167940762006, 9793.608255669837, 9884.406935583887, 9955.203583713286, 9968.501574921225, 10176.949115254525, 779.1351599724302, 781.6951388958311, 792.4571668407159, 799.8240387114826, 800.2197857089292, 4852.927206091911, 4946.925796113062, 4953.380827396575, 4958.553730164303, 4980.12847751642, 65609.34390656128, 69248.6537567309, 71782.28217717861, 71932.64033679798, 72125.63937180281, 61582.69208654018, 61930.071048934304, 63178.0, 63340.36659633345, 64172.358276416635, 56446.15330770042, 58487.415125849046, 58722.41277587255, 58832.0, 58842.11736824037, 9461.574229159567, 9497.0, 9533.484642754482, 9550.0, 9605.279604029585, 38317.80841095777, 38531.80734096424, 38660.80669596634, 38780.80609596934, 38898.0, 46623.0, 51003.74498127485, 52433.47566524438, 52757.0, 53079.469205307454, 12053.457594408097, 12085.577004804789, 12133.514659413524, 12218.633440996784, 12297.0, 11988.940055299669, 13545.322733863464, 13547.864521355055, 14261.144331339738, 14401.567952961428, 13332.333383330988, 13801.171929684251, 13869.237191954539, 14136.22250776176, 14172.716545669235, 12967.740645186856, 13264.938804895392, 13628.727425451634, 13943.163410195015, 14155.929220354245, 12126.211796233216, 13206.0, 13806.17162970225, 14173.078749881224, 14250.073745206528, 11199.552017919517, 11400.144989126014, 11514.30914145154, 11604.88395116038, 11630.0, 11146.442677866236, 11969.64091077269, 12068.336241506802, 12256.693582660148, 12304.446299916704], "value": 7174.3486500585, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 112.0, 111.0, 111.0, 110.0, 110.0, 109.0, 113.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 158.0, 185.0, 130.0, 157.0, 148.0, 124.0, 169.0, 133.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 162.0, 164.0, 174.0, 167.0, 163.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 170.0, 75.0, 75.0, 76.0, 75.0, 164.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 153.0, 84.0, 84.0, 84.0, 141.0, 84.0, 84.0, 153.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 120.0, 117.0, 120.0, 120.0, 118.0, 117.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 149.0, 147.0, 148.0, 149.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 55.0, 55.0, 56.0, 56.0, 56.0, 55.0, 53.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 61.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 80.0, 82.0, 81.0, 81.0, 111.0, 81.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 123.0, 126.0, 126.0, 122.0, 120.0, 122.0, 131.0, 128.0, 122.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 160.0, 161.0, 164.0, 165.0, 165.0, 165.0, 155.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 66.0, 71.0, 67.0, 62.0, 64.0, 64.0, 63.0, 64.0], "value": 65.0, "unit": "score"}]}]} 17:37:03 INFO - Return code: 0 17:37:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:37:03 ERROR - # TBPL SUCCESS # 17:37:03 INFO - Running post-action listener: _resource_record_post_action 17:37:03 INFO - ##### 17:37:03 INFO - ##### Finished run-tests step (success) 17:37:03 INFO - ##### 17:37:03 INFO - Running post-run listener: _resource_record_post_run 17:37:03 INFO - Total resource usage - Wall time: 1207s; CPU: 14.0%; Read bytes: 4096; Write bytes: 550707200; Read time: 108; Write time: 3905196 17:37:03 INFO - TinderboxPrint: CPU usage
13.9% 17:37:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 108 17:37:03 INFO - TinderboxPrint: I/O write bytes / time
550,707,200 / 3,905,196 17:37:03 INFO - TinderboxPrint: CPU idle
8,295.3 (86.1%) 17:37:03 INFO - TinderboxPrint: CPU user
1,220.7 (12.7%) 17:37:03 INFO - TinderboxPrint: Swap in / out
0 / 0 17:37:03 INFO - install - Wall time: 23s; CPU: 23.0%; Read bytes: 0; Write bytes: 236126208; Read time: 0; Write time: 2316356 17:37:03 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 4096; Write bytes: 309989376; Read time: 108; Write time: 1521196 17:37:04 INFO - Running post-run listener: _upload_blobber_files 17:37:04 INFO - Blob upload gear active. 17:37:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:37:04 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 17:37:04 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'] 17:37:04 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 17:37:04 INFO - (blobuploader) - INFO - Open directory for files ... 17:37:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:37:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:37:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:08 INFO - (blobuploader) - INFO - Done attempting. 17:37:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:37:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:37:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:09 INFO - (blobuploader) - INFO - Done attempting. 17:37:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:37:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:37:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:10 INFO - (blobuploader) - INFO - Done attempting. 17:37:10 INFO - (blobuploader) - INFO - Iteration through files over. 17:37:10 INFO - Return code: 0 17:37:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:37:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:37:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a4ec09bde8046abe07631fd04ee269b5b1596ae0c1bde42d976e8a9203624bb95dfcdc7435f21de2997ff9cae71deda82b04621f39f75c4496838fecade026d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62198186d9bff21b284980dbc5ebc027b795e1449a3bd67c16406b2fe06308904001e65abc78d1e5925241cef128ac65f66b954c82537b4871b0ebb106bd7edd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45c13a1a2f0270dfb3ef974eea151d514e26b01eb53ccf69c0ce82fb062d6bd1e9d65bb1ca2b7dd3a8f3f5d6e5700f1ed93436ae045c35531281375a63fa6c2d"} 17:37:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:37:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:37:10 INFO - Contents: 17:37:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a4ec09bde8046abe07631fd04ee269b5b1596ae0c1bde42d976e8a9203624bb95dfcdc7435f21de2997ff9cae71deda82b04621f39f75c4496838fecade026d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62198186d9bff21b284980dbc5ebc027b795e1449a3bd67c16406b2fe06308904001e65abc78d1e5925241cef128ac65f66b954c82537b4871b0ebb106bd7edd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45c13a1a2f0270dfb3ef974eea151d514e26b01eb53ccf69c0ce82fb062d6bd1e9d65bb1ca2b7dd3a8f3f5d6e5700f1ed93436ae045c35531281375a63fa6c2d"} 17:37:10 INFO - Running post-run listener: copy_logs_to_upload_dir 17:37:10 INFO - Copying logs to upload dir... 17:37:10 INFO - mkdir: /builds/slave/test/build/upload/logs 17:37:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.800864 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-27 17:37:10.322113) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 17:37:10.325935) ========= 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=33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589 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/0a4ec09bde8046abe07631fd04ee269b5b1596ae0c1bde42d976e8a9203624bb95dfcdc7435f21de2997ff9cae71deda82b04621f39f75c4496838fecade026d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62198186d9bff21b284980dbc5ebc027b795e1449a3bd67c16406b2fe06308904001e65abc78d1e5925241cef128ac65f66b954c82537b4871b0ebb106bd7edd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45c13a1a2f0270dfb3ef974eea151d514e26b01eb53ccf69c0ce82fb062d6bd1e9d65bb1ca2b7dd3a8f3f5d6e5700f1ed93436ae045c35531281375a63fa6c2d"} build_url:https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/HiuoJDpcTlOjumpwmAN_MQ/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/0a4ec09bde8046abe07631fd04ee269b5b1596ae0c1bde42d976e8a9203624bb95dfcdc7435f21de2997ff9cae71deda82b04621f39f75c4496838fecade026d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62198186d9bff21b284980dbc5ebc027b795e1449a3bd67c16406b2fe06308904001e65abc78d1e5925241cef128ac65f66b954c82537b4871b0ebb106bd7edd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45c13a1a2f0270dfb3ef974eea151d514e26b01eb53ccf69c0ce82fb062d6bd1e9d65bb1ca2b7dd3a8f3f5d6e5700f1ed93436ae045c35531281375a63fa6c2d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 17:37:10.350530) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:37:10.350842) ========= 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=33d5923976266a1c518c4bf7000001ab-1464394375.776300-2010797589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 17:37:10.432374) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 17:37:10.432700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 17:37:10.432998) ========= ========= Total master_lag: 0.15 =========