builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1463621463.9 results: success (0) buildid: 20160518172845 builduid: 213804cc4b3045a08e311bdc6ec89854 revision: 5bd03d0a58768dbe3184fa9f001372291bd679b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.896719) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.897207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.897587) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.914102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.914415) ========= 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=826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 18:31:04-- 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% 66.9M=0s 2016-05-18 18:31:04 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099942 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.063821) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.064172) ========= 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=826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021799 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.097881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.098343) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5bd03d0a58768dbe3184fa9f001372291bd679b8 --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 5bd03d0a58768dbe3184fa9f001372291bd679b8 --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=826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 18:31:04,594 truncating revision to first 12 chars 2016-05-18 18:31:04,594 Setting DEBUG logging. 2016-05-18 18:31:04,595 attempt 1/10 2016-05-18 18:31:04,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5bd03d0a5876?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 18:31:05,004 unpacking tar archive at: fx-team-5bd03d0a5876/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723547 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.834752) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.835057) ========= script_repo_revision: 5bd03d0a58768dbe3184fa9f001372291bd679b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.835510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.835832) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.843719) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-18 18:31:04.844078) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:31:05 INFO - MultiFileLogger online at 20160518 18:31:05 in /builds/slave/test 18:31:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:31:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:31:05 INFO - {'append_to_log': False, 18:31:05 INFO - 'base_work_dir': '/builds/slave/test', 18:31:05 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:31:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:31:05 INFO - 'branch': 'Fx-Team-Non-PGO', 18:31:05 INFO - 'buildbot_json_path': 'buildprops.json', 18:31:05 INFO - 'config_files': ('talos/linux_config.py',), 18:31:05 INFO - 'default_actions': ('clobber', 18:31:05 INFO - 'read-buildbot-config', 18:31:05 INFO - 'download-and-extract', 18:31:05 INFO - 'populate-webroot', 18:31:05 INFO - 'create-virtualenv', 18:31:05 INFO - 'install', 18:31:05 INFO - 'run-tests'), 18:31:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:31:05 INFO - 'download_minidump_stackwalk': True, 18:31:05 INFO - 'download_symbols': 'ondemand', 18:31:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:31:05 INFO - 'tooltool.py': '/tools/tooltool.py', 18:31:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:31:05 INFO - '/tools/misc-python/virtualenv.py')}, 18:31:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:31:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:31:05 INFO - 'installer_path': 'installer.exe', 18:31:05 INFO - 'log_level': 'info', 18:31:05 INFO - 'log_name': 'talos', 18:31:05 INFO - 'log_to_console': True, 18:31:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:31:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:31:05 INFO - 'opt_config_files': (), 18:31:05 INFO - 'pip_index': False, 18:31:05 INFO - 'sps_profile': False, 18:31:05 INFO - 'sps_profile_interval': 0, 18:31:05 INFO - 'suite': 'dromaeojs-e10s', 18:31:05 INFO - 'system_bits': '32', 18:31:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:31:05 INFO - 'title': 'talos-linux64-ix-052', 18:31:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:31:05 INFO - 'use_talos_json': True, 18:31:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:31:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:31:05 INFO - 'work_dir': 'build'} 18:31:05 INFO - ##### 18:31:05 INFO - ##### Running clobber step. 18:31:05 INFO - ##### 18:31:05 INFO - Running pre-action listener: _resource_record_pre_action 18:31:05 INFO - Running main action method: clobber 18:31:05 INFO - rmtree: /builds/slave/test/build 18:31:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:31:06 INFO - Running post-action listener: _resource_record_post_action 18:31:06 INFO - ##### 18:31:06 INFO - ##### Finished clobber step (success) 18:31:06 INFO - ##### 18:31:06 INFO - ##### 18:31:06 INFO - ##### Running read-buildbot-config step. 18:31:06 INFO - ##### 18:31:06 INFO - Running pre-action listener: _resource_record_pre_action 18:31:06 INFO - Running main action method: read_buildbot_config 18:31:06 INFO - Using buildbot properties: 18:31:06 INFO - { 18:31:06 INFO - "project": "", 18:31:06 INFO - "product": "firefox", 18:31:06 INFO - "script_repo_revision": "production", 18:31:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:31:06 INFO - "repository": "", 18:31:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:31:06 INFO - "buildid": "20160518172845", 18:31:06 INFO - "pgo_build": "False", 18:31:06 INFO - "basedir": "/builds/slave/test", 18:31:06 INFO - "buildnumber": 1514, 18:31:06 INFO - "slavename": "talos-linux64-ix-052", 18:31:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:31:06 INFO - "platform": "ubuntu64_hw", 18:31:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:31:06 INFO - "branch": "fx-team", 18:31:06 INFO - "repo_path": "integration/fx-team", 18:31:06 INFO - "revision": "5bd03d0a58768dbe3184fa9f001372291bd679b8", 18:31:06 INFO - "stage_platform": "linux64", 18:31:06 INFO - "builduid": "213804cc4b3045a08e311bdc6ec89854", 18:31:06 INFO - "slavebuilddir": "test" 18:31:06 INFO - } 18:31:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:31:06 INFO - Running post-action listener: _resource_record_post_action 18:31:06 INFO - ##### 18:31:06 INFO - ##### Finished read-buildbot-config step (success) 18:31:06 INFO - ##### 18:31:06 INFO - ##### 18:31:06 INFO - ##### Running download-and-extract step. 18:31:06 INFO - ##### 18:31:06 INFO - Running pre-action listener: _resource_record_pre_action 18:31:06 INFO - Running main action method: download_and_extract 18:31:06 INFO - mkdir: /builds/slave/test/build/tests 18:31:06 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')]} 18:31:06 INFO - https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:31:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:31:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:31:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:18 INFO - Downloaded 1361 bytes. 18:31:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:31:18 INFO - Using the following test package requirements: 18:31:18 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:31:18 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:31:18 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:31:18 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:18 INFO - u'jsshell-linux-x86_64.zip'], 18:31:18 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:31:18 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:31:18 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:31:18 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:31:18 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:31:18 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:31:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:18 INFO - https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:31:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:31:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:31:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:30 INFO - Downloaded 22812201 bytes. 18:31:30 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'] 18:31:30 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 18:31:31 INFO - Return code: 0 18:31:31 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 18:31:31 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')]} 18:31:31 INFO - https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:31:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:31:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:31:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:33 INFO - Downloaded 22812201 bytes. 18:31:33 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'] 18:31:33 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 18:31:34 INFO - Return code: 0 18:31: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')]} 18:31:34 INFO - https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:31:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:31:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:31:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:36 INFO - Downloaded 10840194 bytes. 18:31:36 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'] 18:31:36 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 18:31:36 INFO - Return code: 0 18:31:36 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')]} 18:31:36 INFO - https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:31:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:31:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:31:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:38 INFO - Downloaded 54801701 bytes. 18:31:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:31:38 INFO - mkdir: /builds/slave/test/properties 18:31:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:38 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:38 INFO - Contents: 18:31:38 INFO - build_url:https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:31:39 INFO - Running post-action listener: _resource_record_post_action 18:31:39 INFO - Running post-action listener: set_extra_try_arguments 18:31:39 INFO - ##### 18:31:39 INFO - ##### Finished download-and-extract step (success) 18:31:39 INFO - ##### 18:31:39 INFO - ##### 18:31:39 INFO - ##### Running populate-webroot step. 18:31:39 INFO - ##### 18:31:39 INFO - Running pre-action listener: _resource_record_pre_action 18:31:39 INFO - Running main action method: populate_webroot 18:31:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:39 INFO - '--tppagecycles', 18:31:39 INFO - '7'], 18:31:39 INFO - 'tests': ['tsvgm']}}, 18:31:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:31:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:31:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:31:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:31:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:31:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:31:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:39 INFO - 'talos_options': ['--disable-e10s'], 18:31:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:39 INFO - 'talos_options': ['--disable-e10s'], 18:31:39 INFO - 'tests': ['damp', 'tps']}, 18:31:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:39 INFO - 'tests': ['damp', 'tps']}, 18:31:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:31:39 INFO - 'tests': ['dromaeo_dom']}, 18:31:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:31:39 INFO - 'tests': ['a11yr', 18:31:39 INFO - 'ts_paint', 18:31:39 INFO - 'tpaint', 18:31:39 INFO - 'sessionrestore', 18:31:39 INFO - 'sessionrestore_no_auto_restore', 18:31:39 INFO - 'tabpaint']}, 18:31:39 INFO - 'other-e10s': {'tests': ['a11yr', 18:31:39 INFO - 'ts_paint', 18:31:39 INFO - 'tpaint', 18:31:39 INFO - 'sessionrestore', 18:31:39 INFO - 'sessionrestore_no_auto_restore', 18:31:39 INFO - 'tabpaint']}, 18:31:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:31:39 INFO - 'ts_paint', 18:31:39 INFO - 'tpaint', 18:31:39 INFO - 'sessionrestore', 18:31:39 INFO - 'sessionrestore_no_auto_restore', 18:31:39 INFO - 'tabpaint']}, 18:31:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:31:39 INFO - 'ts_paint', 18:31:39 INFO - 'tpaint', 18:31:39 INFO - 'sessionrestore', 18:31:39 INFO - 'sessionrestore_no_auto_restore', 18:31:39 INFO - 'tabpaint']}, 18:31:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:31:39 INFO - 'tests': ['a11yr', 18:31:39 INFO - 'ts_paint', 18:31:39 INFO - 'tpaint', 18:31:39 INFO - 'sessionrestore', 18:31:39 INFO - 'sessionrestore_no_auto_restore', 18:31:39 INFO - 'tabpaint']}, 18:31:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:31:39 INFO - 'tests': ['a11yr', 18:31:39 INFO - 'ts_paint', 18:31:39 INFO - 'tpaint', 18:31:39 INFO - 'sessionrestore', 18:31:39 INFO - 'sessionrestore_no_auto_restore', 18:31:39 INFO - 'tabpaint']}, 18:31:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:31:39 INFO - 'tests': ['tsvgx', 18:31:39 INFO - 'tsvgr_opacity', 18:31:39 INFO - 'tart', 18:31:39 INFO - 'tscrollx', 18:31:39 INFO - 'cart']}, 18:31:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:31:39 INFO - 'tsvgr_opacity', 18:31:39 INFO - 'tart', 18:31:39 INFO - 'tscrollx', 18:31:39 INFO - 'cart']}, 18:31:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:39 INFO - 'talos_options': ['--disable-e10s'], 18:31:39 INFO - 'tests': ['tp5o']}, 18:31:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:39 INFO - 'tests': ['tp5o']}, 18:31:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:39 INFO - 'talos_options': ['--disable-e10s', 18:31:39 INFO - '--xperf_path', 18:31:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:39 INFO - 'tests': ['tp5n']}, 18:31:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:39 INFO - 'talos_options': ['--xperf_path', 18:31:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:39 INFO - 'tests': ['tp5n']}}, 18:31:39 INFO - 'talos.zip': {'path': '', 18:31:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:39 INFO - Running post-action listener: _resource_record_post_action 18:31:39 INFO - ##### 18:31:39 INFO - ##### Finished populate-webroot step (success) 18:31:39 INFO - ##### 18:31:39 INFO - ##### 18:31:39 INFO - ##### Running create-virtualenv step. 18:31:39 INFO - ##### 18:31:39 INFO - Running pre-action listener: _resource_record_pre_action 18:31:39 INFO - Running main action method: create_virtualenv 18:31:39 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:39 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 18:31:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:39 INFO - Using real prefix '/usr' 18:31:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:40 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:41 INFO - Installing pip.................done. 18:31:42 INFO - Return code: 0 18:31:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0c9ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d9c0>, '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 0x228e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228ed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', '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 18:31:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:31:42 INFO - Using env: {'DISPLAY': ':0', 18:31:42 INFO - 'HOME': '/home/cltbld', 18:31:42 INFO - 'LANG': 'en_US.UTF-8', 18:31:42 INFO - 'LANGUAGE': 'en_US:en', 18:31:42 INFO - 'LOGNAME': 'cltbld', 18:31:42 INFO - 'MAIL': '/var/mail/cltbld', 18:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:42 INFO - 'MOZ_NO_REMOTE': '1', 18:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:42 INFO - 'NO_EM_RESTART': '1', 18:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:42 INFO - 'PWD': '/builds/slave/test', 18:31:42 INFO - 'SHELL': '/bin/bash', 18:31:42 INFO - 'SHLVL': '1', 18:31:42 INFO - 'TERM': 'linux', 18:31:42 INFO - 'TMOUT': '86400', 18:31:42 INFO - 'USER': 'cltbld', 18:31:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', 18:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:42 INFO - '_': '/tools/buildbot/bin/python'} 18:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:42 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 18:31:42 INFO - Cleaning up... 18:31:42 INFO - Return code: 0 18:31:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9a0c9ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d9c0>, '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 0x228e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228ed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', '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 18:31:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:31:42 INFO - Using env: {'DISPLAY': ':0', 18:31:42 INFO - 'HOME': '/home/cltbld', 18:31:42 INFO - 'LANG': 'en_US.UTF-8', 18:31:42 INFO - 'LANGUAGE': 'en_US:en', 18:31:42 INFO - 'LOGNAME': 'cltbld', 18:31:42 INFO - 'MAIL': '/var/mail/cltbld', 18:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:42 INFO - 'MOZ_NO_REMOTE': '1', 18:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:42 INFO - 'NO_EM_RESTART': '1', 18:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:42 INFO - 'PWD': '/builds/slave/test', 18:31:42 INFO - 'SHELL': '/bin/bash', 18:31:42 INFO - 'SHLVL': '1', 18:31:42 INFO - 'TERM': 'linux', 18:31:42 INFO - 'TMOUT': '86400', 18:31:42 INFO - 'USER': 'cltbld', 18:31:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', 18:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:42 INFO - '_': '/tools/buildbot/bin/python'} 18:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:42 INFO - Downloading/unpacking psutil>=3.1.1 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:44 INFO - Installing collected packages: psutil 18:31:44 INFO - Running setup.py install for psutil 18:31:44 INFO - building 'psutil._psutil_linux' extension 18:31:44 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 18:31:44 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 18:31:44 INFO - building 'psutil._psutil_posix' extension 18:31:44 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 18:31:44 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 18:31:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:44 INFO - Successfully installed psutil 18:31:44 INFO - Cleaning up... 18:31:45 INFO - Return code: 0 18:31:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0c9ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d9c0>, '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 0x228e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228ed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', '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 18:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:31:45 INFO - Using env: {'DISPLAY': ':0', 18:31:45 INFO - 'HOME': '/home/cltbld', 18:31:45 INFO - 'LANG': 'en_US.UTF-8', 18:31:45 INFO - 'LANGUAGE': 'en_US:en', 18:31:45 INFO - 'LOGNAME': 'cltbld', 18:31:45 INFO - 'MAIL': '/var/mail/cltbld', 18:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:45 INFO - 'MOZ_NO_REMOTE': '1', 18:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:45 INFO - 'NO_EM_RESTART': '1', 18:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:45 INFO - 'PWD': '/builds/slave/test', 18:31:45 INFO - 'SHELL': '/bin/bash', 18:31:45 INFO - 'SHLVL': '1', 18:31:45 INFO - 'TERM': 'linux', 18:31:45 INFO - 'TMOUT': '86400', 18:31:45 INFO - 'USER': 'cltbld', 18:31:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', 18:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:45 INFO - '_': '/tools/buildbot/bin/python'} 18:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:31:45 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 18:31:45 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 18:31:45 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 18:31:45 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 18:31:45 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 18:31:45 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 18:31:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:31:47 INFO - Installing collected packages: mozsystemmonitor 18:31:47 INFO - Running setup.py install for mozsystemmonitor 18:31:47 INFO - Successfully installed mozsystemmonitor 18:31:47 INFO - Cleaning up... 18:31:47 INFO - Return code: 0 18:31:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31:47 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')]} 18:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:47 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')]} 18:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:47 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 0x7f9a0c9ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d9c0>, '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 0x228e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228ed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', '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 18:31:47 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 18:31:47 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 18:31:47 INFO - Using env: {'DISPLAY': ':0', 18:31:47 INFO - 'HOME': '/home/cltbld', 18:31:47 INFO - 'LANG': 'en_US.UTF-8', 18:31:47 INFO - 'LANGUAGE': 'en_US:en', 18:31:47 INFO - 'LOGNAME': 'cltbld', 18:31:47 INFO - 'MAIL': '/var/mail/cltbld', 18:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:47 INFO - 'MOZ_NO_REMOTE': '1', 18:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:47 INFO - 'NO_EM_RESTART': '1', 18:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:47 INFO - 'PWD': '/builds/slave/test', 18:31:47 INFO - 'SHELL': '/bin/bash', 18:31:47 INFO - 'SHLVL': '1', 18:31:47 INFO - 'TERM': 'linux', 18:31:47 INFO - 'TMOUT': '86400', 18:31:47 INFO - 'USER': 'cltbld', 18:31:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', 18:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:47 INFO - '_': '/tools/buildbot/bin/python'} 18:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:47 INFO - Downloading/unpacking blobuploader==1.2.4 18:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:49 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:50 INFO - Downloading docopt-0.6.1.tar.gz 18:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:50 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:50 INFO - Running setup.py install for blobuploader 18:31:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:50 INFO - Running setup.py install for requests 18:31:50 INFO - Running setup.py install for docopt 18:31:50 INFO - Successfully installed blobuploader requests docopt 18:31:50 INFO - Cleaning up... 18:31:50 INFO - Return code: 0 18:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:50 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 0x7f9a0c9ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d9c0>, '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 0x228e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228ed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', '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 18:31:50 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 18:31:50 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 18:31:50 INFO - Using env: {'DISPLAY': ':0', 18:31:50 INFO - 'HOME': '/home/cltbld', 18:31:50 INFO - 'LANG': 'en_US.UTF-8', 18:31:50 INFO - 'LANGUAGE': 'en_US:en', 18:31:50 INFO - 'LOGNAME': 'cltbld', 18:31:50 INFO - 'MAIL': '/var/mail/cltbld', 18:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:50 INFO - 'MOZ_NO_REMOTE': '1', 18:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:50 INFO - 'NO_EM_RESTART': '1', 18:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:50 INFO - 'PWD': '/builds/slave/test', 18:31:50 INFO - 'SHELL': '/bin/bash', 18:31:50 INFO - 'SHLVL': '1', 18:31:50 INFO - 'TERM': 'linux', 18:31:50 INFO - 'TMOUT': '86400', 18:31:50 INFO - 'USER': 'cltbld', 18:31:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', 18:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:50 INFO - '_': '/tools/buildbot/bin/python'} 18:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:51 INFO - Running setup.py (path:/tmp/pip-jji5lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:51 INFO - Running setup.py (path:/tmp/pip-cfPz5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:51 INFO - Running setup.py (path:/tmp/pip-kG4DlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:51 INFO - Running setup.py (path:/tmp/pip-k7o4OU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:51 INFO - Running setup.py (path:/tmp/pip-1_Tsx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:51 INFO - Running setup.py (path:/tmp/pip-aTi2UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:51 INFO - Running setup.py (path:/tmp/pip-s6jchc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:51 INFO - Running setup.py (path:/tmp/pip-CoFbiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:51 INFO - Running setup.py (path:/tmp/pip-LO0WuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:51 INFO - Running setup.py (path:/tmp/pip-YMDyP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:51 INFO - Running setup.py (path:/tmp/pip-UWPuFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:51 INFO - Running setup.py (path:/tmp/pip-KEzkEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:51 INFO - Running setup.py (path:/tmp/pip-5jTu8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:51 INFO - Running setup.py (path:/tmp/pip-wlzJUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:51 INFO - Running setup.py (path:/tmp/pip-WpHXsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:52 INFO - Running setup.py (path:/tmp/pip-lEHPTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:52 INFO - Running setup.py (path:/tmp/pip-0dW6dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:52 INFO - Running setup.py install for manifestparser 18:31:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:52 INFO - Running setup.py install for mozcrash 18:31:52 INFO - Running setup.py install for mozdebug 18:31:52 INFO - Running setup.py install for mozdevice 18:31:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:31:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:52 INFO - Running setup.py install for mozfile 18:31:52 INFO - Running setup.py install for mozhttpd 18:31:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:52 INFO - Running setup.py install for mozinfo 18:31:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:52 INFO - Running setup.py install for mozInstall 18:31:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Running setup.py install for mozleak 18:31:53 INFO - Running setup.py install for mozlog 18:31:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Running setup.py install for moznetwork 18:31:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Running setup.py install for mozprocess 18:31:53 INFO - Running setup.py install for mozprofile 18:31:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Running setup.py install for mozrunner 18:31:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Running setup.py install for mozscreenshot 18:31:53 INFO - Running setup.py install for moztest 18:31:53 INFO - Running setup.py install for mozversion 18:31:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:53 INFO - Cleaning up... 18:31:54 INFO - Return code: 0 18:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:54 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 0x7f9a0c9ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d9c0>, '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 0x228e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228ed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', '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 18:31:54 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 18:31:54 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 18:31:54 INFO - Using env: {'DISPLAY': ':0', 18:31:54 INFO - 'HOME': '/home/cltbld', 18:31:54 INFO - 'LANG': 'en_US.UTF-8', 18:31:54 INFO - 'LANGUAGE': 'en_US:en', 18:31:54 INFO - 'LOGNAME': 'cltbld', 18:31:54 INFO - 'MAIL': '/var/mail/cltbld', 18:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:54 INFO - 'MOZ_NO_REMOTE': '1', 18:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:54 INFO - 'NO_EM_RESTART': '1', 18:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:54 INFO - 'PWD': '/builds/slave/test', 18:31:54 INFO - 'SHELL': '/bin/bash', 18:31:54 INFO - 'SHLVL': '1', 18:31:54 INFO - 'TERM': 'linux', 18:31:54 INFO - 'TMOUT': '86400', 18:31:54 INFO - 'USER': 'cltbld', 18:31:54 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', 18:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:54 INFO - '_': '/tools/buildbot/bin/python'} 18:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:54 INFO - Running setup.py (path:/tmp/pip-GTBgFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:54 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)) 18:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:54 INFO - Running setup.py (path:/tmp/pip-_X4RLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:54 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)) 18:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:54 INFO - Running setup.py (path:/tmp/pip-ATcyix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:54 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)) 18:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:54 INFO - Running setup.py (path:/tmp/pip-qQOOwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:54 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)) 18:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:54 INFO - Running setup.py (path:/tmp/pip-coyQA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:54 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)) 18:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:54 INFO - Running setup.py (path:/tmp/pip-upZaEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:54 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)) 18:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:54 INFO - Running setup.py (path:/tmp/pip-kM0VyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:54 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)) 18:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:54 INFO - Running setup.py (path:/tmp/pip-XcqlCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:54 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)) 18:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:54 INFO - Running setup.py (path:/tmp/pip-MuC30k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:54 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)) 18:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:54 INFO - Running setup.py (path:/tmp/pip-qSjunG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:54 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)) 18:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:54 INFO - Running setup.py (path:/tmp/pip-q1ASoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:55 INFO - Running setup.py (path:/tmp/pip-hYfXAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:55 INFO - Running setup.py (path:/tmp/pip-3AqbOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:55 INFO - Running setup.py (path:/tmp/pip-qdqPaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:55 INFO - Running setup.py (path:/tmp/pip-p6UPP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:55 INFO - Running setup.py (path:/tmp/pip-FI3sJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:55 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)) 18:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:55 INFO - Running setup.py (path:/tmp/pip-qSaCsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:57 INFO - Downloading blessings-1.6.tar.gz 18:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:57 INFO - Installing collected packages: blessings 18:31:57 INFO - Running setup.py install for blessings 18:31:57 INFO - Successfully installed blessings 18:31:57 INFO - Cleaning up... 18:31:57 INFO - Return code: 0 18:31:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:57 INFO - Reading from file tmpfile_stdout 18:31:57 INFO - Current package versions: 18:31:57 INFO - argparse == 1.2.1 18:31:57 INFO - blessings == 1.6 18:31:57 INFO - blobuploader == 1.2.4 18:31:57 INFO - docopt == 0.6.1 18:31:57 INFO - manifestparser == 1.1 18:31:57 INFO - mozInstall == 1.12 18:31:57 INFO - mozcrash == 0.17 18:31:57 INFO - mozdebug == 0.1 18:31:57 INFO - mozdevice == 0.48 18:31:57 INFO - mozfile == 1.2 18:31:57 INFO - mozhttpd == 0.7 18:31:57 INFO - mozinfo == 0.9 18:31:57 INFO - mozleak == 0.1 18:31:57 INFO - mozlog == 3.2 18:31:57 INFO - moznetwork == 0.27 18:31:57 INFO - mozprocess == 0.22 18:31:57 INFO - mozprofile == 0.28 18:31:57 INFO - mozrunner == 6.11 18:31:57 INFO - mozscreenshot == 0.1 18:31:57 INFO - mozsystemmonitor == 0.3 18:31:57 INFO - moztest == 0.7 18:31:57 INFO - mozversion == 1.4 18:31:57 INFO - psutil == 3.1.1 18:31:57 INFO - requests == 1.2.3 18:31:57 INFO - wsgiref == 0.1.2 18:31:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:57 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')]} 18:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:57 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')]} 18:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:57 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 0x7f9a0c9ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d9c0>, '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 0x228e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228ed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', '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 18:31:57 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 18:31:57 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 18:31:57 INFO - Using env: {'DISPLAY': ':0', 18:31:57 INFO - 'HOME': '/home/cltbld', 18:31:57 INFO - 'LANG': 'en_US.UTF-8', 18:31:57 INFO - 'LANGUAGE': 'en_US:en', 18:31:57 INFO - 'LOGNAME': 'cltbld', 18:31:57 INFO - 'MAIL': '/var/mail/cltbld', 18:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:57 INFO - 'MOZ_NO_REMOTE': '1', 18:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:57 INFO - 'NO_EM_RESTART': '1', 18:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:57 INFO - 'PWD': '/builds/slave/test', 18:31:57 INFO - 'SHELL': '/bin/bash', 18:31:57 INFO - 'SHLVL': '1', 18:31:57 INFO - 'TERM': 'linux', 18:31:57 INFO - 'TMOUT': '86400', 18:31:57 INFO - 'USER': 'cltbld', 18:31:57 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', 18:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:57 INFO - '_': '/tools/buildbot/bin/python'} 18:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:58 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)) 18:31:58 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)) 18:31:58 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)) 18:31:58 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)) 18:31:58 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)) 18:31:58 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)) 18:31:58 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)) 18:31:58 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)) 18:31:58 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)) 18:31:58 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)) 18:31:58 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)) 18:31:58 INFO - Cleaning up... 18:31:58 INFO - Return code: 0 18:31:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:58 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 0x7f9a0c9ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d9c0>, '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 0x228e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228ed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', '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 18:31:58 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 18:31:58 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 18:31:58 INFO - Using env: {'DISPLAY': ':0', 18:31:58 INFO - 'HOME': '/home/cltbld', 18:31:58 INFO - 'LANG': 'en_US.UTF-8', 18:31:58 INFO - 'LANGUAGE': 'en_US:en', 18:31:58 INFO - 'LOGNAME': 'cltbld', 18:31:58 INFO - 'MAIL': '/var/mail/cltbld', 18:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:58 INFO - 'MOZ_NO_REMOTE': '1', 18:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:58 INFO - 'NO_EM_RESTART': '1', 18:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:58 INFO - 'PWD': '/builds/slave/test', 18:31:58 INFO - 'SHELL': '/bin/bash', 18:31:58 INFO - 'SHLVL': '1', 18:31:58 INFO - 'TERM': 'linux', 18:31:58 INFO - 'TMOUT': '86400', 18:31:58 INFO - 'USER': 'cltbld', 18:31:58 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', 18:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:58 INFO - '_': '/tools/buildbot/bin/python'} 18:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:58 INFO - Downloading/unpacking jsonschema 18:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:32:00 INFO - Downloading/unpacking functools32 (from jsonschema) 18:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:00 INFO - Downloading functools32-3.2.3-2.tar.gz 18:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:32:00 INFO - warning: no files found matching '*.txt' 18:32:00 INFO - no previously-included directories found matching 'build' 18:32:00 INFO - no previously-included directories found matching 'dist' 18:32:00 INFO - no previously-included directories found matching '.git*' 18:32:00 INFO - Installing collected packages: jsonschema, functools32 18:32:00 INFO - Running setup.py install for functools32 18:32:00 INFO - warning: no files found matching '*.txt' 18:32:00 INFO - no previously-included directories found matching 'build' 18:32:00 INFO - no previously-included directories found matching 'dist' 18:32:00 INFO - no previously-included directories found matching '.git*' 18:32:00 INFO - Successfully installed jsonschema functools32 18:32:00 INFO - Cleaning up... 18:32:00 INFO - Return code: 0 18:32:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a0c9ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fe770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d9c0>, '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 0x228e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228ed50>, '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': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', '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 18:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:32:00 INFO - Using env: {'DISPLAY': ':0', 18:32:00 INFO - 'HOME': '/home/cltbld', 18:32:00 INFO - 'LANG': 'en_US.UTF-8', 18:32:00 INFO - 'LANGUAGE': 'en_US:en', 18:32:00 INFO - 'LOGNAME': 'cltbld', 18:32:00 INFO - 'MAIL': '/var/mail/cltbld', 18:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:00 INFO - 'MOZ_NO_REMOTE': '1', 18:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:00 INFO - 'NO_EM_RESTART': '1', 18:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:00 INFO - 'PWD': '/builds/slave/test', 18:32:00 INFO - 'SHELL': '/bin/bash', 18:32:00 INFO - 'SHLVL': '1', 18:32:00 INFO - 'TERM': 'linux', 18:32:00 INFO - 'TMOUT': '86400', 18:32:00 INFO - 'USER': 'cltbld', 18:32:00 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', 18:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:00 INFO - '_': '/tools/buildbot/bin/python'} 18:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:00 INFO - Downloading/unpacking flake8 18:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:32:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:32:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:32:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:32:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:32:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:32:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:32:03 INFO - no previously-included directories found matching 'docs/_build' 18:32:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:32:03 INFO - Running setup.py install for pep8 18:32:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:32:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:32:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:32:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:32:03 INFO - no previously-included directories found matching 'docs/_build' 18:32:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:32:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:32:03 INFO - Cleaning up... 18:32:03 INFO - Return code: 0 18:32:03 INFO - Running post-action listener: _resource_record_post_action 18:32:03 INFO - Running post-action listener: _start_resource_monitoring 18:32:03 INFO - Starting resource monitoring. 18:32:03 INFO - ##### 18:32:03 INFO - ##### Finished create-virtualenv step (success) 18:32:03 INFO - ##### 18:32:03 INFO - ##### 18:32:03 INFO - ##### Running install step. 18:32:03 INFO - ##### 18:32:03 INFO - Running pre-action listener: _resource_record_pre_action 18:32:03 INFO - Running main action method: install 18:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:32:03 INFO - Reading from file tmpfile_stdout 18:32:03 INFO - Detecting whether we're running mozinstall >=1.0... 18:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:32:04 INFO - Reading from file tmpfile_stdout 18:32:04 INFO - Output received: 18:32:04 INFO - Usage: mozinstall [options] installer 18:32:04 INFO - Options: 18:32:04 INFO - -h, --help show this help message and exit 18:32:04 INFO - -d DEST, --destination=DEST 18:32:04 INFO - Directory to install application into. [default: 18:32:04 INFO - "/builds/slave/test"] 18:32:04 INFO - --app=APP Application being installed. [default: firefox] 18:32:04 INFO - mkdir: /builds/slave/test/build/application 18:32:04 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'] 18:32:04 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 18:32:19 INFO - Reading from file tmpfile_stdout 18:32:19 INFO - Output received: 18:32:19 INFO - /builds/slave/test/build/application/firefox/firefox 18:32:19 INFO - Running post-action listener: _resource_record_post_action 18:32:19 INFO - ##### 18:32:19 INFO - ##### Finished install step (success) 18:32:19 INFO - ##### 18:32:19 INFO - ##### 18:32:19 INFO - ##### Running run-tests step. 18:32:19 INFO - ##### 18:32:19 INFO - Running pre-action listener: _resource_record_pre_action 18:32:19 INFO - Running main action method: run_tests 18:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:19 INFO - Python 2.7.3 18:32:19 INFO - Return code: 0 18:32:19 INFO - grabbing minidump binary from tooltool 18:32: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')]} 18:32: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 0x228d9c0>, '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 0x228e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32: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 18:32: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 18:32: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 18:32:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:19 INFO - Return code: 0 18:32:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:32:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:32:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:32:20 INFO - Return code: 0 18:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 18:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 18:32:20 INFO - Using env: {'DISPLAY': ':0', 18:32:20 INFO - 'HOME': '/home/cltbld', 18:32:20 INFO - 'LANG': 'en_US.UTF-8', 18:32:20 INFO - 'LANGUAGE': 'en_US:en', 18:32:20 INFO - 'LOGNAME': 'cltbld', 18:32:20 INFO - 'MAIL': '/var/mail/cltbld', 18:32:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:20 INFO - 'MOZ_NO_REMOTE': '1', 18:32:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:20 INFO - 'NO_EM_RESTART': '1', 18:32:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:20 INFO - 'PWD': '/builds/slave/test', 18:32:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:20 INFO - 'SHELL': '/bin/bash', 18:32:20 INFO - 'SHLVL': '1', 18:32:20 INFO - 'TERM': 'linux', 18:32:20 INFO - 'TMOUT': '86400', 18:32:20 INFO - 'USER': 'cltbld', 18:32:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226', 18:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:20 INFO - '_': '/tools/buildbot/bin/python'} 18:32:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 18:32:20 INFO - mozversion application_buildid: 20160518172845 18:32:20 INFO - mozversion application_changeset: 5bd03d0a58768dbe3184fa9f001372291bd679b8 18:32:20 INFO - mozversion application_display_name: Nightly 18:32:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:20 INFO - mozversion application_name: Firefox 18:32:20 INFO - mozversion application_remotingname: firefox 18:32:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:32:20 INFO - mozversion application_vendor: Mozilla 18:32:20 INFO - mozversion application_version: 49.0a1 18:32:20 INFO - mozversion platform_buildid: 20160518172845 18:32:20 INFO - mozversion platform_changeset: 5bd03d0a58768dbe3184fa9f001372291bd679b8 18:32:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:32:20 INFO - mozversion platform_version: 49.0a1 18:32:20 INFO - using testdate: 1463621540 18:32:20 INFO - actual date: 1463621540 18:32:20 INFO - starting webserver on 'localhost:36961' 18:32:20 INFO - SUITE-START | Running 2 tests 18:32:21 INFO - TEST-START | dromaeo_css 18:32:21 INFO - operating with platform_type : linux_ 18:32:21 INFO - Initialising browser for dromaeo_css test... 18:32:21 INFO - TEST-INFO | started process 27166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9KB1OD/profile http://localhost:36961/getInfo.html) 18:32:24 INFO - PROCESS | 27166 | 18:32:24 INFO - PROCESS | 27166 | (process:27231): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:32:25 INFO - PROCESS | 27166 | __metrics Screen width/height:1600/1200 18:32:25 INFO - PROCESS | 27166 | colorDepth:24 18:32:25 INFO - PROCESS | 27166 | Browser inner width/height: 1024/697 18:32:25 INFO - PROCESS | 27166 | __metrics 18:32:26 ERROR - PROCESS | 27166 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 18:32:27 INFO - TEST-INFO | 27166: exit 0 18:32:27 INFO - Browser initialized. 18:32:27 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:27 INFO - TEST-INFO | started process 27282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9KB1OD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:29 INFO - PROCESS | 27282 | 18:32:29 INFO - PROCESS | 27282 | (process:27343): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:32:39 INFO - PROCESS | 27282 | RSS: Main: 165654528 18:32:39 INFO - PROCESS | 27282 | 18:33:28 INFO - PROCESS | 27282 | 1463621608607 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] 18:35:40 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:36961/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36961/tests/dromaeo/cssquery-ext.html) 18:35:41 INFO - PROCESS | 27282 | RSS: Main: 166735872 18:35:41 INFO - PROCESS | 27282 | 18:38:43 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:36961/tests/dromaeo/cssquery-ext.html (next: http://localhost:36961/tests/dromaeo/cssquery-jquery.html) 18:38:43 INFO - PROCESS | 27282 | RSS: Main: 168022016 18:38:43 INFO - PROCESS | 27282 | 18:41:45 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:36961/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36961/tests/dromaeo/cssquery-mootools.html) 18:41:46 INFO - PROCESS | 27282 | RSS: Main: 168628224 18:41:46 INFO - PROCESS | 27282 | 18:44:48 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:36961/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36961/tests/dromaeo/cssquery-prototype.html) 18:44:48 INFO - PROCESS | 27282 | RSS: Main: 166146048 18:44:48 INFO - PROCESS | 27282 | 18:47:51 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:36961/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36961/tests/dromaeo/cssquery-yui.html) 18:47:52 INFO - PROCESS | 27282 | RSS: Main: 167432192 18:47:52 INFO - PROCESS | 27282 | 18:50:54 INFO - PROCESS | 27282 | Cycle 1(1): loaded http://localhost:36961/tests/dromaeo/cssquery-yui.html (next: http://localhost:36961/tests/dromaeo/cssquery-dojo.html) 18:50:55 INFO - PROCESS | 27282 | RSS: Main: 169267200 18:50:55 INFO - PROCESS | 27282 | 18:50:55 INFO - PROCESS | 27282 | __start_tp_report 18:50:55 INFO - PROCESS | 27282 | _x_x_mozilla_page_load 18:50:55 INFO - PROCESS | 27282 | _x_x_mozilla_page_load_details 18:50:55 INFO - PROCESS | 27282 | |i|pagename|runs| 18:50:55 INFO - PROCESS | 27282 | |0;dojo.html;2684.3960108975484;2703.918882433528;2712.389712314728;2727.6863160736507;2732.0710958274185;4692.507286734891;4702.3416721659;4712.246040633499;4782.880427989302;4851.539103785143;4673.2522796352505;4757.9524204757945;4781;4794.592459640935;4806.543378379057;4353.412289340946;4394.384786129945;4466.285394336906;4496.8875778105485;4511.887202819939;4176.97911510442;4479.305707615308;4479.910401791963;4548.56788605082;4566.360709500673;4327.307630779061;4330.090680957002;4396.296592545177;4420.359047938063;4441.644668426518;4392.714473559208;4405.427294451701;4447.444069491314;4470.2177119004045;4474.955250447487;4430.091831174602;4452.220861349251;4461.24158892989;4510.8421205257655;4512.909741805145;4639.721616703008;4702.435707715062;4740.336352910595;4750.976245118787;4758.785854636515;5160.483951604847;5167.741612919376;5175.223716442526;5178;5238.292830467914;5108.361454818148;5124.436312005676;5215.139501982168;5223.791048358099;5225.346831646044;4829.27560865873;4836.298736683161;4836.830710925101;4853.733044682541;4856.05306965142;5279.604029697788;5290.1800220965815;5291.1798671206025;5298.682079075268;5304.946950530522;5002.074616196015;5053.898922021613;5066.138756411419;5083.212102124103;5107.514786095315;4980.078685443204;5159.432462429129;5160.329157209539;5161.045206636784;5179.741012949337;5050.4697006814495;5070.366204224472;5097.515736005073;5144.022635699205;5159.613029022838;4989.850304490871;5054.166062599704;5087.084324821568;5108.948910510847;5143.871403214949;4347.413099231563;4360.65114790816;4372.693911426233;4404.053128577371;4409.426774519292;3785.886423407302;3812.3137835189377;3829.5978922212767;3829.636184562462;3855.132595166065;4401.163778882003;4471.6646251531265;4495.842645507391;4502.752348620792;4509.210888094571;5158.4067832199025;5163.896722065538;5181.922271165936;5203.375594928632;5208.947910520847;4491.393661855673;4494.52807455219;4494.73031618104;4507.414036175276;4562.087582483517;4539.0921815637;4596;4618.722876627413;4621.630269578425;4649.116667833101;4886.438059623118;4888.682235654671;4900.093482705711;4904.5340692634145;4943.134951383421;5074.213496907985;5205.167173252262;5212.713300768494;5217.50433708797;5268.631195816256;4856.587190088882;4871.975640121776;4897.314375987294;4897.7061376316105;4929.2359684248995;5127.589792816491;5164.070467315919;5171.301874247079;5173.715445650525;5228.58171346299;5070.062038522885;5081.695098294114;5240.213967904845;5252.606054545848;5253.947460525345;4825.734584597741;4944.802207911644;4968.22992436173;5026.949730502794;5065.088284108749;4991.001799640159;5006.6495345325475;5020.146575082318;5029.673071250357;5074.340335756328;4782.258749893772;4922.901541969212;4943.876403089952;4948.727819969792;4969.801207951786;4988.825391111293;5058.494150584912;5065.645404821627;5067.619928505451;5082.567981721595;4917.360743103373;4958.57852082577;4974.278729584263;4985.675931064469;5011.7494125294315 18:50:55 INFO - PROCESS | 27282 | |1;ext.html;582.1064665738093;603.4689473263527;618.4557589321397;623.4451338308903;643.1253495246464;40883.18233635329;42420.15159696804;42463.15073698528;42540.36189457161;47128.52871471284;42879.14241715164;43667.56332436675;43779.78110109453;43817.34273985893;43885.12229755403;7944;8133.227343402367;8189.017317921857;8197.79505512361;8198.262156405923;7945.602719863984;8114.837703245931;8120;8124.5937703114905;8129.105798362176;8097;8114;8148.185181481864;8149.266566009058;8171.713990010351;7964.721234756785;8108.270255677017;8114.350851931831;8119;8124.025116985999;7941.483803552808;8036.517808931483;8046.718364857202;8058.717944871902;8079.515229086273;40826.591734082576;41155.38266925998;41369.1726165478;41459;41494.792526037476;3343.4483310253777;3435.209901722593;3442.277121804424;3533.5406397168204;3738.102855314732;30087.247818804488;30240.8487957561;30385.392292154032;30412.391752165055;30858.382832343228;3508.701760350373;3594.155373487228;3600.567931848195;3684.8341824617955;3719.683826874692;202240;202793;202851;202970;203524;34115.14712132217;57888.13167802486;58287.417125829044;58430;58442.123368149514;34708.82645586756;36509.26981460356;36519.26961460809;36568.45147322792;36673.81663091668;13567.796483052762;13734.313284335743;13737.450501980009;13754.93122534381;13767.036307458582;11655;11660.358680272666;11672.70818229551;11811.527538898348;11818.468168932419;8319.542425166674;8322.292605128632;8340.624671889658;8354.331653467829;8416.4950102994;3173;3213.1003319070696;3213.453712868818;3227.1125440504047;3239.6922292382187;936.8501039833731;961.2310151878469;987.629638885418;1030.2015937648382;1046.8115739166872;29618.407631847673;29911.850440747658;29948.401031979673;30124.84937575342;30148.84925575358;1103.7351035751362;1104.5857803323754;1105.8562386889814;1151.240181480219;1181.4447209811374;15871.127088010271;15875.364985400685;15933.498090316922;16002.519924402286;16062.598435038984;431505;434624;435097;438326;441320;53972.46027539753;54063.45936540584;54230.728846355516;54346.45653543493;54448.72775636097;1265.702559898423;1271.1927925767204;1300.7788675925115;1303.2571434282368;1314.1917720601762;27855.721442785314;29334.559981599865;29357.55963660504;29567.26081847971;29890.252743681584;46030.309545357515;46656.533434665216;46689.53310466852;46777.76611116923;46985.76507117443;356114;360175;363141;364263.17868411547;366171;26475.470490590465;26854.731452685224;26928.32679183036;27018.594721079593;27034.837213022518;44351.77824110859;45023.774881125384;45164;45652.315215272465;46290.537094629966;38520.6147938517;38745.22509549737;38884.6111538881;39228.803855980535;39380.80309598434;38136.237275253785;38461.80769096137;38567.614323857524;38900.80549597234;39255.80372098235;37066.44400334051;38182.23635527329;38416.50292730964;38668.6133138665;38756.6124338753;32571.185720356232;33861.492077618364;34882;34923.65076349204;35051.82474087613;26081.347966300993;26425.60361594539;26536;26568.734312656627;26809.869895031894 18:50:55 INFO - PROCESS | 27282 | |2;jquery.html;376.6064462636543;380.9618788800518;390.25850883321687;397.69774971022014;400.6174103730937;15453.71969296188;17455.73816392752;17890.194941227644;18082.186301616424;18124.184411701473;16415.753763693523;17081.14594270288;17224.827751722478;17432.128393580333;17587.73618395722;5110.054639891623;5308.256844041837;5323.441038690939;5338.145896656536;5352.063388906945;3759.398496240602;5726.799562015331;6044.607100538473;6051.939480605181;6160.0759886017;5096.745162741848;6085.878282434349;6097.268327800648;6101.694915254242;6110.511159107261;5439.129739241703;5461.972690136524;5467.917981230285;5481.862953426156;5489.1217405215375;5179.300794392747;5499.972500137474;5508.586855985777;5520;5542.919130769502;12753.234805911583;13044.28256445895;13056;18615.44153675392;19661.410157695293;1947.5849946066917;1991.8107779760899;2049.282751037125;2112.651412516933;2338.9708528247515;9272.350935434522;9312.8603070954;9331.72004839856;9525.19035881951;9646.180074693659;1773.2906837265068;1784.3041213926579;1795.6588248232795;1834.779826420838;1884.2651365967283;67818.3218167817;68022;69223;69411.30588694048;70677;10291.897081029243;10298.330608510423;10386.636467723745;10513.737156571147;10524.105451036748;14510.927445362706;14518.128912265298;14554.41782328695;14566.563003109924;14603.415863365559;7326.3406293433845;7617.923820761832;7623.390128789683;7754.263344982218;7791.610419479003;7096.07750992378;7159.57042577447;7254.093238345207;7345;7413.703451861973;4415.911681766347;4454.420925279693;4503.729776213372;4546.977265113654;4612.5156858530045;1712.922918468672;3033.2720147164523;3115.9376812463624;3322.2888868989025;3403.982980085084;827.3009307135461;925.8703781470599;942.566419447062;954.2699834626517;979.6326377608397;15094.169820659969;16510.42213522521;16644.001359918442;17205.483835484956;17393.65212695739;909.836229478687;935.1817159985013;936.8688383626297;940.3699521320732;941.9811603767886;9433.24534037289;9465.242780577675;9577.281703872099;9632.807343853225;9760.853587196198;364921;365513;369234;372414;389685;75943.24056759362;78019.60990195013;82329.17670823335;82735;83974;927.6892241099173;959.9568019439142;962.2494454325637;962.5091203486272;1021.3667526133696;15929.283182257059;15978.8402115982;16040.197990100682;16056.598585035468;16069.678606427573;35477.82261088678;36614.8169259152;38708.41937370998;39424;39743;51725.74137129441;54285;54377;54474.18288725593;54658;6043.8186854394435;7823.765287041398;7877.094134174643;8119.066307374727;8149.185081491803;11077;11846.407679615812;11858.40707964581;12114.697132571757;12246.44890979926;10415.895841041493;10438.478076096013;10511.159107271553;10533.789324213627;10574.41840698769;10227.232957528066;10231.897681023094;10372.325798823053;10578;10611;10542.367457952547;10701.89298107009;10725.839112413476;10744.623938162127;10768.084712799186;7651.961740191264;7840.882386764317;8039.598020099089;8165.79585510367;8218.547979861165;9582.233421326138;10702.839457408301;10744.51649675782;10790.622328218475;10854.18593605467 18:50:55 INFO - PROCESS | 27282 | |3;mootools.html;1521.7336966030946;1528.4421186267011;1698.1169791708312;1837.531429485481;1847.6120014796893;7045.330693584114;7836.41226907982;7906.762797116081;8394.286485648712;8395.454295470798;7935;8130.674773009073;8134.552599607034;8140.389470789685;8216.548089855056;2249.730032396111;2289.645105008726;2293.1859189987563;2296.1389478945393;2296.7818057284617;2229.5317983223545;2241.26038407326;2257.604919139152;2261.547690461906;2276.6129757941108;2218.2901471529117;2226.298715904493;2245.191730976847;2252.3918541993653;2269.716285464317;2204.6913432119436;2230.5984922713988;2234.575430668176;2249.5725812095648;2258.7402448718444;2224.944376390587;2238.518718475519;2247.5729611373786;2253.3352660965056;2265.9660105098437;8133.674653013873;8231.34149268057;8234.258916697467;8234.794130146794;8252.092269850311;4648.930266046012;4736.360591320196;4749.715017098985;4762.690425122356;4772.141014617368;2947.3073827650487;2967.3768508613216;3042.3763128558594;3183.984080079608;3190.489521676544;1025.810060330021;1029.3669393323128;1043.410473082706;1056.2922841696081;1061.098066643347;10864.728381790439;10867.891321086767;10898.455077246106;10920.453977301182;10934.125269978304;4422.911541769146;4446.288593825037;4540.250858608292;4549.203889319356;4563.634909207255;9249.861252081224;9254.722358329262;9281.257499400032;9293.442393456415;9302.16280534755;4829.492903245179;4847.95152048475;4858.8785280367565;4861.538153875376;4864.416270047617;3716.1452865841006;4263.211305908355;4357.586029327209;4413.117376524644;4452.732836029849;3760.6427389397963;3848.2111167210655;3901.08324543732;3924.803759811998;4043.6765058795227;1264.7723409786327;1294.4045738959996;1297.2800095946652;1304.4325718312375;1318.1019332161657;861.2722249698994;879.1823604048296;891.148952750122;908.5457271364318;914.4741773480275;5665.716714164358;5667.943320566824;5673.546116310686;5709.143628455682;5816.82549523515;933.0622724162174;937.5687183895484;945.2343601682659;959.5681943125481;993.438707130469;3854.479645247856;3939.783311917872;4001.419794129893;4037.1723796621623;4071.328230841937;9095.81808363829;9406.905930940604;9427.764305892408;9695.757606059906;9919.355241909252;9576.281778866613;9596.328257021942;9616.134547890724;9655.420674759536;9658.468784216795;7369.484136110528;7701.3068823806125;7750.302472777477;7750.573718445539;7784;5654.886902262014;5734.598578099493;5809.808989157297;5920;5982.641041537521;9316;9409.717708468757;9426.858597120912;9478.431294122374;9483.28875334339;9378.155965963097;9462.148406643435;9468.905310947079;9560.856587151338;9576.186024187744;6578.638174900427;6971.651417429007;7034.753783617549;7039.472039596948;7044.929550704427;7303.087114110736;7373.889391659237;7384.667689953858;7385.113786345673;7414.147373051952;6499.902501462577;6714.294999025032;6720.731170753115;6835.555688880207;7011.6494175292055;6621.801345959629;6623.933760662524;6661.067450556829;6715.093462382712;6893.482988775761;6336.239651241881;6439.291677915332;6495.610263384212;6497;6498.122753428416;4670.439547254351;4750.287456881495;4784.856454306377;4810.687305325143;4843.975780121077;4807.230843065093;4876.439209490812;4905.043516514245;4929.260610908393;4932.53140951609 18:50:55 INFO - PROCESS | 27282 | |4;prototype.html;312.5827020927062;318.0934337139154;320.1260558674818;324.87817068599276;326.38965135197185;4874.341963834881;4950.925736113961;5000.249962505626;5030.773615187316;5059.822906198284;4917.680350777197;4933.383327084114;4935.555799978001;4968.2547617857335;4980.825671101512;3917.7649341039487;3922.4312474691083;3923.9019024524473;3954.2091581683635;3963.128111815396;3649.671529562339;3956.109875278068;3972.9006774830714;3984.6413822755944;4007.3150988837547;3789.8484060637543;3828.119532507525;3841.3277676406656;3846.615338466145;3862.478565393664;3804.08701911542;3815.2560250751117;3816.6183381661613;3826.7703937763545;3844.308024555579;3371.376295385337;3378.121688361019;3378.2567835076243;3383.204946837491;3385.8814941477176;4719.174144524694;4766.713997160146;4806.711597304138;4876.244182151737;4896.828610998634;4365.148795984785;4370.257056300405;4380.824767009316;4385.912281754347;4411.316245981878;5224.164133738584;5227.706544876742;5251.186066159751;5294.470552944713;5310.36275646921;3535.2045789697368;3672.375696131664;3674.7427680062406;3683.834227459744;3693.91029646255;5482.91775623362;5509.283793106871;5523.143912693539;5524.33707955048;5536.197251398606;3722.3113723961155;3727.329080765434;3729.2541491701227;3730.7388482806487;3745.6702870480585;3774.7168962327387;3785.621437856192;3791.8954979986374;3801.790901500444;3810.9809450952566;4251.404803327537;4359.215341238608;4379.233634114081;4381.9342709859375;4383.978080109643;5164;5173.965206958548;5186.766595503212;5212.843614691566;5227.790888364499;1244.3467179730715;1299.2918859221747;1325.284346452924;1330.1686445971268;1339.5177736015028;845.9323254139654;852.1691350932915;854.9059603443616;862.6549380247951;867.8524650809378;4136.482939632546;4177.456930599003;4181.414601955728;4185.602367775056;4234.6823988201;4851.442084160367;4853.174960256765;4870.514493079574;4889.315495830587;4908.9754551227015;4181.268278051329;4218.177455396169;4247.893802654959;4250.511191212988;4265.722728022669;2409.106737357348;2579.9355016124746;2583.6641236639116;2583.6899572051475;2588.9093881714048;4470.284754439274;4507.909841803145;4520.163769702615;4546.477155127137;4546.499885012646;4873.926891096637;4909.263610458388;4925.094194425306;4959.876003099879;4971.6271279654175;4405.378799614225;4573.542645735466;4600.4479462464715;4605.792739326671;4610.824239818825;4811.78346974394;4845.183056353867;4855.781489832895;4878.609711223023;4898;4651.674382793172;4689.147786624332;4703.270992996091;4715.198416269311;4745.881352966066;4426.276148121548;4488.326750987248;4599.586037256529;4607.7465739383315;4608.308753686973;3511.666391692785;3521.295740851891;3540.9114772129874;3540.9468857966635;3559.982200088983;4792.2332426811545;4827.8551643450755;4829.492903245108;4892.706437613612;5197.7141257229705;5157.871053223699;5254.60590455725;5261.421243663118;5270.60470464709;5277.340332458442;5197.28489598424;5224.373075230997;5256.894862102813;5263.131583288715;5304.893902122013;4962.330085438564;5153.510416510426;5194.35070616173;5226.771708648541;5239.842804715865;5278.287431196739;5328.3605967284175;5337.919931200958;5347.224652425299;5353.598480113929;5155.948440515547;5205.427402985744;5210.244514545446;5214.582833373245;5239.29269548606 18:50:55 INFO - PROCESS | 27282 | |5;yui.html;645.1677336236255;696.9442444604432;709.3438569323376;736.5065406177861;744.4007573903009;12389.442475088621;12894.871051289496;12908.160969536973;13813.654658633539;14250;13984.65038374041;13987.650308742286;13990.160590364585;13994.720105597882;14049.50826721065;683.893996430554;835.3567752830317;855.9358048146382;864.2394692670441;865.8095219051798;860.1054902900976;863.1756672377895;865.2515574028483;865.6796985115516;866.7313132928781;907.7004588485817;910.2672348759246;911.1662828511903;913.0002647101413;915.812258487012;904.6924045824451;906.7778394293407;906.8095699903029;907.6278725722456;909.0455022226702;655.8589903170794;661.3650895140671;662.4965026579786;662.7812821768805;663.5056882622429;13348.065635405526;13400.731985360238;13403.597892063253;13407.128536645185;13460.326983650877;12799.232046077264;12820.743585128339;12841.165324253894;12881.742365152739;13140.277284749334;9870.555824987892;9881.950590247076;10082.193424526095;10098.29311948164;10113.49432528378;3289.7039266465895;3293.440115180425;3327.434336162858;3416.026432466735;3437.862485500577;49128.26307605389;49836;51292.743536282454;53544.73227633915;53585;9329.580168892417;9383;9674.75813104664;9680.27397945157;9758.75603109928;17426.12869356527;17660.470185894443;17660.558486037953;17684.911575442296;18210.54473638143;6889.517733758589;7039.753608623673;7169.605671688108;7232.493725439169;7348.2284360142485;3837.846486140523;3866.709996750255;3871.090293780959;3886.6696330811633;3898.7270891037924;2863.1267463423856;2965.9703402966124;2974.509205981032;2977.7171168738937;2988.3873805869744;477.8924741933037;484.728552010868;489.9289603007544;495.86115887551546;496.1689170639165;600.7356763024255;616.1866336435861;624.4567226512963;626.5207116555838;636.9808905732835;7827.412944029221;7980.281774640311;8105.837883242302;8459.323254139654;8459.873101903477;528.2340606121063;617.3702823120392;632.4434497642045;635.2345423764353;642.787879999599;3732.6080761519647;3902.180542086194;3923.722983573619;3996.3805610130476;4036;61876.38123618796;62593;62628.373716263166;62918.68540657267;63313.36686633075;55818.72090639521;55835.162472562944;56219.718901405235;57154;57188.42811571914;51246.23130653043;51296.74351628218;51450;51735.74132129315;52336.21495677568;7853;8059.234372734581;8137.593120344078;8175.1416101308505;8428.747137585882;34311.65688343085;34346.14134646654;34623.480647790806;34944.475832862016;35096;42531.36202956896;45256;45322.77338613286;45374.54625453703;45480.54519454763;9611.663591774255;9889;10324;10471;10617.89382106169;10627.521761520904;10879.075278601407;11102.555897764;11165.553377864795;11477.08183345347;10293.588256469657;10527;10647.94676026615;10751.569937202425;10897.237193396386;10537.367757934548;10584.682459526226;10592.364458132537;10670.946645266724;10777.299475534066;10154.796904062025;10446.94776526143;11552.422378880854;11574.717354578523;11630.732007258503;9276.489793061446;9601.615935362508;10099.596016159565;10149.594016239267;10489.265751397328;9385.343025988115;9564.378315409476;9567.952160239154;9627.181689556186;9636.373635713657 18:50:55 INFO - PROCESS | 27282 | __end_tp_report 18:50:55 INFO - PROCESS | 27282 | __start_cc_report 18:50:55 INFO - PROCESS | 27282 | _x_x_mozilla_cycle_collect,385 18:50:55 INFO - PROCESS | 27282 | __end_cc_report 18:50:55 INFO - PROCESS | 27282 | __startTimestamp1463622655001__endTimestamp 18:50:55 INFO - PROCESS | 27282 | 18:50:55 INFO - PROCESS | 27282 | ------- Summary: start ------- 18:50:55 INFO - PROCESS | 27282 | Number of tests: 6 18:50:55 INFO - PROCESS | 27282 | 18:50:55 INFO - PROCESS | 27282 | [#0] dojo.html Cycles:165 Average:4765.06 Median:4897.71 stddev:497.09 (10.1%) stddev-sans-first:471.06 18:50:55 INFO - PROCESS | 27282 | Values: 2684.4 2703.9 2712.4 2727.7 2732.1 4692.5 4702.3 4712.2 4782.9 4851.5 4673.3 4758.0 4781.0 4794.6 4806.5 4353.4 4394.4 4466.3 4496.9 4511.9 4177.0 4479.3 4479.9 4548.6 4566.4 4327.3 4330.1 4396.3 4420.4 4441.6 4392.7 4405.4 4447.4 4470.2 4475.0 4430.1 4452.2 4461.2 4510.8 4512.9 4639.7 4702.4 4740.3 4751.0 4758.8 5160.5 5167.7 5175.2 5178.0 5238.3 5108.4 5124.4 5215.1 5223.8 5225.3 4829.3 4836.3 4836.8 4853.7 4856.1 5279.6 5290.2 5291.2 5298.7 5304.9 5002.1 5053.9 5066.1 5083.2 5107.5 4980.1 5159.4 5160.3 5161.0 5179.7 5050.5 5070.4 5097.5 5144.0 5159.6 4989.9 5054.2 5087.1 5108.9 5143.9 4347.4 4360.7 4372.7 4404.1 4409.4 3785.9 3812.3 3829.6 3829.6 3855.1 4401.2 4471.7 4495.8 4502.8 4509.2 5158.4 5163.9 5181.9 5203.4 5208.9 4491.4 4494.5 4494.7 4507.4 4562.1 4539.1 4596.0 4618.7 4621.6 4649.1 4886.4 4888.7 4900.1 4904.5 4943.1 5074.2 5205.2 5212.7 5217.5 5268.6 4856.6 4872.0 4897.3 4897.7 4929.2 5127.6 5164.1 5171.3 5173.7 5228.6 5070.1 5081.7 5240.2 5252.6 5253.9 4825.7 4944.8 4968.2 5026.9 5065.1 4991.0 5006.6 5020.1 5029.7 5074.3 4782.3 4922.9 4943.9 4948.7 4969.8 4988.8 5058.5 5065.6 5067.6 5082.6 4917.4 4958.6 4974.3 4985.7 5011.7 18:50:55 INFO - PROCESS | 27282 | 18:50:55 INFO - PROCESS | 27282 | [#1] ext.html Cycles:180 Average:48952.77 Median:38299.37 stddev:92125.36 (240.5%) stddev-sans-first:92312.22 18:50:55 INFO - PROCESS | 27282 | Values: 582.1 603.5 618.5 623.4 643.1 40883.2 42420.2 42463.2 42540.4 47128.5 42879.1 43667.6 43779.8 43817.3 43885.1 7944.0 8133.2 8189.0 8197.8 8198.3 7945.6 8114.8 8120.0 8124.6 8129.1 8097.0 8114.0 8148.2 8149.3 8171.7 7964.7 8108.3 8114.4 8119.0 8124.0 7941.5 8036.5 8046.7 8058.7 8079.5 40826.6 41155.4 41369.2 41459.0 41494.8 3343.4 3435.2 3442.3 3533.5 3738.1 30087.2 30240.8 30385.4 30412.4 30858.4 3508.7 3594.2 3600.6 3684.8 3719.7 202240.0 202793.0 202851.0 202970.0 203524.0 34115.1 57888.1 58287.4 58430.0 58442.1 34708.8 36509.3 36519.3 36568.5 36673.8 13567.8 13734.3 13737.5 13754.9 13767.0 11655.0 11660.4 11672.7 11811.5 11818.5 8319.5 8322.3 8340.6 8354.3 8416.5 3173.0 3213.1 3213.5 3227.1 3239.7 936.9 961.2 987.6 1030.2 1046.8 29618.4 29911.9 29948.4 30124.8 30148.8 1103.7 1104.6 1105.9 1151.2 1181.4 15871.1 15875.4 15933.5 16002.5 16062.6 431505.0 434624.0 435097.0 438326.0 441320.0 53972.5 54063.5 54230.7 54346.5 54448.7 1265.7 1271.2 1300.8 1303.3 1314.2 27855.7 29334.6 29357.6 29567.3 29890.3 46030.3 46656.5 46689.5 46777.8 46985.8 356114.0 360175.0 363141.0 364263.2 366171.0 26475.5 26854.7 26928.3 27018.6 27034.8 44351.8 45023.8 45164.0 45652.3 46290.5 38520.6 38745.2 38884.6 39228.8 39380.8 38136.2 38461.8 38567.6 38900.8 39255.8 37066.4 38182.2 38416.5 38668.6 38756.6 32571.2 33861.5 34882.0 34923.7 35051.8 26081.3 26425.6 26536.0 26568.7 26809.9 18:50:55 INFO - PROCESS | 27282 | 18:50:55 INFO - PROCESS | 27282 | [#2] jquery.html Cycles:180 Average:24083.37 Median:2408.26 stddev:61717.20 (2562.7%) stddev-sans-first:61864.67 18:50:55 INFO - PROCESS | 27282 | Values: 376.6 381.0 390.3 397.7 400.6 15453.7 17455.7 17890.2 18082.2 18124.2 16415.8 17081.1 17224.8 17432.1 17587.7 5110.1 5308.3 5323.4 5338.1 5352.1 3759.4 5726.8 6044.6 6051.9 6160.1 5096.7 6085.9 6097.3 6101.7 6110.5 5439.1 5462.0 5467.9 5481.9 5489.1 5179.3 5500.0 5508.6 5520.0 5542.9 12753.2 13044.3 13056.0 18615.4 19661.4 1947.6 1991.8 2049.3 2112.7 2339.0 9272.4 9312.9 9331.7 9525.2 9646.2 1773.3 1784.3 1795.7 1834.8 1884.3 67818.3 68022.0 69223.0 69411.3 70677.0 10291.9 10298.3 10386.6 10513.7 10524.1 14510.9 14518.1 14554.4 14566.6 14603.4 7326.3 7617.9 7623.4 7754.3 7791.6 7096.1 7159.6 7254.1 7345.0 7413.7 4415.9 4454.4 4503.7 4547.0 4612.5 1712.9 3033.3 3115.9 3322.3 3404.0 827.3 925.9 942.6 954.3 979.6 15094.2 16510.4 16644.0 17205.5 17393.7 909.8 935.2 936.9 940.4 942.0 9433.2 9465.2 9577.3 9632.8 9760.9 364921.0 365513.0 369234.0 372414.0 389685.0 75943.2 78019.6 82329.2 82735.0 83974.0 927.7 960.0 962.2 962.5 1021.4 15929.3 15978.8 16040.2 16056.6 16069.7 35477.8 36614.8 38708.4 39424.0 39743.0 51725.7 54285.0 54377.0 54474.2 54658.0 6043.8 7823.8 7877.1 8119.1 8149.2 11077.0 11846.4 11858.4 12114.7 12246.4 10415.9 10438.5 10511.2 10533.8 10574.4 10227.2 10231.9 10372.3 10578.0 10611.0 10542.4 10701.9 10725.8 10744.6 10768.1 7652.0 7840.9 8039.6 8165.8 8218.5 9582.2 10702.8 10744.5 10790.6 10854.2 18:50:55 INFO - PROCESS | 27282 | 18:50:55 INFO - PROCESS | 27282 | [#3] mootools.html Cycles:180 Average:5331.83 Median:5660.30 stddev:2912.73 (51.5%) stddev-sans-first:2906.83 18:50:55 INFO - PROCESS | 27282 | Values: 1521.7 1528.4 1698.1 1837.5 1847.6 7045.3 7836.4 7906.8 8394.3 8395.5 7935.0 8130.7 8134.6 8140.4 8216.5 2249.7 2289.6 2293.2 2296.1 2296.8 2229.5 2241.3 2257.6 2261.5 2276.6 2218.3 2226.3 2245.2 2252.4 2269.7 2204.7 2230.6 2234.6 2249.6 2258.7 2224.9 2238.5 2247.6 2253.3 2266.0 8133.7 8231.3 8234.3 8234.8 8252.1 4648.9 4736.4 4749.7 4762.7 4772.1 2947.3 2967.4 3042.4 3184.0 3190.5 1025.8 1029.4 1043.4 1056.3 1061.1 10864.7 10867.9 10898.5 10920.5 10934.1 4422.9 4446.3 4540.3 4549.2 4563.6 9249.9 9254.7 9281.3 9293.4 9302.2 4829.5 4848.0 4858.9 4861.5 4864.4 3716.1 4263.2 4357.6 4413.1 4452.7 3760.6 3848.2 3901.1 3924.8 4043.7 1264.8 1294.4 1297.3 1304.4 1318.1 861.3 879.2 891.1 908.5 914.5 5665.7 5667.9 5673.5 5709.1 5816.8 933.1 937.6 945.2 959.6 993.4 3854.5 3939.8 4001.4 4037.2 4071.3 9095.8 9406.9 9427.8 9695.8 9919.4 9576.3 9596.3 9616.1 9655.4 9658.5 7369.5 7701.3 7750.3 7750.6 7784.0 5654.9 5734.6 5809.8 5920.0 5982.6 9316.0 9409.7 9426.9 9478.4 9483.3 9378.2 9462.1 9468.9 9560.9 9576.2 6578.6 6971.7 7034.8 7039.5 7044.9 7303.1 7373.9 7384.7 7385.1 7414.1 6499.9 6714.3 6720.7 6835.6 7011.6 6621.8 6623.9 6661.1 6715.1 6893.5 6336.2 6439.3 6495.6 6497.0 6498.1 4670.4 4750.3 4784.9 4810.7 4844.0 4807.2 4876.4 4905.0 4929.3 4932.5 18:50:55 INFO - PROCESS | 27282 | 18:50:55 INFO - PROCESS | 27282 | [#4] prototype.html Cycles:180 Average:4182.48 Median:4603.12 stddev:1216.68 (26.4%) stddev-sans-first:1184.91 18:50:55 INFO - PROCESS | 27282 | Values: 312.6 318.1 320.1 324.9 326.4 4874.3 4950.9 5000.2 5030.8 5059.8 4917.7 4933.4 4935.6 4968.3 4980.8 3917.8 3922.4 3923.9 3954.2 3963.1 3649.7 3956.1 3972.9 3984.6 4007.3 3789.8 3828.1 3841.3 3846.6 3862.5 3804.1 3815.3 3816.6 3826.8 3844.3 3371.4 3378.1 3378.3 3383.2 3385.9 4719.2 4766.7 4806.7 4876.2 4896.8 4365.1 4370.3 4380.8 4385.9 4411.3 5224.2 5227.7 5251.2 5294.5 5310.4 3535.2 3672.4 3674.7 3683.8 3693.9 5482.9 5509.3 5523.1 5524.3 5536.2 3722.3 3727.3 3729.3 3730.7 3745.7 3774.7 3785.6 3791.9 3801.8 3811.0 4251.4 4359.2 4379.2 4381.9 4384.0 5164.0 5174.0 5186.8 5212.8 5227.8 1244.3 1299.3 1325.3 1330.2 1339.5 845.9 852.2 854.9 862.7 867.9 4136.5 4177.5 4181.4 4185.6 4234.7 4851.4 4853.2 4870.5 4889.3 4909.0 4181.3 4218.2 4247.9 4250.5 4265.7 2409.1 2579.9 2583.7 2583.7 2588.9 4470.3 4507.9 4520.2 4546.5 4546.5 4873.9 4909.3 4925.1 4959.9 4971.6 4405.4 4573.5 4600.4 4605.8 4610.8 4811.8 4845.2 4855.8 4878.6 4898.0 4651.7 4689.1 4703.3 4715.2 4745.9 4426.3 4488.3 4599.6 4607.7 4608.3 3511.7 3521.3 3540.9 3540.9 3560.0 4792.2 4827.9 4829.5 4892.7 5197.7 5157.9 5254.6 5261.4 5270.6 5277.3 5197.3 5224.4 5256.9 5263.1 5304.9 4962.3 5153.5 5194.4 5226.8 5239.8 5278.3 5328.4 5337.9 5347.2 5353.6 5155.9 5205.4 5210.2 5214.6 5239.3 18:50:55 INFO - PROCESS | 27282 | 18:50:55 INFO - PROCESS | 27282 | [#5] yui.html Cycles:180 Average:14157.69 Median:50541.12 stddev:17250.00 (34.1%) stddev-sans-first:17268.55 18:50:55 INFO - PROCESS | 27282 | Values: 645.2 696.9 709.3 736.5 744.4 12389.4 12894.9 12908.2 13813.7 14250.0 13984.7 13987.7 13990.2 13994.7 14049.5 683.9 835.4 855.9 864.2 865.8 860.1 863.2 865.3 865.7 866.7 907.7 910.3 911.2 913.0 915.8 904.7 906.8 906.8 907.6 909.0 655.9 661.4 662.5 662.8 663.5 13348.1 13400.7 13403.6 13407.1 13460.3 12799.2 12820.7 12841.2 12881.7 13140.3 9870.6 9882.0 10082.2 10098.3 10113.5 3289.7 3293.4 3327.4 3416.0 3437.9 49128.3 49836.0 51292.7 53544.7 53585.0 9329.6 9383.0 9674.8 9680.3 9758.8 17426.1 17660.5 17660.6 17684.9 18210.5 6889.5 7039.8 7169.6 7232.5 7348.2 3837.8 3866.7 3871.1 3886.7 3898.7 2863.1 2966.0 2974.5 2977.7 2988.4 477.9 484.7 489.9 495.9 496.2 600.7 616.2 624.5 626.5 637.0 7827.4 7980.3 8105.8 8459.3 8459.9 528.2 617.4 632.4 635.2 642.8 3732.6 3902.2 3923.7 3996.4 4036.0 61876.4 62593.0 62628.4 62918.7 63313.4 55818.7 55835.2 56219.7 57154.0 57188.4 51246.2 51296.7 51450.0 51735.7 52336.2 7853.0 8059.2 8137.6 8175.1 8428.7 34311.7 34346.1 34623.5 34944.5 35096.0 42531.4 45256.0 45322.8 45374.5 45480.5 9611.7 9889.0 10324.0 10471.0 10617.9 10627.5 10879.1 11102.6 11165.6 11477.1 10293.6 10527.0 10647.9 10751.6 10897.2 10537.4 10584.7 10592.4 10670.9 10777.3 10154.8 10446.9 11552.4 11574.7 11630.7 9276.5 9601.6 10099.6 10149.6 10489.3 9385.3 9564.4 9568.0 9627.2 9636.4 18:50:55 INFO - PROCESS | 27282 | -------- Summary: end -------- 18:50:55 INFO - PROCESS | 27282 | 18:50:55 INFO - TEST-INFO | 27282: exit 0 18:50:55 INFO - TEST-OK | dromaeo_css | took 1114722ms 18:50:55 INFO - TEST-START | kraken 18:50:55 INFO - operating with platform_type : linux_ 18:50:55 INFO - Initialising browser for kraken test... 18:50:55 INFO - TEST-INFO | started process 27519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQO_D2P/profile http://localhost:36961/getInfo.html) 18:50:59 INFO - PROCESS | 27519 | 18:50:59 INFO - PROCESS | 27519 | (process:27588): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:51:00 INFO - PROCESS | 27519 | __metrics Screen width/height:1600/1200 18:51:00 INFO - PROCESS | 27519 | colorDepth:24 18:51:00 INFO - PROCESS | 27519 | Browser inner width/height: 1024/697 18:51:00 INFO - PROCESS | 27519 | __metrics 18:51:00 ERROR - PROCESS | 27519 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 18:51:01 INFO - TEST-INFO | 27519: exit 0 18:51:01 INFO - Browser initialized. 18:51:01 INFO - Running cycle 1/1 for kraken test... 18:51:01 INFO - TEST-INFO | started process 27639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQO_D2P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:03 INFO - PROCESS | 27639 | 18:51:03 INFO - PROCESS | 27639 | (process:27698): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:51:13 INFO - PROCESS | 27639 | RSS: Main: 165289984 18:51:13 INFO - PROCESS | 27639 | 18:51:16 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36961/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:17 INFO - PROCESS | 27639 | RSS: Main: 168816640 18:51:17 INFO - PROCESS | 27639 | 18:51:19 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36961/tests/kraken/driver.html?testName=audio-dft) 18:51:20 INFO - PROCESS | 27639 | RSS: Main: 168779776 18:51:20 INFO - PROCESS | 27639 | 18:51:23 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36961/tests/kraken/driver.html?testName=audio-fft) 18:51:24 INFO - PROCESS | 27639 | RSS: Main: 164511744 18:51:24 INFO - PROCESS | 27639 | 18:51:26 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36961/tests/kraken/driver.html?testName=audio-oscillator) 18:51:27 INFO - PROCESS | 27639 | RSS: Main: 165302272 18:51:27 INFO - PROCESS | 27639 | 18:51:29 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36961/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:30 INFO - PROCESS | 27639 | RSS: Main: 165335040 18:51:30 INFO - PROCESS | 27639 | 18:51:33 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36961/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:33 INFO - PROCESS | 27639 | RSS: Main: 165912576 18:51:33 INFO - PROCESS | 27639 | 18:51:37 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36961/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:38 INFO - PROCESS | 27639 | RSS: Main: 163823616 18:51:38 INFO - PROCESS | 27639 | 18:51:41 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36961/tests/kraken/driver.html?testName=json-parse-financial) 18:51:41 INFO - PROCESS | 27639 | RSS: Main: 164761600 18:51:41 INFO - PROCESS | 27639 | 18:51:43 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36961/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:44 INFO - PROCESS | 27639 | RSS: Main: 164802560 18:51:44 INFO - PROCESS | 27639 | 18:51:46 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36961/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:46 INFO - PROCESS | 27639 | RSS: Main: 165912576 18:51:46 INFO - PROCESS | 27639 | 18:51:49 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36961/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:49 INFO - PROCESS | 27639 | RSS: Main: 166080512 18:51:49 INFO - PROCESS | 27639 | 18:51:52 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:51:53 INFO - PROCESS | 27639 | RSS: Main: 165515264 18:51:53 INFO - PROCESS | 27639 | 18:51:56 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:51:56 INFO - PROCESS | 27639 | RSS: Main: 165429248 18:51:56 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | Cycle 1(1): loaded http://localhost:36961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36961/tests/kraken/driver.html?testName=ai-astar) 18:51:58 INFO - PROCESS | 27639 | RSS: Main: 168071168 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | __start_tp_report 18:51:58 INFO - PROCESS | 27639 | _x_x_mozilla_page_load 18:51:58 INFO - PROCESS | 27639 | _x_x_mozilla_page_load_details 18:51:58 INFO - PROCESS | 27639 | |i|pagename|runs| 18:51:58 INFO - PROCESS | 27639 | |0;ai-astar;110;116;105;116;115;115;107;112;116;114 18:51:58 INFO - PROCESS | 27639 | |1;audio-beat-detection;153;131;154;213;131;160;165;130;190;139 18:51:58 INFO - PROCESS | 27639 | |2;audio-dft;162;165;168;166;163;164;166;163;161;161 18:51:58 INFO - PROCESS | 27639 | |3;audio-fft;76;83;76;178;76;75;76;76;164;74 18:51:58 INFO - PROCESS | 27639 | |4;audio-oscillator;95;93;172;94;94;94;135;94;93;148 18:51:58 INFO - PROCESS | 27639 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;118;118;118 18:51:58 INFO - PROCESS | 27639 | |6;imaging-darkroom;147;147;147;148;147;147;148;147;158;148 18:51:58 INFO - PROCESS | 27639 | |7;imaging-desaturate;95;96;95;95;95;96;95;95;95;95 18:51:58 INFO - PROCESS | 27639 | |8;json-parse-financial;64;66;63;64;63;62;65;65;63;65 18:51:58 INFO - PROCESS | 27639 | |9;json-stringify-tinderbox;64;65;65;65;73;65;65;65;64;65 18:51:58 INFO - PROCESS | 27639 | |10;stanford-crypto-aes;85;81;84;81;87;88;83;84;142;84 18:51:58 INFO - PROCESS | 27639 | |11;stanford-crypto-ccm;148;141;139;136;138;129;138;137;148;137 18:51:58 INFO - PROCESS | 27639 | |12;stanford-crypto-pbkdf2;170;170;176;170;171;170;170;172;169;169 18:51:58 INFO - PROCESS | 27639 | |13;stanford-crypto-sha256-iterative;68;67;66;70;67;67;66;66;65;67 18:51:58 INFO - PROCESS | 27639 | __end_tp_report 18:51:58 INFO - PROCESS | 27639 | __start_cc_report 18:51:58 INFO - PROCESS | 27639 | _x_x_mozilla_cycle_collect,947 18:51:58 INFO - PROCESS | 27639 | __end_cc_report 18:51:58 INFO - PROCESS | 27639 | __startTimestamp1463622718883__endTimestamp 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | ------- Summary: start ------- 18:51:58 INFO - PROCESS | 27639 | Number of tests: 14 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#0] ai-astar Cycles:10 Average:112.60 Median:115.00 stddev:4.01 (3.5%) stddev-sans-first:4.14 18:51:58 INFO - PROCESS | 27639 | Values: 110.0 116.0 105.0 116.0 115.0 115.0 107.0 112.0 116.0 114.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#1] audio-beat-detection Cycles:10 Average:156.60 Median:157.00 stddev:27.34 (17.4%) stddev-sans-first:28.97 18:51:58 INFO - PROCESS | 27639 | Values: 153.0 131.0 154.0 213.0 131.0 160.0 165.0 130.0 190.0 139.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.50 stddev:2.33 (1.4%) stddev-sans-first:2.37 18:51:58 INFO - PROCESS | 27639 | Values: 162.0 165.0 168.0 166.0 163.0 164.0 166.0 163.0 161.0 161.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.00 stddev:40.05 (52.7%) stddev-sans-first:41.86 18:51:58 INFO - PROCESS | 27639 | Values: 76.0 83.0 76.0 178.0 76.0 75.0 76.0 76.0 164.0 74.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:94.00 stddev:29.30 (31.2%) stddev-sans-first:30.48 18:51:58 INFO - PROCESS | 27639 | Values: 95.0 93.0 172.0 94.0 94.0 94.0 135.0 94.0 93.0 148.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 18:51:58 INFO - PROCESS | 27639 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:147.50 stddev:3.41 (2.3%) stddev-sans-first:3.57 18:51:58 INFO - PROCESS | 27639 | Values: 147.0 147.0 147.0 148.0 147.0 147.0 148.0 147.0 158.0 148.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:51:58 INFO - PROCESS | 27639 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.50 stddev:1.25 (1.9%) stddev-sans-first:1.32 18:51:58 INFO - PROCESS | 27639 | Values: 64.0 66.0 63.0 64.0 63.0 62.0 65.0 65.0 63.0 65.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.00 stddev:2.63 (4.1%) stddev-sans-first:2.73 18:51:58 INFO - PROCESS | 27639 | Values: 64.0 65.0 65.0 65.0 73.0 65.0 65.0 65.0 64.0 65.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:84.00 stddev:18.44 (22.0%) stddev-sans-first:19.48 18:51:58 INFO - PROCESS | 27639 | Values: 85.0 81.0 84.0 81.0 87.0 88.0 83.0 84.0 142.0 84.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:138.50 stddev:5.63 (4.1%) stddev-sans-first:4.96 18:51:58 INFO - PROCESS | 27639 | Values: 148.0 141.0 139.0 136.0 138.0 129.0 138.0 137.0 148.0 137.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:170.00 stddev:2.06 (1.2%) stddev-sans-first:2.17 18:51:58 INFO - PROCESS | 27639 | Values: 170.0 170.0 176.0 170.0 171.0 170.0 170.0 172.0 169.0 169.0 18:51:58 INFO - PROCESS | 27639 | 18:51:58 INFO - PROCESS | 27639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.37 (2.0%) stddev-sans-first:1.39 18:51:58 INFO - PROCESS | 27639 | Values: 68.0 67.0 66.0 70.0 67.0 67.0 66.0 66.0 65.0 67.0 18:51:58 INFO - PROCESS | 27639 | -------- Summary: end -------- 18:51:58 INFO - PROCESS | 27639 | 18:51:59 INFO - TEST-INFO | 27639: exit 0 18:51:59 INFO - TEST-OK | kraken | took 64185ms 18:51:59 INFO - SUITE-END | took 1178s 18:52:00 INFO - Completed test suite (00:19:39) 18:52:00 INFO - javascript benchmark 18:52:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6455.702807942267, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2684.3960108975484, 2703.918882433528, 2712.389712314728, 2727.6863160736507, 2732.0710958274185, 4692.507286734891, 4702.3416721659, 4712.246040633499, 4782.880427989302, 4851.539103785143, 4673.2522796352505, 4757.9524204757945, 4781.0, 4794.592459640935, 4806.543378379057, 4353.412289340946, 4394.384786129945, 4466.285394336906, 4496.8875778105485, 4511.887202819939, 4176.97911510442, 4479.305707615308, 4479.910401791963, 4548.56788605082, 4566.360709500673, 4327.307630779061, 4330.090680957002, 4396.296592545177, 4420.359047938063, 4441.644668426518, 4392.714473559208, 4405.427294451701, 4447.444069491314, 4470.2177119004045, 4474.955250447487, 4430.091831174602, 4452.220861349251, 4461.24158892989, 4510.8421205257655, 4512.909741805145, 4639.721616703008, 4702.435707715062, 4740.336352910595, 4750.976245118787, 4758.785854636515, 5160.483951604847, 5167.741612919376, 5175.223716442526, 5178.0, 5238.292830467914, 5108.361454818148, 5124.436312005676, 5215.139501982168, 5223.791048358099, 5225.346831646044, 4829.27560865873, 4836.298736683161, 4836.830710925101, 4853.733044682541, 4856.05306965142, 5279.604029697788, 5290.1800220965815, 5291.1798671206025, 5298.682079075268, 5304.946950530522, 5002.074616196015, 5053.898922021613, 5066.138756411419, 5083.212102124103, 5107.514786095315, 4980.078685443204, 5159.432462429129, 5160.329157209539, 5161.045206636784, 5179.741012949337, 5050.4697006814495, 5070.366204224472, 5097.515736005073, 5144.022635699205, 5159.613029022838, 4989.850304490871, 5054.166062599704, 5087.084324821568, 5108.948910510847, 5143.871403214949, 4347.413099231563, 4360.65114790816, 4372.693911426233, 4404.053128577371, 4409.426774519292, 3785.886423407302, 3812.3137835189377, 3829.5978922212767, 3829.636184562462, 3855.132595166065, 4401.163778882003, 4471.6646251531265, 4495.842645507391, 4502.752348620792, 4509.210888094571, 5158.4067832199025, 5163.896722065538, 5181.922271165936, 5203.375594928632, 5208.947910520847, 4491.393661855673, 4494.52807455219, 4494.73031618104, 4507.414036175276, 4562.087582483517, 4539.0921815637, 4596.0, 4618.722876627413, 4621.630269578425, 4649.116667833101, 4886.438059623118, 4888.682235654671, 4900.093482705711, 4904.5340692634145, 4943.134951383421, 5074.213496907985, 5205.167173252262, 5212.713300768494, 5217.50433708797, 5268.631195816256, 4856.587190088882, 4871.975640121776, 4897.314375987294, 4897.7061376316105, 4929.2359684248995, 5127.589792816491, 5164.070467315919, 5171.301874247079, 5173.715445650525, 5228.58171346299, 5070.062038522885, 5081.695098294114, 5240.213967904845, 5252.606054545848, 5253.947460525345, 4825.734584597741, 4944.802207911644, 4968.22992436173, 5026.949730502794, 5065.088284108749, 4991.001799640159, 5006.6495345325475, 5020.146575082318, 5029.673071250357, 5074.340335756328, 4782.258749893772, 4922.901541969212, 4943.876403089952, 4948.727819969792, 4969.801207951786, 4988.825391111293, 5058.494150584912, 5065.645404821627, 5067.619928505451, 5082.567981721595, 4917.360743103373, 4958.57852082577, 4974.278729584263, 4985.675931064469, 5011.7494125294315], "value": 4733.666372776149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.1064665738093, 603.4689473263527, 618.4557589321397, 623.4451338308903, 643.1253495246464, 40883.18233635329, 42420.15159696804, 42463.15073698528, 42540.36189457161, 47128.52871471284, 42879.14241715164, 43667.56332436675, 43779.78110109453, 43817.34273985893, 43885.12229755403, 7944.0, 8133.227343402367, 8189.017317921857, 8197.79505512361, 8198.262156405923, 7945.602719863984, 8114.837703245931, 8120.0, 8124.5937703114905, 8129.105798362176, 8097.0, 8114.0, 8148.185181481864, 8149.266566009058, 8171.713990010351, 7964.721234756785, 8108.270255677017, 8114.350851931831, 8119.0, 8124.025116985999, 7941.483803552808, 8036.517808931483, 8046.718364857202, 8058.717944871902, 8079.515229086273, 40826.591734082576, 41155.38266925998, 41369.1726165478, 41459.0, 41494.792526037476, 3343.4483310253777, 3435.209901722593, 3442.277121804424, 3533.5406397168204, 3738.102855314732, 30087.247818804488, 30240.8487957561, 30385.392292154032, 30412.391752165055, 30858.382832343228, 3508.701760350373, 3594.155373487228, 3600.567931848195, 3684.8341824617955, 3719.683826874692, 202240.0, 202793.0, 202851.0, 202970.0, 203524.0, 34115.14712132217, 57888.13167802486, 58287.417125829044, 58430.0, 58442.123368149514, 34708.82645586756, 36509.26981460356, 36519.26961460809, 36568.45147322792, 36673.81663091668, 13567.796483052762, 13734.313284335743, 13737.450501980009, 13754.93122534381, 13767.036307458582, 11655.0, 11660.358680272666, 11672.70818229551, 11811.527538898348, 11818.468168932419, 8319.542425166674, 8322.292605128632, 8340.624671889658, 8354.331653467829, 8416.4950102994, 3173.0, 3213.1003319070696, 3213.453712868818, 3227.1125440504047, 3239.6922292382187, 936.8501039833731, 961.2310151878469, 987.629638885418, 1030.2015937648382, 1046.8115739166872, 29618.407631847673, 29911.850440747658, 29948.401031979673, 30124.84937575342, 30148.84925575358, 1103.7351035751362, 1104.5857803323754, 1105.8562386889814, 1151.240181480219, 1181.4447209811374, 15871.127088010271, 15875.364985400685, 15933.498090316922, 16002.519924402286, 16062.598435038984, 431505.0, 434624.0, 435097.0, 438326.0, 441320.0, 53972.46027539753, 54063.45936540584, 54230.728846355516, 54346.45653543493, 54448.72775636097, 1265.702559898423, 1271.1927925767204, 1300.7788675925115, 1303.2571434282368, 1314.1917720601762, 27855.721442785314, 29334.559981599865, 29357.55963660504, 29567.26081847971, 29890.252743681584, 46030.309545357515, 46656.533434665216, 46689.53310466852, 46777.76611116923, 46985.76507117443, 356114.0, 360175.0, 363141.0, 364263.17868411547, 366171.0, 26475.470490590465, 26854.731452685224, 26928.32679183036, 27018.594721079593, 27034.837213022518, 44351.77824110859, 45023.774881125384, 45164.0, 45652.315215272465, 46290.537094629966, 38520.6147938517, 38745.22509549737, 38884.6111538881, 39228.803855980535, 39380.80309598434, 38136.237275253785, 38461.80769096137, 38567.614323857524, 38900.80549597234, 39255.80372098235, 37066.44400334051, 38182.23635527329, 38416.50292730964, 38668.6133138665, 38756.6124338753, 32571.185720356232, 33861.492077618364, 34882.0, 34923.65076349204, 35051.82474087613, 26081.347966300993, 26425.60361594539, 26536.0, 26568.734312656627, 26809.869895031894], "value": 17494.01160235435, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.6064462636543, 380.9618788800518, 390.25850883321687, 397.69774971022014, 400.6174103730937, 15453.71969296188, 17455.73816392752, 17890.194941227644, 18082.186301616424, 18124.184411701473, 16415.753763693523, 17081.14594270288, 17224.827751722478, 17432.128393580333, 17587.73618395722, 5110.054639891623, 5308.256844041837, 5323.441038690939, 5338.145896656536, 5352.063388906945, 3759.398496240602, 5726.799562015331, 6044.607100538473, 6051.939480605181, 6160.0759886017, 5096.745162741848, 6085.878282434349, 6097.268327800648, 6101.694915254242, 6110.511159107261, 5439.129739241703, 5461.972690136524, 5467.917981230285, 5481.862953426156, 5489.1217405215375, 5179.300794392747, 5499.972500137474, 5508.586855985777, 5520.0, 5542.919130769502, 12753.234805911583, 13044.28256445895, 13056.0, 18615.44153675392, 19661.410157695293, 1947.5849946066917, 1991.8107779760899, 2049.282751037125, 2112.651412516933, 2338.9708528247515, 9272.350935434522, 9312.8603070954, 9331.72004839856, 9525.19035881951, 9646.180074693659, 1773.2906837265068, 1784.3041213926579, 1795.6588248232795, 1834.779826420838, 1884.2651365967283, 67818.3218167817, 68022.0, 69223.0, 69411.30588694048, 70677.0, 10291.897081029243, 10298.330608510423, 10386.636467723745, 10513.737156571147, 10524.105451036748, 14510.927445362706, 14518.128912265298, 14554.41782328695, 14566.563003109924, 14603.415863365559, 7326.3406293433845, 7617.923820761832, 7623.390128789683, 7754.263344982218, 7791.610419479003, 7096.07750992378, 7159.57042577447, 7254.093238345207, 7345.0, 7413.703451861973, 4415.911681766347, 4454.420925279693, 4503.729776213372, 4546.977265113654, 4612.5156858530045, 1712.922918468672, 3033.2720147164523, 3115.9376812463624, 3322.2888868989025, 3403.982980085084, 827.3009307135461, 925.8703781470599, 942.566419447062, 954.2699834626517, 979.6326377608397, 15094.169820659969, 16510.42213522521, 16644.001359918442, 17205.483835484956, 17393.65212695739, 909.836229478687, 935.1817159985013, 936.8688383626297, 940.3699521320732, 941.9811603767886, 9433.24534037289, 9465.242780577675, 9577.281703872099, 9632.807343853225, 9760.853587196198, 364921.0, 365513.0, 369234.0, 372414.0, 389685.0, 75943.24056759362, 78019.60990195013, 82329.17670823335, 82735.0, 83974.0, 927.6892241099173, 959.9568019439142, 962.2494454325637, 962.5091203486272, 1021.3667526133696, 15929.283182257059, 15978.8402115982, 16040.197990100682, 16056.598585035468, 16069.678606427573, 35477.82261088678, 36614.8169259152, 38708.41937370998, 39424.0, 39743.0, 51725.74137129441, 54285.0, 54377.0, 54474.18288725593, 54658.0, 6043.8186854394435, 7823.765287041398, 7877.094134174643, 8119.066307374727, 8149.185081491803, 11077.0, 11846.407679615812, 11858.40707964581, 12114.697132571757, 12246.44890979926, 10415.895841041493, 10438.478076096013, 10511.159107271553, 10533.789324213627, 10574.41840698769, 10227.232957528066, 10231.897681023094, 10372.325798823053, 10578.0, 10611.0, 10542.367457952547, 10701.89298107009, 10725.839112413476, 10744.623938162127, 10768.084712799186, 7651.961740191264, 7840.882386764317, 8039.598020099089, 8165.79585510367, 8218.547979861165, 9582.233421326138, 10702.839457408301, 10744.51649675782, 10790.622328218475, 10854.18593605467], "value": 8501.877507844873, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.7336966030946, 1528.4421186267011, 1698.1169791708312, 1837.531429485481, 1847.6120014796893, 7045.330693584114, 7836.41226907982, 7906.762797116081, 8394.286485648712, 8395.454295470798, 7935.0, 8130.674773009073, 8134.552599607034, 8140.389470789685, 8216.548089855056, 2249.730032396111, 2289.645105008726, 2293.1859189987563, 2296.1389478945393, 2296.7818057284617, 2229.5317983223545, 2241.26038407326, 2257.604919139152, 2261.547690461906, 2276.6129757941108, 2218.2901471529117, 2226.298715904493, 2245.191730976847, 2252.3918541993653, 2269.716285464317, 2204.6913432119436, 2230.5984922713988, 2234.575430668176, 2249.5725812095648, 2258.7402448718444, 2224.944376390587, 2238.518718475519, 2247.5729611373786, 2253.3352660965056, 2265.9660105098437, 8133.674653013873, 8231.34149268057, 8234.258916697467, 8234.794130146794, 8252.092269850311, 4648.930266046012, 4736.360591320196, 4749.715017098985, 4762.690425122356, 4772.141014617368, 2947.3073827650487, 2967.3768508613216, 3042.3763128558594, 3183.984080079608, 3190.489521676544, 1025.810060330021, 1029.3669393323128, 1043.410473082706, 1056.2922841696081, 1061.098066643347, 10864.728381790439, 10867.891321086767, 10898.455077246106, 10920.453977301182, 10934.125269978304, 4422.911541769146, 4446.288593825037, 4540.250858608292, 4549.203889319356, 4563.634909207255, 9249.861252081224, 9254.722358329262, 9281.257499400032, 9293.442393456415, 9302.16280534755, 4829.492903245179, 4847.95152048475, 4858.8785280367565, 4861.538153875376, 4864.416270047617, 3716.1452865841006, 4263.211305908355, 4357.586029327209, 4413.117376524644, 4452.732836029849, 3760.6427389397963, 3848.2111167210655, 3901.08324543732, 3924.803759811998, 4043.6765058795227, 1264.7723409786327, 1294.4045738959996, 1297.2800095946652, 1304.4325718312375, 1318.1019332161657, 861.2722249698994, 879.1823604048296, 891.148952750122, 908.5457271364318, 914.4741773480275, 5665.716714164358, 5667.943320566824, 5673.546116310686, 5709.143628455682, 5816.82549523515, 933.0622724162174, 937.5687183895484, 945.2343601682659, 959.5681943125481, 993.438707130469, 3854.479645247856, 3939.783311917872, 4001.419794129893, 4037.1723796621623, 4071.328230841937, 9095.81808363829, 9406.905930940604, 9427.764305892408, 9695.757606059906, 9919.355241909252, 9576.281778866613, 9596.328257021942, 9616.134547890724, 9655.420674759536, 9658.468784216795, 7369.484136110528, 7701.3068823806125, 7750.302472777477, 7750.573718445539, 7784.0, 5654.886902262014, 5734.598578099493, 5809.808989157297, 5920.0, 5982.641041537521, 9316.0, 9409.717708468757, 9426.858597120912, 9478.431294122374, 9483.28875334339, 9378.155965963097, 9462.148406643435, 9468.905310947079, 9560.856587151338, 9576.186024187744, 6578.638174900427, 6971.651417429007, 7034.753783617549, 7039.472039596948, 7044.929550704427, 7303.087114110736, 7373.889391659237, 7384.667689953858, 7385.113786345673, 7414.147373051952, 6499.902501462577, 6714.294999025032, 6720.731170753115, 6835.555688880207, 7011.6494175292055, 6621.801345959629, 6623.933760662524, 6661.067450556829, 6715.093462382712, 6893.482988775761, 6336.239651241881, 6439.291677915332, 6495.610263384212, 6497.0, 6498.122753428416, 4670.439547254351, 4750.287456881495, 4784.856454306377, 4810.687305325143, 4843.975780121077, 4807.230843065093, 4876.439209490812, 4905.043516514245, 4929.260610908393, 4932.53140951609], "value": 4342.715178548416, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.5827020927062, 318.0934337139154, 320.1260558674818, 324.87817068599276, 326.38965135197185, 4874.341963834881, 4950.925736113961, 5000.249962505626, 5030.773615187316, 5059.822906198284, 4917.680350777197, 4933.383327084114, 4935.555799978001, 4968.2547617857335, 4980.825671101512, 3917.7649341039487, 3922.4312474691083, 3923.9019024524473, 3954.2091581683635, 3963.128111815396, 3649.671529562339, 3956.109875278068, 3972.9006774830714, 3984.6413822755944, 4007.3150988837547, 3789.8484060637543, 3828.119532507525, 3841.3277676406656, 3846.615338466145, 3862.478565393664, 3804.08701911542, 3815.2560250751117, 3816.6183381661613, 3826.7703937763545, 3844.308024555579, 3371.376295385337, 3378.121688361019, 3378.2567835076243, 3383.204946837491, 3385.8814941477176, 4719.174144524694, 4766.713997160146, 4806.711597304138, 4876.244182151737, 4896.828610998634, 4365.148795984785, 4370.257056300405, 4380.824767009316, 4385.912281754347, 4411.316245981878, 5224.164133738584, 5227.706544876742, 5251.186066159751, 5294.470552944713, 5310.36275646921, 3535.2045789697368, 3672.375696131664, 3674.7427680062406, 3683.834227459744, 3693.91029646255, 5482.91775623362, 5509.283793106871, 5523.143912693539, 5524.33707955048, 5536.197251398606, 3722.3113723961155, 3727.329080765434, 3729.2541491701227, 3730.7388482806487, 3745.6702870480585, 3774.7168962327387, 3785.621437856192, 3791.8954979986374, 3801.790901500444, 3810.9809450952566, 4251.404803327537, 4359.215341238608, 4379.233634114081, 4381.9342709859375, 4383.978080109643, 5164.0, 5173.965206958548, 5186.766595503212, 5212.843614691566, 5227.790888364499, 1244.3467179730715, 1299.2918859221747, 1325.284346452924, 1330.1686445971268, 1339.5177736015028, 845.9323254139654, 852.1691350932915, 854.9059603443616, 862.6549380247951, 867.8524650809378, 4136.482939632546, 4177.456930599003, 4181.414601955728, 4185.602367775056, 4234.6823988201, 4851.442084160367, 4853.174960256765, 4870.514493079574, 4889.315495830587, 4908.9754551227015, 4181.268278051329, 4218.177455396169, 4247.893802654959, 4250.511191212988, 4265.722728022669, 2409.106737357348, 2579.9355016124746, 2583.6641236639116, 2583.6899572051475, 2588.9093881714048, 4470.284754439274, 4507.909841803145, 4520.163769702615, 4546.477155127137, 4546.499885012646, 4873.926891096637, 4909.263610458388, 4925.094194425306, 4959.876003099879, 4971.6271279654175, 4405.378799614225, 4573.542645735466, 4600.4479462464715, 4605.792739326671, 4610.824239818825, 4811.78346974394, 4845.183056353867, 4855.781489832895, 4878.609711223023, 4898.0, 4651.674382793172, 4689.147786624332, 4703.270992996091, 4715.198416269311, 4745.881352966066, 4426.276148121548, 4488.326750987248, 4599.586037256529, 4607.7465739383315, 4608.308753686973, 3511.666391692785, 3521.295740851891, 3540.9114772129874, 3540.9468857966635, 3559.982200088983, 4792.2332426811545, 4827.8551643450755, 4829.492903245108, 4892.706437613612, 5197.7141257229705, 5157.871053223699, 5254.60590455725, 5261.421243663118, 5270.60470464709, 5277.340332458442, 5197.28489598424, 5224.373075230997, 5256.894862102813, 5263.131583288715, 5304.893902122013, 4962.330085438564, 5153.510416510426, 5194.35070616173, 5226.771708648541, 5239.842804715865, 5278.287431196739, 5328.3605967284175, 5337.919931200958, 5347.224652425299, 5353.598480113929, 5155.948440515547, 5205.427402985744, 5210.244514545446, 5214.582833373245, 5239.29269548606], "value": 3803.007125290796, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.1677336236255, 696.9442444604432, 709.3438569323376, 736.5065406177861, 744.4007573903009, 12389.442475088621, 12894.871051289496, 12908.160969536973, 13813.654658633539, 14250.0, 13984.65038374041, 13987.650308742286, 13990.160590364585, 13994.720105597882, 14049.50826721065, 683.893996430554, 835.3567752830317, 855.9358048146382, 864.2394692670441, 865.8095219051798, 860.1054902900976, 863.1756672377895, 865.2515574028483, 865.6796985115516, 866.7313132928781, 907.7004588485817, 910.2672348759246, 911.1662828511903, 913.0002647101413, 915.812258487012, 904.6924045824451, 906.7778394293407, 906.8095699903029, 907.6278725722456, 909.0455022226702, 655.8589903170794, 661.3650895140671, 662.4965026579786, 662.7812821768805, 663.5056882622429, 13348.065635405526, 13400.731985360238, 13403.597892063253, 13407.128536645185, 13460.326983650877, 12799.232046077264, 12820.743585128339, 12841.165324253894, 12881.742365152739, 13140.277284749334, 9870.555824987892, 9881.950590247076, 10082.193424526095, 10098.29311948164, 10113.49432528378, 3289.7039266465895, 3293.440115180425, 3327.434336162858, 3416.026432466735, 3437.862485500577, 49128.26307605389, 49836.0, 51292.743536282454, 53544.73227633915, 53585.0, 9329.580168892417, 9383.0, 9674.75813104664, 9680.27397945157, 9758.75603109928, 17426.12869356527, 17660.470185894443, 17660.558486037953, 17684.911575442296, 18210.54473638143, 6889.517733758589, 7039.753608623673, 7169.605671688108, 7232.493725439169, 7348.2284360142485, 3837.846486140523, 3866.709996750255, 3871.090293780959, 3886.6696330811633, 3898.7270891037924, 2863.1267463423856, 2965.9703402966124, 2974.509205981032, 2977.7171168738937, 2988.3873805869744, 477.8924741933037, 484.728552010868, 489.9289603007544, 495.86115887551546, 496.1689170639165, 600.7356763024255, 616.1866336435861, 624.4567226512963, 626.5207116555838, 636.9808905732835, 7827.412944029221, 7980.281774640311, 8105.837883242302, 8459.323254139654, 8459.873101903477, 528.2340606121063, 617.3702823120392, 632.4434497642045, 635.2345423764353, 642.787879999599, 3732.6080761519647, 3902.180542086194, 3923.722983573619, 3996.3805610130476, 4036.0, 61876.38123618796, 62593.0, 62628.373716263166, 62918.68540657267, 63313.36686633075, 55818.72090639521, 55835.162472562944, 56219.718901405235, 57154.0, 57188.42811571914, 51246.23130653043, 51296.74351628218, 51450.0, 51735.74132129315, 52336.21495677568, 7853.0, 8059.234372734581, 8137.593120344078, 8175.1416101308505, 8428.747137585882, 34311.65688343085, 34346.14134646654, 34623.480647790806, 34944.475832862016, 35096.0, 42531.36202956896, 45256.0, 45322.77338613286, 45374.54625453703, 45480.54519454763, 9611.663591774255, 9889.0, 10324.0, 10471.0, 10617.89382106169, 10627.521761520904, 10879.075278601407, 11102.555897764, 11165.553377864795, 11477.08183345347, 10293.588256469657, 10527.0, 10647.94676026615, 10751.569937202425, 10897.237193396386, 10537.367757934548, 10584.682459526226, 10592.364458132537, 10670.946645266724, 10777.299475534066, 10154.796904062025, 10446.94776526143, 11552.422378880854, 11574.717354578523, 11630.732007258503, 9276.489793061446, 9601.615935362508, 10099.596016159565, 10149.594016239267, 10489.265751397328, 9385.343025988115, 9564.378315409476, 9567.952160239154, 9627.181689556186, 9636.373635713657], "value": 6224.762943024787, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 116.0, 105.0, 116.0, 115.0, 115.0, 107.0, 112.0, 116.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 154.0, 213.0, 131.0, 160.0, 165.0, 130.0, 190.0, 139.0], "value": 156.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 168.0, 166.0, 163.0, 164.0, 166.0, 163.0, 161.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 76.0, 178.0, 76.0, 75.0, 76.0, 76.0, 164.0, 74.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 172.0, 94.0, 94.0, 94.0, 135.0, 94.0, 93.0, 148.0], "value": 111.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 158.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 63.0, 64.0, 63.0, 62.0, 65.0, 65.0, 63.0, 65.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 73.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 84.0, 81.0, 87.0, 88.0, 83.0, 84.0, 142.0, 84.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 141.0, 139.0, 136.0, 138.0, 129.0, 138.0, 137.0, 148.0, 137.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 176.0, 170.0, 171.0, 170.0, 170.0, 172.0, 169.0, 169.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 70.0, 67.0, 67.0, 66.0, 66.0, 65.0, 67.0], "value": 66.9, "unit": "score"}]}]} 18:52:00 INFO - Return code: 0 18:52:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:52:00 ERROR - # TBPL SUCCESS # 18:52:00 INFO - Running post-action listener: _resource_record_post_action 18:52:00 INFO - ##### 18:52:00 INFO - ##### Finished run-tests step (success) 18:52:00 INFO - ##### 18:52:00 INFO - Running post-run listener: _resource_record_post_run 18:52:00 INFO - Total resource usage - Wall time: 1196s; CPU: 14.0%; Read bytes: 8192; Write bytes: 526680064; Read time: 404; Write time: 486128 18:52:00 INFO - TinderboxPrint: CPU usage
13.5% 18:52:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 404 18:52:00 INFO - TinderboxPrint: I/O write bytes / time
526,680,064 / 486,128 18:52:00 INFO - TinderboxPrint: CPU idle
8,252.8 (86.5%) 18:52:00 INFO - TinderboxPrint: CPU user
1,236.7 (13.0%) 18:52:00 INFO - TinderboxPrint: Swap in / out
0 / 0 18:52:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 204070912; Read time: 208; Write time: 256984 18:52:00 INFO - run-tests - Wall time: 1180s; CPU: 14.0%; Read bytes: 4096; Write bytes: 286982144; Read time: 196; Write time: 217140 18:52:00 INFO - Running post-run listener: _upload_blobber_files 18:52:00 INFO - Blob upload gear active. 18:52:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:52:00 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 18:52:00 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:52:00 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:52:01 INFO - (blobuploader) - INFO - Open directory for files ... 18:52:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:52:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:52:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:02 INFO - (blobuploader) - INFO - Done attempting. 18:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:52:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:07 INFO - (blobuploader) - INFO - Done attempting. 18:52:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:52:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:52:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:08 INFO - (blobuploader) - INFO - Done attempting. 18:52:08 INFO - (blobuploader) - INFO - Iteration through files over. 18:52:08 INFO - Return code: 0 18:52:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:52:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:52:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f28b586a851cccd8e1770381d058ac689f831e546bdc079de789d72494dc937814b513be11e159b15a390656acad3a239061b3988ed09a1e59128a1f1c0be35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1841e15a0b0da02ec8618e60fdb450c015782f8df9c7a43c535b90c235b1e6366d7013d6bf97c35703c7bd4afb16cf1d55a9539827c75fa2f68ad3f9ef68ccf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0b2922ec3725c5f01a164aff877195222bbd5aa417c94f97a36c223583c6de95a0d94749830f50b0f975b90a1a8fb483b32d825b19cf90a1512dde184d38af7"} 18:52:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:52:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:52:08 INFO - Contents: 18:52:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f28b586a851cccd8e1770381d058ac689f831e546bdc079de789d72494dc937814b513be11e159b15a390656acad3a239061b3988ed09a1e59128a1f1c0be35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1841e15a0b0da02ec8618e60fdb450c015782f8df9c7a43c535b90c235b1e6366d7013d6bf97c35703c7bd4afb16cf1d55a9539827c75fa2f68ad3f9ef68ccf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0b2922ec3725c5f01a164aff877195222bbd5aa417c94f97a36c223583c6de95a0d94749830f50b0f975b90a1a8fb483b32d825b19cf90a1512dde184d38af7"} 18:52:08 INFO - Running post-run listener: copy_logs_to_upload_dir 18:52:08 INFO - Copying logs to upload dir... 18:52:08 INFO - mkdir: /builds/slave/test/build/upload/logs 18:52:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.524236 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-18 18:52:08.398429) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 18:52:08.402348) ========= 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=826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226 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-Non-PGO/sha512/3f28b586a851cccd8e1770381d058ac689f831e546bdc079de789d72494dc937814b513be11e159b15a390656acad3a239061b3988ed09a1e59128a1f1c0be35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1841e15a0b0da02ec8618e60fdb450c015782f8df9c7a43c535b90c235b1e6366d7013d6bf97c35703c7bd4afb16cf1d55a9539827c75fa2f68ad3f9ef68ccf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0b2922ec3725c5f01a164aff877195222bbd5aa417c94f97a36c223583c6de95a0d94749830f50b0f975b90a1a8fb483b32d825b19cf90a1512dde184d38af7"} build_url:https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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-Non-PGO/sha512/3f28b586a851cccd8e1770381d058ac689f831e546bdc079de789d72494dc937814b513be11e159b15a390656acad3a239061b3988ed09a1e59128a1f1c0be35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1841e15a0b0da02ec8618e60fdb450c015782f8df9c7a43c535b90c235b1e6366d7013d6bf97c35703c7bd4afb16cf1d55a9539827c75fa2f68ad3f9ef68ccf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0b2922ec3725c5f01a164aff877195222bbd5aa417c94f97a36c223583c6de95a0d94749830f50b0f975b90a1a8fb483b32d825b19cf90a1512dde184d38af7"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 18:52:08.471573) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:52:08.471892) ========= 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=826874ccc97bd7bf541b4875000001d5-1463620697.203832-1022423226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:52:08.540919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 18:52:08.541224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 18:52:08.541497) ========= ========= Total master_lag: 0.23 =========