builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1464069848.08 results: success (0) buildid: 20160523203030 builduid: 4ecf4be1d94c487b9ad1f6fc4b2989c1 revision: 9e938575c485151e55c05dd7a1f824bdd8c64837 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:08.079395) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:08.079838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:08.080115) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:08.097502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:08.097774) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 23:04:08-- 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% 50.2M=0s 2016-05-23 23:04:08 (50.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098441 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:08.366734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:08.367042) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020655 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:08.408615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 23:04:08.408942) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9e938575c485151e55c05dd7a1f824bdd8c64837 --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 9e938575c485151e55c05dd7a1f824bdd8c64837 --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=31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 23:04:08,625 truncating revision to first 12 chars 2016-05-23 23:04:08,625 Setting DEBUG logging. 2016-05-23 23:04:08,625 attempt 1/10 2016-05-23 23:04:08,625 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9e938575c485?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 23:04:09,462 unpacking tar archive at: fx-team-9e938575c485/testing/mozharness/ program finished with exit code 0 elapsedTime=1.114219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 23:04:09.542760) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:09.543138) ========= script_repo_revision: 9e938575c485151e55c05dd7a1f824bdd8c64837 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:09.543535) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:09.543803) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 23:04:09.556433) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-23 23:04:09.556890) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:04:09 INFO - MultiFileLogger online at 20160523 23:04:09 in /builds/slave/test 23:04:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:04:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:04:09 INFO - {'append_to_log': False, 23:04:09 INFO - 'base_work_dir': '/builds/slave/test', 23:04:09 INFO - 'blob_upload_branch': 'Fx-Team', 23:04:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:04:09 INFO - 'branch': 'Fx-Team', 23:04:09 INFO - 'buildbot_json_path': 'buildprops.json', 23:04:09 INFO - 'config_files': ('talos/linux_config.py',), 23:04:09 INFO - 'default_actions': ('clobber', 23:04:09 INFO - 'read-buildbot-config', 23:04:09 INFO - 'download-and-extract', 23:04:09 INFO - 'populate-webroot', 23:04:09 INFO - 'create-virtualenv', 23:04:09 INFO - 'install', 23:04:09 INFO - 'run-tests'), 23:04:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:04:09 INFO - 'download_minidump_stackwalk': True, 23:04:09 INFO - 'download_symbols': 'ondemand', 23:04:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:04:09 INFO - 'tooltool.py': '/tools/tooltool.py', 23:04:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:04:09 INFO - '/tools/misc-python/virtualenv.py')}, 23:04:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:04:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:04:09 INFO - 'installer_path': 'installer.exe', 23:04:09 INFO - 'log_level': 'info', 23:04:09 INFO - 'log_name': 'talos', 23:04:09 INFO - 'log_to_console': True, 23:04:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:04:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:04:09 INFO - 'opt_config_files': (), 23:04:09 INFO - 'pip_index': False, 23:04:09 INFO - 'sps_profile': False, 23:04:09 INFO - 'sps_profile_interval': 0, 23:04:09 INFO - 'suite': 'dromaeojs-e10s', 23:04:09 INFO - 'system_bits': '32', 23:04:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:04:09 INFO - 'title': 'talos-linux64-ix-014', 23:04:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:04:09 INFO - 'use_talos_json': True, 23:04:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:04:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:04:09 INFO - 'work_dir': 'build'} 23:04:09 INFO - ##### 23:04:09 INFO - ##### Running clobber step. 23:04:09 INFO - ##### 23:04:09 INFO - Running pre-action listener: _resource_record_pre_action 23:04:09 INFO - Running main action method: clobber 23:04:09 INFO - rmtree: /builds/slave/test/build 23:04:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:04:10 INFO - Running post-action listener: _resource_record_post_action 23:04:10 INFO - ##### 23:04:10 INFO - ##### Finished clobber step (success) 23:04:10 INFO - ##### 23:04:10 INFO - ##### 23:04:10 INFO - ##### Running read-buildbot-config step. 23:04:10 INFO - ##### 23:04:10 INFO - Running pre-action listener: _resource_record_pre_action 23:04:10 INFO - Running main action method: read_buildbot_config 23:04:10 INFO - Using buildbot properties: 23:04:10 INFO - { 23:04:10 INFO - "project": "", 23:04:10 INFO - "product": "firefox", 23:04:10 INFO - "script_repo_revision": "production", 23:04:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:04:10 INFO - "repository": "", 23:04:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:04:10 INFO - "buildid": "20160523203030", 23:04:10 INFO - "pgo_build": "True", 23:04:10 INFO - "basedir": "/builds/slave/test", 23:04:10 INFO - "buildnumber": 484, 23:04:10 INFO - "slavename": "talos-linux64-ix-014", 23:04:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:04:10 INFO - "platform": "ubuntu64_hw", 23:04:10 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:04:10 INFO - "branch": "fx-team", 23:04:10 INFO - "repo_path": "integration/fx-team", 23:04:10 INFO - "revision": "9e938575c485151e55c05dd7a1f824bdd8c64837", 23:04:10 INFO - "stage_platform": "linux64-pgo", 23:04:10 INFO - "builduid": "4ecf4be1d94c487b9ad1f6fc4b2989c1", 23:04:10 INFO - "slavebuilddir": "test" 23:04:10 INFO - } 23:04:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:04:10 INFO - Running post-action listener: _resource_record_post_action 23:04:10 INFO - ##### 23:04:10 INFO - ##### Finished read-buildbot-config step (success) 23:04:10 INFO - ##### 23:04:10 INFO - ##### 23:04:10 INFO - ##### Running download-and-extract step. 23:04:10 INFO - ##### 23:04:10 INFO - Running pre-action listener: _resource_record_pre_action 23:04:10 INFO - Running main action method: download_and_extract 23:04:10 INFO - mkdir: /builds/slave/test/build/tests 23:04:10 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')]} 23:04:10 INFO - https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:04:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:04:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:04:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/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 23:04:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/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 23:04:13 INFO - Downloaded 1361 bytes. 23:04:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:04:13 INFO - Using the following test package requirements: 23:04:13 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:04:13 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:04:13 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:04:13 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:13 INFO - u'jsshell-linux-x86_64.zip'], 23:04:13 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:04:13 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:04:13 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:04:13 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:04:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:04:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:04:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:04:13 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')]} 23:04:13 INFO - https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:04:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/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 23:04:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/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 23:04:15 INFO - Downloaded 24388634 bytes. 23:04:15 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'] 23:04:15 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 23:04:16 INFO - Return code: 0 23:04:16 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 23:04:16 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')]} 23:04:16 INFO - https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/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 23:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/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 23:04:25 INFO - Downloaded 24388634 bytes. 23:04:25 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'] 23:04:25 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 23:04:26 INFO - Return code: 0 23:04:26 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')]} 23:04:26 INFO - https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/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 23:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/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 23:04:27 INFO - Downloaded 10840359 bytes. 23:04:27 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'] 23:04:27 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 23:04:27 INFO - Return code: 0 23:04:27 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')]} 23:04:27 INFO - https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/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 23:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/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 23:04:29 INFO - Downloaded 58590690 bytes. 23:04:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:04:29 INFO - mkdir: /builds/slave/test/properties 23:04:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:04:29 INFO - Writing to file /builds/slave/test/properties/build_url 23:04:29 INFO - Contents: 23:04:29 INFO - build_url:https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:04:30 INFO - Running post-action listener: _resource_record_post_action 23:04:30 INFO - Running post-action listener: set_extra_try_arguments 23:04:30 INFO - ##### 23:04:30 INFO - ##### Finished download-and-extract step (success) 23:04:30 INFO - ##### 23:04:30 INFO - ##### 23:04:30 INFO - ##### Running populate-webroot step. 23:04:30 INFO - ##### 23:04:30 INFO - Running pre-action listener: _resource_record_pre_action 23:04:30 INFO - Running main action method: populate_webroot 23:04:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:04:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:04:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:04:30 INFO - '--tppagecycles', 23:04:30 INFO - '7'], 23:04:30 INFO - 'tests': ['tsvgm']}}, 23:04:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:04:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:04:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:04:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:04:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:04:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:04:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:30 INFO - 'talos_options': ['--disable-e10s'], 23:04:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:04:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:04:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:30 INFO - 'talos_options': ['--disable-e10s'], 23:04:30 INFO - 'tests': ['damp', 'tps']}, 23:04:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:30 INFO - 'tests': ['damp', 'tps']}, 23:04:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:04:30 INFO - 'tests': ['dromaeo_dom']}, 23:04:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:04:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:04:30 INFO - 'tests': ['a11yr', 23:04:30 INFO - 'ts_paint', 23:04:30 INFO - 'tpaint', 23:04:30 INFO - 'sessionrestore', 23:04:30 INFO - 'sessionrestore_no_auto_restore', 23:04:30 INFO - 'tabpaint']}, 23:04:30 INFO - 'other-e10s': {'tests': ['a11yr', 23:04:30 INFO - 'ts_paint', 23:04:30 INFO - 'tpaint', 23:04:30 INFO - 'sessionrestore', 23:04:30 INFO - 'sessionrestore_no_auto_restore', 23:04:30 INFO - 'tabpaint']}, 23:04:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:04:30 INFO - 'ts_paint', 23:04:30 INFO - 'tpaint', 23:04:30 INFO - 'sessionrestore', 23:04:30 INFO - 'sessionrestore_no_auto_restore', 23:04:30 INFO - 'tabpaint']}, 23:04:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:04:30 INFO - 'ts_paint', 23:04:30 INFO - 'tpaint', 23:04:30 INFO - 'sessionrestore', 23:04:30 INFO - 'sessionrestore_no_auto_restore', 23:04:30 INFO - 'tabpaint']}, 23:04:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:04:30 INFO - 'tests': ['a11yr', 23:04:30 INFO - 'ts_paint', 23:04:30 INFO - 'tpaint', 23:04:30 INFO - 'sessionrestore', 23:04:30 INFO - 'sessionrestore_no_auto_restore', 23:04:30 INFO - 'tabpaint']}, 23:04:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:04:30 INFO - 'tests': ['a11yr', 23:04:30 INFO - 'ts_paint', 23:04:30 INFO - 'tpaint', 23:04:30 INFO - 'sessionrestore', 23:04:30 INFO - 'sessionrestore_no_auto_restore', 23:04:30 INFO - 'tabpaint']}, 23:04:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:04:30 INFO - 'tests': ['tsvgx', 23:04:30 INFO - 'tsvgr_opacity', 23:04:30 INFO - 'tart', 23:04:30 INFO - 'tscrollx', 23:04:30 INFO - 'cart']}, 23:04:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:04:30 INFO - 'tsvgr_opacity', 23:04:30 INFO - 'tart', 23:04:30 INFO - 'tscrollx', 23:04:30 INFO - 'cart']}, 23:04:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:30 INFO - 'talos_options': ['--disable-e10s'], 23:04:30 INFO - 'tests': ['tp5o']}, 23:04:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:30 INFO - 'tests': ['tp5o']}, 23:04:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:30 INFO - 'talos_options': ['--disable-e10s', 23:04:30 INFO - '--xperf_path', 23:04:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:04:30 INFO - 'tests': ['tp5n']}, 23:04:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:04:30 INFO - 'talos_options': ['--xperf_path', 23:04:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:04:30 INFO - 'tests': ['tp5n']}}, 23:04:30 INFO - 'talos.zip': {'path': '', 23:04:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:04:30 INFO - Running post-action listener: _resource_record_post_action 23:04:30 INFO - ##### 23:04:30 INFO - ##### Finished populate-webroot step (success) 23:04:30 INFO - ##### 23:04:30 INFO - ##### 23:04:30 INFO - ##### Running create-virtualenv step. 23:04:30 INFO - ##### 23:04:30 INFO - Running pre-action listener: _resource_record_pre_action 23:04:30 INFO - Running main action method: create_virtualenv 23:04:30 INFO - Creating virtualenv /builds/slave/test/build/venv 23:04:30 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 23:04:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:04:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:04:30 INFO - Using real prefix '/usr' 23:04:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:04:30 INFO - Installing distribute.............................................................................................................................................................................................done. 23:04:32 INFO - Installing pip.................done. 23:04:32 INFO - Return code: 0 23:04:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f117d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22299c0>, '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 0x222a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222ad50>, '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': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', '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 23:04:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:04:32 INFO - Using env: {'DISPLAY': ':0', 23:04:32 INFO - 'HOME': '/home/cltbld', 23:04:32 INFO - 'LANG': 'en_US.UTF-8', 23:04:32 INFO - 'LANGUAGE': 'en_US:en', 23:04:32 INFO - 'LOGNAME': 'cltbld', 23:04:32 INFO - 'MAIL': '/var/mail/cltbld', 23:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:32 INFO - 'MOZ_NO_REMOTE': '1', 23:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:32 INFO - 'NO_EM_RESTART': '1', 23:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:32 INFO - 'PWD': '/builds/slave/test', 23:04:32 INFO - 'SHELL': '/bin/bash', 23:04:32 INFO - 'SHLVL': '1', 23:04:32 INFO - 'TERM': 'linux', 23:04:32 INFO - 'TMOUT': '86400', 23:04:32 INFO - 'USER': 'cltbld', 23:04:32 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', 23:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:32 INFO - '_': '/tools/buildbot/bin/python'} 23:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:32 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 23:04:32 INFO - Cleaning up... 23:04:33 INFO - Return code: 0 23:04:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:04:33 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')]} 23:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:33 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')]} 23:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:33 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 0x7f4f117d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22299c0>, '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 0x222a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222ad50>, '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': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', '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 23:04:33 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 23:04:33 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 23:04:33 INFO - Using env: {'DISPLAY': ':0', 23:04:33 INFO - 'HOME': '/home/cltbld', 23:04:33 INFO - 'LANG': 'en_US.UTF-8', 23:04:33 INFO - 'LANGUAGE': 'en_US:en', 23:04:33 INFO - 'LOGNAME': 'cltbld', 23:04:33 INFO - 'MAIL': '/var/mail/cltbld', 23:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:33 INFO - 'MOZ_NO_REMOTE': '1', 23:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:33 INFO - 'NO_EM_RESTART': '1', 23:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:33 INFO - 'PWD': '/builds/slave/test', 23:04:33 INFO - 'SHELL': '/bin/bash', 23:04:33 INFO - 'SHLVL': '1', 23:04:33 INFO - 'TERM': 'linux', 23:04:33 INFO - 'TMOUT': '86400', 23:04:33 INFO - 'USER': 'cltbld', 23:04:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', 23:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:33 INFO - '_': '/tools/buildbot/bin/python'} 23:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:33 INFO - Downloading/unpacking psutil>=3.1.1 23:04:33 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 23:04:33 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 23:04:33 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 23:04:33 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 23:04:33 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 23:04:33 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 23:04:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:04:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:04:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:04:36 INFO - Installing collected packages: psutil 23:04:36 INFO - Running setup.py install for psutil 23:04:36 INFO - building 'psutil._psutil_linux' extension 23:04:36 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 23:04:36 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 23:04:36 INFO - building 'psutil._psutil_posix' extension 23:04:36 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 23:04:36 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 23:04:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:04:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:04:36 INFO - Successfully installed psutil 23:04:36 INFO - Cleaning up... 23:04:36 INFO - Return code: 0 23:04:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:04: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')]} 23:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04: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')]} 23:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:36 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 0x7f4f117d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22299c0>, '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 0x222a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222ad50>, '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': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', '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 23:04:36 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 23:04:36 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 23:04:36 INFO - Using env: {'DISPLAY': ':0', 23:04:36 INFO - 'HOME': '/home/cltbld', 23:04:36 INFO - 'LANG': 'en_US.UTF-8', 23:04:36 INFO - 'LANGUAGE': 'en_US:en', 23:04:36 INFO - 'LOGNAME': 'cltbld', 23:04:36 INFO - 'MAIL': '/var/mail/cltbld', 23:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:36 INFO - 'MOZ_NO_REMOTE': '1', 23:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:36 INFO - 'NO_EM_RESTART': '1', 23:04:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:36 INFO - 'PWD': '/builds/slave/test', 23:04:36 INFO - 'SHELL': '/bin/bash', 23:04:36 INFO - 'SHLVL': '1', 23:04:36 INFO - 'TERM': 'linux', 23:04:36 INFO - 'TMOUT': '86400', 23:04:36 INFO - 'USER': 'cltbld', 23:04:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', 23:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:36 INFO - '_': '/tools/buildbot/bin/python'} 23:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:04:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:04:40 INFO - Installing collected packages: mozsystemmonitor 23:04:40 INFO - Running setup.py install for mozsystemmonitor 23:04:40 INFO - Successfully installed mozsystemmonitor 23:04:40 INFO - Cleaning up... 23:04:40 INFO - Return code: 0 23:04:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4f117d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22299c0>, '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 0x222a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222ad50>, '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': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', '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 23:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:04:40 INFO - Using env: {'DISPLAY': ':0', 23:04:40 INFO - 'HOME': '/home/cltbld', 23:04:40 INFO - 'LANG': 'en_US.UTF-8', 23:04:40 INFO - 'LANGUAGE': 'en_US:en', 23:04:40 INFO - 'LOGNAME': 'cltbld', 23:04:40 INFO - 'MAIL': '/var/mail/cltbld', 23:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:40 INFO - 'MOZ_NO_REMOTE': '1', 23:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:40 INFO - 'NO_EM_RESTART': '1', 23:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:40 INFO - 'PWD': '/builds/slave/test', 23:04:40 INFO - 'SHELL': '/bin/bash', 23:04:40 INFO - 'SHLVL': '1', 23:04:40 INFO - 'TERM': 'linux', 23:04:40 INFO - 'TMOUT': '86400', 23:04:40 INFO - 'USER': 'cltbld', 23:04:40 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', 23:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:40 INFO - '_': '/tools/buildbot/bin/python'} 23:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:40 INFO - Downloading/unpacking blobuploader==1.2.4 23:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:42 INFO - Downloading blobuploader-1.2.4.tar.gz 23:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:04:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04: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 23:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:04:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:43 INFO - Downloading docopt-0.6.1.tar.gz 23:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:04:43 INFO - Installing collected packages: blobuploader, requests, docopt 23:04:43 INFO - Running setup.py install for blobuploader 23:04:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:04:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:04:43 INFO - Running setup.py install for requests 23:04:44 INFO - Running setup.py install for docopt 23:04:44 INFO - Successfully installed blobuploader requests docopt 23:04:44 INFO - Cleaning up... 23:04:44 INFO - Return code: 0 23:04:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:04:44 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')]} 23:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:44 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')]} 23:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:44 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 0x7f4f117d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22299c0>, '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 0x222a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222ad50>, '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': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', '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 23:04:44 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 23:04:44 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 23:04:44 INFO - Using env: {'DISPLAY': ':0', 23:04:44 INFO - 'HOME': '/home/cltbld', 23:04:44 INFO - 'LANG': 'en_US.UTF-8', 23:04:44 INFO - 'LANGUAGE': 'en_US:en', 23:04:44 INFO - 'LOGNAME': 'cltbld', 23:04:44 INFO - 'MAIL': '/var/mail/cltbld', 23:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:44 INFO - 'MOZ_NO_REMOTE': '1', 23:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:44 INFO - 'NO_EM_RESTART': '1', 23:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:44 INFO - 'PWD': '/builds/slave/test', 23:04:44 INFO - 'SHELL': '/bin/bash', 23:04:44 INFO - 'SHLVL': '1', 23:04:44 INFO - 'TERM': 'linux', 23:04:44 INFO - 'TMOUT': '86400', 23:04:44 INFO - 'USER': 'cltbld', 23:04:44 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', 23:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:44 INFO - '_': '/tools/buildbot/bin/python'} 23:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:04:44 INFO - Running setup.py (path:/tmp/pip-UJjSOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:04:44 INFO - Running setup.py (path:/tmp/pip-qWNMOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:04:44 INFO - Running setup.py (path:/tmp/pip-xV0gx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:04:44 INFO - Running setup.py (path:/tmp/pip-qYUnDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:04:44 INFO - Running setup.py (path:/tmp/pip-rNMnqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:04:44 INFO - Running setup.py (path:/tmp/pip-Es4Y6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:04:44 INFO - Running setup.py (path:/tmp/pip-6MJRz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:04:44 INFO - Running setup.py (path:/tmp/pip-c8gvl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:04:44 INFO - Running setup.py (path:/tmp/pip-03BKmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:04:45 INFO - Running setup.py (path:/tmp/pip-ebqify-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:04:45 INFO - Running setup.py (path:/tmp/pip-Fm0YBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:04:45 INFO - Running setup.py (path:/tmp/pip-Sl7ThA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:04:45 INFO - Running setup.py (path:/tmp/pip-K83aH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:04:45 INFO - Running setup.py (path:/tmp/pip-gYSrPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:04:45 INFO - Running setup.py (path:/tmp/pip-FxEsJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:04:45 INFO - Running setup.py (path:/tmp/pip-SU2fsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:04:45 INFO - Running setup.py (path:/tmp/pip-YUrW6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:04:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:04:45 INFO - Running setup.py install for manifestparser 23:04:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:04:45 INFO - Running setup.py install for mozcrash 23:04:45 INFO - Running setup.py install for mozdebug 23:04:45 INFO - Running setup.py install for mozdevice 23:04:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Running setup.py install for mozfile 23:04:46 INFO - Running setup.py install for mozhttpd 23:04:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Running setup.py install for mozinfo 23:04:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Running setup.py install for mozInstall 23:04:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Running setup.py install for mozleak 23:04:46 INFO - Running setup.py install for mozlog 23:04:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Running setup.py install for moznetwork 23:04:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Running setup.py install for mozprocess 23:04:46 INFO - Running setup.py install for mozprofile 23:04:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:04:46 INFO - Running setup.py install for mozrunner 23:04:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:04:47 INFO - Running setup.py install for mozscreenshot 23:04:47 INFO - Running setup.py install for moztest 23:04:47 INFO - Running setup.py install for mozversion 23:04:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:04:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:04:47 INFO - Cleaning up... 23:04:47 INFO - Return code: 0 23:04:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:04: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')]} 23:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04: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')]} 23:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:47 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 0x7f4f117d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22299c0>, '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 0x222a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222ad50>, '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': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', '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 23:04:47 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 23:04:47 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 23:04:47 INFO - Using env: {'DISPLAY': ':0', 23:04:47 INFO - 'HOME': '/home/cltbld', 23:04:47 INFO - 'LANG': 'en_US.UTF-8', 23:04:47 INFO - 'LANGUAGE': 'en_US:en', 23:04:47 INFO - 'LOGNAME': 'cltbld', 23:04:47 INFO - 'MAIL': '/var/mail/cltbld', 23:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:47 INFO - 'MOZ_NO_REMOTE': '1', 23:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:47 INFO - 'NO_EM_RESTART': '1', 23:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:47 INFO - 'PWD': '/builds/slave/test', 23:04:47 INFO - 'SHELL': '/bin/bash', 23:04:47 INFO - 'SHLVL': '1', 23:04:47 INFO - 'TERM': 'linux', 23:04:47 INFO - 'TMOUT': '86400', 23:04:47 INFO - 'USER': 'cltbld', 23:04:47 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', 23:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:47 INFO - '_': '/tools/buildbot/bin/python'} 23:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:04:47 INFO - Running setup.py (path:/tmp/pip-FJlj7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:04:47 INFO - Running setup.py (path:/tmp/pip-qYosFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:04:47 INFO - Running setup.py (path:/tmp/pip-L2gA9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:04:47 INFO - Running setup.py (path:/tmp/pip-NNceUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:04:47 INFO - Running setup.py (path:/tmp/pip-HpiFQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:04:47 INFO - Running setup.py (path:/tmp/pip-DqHbnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:04:48 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)) 23:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:04:48 INFO - Running setup.py (path:/tmp/pip-pq5s4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:04:48 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)) 23:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:04:48 INFO - Running setup.py (path:/tmp/pip-RjdoLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:04:48 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)) 23:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:04:48 INFO - Running setup.py (path:/tmp/pip-L2jJI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:04:48 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)) 23:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:04:48 INFO - Running setup.py (path:/tmp/pip-4pgyHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:04:48 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)) 23:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:04:48 INFO - Running setup.py (path:/tmp/pip-nY_G86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:04:48 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)) 23:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:04:48 INFO - Running setup.py (path:/tmp/pip-v4vEOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:04:48 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)) 23:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:04:48 INFO - Running setup.py (path:/tmp/pip-9GmbiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:04:48 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)) 23:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:04:48 INFO - Running setup.py (path:/tmp/pip-tQU4Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:04:48 INFO - Running setup.py (path:/tmp/pip-3T0jPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:04:48 INFO - Running setup.py (path:/tmp/pip-ukCKgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:04:48 INFO - Running setup.py (path:/tmp/pip-Z1uL3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:04:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:51 INFO - Downloading blessings-1.6.tar.gz 23:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:04:51 INFO - Installing collected packages: blessings 23:04:51 INFO - Running setup.py install for blessings 23:04:51 INFO - Successfully installed blessings 23:04:51 INFO - Cleaning up... 23:04:51 INFO - Return code: 0 23:04:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:04:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:04:51 INFO - Reading from file tmpfile_stdout 23:04:51 INFO - Current package versions: 23:04:51 INFO - argparse == 1.2.1 23:04:51 INFO - blessings == 1.6 23:04:51 INFO - blobuploader == 1.2.4 23:04:51 INFO - docopt == 0.6.1 23:04:51 INFO - manifestparser == 1.1 23:04:51 INFO - mozInstall == 1.12 23:04:51 INFO - mozcrash == 0.17 23:04:51 INFO - mozdebug == 0.1 23:04:51 INFO - mozdevice == 0.48 23:04:51 INFO - mozfile == 1.2 23:04:51 INFO - mozhttpd == 0.7 23:04:51 INFO - mozinfo == 0.9 23:04:51 INFO - mozleak == 0.1 23:04:51 INFO - mozlog == 3.2 23:04:51 INFO - moznetwork == 0.27 23:04:51 INFO - mozprocess == 0.22 23:04:51 INFO - mozprofile == 0.28 23:04:51 INFO - mozrunner == 6.11 23:04:51 INFO - mozscreenshot == 0.1 23:04:51 INFO - mozsystemmonitor == 0.3 23:04:51 INFO - moztest == 0.7 23:04:51 INFO - mozversion == 1.4 23:04:51 INFO - psutil == 3.1.1 23:04:51 INFO - requests == 1.2.3 23:04:51 INFO - wsgiref == 0.1.2 23:04:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:04:51 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')]} 23:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:51 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')]} 23:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:51 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 0x7f4f117d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22299c0>, '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 0x222a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222ad50>, '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': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', '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 23:04:51 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 23:04:51 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 23:04:51 INFO - Using env: {'DISPLAY': ':0', 23:04:51 INFO - 'HOME': '/home/cltbld', 23:04:51 INFO - 'LANG': 'en_US.UTF-8', 23:04:51 INFO - 'LANGUAGE': 'en_US:en', 23:04:51 INFO - 'LOGNAME': 'cltbld', 23:04:51 INFO - 'MAIL': '/var/mail/cltbld', 23:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:51 INFO - 'MOZ_NO_REMOTE': '1', 23:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:51 INFO - 'NO_EM_RESTART': '1', 23:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:51 INFO - 'PWD': '/builds/slave/test', 23:04:51 INFO - 'SHELL': '/bin/bash', 23:04:51 INFO - 'SHLVL': '1', 23:04:51 INFO - 'TERM': 'linux', 23:04:51 INFO - 'TMOUT': '86400', 23:04:51 INFO - 'USER': 'cltbld', 23:04:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', 23:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:51 INFO - '_': '/tools/buildbot/bin/python'} 23:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:51 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)) 23:04:51 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)) 23:04:51 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)) 23:04:51 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)) 23:04:51 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)) 23:04:51 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)) 23:04:51 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)) 23:04:51 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)) 23:04:51 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)) 23:04:51 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)) 23:04:51 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)) 23:04:51 INFO - Cleaning up... 23:04:51 INFO - Return code: 0 23:04:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:04:51 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')]} 23:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:51 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')]} 23:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:51 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 0x7f4f117d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22299c0>, '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 0x222a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222ad50>, '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': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', '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 23:04:51 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 23:04:51 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 23:04:51 INFO - Using env: {'DISPLAY': ':0', 23:04:51 INFO - 'HOME': '/home/cltbld', 23:04:51 INFO - 'LANG': 'en_US.UTF-8', 23:04:51 INFO - 'LANGUAGE': 'en_US:en', 23:04:51 INFO - 'LOGNAME': 'cltbld', 23:04:51 INFO - 'MAIL': '/var/mail/cltbld', 23:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:51 INFO - 'MOZ_NO_REMOTE': '1', 23:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:51 INFO - 'NO_EM_RESTART': '1', 23:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:51 INFO - 'PWD': '/builds/slave/test', 23:04:51 INFO - 'SHELL': '/bin/bash', 23:04:51 INFO - 'SHLVL': '1', 23:04:51 INFO - 'TERM': 'linux', 23:04:51 INFO - 'TMOUT': '86400', 23:04:51 INFO - 'USER': 'cltbld', 23:04:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', 23:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:51 INFO - '_': '/tools/buildbot/bin/python'} 23:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:51 INFO - Downloading/unpacking jsonschema 23:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:04:54 INFO - Downloading/unpacking functools32 (from jsonschema) 23:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:54 INFO - Downloading functools32-3.2.3-2.tar.gz 23:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:04:54 INFO - warning: no files found matching '*.txt' 23:04:54 INFO - no previously-included directories found matching 'build' 23:04:54 INFO - no previously-included directories found matching 'dist' 23:04:54 INFO - no previously-included directories found matching '.git*' 23:04:54 INFO - Installing collected packages: jsonschema, functools32 23:04:54 INFO - Running setup.py install for functools32 23:04:54 INFO - warning: no files found matching '*.txt' 23:04:54 INFO - no previously-included directories found matching 'build' 23:04:54 INFO - no previously-included directories found matching 'dist' 23:04:54 INFO - no previously-included directories found matching '.git*' 23:04:54 INFO - Successfully installed jsonschema functools32 23:04:54 INFO - Cleaning up... 23:04:54 INFO - Return code: 0 23:04:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:04: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')]} 23:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04: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')]} 23:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:04:54 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 0x7f4f117d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22299c0>, '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 0x222a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222ad50>, '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': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', '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 23:04:54 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 23:04:54 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 23:04:54 INFO - Using env: {'DISPLAY': ':0', 23:04:54 INFO - 'HOME': '/home/cltbld', 23:04:54 INFO - 'LANG': 'en_US.UTF-8', 23:04:54 INFO - 'LANGUAGE': 'en_US:en', 23:04:54 INFO - 'LOGNAME': 'cltbld', 23:04:54 INFO - 'MAIL': '/var/mail/cltbld', 23:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:04:54 INFO - 'MOZ_NO_REMOTE': '1', 23:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:04:54 INFO - 'NO_EM_RESTART': '1', 23:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:04:54 INFO - 'PWD': '/builds/slave/test', 23:04:54 INFO - 'SHELL': '/bin/bash', 23:04:54 INFO - 'SHLVL': '1', 23:04:54 INFO - 'TERM': 'linux', 23:04:54 INFO - 'TMOUT': '86400', 23:04:54 INFO - 'USER': 'cltbld', 23:04:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', 23:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:04:54 INFO - '_': '/tools/buildbot/bin/python'} 23:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:04:54 INFO - Downloading/unpacking flake8 23:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:04:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:04:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:04:58 INFO - no previously-included directories found matching 'docs/_build' 23:04:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:04:58 INFO - Running setup.py install for pep8 23:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:04:58 INFO - no previously-included directories found matching 'docs/_build' 23:04:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:04:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:04:58 INFO - Cleaning up... 23:04:58 INFO - Return code: 0 23:04:58 INFO - Running post-action listener: _resource_record_post_action 23:04:58 INFO - Running post-action listener: _start_resource_monitoring 23:04:58 INFO - Starting resource monitoring. 23:04:58 INFO - ##### 23:04:58 INFO - ##### Finished create-virtualenv step (success) 23:04:58 INFO - ##### 23:04:58 INFO - ##### 23:04:58 INFO - ##### Running install step. 23:04:58 INFO - ##### 23:04:58 INFO - Running pre-action listener: _resource_record_pre_action 23:04:58 INFO - Running main action method: install 23:04:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:04:58 INFO - Reading from file tmpfile_stdout 23:04:58 INFO - Detecting whether we're running mozinstall >=1.0... 23:04:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:04:58 INFO - Reading from file tmpfile_stdout 23:04:58 INFO - Output received: 23:04:58 INFO - Usage: mozinstall [options] installer 23:04:58 INFO - Options: 23:04:58 INFO - -h, --help show this help message and exit 23:04:58 INFO - -d DEST, --destination=DEST 23:04:58 INFO - Directory to install application into. [default: 23:04:58 INFO - "/builds/slave/test"] 23:04:58 INFO - --app=APP Application being installed. [default: firefox] 23:04:58 INFO - mkdir: /builds/slave/test/build/application 23:04:58 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'] 23:04:58 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 23:05:15 INFO - Reading from file tmpfile_stdout 23:05:15 INFO - Output received: 23:05:15 INFO - /builds/slave/test/build/application/firefox/firefox 23:05:15 INFO - Running post-action listener: _resource_record_post_action 23:05:15 INFO - ##### 23:05:15 INFO - ##### Finished install step (success) 23:05:15 INFO - ##### 23:05:15 INFO - ##### 23:05:15 INFO - ##### Running run-tests step. 23:05:15 INFO - ##### 23:05:15 INFO - Running pre-action listener: _resource_record_pre_action 23:05:15 INFO - Running main action method: run_tests 23:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:05:15 INFO - Python 2.7.3 23:05:15 INFO - Return code: 0 23:05:15 INFO - grabbing minidump binary from tooltool 23:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22299c0>, '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 0x222a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:05:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:05:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:05:15 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 23:05:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:05:15 INFO - Return code: 0 23:05:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:05:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:05:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:05:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:05:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:05:16 INFO - Return code: 0 23:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 23:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 23:05:16 INFO - Using env: {'DISPLAY': ':0', 23:05:16 INFO - 'HOME': '/home/cltbld', 23:05:16 INFO - 'LANG': 'en_US.UTF-8', 23:05:16 INFO - 'LANGUAGE': 'en_US:en', 23:05:16 INFO - 'LOGNAME': 'cltbld', 23:05:16 INFO - 'MAIL': '/var/mail/cltbld', 23:05:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:05:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:16 INFO - 'MOZ_NO_REMOTE': '1', 23:05:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:16 INFO - 'NO_EM_RESTART': '1', 23:05:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:16 INFO - 'PWD': '/builds/slave/test', 23:05:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:05:16 INFO - 'SHELL': '/bin/bash', 23:05:16 INFO - 'SHLVL': '1', 23:05:16 INFO - 'TERM': 'linux', 23:05:16 INFO - 'TMOUT': '86400', 23:05:16 INFO - 'USER': 'cltbld', 23:05:16 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375', 23:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:16 INFO - '_': '/tools/buildbot/bin/python'} 23:05:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 23:05:16 INFO - mozversion application_buildid: 20160523203030 23:05:16 INFO - mozversion application_changeset: 9e938575c485151e55c05dd7a1f824bdd8c64837 23:05:16 INFO - mozversion application_display_name: Nightly 23:05:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:05:16 INFO - mozversion application_name: Firefox 23:05:16 INFO - mozversion application_remotingname: firefox 23:05:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:05:16 INFO - mozversion application_vendor: Mozilla 23:05:16 INFO - mozversion application_version: 49.0a1 23:05:16 INFO - mozversion platform_buildid: 20160523203030 23:05:16 INFO - mozversion platform_changeset: 9e938575c485151e55c05dd7a1f824bdd8c64837 23:05:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:05:16 INFO - mozversion platform_version: 49.0a1 23:05:16 INFO - using testdate: 1464069916 23:05:16 INFO - actual date: 1464069916 23:05:16 INFO - starting webserver on 'localhost:46254' 23:05:16 INFO - SUITE-START | Running 2 tests 23:05:16 INFO - TEST-START | dromaeo_css 23:05:16 INFO - operating with platform_type : linux_ 23:05:16 INFO - Initialising browser for dromaeo_css test... 23:05:16 INFO - TEST-INFO | started process 24891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2WIZIm/profile http://localhost:46254/getInfo.html) 23:05:20 INFO - PROCESS | 24891 | 23:05:20 INFO - PROCESS | 24891 | (process:24960): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:05:21 INFO - PROCESS | 24891 | __metrics Screen width/height:1600/1200 23:05:21 INFO - PROCESS | 24891 | colorDepth:24 23:05:21 INFO - PROCESS | 24891 | Browser inner width/height: 1024/697 23:05:21 INFO - PROCESS | 24891 | __metrics 23:05:21 ERROR - PROCESS | 24891 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:05:22 INFO - TEST-INFO | 24891: exit 0 23:05:22 INFO - Browser initialized. 23:05:22 INFO - Running cycle 1/1 for dromaeo_css test... 23:05:22 INFO - TEST-INFO | started process 25011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2WIZIm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:05:24 INFO - PROCESS | 25011 | 23:05:24 INFO - PROCESS | 25011 | (process:25076): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:05:34 INFO - PROCESS | 25011 | RSS: Main: 164306944 23:05:34 INFO - PROCESS | 25011 | 23:06:23 INFO - PROCESS | 25011 | 1464069983983 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:08:31 INFO - PROCESS | 25011 | Cycle 1(1): loaded http://localhost:46254/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46254/tests/dromaeo/cssquery-ext.html) 23:08:32 INFO - PROCESS | 25011 | RSS: Main: 166924288 23:08:32 INFO - PROCESS | 25011 | 23:11:34 INFO - PROCESS | 25011 | Cycle 1(1): loaded http://localhost:46254/tests/dromaeo/cssquery-ext.html (next: http://localhost:46254/tests/dromaeo/cssquery-jquery.html) 23:11:35 INFO - PROCESS | 25011 | RSS: Main: 166703104 23:11:35 INFO - PROCESS | 25011 | 23:14:37 INFO - PROCESS | 25011 | Cycle 1(1): loaded http://localhost:46254/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46254/tests/dromaeo/cssquery-mootools.html) 23:14:37 INFO - PROCESS | 25011 | RSS: Main: 167972864 23:14:37 INFO - PROCESS | 25011 | 23:17:39 INFO - PROCESS | 25011 | Cycle 1(1): loaded http://localhost:46254/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46254/tests/dromaeo/cssquery-prototype.html) 23:17:40 INFO - PROCESS | 25011 | RSS: Main: 165715968 23:17:40 INFO - PROCESS | 25011 | 23:20:42 INFO - PROCESS | 25011 | Cycle 1(1): loaded http://localhost:46254/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46254/tests/dromaeo/cssquery-yui.html) 23:20:43 INFO - PROCESS | 25011 | RSS: Main: 166514688 23:20:43 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | Cycle 1(1): loaded http://localhost:46254/tests/dromaeo/cssquery-yui.html (next: http://localhost:46254/tests/dromaeo/cssquery-dojo.html) 23:23:46 INFO - PROCESS | 25011 | RSS: Main: 169050112 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | __start_tp_report 23:23:46 INFO - PROCESS | 25011 | _x_x_mozilla_page_load 23:23:46 INFO - PROCESS | 25011 | _x_x_mozilla_page_load_details 23:23:46 INFO - PROCESS | 25011 | |i|pagename|runs| 23:23:46 INFO - PROCESS | 25011 | |0;dojo.html;3094;3103.8758449661987;3112.299732560174;3132.718055375016;3155.3689262147564;5339.7330133493315;5369.167778994257;5380.946190538093;5401.4328495508;5421.21392398102;5147.459516750743;5325.733713314338;5421.186821976706;5422.267993820833;5426.945730542693;4889.217725163983;4930.087933732271;5054.3176671149295;5081.974590127044;5132.640715149941;722.6349584428189;4845.878853028685;4883.804647814083;4912.263160525914;4957.107720610306;4891.4619391867045;4930.482299358551;4944.060628480577;4951.925721114186;4955.776990035439;4960.032793605248;4961.3798275215595;4962.106820772259;4978.726170060645;4989.301497790312;4884.438289596706;4925.113479573675;4939.5554400104165;4942.061008408391;4952.975235123838;5311.468853114658;5341.893162136775;5347.812826551091;5366.248725178478;5391.865203369908;5688.175214593861;5692.345380281279;5823.068309070571;5860.589758716891;5898.203742494751;5854.882902341972;5859.6777177255235;5865.706714664292;5923.407659234085;5941.55438342126;5488.231647569343;5497.367802702661;5501.889962200774;5504.9174262385695;5510.504054635062;5774.335951365562;5827.329857066492;6011.549133814981;6048.516118710492;6052.909206361908;5710.428957104339;5727.2268243787385;5763.4812866842185;5789.94210057894;5794.565407594448;5824.854378640568;5831.2127862738835;5853.795117170878;5861.3845546217035;5877.500412464989;5569.081101618269;5758.222639943638;5777.45114214149;5826.650400975955;5844.298684157929;5732.742026608813;5757.280339957505;5757.309122905194;5774.711264436762;5782.913256301159;4468.620167285752;4475.820967161342;4481.7983190756495;4497.437820272466;4521.502634710179;3859.6333348331864;3921.5294164700417;3946.309395855714;3951.1702542465828;3977.840886364571;5628.577856660685;5644.209810626516;5648.548116150698;5702.971485142548;5722.141678748221;5788.507976821933;5945.227120474397;5945.791897283574;5948.7323070461935;5958.404159584007;5492.780288788404;5587.3015873015875;5611.382747897728;5615.466530679579;5646.548276137899;4900.26496025599;4909.239067944474;4966.701997880139;4978.352814134139;5009.173486374707;6091.51267898567;6105.755769769248;6109.2974307955155;6117.785877494266;6144.354842741448;5678.432156784289;5773.480386765212;5787.536997040311;5788.942110579009;5873.911891321719;6028.608140470856;6038.879222415615;6042.788502402394;6049.062395328731;6072.605280656743;5630.971845140748;5732.34078081026;5733.168690539932;5743.8851222976145;5756.94243057564;5726.742296596746;5732.512736417284;5734.483896449173;5784.421557844182;5790.884182316414;5644.88710225785;5648.350439699487;5658.547316214611;5658.688772117408;5659.6321239119325;5493.835184944458;5564.527015203753;5611.270534830446;5620.74706638194;5693.629914055573;5579.832605021856;5626.071698169756;5628.8874222514505;5630.774769009357;5677.829665110054;5730.541556675373;5762.798302059407;5775.451332123442;5789.623674461147;5808.970955145366;5458.290422245242;5490.615656903979;5515.034868898007;5664.943350566442;5669.461401166883 23:23:46 INFO - PROCESS | 25011 | |1;ext.html;592.688838359861;636.8789929913319;653.6600967496902;670.8595387840669;673.4444083631006;42254.7887260564;43220.56779432205;43302.783486082604;43326.35010474842;43446.56553434465;43723.78138109305;44099.338509922374;44310.778446107724;44344.11311773762;44400.555994440045;8697.1302869713;8851.070637583058;8874.911250887473;8882.245009174228;8899.68851090212;8587.785305367353;8767.254783343391;8768.298536117127;8772.649094036231;8773.95613021934;8698.782530436758;8791.912080879205;8798.428102173339;8830.867536986918;8832;8707.912920870805;8743.256823170039;8747;8766.035736068996;8786.912130878673;8586.742397728078;8675.56622168889;8720.084391138966;8726.738197854074;8753.255973242281;33055.83472082648;41481;41488.37767433491;41781;41965.580344196474;3405.2338223899674;3411.727061835047;3638.3632864248652;3659.72552058594;3697.352963231424;31592.842035789905;32105;32148.03555893327;33536.496952545735;35088.82455587706;4180.707350485467;4227.577242275778;4235.343521754133;4276.379924910871;4296.8281268749215;344984;348504;349269;352192;352384.2380788105;35655.64344356575;36162.27675446529;64995.35004649987;65186;65903.34096658972;37566;37956.43065354022;38002.80998594989;38007.2398552033;38390;14997.775033374508;15013.474528391454;15123.243837808066;15177;15193.924030379778;12903.161294515827;12931.224126552248;12948.352582370844;13015.219086854819;13038.608841734764;8585.227329540247;8638.956805215934;8657.610407531676;8686.087960764029;8716.694915677921;3316.369889720945;3357.1439282982683;3369.747268954838;3398.8810391636175;3450.4996775467416;985.8964808695127;1083.7453198498347;1094.8248280275118;1108.0027974822563;1140.686311264409;32449.35101297961;32734.508982365285;32785.50821737676;32828.17929551732;32932;1094.5129417409335;1159.8144296912453;1176.1707995862896;1177.2759752752168;1179.9174057815871;16864.241109150116;17553.21010554528;17574.736378954327;17641;17819.73270400945;569168;572426;575181;575949;578121;40467.98830029273;40799.59200408017;40848.79575602103;40903.590964090574;40990.38514422286;1317.5586178630267;1356.3625096204769;1359.6328991172527;1374.1617613255905;1385.369656806171;30943.607537661308;31139.91010314628;31882.52176217405;31930.36139277248;32554.674453255164;52918;53138.46861531335;53290;53473;53602.46397536131;414714;422260;423960;425295;425362;28719.138425847257;29099.272518187216;29244.268893277836;29346.413071738018;29445.11664650064;47017.764911175225;48256.7587162062;48539;48574;49859.501404986935;41698.37452438155;42324.5767542333;42554.36168457538;42728.78635606802;43171;41055;41179.1764164721;41622.37566436567;41689.160818188095;42609.36085958775;35810.28379432449;40055.1988960225;40373;41043.79478102591;41149.588504114574;32384;33805.49291760576;34242.48636270408;34270.31459370749;34485;28418.06724787055;28699.71300287054;28919;28936.56595151032;29031 23:23:46 INFO - PROCESS | 25011 | |2;jquery.html;363.51289272375027;380.7334865594085;381.5516767797837;382.4359070371202;399.5964076282953;17900.731489027676;19201;19413.417597472082;20166.193352265927;20177.899110504444;17649.382271620496;18669.626607467875;18715.43853684388;18946.43160705181;19017.2393104276;5103.8468845934685;5127.743612819344;5315.734213289339;5335.093034184179;5337.06601344765;5167;5200.92198617021;5222.060029194743;5242.030224408478;5243.082460569404;5189.584833213353;5223.660462069973;5227.843164705065;5240.161574148137;5283.181106928432;5614.9157762633595;5721.942780572224;5732.0542110551705;5751.166080918264;5760;4953.504649535053;5106.310648062501;5162.6902385856965;5185.766640501187;5191.610629202825;12786.168899021533;13097.738045239043;13115;13277.734445311136;13298.534551290659;2274.4200228941513;2401.1715957994465;2420.2739178246457;2544.7530709952175;2563.9615405768927;10089;10197.949010254975;12263.386830658521;14561;14588.27058647074;1945.2121890634317;1961.205711686769;1971.2607772085469;1997.3508609701905;2051.8768873867466;59617.70191149016;65019.67490162519;67315.66342168258;72717.27282727211;78165.21834781693;10642;10717.571297148026;11011.174161937886;11148.777024459465;11242.831357529643;15153.090814551162;15230.086194828124;15261.084334939938;15363.462278820187;15434.6141346465;7832.804179895548;7951.403644726669;8008.559529225949;8148.470349427268;8154.38842086834;7653.923460765321;7715.305622494003;7746.57393843344;7841.019872515935;7874.133845277015;4640.424564366809;4649.837255696035;4706.623470122382;4733.83431579893;4760.071786001766;1903.4099429177;1926.489480287725;1936.9806301937083;1971.86196966211;2014.7380840490641;894.5080205886867;916.7364183506737;1001.3140998416109;1008.6721815410021;1033.0495943731785;17461.47615571535;17977.550561236072;18561.35035273759;19017.429477115707;19271.13279902408;1033.8397548380012;1043.6034306963306;1049.8687664041995;1057.7620035492107;1084.0297933349607;10548.789024219474;11160.497777599865;11181.664550063511;11186.216964812547;11266.943665281786;486927;488359;489197;552547;564514;57631.135532966204;93437.5328123355;96162.51918740502;96830.51584742172;96931.24550036121;1015.1777060580805;1020.8315627921459;1040.4433628008978;1043.5147656339686;1059.7668512927298;17519.912400437915;17578.648427031643;18017.459476215212;18025.278988840822;18086.819131808512;39967.2006559873;41927.371089434295;42320.5767942329;42551.7872410636;42835.357469637354;58542;59970.76008801954;60022.69988650029;60690.393096068474;61461;8249.79375515617;8371.665133394596;8381.580920953806;8384.329253659815;8705.73882783492;9492.477913714813;13088.934555327163;13330.400131993889;13336.19982801035;13471.393787279792;11431.199816013132;11470.827937580776;11711.414429278331;11852.229605075643;11934.403279836148;11401.885981140082;11646.650600481998;11709.180357374902;11779.823302650639;11870.525178992744;11351.48918298695;11446.542138314708;11732.648020559396;12041.759164816829;12058.03535717158;8310.376721746014;8438.742949876472;8533.786655333419;8655.740327790176;8672.653093876426;11196.776064478829;11688.532458701557;11919.165658404176;12137.878621213675;12334.383280835742 23:23:46 INFO - PROCESS | 25011 | |3;mootools.html;1501.444465547747;1545.1192820092547;1662.8004639443268;1777.5911540345712;1801.3425099838555;8012.799680007988;8678.262347700445;8797.07630698777;9274.67538636148;9316.254699624022;8802.735917922473;9099.681511147111;9108.134727200922;9119.863202051974;9123.224525915288;2319.7680231976838;2362.9054837806466;2364.9408764780846;2375.3349062262596;2378.1676413255395;2323.4191452136965;2336.380859072347;2394.8682822444844;2396.101461951768;2397.041183526586;2330.7902288794007;2339.578875802355;2351.5649604823075;2377.8216633752536;2381.9761802382013;2281.3384118605586;2281.532285881399;2293.816494680422;2302.309307207831;2308.7114110736156;2269.4553307206315;2311.8266130040147;2322.779335963081;2326.674265602817;2331.778481044298;9090.090990900922;9174.724758257264;9177.174054335143;9184.954075229647;9199;5248.291480650101;5314;5422.620416570841;5436;5442.891142177174;3433.5536380270655;3484.3379757846183;3513.367593833109;3545.85816567337;3567.839447224855;1118.105515587535;1124.668222874254;1130.2822707580744;1146.7419830538063;1181.2794195540714;12711.682207944783;12776.169548979287;12783.744325113446;12785.936070319682;12858.614241572768;4582.427196600425;4668.883277918011;4699.600533954584;4729.7398643074275;4749.097671442415;10059.245556583286;10089.041541053588;10102.040306170902;10103.444310562989;10125.493725313705;5397.730113494388;5457.918131228034;5460.781568737286;5466.180072989004;5467.043267428184;4419.734815911055;4938.530839570235;5019.14674505335;5057.115004874132;5083.822066227664;3695.150115473456;3759.812009399519;3781.640744129303;3781.6785573226034;3882.242962622318;1162.7209469727204;1163.2613290560387;1173.0908545877014;1173.5481839491856;1185.8399116119385;889.9911000890038;905.8958219804807;981.9410835349902;1014.7767491151935;1022.1107636356418;6032.969835150796;6334.271558770801;6393.1688880445245;6401.231852177769;6495.1935567679575;441.80118946474215;452.7057412681783;460.4313672614319;467.231404339859;468.53146853146853;4209;4444.599986001211;4454.086912182995;4516;4532.342810292489;11107;11394.1454390921;11501.597444089417;11533.308001519936;11554.422278886022;10768.3538987661;11189.664310070712;11302.43487825622;11340.886591134147;11389.601363952388;8508.617112229964;8642.611082501302;8650.78373040679;8660.8700869487;8673.696420625249;6183.103449999635;6435.581687190318;6449.419552240133;6453.967730161319;6519.934800652122;10270.537825797708;10528.473576321307;10756.623518177139;10783.946080269548;10791.244612877023;10644;10688.091512221548;10713.250072494851;10782.137429005505;10798.082163016232;7299.087614048244;7837.960810195913;7919.802004949923;7965.641546130554;8100.635471403683;8863.537516309736;8881.822363552563;8891.110888911056;8964.641414343354;8975.28197744192;7864.370850332074;7871.134175240604;8009.359251259769;8072.112067672434;8111;7664.961675191588;7671.769846904602;7734.265244801735;7780.533168009937;7788.104367997753;7285.854282914418;7368.852622947618;7375.926240737524;7421.851562968818;7457.47797654159;5267.578593712417;5315.0964336063735;5362.678239305654;5375.704336261387;5501.5323697486165;5523.25436066142;5547.278853749148;5561.777528898799;5575.470330318775;5586.301712285965 23:23:46 INFO - PROCESS | 25011 | |4;prototype.html;309.41674942732953;317.1579456542878;319.5749652961561;319.5893277138877;324.8164786895404;5422.539084177844;5455.727213639322;5493.258410114633;5513.255710479079;5514.200440936062;5381.219723140142;5385.272988146599;5388.703621300827;5453.182022696587;5461.508464238228;4173.749575025493;4286.228478873802;4290.7985763986135;4292.205941900743;4303.376010478479;4238.427812245338;4247.171801498709;4248.893777655568;4265.31754919213;4265.765382903939;4194.916101677964;4211.452511173543;4230.990279617188;4266.146770645868;4291.334843099325;4065.2072845795083;4078.3270760324513;4221.936670949938;4233.428487154241;4262.637675797561;3690.612485688991;3707.796071216082;3713.4429835524616;3714.238581090897;3740.6446387593137;5293.9735301323635;5332.893342133136;5334.5732341412595;5348.331458567679;5361.410244873061;4644.837430689943;4808.807647694123;4822.63830212732;4843.927341089887;4852.878678033077;5659.971700141473;5693.572982026323;5707.429257074301;5713.228714123623;5746.569007324468;4077.55146933837;4079.102597428561;4079.4084857695766;4094.263032654121;4097.959020409788;5649.305208437452;5921.61509501881;5925.585209035326;5931.762729490815;5956.851078723066;4057.4522439470293;4075.9388609170887;4093.8946484449034;4095.6313931746286;4122.1244333828035;4133;4146.942529654919;4147.751134931914;4156.459660244149;4172.958270417257;4576.199165146086;4798.712077275374;4804;4826.348442960226;4845.6123510119105;5833.891560603472;5851.093080572518;5859.853503662357;5864.384239654775;5876.941230587639;1444.1407362619225;1463.0563286680033;1467.9633009174643;1468.0897843336986;1469.904456210343;881.1628952495155;914.5244472874201;919.2691810011057;927.679950417105;932.4079209701888;5024.337101336298;5026.84919452417;5040.924386134211;5059.215821547666;5065.594752419797;5184.196449550326;5251.868703282448;5253.763580638881;5274.3670759509105;5299.258103865462;4971.875703107451;5009.924851127236;5033.345665063518;5374.247605335257;5693;3137.3685683444482;3150.936981260362;3179.3482336121037;3184.633767116811;3187.920301992469;6128.662923539159;6148.754049838046;6219.315875253718;6221.720022598994;6229.190205273376;5957.672328022;5994.460498555064;5994.910076348859;6037.72830222641;6067.393260673897;6149.3235744068115;6218.098375735493;6261.9373806262265;6289.905651415233;6293.527985401113;5879.588428809942;5926.718213487752;6012.819615411545;6016.5487588431915;6025.578209525291;5936.7922122725495;5961.821145365646;5969.552283578662;5975.223220981245;5988.28140623128;6021.885951099061;6112.847178820565;6222.315545290105;6330.942443705722;6335.2261366817365;4086.5504794473177;4096.057906681421;4107.096438783463;4111.527174374985;4122.711410201257;5945.494632956247;5964.821055368346;5968;5971.313298970674;5998.9801733706245;5533.98009726455;5778.133280008033;5827.446392592697;5831.766729330949;5865.882682346244;5774.141799809121;5775.6823374714795;5777.682227477361;5805.535557155502;5832.83343331327;5398.217258497417;5626.662400255997;5642.069058605448;5659.915101273402;5663.377028526941;5675.120356344773;5726.599138060463;5781.612413020761;5839.1096407278665;5906.497947674496;5615.831525054255;5659.490645841894;5671.574631902707;5686.4029276926985;5725.8568535786935 23:23:46 INFO - PROCESS | 25011 | |5;yui.html;826.1696994520507;851.5954921412334;858.9570521473929;866.3069544364511;873.7990262239684;14744.852551474482;15381.846181538182;15386.61533461664;15554.144522051283;15635.140067296279;14368;14449.133052016887;14449.5665130046;14461.20463374514;14575.708485830277;681.471859309037;796.1918652567648;807.5114555693809;816.4529765057396;820.4953953318726;813.6297984417076;822.9135940726227;824.9587520623975;826;826.2481142160635;884.8628462588309;885.2519620920344;886.3396769406801;887.0419946457843;887.951162686052;879.3580686099151;880.665347168072;885.0574138542496;885.4200498673412;887.7913690282778;636.11897521932;640.1134428816076;641.7689631732572;642.7782415066841;643.1960049937578;14038.789418158736;14115.364808583638;14161.291935403291;14190.50333238342;14200.289985500684;14620.926895365561;14742.410303587843;14777.852221477862;14791.186484743335;14796.260186990607;11907.880921190765;11926.224795388272;11998.880011199952;12012;12132.332721700302;3876;4029.979850100731;4040.1717647882406;4075;4079.3065178919655;55342.72328638331;55983.44016559823;55984.16023759647;56004.719976400265;56373.15440268358;10548.894511054945;11069.114470842313;11257.549698012152;11269.605563805391;11525.596604118984;18287.81712182861;19094;19126.521836954187;19848;20714.896425517774;8391.076981532027;8556.529390883561;8602.52686102258;8761.299096072298;8816.294696424271;4679;4760.428748550196;4794.2808578713475;4842.5157484251295;4879.804807807648;3462.290230502741;3548.2371290172737;3553.09396103997;3555.5733312002208;3560.3235385276716;665.0788657709011;682.2495255219318;692.1140939597324;694.0872752330669;706.5160365149889;649.5518092516148;711.2389742975071;742.4839736383162;760.8478304339154;769.1539306762517;10137.64518241858;10269.963001007292;10286.177105831515;10386.636467723745;10523.631672891412;653.6666300186939;672.9899051514232;736.8047467421138;757.0158793568339;778.5250996891891;4535.131546766358;4913.975430122827;4920.458749537548;4980.224553433607;5000.799968001312;63867;66065;66397.6680116606;66795.33204667988;67322.3267767316;58718.706406467696;58881;59167.40832591705;59327.406725933055;61479.385206147366;52949.470505294456;53160.468395316326;54155.18767218495;54309.45690543044;54524.45475545273;9273.124122809186;9530.714078577654;9846.838043196596;10116.24128190374;10175.135113515138;36126.63873361338;36203.09492262715;36418.893629762075;36682;36816.26367472582;48398.75800621115;48792.512074878796;49014.50985490242;49197;49360.50639493559;11762.941185294361;12416.379181040731;12685.746285074432;12982.480700772241;13059.804102938653;14110.223937683526;14160.221187834768;14246.501372451914;14297.213653249171;14399.280035997948;13125.212487250796;13222.404991775586;13250.734985300047;13437.260950647807;13750.518731844337;13384;13545.390457429243;13546.254955977516;13652.112612680145;14078.366473508922;12832.422540985865;13061;13130.606081817561;13180.472781088649;13189.472421103432;10059.39643621385;10107.595696172071;10537.89462105369;10617.469126543796;10822.837657435302;10638.573421000014;10768.300060496043;10910.23628346008;10937;10947 23:23:46 INFO - PROCESS | 25011 | __end_tp_report 23:23:46 INFO - PROCESS | 25011 | __start_cc_report 23:23:46 INFO - PROCESS | 25011 | _x_x_mozilla_cycle_collect,367 23:23:46 INFO - PROCESS | 25011 | __end_cc_report 23:23:46 INFO - PROCESS | 25011 | __startTimestamp1464071026486__endTimestamp 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | ------- Summary: start ------- 23:23:46 INFO - PROCESS | 25011 | Number of tests: 6 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | [#0] dojo.html Cycles:165 Average:5380.11 Median:5644.21 stddev:721.98 (12.8%) stddev-sans-first:701.56 23:23:46 INFO - PROCESS | 25011 | Values: 3094.0 3103.9 3112.3 3132.7 3155.4 5339.7 5369.2 5380.9 5401.4 5421.2 5147.5 5325.7 5421.2 5422.3 5426.9 4889.2 4930.1 5054.3 5082.0 5132.6 722.6 4845.9 4883.8 4912.3 4957.1 4891.5 4930.5 4944.1 4951.9 4955.8 4960.0 4961.4 4962.1 4978.7 4989.3 4884.4 4925.1 4939.6 4942.1 4953.0 5311.5 5341.9 5347.8 5366.2 5391.9 5688.2 5692.3 5823.1 5860.6 5898.2 5854.9 5859.7 5865.7 5923.4 5941.6 5488.2 5497.4 5501.9 5504.9 5510.5 5774.3 5827.3 6011.5 6048.5 6052.9 5710.4 5727.2 5763.5 5789.9 5794.6 5824.9 5831.2 5853.8 5861.4 5877.5 5569.1 5758.2 5777.5 5826.7 5844.3 5732.7 5757.3 5757.3 5774.7 5782.9 4468.6 4475.8 4481.8 4497.4 4521.5 3859.6 3921.5 3946.3 3951.2 3977.8 5628.6 5644.2 5648.5 5703.0 5722.1 5788.5 5945.2 5945.8 5948.7 5958.4 5492.8 5587.3 5611.4 5615.5 5646.5 4900.3 4909.2 4966.7 4978.4 5009.2 6091.5 6105.8 6109.3 6117.8 6144.4 5678.4 5773.5 5787.5 5788.9 5873.9 6028.6 6038.9 6042.8 6049.1 6072.6 5631.0 5732.3 5733.2 5743.9 5756.9 5726.7 5732.5 5734.5 5784.4 5790.9 5644.9 5648.4 5658.5 5658.7 5659.6 5493.8 5564.5 5611.3 5620.7 5693.6 5579.8 5626.1 5628.9 5630.8 5677.8 5730.5 5762.8 5775.5 5789.6 5809.0 5458.3 5490.6 5515.0 5664.9 5669.5 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | [#1] ext.html Cycles:180 Average:59269.44 Median:41049.40 stddev:121997.47 (297.2%) stddev-sans-first:122260.16 23:23:46 INFO - PROCESS | 25011 | Values: 592.7 636.9 653.7 670.9 673.4 42254.8 43220.6 43302.8 43326.4 43446.6 43723.8 44099.3 44310.8 44344.1 44400.6 8697.1 8851.1 8874.9 8882.2 8899.7 8587.8 8767.3 8768.3 8772.6 8774.0 8698.8 8791.9 8798.4 8830.9 8832.0 8707.9 8743.3 8747.0 8766.0 8786.9 8586.7 8675.6 8720.1 8726.7 8753.3 33055.8 41481.0 41488.4 41781.0 41965.6 3405.2 3411.7 3638.4 3659.7 3697.4 31592.8 32105.0 32148.0 33536.5 35088.8 4180.7 4227.6 4235.3 4276.4 4296.8 344984.0 348504.0 349269.0 352192.0 352384.2 35655.6 36162.3 64995.4 65186.0 65903.3 37566.0 37956.4 38002.8 38007.2 38390.0 14997.8 15013.5 15123.2 15177.0 15193.9 12903.2 12931.2 12948.4 13015.2 13038.6 8585.2 8639.0 8657.6 8686.1 8716.7 3316.4 3357.1 3369.7 3398.9 3450.5 985.9 1083.7 1094.8 1108.0 1140.7 32449.4 32734.5 32785.5 32828.2 32932.0 1094.5 1159.8 1176.2 1177.3 1179.9 16864.2 17553.2 17574.7 17641.0 17819.7 569168.0 572426.0 575181.0 575949.0 578121.0 40468.0 40799.6 40848.8 40903.6 40990.4 1317.6 1356.4 1359.6 1374.2 1385.4 30943.6 31139.9 31882.5 31930.4 32554.7 52918.0 53138.5 53290.0 53473.0 53602.5 414714.0 422260.0 423960.0 425295.0 425362.0 28719.1 29099.3 29244.3 29346.4 29445.1 47017.8 48256.8 48539.0 48574.0 49859.5 41698.4 42324.6 42554.4 42728.8 43171.0 41055.0 41179.2 41622.4 41689.2 42609.4 35810.3 40055.2 40373.0 41043.8 41149.6 32384.0 33805.5 34242.5 34270.3 34485.0 28418.1 28699.7 28919.0 28936.6 29031.0 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | [#2] jquery.html Cycles:180 Average:29039.73 Median:11114.89 stddev:85039.72 (765.1%) stddev-sans-first:85251.02 23:23:46 INFO - PROCESS | 25011 | Values: 363.5 380.7 381.6 382.4 399.6 17900.7 19201.0 19413.4 20166.2 20177.9 17649.4 18669.6 18715.4 18946.4 19017.2 5103.8 5127.7 5315.7 5335.1 5337.1 5167.0 5200.9 5222.1 5242.0 5243.1 5189.6 5223.7 5227.8 5240.2 5283.2 5614.9 5721.9 5732.1 5751.2 5760.0 4953.5 5106.3 5162.7 5185.8 5191.6 12786.2 13097.7 13115.0 13277.7 13298.5 2274.4 2401.2 2420.3 2544.8 2564.0 10089.0 10197.9 12263.4 14561.0 14588.3 1945.2 1961.2 1971.3 1997.4 2051.9 59617.7 65019.7 67315.7 72717.3 78165.2 10642.0 10717.6 11011.2 11148.8 11242.8 15153.1 15230.1 15261.1 15363.5 15434.6 7832.8 7951.4 8008.6 8148.5 8154.4 7653.9 7715.3 7746.6 7841.0 7874.1 4640.4 4649.8 4706.6 4733.8 4760.1 1903.4 1926.5 1937.0 1971.9 2014.7 894.5 916.7 1001.3 1008.7 1033.0 17461.5 17977.6 18561.4 19017.4 19271.1 1033.8 1043.6 1049.9 1057.8 1084.0 10548.8 11160.5 11181.7 11186.2 11266.9 486927.0 488359.0 489197.0 552547.0 564514.0 57631.1 93437.5 96162.5 96830.5 96931.2 1015.2 1020.8 1040.4 1043.5 1059.8 17519.9 17578.6 18017.5 18025.3 18086.8 39967.2 41927.4 42320.6 42551.8 42835.4 58542.0 59970.8 60022.7 60690.4 61461.0 8249.8 8371.7 8381.6 8384.3 8705.7 9492.5 13088.9 13330.4 13336.2 13471.4 11431.2 11470.8 11711.4 11852.2 11934.4 11401.9 11646.7 11709.2 11779.8 11870.5 11351.5 11446.5 11732.6 12041.8 12058.0 8310.4 8438.7 8533.8 8655.7 8672.7 11196.8 11688.5 11919.2 12137.9 12334.4 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | [#3] mootools.html Cycles:180 Average:5978.32 Median:2521.43 stddev:3446.82 (136.7%) stddev-sans-first:3440.07 23:23:46 INFO - PROCESS | 25011 | Values: 1501.4 1545.1 1662.8 1777.6 1801.3 8012.8 8678.3 8797.1 9274.7 9316.3 8802.7 9099.7 9108.1 9119.9 9123.2 2319.8 2362.9 2364.9 2375.3 2378.2 2323.4 2336.4 2394.9 2396.1 2397.0 2330.8 2339.6 2351.6 2377.8 2382.0 2281.3 2281.5 2293.8 2302.3 2308.7 2269.5 2311.8 2322.8 2326.7 2331.8 9090.1 9174.7 9177.2 9185.0 9199.0 5248.3 5314.0 5422.6 5436.0 5442.9 3433.6 3484.3 3513.4 3545.9 3567.8 1118.1 1124.7 1130.3 1146.7 1181.3 12711.7 12776.2 12783.7 12785.9 12858.6 4582.4 4668.9 4699.6 4729.7 4749.1 10059.2 10089.0 10102.0 10103.4 10125.5 5397.7 5457.9 5460.8 5466.2 5467.0 4419.7 4938.5 5019.1 5057.1 5083.8 3695.2 3759.8 3781.6 3781.7 3882.2 1162.7 1163.3 1173.1 1173.5 1185.8 890.0 905.9 981.9 1014.8 1022.1 6033.0 6334.3 6393.2 6401.2 6495.2 441.8 452.7 460.4 467.2 468.5 4209.0 4444.6 4454.1 4516.0 4532.3 11107.0 11394.1 11501.6 11533.3 11554.4 10768.4 11189.7 11302.4 11340.9 11389.6 8508.6 8642.6 8650.8 8660.9 8673.7 6183.1 6435.6 6449.4 6454.0 6519.9 10270.5 10528.5 10756.6 10783.9 10791.2 10644.0 10688.1 10713.3 10782.1 10798.1 7299.1 7838.0 7919.8 7965.6 8100.6 8863.5 8881.8 8891.1 8964.6 8975.3 7864.4 7871.1 8009.4 8072.1 8111.0 7665.0 7671.8 7734.3 7780.5 7788.1 7285.9 7368.9 7375.9 7421.9 7457.5 5267.6 5315.1 5362.7 5375.7 5501.5 5523.3 5547.3 5561.8 5575.5 5586.3 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | [#4] prototype.html Cycles:180 Average:4801.59 Median:5386.99 stddev:1438.27 (26.7%) stddev-sans-first:1402.23 23:23:46 INFO - PROCESS | 25011 | Values: 309.4 317.2 319.6 319.6 324.8 5422.5 5455.7 5493.3 5513.3 5514.2 5381.2 5385.3 5388.7 5453.2 5461.5 4173.7 4286.2 4290.8 4292.2 4303.4 4238.4 4247.2 4248.9 4265.3 4265.8 4194.9 4211.5 4231.0 4266.1 4291.3 4065.2 4078.3 4221.9 4233.4 4262.6 3690.6 3707.8 3713.4 3714.2 3740.6 5294.0 5332.9 5334.6 5348.3 5361.4 4644.8 4808.8 4822.6 4843.9 4852.9 5660.0 5693.6 5707.4 5713.2 5746.6 4077.6 4079.1 4079.4 4094.3 4098.0 5649.3 5921.6 5925.6 5931.8 5956.9 4057.5 4075.9 4093.9 4095.6 4122.1 4133.0 4146.9 4147.8 4156.5 4173.0 4576.2 4798.7 4804.0 4826.3 4845.6 5833.9 5851.1 5859.9 5864.4 5876.9 1444.1 1463.1 1468.0 1468.1 1469.9 881.2 914.5 919.3 927.7 932.4 5024.3 5026.8 5040.9 5059.2 5065.6 5184.2 5251.9 5253.8 5274.4 5299.3 4971.9 5009.9 5033.3 5374.2 5693.0 3137.4 3150.9 3179.3 3184.6 3187.9 6128.7 6148.8 6219.3 6221.7 6229.2 5957.7 5994.5 5994.9 6037.7 6067.4 6149.3 6218.1 6261.9 6289.9 6293.5 5879.6 5926.7 6012.8 6016.5 6025.6 5936.8 5961.8 5969.6 5975.2 5988.3 6021.9 6112.8 6222.3 6330.9 6335.2 4086.6 4096.1 4107.1 4111.5 4122.7 5945.5 5964.8 5968.0 5971.3 5999.0 5534.0 5778.1 5827.4 5831.8 5865.9 5774.1 5775.7 5777.7 5805.5 5832.8 5398.2 5626.7 5642.1 5659.9 5663.4 5675.1 5726.6 5781.6 5839.1 5906.5 5615.8 5659.5 5671.6 5686.4 5725.9 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | [#5] yui.html Cycles:180 Average:15642.40 Median:4077.15 stddev:18188.61 (446.1%) stddev-sans-first:18205.61 23:23:46 INFO - PROCESS | 25011 | Values: 826.2 851.6 859.0 866.3 873.8 14744.9 15381.8 15386.6 15554.1 15635.1 14368.0 14449.1 14449.6 14461.2 14575.7 681.5 796.2 807.5 816.5 820.5 813.6 822.9 825.0 826.0 826.2 884.9 885.3 886.3 887.0 888.0 879.4 880.7 885.1 885.4 887.8 636.1 640.1 641.8 642.8 643.2 14038.8 14115.4 14161.3 14190.5 14200.3 14620.9 14742.4 14777.9 14791.2 14796.3 11907.9 11926.2 11998.9 12012.0 12132.3 3876.0 4030.0 4040.2 4075.0 4079.3 55342.7 55983.4 55984.2 56004.7 56373.2 10548.9 11069.1 11257.5 11269.6 11525.6 18287.8 19094.0 19126.5 19848.0 20714.9 8391.1 8556.5 8602.5 8761.3 8816.3 4679.0 4760.4 4794.3 4842.5 4879.8 3462.3 3548.2 3553.1 3555.6 3560.3 665.1 682.2 692.1 694.1 706.5 649.6 711.2 742.5 760.8 769.2 10137.6 10270.0 10286.2 10386.6 10523.6 653.7 673.0 736.8 757.0 778.5 4535.1 4914.0 4920.5 4980.2 5000.8 63867.0 66065.0 66397.7 66795.3 67322.3 58718.7 58881.0 59167.4 59327.4 61479.4 52949.5 53160.5 54155.2 54309.5 54524.5 9273.1 9530.7 9846.8 10116.2 10175.1 36126.6 36203.1 36418.9 36682.0 36816.3 48398.8 48792.5 49014.5 49197.0 49360.5 11762.9 12416.4 12685.7 12982.5 13059.8 14110.2 14160.2 14246.5 14297.2 14399.3 13125.2 13222.4 13250.7 13437.3 13750.5 13384.0 13545.4 13546.3 13652.1 14078.4 12832.4 13061.0 13130.6 13180.5 13189.5 10059.4 10107.6 10537.9 10617.5 10822.8 10638.6 10768.3 10910.2 10937.0 10947.0 23:23:46 INFO - PROCESS | 25011 | -------- Summary: end -------- 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | ###!!! [Child][MessageChannel] Error: (msgtype=0x46010F,name=PContent::Msg_AsyncMessage) Channel closing: too late to send/recv, messages will be lost 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | 23:23:46 INFO - PROCESS | 25011 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 23:23:46 INFO - PROCESS | 25011 | 23:23:47 INFO - TEST-INFO | 25011: exit 0 23:23:47 INFO - TEST-OK | dromaeo_css | took 1110665ms 23:23:47 INFO - TEST-START | kraken 23:23:47 INFO - operating with platform_type : linux_ 23:23:47 INFO - Initialising browser for kraken test... 23:23:47 INFO - TEST-INFO | started process 25252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnYREc_/profile http://localhost:46254/getInfo.html) 23:23:50 INFO - PROCESS | 25252 | 23:23:50 INFO - PROCESS | 25252 | (process:25321): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:23:51 INFO - PROCESS | 25252 | __metrics Screen width/height:1600/1200 23:23:51 INFO - PROCESS | 25252 | colorDepth:24 23:23:51 INFO - PROCESS | 25252 | Browser inner width/height: 1024/697 23:23:51 INFO - PROCESS | 25252 | __metrics 23:23:52 ERROR - PROCESS | 25252 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:23:52 INFO - TEST-INFO | 25252: exit 0 23:23:52 INFO - Browser initialized. 23:23:52 INFO - Running cycle 1/1 for kraken test... 23:23:52 INFO - TEST-INFO | started process 25372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnYREc_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:23:54 INFO - PROCESS | 25372 | 23:23:54 INFO - PROCESS | 25372 | (process:25433): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:24:04 INFO - PROCESS | 25372 | RSS: Main: 164315136 23:24:04 INFO - PROCESS | 25372 | 23:24:07 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46254/tests/kraken/driver.html?testName=audio-beat-detection) 23:24:08 INFO - PROCESS | 25372 | RSS: Main: 169238528 23:24:08 INFO - PROCESS | 25372 | 23:24:11 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46254/tests/kraken/driver.html?testName=audio-dft) 23:24:11 INFO - PROCESS | 25372 | RSS: Main: 169349120 23:24:11 INFO - PROCESS | 25372 | 23:24:14 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46254/tests/kraken/driver.html?testName=audio-fft) 23:24:15 INFO - PROCESS | 25372 | RSS: Main: 164052992 23:24:15 INFO - PROCESS | 25372 | 23:24:17 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46254/tests/kraken/driver.html?testName=audio-oscillator) 23:24:18 INFO - PROCESS | 25372 | RSS: Main: 164241408 23:24:18 INFO - PROCESS | 25372 | 23:24:20 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46254/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:24:21 INFO - PROCESS | 25372 | RSS: Main: 164544512 23:24:21 INFO - PROCESS | 25372 | 23:24:24 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46254/tests/kraken/driver.html?testName=imaging-darkroom) 23:24:24 INFO - PROCESS | 25372 | RSS: Main: 165363712 23:24:24 INFO - PROCESS | 25372 | 23:24:28 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46254/tests/kraken/driver.html?testName=imaging-desaturate) 23:24:29 INFO - PROCESS | 25372 | RSS: Main: 163794944 23:24:29 INFO - PROCESS | 25372 | 23:24:32 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46254/tests/kraken/driver.html?testName=json-parse-financial) 23:24:32 INFO - PROCESS | 25372 | RSS: Main: 164012032 23:24:32 INFO - PROCESS | 25372 | 23:24:34 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46254/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:24:34 INFO - PROCESS | 25372 | RSS: Main: 164356096 23:24:34 INFO - PROCESS | 25372 | 23:24:36 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46254/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:24:37 INFO - PROCESS | 25372 | RSS: Main: 165253120 23:24:37 INFO - PROCESS | 25372 | 23:24:39 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46254/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:24:40 INFO - PROCESS | 25372 | RSS: Main: 164962304 23:24:40 INFO - PROCESS | 25372 | 23:24:42 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:24:43 INFO - PROCESS | 25372 | RSS: Main: 165031936 23:24:43 INFO - PROCESS | 25372 | 23:24:46 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:24:46 INFO - PROCESS | 25372 | RSS: Main: 165593088 23:24:46 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | Cycle 1(1): loaded http://localhost:46254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46254/tests/kraken/driver.html?testName=ai-astar) 23:24:48 INFO - PROCESS | 25372 | RSS: Main: 166629376 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | __start_tp_report 23:24:48 INFO - PROCESS | 25372 | _x_x_mozilla_page_load 23:24:48 INFO - PROCESS | 25372 | _x_x_mozilla_page_load_details 23:24:48 INFO - PROCESS | 25372 | |i|pagename|runs| 23:24:48 INFO - PROCESS | 25372 | |0;ai-astar;112;105;110;112;111;114;113;109;123;112 23:24:48 INFO - PROCESS | 25372 | |1;audio-beat-detection;149;132;155;200;129;151;152;129;191;128 23:24:48 INFO - PROCESS | 25372 | |2;audio-dft;163;164;162;162;165;172;163;163;166;164 23:24:48 INFO - PROCESS | 25372 | |3;audio-fft;75;76;76;161;75;74;74;74;181;74 23:24:48 INFO - PROCESS | 25372 | |4;audio-oscillator;93;92;180;93;92;94;145;94;93;154 23:24:48 INFO - PROCESS | 25372 | |5;imaging-gaussian-blur;118;117;117;118;118;117;118;117;118;117 23:24:48 INFO - PROCESS | 25372 | |6;imaging-darkroom;150;149;150;148;149;150;150;150;149;147 23:24:48 INFO - PROCESS | 25372 | |7;imaging-desaturate;96;95;96;95;95;96;95;95;96;95 23:24:48 INFO - PROCESS | 25372 | |8;json-parse-financial;56;56;59;55;58;55;56;56;55;56 23:24:48 INFO - PROCESS | 25372 | |9;json-stringify-tinderbox;63;61;63;62;62;61;61;62;61;62 23:24:48 INFO - PROCESS | 25372 | |10;stanford-crypto-aes;78;78;78;79;80;85;80;78;133;85 23:24:48 INFO - PROCESS | 25372 | |11;stanford-crypto-ccm;123;121;123;128;130;128;120;131;141;140 23:24:48 INFO - PROCESS | 25372 | |12;stanford-crypto-pbkdf2;167;161;167;162;165;160;169;162;170;164 23:24:48 INFO - PROCESS | 25372 | |13;stanford-crypto-sha256-iterative;64;64;67;63;63;62;63;64;62;61 23:24:48 INFO - PROCESS | 25372 | __end_tp_report 23:24:48 INFO - PROCESS | 25372 | __start_cc_report 23:24:48 INFO - PROCESS | 25372 | _x_x_mozilla_cycle_collect,858 23:24:48 INFO - PROCESS | 25372 | __end_cc_report 23:24:48 INFO - PROCESS | 25372 | __startTimestamp1464071088848__endTimestamp 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | ------- Summary: start ------- 23:24:48 INFO - PROCESS | 25372 | Number of tests: 14 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:4.58 (4.1%) stddev-sans-first:4.86 23:24:48 INFO - PROCESS | 25372 | Values: 112.0 105.0 110.0 112.0 111.0 114.0 113.0 109.0 123.0 112.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:151.50 stddev:25.55 (16.9%) stddev-sans-first:27.09 23:24:48 INFO - PROCESS | 25372 | Values: 149.0 132.0 155.0 200.0 129.0 151.0 152.0 129.0 191.0 128.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.95 (1.8%) stddev-sans-first:3.09 23:24:48 INFO - PROCESS | 25372 | Values: 163.0 164.0 162.0 162.0 165.0 172.0 163.0 163.0 166.0 164.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#3] audio-fft Cycles:10 Average:94.00 Median:74.50 stddev:40.86 (54.8%) stddev-sans-first:42.76 23:24:48 INFO - PROCESS | 25372 | Values: 75.0 76.0 76.0 161.0 75.0 74.0 74.0 74.0 181.0 74.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#4] audio-oscillator Cycles:10 Average:113.00 Median:93.00 stddev:33.33 (35.8%) stddev-sans-first:34.56 23:24:48 INFO - PROCESS | 25372 | Values: 93.0 92.0 180.0 93.0 92.0 94.0 145.0 94.0 93.0 154.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 23:24:48 INFO - PROCESS | 25372 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:150.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 23:24:48 INFO - PROCESS | 25372 | Values: 150.0 149.0 150.0 148.0 149.0 150.0 150.0 150.0 149.0 147.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 23:24:48 INFO - PROCESS | 25372 | Values: 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:1.32 (2.4%) stddev-sans-first:1.39 23:24:48 INFO - PROCESS | 25372 | Values: 56.0 56.0 59.0 55.0 58.0 55.0 56.0 56.0 55.0 56.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 23:24:48 INFO - PROCESS | 25372 | Values: 63.0 61.0 63.0 62.0 62.0 61.0 61.0 62.0 61.0 62.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:79.50 stddev:16.95 (21.3%) stddev-sans-first:17.76 23:24:48 INFO - PROCESS | 25372 | Values: 78.0 78.0 78.0 79.0 80.0 85.0 80.0 78.0 133.0 85.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:129.00 stddev:7.35 (5.7%) stddev-sans-first:7.52 23:24:48 INFO - PROCESS | 25372 | Values: 123.0 121.0 123.0 128.0 130.0 128.0 120.0 131.0 141.0 140.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:166.00 stddev:3.47 (2.1%) stddev-sans-first:3.57 23:24:48 INFO - PROCESS | 25372 | Values: 167.0 161.0 167.0 162.0 165.0 160.0 169.0 162.0 170.0 164.0 23:24:48 INFO - PROCESS | 25372 | 23:24:48 INFO - PROCESS | 25372 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.64 (2.6%) stddev-sans-first:1.72 23:24:48 INFO - PROCESS | 25372 | Values: 64.0 64.0 67.0 63.0 63.0 62.0 63.0 64.0 62.0 61.0 23:24:48 INFO - PROCESS | 25372 | -------- Summary: end -------- 23:24:48 INFO - PROCESS | 25372 | 23:24:49 INFO - TEST-INFO | 25372: exit 0 23:24:49 INFO - TEST-OK | kraken | took 62591ms 23:24:49 INFO - SUITE-END | took 1173s 23:24:50 INFO - Completed test suite (00:19:33) 23:24:50 INFO - javascript benchmark 23:24:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7110.100789258215, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.0, 3103.8758449661987, 3112.299732560174, 3132.718055375016, 3155.3689262147564, 5339.7330133493315, 5369.167778994257, 5380.946190538093, 5401.4328495508, 5421.21392398102, 5147.459516750743, 5325.733713314338, 5421.186821976706, 5422.267993820833, 5426.945730542693, 4889.217725163983, 4930.087933732271, 5054.3176671149295, 5081.974590127044, 5132.640715149941, 722.6349584428189, 4845.878853028685, 4883.804647814083, 4912.263160525914, 4957.107720610306, 4891.4619391867045, 4930.482299358551, 4944.060628480577, 4951.925721114186, 4955.776990035439, 4960.032793605248, 4961.3798275215595, 4962.106820772259, 4978.726170060645, 4989.301497790312, 4884.438289596706, 4925.113479573675, 4939.5554400104165, 4942.061008408391, 4952.975235123838, 5311.468853114658, 5341.893162136775, 5347.812826551091, 5366.248725178478, 5391.865203369908, 5688.175214593861, 5692.345380281279, 5823.068309070571, 5860.589758716891, 5898.203742494751, 5854.882902341972, 5859.6777177255235, 5865.706714664292, 5923.407659234085, 5941.55438342126, 5488.231647569343, 5497.367802702661, 5501.889962200774, 5504.9174262385695, 5510.504054635062, 5774.335951365562, 5827.329857066492, 6011.549133814981, 6048.516118710492, 6052.909206361908, 5710.428957104339, 5727.2268243787385, 5763.4812866842185, 5789.94210057894, 5794.565407594448, 5824.854378640568, 5831.2127862738835, 5853.795117170878, 5861.3845546217035, 5877.500412464989, 5569.081101618269, 5758.222639943638, 5777.45114214149, 5826.650400975955, 5844.298684157929, 5732.742026608813, 5757.280339957505, 5757.309122905194, 5774.711264436762, 5782.913256301159, 4468.620167285752, 4475.820967161342, 4481.7983190756495, 4497.437820272466, 4521.502634710179, 3859.6333348331864, 3921.5294164700417, 3946.309395855714, 3951.1702542465828, 3977.840886364571, 5628.577856660685, 5644.209810626516, 5648.548116150698, 5702.971485142548, 5722.141678748221, 5788.507976821933, 5945.227120474397, 5945.791897283574, 5948.7323070461935, 5958.404159584007, 5492.780288788404, 5587.3015873015875, 5611.382747897728, 5615.466530679579, 5646.548276137899, 4900.26496025599, 4909.239067944474, 4966.701997880139, 4978.352814134139, 5009.173486374707, 6091.51267898567, 6105.755769769248, 6109.2974307955155, 6117.785877494266, 6144.354842741448, 5678.432156784289, 5773.480386765212, 5787.536997040311, 5788.942110579009, 5873.911891321719, 6028.608140470856, 6038.879222415615, 6042.788502402394, 6049.062395328731, 6072.605280656743, 5630.971845140748, 5732.34078081026, 5733.168690539932, 5743.8851222976145, 5756.94243057564, 5726.742296596746, 5732.512736417284, 5734.483896449173, 5784.421557844182, 5790.884182316414, 5644.88710225785, 5648.350439699487, 5658.547316214611, 5658.688772117408, 5659.6321239119325, 5493.835184944458, 5564.527015203753, 5611.270534830446, 5620.74706638194, 5693.629914055573, 5579.832605021856, 5626.071698169756, 5628.8874222514505, 5630.774769009357, 5677.829665110054, 5730.541556675373, 5762.798302059407, 5775.451332123442, 5789.623674461147, 5808.970955145366, 5458.290422245242, 5490.615656903979, 5515.034868898007, 5664.943350566442, 5669.461401166883], "value": 5332.192569885235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.688838359861, 636.8789929913319, 653.6600967496902, 670.8595387840669, 673.4444083631006, 42254.7887260564, 43220.56779432205, 43302.783486082604, 43326.35010474842, 43446.56553434465, 43723.78138109305, 44099.338509922374, 44310.778446107724, 44344.11311773762, 44400.555994440045, 8697.1302869713, 8851.070637583058, 8874.911250887473, 8882.245009174228, 8899.68851090212, 8587.785305367353, 8767.254783343391, 8768.298536117127, 8772.649094036231, 8773.95613021934, 8698.782530436758, 8791.912080879205, 8798.428102173339, 8830.867536986918, 8832.0, 8707.912920870805, 8743.256823170039, 8747.0, 8766.035736068996, 8786.912130878673, 8586.742397728078, 8675.56622168889, 8720.084391138966, 8726.738197854074, 8753.255973242281, 33055.83472082648, 41481.0, 41488.37767433491, 41781.0, 41965.580344196474, 3405.2338223899674, 3411.727061835047, 3638.3632864248652, 3659.72552058594, 3697.352963231424, 31592.842035789905, 32105.0, 32148.03555893327, 33536.496952545735, 35088.82455587706, 4180.707350485467, 4227.577242275778, 4235.343521754133, 4276.379924910871, 4296.8281268749215, 344984.0, 348504.0, 349269.0, 352192.0, 352384.2380788105, 35655.64344356575, 36162.27675446529, 64995.35004649987, 65186.0, 65903.34096658972, 37566.0, 37956.43065354022, 38002.80998594989, 38007.2398552033, 38390.0, 14997.775033374508, 15013.474528391454, 15123.243837808066, 15177.0, 15193.924030379778, 12903.161294515827, 12931.224126552248, 12948.352582370844, 13015.219086854819, 13038.608841734764, 8585.227329540247, 8638.956805215934, 8657.610407531676, 8686.087960764029, 8716.694915677921, 3316.369889720945, 3357.1439282982683, 3369.747268954838, 3398.8810391636175, 3450.4996775467416, 985.8964808695127, 1083.7453198498347, 1094.8248280275118, 1108.0027974822563, 1140.686311264409, 32449.35101297961, 32734.508982365285, 32785.50821737676, 32828.17929551732, 32932.0, 1094.5129417409335, 1159.8144296912453, 1176.1707995862896, 1177.2759752752168, 1179.9174057815871, 16864.241109150116, 17553.21010554528, 17574.736378954327, 17641.0, 17819.73270400945, 569168.0, 572426.0, 575181.0, 575949.0, 578121.0, 40467.98830029273, 40799.59200408017, 40848.79575602103, 40903.590964090574, 40990.38514422286, 1317.5586178630267, 1356.3625096204769, 1359.6328991172527, 1374.1617613255905, 1385.369656806171, 30943.607537661308, 31139.91010314628, 31882.52176217405, 31930.36139277248, 32554.674453255164, 52918.0, 53138.46861531335, 53290.0, 53473.0, 53602.46397536131, 414714.0, 422260.0, 423960.0, 425295.0, 425362.0, 28719.138425847257, 29099.272518187216, 29244.268893277836, 29346.413071738018, 29445.11664650064, 47017.764911175225, 48256.7587162062, 48539.0, 48574.0, 49859.501404986935, 41698.37452438155, 42324.5767542333, 42554.36168457538, 42728.78635606802, 43171.0, 41055.0, 41179.1764164721, 41622.37566436567, 41689.160818188095, 42609.36085958775, 35810.28379432449, 40055.1988960225, 40373.0, 41043.79478102591, 41149.588504114574, 32384.0, 33805.49291760576, 34242.48636270408, 34270.31459370749, 34485.0, 28418.06724787055, 28699.71300287054, 28919.0, 28936.56595151032, 29031.0], "value": 18848.469597105548, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.51289272375027, 380.7334865594085, 381.5516767797837, 382.4359070371202, 399.5964076282953, 17900.731489027676, 19201.0, 19413.417597472082, 20166.193352265927, 20177.899110504444, 17649.382271620496, 18669.626607467875, 18715.43853684388, 18946.43160705181, 19017.2393104276, 5103.8468845934685, 5127.743612819344, 5315.734213289339, 5335.093034184179, 5337.06601344765, 5167.0, 5200.92198617021, 5222.060029194743, 5242.030224408478, 5243.082460569404, 5189.584833213353, 5223.660462069973, 5227.843164705065, 5240.161574148137, 5283.181106928432, 5614.9157762633595, 5721.942780572224, 5732.0542110551705, 5751.166080918264, 5760.0, 4953.504649535053, 5106.310648062501, 5162.6902385856965, 5185.766640501187, 5191.610629202825, 12786.168899021533, 13097.738045239043, 13115.0, 13277.734445311136, 13298.534551290659, 2274.4200228941513, 2401.1715957994465, 2420.2739178246457, 2544.7530709952175, 2563.9615405768927, 10089.0, 10197.949010254975, 12263.386830658521, 14561.0, 14588.27058647074, 1945.2121890634317, 1961.205711686769, 1971.2607772085469, 1997.3508609701905, 2051.8768873867466, 59617.70191149016, 65019.67490162519, 67315.66342168258, 72717.27282727211, 78165.21834781693, 10642.0, 10717.571297148026, 11011.174161937886, 11148.777024459465, 11242.831357529643, 15153.090814551162, 15230.086194828124, 15261.084334939938, 15363.462278820187, 15434.6141346465, 7832.804179895548, 7951.403644726669, 8008.559529225949, 8148.470349427268, 8154.38842086834, 7653.923460765321, 7715.305622494003, 7746.57393843344, 7841.019872515935, 7874.133845277015, 4640.424564366809, 4649.837255696035, 4706.623470122382, 4733.83431579893, 4760.071786001766, 1903.4099429177, 1926.489480287725, 1936.9806301937083, 1971.86196966211, 2014.7380840490641, 894.5080205886867, 916.7364183506737, 1001.3140998416109, 1008.6721815410021, 1033.0495943731785, 17461.47615571535, 17977.550561236072, 18561.35035273759, 19017.429477115707, 19271.13279902408, 1033.8397548380012, 1043.6034306963306, 1049.8687664041995, 1057.7620035492107, 1084.0297933349607, 10548.789024219474, 11160.497777599865, 11181.664550063511, 11186.216964812547, 11266.943665281786, 486927.0, 488359.0, 489197.0, 552547.0, 564514.0, 57631.135532966204, 93437.5328123355, 96162.51918740502, 96830.51584742172, 96931.24550036121, 1015.1777060580805, 1020.8315627921459, 1040.4433628008978, 1043.5147656339686, 1059.7668512927298, 17519.912400437915, 17578.648427031643, 18017.459476215212, 18025.278988840822, 18086.819131808512, 39967.2006559873, 41927.371089434295, 42320.5767942329, 42551.7872410636, 42835.357469637354, 58542.0, 59970.76008801954, 60022.69988650029, 60690.393096068474, 61461.0, 8249.79375515617, 8371.665133394596, 8381.580920953806, 8384.329253659815, 8705.73882783492, 9492.477913714813, 13088.934555327163, 13330.400131993889, 13336.19982801035, 13471.393787279792, 11431.199816013132, 11470.827937580776, 11711.414429278331, 11852.229605075643, 11934.403279836148, 11401.885981140082, 11646.650600481998, 11709.180357374902, 11779.823302650639, 11870.525178992744, 11351.48918298695, 11446.542138314708, 11732.648020559396, 12041.759164816829, 12058.03535717158, 8310.376721746014, 8438.742949876472, 8533.786655333419, 8655.740327790176, 8672.653093876426, 11196.776064478829, 11688.532458701557, 11919.165658404176, 12137.878621213675, 12334.383280835742], "value": 9000.114285488016, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.444465547747, 1545.1192820092547, 1662.8004639443268, 1777.5911540345712, 1801.3425099838555, 8012.799680007988, 8678.262347700445, 8797.07630698777, 9274.67538636148, 9316.254699624022, 8802.735917922473, 9099.681511147111, 9108.134727200922, 9119.863202051974, 9123.224525915288, 2319.7680231976838, 2362.9054837806466, 2364.9408764780846, 2375.3349062262596, 2378.1676413255395, 2323.4191452136965, 2336.380859072347, 2394.8682822444844, 2396.101461951768, 2397.041183526586, 2330.7902288794007, 2339.578875802355, 2351.5649604823075, 2377.8216633752536, 2381.9761802382013, 2281.3384118605586, 2281.532285881399, 2293.816494680422, 2302.309307207831, 2308.7114110736156, 2269.4553307206315, 2311.8266130040147, 2322.779335963081, 2326.674265602817, 2331.778481044298, 9090.090990900922, 9174.724758257264, 9177.174054335143, 9184.954075229647, 9199.0, 5248.291480650101, 5314.0, 5422.620416570841, 5436.0, 5442.891142177174, 3433.5536380270655, 3484.3379757846183, 3513.367593833109, 3545.85816567337, 3567.839447224855, 1118.105515587535, 1124.668222874254, 1130.2822707580744, 1146.7419830538063, 1181.2794195540714, 12711.682207944783, 12776.169548979287, 12783.744325113446, 12785.936070319682, 12858.614241572768, 4582.427196600425, 4668.883277918011, 4699.600533954584, 4729.7398643074275, 4749.097671442415, 10059.245556583286, 10089.041541053588, 10102.040306170902, 10103.444310562989, 10125.493725313705, 5397.730113494388, 5457.918131228034, 5460.781568737286, 5466.180072989004, 5467.043267428184, 4419.734815911055, 4938.530839570235, 5019.14674505335, 5057.115004874132, 5083.822066227664, 3695.150115473456, 3759.812009399519, 3781.640744129303, 3781.6785573226034, 3882.242962622318, 1162.7209469727204, 1163.2613290560387, 1173.0908545877014, 1173.5481839491856, 1185.8399116119385, 889.9911000890038, 905.8958219804807, 981.9410835349902, 1014.7767491151935, 1022.1107636356418, 6032.969835150796, 6334.271558770801, 6393.1688880445245, 6401.231852177769, 6495.1935567679575, 441.80118946474215, 452.7057412681783, 460.4313672614319, 467.231404339859, 468.53146853146853, 4209.0, 4444.599986001211, 4454.086912182995, 4516.0, 4532.342810292489, 11107.0, 11394.1454390921, 11501.597444089417, 11533.308001519936, 11554.422278886022, 10768.3538987661, 11189.664310070712, 11302.43487825622, 11340.886591134147, 11389.601363952388, 8508.617112229964, 8642.611082501302, 8650.78373040679, 8660.8700869487, 8673.696420625249, 6183.103449999635, 6435.581687190318, 6449.419552240133, 6453.967730161319, 6519.934800652122, 10270.537825797708, 10528.473576321307, 10756.623518177139, 10783.946080269548, 10791.244612877023, 10644.0, 10688.091512221548, 10713.250072494851, 10782.137429005505, 10798.082163016232, 7299.087614048244, 7837.960810195913, 7919.802004949923, 7965.641546130554, 8100.635471403683, 8863.537516309736, 8881.822363552563, 8891.110888911056, 8964.641414343354, 8975.28197744192, 7864.370850332074, 7871.134175240604, 8009.359251259769, 8072.112067672434, 8111.0, 7664.961675191588, 7671.769846904602, 7734.265244801735, 7780.533168009937, 7788.104367997753, 7285.854282914418, 7368.852622947618, 7375.926240737524, 7421.851562968818, 7457.47797654159, 5267.578593712417, 5315.0964336063735, 5362.678239305654, 5375.704336261387, 5501.5323697486165, 5523.25436066142, 5547.278853749148, 5561.777528898799, 5575.470330318775, 5586.301712285965], "value": 4669.071029477105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.41674942732953, 317.1579456542878, 319.5749652961561, 319.5893277138877, 324.8164786895404, 5422.539084177844, 5455.727213639322, 5493.258410114633, 5513.255710479079, 5514.200440936062, 5381.219723140142, 5385.272988146599, 5388.703621300827, 5453.182022696587, 5461.508464238228, 4173.749575025493, 4286.228478873802, 4290.7985763986135, 4292.205941900743, 4303.376010478479, 4238.427812245338, 4247.171801498709, 4248.893777655568, 4265.31754919213, 4265.765382903939, 4194.916101677964, 4211.452511173543, 4230.990279617188, 4266.146770645868, 4291.334843099325, 4065.2072845795083, 4078.3270760324513, 4221.936670949938, 4233.428487154241, 4262.637675797561, 3690.612485688991, 3707.796071216082, 3713.4429835524616, 3714.238581090897, 3740.6446387593137, 5293.9735301323635, 5332.893342133136, 5334.5732341412595, 5348.331458567679, 5361.410244873061, 4644.837430689943, 4808.807647694123, 4822.63830212732, 4843.927341089887, 4852.878678033077, 5659.971700141473, 5693.572982026323, 5707.429257074301, 5713.228714123623, 5746.569007324468, 4077.55146933837, 4079.102597428561, 4079.4084857695766, 4094.263032654121, 4097.959020409788, 5649.305208437452, 5921.61509501881, 5925.585209035326, 5931.762729490815, 5956.851078723066, 4057.4522439470293, 4075.9388609170887, 4093.8946484449034, 4095.6313931746286, 4122.1244333828035, 4133.0, 4146.942529654919, 4147.751134931914, 4156.459660244149, 4172.958270417257, 4576.199165146086, 4798.712077275374, 4804.0, 4826.348442960226, 4845.6123510119105, 5833.891560603472, 5851.093080572518, 5859.853503662357, 5864.384239654775, 5876.941230587639, 1444.1407362619225, 1463.0563286680033, 1467.9633009174643, 1468.0897843336986, 1469.904456210343, 881.1628952495155, 914.5244472874201, 919.2691810011057, 927.679950417105, 932.4079209701888, 5024.337101336298, 5026.84919452417, 5040.924386134211, 5059.215821547666, 5065.594752419797, 5184.196449550326, 5251.868703282448, 5253.763580638881, 5274.3670759509105, 5299.258103865462, 4971.875703107451, 5009.924851127236, 5033.345665063518, 5374.247605335257, 5693.0, 3137.3685683444482, 3150.936981260362, 3179.3482336121037, 3184.633767116811, 3187.920301992469, 6128.662923539159, 6148.754049838046, 6219.315875253718, 6221.720022598994, 6229.190205273376, 5957.672328022, 5994.460498555064, 5994.910076348859, 6037.72830222641, 6067.393260673897, 6149.3235744068115, 6218.098375735493, 6261.9373806262265, 6289.905651415233, 6293.527985401113, 5879.588428809942, 5926.718213487752, 6012.819615411545, 6016.5487588431915, 6025.578209525291, 5936.7922122725495, 5961.821145365646, 5969.552283578662, 5975.223220981245, 5988.28140623128, 6021.885951099061, 6112.847178820565, 6222.315545290105, 6330.942443705722, 6335.2261366817365, 4086.5504794473177, 4096.057906681421, 4107.096438783463, 4111.527174374985, 4122.711410201257, 5945.494632956247, 5964.821055368346, 5968.0, 5971.313298970674, 5998.9801733706245, 5533.98009726455, 5778.133280008033, 5827.446392592697, 5831.766729330949, 5865.882682346244, 5774.141799809121, 5775.6823374714795, 5777.682227477361, 5805.535557155502, 5832.83343331327, 5398.217258497417, 5626.662400255997, 5642.069058605448, 5659.915101273402, 5663.377028526941, 5675.120356344773, 5726.599138060463, 5781.612413020761, 5839.1096407278665, 5906.497947674496, 5615.831525054255, 5659.490645841894, 5671.574631902707, 5686.4029276926985, 5725.8568535786935], "value": 4334.216582198055, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.1696994520507, 851.5954921412334, 858.9570521473929, 866.3069544364511, 873.7990262239684, 14744.852551474482, 15381.846181538182, 15386.61533461664, 15554.144522051283, 15635.140067296279, 14368.0, 14449.133052016887, 14449.5665130046, 14461.20463374514, 14575.708485830277, 681.471859309037, 796.1918652567648, 807.5114555693809, 816.4529765057396, 820.4953953318726, 813.6297984417076, 822.9135940726227, 824.9587520623975, 826.0, 826.2481142160635, 884.8628462588309, 885.2519620920344, 886.3396769406801, 887.0419946457843, 887.951162686052, 879.3580686099151, 880.665347168072, 885.0574138542496, 885.4200498673412, 887.7913690282778, 636.11897521932, 640.1134428816076, 641.7689631732572, 642.7782415066841, 643.1960049937578, 14038.789418158736, 14115.364808583638, 14161.291935403291, 14190.50333238342, 14200.289985500684, 14620.926895365561, 14742.410303587843, 14777.852221477862, 14791.186484743335, 14796.260186990607, 11907.880921190765, 11926.224795388272, 11998.880011199952, 12012.0, 12132.332721700302, 3876.0, 4029.979850100731, 4040.1717647882406, 4075.0, 4079.3065178919655, 55342.72328638331, 55983.44016559823, 55984.16023759647, 56004.719976400265, 56373.15440268358, 10548.894511054945, 11069.114470842313, 11257.549698012152, 11269.605563805391, 11525.596604118984, 18287.81712182861, 19094.0, 19126.521836954187, 19848.0, 20714.896425517774, 8391.076981532027, 8556.529390883561, 8602.52686102258, 8761.299096072298, 8816.294696424271, 4679.0, 4760.428748550196, 4794.2808578713475, 4842.5157484251295, 4879.804807807648, 3462.290230502741, 3548.2371290172737, 3553.09396103997, 3555.5733312002208, 3560.3235385276716, 665.0788657709011, 682.2495255219318, 692.1140939597324, 694.0872752330669, 706.5160365149889, 649.5518092516148, 711.2389742975071, 742.4839736383162, 760.8478304339154, 769.1539306762517, 10137.64518241858, 10269.963001007292, 10286.177105831515, 10386.636467723745, 10523.631672891412, 653.6666300186939, 672.9899051514232, 736.8047467421138, 757.0158793568339, 778.5250996891891, 4535.131546766358, 4913.975430122827, 4920.458749537548, 4980.224553433607, 5000.799968001312, 63867.0, 66065.0, 66397.6680116606, 66795.33204667988, 67322.3267767316, 58718.706406467696, 58881.0, 59167.40832591705, 59327.406725933055, 61479.385206147366, 52949.470505294456, 53160.468395316326, 54155.18767218495, 54309.45690543044, 54524.45475545273, 9273.124122809186, 9530.714078577654, 9846.838043196596, 10116.24128190374, 10175.135113515138, 36126.63873361338, 36203.09492262715, 36418.893629762075, 36682.0, 36816.26367472582, 48398.75800621115, 48792.512074878796, 49014.50985490242, 49197.0, 49360.50639493559, 11762.941185294361, 12416.379181040731, 12685.746285074432, 12982.480700772241, 13059.804102938653, 14110.223937683526, 14160.221187834768, 14246.501372451914, 14297.213653249171, 14399.280035997948, 13125.212487250796, 13222.404991775586, 13250.734985300047, 13437.260950647807, 13750.518731844337, 13384.0, 13545.390457429243, 13546.254955977516, 13652.112612680145, 14078.366473508922, 12832.422540985865, 13061.0, 13130.606081817561, 13180.472781088649, 13189.472421103432, 10059.39643621385, 10107.595696172071, 10537.89462105369, 10617.469126543796, 10822.837657435302, 10638.573421000014, 10768.300060496043, 10910.23628346008, 10937.0, 10947.0], "value": 7057.363888644673, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 110.0, 112.0, 111.0, 114.0, 113.0, 109.0, 123.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 155.0, 200.0, 129.0, 151.0, 152.0, 129.0, 191.0, 128.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 162.0, 165.0, 172.0, 163.0, 163.0, 166.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 161.0, 75.0, 74.0, 74.0, 74.0, 181.0, 74.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 180.0, 93.0, 92.0, 94.0, 145.0, 94.0, 93.0, 154.0], "value": 113.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 148.0, 149.0, 150.0, 150.0, 150.0, 149.0, 147.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 59.0, 55.0, 58.0, 55.0, 56.0, 56.0, 55.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 79.0, 80.0, 85.0, 80.0, 78.0, 133.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 123.0, 128.0, 130.0, 128.0, 120.0, 131.0, 141.0, 140.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 167.0, 162.0, 165.0, 160.0, 169.0, 162.0, 170.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 67.0, 63.0, 63.0, 62.0, 63.0, 64.0, 62.0, 61.0], "value": 63.3, "unit": "score"}]}]} 23:24:50 INFO - Return code: 0 23:24:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:24:50 ERROR - # TBPL SUCCESS # 23:24:50 INFO - Running post-action listener: _resource_record_post_action 23:24:50 INFO - ##### 23:24:50 INFO - ##### Finished run-tests step (success) 23:24:50 INFO - ##### 23:24:50 INFO - Running post-run listener: _resource_record_post_run 23:24:50 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 525672448; Read time: 0; Write time: 554924 23:24:50 INFO - TinderboxPrint: CPU usage
13.4% 23:24:50 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:24:50 INFO - TinderboxPrint: I/O write bytes / time
525,672,448 / 554,924 23:24:50 INFO - TinderboxPrint: CPU idle
8,230.4 (86.6%) 23:24:50 INFO - TinderboxPrint: CPU user
1,222.5 (12.9%) 23:24:50 INFO - TinderboxPrint: Swap in / out
0 / 0 23:24:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 120303616; Read time: 0; Write time: 230972 23:24:50 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 289497088; Read time: 0; Write time: 240488 23:24:50 INFO - Running post-run listener: _upload_blobber_files 23:24:50 INFO - Blob upload gear active. 23:24:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:24:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:24:51 INFO - (blobuploader) - INFO - Open directory for files ... 23:24:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:24:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:24:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:24:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:24:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:24:54 INFO - (blobuploader) - INFO - Done attempting. 23:24:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:24:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:24:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:24:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:24:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:24:55 INFO - (blobuploader) - INFO - Done attempting. 23:24:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:24:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:24:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:24:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:24:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:24:56 INFO - (blobuploader) - INFO - Done attempting. 23:24:56 INFO - (blobuploader) - INFO - Iteration through files over. 23:24:56 INFO - Return code: 0 23:24:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:24:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:24:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/655bf947df75c556b3d50ef29e2197376fb17dffd7b440047084f1aed8970bd70561324af1f8837931a43e3dac38e3e03ac581bbfa9a3fb2f7cfbb000c699c81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2087311f98d696b890dec6c1064cd970f79bbcd9fe17fcd11a8e7ec4e471f58b18efb1d2c1f5706e2d4397734bd320dcbfed68d5f87a3174299df0f7ada2f591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecb4000b4c4cf0aa3d0e68254b72e14fe3cb812884f48fc36433ea5baa21a540f239541c270074c47b02f16b30ae990bfa5fa336c36d9d0bf286f00210d24b0a"} 23:24:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:24:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:24:56 INFO - Contents: 23:24:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/655bf947df75c556b3d50ef29e2197376fb17dffd7b440047084f1aed8970bd70561324af1f8837931a43e3dac38e3e03ac581bbfa9a3fb2f7cfbb000c699c81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2087311f98d696b890dec6c1064cd970f79bbcd9fe17fcd11a8e7ec4e471f58b18efb1d2c1f5706e2d4397734bd320dcbfed68d5f87a3174299df0f7ada2f591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecb4000b4c4cf0aa3d0e68254b72e14fe3cb812884f48fc36433ea5baa21a540f239541c270074c47b02f16b30ae990bfa5fa336c36d9d0bf286f00210d24b0a"} 23:24:56 INFO - Running post-run listener: copy_logs_to_upload_dir 23:24:56 INFO - Copying logs to upload dir... 23:24:56 INFO - mkdir: /builds/slave/test/build/upload/logs 23:24:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.508579 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-23 23:24:56.082459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 23:24:56.085815) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/655bf947df75c556b3d50ef29e2197376fb17dffd7b440047084f1aed8970bd70561324af1f8837931a43e3dac38e3e03ac581bbfa9a3fb2f7cfbb000c699c81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2087311f98d696b890dec6c1064cd970f79bbcd9fe17fcd11a8e7ec4e471f58b18efb1d2c1f5706e2d4397734bd320dcbfed68d5f87a3174299df0f7ada2f591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecb4000b4c4cf0aa3d0e68254b72e14fe3cb812884f48fc36433ea5baa21a540f239541c270074c47b02f16b30ae990bfa5fa336c36d9d0bf286f00210d24b0a"} build_url:https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/H5xrVA-wTvOEHQUl2XDQGQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/655bf947df75c556b3d50ef29e2197376fb17dffd7b440047084f1aed8970bd70561324af1f8837931a43e3dac38e3e03ac581bbfa9a3fb2f7cfbb000c699c81", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2087311f98d696b890dec6c1064cd970f79bbcd9fe17fcd11a8e7ec4e471f58b18efb1d2c1f5706e2d4397734bd320dcbfed68d5f87a3174299df0f7ada2f591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecb4000b4c4cf0aa3d0e68254b72e14fe3cb812884f48fc36433ea5baa21a540f239541c270074c47b02f16b30ae990bfa5fa336c36d9d0bf286f00210d24b0a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 23:24:56.111813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 23:24:56.112134) ========= 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=31acecf42b6a79ec49471d4a000001bb-1464068960.219103-1475852375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 23:24:56.197041) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 23:24:56.197370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 23:24:56.197657) ========= ========= Total master_lag: 0.32 =========