builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1469810156.77 results: success (0) buildid: 20160729063002 builduid: 5a0c5b8ab4a4458580c568b3a0b44e98 revision: f3d6887279f8175b0d1e3835d1ca2a152bc4453f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:56.769378) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:56.769864) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:56.770215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:56.786639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:56.786983) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 09:35:58-- 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% 45.9M=0s 2016-07-29 09:35:58 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093001 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:56.894040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:56.894397) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017729 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:56.945377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 09:35:56.945769) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f3d6887279f8175b0d1e3835d1ca2a152bc4453f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev f3d6887279f8175b0d1e3835d1ca2a152bc4453f --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=3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 09:35:58,212 truncating revision to first 12 chars 2016-07-29 09:35:58,212 Setting DEBUG logging. 2016-07-29 09:35:58,212 attempt 1/10 2016-07-29 09:35:58,212 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f3d6887279f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 09:35:59,205 unpacking tar archive at: autoland-f3d6887279f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.311467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 09:35:58.270908) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:58.271208) ========= script_repo_revision: f3d6887279f8175b0d1e3835d1ca2a152bc4453f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:58.271619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:58.271902) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 09:35:58.279985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-29 09:35:58.280305) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:35:59 INFO - MultiFileLogger online at 20160729 09:35:59 in /builds/slave/test 09:35:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 09:35:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:35:59 INFO - {'append_to_log': False, 09:35:59 INFO - 'base_work_dir': '/builds/slave/test', 09:35:59 INFO - 'blob_upload_branch': 'Autoland', 09:35:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:35:59 INFO - 'branch': 'Autoland', 09:35:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:59 INFO - 'config_files': ('talos/linux_config.py',), 09:35:59 INFO - 'default_actions': ('clobber', 09:35:59 INFO - 'read-buildbot-config', 09:35:59 INFO - 'download-and-extract', 09:35:59 INFO - 'populate-webroot', 09:35:59 INFO - 'create-virtualenv', 09:35:59 INFO - 'install', 09:35:59 INFO - 'run-tests'), 09:35:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:59 INFO - 'download_minidump_stackwalk': True, 09:35:59 INFO - 'download_symbols': 'ondemand', 09:35:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:59 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:59 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:59 INFO - 'installer_path': 'installer.exe', 09:35:59 INFO - 'log_level': 'info', 09:35:59 INFO - 'log_name': 'talos', 09:35:59 INFO - 'log_to_console': True, 09:35:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:35:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:35:59 INFO - 'opt_config_files': (), 09:35:59 INFO - 'pip_index': False, 09:35:59 INFO - 'sps_profile': False, 09:35:59 INFO - 'sps_profile_interval': 0, 09:35:59 INFO - 'suite': 'dromaeojs-e10s', 09:35:59 INFO - 'system_bits': '32', 09:35:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:59 INFO - 'title': 'talos-linux64-ix-059', 09:35:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:59 INFO - 'use_talos_json': True, 09:35:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:35:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:59 INFO - 'work_dir': 'build'} 09:35:59 INFO - [mozharness: 2016-07-29 16:35:59.640651Z] Running clobber step. 09:35:59 INFO - Running pre-action listener: _resource_record_pre_action 09:35:59 INFO - Running main action method: clobber 09:35:59 INFO - rmtree: /builds/slave/test/build 09:35:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:36:00 INFO - Running post-action listener: _resource_record_post_action 09:36:00 INFO - [mozharness: 2016-07-29 16:36:00.641386Z] Finished clobber step (success) 09:36:00 INFO - [mozharness: 2016-07-29 16:36:00.641487Z] Running read-buildbot-config step. 09:36:00 INFO - Running pre-action listener: _resource_record_pre_action 09:36:00 INFO - Running main action method: read_buildbot_config 09:36:00 INFO - Using buildbot properties: 09:36:00 INFO - { 09:36:00 INFO - "project": "", 09:36:00 INFO - "product": "firefox", 09:36:00 INFO - "script_repo_revision": "production", 09:36:00 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 09:36:00 INFO - "repository": "", 09:36:00 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 09:36:00 INFO - "buildid": "20160729063002", 09:36:00 INFO - "pgo_build": "True", 09:36:00 INFO - "basedir": "/builds/slave/test", 09:36:00 INFO - "buildnumber": 74, 09:36:00 INFO - "slavename": "talos-linux64-ix-059", 09:36:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:36:00 INFO - "platform": "ubuntu64_hw", 09:36:00 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 09:36:00 INFO - "branch": "autoland", 09:36:00 INFO - "repo_path": "integration/autoland", 09:36:00 INFO - "revision": "f3d6887279f8175b0d1e3835d1ca2a152bc4453f", 09:36:00 INFO - "stage_platform": "linux64-pgo", 09:36:00 INFO - "builduid": "5a0c5b8ab4a4458580c568b3a0b44e98", 09:36:00 INFO - "slavebuilddir": "test" 09:36:00 INFO - } 09:36:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:36:00 INFO - Running post-action listener: _resource_record_post_action 09:36:00 INFO - [mozharness: 2016-07-29 16:36:00.644025Z] Finished read-buildbot-config step (success) 09:36:00 INFO - [mozharness: 2016-07-29 16:36:00.644115Z] Running download-and-extract step. 09:36:00 INFO - Running pre-action listener: _resource_record_pre_action 09:36:00 INFO - Running main action method: download_and_extract 09:36:00 INFO - mkdir: /builds/slave/test/build/tests 09:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:00 INFO - https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:36:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:36:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:36:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:36:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:36:01 INFO - Downloaded 1361 bytes. 09:36:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:36:01 INFO - Using the following test package requirements: 09:36:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:36:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:36:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:01 INFO - u'jsshell-linux-x86_64.zip'], 09:36:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:36:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:36:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:36:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:36:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:36:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:36:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:36:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:36:01 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')]} 09:36:01 INFO - https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:36:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:36:02 INFO - Downloaded 24328566 bytes. 09:36:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:36:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:36:03 INFO - Return code: 0 09:36:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:36:03 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')]} 09:36:03 INFO - https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:36:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:36:04 INFO - Downloaded 24328566 bytes. 09:36:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:36:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:36:06 INFO - Return code: 0 09:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:06 INFO - https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:36:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:36:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:36:07 INFO - Downloaded 14413725 bytes. 09:36:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:36:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:36:07 INFO - Return code: 0 09:36:07 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')]} 09:36:07 INFO - https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:36:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:36:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:36:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:36:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:36:08 INFO - Downloaded 61032243 bytes. 09:36:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:36:08 INFO - mkdir: /builds/slave/test/properties 09:36:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:36:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:36:08 INFO - Contents: 09:36:08 INFO - build_url:https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:36:09 INFO - Running post-action listener: _resource_record_post_action 09:36:09 INFO - Running post-action listener: set_extra_try_arguments 09:36:09 INFO - [mozharness: 2016-07-29 16:36:09.238285Z] Finished download-and-extract step (success) 09:36:09 INFO - [mozharness: 2016-07-29 16:36:09.238518Z] Running populate-webroot step. 09:36:09 INFO - Running pre-action listener: _resource_record_pre_action 09:36:09 INFO - Running main action method: populate_webroot 09:36:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:36:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:36:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:36:09 INFO - '--tppagecycles', 09:36:09 INFO - '7'], 09:36:09 INFO - 'tests': ['tsvgm']}}, 09:36:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:36:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:36:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:36:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:36:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['damp', 'tps']}, 09:36:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'tests': ['damp', 'tps']}, 09:36:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['dromaeo_dom']}, 09:36:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:36:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['basic_compositor_video']}, 09:36:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:36:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'other-e10s': {'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['a11yr', 09:36:09 INFO - 'ts_paint', 09:36:09 INFO - 'tpaint', 09:36:09 INFO - 'sessionrestore', 09:36:09 INFO - 'sessionrestore_no_auto_restore', 09:36:09 INFO - 'tabpaint']}, 09:36:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['tsvgx', 09:36:09 INFO - 'tsvgr_opacity', 09:36:09 INFO - 'tart', 09:36:09 INFO - 'tscrollx', 09:36:09 INFO - 'cart']}, 09:36:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:36:09 INFO - 'tsvgr_opacity', 09:36:09 INFO - 'tart', 09:36:09 INFO - 'tscrollx', 09:36:09 INFO - 'cart']}, 09:36:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'talos_options': ['--disable-e10s'], 09:36:09 INFO - 'tests': ['tp5o']}, 09:36:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'tests': ['tp5o']}, 09:36:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'talos_options': ['--disable-e10s', 09:36:09 INFO - '--xperf_path', 09:36:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:09 INFO - 'tests': ['tp5n']}, 09:36:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:09 INFO - 'talos_options': ['--xperf_path', 09:36:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:09 INFO - 'tests': ['tp5n']}}, 09:36:09 INFO - 'talos.zip': {'path': '', 09:36:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:36:09 INFO - Running post-action listener: _resource_record_post_action 09:36:09 INFO - [mozharness: 2016-07-29 16:36:09.259986Z] Finished populate-webroot step (success) 09:36:09 INFO - [mozharness: 2016-07-29 16:36:09.260075Z] Running create-virtualenv step. 09:36:09 INFO - Running pre-action listener: _resource_record_pre_action 09:36:09 INFO - Running main action method: create_virtualenv 09:36:09 INFO - Creating virtualenv /builds/slave/test/build/venv 09:36:09 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 09:36:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:36:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:36:09 INFO - Using real prefix '/usr' 09:36:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:36:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:36:11 INFO - Installing pip.................done. 09:36:11 INFO - Return code: 0 09:36:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:36:11 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')]} 09:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:11 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')]} 09:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:11 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 0x1172030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14313b0>, '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 0x14322b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1432740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', '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 09:36:11 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 09:36:11 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 09:36:11 INFO - Using env: {'DISPLAY': ':0', 09:36:11 INFO - 'HOME': '/home/cltbld', 09:36:11 INFO - 'LANG': 'en_US.UTF-8', 09:36:11 INFO - 'LANGUAGE': 'en_US:en', 09:36:11 INFO - 'LOGNAME': 'cltbld', 09:36:11 INFO - 'MAIL': '/var/mail/cltbld', 09:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:11 INFO - 'MOZ_NO_REMOTE': '1', 09:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:11 INFO - 'NO_EM_RESTART': '1', 09:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:11 INFO - 'PWD': '/builds/slave/test', 09:36:11 INFO - 'SHELL': '/bin/bash', 09:36:11 INFO - 'SHLVL': '1', 09:36:11 INFO - 'TERM': 'linux', 09:36:11 INFO - 'TMOUT': '86400', 09:36:11 INFO - 'USER': 'cltbld', 09:36:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', 09:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:11 INFO - '_': '/tools/buildbot/bin/python'} 09:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:12 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 09:36:12 INFO - Cleaning up... 09:36:12 INFO - Return code: 0 09:36:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:36:12 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')]} 09:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:12 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')]} 09:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:12 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 0x1172030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14313b0>, '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 0x14322b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1432740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', '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 09:36:12 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 09:36:12 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 09:36:12 INFO - Using env: {'DISPLAY': ':0', 09:36:12 INFO - 'HOME': '/home/cltbld', 09:36:12 INFO - 'LANG': 'en_US.UTF-8', 09:36:12 INFO - 'LANGUAGE': 'en_US:en', 09:36:12 INFO - 'LOGNAME': 'cltbld', 09:36:12 INFO - 'MAIL': '/var/mail/cltbld', 09:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:12 INFO - 'MOZ_NO_REMOTE': '1', 09:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:12 INFO - 'NO_EM_RESTART': '1', 09:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:12 INFO - 'PWD': '/builds/slave/test', 09:36:12 INFO - 'SHELL': '/bin/bash', 09:36:12 INFO - 'SHLVL': '1', 09:36:12 INFO - 'TERM': 'linux', 09:36:12 INFO - 'TMOUT': '86400', 09:36:12 INFO - 'USER': 'cltbld', 09:36:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', 09:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:12 INFO - '_': '/tools/buildbot/bin/python'} 09:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:12 INFO - Downloading/unpacking psutil>=3.1.1 09:36:12 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 09:36:12 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 09:36:12 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 09:36:12 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 09:36:12 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 09:36:12 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 09:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:36:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:14 INFO - Installing collected packages: psutil 09:36:14 INFO - Running setup.py install for psutil 09:36:14 INFO - building 'psutil._psutil_linux' extension 09:36:14 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 09:36:14 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 09:36:14 INFO - building 'psutil._psutil_posix' extension 09:36:14 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 09:36:14 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 09:36:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:14 INFO - Successfully installed psutil 09:36:14 INFO - Cleaning up... 09:36:14 INFO - Return code: 0 09:36:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:36:14 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')]} 09:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:14 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')]} 09:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:14 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 0x1172030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14313b0>, '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 0x14322b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1432740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', '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 09:36:14 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 09:36:14 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 09:36:14 INFO - Using env: {'DISPLAY': ':0', 09:36:14 INFO - 'HOME': '/home/cltbld', 09:36:14 INFO - 'LANG': 'en_US.UTF-8', 09:36:14 INFO - 'LANGUAGE': 'en_US:en', 09:36:14 INFO - 'LOGNAME': 'cltbld', 09:36:14 INFO - 'MAIL': '/var/mail/cltbld', 09:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:14 INFO - 'MOZ_NO_REMOTE': '1', 09:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:14 INFO - 'NO_EM_RESTART': '1', 09:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:14 INFO - 'PWD': '/builds/slave/test', 09:36:14 INFO - 'SHELL': '/bin/bash', 09:36:14 INFO - 'SHLVL': '1', 09:36:14 INFO - 'TERM': 'linux', 09:36:14 INFO - 'TMOUT': '86400', 09:36:14 INFO - 'USER': 'cltbld', 09:36:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', 09:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:14 INFO - '_': '/tools/buildbot/bin/python'} 09:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:36:15 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 09:36:15 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 09:36:15 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 09:36:15 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 09:36:15 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 09:36:15 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 09:36:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:36:16 INFO - Installing collected packages: mozsystemmonitor 09:36:16 INFO - Running setup.py install for mozsystemmonitor 09:36:17 INFO - Successfully installed mozsystemmonitor 09:36:17 INFO - Cleaning up... 09:36:17 INFO - Return code: 0 09:36:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:36:17 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')]} 09:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:17 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')]} 09:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:17 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14313b0>, '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 0x14322b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1432740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', '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 09:36:17 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==2.5.1'] in /builds/slave/test/build 09:36:17 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==2.5.1 09:36:17 INFO - Using env: {'DISPLAY': ':0', 09:36:17 INFO - 'HOME': '/home/cltbld', 09:36:17 INFO - 'LANG': 'en_US.UTF-8', 09:36:17 INFO - 'LANGUAGE': 'en_US:en', 09:36:17 INFO - 'LOGNAME': 'cltbld', 09:36:17 INFO - 'MAIL': '/var/mail/cltbld', 09:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:17 INFO - 'MOZ_NO_REMOTE': '1', 09:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:17 INFO - 'NO_EM_RESTART': '1', 09:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:17 INFO - 'PWD': '/builds/slave/test', 09:36:17 INFO - 'SHELL': '/bin/bash', 09:36:17 INFO - 'SHLVL': '1', 09:36:17 INFO - 'TERM': 'linux', 09:36:17 INFO - 'TMOUT': '86400', 09:36:17 INFO - 'USER': 'cltbld', 09:36:17 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', 09:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:17 INFO - '_': '/tools/buildbot/bin/python'} 09:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:17 INFO - Downloading/unpacking jsonschema==2.5.1 09:36:17 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 09:36:17 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 09:36:17 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 09:36:17 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 09:36:17 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 09:36:17 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 09:36:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:36:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:36:19 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 09:36:19 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 09:36:19 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 09:36:19 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 09:36:19 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 09:36:19 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 09:36:19 INFO - Downloading functools32-3.2.3-2.tar.gz 09:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:36:19 INFO - warning: no files found matching '*.txt' 09:36:19 INFO - no previously-included directories found matching 'build' 09:36:19 INFO - no previously-included directories found matching 'dist' 09:36:19 INFO - no previously-included directories found matching '.git*' 09:36:19 INFO - Installing collected packages: jsonschema, functools32 09:36:19 INFO - Running setup.py install for functools32 09:36:19 INFO - warning: no files found matching '*.txt' 09:36:19 INFO - no previously-included directories found matching 'build' 09:36:19 INFO - no previously-included directories found matching 'dist' 09:36:19 INFO - no previously-included directories found matching '.git*' 09:36:19 INFO - Successfully installed jsonschema functools32 09:36:19 INFO - Cleaning up... 09:36:19 INFO - Return code: 0 09:36:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:19 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14313b0>, '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 0x14322b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1432740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', '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 09:36:19 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:36:19 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 functools32==3.2.3-2 09:36:19 INFO - Using env: {'DISPLAY': ':0', 09:36:19 INFO - 'HOME': '/home/cltbld', 09:36:19 INFO - 'LANG': 'en_US.UTF-8', 09:36:19 INFO - 'LANGUAGE': 'en_US:en', 09:36:19 INFO - 'LOGNAME': 'cltbld', 09:36:19 INFO - 'MAIL': '/var/mail/cltbld', 09:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:19 INFO - 'MOZ_NO_REMOTE': '1', 09:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:19 INFO - 'NO_EM_RESTART': '1', 09:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:19 INFO - 'PWD': '/builds/slave/test', 09:36:19 INFO - 'SHELL': '/bin/bash', 09:36:19 INFO - 'SHLVL': '1', 09:36:19 INFO - 'TERM': 'linux', 09:36:19 INFO - 'TMOUT': '86400', 09:36:19 INFO - 'USER': 'cltbld', 09:36:19 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', 09:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:19 INFO - '_': '/tools/buildbot/bin/python'} 09:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:36:19 INFO - Cleaning up... 09:36:19 INFO - Return code: 0 09:36:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:19 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 0x1172030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14313b0>, '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 0x14322b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1432740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', '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 09:36:19 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 09:36:19 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 09:36:19 INFO - Using env: {'DISPLAY': ':0', 09:36:19 INFO - 'HOME': '/home/cltbld', 09:36:19 INFO - 'LANG': 'en_US.UTF-8', 09:36:19 INFO - 'LANGUAGE': 'en_US:en', 09:36:19 INFO - 'LOGNAME': 'cltbld', 09:36:19 INFO - 'MAIL': '/var/mail/cltbld', 09:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:19 INFO - 'MOZ_NO_REMOTE': '1', 09:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:19 INFO - 'NO_EM_RESTART': '1', 09:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:19 INFO - 'PWD': '/builds/slave/test', 09:36:19 INFO - 'SHELL': '/bin/bash', 09:36:19 INFO - 'SHLVL': '1', 09:36:19 INFO - 'TERM': 'linux', 09:36:19 INFO - 'TMOUT': '86400', 09:36:19 INFO - 'USER': 'cltbld', 09:36:19 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', 09:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:19 INFO - '_': '/tools/buildbot/bin/python'} 09:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:20 INFO - Downloading/unpacking blobuploader==1.2.4 09:36:20 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 09:36:20 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 09:36:20 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 09:36:20 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 09:36:20 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 09:36:20 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 09:36:22 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:36:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 INFO - Downloading docopt-0.6.1.tar.gz 09:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:22 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:22 INFO - Running setup.py install for blobuploader 09:36:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:36:22 INFO - Running setup.py install for requests 09:36:23 INFO - Running setup.py install for docopt 09:36:23 INFO - Successfully installed blobuploader requests docopt 09:36:23 INFO - Cleaning up... 09:36:23 INFO - Return code: 0 09:36:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:23 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 0x1172030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14313b0>, '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 0x14322b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1432740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', '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 09:36:23 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 09:36:23 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 09:36:23 INFO - Using env: {'DISPLAY': ':0', 09:36:23 INFO - 'HOME': '/home/cltbld', 09:36:23 INFO - 'LANG': 'en_US.UTF-8', 09:36:23 INFO - 'LANGUAGE': 'en_US:en', 09:36:23 INFO - 'LOGNAME': 'cltbld', 09:36:23 INFO - 'MAIL': '/var/mail/cltbld', 09:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:23 INFO - 'MOZ_NO_REMOTE': '1', 09:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:23 INFO - 'NO_EM_RESTART': '1', 09:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:23 INFO - 'PWD': '/builds/slave/test', 09:36:23 INFO - 'SHELL': '/bin/bash', 09:36:23 INFO - 'SHLVL': '1', 09:36:23 INFO - 'TERM': 'linux', 09:36:23 INFO - 'TMOUT': '86400', 09:36:23 INFO - 'USER': 'cltbld', 09:36:23 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', 09:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:23 INFO - '_': '/tools/buildbot/bin/python'} 09:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:23 INFO - Running setup.py (path:/tmp/pip-uJd0x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:23 INFO - Running setup.py (path:/tmp/pip-6UF3_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:23 INFO - Running setup.py (path:/tmp/pip-1Aasxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:23 INFO - Running setup.py (path:/tmp/pip-tAYfAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:23 INFO - Running setup.py (path:/tmp/pip-oy5G9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:23 INFO - Running setup.py (path:/tmp/pip-Hl6s8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:24 INFO - Running setup.py (path:/tmp/pip-6Rbhdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:24 INFO - Running setup.py (path:/tmp/pip-VKZMHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:24 INFO - Running setup.py (path:/tmp/pip-qkZUkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:24 INFO - Running setup.py (path:/tmp/pip-6lyp1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:24 INFO - Running setup.py (path:/tmp/pip-sxKYv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:24 INFO - Running setup.py (path:/tmp/pip-80lftJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:24 INFO - Running setup.py (path:/tmp/pip-JFXSi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:24 INFO - Running setup.py (path:/tmp/pip-z_mY6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:24 INFO - Running setup.py (path:/tmp/pip-Y9O70Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:24 INFO - Running setup.py (path:/tmp/pip-mZm23h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:24 INFO - Running setup.py (path:/tmp/pip-V8y77_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:24 INFO - Running setup.py install for manifestparser 09:36:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:36:24 INFO - Running setup.py install for mozcrash 09:36:25 INFO - Running setup.py install for mozdebug 09:36:25 INFO - Running setup.py install for mozdevice 09:36:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Running setup.py install for mozfile 09:36:25 INFO - Running setup.py install for mozhttpd 09:36:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Running setup.py install for mozinfo 09:36:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Running setup.py install for mozInstall 09:36:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Running setup.py install for mozleak 09:36:25 INFO - Running setup.py install for mozlog 09:36:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Running setup.py install for moznetwork 09:36:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:36:25 INFO - Running setup.py install for mozprocess 09:36:26 INFO - Running setup.py install for mozprofile 09:36:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Running setup.py install for mozrunner 09:36:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Running setup.py install for mozscreenshot 09:36:26 INFO - Running setup.py install for moztest 09:36:26 INFO - Running setup.py install for mozversion 09:36:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:36:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:26 INFO - Cleaning up... 09:36:26 INFO - Return code: 0 09:36:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36: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')]} 09:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:26 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 0x1172030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14313b0>, '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 0x14322b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1432740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', '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 09:36:26 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 09:36:26 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 09:36:26 INFO - Using env: {'DISPLAY': ':0', 09:36:26 INFO - 'HOME': '/home/cltbld', 09:36:26 INFO - 'LANG': 'en_US.UTF-8', 09:36:26 INFO - 'LANGUAGE': 'en_US:en', 09:36:26 INFO - 'LOGNAME': 'cltbld', 09:36:26 INFO - 'MAIL': '/var/mail/cltbld', 09:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:26 INFO - 'MOZ_NO_REMOTE': '1', 09:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:26 INFO - 'NO_EM_RESTART': '1', 09:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:26 INFO - 'PWD': '/builds/slave/test', 09:36:26 INFO - 'SHELL': '/bin/bash', 09:36:26 INFO - 'SHLVL': '1', 09:36:26 INFO - 'TERM': 'linux', 09:36:26 INFO - 'TMOUT': '86400', 09:36:26 INFO - 'USER': 'cltbld', 09:36:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', 09:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:26 INFO - '_': '/tools/buildbot/bin/python'} 09:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:26 INFO - Running setup.py (path:/tmp/pip-l58K1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:26 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)) 09:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:26 INFO - Running setup.py (path:/tmp/pip-0w28il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:27 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:27 INFO - Running setup.py (path:/tmp/pip-QEjifk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:27 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:27 INFO - Running setup.py (path:/tmp/pip-P3njOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:27 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:27 INFO - Running setup.py (path:/tmp/pip-e5KfXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:27 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:27 INFO - Running setup.py (path:/tmp/pip-CleTKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:27 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:27 INFO - Running setup.py (path:/tmp/pip-ePxKRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:27 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:27 INFO - Running setup.py (path:/tmp/pip-TukD17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:27 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:27 INFO - Running setup.py (path:/tmp/pip-CRiwyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:27 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:27 INFO - Running setup.py (path:/tmp/pip-xnlIwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:27 INFO - Running setup.py (path:/tmp/pip-Zyo8bL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:27 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:27 INFO - Running setup.py (path:/tmp/pip-mX1pIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:27 INFO - Running setup.py (path:/tmp/pip-VWTBbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:27 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:27 INFO - Running setup.py (path:/tmp/pip-NC2tI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:27 INFO - Running setup.py (path:/tmp/pip-lU27DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:27 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)) 09:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:27 INFO - Running setup.py (path:/tmp/pip-F4gLk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:28 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)) 09:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:28 INFO - Running setup.py (path:/tmp/pip-Q_foCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:28 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)) 09:36:28 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)) 09:36:28 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)) 09:36:28 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)) 09:36:28 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)) 09:36:28 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)) 09:36:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:28 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 09:36:28 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 09:36:28 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 09:36:28 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 09:36:28 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 09:36:28 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 09:36:29 INFO - Downloading blessings-1.6.tar.gz 09:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:30 INFO - Installing collected packages: blessings 09:36:30 INFO - Running setup.py install for blessings 09:36:30 INFO - Successfully installed blessings 09:36:30 INFO - Cleaning up... 09:36:30 INFO - Return code: 0 09:36:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:30 INFO - Reading from file tmpfile_stdout 09:36:30 INFO - Current package versions: 09:36:30 INFO - argparse == 1.2.1 09:36:30 INFO - blessings == 1.6 09:36:30 INFO - blobuploader == 1.2.4 09:36:30 INFO - docopt == 0.6.1 09:36:30 INFO - functools32 == 3.2.3-2 09:36:30 INFO - jsonschema == 2.5.1 09:36:30 INFO - manifestparser == 1.1 09:36:30 INFO - mozInstall == 1.12 09:36:30 INFO - mozcrash == 0.17 09:36:30 INFO - mozdebug == 0.1 09:36:30 INFO - mozdevice == 0.48 09:36:30 INFO - mozfile == 1.2 09:36:30 INFO - mozhttpd == 0.7 09:36:30 INFO - mozinfo == 0.9 09:36:30 INFO - mozleak == 0.1 09:36:30 INFO - mozlog == 3.3 09:36:30 INFO - moznetwork == 0.27 09:36:30 INFO - mozprocess == 0.23 09:36:30 INFO - mozprofile == 0.28 09:36:30 INFO - mozrunner == 6.12 09:36:30 INFO - mozscreenshot == 0.1 09:36:30 INFO - mozsystemmonitor == 0.3 09:36:30 INFO - moztest == 0.7 09:36:30 INFO - mozversion == 1.4 09:36:30 INFO - psutil == 3.1.1 09:36:30 INFO - requests == 1.2.3 09:36:30 INFO - wsgiref == 0.1.2 09:36:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:30 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')]} 09:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:30 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')]} 09:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:30 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 0x1172030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14313b0>, '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 0x14322b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1432740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', '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 09:36:30 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 09:36:30 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 09:36:30 INFO - Using env: {'DISPLAY': ':0', 09:36:30 INFO - 'HOME': '/home/cltbld', 09:36:30 INFO - 'LANG': 'en_US.UTF-8', 09:36:30 INFO - 'LANGUAGE': 'en_US:en', 09:36:30 INFO - 'LOGNAME': 'cltbld', 09:36:30 INFO - 'MAIL': '/var/mail/cltbld', 09:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:30 INFO - 'MOZ_NO_REMOTE': '1', 09:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:30 INFO - 'NO_EM_RESTART': '1', 09:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:30 INFO - 'PWD': '/builds/slave/test', 09:36:30 INFO - 'SHELL': '/bin/bash', 09:36:30 INFO - 'SHLVL': '1', 09:36:30 INFO - 'TERM': 'linux', 09:36:30 INFO - 'TMOUT': '86400', 09:36:30 INFO - 'USER': 'cltbld', 09:36:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', 09:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:30 INFO - '_': '/tools/buildbot/bin/python'} 09:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:30 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)) 09:36:30 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)) 09:36:30 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)) 09:36:30 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)) 09:36:30 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)) 09:36:30 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)) 09:36:30 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)) 09:36:30 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)) 09:36:30 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)) 09:36:30 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)) 09:36:30 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)) 09:36:30 INFO - Cleaning up... 09:36:30 INFO - Return code: 0 09:36:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:36:30 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')]} 09:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:30 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')]} 09:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:30 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 0x1172030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1433180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14313b0>, '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 0x14322b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1432740>, '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': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', '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 09:36:30 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 09:36:30 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 09:36:30 INFO - Using env: {'DISPLAY': ':0', 09:36:30 INFO - 'HOME': '/home/cltbld', 09:36:30 INFO - 'LANG': 'en_US.UTF-8', 09:36:30 INFO - 'LANGUAGE': 'en_US:en', 09:36:30 INFO - 'LOGNAME': 'cltbld', 09:36:30 INFO - 'MAIL': '/var/mail/cltbld', 09:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:30 INFO - 'MOZ_NO_REMOTE': '1', 09:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:30 INFO - 'NO_EM_RESTART': '1', 09:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:30 INFO - 'PWD': '/builds/slave/test', 09:36:30 INFO - 'SHELL': '/bin/bash', 09:36:30 INFO - 'SHLVL': '1', 09:36:30 INFO - 'TERM': 'linux', 09:36:30 INFO - 'TMOUT': '86400', 09:36:30 INFO - 'USER': 'cltbld', 09:36:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', 09:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:30 INFO - '_': '/tools/buildbot/bin/python'} 09:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:36:30 INFO - Cleaning up... 09:36:30 INFO - Return code: 0 09:36:30 INFO - Running post-action listener: _resource_record_post_action 09:36:30 INFO - Running post-action listener: _start_resource_monitoring 09:36:30 INFO - Starting resource monitoring. 09:36:30 INFO - [mozharness: 2016-07-29 16:36:30.940235Z] Finished create-virtualenv step (success) 09:36:30 INFO - [mozharness: 2016-07-29 16:36:30.940671Z] Running install step. 09:36:30 INFO - Running pre-action listener: _resource_record_pre_action 09:36:30 INFO - Running main action method: install 09:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:31 INFO - Reading from file tmpfile_stdout 09:36:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:36:31 INFO - Reading from file tmpfile_stdout 09:36:31 INFO - Output received: 09:36:31 INFO - Usage: mozinstall [options] installer 09:36:31 INFO - Options: 09:36:31 INFO - -h, --help show this help message and exit 09:36:31 INFO - -d DEST, --destination=DEST 09:36:31 INFO - Directory to install application into. [default: 09:36:31 INFO - "/builds/slave/test"] 09:36:31 INFO - --app=APP Application being installed. [default: firefox] 09:36:31 INFO - mkdir: /builds/slave/test/build/application 09:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:36:49 INFO - Reading from file tmpfile_stdout 09:36:49 INFO - Output received: 09:36:49 INFO - /builds/slave/test/build/application/firefox/firefox 09:36:49 INFO - Running post-action listener: _resource_record_post_action 09:36:49 INFO - [mozharness: 2016-07-29 16:36:49.026507Z] Finished install step (success) 09:36:49 INFO - [mozharness: 2016-07-29 16:36:49.026783Z] Running run-tests step. 09:36:49 INFO - Running pre-action listener: _resource_record_pre_action 09:36:49 INFO - Running main action method: run_tests 09:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:36:49 INFO - Python 2.7.3 09:36:49 INFO - Return code: 0 09:36:49 INFO - grabbing minidump binary from tooltool 09:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:49 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 0x14313b0>, '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 0x14322b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1432740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:36:49 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 09:36:49 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 09:36:49 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 09:36:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:36:49 INFO - Return code: 0 09:36:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:36:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:36:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:36:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:36:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 09:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 09:36:49 INFO - Using env: {'DISPLAY': ':0', 09:36:49 INFO - 'HOME': '/home/cltbld', 09:36:49 INFO - 'LANG': 'en_US.UTF-8', 09:36:49 INFO - 'LANGUAGE': 'en_US:en', 09:36:49 INFO - 'LOGNAME': 'cltbld', 09:36:49 INFO - 'MAIL': '/var/mail/cltbld', 09:36:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:36:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:49 INFO - 'MOZ_NO_REMOTE': '1', 09:36:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:49 INFO - 'NO_EM_RESTART': '1', 09:36:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:49 INFO - 'PWD': '/builds/slave/test', 09:36:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:36:49 INFO - 'SHELL': '/bin/bash', 09:36:49 INFO - 'SHLVL': '1', 09:36:49 INFO - 'TERM': 'linux', 09:36:49 INFO - 'TMOUT': '86400', 09:36:49 INFO - 'USER': 'cltbld', 09:36:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083', 09:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:49 INFO - '_': '/tools/buildbot/bin/python'} 09:36:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 09:36:49 INFO - mozversion application_buildid: 20160729063002 09:36:49 INFO - mozversion application_changeset: f3d6887279f8175b0d1e3835d1ca2a152bc4453f 09:36:49 INFO - mozversion application_display_name: Nightly 09:36:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:36:49 INFO - mozversion application_name: Firefox 09:36:49 INFO - mozversion application_remotingname: firefox 09:36:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:36:49 INFO - mozversion application_vendor: Mozilla 09:36:49 INFO - mozversion application_version: 50.0a1 09:36:49 INFO - mozversion platform_buildid: 20160729063002 09:36:49 INFO - mozversion platform_changeset: f3d6887279f8175b0d1e3835d1ca2a152bc4453f 09:36:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:36:49 INFO - mozversion platform_version: 50.0a1 09:36:49 INFO - using testdate: 1469810209 09:36:49 INFO - actual date: 1469810209 09:36:49 INFO - starting webserver on 'localhost:59388' 09:36:49 INFO - SUITE-START | Running 2 tests 09:36:49 INFO - TEST-START | dromaeo_css 09:36:49 INFO - operating with platform_type : linux_ 09:36:49 INFO - Initialising browser for dromaeo_css test... 09:36:49 INFO - TEST-INFO | started process 20307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp34s73n/profile http://localhost:59388/getInfo.html) 09:36:52 INFO - PROCESS | 20307 | JavaScript error: , line 0: uncaught exception: undefined 09:36:53 INFO - PROCESS | 20307 | __metrics Screen width/height:1600/1200 09:36:53 INFO - PROCESS | 20307 | colorDepth:24 09:36:53 INFO - PROCESS | 20307 | Browser inner width/height: 1024/697 09:36:53 INFO - PROCESS | 20307 | __metrics 09:36:54 ERROR - PROCESS | 20307 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:36:54 INFO - TEST-INFO | 20307: exit 0 09:36:54 INFO - Browser initialized. 09:36:54 INFO - Running cycle 1/1 for dromaeo_css test... 09:36:54 INFO - TEST-INFO | started process 20427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp34s73n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:06 INFO - PROCESS | 20427 | RSS: Main: 164839424 09:37:06 INFO - PROCESS | 20427 | 09:37:56 INFO - PROCESS | 20427 | 1469810276443 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] 09:40:05 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:59388/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59388/tests/dromaeo/cssquery-ext.html) 09:40:06 INFO - PROCESS | 20427 | RSS: Main: 169586688 09:40:06 INFO - PROCESS | 20427 | 09:43:08 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:59388/tests/dromaeo/cssquery-ext.html (next: http://localhost:59388/tests/dromaeo/cssquery-jquery.html) 09:43:09 INFO - PROCESS | 20427 | RSS: Main: 167903232 09:43:09 INFO - PROCESS | 20427 | 09:46:11 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:59388/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59388/tests/dromaeo/cssquery-mootools.html) 09:46:11 INFO - PROCESS | 20427 | RSS: Main: 170754048 09:46:11 INFO - PROCESS | 20427 | 09:49:13 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:59388/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59388/tests/dromaeo/cssquery-prototype.html) 09:49:14 INFO - PROCESS | 20427 | RSS: Main: 165875712 09:49:14 INFO - PROCESS | 20427 | 09:52:16 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:59388/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59388/tests/dromaeo/cssquery-yui.html) 09:52:17 INFO - PROCESS | 20427 | RSS: Main: 167845888 09:52:17 INFO - PROCESS | 20427 | 09:55:19 INFO - PROCESS | 20427 | Cycle 1(1): loaded http://localhost:59388/tests/dromaeo/cssquery-yui.html (next: http://localhost:59388/tests/dromaeo/cssquery-dojo.html) 09:55:20 INFO - PROCESS | 20427 | RSS: Main: 170790912 09:55:20 INFO - PROCESS | 20427 | 09:55:20 INFO - PROCESS | 20427 | __start_tp_report 09:55:20 INFO - PROCESS | 20427 | _x_x_mozilla_page_load 09:55:20 INFO - PROCESS | 20427 | _x_x_mozilla_page_load_details 09:55:20 INFO - PROCESS | 20427 | |i|pagename|runs| 09:55:20 INFO - PROCESS | 20427 | |0;dojo.html;3094.0717784664603;3116.8753249870006;3145.4495463293924;3150.4014237294914;3151.4327421064213;5304.867378315544;5400.837974860756;5424.918626220605;5444.972775136119;5474.835754927353;5309.654872433289;5347.598930080249;5355.250264962909;5376.731163441822;5412.4587541245855;4733.455652599952;4843.612510999129;4866.099771542258;4901.607871370282;4979.278004689318;4879.853604391874;4900.019996000797;4903.264510323462;4962.6526143169995;5003.699778013331;4821.590164835976;4828.830990915319;4831.033793241366;4918.827841025547;4959.256111583255;4907.2393778964315;4918.950810491885;4919.409670839486;4923.58149557288;4945.258211268302;4712.64655150865;4830.927536086926;4835.975820120912;4877.219644856806;4906.165951788204;5185.351831021122;5207.765650545734;5275.894482110336;5362.946370536284;5372.758225879845;5710.65736055838;5716.599838011341;5719.342275638313;5721.399253078408;5726.226959360475;5661.179129026309;5755.482006619424;5755.510781583571;5756.65460072397;5769.394213607595;5326.227696983916;5332.626716129873;5357.8392648220615;5413.269208656781;5443.755031023614;5873.588848780544;5895.970520147372;5919.792807251812;5927.110933359944;5928.199693041471;5491.395946445888;5686.60193786431;5689.061304884731;5694.857628559319;5722.341930677942;5656.858578535487;5700.828975130753;5732.627379220337;5784.623999440107;5830.3586605473365;5652.378238393773;5684.744186511534;5772.740226689809;5792.391798861143;5883.470487656132;5768.826935191867;5837.824865254049;5839.737211825393;5845.766169353178;5848.61983971049;4384.934225986613;4414.80133393998;4468.151051300242;4531.3882625845745;4531.977340113344;3988.062805240766;4005.218982298482;4009.699272554512;4041.1715598302276;4043.7978101095414;5555.833325000256;5595.104783234663;5598.608097433141;5605;5614.578906582023;5698.971505142447;5809.215755872903;5850.765969361178;5864.765409383577;5873.647581145145;5605.971970140205;5624.268845050117;5634.3802181759975;5650.5479561634975;5650.7174641267775;5075.3402057733;5088.898222035538;5094.949050509522;5099.133147364957;5129.743512824344;5918.704064796743;6010.338862725097;6028.999999999913;6138.785142519991;6141.692915354214;5799.449052340021;5803.274590676166;5807.128930660435;5859.5019423349495;5869.559783016205;6061.575689701678;6080.2399700037495;6086.6348019119;6087.9391206087375;6090.390960903874;5534.972325138509;5545.029619816597;5574.637648552994;5625.578081643811;5691.3170419549915;5714.000049991318;5739.598228123991;5751.511121554715;5793.739281732416;5813.505852002627;5581.5813813963305;5598.776048957996;5610.49505544503;5611.074172761612;5616.269884914935;5484.396716361117;5576.776928922797;5581.413951535193;5605.5515558756015;5652.265205523256;5578.219049333178;5611.943880561143;5630.774769009194;5631.746571404378;5639;5679.119736440858;5682.204491371129;5692.943070569241;5719.342275638189;5731.684757338387;5454.290942177491;5530.806421775219;5546.778128874961;5568;5599.356074051373 09:55:20 INFO - PROCESS | 20427 | |1;ext.html;550.403597003789;584.3046774338537;594.5897330841719;605.179981125575;626.70231639971;39284.2143157137;43210.135797284034;43217.13565728691;43279.56720432795;43292.91767705809;44067;44537.55462445383;44562;44599;44601.77699111508;8836.690715824947;8867.73396798097;8963.10368963105;8978.820423591524;8981.95509022454;8952.820943581157;9010.774730631721;9044.457332560067;9051.185393314601;9052.77368065797;9041.502717350577;9049.95475022624;9081.909180908206;9110.726678199664;9129;8975.461472311683;8988.550572471382;9001.369904106716;9035.774105647411;9060.954695226515;8862.15809498103;8970.058143894928;8978.371513994023;8982.550872456351;9012.684556040507;41386.58613413887;41732.165356692996;41884.581154188374;41900.58099418997;41912.79043604793;3522.5244591980013;3570.232400033979;3707.4028205025843;3740.4202348636004;3750.887473375803;32796;32934.6706532934;33437.33125337504;33455.498167527505;33562;4156.7921603919685;4164.83340666373;4252.170826688797;4264.381664658607;4318.589733975267;365899;367780;367967.92192468536;368356;368358.9999999973;59047.40952590505;59186;59570.70214648899;59671.403285967455;60045.295696908724;35308;36541.81729091391;62871.37128628747;62984;63081.36918630847;14487.927560362341;14959.102453852804;15093.622659433382;15102.169380683948;15132;10699;10719.892801072045;10736.516856741466;10843.403612801214;10902.5093870776;19333.168194203616;19437.3350792612;19470.987810755938;19517.707234391495;19570.80429195718;7101.254368291358;7170.784876453715;7222;7231.819204519929;7344.339009489172;950.3442624589012;1048.3919326790444;1057.9365238085738;1063.4895250279908;1094.3816743540033;32341.51487727686;32552.348953020806;32768;32865.83567082197;33412.33175336479;1107.8172101603307;1132.4394424759796;1135.3585224348383;1151.1308961734005;1175.6531823112202;17035.829641703425;17236.569085772957;17279.222434990457;17286.481405557854;17322;458353;463369;465556;465974;466388;56511.15233271504;57071;57227.14159287614;57241.713791430775;57327.71336143376;1302.400895588021;1326.476041963419;1328.16325714801;1352.5266156845223;1364.2837510307168;30032.39654966812;31793.523097154022;31911.521327179646;32312.35375292528;33006.669933300356;53540.732296339826;58447;59205.70397148159;59208.40791592029;59295.703521482115;492653;493692;500664;501763;505416;44963;45034;45068.54931450643;45378.54621453743;46020.539794601624;48262.75868620635;50235;50269;50832.74583627058;51257;41341.58658413377;43623;43806;44061.33907991319;44664;42430;42848;43270;44442.333365000195;44707.55292447164;42062.36906446467;42503.3624495639;42552;42870.78564607157;44316;36518.8174059128;38129.809350953066;38249.61750382461;38613.80693096629;39422.408663870636;29400.852995734884;29428;29447;29536.556951646173;29552 09:55:20 INFO - PROCESS | 20427 | |2;jquery.html;378.41345913833567;381.5250013732903;397.60041158635573;397.72358211043326;410.02823308758246;13788;18399.080045997696;18462.261509539636;19938.800611993876;19959.401217963466;18226.908865455654;18302.26790928361;18631.720524192147;18950.526236844085;19030.619387612238;5735.369109397973;5784.508316793057;5834.095715164135;5891.911621325684;5916.467517923386;5703.486686198241;5853.268341457318;5872.9706351468185;5877.70611469427;6996.090508233922;7262.092238470192;7327.963360183192;7368.668409921566;7431.665575049109;7434.7769566913075;7373.926260737378;7445.367143792784;7631.35133513652;7727.995360603142;7818.14000459949;7415.1101867776215;7471.813204669872;7475.8504829903095;7487.064116985377;7512.924870751332;25095.37261568457;26462.867685661447;26893.596596051077;27390.726092739016;27611.585826212624;2459.4712136890653;2492.102842976527;2514.333701569086;2766.349907771672;3212.4538828399227;15803.841961580352;16048.518544443685;16186.595335116599;16301.836981630151;17124.48626541206;2052.4766184622977;2136.700861879338;2202.812760915308;2219.7336319641586;2448.5347783920997;93394;94579;94596;95336.52331738296;96197;17658.5585360367;17806.198721057324;17974.37089701854;18139.909300453677;18332.887157063837;31195.68804311973;31527.527087093713;31572.368552628817;31607.20981975469;31608.841955790074;9331.673391431403;9503.619855205852;9612;9847.704568862802;9875.456849873182;7724.459287849797;7749.7287594933905;7799;8011.759647210476;8020.398470114765;8625.568721563897;8647.956760216284;8685.435446695945;8922.464652120894;9048.140426659456;3436.398630239748;3496.5629296337956;3521.6830485255937;3532.8056956867104;3604.315180115822;967.6129548180784;991.8859331177007;1011.261778901406;1035.1511760356436;1044.7544826965657;19197.32809351666;19703.802961970483;19946.70079948802;20210.696839547418;20254.29109981173;969.762408209993;990.0396615283164;1009.9192064634811;1013.5591017907234;1021.1728499915092;10532.631357902437;11178.496967636313;11195.384253866116;11292.322460652387;11297.491612877277;471397;472931;473366;478860;496429.5535566897;84892.57553712191;90570;93474.52203823678;94389.5280523593;96195;951.9809603807885;953.675750244934;993.7416271769248;1036.0623635609786;1042.7393151712072;17399.56501087483;17984.37054703079;18197.45407637773;18363;18590.349337773114;43346.78326608347;43455.34816977811;44268;44718;44736.77631611821;63190.684046579474;64546.67726661337;64559.354406455335;64814;65109;8012.238837310446;8061.395395345256;8094.190580941859;8187.345012399113;8472.957635211784;9531.618735250513;12499.250044997329;12692.555760548337;12967;13200.66998325011;11316.094712423152;11548.422578870855;11683.941580292045;11765.294082355085;11895.10786691019;11344.432778361213;11419.828702569303;11474.655760327203;12044.75910481803;12070.456829442872;11500.827487587525;11540.94229528847;11870.406479676154;11967.042636588878;12326.691832703895;7336.4130869529245;7655.885161722467;8106;8247.092819789937;8587.570621469027;10866.565337386732;11073.778524429628;11625;11829.408529573315;12020.459079341275 09:55:20 INFO - PROCESS | 20427 | |3;mootools.html;1460.9123452592846;1492.0972811449071;1613.257901365372;1748.2569907789195;1767.3372485318005;8091.2717855393;8742.825143497126;8745;9282.118198771122;9393;8969.865452018208;9267.953660231706;9270.119338662833;9283.071692830714;9298.442093474396;2202.6695995600667;2232.2633530934754;2233.6314508106225;2239.0819763896807;2242.4842286274165;2305.596520608895;2361.6693662887124;2370.5851475991717;2378.0725517048363;2385.9880700596473;2315.81473482121;2329.04509151248;2358.587247231736;2362.9527409451803;2364.9527009459803;2168.815650669695;2173.3262688566597;2180.6183917814396;2184.191849015874;2186.6173419651495;2177;2181.149351752818;2182.552576721784;2190.638544640148;2190.8247340212743;9149.496777677225;9240.445573265626;9286.582103805278;9290.860637090449;9295.349325547215;4966.106100901836;5015.172496538067;5048.066107770074;5054.797808087709;5058.999999999964;3155.7002084801907;3183.602049743782;3261.2173078461237;3272.7709060365783;3285.342931413703;1022.0750221049888;1027.41950797799;1029.0584115534277;1035.502958579886;1051.3691784929058;11585.536578536849;11773.941130294294;11785.116116291312;11803.763924721543;11809.94095029528;4188.099558594917;4421.646268298528;4472.798724057425;4480.350349199413;4490.528494508095;9956.950215248877;10002.49987500622;10002.599896004078;10037.598496060076;10053.195744340435;5053.9494605054215;5055.595552355802;5069.898602027939;5072.594192464594;5074.923876141861;4392.4289842320295;4626.86119416418;4643.930341044887;4779.498152693986;4817.879553011203;3774.4338349247832;3794.79128647927;3831.367824308958;3878.825452854628;3936.527616686016;1202.0744027099086;1222.6036967543537;1222.6332100369852;1231.310466138965;1233.0505510756668;995.7560397702609;997.9950100249597;1007.29992655104;1010.5503051142172;1032.1845741863995;6196.411340922696;6222.421658813869;6295.559310848288;6327.367263273728;6493.967530162319;440.7289516947055;441.7989814634334;443.07176465305133;451.05053861620814;1002.7042022603349;4307.353896915488;4357.237483440385;4437.134758722083;4440.2673558862425;4502.954970450319;11218.102551795837;11467.598634047768;11523.423828808525;11533.88466115328;11682;11535.942320288512;11589.24669896454;11600.593979210687;11611.071114310835;11632.767344653059;8060.153683863227;8264.793380165424;8464.873026904601;8467.110953349933;8633.266172375419;6167.229096362955;6226.813195604139;6316.494680425647;6352.460040896575;6399.6800159992745;10481;10570.947145264225;10696.679099627023;10721.571137154739;10832.945835271088;9558.187554057982;9679.08048735369;9779.119879210904;10743.785124297627;10768.19238557127;7557.130929943127;7678.539287642536;7802.804929876798;8130.83738325242;8297.626606802587;8442.957785211034;8482.745517634481;8560.743177704679;8566.400351975552;8572.699955501528;7601.125870524739;7701.075870895528;7845.097813751263;8013.4791238569305;8051.4766540174705;7453.664585093576;7506.474546781673;7573.848523029619;7611.048618922635;7842.254985776342;6913.585184888922;7026.648667566499;7037.964810175917;7038.542494737826;7063.293670632896;4553.795079221377;4655.231886738786;4697.976510117427;4708.458527269271;4712.410948631421;5110.3356563646485;5188.844334669966;5226.555742761756;5245.947540524546;5290.8941821164135 09:55:20 INFO - PROCESS | 20427 | |4;prototype.html;321.1265358225626;334.4581777520417;337.6134326196505;343.62201578263915;343.7301718151249;5355.651882627626;5441.782328706847;5524.806631767884;5545.085060964941;5587.245721827552;5433.510984011438;5454.61817672763;5470.234167216593;5490.752916118774;5495.917561236584;4275.380069889864;4276.23027854986;4277.930517370657;4285.335772955197;4285.5928686774705;4169.6455801256925;4237.7669228192435;4249.596288352617;4266.978665106686;4281.207976524337;4221.852235171769;4225.176090662322;4235.767032813194;4242.9151416971645;4249.617534421902;4219.683523735732;4236.343366778155;4247.173715302434;4253.893652658678;4263.232618128735;3622.728295377831;3763.924721505582;3765.7363984521094;3766.719315432766;3775.244071827554;5350.100714246425;5351.411344752074;5373.274607927919;5374.381946076212;5378;4799.952000479985;4848.321235027099;4858.46556878743;4860.198067318888;4898.191798353268;5570.3315602127595;5698.943010569924;5711.742971566289;5719.6854173020465;5727.284089488814;4063.207674503473;4066.34938409853;4068.8982775430554;4069.959300407017;4071.491063617048;5917.195255447087;5939.495142912858;5941.524678025748;5947.316058653267;5950.851228719273;4100.507939047334;4178.101708132766;4202.810873510699;4203.78090353794;4210.5157906841105;4201.978990105091;4238.745675259494;4256.382824490432;4268.018355778188;4271.423357846651;4852.757362131879;4855.174620314555;4866.812237984055;4869.099216644932;4892.828750993698;5522.2544956431175;5746.511546518509;5780.855478612984;5797.594168408171;5808.709564521757;1438.2736717957573;1444.833844107941;1449.7680371140777;1453.1789538910482;1456.1699831096385;895.5477483870734;904.7150147703584;921.9124183202586;931.1573026411108;932.5104320231933;4874;4931.235658472942;4938.506149385033;4959.355283813154;4970;5160.535551800281;5222.843314700565;5229.320188375486;5242.663120904145;5249.658772179872;4784.6889952153;4917.934467523649;4958.826441074617;4967.304577359173;4983.127952608279;2775.4310366374843;2775.9306017349727;2777.916662500128;2782;2789.748922596976;5372.328458942632;5390.51485366319;5391;5453.4273901240595;5472.20653005312;5068.315777370081;5246.970321824127;5251.45304527304;5325.440828713007;5326.760295786699;5339.5728341732565;5341.759620817073;5344.759485823147;5358.392482255308;5393.622446428791;5153.510416510426;5197.948020519746;5204.843854684365;5208.3229180207845;5235.8481134150425;4975.900481990412;5099.337086178922;5099.6685215460875;5127.87180320495;5139.280500729826;5401.918971215514;5406.648567843077;5410.458954104715;5417.51242388187;5427.39891731948;3738.4766132741984;3960.128771670228;3966.504186976628;4081.775502347399;4135.883311505816;5743.282089738783;5833.762261944492;5855.707214639337;5855.824325270249;5862.94137058641;5565.30433695788;5667.716614169358;5670.319561652628;5693.5160511357;5727.713614319351;5655.077273726953;5662.094064949588;5677.74450149736;5680.801171958961;5688.890666320028;5607.495325420732;5619.522340601095;5629.802956896489;5636.182753500638;5640.633358831663;5510.972445137749;5700.315962084576;5719.7426115824055;5743.310802703702;5758.769649213985;5577.60956733041;5580.972095139498;5602.691851948182;5612.691301978431;5613.410591887793 09:55:20 INFO - PROCESS | 20427 | |5;yui.html;626.2047200055929;659.8878190707579;711.6477343714859;735.7719107076804;762.2720302111483;14712.92643536782;15953.042817430947;16004.199790010496;16418.26117824698;17107.486775396726;16167.272472738725;16267.593310167253;16314.592135196626;16330.83669163308;16331;809.3646487507308;830.1905641999033;833.8999320081599;834.3116928533984;837.6733074101105;796.3947399976003;815.148170162179;821.9465734727223;825.4098319701412;832.2052439919893;843.8354520868434;844.2950136635885;848.1094850407079;850.6809946270149;851.8637018077109;839.3998291221775;841.5077179849795;842.6292431330256;842.6418772021897;843.1989609870586;611.626907586372;613.310026220502;616.2081724983419;618.4897459595851;620.7206756959341;15394.461193858273;15477.22613869302;15492.22538873063;15511;15518;13890.722185556333;14330.57008289753;14530.418783248657;14532.128072315589;14549.781753273604;12148.45331960055;12517.147973920111;12558.246505209625;12704.872951270461;13171.407286672124;3676.852925882988;3688.4467329900463;3774.2828862516035;3891.9686283134993;3909.843606255746;78960;79142;79161.60419197925;79777.60111199465;80425;11483.483243254073;11666.70833229176;11798.882011179778;11920.642380728592;12291.93854030742;22008.229711960004;22037.11851525921;22065.33803985883;22076.116955321606;22077.668834967488;8232.547209903512;8241.752747417588;8350.916490835136;8515.233628973423;8634.827303453896;4456.420665313489;4834.734089625034;4868.269759536027;4938.876528086755;5075.959428317186;3301.570795796531;3384.5430866833153;3393.9490907636405;3394.6096198936943;3397.5922889253447;589.7198830555452;592.6503363015755;603.5171862510063;606.9119977603311;614.7295190116424;595.4333542082892;602.686602966455;623.4544773323342;722.1009842745815;723.9167495737952;9638.277129215197;9670.903290967;9771.902280977241;9981.500924953723;10233.9488302558;636.5957616913294;696.8571442854203;700.2192555300803;718.6489399928101;730.1967835381145;4681.32120842476;4709.293605959065;4845.878853028632;4847.297141914473;4849.369581954324;118316.40841795735;120665;121101.39449302696;121625;126741;102388;103134.48432757788;104669.47665261626;105482.47258763811;108084.45957770318;88372;89876.5506172465;91066;92367.53816230876;93896;8832.205101540892;8918.19736223743;8982.236509896471;9011.909880901107;9067.410618309788;52389.476105239984;52516;53295;54367.45632543624;55053.72473137609;43873.56126438823;44858.10283794371;48579.51420485891;74212;77452.61273693596;9822.21422286201;10843.945780271048;11689.240199387013;11734.530618775154;11756.353400563052;11970.58102966392;12249.448774804978;12450.06624503184;12530.937345313216;13025.413856376676;12571.37143142821;12756.936215318863;12815.807762883378;12968.67578310512;13376.788157731062;11753.588624398106;11837.526498939946;11840.526378945091;11968.3121265516;12215.938920305342;10972.890271097187;11143.665690029313;11262.493187806733;11320.830187547359;11687.415629218674;10016.549255283384;10089;10122.190224782147;10144.54349554257;10395.220358472994;8727.607257673293;9721.125098741148;10137.189024877845;10141.594336226468;10210.234232432449 09:55:20 INFO - PROCESS | 20427 | __end_tp_report 09:55:20 INFO - PROCESS | 20427 | __start_cc_report 09:55:20 INFO - PROCESS | 20427 | _x_x_mozilla_cycle_collect,346 09:55:20 INFO - PROCESS | 20427 | __end_cc_report 09:55:20 INFO - PROCESS | 20427 | __startTimestamp1469811320196__endTimestamp 09:55:20 INFO - PROCESS | 20427 | 09:55:20 INFO - PROCESS | 20427 | ------- Summary: start ------- 09:55:20 INFO - PROCESS | 20427 | Number of tests: 6 09:55:20 INFO - PROCESS | 20427 | 09:55:20 INFO - PROCESS | 20427 | [#0] dojo.html Cycles:165 Average:5373.18 Median:5599.36 stddev:608.16 (10.9%) stddev-sans-first:583.15 09:55:20 INFO - PROCESS | 20427 | Values: 3094.1 3116.9 3145.4 3150.4 3151.4 5304.9 5400.8 5424.9 5445.0 5474.8 5309.7 5347.6 5355.3 5376.7 5412.5 4733.5 4843.6 4866.1 4901.6 4979.3 4879.9 4900.0 4903.3 4962.7 5003.7 4821.6 4828.8 4831.0 4918.8 4959.3 4907.2 4919.0 4919.4 4923.6 4945.3 4712.6 4830.9 4836.0 4877.2 4906.2 5185.4 5207.8 5275.9 5362.9 5372.8 5710.7 5716.6 5719.3 5721.4 5726.2 5661.2 5755.5 5755.5 5756.7 5769.4 5326.2 5332.6 5357.8 5413.3 5443.8 5873.6 5896.0 5919.8 5927.1 5928.2 5491.4 5686.6 5689.1 5694.9 5722.3 5656.9 5700.8 5732.6 5784.6 5830.4 5652.4 5684.7 5772.7 5792.4 5883.5 5768.8 5837.8 5839.7 5845.8 5848.6 4384.9 4414.8 4468.2 4531.4 4532.0 3988.1 4005.2 4009.7 4041.2 4043.8 5555.8 5595.1 5598.6 5605.0 5614.6 5699.0 5809.2 5850.8 5864.8 5873.6 5606.0 5624.3 5634.4 5650.5 5650.7 5075.3 5088.9 5094.9 5099.1 5129.7 5918.7 6010.3 6029.0 6138.8 6141.7 5799.4 5803.3 5807.1 5859.5 5869.6 6061.6 6080.2 6086.6 6087.9 6090.4 5535.0 5545.0 5574.6 5625.6 5691.3 5714.0 5739.6 5751.5 5793.7 5813.5 5581.6 5598.8 5610.5 5611.1 5616.3 5484.4 5576.8 5581.4 5605.6 5652.3 5578.2 5611.9 5630.8 5631.7 5639.0 5679.1 5682.2 5692.9 5719.3 5731.7 5454.3 5530.8 5546.8 5568.0 5599.4 09:55:20 INFO - PROCESS | 20427 | 09:55:20 INFO - PROCESS | 20427 | [#1] ext.html Cycles:180 Average:61203.33 Median:43243.57 stddev:118208.83 (273.4%) stddev-sans-first:118452.72 09:55:20 INFO - PROCESS | 20427 | Values: 550.4 584.3 594.6 605.2 626.7 39284.2 43210.1 43217.1 43279.6 43292.9 44067.0 44537.6 44562.0 44599.0 44601.8 8836.7 8867.7 8963.1 8978.8 8982.0 8952.8 9010.8 9044.5 9051.2 9052.8 9041.5 9050.0 9081.9 9110.7 9129.0 8975.5 8988.6 9001.4 9035.8 9061.0 8862.2 8970.1 8978.4 8982.6 9012.7 41386.6 41732.2 41884.6 41900.6 41912.8 3522.5 3570.2 3707.4 3740.4 3750.9 32796.0 32934.7 33437.3 33455.5 33562.0 4156.8 4164.8 4252.2 4264.4 4318.6 365899.0 367780.0 367967.9 368356.0 368359.0 59047.4 59186.0 59570.7 59671.4 60045.3 35308.0 36541.8 62871.4 62984.0 63081.4 14487.9 14959.1 15093.6 15102.2 15132.0 10699.0 10719.9 10736.5 10843.4 10902.5 19333.2 19437.3 19471.0 19517.7 19570.8 7101.3 7170.8 7222.0 7231.8 7344.3 950.3 1048.4 1057.9 1063.5 1094.4 32341.5 32552.3 32768.0 32865.8 33412.3 1107.8 1132.4 1135.4 1151.1 1175.7 17035.8 17236.6 17279.2 17286.5 17322.0 458353.0 463369.0 465556.0 465974.0 466388.0 56511.2 57071.0 57227.1 57241.7 57327.7 1302.4 1326.5 1328.2 1352.5 1364.3 30032.4 31793.5 31911.5 32312.4 33006.7 53540.7 58447.0 59205.7 59208.4 59295.7 492653.0 493692.0 500664.0 501763.0 505416.0 44963.0 45034.0 45068.5 45378.5 46020.5 48262.8 50235.0 50269.0 50832.7 51257.0 41341.6 43623.0 43806.0 44061.3 44664.0 42430.0 42848.0 43270.0 44442.3 44707.6 42062.4 42503.4 42552.0 42870.8 44316.0 36518.8 38129.8 38249.6 38613.8 39422.4 29400.9 29428.0 29447.0 29536.6 29552.0 09:55:20 INFO - PROCESS | 20427 | 09:55:20 INFO - PROCESS | 20427 | [#2] jquery.html Cycles:180 Average:30542.87 Median:3568.56 stddev:79146.07 (2217.9%) stddev-sans-first:79335.69 09:55:20 INFO - PROCESS | 20427 | Values: 378.4 381.5 397.6 397.7 410.0 13788.0 18399.1 18462.3 19938.8 19959.4 18226.9 18302.3 18631.7 18950.5 19030.6 5735.4 5784.5 5834.1 5891.9 5916.5 5703.5 5853.3 5873.0 5877.7 6996.1 7262.1 7328.0 7368.7 7431.7 7434.8 7373.9 7445.4 7631.4 7728.0 7818.1 7415.1 7471.8 7475.9 7487.1 7512.9 25095.4 26462.9 26893.6 27390.7 27611.6 2459.5 2492.1 2514.3 2766.3 3212.5 15803.8 16048.5 16186.6 16301.8 17124.5 2052.5 2136.7 2202.8 2219.7 2448.5 93394.0 94579.0 94596.0 95336.5 96197.0 17658.6 17806.2 17974.4 18139.9 18332.9 31195.7 31527.5 31572.4 31607.2 31608.8 9331.7 9503.6 9612.0 9847.7 9875.5 7724.5 7749.7 7799.0 8011.8 8020.4 8625.6 8648.0 8685.4 8922.5 9048.1 3436.4 3496.6 3521.7 3532.8 3604.3 967.6 991.9 1011.3 1035.2 1044.8 19197.3 19703.8 19946.7 20210.7 20254.3 969.8 990.0 1009.9 1013.6 1021.2 10532.6 11178.5 11195.4 11292.3 11297.5 471397.0 472931.0 473366.0 478860.0 496429.6 84892.6 90570.0 93474.5 94389.5 96195.0 952.0 953.7 993.7 1036.1 1042.7 17399.6 17984.4 18197.5 18363.0 18590.3 43346.8 43455.3 44268.0 44718.0 44736.8 63190.7 64546.7 64559.4 64814.0 65109.0 8012.2 8061.4 8094.2 8187.3 8473.0 9531.6 12499.3 12692.6 12967.0 13200.7 11316.1 11548.4 11683.9 11765.3 11895.1 11344.4 11419.8 11474.7 12044.8 12070.5 11500.8 11540.9 11870.4 11967.0 12326.7 7336.4 7655.9 8106.0 8247.1 8587.6 10866.6 11073.8 11625.0 11829.4 12020.5 09:55:20 INFO - PROCESS | 20427 | 09:55:20 INFO - PROCESS | 20427 | [#3] mootools.html Cycles:180 Average:5834.33 Median:4476.57 stddev:3406.74 (76.1%) stddev-sans-first:3400.44 09:55:20 INFO - PROCESS | 20427 | Values: 1460.9 1492.1 1613.3 1748.3 1767.3 8091.3 8742.8 8745.0 9282.1 9393.0 8969.9 9268.0 9270.1 9283.1 9298.4 2202.7 2232.3 2233.6 2239.1 2242.5 2305.6 2361.7 2370.6 2378.1 2386.0 2315.8 2329.0 2358.6 2363.0 2365.0 2168.8 2173.3 2180.6 2184.2 2186.6 2177.0 2181.1 2182.6 2190.6 2190.8 9149.5 9240.4 9286.6 9290.9 9295.3 4966.1 5015.2 5048.1 5054.8 5059.0 3155.7 3183.6 3261.2 3272.8 3285.3 1022.1 1027.4 1029.1 1035.5 1051.4 11585.5 11773.9 11785.1 11803.8 11809.9 4188.1 4421.6 4472.8 4480.4 4490.5 9957.0 10002.5 10002.6 10037.6 10053.2 5053.9 5055.6 5069.9 5072.6 5074.9 4392.4 4626.9 4643.9 4779.5 4817.9 3774.4 3794.8 3831.4 3878.8 3936.5 1202.1 1222.6 1222.6 1231.3 1233.1 995.8 998.0 1007.3 1010.6 1032.2 6196.4 6222.4 6295.6 6327.4 6494.0 440.7 441.8 443.1 451.1 1002.7 4307.4 4357.2 4437.1 4440.3 4503.0 11218.1 11467.6 11523.4 11533.9 11682.0 11535.9 11589.2 11600.6 11611.1 11632.8 8060.2 8264.8 8464.9 8467.1 8633.3 6167.2 6226.8 6316.5 6352.5 6399.7 10481.0 10570.9 10696.7 10721.6 10832.9 9558.2 9679.1 9779.1 10743.8 10768.2 7557.1 7678.5 7802.8 8130.8 8297.6 8443.0 8482.7 8560.7 8566.4 8572.7 7601.1 7701.1 7845.1 8013.5 8051.5 7453.7 7506.5 7573.8 7611.0 7842.3 6913.6 7026.6 7038.0 7038.5 7063.3 4553.8 4655.2 4698.0 4708.5 4712.4 5110.3 5188.8 5226.6 5245.9 5290.9 09:55:20 INFO - PROCESS | 20427 | 09:55:20 INFO - PROCESS | 20427 | [#4] prototype.html Cycles:180 Average:4637.98 Median:5215.58 stddev:1340.09 (25.7%) stddev-sans-first:1304.09 09:55:20 INFO - PROCESS | 20427 | Values: 321.1 334.5 337.6 343.6 343.7 5355.7 5441.8 5524.8 5545.1 5587.2 5433.5 5454.6 5470.2 5490.8 5495.9 4275.4 4276.2 4277.9 4285.3 4285.6 4169.6 4237.8 4249.6 4267.0 4281.2 4221.9 4225.2 4235.8 4242.9 4249.6 4219.7 4236.3 4247.2 4253.9 4263.2 3622.7 3763.9 3765.7 3766.7 3775.2 5350.1 5351.4 5373.3 5374.4 5378.0 4800.0 4848.3 4858.5 4860.2 4898.2 5570.3 5698.9 5711.7 5719.7 5727.3 4063.2 4066.3 4068.9 4070.0 4071.5 5917.2 5939.5 5941.5 5947.3 5950.9 4100.5 4178.1 4202.8 4203.8 4210.5 4202.0 4238.7 4256.4 4268.0 4271.4 4852.8 4855.2 4866.8 4869.1 4892.8 5522.3 5746.5 5780.9 5797.6 5808.7 1438.3 1444.8 1449.8 1453.2 1456.2 895.5 904.7 921.9 931.2 932.5 4874.0 4931.2 4938.5 4959.4 4970.0 5160.5 5222.8 5229.3 5242.7 5249.7 4784.7 4917.9 4958.8 4967.3 4983.1 2775.4 2775.9 2777.9 2782.0 2789.7 5372.3 5390.5 5391.0 5453.4 5472.2 5068.3 5247.0 5251.5 5325.4 5326.8 5339.6 5341.8 5344.8 5358.4 5393.6 5153.5 5197.9 5204.8 5208.3 5235.8 4975.9 5099.3 5099.7 5127.9 5139.3 5401.9 5406.6 5410.5 5417.5 5427.4 3738.5 3960.1 3966.5 4081.8 4135.9 5743.3 5833.8 5855.7 5855.8 5862.9 5565.3 5667.7 5670.3 5693.5 5727.7 5655.1 5662.1 5677.7 5680.8 5688.9 5607.5 5619.5 5629.8 5636.2 5640.6 5511.0 5700.3 5719.7 5743.3 5758.8 5577.6 5581.0 5602.7 5612.7 5613.4 09:55:20 INFO - PROCESS | 20427 | 09:55:20 INFO - PROCESS | 20427 | [#5] yui.html Cycles:180 Average:20758.35 Median:24769.71 stddev:30965.55 (125.0%) stddev-sans-first:31015.52 09:55:20 INFO - PROCESS | 20427 | Values: 626.2 659.9 711.6 735.8 762.3 14712.9 15953.0 16004.2 16418.3 17107.5 16167.3 16267.6 16314.6 16330.8 16331.0 809.4 830.2 833.9 834.3 837.7 796.4 815.1 821.9 825.4 832.2 843.8 844.3 848.1 850.7 851.9 839.4 841.5 842.6 842.6 843.2 611.6 613.3 616.2 618.5 620.7 15394.5 15477.2 15492.2 15511.0 15518.0 13890.7 14330.6 14530.4 14532.1 14549.8 12148.5 12517.1 12558.2 12704.9 13171.4 3676.9 3688.4 3774.3 3892.0 3909.8 78960.0 79142.0 79161.6 79777.6 80425.0 11483.5 11666.7 11798.9 11920.6 12291.9 22008.2 22037.1 22065.3 22076.1 22077.7 8232.5 8241.8 8350.9 8515.2 8634.8 4456.4 4834.7 4868.3 4938.9 5076.0 3301.6 3384.5 3393.9 3394.6 3397.6 589.7 592.7 603.5 606.9 614.7 595.4 602.7 623.5 722.1 723.9 9638.3 9670.9 9771.9 9981.5 10233.9 636.6 696.9 700.2 718.6 730.2 4681.3 4709.3 4845.9 4847.3 4849.4 118316.4 120665.0 121101.4 121625.0 126741.0 102388.0 103134.5 104669.5 105482.5 108084.5 88372.0 89876.6 91066.0 92367.5 93896.0 8832.2 8918.2 8982.2 9011.9 9067.4 52389.5 52516.0 53295.0 54367.5 55053.7 43873.6 44858.1 48579.5 74212.0 77452.6 9822.2 10843.9 11689.2 11734.5 11756.4 11970.6 12249.4 12450.1 12530.9 13025.4 12571.4 12756.9 12815.8 12968.7 13376.8 11753.6 11837.5 11840.5 11968.3 12215.9 10972.9 11143.7 11262.5 11320.8 11687.4 10016.5 10089.0 10122.2 10144.5 10395.2 8727.6 9721.1 10137.2 10141.6 10210.2 09:55:20 INFO - PROCESS | 20427 | -------- Summary: end -------- 09:55:20 INFO - PROCESS | 20427 | 09:55:20 INFO - TEST-INFO | 20427: exit 0 09:55:20 INFO - TEST-OK | dromaeo_css | took 1111623ms 09:55:20 INFO - TEST-START | kraken 09:55:20 INFO - operating with platform_type : linux_ 09:55:20 INFO - Initialising browser for kraken test... 09:55:20 INFO - TEST-INFO | started process 20676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWqEttk/profile http://localhost:59388/getInfo.html) 09:55:24 INFO - PROCESS | 20676 | JavaScript error: , line 0: uncaught exception: undefined 09:55:25 INFO - PROCESS | 20676 | __metrics Screen width/height:1600/1200 09:55:25 INFO - PROCESS | 20676 | colorDepth:24 09:55:25 INFO - PROCESS | 20676 | Browser inner width/height: 1024/697 09:55:25 INFO - PROCESS | 20676 | __metrics 09:55:25 ERROR - PROCESS | 20676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:55:26 INFO - TEST-INFO | 20676: exit 0 09:55:26 INFO - Browser initialized. 09:55:26 INFO - Running cycle 1/1 for kraken test... 09:55:26 INFO - TEST-INFO | started process 20793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWqEttk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:38 INFO - PROCESS | 20793 | RSS: Main: 165261312 09:55:38 INFO - PROCESS | 20793 | 09:55:40 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59388/tests/kraken/driver.html?testName=audio-beat-detection) 09:55:41 INFO - PROCESS | 20793 | RSS: Main: 170713088 09:55:41 INFO - PROCESS | 20793 | 09:55:44 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59388/tests/kraken/driver.html?testName=audio-dft) 09:55:45 INFO - PROCESS | 20793 | RSS: Main: 169492480 09:55:45 INFO - PROCESS | 20793 | 09:55:48 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59388/tests/kraken/driver.html?testName=audio-fft) 09:55:48 INFO - PROCESS | 20793 | RSS: Main: 165031936 09:55:48 INFO - PROCESS | 20793 | 09:55:50 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59388/tests/kraken/driver.html?testName=audio-oscillator) 09:55:51 INFO - PROCESS | 20793 | RSS: Main: 166146048 09:55:51 INFO - PROCESS | 20793 | 09:55:53 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59388/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:54 INFO - PROCESS | 20793 | RSS: Main: 166629376 09:55:54 INFO - PROCESS | 20793 | 09:55:57 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59388/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:57 INFO - PROCESS | 20793 | RSS: Main: 166387712 09:55:57 INFO - PROCESS | 20793 | 09:56:01 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59388/tests/kraken/driver.html?testName=imaging-desaturate) 09:56:02 INFO - PROCESS | 20793 | RSS: Main: 164151296 09:56:02 INFO - PROCESS | 20793 | 09:56:04 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59388/tests/kraken/driver.html?testName=json-parse-financial) 09:56:05 INFO - PROCESS | 20793 | RSS: Main: 166473728 09:56:05 INFO - PROCESS | 20793 | 09:56:07 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59388/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:56:07 INFO - PROCESS | 20793 | RSS: Main: 166707200 09:56:07 INFO - PROCESS | 20793 | 09:56:09 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59388/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:56:10 INFO - PROCESS | 20793 | RSS: Main: 166694912 09:56:10 INFO - PROCESS | 20793 | 09:56:12 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59388/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:56:12 INFO - PROCESS | 20793 | RSS: Main: 167387136 09:56:12 INFO - PROCESS | 20793 | 09:56:15 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:56:16 INFO - PROCESS | 20793 | RSS: Main: 167014400 09:56:16 INFO - PROCESS | 20793 | 09:56:18 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:19 INFO - PROCESS | 20793 | RSS: Main: 167600128 09:56:19 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | Cycle 1(1): loaded http://localhost:59388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59388/tests/kraken/driver.html?testName=ai-astar) 09:56:21 INFO - PROCESS | 20793 | RSS: Main: 169058304 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | __start_tp_report 09:56:21 INFO - PROCESS | 20793 | _x_x_mozilla_page_load 09:56:21 INFO - PROCESS | 20793 | _x_x_mozilla_page_load_details 09:56:21 INFO - PROCESS | 20793 | |i|pagename|runs| 09:56:21 INFO - PROCESS | 20793 | |0;ai-astar;105;112;106;111;112;110;113;111;111;113 09:56:21 INFO - PROCESS | 20793 | |1;audio-beat-detection;150;117;146;178;119;147;145;120;190;124 09:56:21 INFO - PROCESS | 20793 | |2;audio-dft;162;163;163;161;162;165;169;162;163;163 09:56:21 INFO - PROCESS | 20793 | |3;audio-fft;77;78;75;180;76;77;77;76;168;76 09:56:21 INFO - PROCESS | 20793 | |4;audio-oscillator;86;83;146;84;84;85;132;84;84;156 09:56:21 INFO - PROCESS | 20793 | |5;imaging-gaussian-blur;117;119;117;117;118;117;124;117;118;118 09:56:21 INFO - PROCESS | 20793 | |6;imaging-darkroom;146;147;147;148;149;147;148;147;149;148 09:56:21 INFO - PROCESS | 20793 | |7;imaging-desaturate;97;96;95;95;95;95;95;96;95;95 09:56:21 INFO - PROCESS | 20793 | |8;json-parse-financial;55;53;57;53;53;55;55;54;53;61 09:56:21 INFO - PROCESS | 20793 | |9;json-stringify-tinderbox;64;64;64;64;64;64;63;64;64;64 09:56:21 INFO - PROCESS | 20793 | |10;stanford-crypto-aes;75;85;76;82;77;77;76;78;83;77 09:56:21 INFO - PROCESS | 20793 | |11;stanford-crypto-ccm;126;127;147;131;126;130;140;124;167;130 09:56:21 INFO - PROCESS | 20793 | |12;stanford-crypto-pbkdf2;175;166;161;166;167;168;165;175;165;161 09:56:21 INFO - PROCESS | 20793 | |13;stanford-crypto-sha256-iterative;64;67;65;65;64;64;66;64;64;64 09:56:21 INFO - PROCESS | 20793 | __end_tp_report 09:56:21 INFO - PROCESS | 20793 | __start_cc_report 09:56:21 INFO - PROCESS | 20793 | _x_x_mozilla_cycle_collect,887 09:56:21 INFO - PROCESS | 20793 | __end_cc_report 09:56:21 INFO - PROCESS | 20793 | __startTimestamp1469811381518__endTimestamp 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | ------- Summary: start ------- 09:56:21 INFO - PROCESS | 20793 | Number of tests: 14 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:2.76 (2.5%) stddev-sans-first:2.12 09:56:21 INFO - PROCESS | 20793 | Values: 105.0 112.0 106.0 111.0 112.0 110.0 113.0 111.0 111.0 113.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:146.50 stddev:25.06 (17.1%) stddev-sans-first:26.47 09:56:21 INFO - PROCESS | 20793 | Values: 150.0 117.0 146.0 178.0 119.0 147.0 145.0 120.0 190.0 124.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.26 (1.4%) stddev-sans-first:2.35 09:56:21 INFO - PROCESS | 20793 | Values: 162.0 163.0 163.0 161.0 162.0 165.0 169.0 162.0 163.0 163.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.50 stddev:41.21 (53.9%) stddev-sans-first:43.14 09:56:21 INFO - PROCESS | 20793 | Values: 77.0 78.0 75.0 180.0 76.0 77.0 77.0 76.0 168.0 76.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:84.00 stddev:29.73 (35.4%) stddev-sans-first:30.93 09:56:21 INFO - PROCESS | 20793 | Values: 86.0 83.0 146.0 84.0 84.0 85.0 132.0 84.0 84.0 156.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:2.15 (1.8%) stddev-sans-first:2.24 09:56:21 INFO - PROCESS | 20793 | Values: 117.0 119.0 117.0 117.0 118.0 117.0 124.0 117.0 118.0 118.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:0.83 09:56:21 INFO - PROCESS | 20793 | Values: 146.0 147.0 147.0 148.0 149.0 147.0 148.0 147.0 149.0 148.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.44 09:56:21 INFO - PROCESS | 20793 | Values: 97.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:2.51 (4.6%) stddev-sans-first:2.67 09:56:21 INFO - PROCESS | 20793 | Values: 55.0 53.0 57.0 53.0 53.0 55.0 55.0 54.0 53.0 61.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 09:56:21 INFO - PROCESS | 20793 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 64.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:77.50 stddev:3.44 (4.4%) stddev-sans-first:3.39 09:56:21 INFO - PROCESS | 20793 | Values: 75.0 85.0 76.0 82.0 77.0 77.0 76.0 78.0 83.0 77.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:130.50 stddev:13.36 (10.2%) stddev-sans-first:13.78 09:56:21 INFO - PROCESS | 20793 | Values: 126.0 127.0 147.0 131.0 126.0 130.0 140.0 124.0 167.0 130.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:166.50 stddev:4.84 (2.9%) stddev-sans-first:4.15 09:56:21 INFO - PROCESS | 20793 | Values: 175.0 166.0 161.0 166.0 167.0 168.0 165.0 175.0 165.0 161.0 09:56:21 INFO - PROCESS | 20793 | 09:56:21 INFO - PROCESS | 20793 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.50 stddev:1.06 (1.6%) stddev-sans-first:1.09 09:56:21 INFO - PROCESS | 20793 | Values: 64.0 67.0 65.0 65.0 64.0 64.0 66.0 64.0 64.0 64.0 09:56:21 INFO - PROCESS | 20793 | -------- Summary: end -------- 09:56:21 INFO - PROCESS | 20793 | 09:56:22 INFO - TEST-INFO | 20793: exit 0 09:56:22 INFO - TEST-OK | kraken | took 61598ms 09:56:22 INFO - SUITE-END | took 1173s 09:56:22 INFO - Completed test suite (00:19:33) 09:56:22 INFO - javascript benchmark 09:56:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7380.726413618255, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.0717784664603, 3116.8753249870006, 3145.4495463293924, 3150.4014237294914, 3151.4327421064213, 5304.867378315544, 5400.837974860756, 5424.918626220605, 5444.972775136119, 5474.835754927353, 5309.654872433289, 5347.598930080249, 5355.250264962909, 5376.731163441822, 5412.4587541245855, 4733.455652599952, 4843.612510999129, 4866.099771542258, 4901.607871370282, 4979.278004689318, 4879.853604391874, 4900.019996000797, 4903.264510323462, 4962.6526143169995, 5003.699778013331, 4821.590164835976, 4828.830990915319, 4831.033793241366, 4918.827841025547, 4959.256111583255, 4907.2393778964315, 4918.950810491885, 4919.409670839486, 4923.58149557288, 4945.258211268302, 4712.64655150865, 4830.927536086926, 4835.975820120912, 4877.219644856806, 4906.165951788204, 5185.351831021122, 5207.765650545734, 5275.894482110336, 5362.946370536284, 5372.758225879845, 5710.65736055838, 5716.599838011341, 5719.342275638313, 5721.399253078408, 5726.226959360475, 5661.179129026309, 5755.482006619424, 5755.510781583571, 5756.65460072397, 5769.394213607595, 5326.227696983916, 5332.626716129873, 5357.8392648220615, 5413.269208656781, 5443.755031023614, 5873.588848780544, 5895.970520147372, 5919.792807251812, 5927.110933359944, 5928.199693041471, 5491.395946445888, 5686.60193786431, 5689.061304884731, 5694.857628559319, 5722.341930677942, 5656.858578535487, 5700.828975130753, 5732.627379220337, 5784.623999440107, 5830.3586605473365, 5652.378238393773, 5684.744186511534, 5772.740226689809, 5792.391798861143, 5883.470487656132, 5768.826935191867, 5837.824865254049, 5839.737211825393, 5845.766169353178, 5848.61983971049, 4384.934225986613, 4414.80133393998, 4468.151051300242, 4531.3882625845745, 4531.977340113344, 3988.062805240766, 4005.218982298482, 4009.699272554512, 4041.1715598302276, 4043.7978101095414, 5555.833325000256, 5595.104783234663, 5598.608097433141, 5605.0, 5614.578906582023, 5698.971505142447, 5809.215755872903, 5850.765969361178, 5864.765409383577, 5873.647581145145, 5605.971970140205, 5624.268845050117, 5634.3802181759975, 5650.5479561634975, 5650.7174641267775, 5075.3402057733, 5088.898222035538, 5094.949050509522, 5099.133147364957, 5129.743512824344, 5918.704064796743, 6010.338862725097, 6028.999999999913, 6138.785142519991, 6141.692915354214, 5799.449052340021, 5803.274590676166, 5807.128930660435, 5859.5019423349495, 5869.559783016205, 6061.575689701678, 6080.2399700037495, 6086.6348019119, 6087.9391206087375, 6090.390960903874, 5534.972325138509, 5545.029619816597, 5574.637648552994, 5625.578081643811, 5691.3170419549915, 5714.000049991318, 5739.598228123991, 5751.511121554715, 5793.739281732416, 5813.505852002627, 5581.5813813963305, 5598.776048957996, 5610.49505544503, 5611.074172761612, 5616.269884914935, 5484.396716361117, 5576.776928922797, 5581.413951535193, 5605.5515558756015, 5652.265205523256, 5578.219049333178, 5611.943880561143, 5630.774769009194, 5631.746571404378, 5639.0, 5679.119736440858, 5682.204491371129, 5692.943070569241, 5719.342275638189, 5731.684757338387, 5454.290942177491, 5530.806421775219, 5546.778128874961, 5568.0, 5599.356074051373], "value": 5332.424747755335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.403597003789, 584.3046774338537, 594.5897330841719, 605.179981125575, 626.70231639971, 39284.2143157137, 43210.135797284034, 43217.13565728691, 43279.56720432795, 43292.91767705809, 44067.0, 44537.55462445383, 44562.0, 44599.0, 44601.77699111508, 8836.690715824947, 8867.73396798097, 8963.10368963105, 8978.820423591524, 8981.95509022454, 8952.820943581157, 9010.774730631721, 9044.457332560067, 9051.185393314601, 9052.77368065797, 9041.502717350577, 9049.95475022624, 9081.909180908206, 9110.726678199664, 9129.0, 8975.461472311683, 8988.550572471382, 9001.369904106716, 9035.774105647411, 9060.954695226515, 8862.15809498103, 8970.058143894928, 8978.371513994023, 8982.550872456351, 9012.684556040507, 41386.58613413887, 41732.165356692996, 41884.581154188374, 41900.58099418997, 41912.79043604793, 3522.5244591980013, 3570.232400033979, 3707.4028205025843, 3740.4202348636004, 3750.887473375803, 32796.0, 32934.6706532934, 33437.33125337504, 33455.498167527505, 33562.0, 4156.7921603919685, 4164.83340666373, 4252.170826688797, 4264.381664658607, 4318.589733975267, 365899.0, 367780.0, 367967.92192468536, 368356.0, 368358.9999999973, 59047.40952590505, 59186.0, 59570.70214648899, 59671.403285967455, 60045.295696908724, 35308.0, 36541.81729091391, 62871.37128628747, 62984.0, 63081.36918630847, 14487.927560362341, 14959.102453852804, 15093.622659433382, 15102.169380683948, 15132.0, 10699.0, 10719.892801072045, 10736.516856741466, 10843.403612801214, 10902.5093870776, 19333.168194203616, 19437.3350792612, 19470.987810755938, 19517.707234391495, 19570.80429195718, 7101.254368291358, 7170.784876453715, 7222.0, 7231.819204519929, 7344.339009489172, 950.3442624589012, 1048.3919326790444, 1057.9365238085738, 1063.4895250279908, 1094.3816743540033, 32341.51487727686, 32552.348953020806, 32768.0, 32865.83567082197, 33412.33175336479, 1107.8172101603307, 1132.4394424759796, 1135.3585224348383, 1151.1308961734005, 1175.6531823112202, 17035.829641703425, 17236.569085772957, 17279.222434990457, 17286.481405557854, 17322.0, 458353.0, 463369.0, 465556.0, 465974.0, 466388.0, 56511.15233271504, 57071.0, 57227.14159287614, 57241.713791430775, 57327.71336143376, 1302.400895588021, 1326.476041963419, 1328.16325714801, 1352.5266156845223, 1364.2837510307168, 30032.39654966812, 31793.523097154022, 31911.521327179646, 32312.35375292528, 33006.669933300356, 53540.732296339826, 58447.0, 59205.70397148159, 59208.40791592029, 59295.703521482115, 492653.0, 493692.0, 500664.0, 501763.0, 505416.0, 44963.0, 45034.0, 45068.54931450643, 45378.54621453743, 46020.539794601624, 48262.75868620635, 50235.0, 50269.0, 50832.74583627058, 51257.0, 41341.58658413377, 43623.0, 43806.0, 44061.33907991319, 44664.0, 42430.0, 42848.0, 43270.0, 44442.333365000195, 44707.55292447164, 42062.36906446467, 42503.3624495639, 42552.0, 42870.78564607157, 44316.0, 36518.8174059128, 38129.809350953066, 38249.61750382461, 38613.80693096629, 39422.408663870636, 29400.852995734884, 29428.0, 29447.0, 29536.556951646173, 29552.0], "value": 20499.373473167157, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.41345913833567, 381.5250013732903, 397.60041158635573, 397.72358211043326, 410.02823308758246, 13788.0, 18399.080045997696, 18462.261509539636, 19938.800611993876, 19959.401217963466, 18226.908865455654, 18302.26790928361, 18631.720524192147, 18950.526236844085, 19030.619387612238, 5735.369109397973, 5784.508316793057, 5834.095715164135, 5891.911621325684, 5916.467517923386, 5703.486686198241, 5853.268341457318, 5872.9706351468185, 5877.70611469427, 6996.090508233922, 7262.092238470192, 7327.963360183192, 7368.668409921566, 7431.665575049109, 7434.7769566913075, 7373.926260737378, 7445.367143792784, 7631.35133513652, 7727.995360603142, 7818.14000459949, 7415.1101867776215, 7471.813204669872, 7475.8504829903095, 7487.064116985377, 7512.924870751332, 25095.37261568457, 26462.867685661447, 26893.596596051077, 27390.726092739016, 27611.585826212624, 2459.4712136890653, 2492.102842976527, 2514.333701569086, 2766.349907771672, 3212.4538828399227, 15803.841961580352, 16048.518544443685, 16186.595335116599, 16301.836981630151, 17124.48626541206, 2052.4766184622977, 2136.700861879338, 2202.812760915308, 2219.7336319641586, 2448.5347783920997, 93394.0, 94579.0, 94596.0, 95336.52331738296, 96197.0, 17658.5585360367, 17806.198721057324, 17974.37089701854, 18139.909300453677, 18332.887157063837, 31195.68804311973, 31527.527087093713, 31572.368552628817, 31607.20981975469, 31608.841955790074, 9331.673391431403, 9503.619855205852, 9612.0, 9847.704568862802, 9875.456849873182, 7724.459287849797, 7749.7287594933905, 7799.0, 8011.759647210476, 8020.398470114765, 8625.568721563897, 8647.956760216284, 8685.435446695945, 8922.464652120894, 9048.140426659456, 3436.398630239748, 3496.5629296337956, 3521.6830485255937, 3532.8056956867104, 3604.315180115822, 967.6129548180784, 991.8859331177007, 1011.261778901406, 1035.1511760356436, 1044.7544826965657, 19197.32809351666, 19703.802961970483, 19946.70079948802, 20210.696839547418, 20254.29109981173, 969.762408209993, 990.0396615283164, 1009.9192064634811, 1013.5591017907234, 1021.1728499915092, 10532.631357902437, 11178.496967636313, 11195.384253866116, 11292.322460652387, 11297.491612877277, 471397.0, 472931.0, 473366.0, 478860.0, 496429.5535566897, 84892.57553712191, 90570.0, 93474.52203823678, 94389.5280523593, 96195.0, 951.9809603807885, 953.675750244934, 993.7416271769248, 1036.0623635609786, 1042.7393151712072, 17399.56501087483, 17984.37054703079, 18197.45407637773, 18363.0, 18590.349337773114, 43346.78326608347, 43455.34816977811, 44268.0, 44718.0, 44736.77631611821, 63190.684046579474, 64546.67726661337, 64559.354406455335, 64814.0, 65109.0, 8012.238837310446, 8061.395395345256, 8094.190580941859, 8187.345012399113, 8472.957635211784, 9531.618735250513, 12499.250044997329, 12692.555760548337, 12967.0, 13200.66998325011, 11316.094712423152, 11548.422578870855, 11683.941580292045, 11765.294082355085, 11895.10786691019, 11344.432778361213, 11419.828702569303, 11474.655760327203, 12044.75910481803, 12070.456829442872, 11500.827487587525, 11540.94229528847, 11870.406479676154, 11967.042636588878, 12326.691832703895, 7336.4130869529245, 7655.885161722467, 8106.0, 8247.092819789937, 8587.570621469027, 10866.565337386732, 11073.778524429628, 11625.0, 11829.408529573315, 12020.459079341275], "value": 10440.857392787455, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.9123452592846, 1492.0972811449071, 1613.257901365372, 1748.2569907789195, 1767.3372485318005, 8091.2717855393, 8742.825143497126, 8745.0, 9282.118198771122, 9393.0, 8969.865452018208, 9267.953660231706, 9270.119338662833, 9283.071692830714, 9298.442093474396, 2202.6695995600667, 2232.2633530934754, 2233.6314508106225, 2239.0819763896807, 2242.4842286274165, 2305.596520608895, 2361.6693662887124, 2370.5851475991717, 2378.0725517048363, 2385.9880700596473, 2315.81473482121, 2329.04509151248, 2358.587247231736, 2362.9527409451803, 2364.9527009459803, 2168.815650669695, 2173.3262688566597, 2180.6183917814396, 2184.191849015874, 2186.6173419651495, 2177.0, 2181.149351752818, 2182.552576721784, 2190.638544640148, 2190.8247340212743, 9149.496777677225, 9240.445573265626, 9286.582103805278, 9290.860637090449, 9295.349325547215, 4966.106100901836, 5015.172496538067, 5048.066107770074, 5054.797808087709, 5058.999999999964, 3155.7002084801907, 3183.602049743782, 3261.2173078461237, 3272.7709060365783, 3285.342931413703, 1022.0750221049888, 1027.41950797799, 1029.0584115534277, 1035.502958579886, 1051.3691784929058, 11585.536578536849, 11773.941130294294, 11785.116116291312, 11803.763924721543, 11809.94095029528, 4188.099558594917, 4421.646268298528, 4472.798724057425, 4480.350349199413, 4490.528494508095, 9956.950215248877, 10002.49987500622, 10002.599896004078, 10037.598496060076, 10053.195744340435, 5053.9494605054215, 5055.595552355802, 5069.898602027939, 5072.594192464594, 5074.923876141861, 4392.4289842320295, 4626.86119416418, 4643.930341044887, 4779.498152693986, 4817.879553011203, 3774.4338349247832, 3794.79128647927, 3831.367824308958, 3878.825452854628, 3936.527616686016, 1202.0744027099086, 1222.6036967543537, 1222.6332100369852, 1231.310466138965, 1233.0505510756668, 995.7560397702609, 997.9950100249597, 1007.29992655104, 1010.5503051142172, 1032.1845741863995, 6196.411340922696, 6222.421658813869, 6295.559310848288, 6327.367263273728, 6493.967530162319, 440.7289516947055, 441.7989814634334, 443.07176465305133, 451.05053861620814, 1002.7042022603349, 4307.353896915488, 4357.237483440385, 4437.134758722083, 4440.2673558862425, 4502.954970450319, 11218.102551795837, 11467.598634047768, 11523.423828808525, 11533.88466115328, 11682.0, 11535.942320288512, 11589.24669896454, 11600.593979210687, 11611.071114310835, 11632.767344653059, 8060.153683863227, 8264.793380165424, 8464.873026904601, 8467.110953349933, 8633.266172375419, 6167.229096362955, 6226.813195604139, 6316.494680425647, 6352.460040896575, 6399.6800159992745, 10481.0, 10570.947145264225, 10696.679099627023, 10721.571137154739, 10832.945835271088, 9558.187554057982, 9679.08048735369, 9779.119879210904, 10743.785124297627, 10768.19238557127, 7557.130929943127, 7678.539287642536, 7802.804929876798, 8130.83738325242, 8297.626606802587, 8442.957785211034, 8482.745517634481, 8560.743177704679, 8566.400351975552, 8572.699955501528, 7601.125870524739, 7701.075870895528, 7845.097813751263, 8013.4791238569305, 8051.4766540174705, 7453.664585093576, 7506.474546781673, 7573.848523029619, 7611.048618922635, 7842.254985776342, 6913.585184888922, 7026.648667566499, 7037.964810175917, 7038.542494737826, 7063.293670632896, 4553.795079221377, 4655.231886738786, 4697.976510117427, 4708.458527269271, 4712.410948631421, 5110.3356563646485, 5188.844334669966, 5226.555742761756, 5245.947540524546, 5290.8941821164135], "value": 4567.412047322784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.1265358225626, 334.4581777520417, 337.6134326196505, 343.62201578263915, 343.7301718151249, 5355.651882627626, 5441.782328706847, 5524.806631767884, 5545.085060964941, 5587.245721827552, 5433.510984011438, 5454.61817672763, 5470.234167216593, 5490.752916118774, 5495.917561236584, 4275.380069889864, 4276.23027854986, 4277.930517370657, 4285.335772955197, 4285.5928686774705, 4169.6455801256925, 4237.7669228192435, 4249.596288352617, 4266.978665106686, 4281.207976524337, 4221.852235171769, 4225.176090662322, 4235.767032813194, 4242.9151416971645, 4249.617534421902, 4219.683523735732, 4236.343366778155, 4247.173715302434, 4253.893652658678, 4263.232618128735, 3622.728295377831, 3763.924721505582, 3765.7363984521094, 3766.719315432766, 3775.244071827554, 5350.100714246425, 5351.411344752074, 5373.274607927919, 5374.381946076212, 5378.0, 4799.952000479985, 4848.321235027099, 4858.46556878743, 4860.198067318888, 4898.191798353268, 5570.3315602127595, 5698.943010569924, 5711.742971566289, 5719.6854173020465, 5727.284089488814, 4063.207674503473, 4066.34938409853, 4068.8982775430554, 4069.959300407017, 4071.491063617048, 5917.195255447087, 5939.495142912858, 5941.524678025748, 5947.316058653267, 5950.851228719273, 4100.507939047334, 4178.101708132766, 4202.810873510699, 4203.78090353794, 4210.5157906841105, 4201.978990105091, 4238.745675259494, 4256.382824490432, 4268.018355778188, 4271.423357846651, 4852.757362131879, 4855.174620314555, 4866.812237984055, 4869.099216644932, 4892.828750993698, 5522.2544956431175, 5746.511546518509, 5780.855478612984, 5797.594168408171, 5808.709564521757, 1438.2736717957573, 1444.833844107941, 1449.7680371140777, 1453.1789538910482, 1456.1699831096385, 895.5477483870734, 904.7150147703584, 921.9124183202586, 931.1573026411108, 932.5104320231933, 4874.0, 4931.235658472942, 4938.506149385033, 4959.355283813154, 4970.0, 5160.535551800281, 5222.843314700565, 5229.320188375486, 5242.663120904145, 5249.658772179872, 4784.6889952153, 4917.934467523649, 4958.826441074617, 4967.304577359173, 4983.127952608279, 2775.4310366374843, 2775.9306017349727, 2777.916662500128, 2782.0, 2789.748922596976, 5372.328458942632, 5390.51485366319, 5391.0, 5453.4273901240595, 5472.20653005312, 5068.315777370081, 5246.970321824127, 5251.45304527304, 5325.440828713007, 5326.760295786699, 5339.5728341732565, 5341.759620817073, 5344.759485823147, 5358.392482255308, 5393.622446428791, 5153.510416510426, 5197.948020519746, 5204.843854684365, 5208.3229180207845, 5235.8481134150425, 4975.900481990412, 5099.337086178922, 5099.6685215460875, 5127.87180320495, 5139.280500729826, 5401.918971215514, 5406.648567843077, 5410.458954104715, 5417.51242388187, 5427.39891731948, 3738.4766132741984, 3960.128771670228, 3966.504186976628, 4081.775502347399, 4135.883311505816, 5743.282089738783, 5833.762261944492, 5855.707214639337, 5855.824325270249, 5862.94137058641, 5565.30433695788, 5667.716614169358, 5670.319561652628, 5693.5160511357, 5727.713614319351, 5655.077273726953, 5662.094064949588, 5677.74450149736, 5680.801171958961, 5688.890666320028, 5607.495325420732, 5619.522340601095, 5629.802956896489, 5636.182753500638, 5640.633358831663, 5510.972445137749, 5700.315962084576, 5719.7426115824055, 5743.310802703702, 5758.769649213985, 5577.60956733041, 5580.972095139498, 5602.691851948182, 5612.691301978431, 5613.410591887793], "value": 4209.943146832288, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.2047200055929, 659.8878190707579, 711.6477343714859, 735.7719107076804, 762.2720302111483, 14712.92643536782, 15953.042817430947, 16004.199790010496, 16418.26117824698, 17107.486775396726, 16167.272472738725, 16267.593310167253, 16314.592135196626, 16330.83669163308, 16331.0, 809.3646487507308, 830.1905641999033, 833.8999320081599, 834.3116928533984, 837.6733074101105, 796.3947399976003, 815.148170162179, 821.9465734727223, 825.4098319701412, 832.2052439919893, 843.8354520868434, 844.2950136635885, 848.1094850407079, 850.6809946270149, 851.8637018077109, 839.3998291221775, 841.5077179849795, 842.6292431330256, 842.6418772021897, 843.1989609870586, 611.626907586372, 613.310026220502, 616.2081724983419, 618.4897459595851, 620.7206756959341, 15394.461193858273, 15477.22613869302, 15492.22538873063, 15511.0, 15518.0, 13890.722185556333, 14330.57008289753, 14530.418783248657, 14532.128072315589, 14549.781753273604, 12148.45331960055, 12517.147973920111, 12558.246505209625, 12704.872951270461, 13171.407286672124, 3676.852925882988, 3688.4467329900463, 3774.2828862516035, 3891.9686283134993, 3909.843606255746, 78960.0, 79142.0, 79161.60419197925, 79777.60111199465, 80425.0, 11483.483243254073, 11666.70833229176, 11798.882011179778, 11920.642380728592, 12291.93854030742, 22008.229711960004, 22037.11851525921, 22065.33803985883, 22076.116955321606, 22077.668834967488, 8232.547209903512, 8241.752747417588, 8350.916490835136, 8515.233628973423, 8634.827303453896, 4456.420665313489, 4834.734089625034, 4868.269759536027, 4938.876528086755, 5075.959428317186, 3301.570795796531, 3384.5430866833153, 3393.9490907636405, 3394.6096198936943, 3397.5922889253447, 589.7198830555452, 592.6503363015755, 603.5171862510063, 606.9119977603311, 614.7295190116424, 595.4333542082892, 602.686602966455, 623.4544773323342, 722.1009842745815, 723.9167495737952, 9638.277129215197, 9670.903290967, 9771.902280977241, 9981.500924953723, 10233.9488302558, 636.5957616913294, 696.8571442854203, 700.2192555300803, 718.6489399928101, 730.1967835381145, 4681.32120842476, 4709.293605959065, 4845.878853028632, 4847.297141914473, 4849.369581954324, 118316.40841795735, 120665.0, 121101.39449302696, 121625.0, 126741.0, 102388.0, 103134.48432757788, 104669.47665261626, 105482.47258763811, 108084.45957770318, 88372.0, 89876.5506172465, 91066.0, 92367.53816230876, 93896.0, 8832.205101540892, 8918.19736223743, 8982.236509896471, 9011.909880901107, 9067.410618309788, 52389.476105239984, 52516.0, 53295.0, 54367.45632543624, 55053.72473137609, 43873.56126438823, 44858.10283794371, 48579.51420485891, 74212.0, 77452.61273693596, 9822.21422286201, 10843.945780271048, 11689.240199387013, 11734.530618775154, 11756.353400563052, 11970.58102966392, 12249.448774804978, 12450.06624503184, 12530.937345313216, 13025.413856376676, 12571.37143142821, 12756.936215318863, 12815.807762883378, 12968.67578310512, 13376.788157731062, 11753.588624398106, 11837.526498939946, 11840.526378945091, 11968.3121265516, 12215.938920305342, 10972.890271097187, 11143.665690029313, 11262.493187806733, 11320.830187547359, 11687.415629218674, 10016.549255283384, 10089.0, 10122.190224782147, 10144.54349554257, 10395.220358472994, 8727.607257673293, 9721.125098741148, 10137.189024877845, 10141.594336226468, 10210.234232432449], "value": 7365.434333640904, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 106.0, 111.0, 112.0, 110.0, 113.0, 111.0, 111.0, 113.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 146.0, 178.0, 119.0, 147.0, 145.0, 120.0, 190.0, 124.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 161.0, 162.0, 165.0, 169.0, 162.0, 163.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 75.0, 180.0, 76.0, 77.0, 77.0, 76.0, 168.0, 76.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 146.0, 84.0, 84.0, 85.0, 132.0, 84.0, 84.0, 156.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 118.0, 117.0, 124.0, 117.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 149.0, 147.0, 148.0, 147.0, 149.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 57.0, 53.0, 53.0, 55.0, 55.0, 54.0, 53.0, 61.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 85.0, 76.0, 82.0, 77.0, 77.0, 76.0, 78.0, 83.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 147.0, 131.0, 126.0, 130.0, 140.0, 124.0, 167.0, 130.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 166.0, 161.0, 166.0, 167.0, 168.0, 165.0, 175.0, 165.0, 161.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 65.0, 65.0, 64.0, 64.0, 66.0, 64.0, 64.0, 64.0], "value": 64.7, "unit": "score"}]}]} 09:56:22 INFO - Return code: 0 09:56:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:56:22 ERROR - # TBPL SUCCESS # 09:56:22 INFO - Running post-action listener: _resource_record_post_action 09:56:22 INFO - [mozharness: 2016-07-29 16:56:22.822750Z] Finished run-tests step (success) 09:56:22 INFO - Running post-run listener: _resource_record_post_run 09:56:22 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 571904000; Read time: 16; Write time: 526984 09:56:22 INFO - TinderboxPrint: CPU usage
13.4% 09:56:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 09:56:22 INFO - TinderboxPrint: I/O write bytes / time
571,904,000 / 526,984 09:56:22 INFO - TinderboxPrint: CPU idle
8,230.6 (86.6%) 09:56:22 INFO - TinderboxPrint: CPU user
1,212.0 (12.8%) 09:56:22 INFO - TinderboxPrint: Swap in / out
0 / 0 09:56:22 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 274079744; Read time: 0; Write time: 309316 09:56:22 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 297373696; Read time: 0; Write time: 217544 09:56:23 INFO - Running post-run listener: _upload_blobber_files 09:56:23 INFO - Blob upload gear active. 09:56:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:56:23 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 09:56:23 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:56:23 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:56:23 INFO - (blobuploader) - INFO - Open directory for files ... 09:56:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:56:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:56:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:24 INFO - (blobuploader) - INFO - Done attempting. 09:56:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:56:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:56:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:28 INFO - (blobuploader) - INFO - Done attempting. 09:56:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:56:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:56:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:29 INFO - (blobuploader) - INFO - Done attempting. 09:56:29 INFO - (blobuploader) - INFO - Iteration through files over. 09:56:29 INFO - Return code: 0 09:56:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:56:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:56:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b4894c2c7a1eabc6918c378c354441d8147e02243094ae0d5cc03269b846b68154dd3de223129525fe169f42ae9a4549f492f9cd1b52eb1b1300d5c8da9e9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ca660322f237157c8ca18c9c02b2ebfa22834841eddd54e140918580d6cdeee396c8e9698d4dfb55dca10cfffc50b4347adcc94e9fe178bf3347c8908f0b1724", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/64aec88f463f7ae48bfc6eb632770298ba09273ba869d8fb2121d274d45564f24a5cdae5cd05b851a49037c789b988b7262f8a438bf636ebbd86d2f568d4d0ad"} 09:56:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:56:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:56:29 INFO - Contents: 09:56:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b4894c2c7a1eabc6918c378c354441d8147e02243094ae0d5cc03269b846b68154dd3de223129525fe169f42ae9a4549f492f9cd1b52eb1b1300d5c8da9e9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ca660322f237157c8ca18c9c02b2ebfa22834841eddd54e140918580d6cdeee396c8e9698d4dfb55dca10cfffc50b4347adcc94e9fe178bf3347c8908f0b1724", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/64aec88f463f7ae48bfc6eb632770298ba09273ba869d8fb2121d274d45564f24a5cdae5cd05b851a49037c789b988b7262f8a438bf636ebbd86d2f568d4d0ad"} 09:56:29 INFO - Running post-run listener: copy_logs_to_upload_dir 09:56:29 INFO - Copying logs to upload dir... 09:56:29 INFO - mkdir: /builds/slave/test/build/upload/logs 09:56:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.819515 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-29 09:56:28.097119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 09:56:28.100893) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083 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/Autoland/sha512/2b4894c2c7a1eabc6918c378c354441d8147e02243094ae0d5cc03269b846b68154dd3de223129525fe169f42ae9a4549f492f9cd1b52eb1b1300d5c8da9e9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ca660322f237157c8ca18c9c02b2ebfa22834841eddd54e140918580d6cdeee396c8e9698d4dfb55dca10cfffc50b4347adcc94e9fe178bf3347c8908f0b1724", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/64aec88f463f7ae48bfc6eb632770298ba09273ba869d8fb2121d274d45564f24a5cdae5cd05b851a49037c789b988b7262f8a438bf636ebbd86d2f568d4d0ad"} build_url:https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/dpUavv9MRyaLkgyDNVeu1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b4894c2c7a1eabc6918c378c354441d8147e02243094ae0d5cc03269b846b68154dd3de223129525fe169f42ae9a4549f492f9cd1b52eb1b1300d5c8da9e9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ca660322f237157c8ca18c9c02b2ebfa22834841eddd54e140918580d6cdeee396c8e9698d4dfb55dca10cfffc50b4347adcc94e9fe178bf3347c8908f0b1724", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/64aec88f463f7ae48bfc6eb632770298ba09273ba869d8fb2121d274d45564f24a5cdae5cd05b851a49037c789b988b7262f8a438bf636ebbd86d2f568d4d0ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 09:56:28.127248) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 09:56:28.127614) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469808647.902232-292524083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004343 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 09:56:28.211920) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 09:56:28.212255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 09:56:28.212616) ========= ========= Total master_lag: 0.15 =========