builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1469798284.59 results: success (0) buildid: 20160729045425 builduid: 48085d2544cb4dee99d5fc5b442d00fd revision: f3d6887279f8175b0d1e3835d1ca2a152bc4453f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:04.588713) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:04.589193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:04.589484) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:04.604075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:04.604354) ========= 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=920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 06:18:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-07-29 06:18:05 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107700 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:04.725880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:04.726235) ========= 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=920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016098 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:04.775382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:04.775777) ========= 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=920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 06:18:05,144 truncating revision to first 12 chars 2016-07-29 06:18:05,144 Setting DEBUG logging. 2016-07-29 06:18:05,144 attempt 1/10 2016-07-29 06:18:05,144 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 06:18:05,446 unpacking tar archive at: autoland-f3d6887279f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:05.448979) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:05.449353) ========= script_repo_revision: f3d6887279f8175b0d1e3835d1ca2a152bc4453f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:05.449769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:05.450070) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 06:18:05.459848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-29 06:18:05.460169) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:18:05 INFO - MultiFileLogger online at 20160729 06:18:05 in /builds/slave/test 06:18:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 06:18:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:18:05 INFO - {'append_to_log': False, 06:18:05 INFO - 'base_work_dir': '/builds/slave/test', 06:18:05 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 06:18:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:18:05 INFO - 'branch': 'Autoland-Non-PGO', 06:18:05 INFO - 'buildbot_json_path': 'buildprops.json', 06:18:05 INFO - 'config_files': ('talos/linux_config.py',), 06:18:05 INFO - 'default_actions': ('clobber', 06:18:05 INFO - 'read-buildbot-config', 06:18:05 INFO - 'download-and-extract', 06:18:05 INFO - 'populate-webroot', 06:18:05 INFO - 'create-virtualenv', 06:18:05 INFO - 'install', 06:18:05 INFO - 'run-tests'), 06:18:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:18:05 INFO - 'download_minidump_stackwalk': True, 06:18:05 INFO - 'download_symbols': 'ondemand', 06:18:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:18:05 INFO - 'tooltool.py': '/tools/tooltool.py', 06:18:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:18:05 INFO - '/tools/misc-python/virtualenv.py')}, 06:18:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:18:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:18:05 INFO - 'installer_path': 'installer.exe', 06:18:05 INFO - 'log_level': 'info', 06:18:05 INFO - 'log_name': 'talos', 06:18:05 INFO - 'log_to_console': True, 06:18:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:18:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:18:05 INFO - 'opt_config_files': (), 06:18:05 INFO - 'pip_index': False, 06:18:05 INFO - 'sps_profile': False, 06:18:05 INFO - 'sps_profile_interval': 0, 06:18:05 INFO - 'suite': 'dromaeojs-e10s', 06:18:05 INFO - 'system_bits': '32', 06:18:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:18:05 INFO - 'title': 'talos-linux64-ix-053', 06:18:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:18:05 INFO - 'use_talos_json': True, 06:18:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:18:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:18:05 INFO - 'work_dir': 'build'} 06:18:05 INFO - [mozharness: 2016-07-29 13:18:05.918490Z] Running clobber step. 06:18:05 INFO - Running pre-action listener: _resource_record_pre_action 06:18:05 INFO - Running main action method: clobber 06:18:05 INFO - rmtree: /builds/slave/test/build 06:18:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:18:06 INFO - Running post-action listener: _resource_record_post_action 06:18:06 INFO - [mozharness: 2016-07-29 13:18:06.421332Z] Finished clobber step (success) 06:18:06 INFO - [mozharness: 2016-07-29 13:18:06.421433Z] Running read-buildbot-config step. 06:18:06 INFO - Running pre-action listener: _resource_record_pre_action 06:18:06 INFO - Running main action method: read_buildbot_config 06:18:06 INFO - Using buildbot properties: 06:18:06 INFO - { 06:18:06 INFO - "project": "", 06:18:06 INFO - "product": "firefox", 06:18:06 INFO - "script_repo_revision": "production", 06:18:06 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 06:18:06 INFO - "repository": "", 06:18:06 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 06:18:06 INFO - "buildid": "20160729045425", 06:18:06 INFO - "pgo_build": "False", 06:18:06 INFO - "basedir": "/builds/slave/test", 06:18:06 INFO - "buildnumber": 219, 06:18:06 INFO - "slavename": "talos-linux64-ix-053", 06:18:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:18:06 INFO - "platform": "ubuntu64_hw", 06:18:06 INFO - "scheduler": "tests-autoland-linux64-talos", 06:18:06 INFO - "branch": "autoland", 06:18:06 INFO - "repo_path": "integration/autoland", 06:18:06 INFO - "revision": "f3d6887279f8175b0d1e3835d1ca2a152bc4453f", 06:18:06 INFO - "stage_platform": "linux64", 06:18:06 INFO - "builduid": "48085d2544cb4dee99d5fc5b442d00fd", 06:18:06 INFO - "slavebuilddir": "test" 06:18:06 INFO - } 06:18:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:18:06 INFO - Running post-action listener: _resource_record_post_action 06:18:06 INFO - [mozharness: 2016-07-29 13:18:06.423858Z] Finished read-buildbot-config step (success) 06:18:06 INFO - [mozharness: 2016-07-29 13:18:06.423947Z] Running download-and-extract step. 06:18:06 INFO - Running pre-action listener: _resource_record_pre_action 06:18:06 INFO - Running main action method: download_and_extract 06:18:06 INFO - mkdir: /builds/slave/test/build/tests 06:18: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')]} 06:18:06 INFO - https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:18:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:18:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:18:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/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 06:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/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 06:18:07 INFO - Downloaded 1361 bytes. 06:18:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:18:07 INFO - Using the following test package requirements: 06:18:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:18:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:18:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:18:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:07 INFO - u'jsshell-linux-x86_64.zip'], 06:18:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:18:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:18:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:18:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:18:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:18:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:18:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:18: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')]} 06:18:07 INFO - https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:18:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:18:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:18:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/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 06:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/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 06:18:07 INFO - Downloaded 22758510 bytes. 06:18:07 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'] 06:18:07 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 06:18:09 INFO - Return code: 0 06:18:09 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 06:18:09 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')]} 06:18:09 INFO - https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:18:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:18:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:18:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/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 06:18:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/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 06:18:10 INFO - Downloaded 22758510 bytes. 06:18:10 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'] 06:18:10 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 06:18:11 INFO - Return code: 0 06:18: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')]} 06:18:11 INFO - https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:18:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:18:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:18:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/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 06:18:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/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 06:18:12 INFO - Downloaded 14413725 bytes. 06:18:12 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'] 06:18:12 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 06:18:12 INFO - Return code: 0 06:18: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')]} 06:18:12 INFO - https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:18:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:18:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:18:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/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 06:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGIP2XLkTimS7vjVi-eshw/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 06:18:14 INFO - Downloaded 57169305 bytes. 06:18:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:18:14 INFO - mkdir: /builds/slave/test/properties 06:18:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:18:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:18:14 INFO - Contents: 06:18:14 INFO - build_url:https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:18:14 INFO - Running post-action listener: _resource_record_post_action 06:18:14 INFO - Running post-action listener: set_extra_try_arguments 06:18:14 INFO - [mozharness: 2016-07-29 13:18:14.800637Z] Finished download-and-extract step (success) 06:18:14 INFO - [mozharness: 2016-07-29 13:18:14.800868Z] Running populate-webroot step. 06:18:14 INFO - Running pre-action listener: _resource_record_pre_action 06:18:14 INFO - Running main action method: populate_webroot 06:18:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:18:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:18:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:18:14 INFO - '--tppagecycles', 06:18:14 INFO - '7'], 06:18:14 INFO - 'tests': ['tsvgm']}}, 06:18:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:18:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:18:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:18:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:18:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:18:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:18:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'talos_options': ['--disable-e10s'], 06:18:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'talos_options': ['--disable-e10s'], 06:18:14 INFO - 'tests': ['damp', 'tps']}, 06:18:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'tests': ['damp', 'tps']}, 06:18:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:18:14 INFO - 'tests': ['dromaeo_dom']}, 06:18:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:18:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:18:14 INFO - 'tests': ['basic_compositor_video']}, 06:18:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:18:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:18:14 INFO - 'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'other-e10s': {'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:18:14 INFO - 'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:18:14 INFO - 'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:18:14 INFO - 'tests': ['tsvgx', 06:18:14 INFO - 'tsvgr_opacity', 06:18:14 INFO - 'tart', 06:18:14 INFO - 'tscrollx', 06:18:14 INFO - 'cart']}, 06:18:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:18:14 INFO - 'tsvgr_opacity', 06:18:14 INFO - 'tart', 06:18:14 INFO - 'tscrollx', 06:18:14 INFO - 'cart']}, 06:18:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'talos_options': ['--disable-e10s'], 06:18:14 INFO - 'tests': ['tp5o']}, 06:18:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'tests': ['tp5o']}, 06:18:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'talos_options': ['--disable-e10s', 06:18:14 INFO - '--xperf_path', 06:18:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:14 INFO - 'tests': ['tp5n']}, 06:18:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'talos_options': ['--xperf_path', 06:18:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:14 INFO - 'tests': ['tp5n']}}, 06:18:14 INFO - 'talos.zip': {'path': '', 06:18:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:18:14 INFO - Running post-action listener: _resource_record_post_action 06:18:14 INFO - [mozharness: 2016-07-29 13:18:14.817905Z] Finished populate-webroot step (success) 06:18:14 INFO - [mozharness: 2016-07-29 13:18:14.817994Z] Running create-virtualenv step. 06:18:14 INFO - Running pre-action listener: _resource_record_pre_action 06:18:14 INFO - Running main action method: create_virtualenv 06:18:14 INFO - Creating virtualenv /builds/slave/test/build/venv 06:18:14 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 06:18:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:18:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:18:14 INFO - Using real prefix '/usr' 06:18:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:18:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:18:17 INFO - Installing pip.................done. 06:18:17 INFO - Return code: 0 06:18:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f570>, '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 0x1770470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1770900>, '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': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', '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 06:18: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', 'pip>=1.5'] in /builds/slave/test/build 06:18: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 pip>=1.5 06:18:17 INFO - Using env: {'DISPLAY': ':0', 06:18:17 INFO - 'HOME': '/home/cltbld', 06:18:17 INFO - 'LANG': 'en_US.UTF-8', 06:18:17 INFO - 'LANGUAGE': 'en_US:en', 06:18:17 INFO - 'LOGNAME': 'cltbld', 06:18:17 INFO - 'MAIL': '/var/mail/cltbld', 06:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:17 INFO - 'MOZ_NO_REMOTE': '1', 06:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:17 INFO - 'NO_EM_RESTART': '1', 06:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:17 INFO - 'PWD': '/builds/slave/test', 06:18:17 INFO - 'SHELL': '/bin/bash', 06:18:17 INFO - 'SHLVL': '1', 06:18:17 INFO - 'TERM': 'linux', 06:18:17 INFO - 'TMOUT': '86400', 06:18:17 INFO - 'USER': 'cltbld', 06:18:17 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', 06:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:17 INFO - '_': '/tools/buildbot/bin/python'} 06:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:17 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 06:18:17 INFO - Cleaning up... 06:18:17 INFO - Return code: 0 06:18:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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', '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 0x14b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f570>, '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 0x1770470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1770900>, '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': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', '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 06:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:18: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 psutil>=3.1.1 06:18:17 INFO - Using env: {'DISPLAY': ':0', 06:18:17 INFO - 'HOME': '/home/cltbld', 06:18:17 INFO - 'LANG': 'en_US.UTF-8', 06:18:17 INFO - 'LANGUAGE': 'en_US:en', 06:18:17 INFO - 'LOGNAME': 'cltbld', 06:18:17 INFO - 'MAIL': '/var/mail/cltbld', 06:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:17 INFO - 'MOZ_NO_REMOTE': '1', 06:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:17 INFO - 'NO_EM_RESTART': '1', 06:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:17 INFO - 'PWD': '/builds/slave/test', 06:18:17 INFO - 'SHELL': '/bin/bash', 06:18:17 INFO - 'SHLVL': '1', 06:18:17 INFO - 'TERM': 'linux', 06:18:17 INFO - 'TMOUT': '86400', 06:18:17 INFO - 'USER': 'cltbld', 06:18:17 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', 06:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:17 INFO - '_': '/tools/buildbot/bin/python'} 06:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:17 INFO - Downloading/unpacking psutil>=3.1.1 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:18:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:19 INFO - Installing collected packages: psutil 06:18:19 INFO - Running setup.py install for psutil 06:18:19 INFO - building 'psutil._psutil_linux' extension 06:18:19 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 06:18:20 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 06:18:20 INFO - building 'psutil._psutil_posix' extension 06:18:20 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 06:18:20 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 06:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:20 INFO - Successfully installed psutil 06:18:20 INFO - Cleaning up... 06:18:20 INFO - Return code: 0 06:18:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:20 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 0x14b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f570>, '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 0x1770470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1770900>, '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': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', '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 06:18:20 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 06:18:20 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 06:18:20 INFO - Using env: {'DISPLAY': ':0', 06:18:20 INFO - 'HOME': '/home/cltbld', 06:18:20 INFO - 'LANG': 'en_US.UTF-8', 06:18:20 INFO - 'LANGUAGE': 'en_US:en', 06:18:20 INFO - 'LOGNAME': 'cltbld', 06:18:20 INFO - 'MAIL': '/var/mail/cltbld', 06:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:20 INFO - 'MOZ_NO_REMOTE': '1', 06:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:20 INFO - 'NO_EM_RESTART': '1', 06:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:20 INFO - 'PWD': '/builds/slave/test', 06:18:20 INFO - 'SHELL': '/bin/bash', 06:18:20 INFO - 'SHLVL': '1', 06:18:20 INFO - 'TERM': 'linux', 06:18:20 INFO - 'TMOUT': '86400', 06:18:20 INFO - 'USER': 'cltbld', 06:18:20 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', 06:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:20 INFO - '_': '/tools/buildbot/bin/python'} 06:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:18:22 INFO - Installing collected packages: mozsystemmonitor 06:18:22 INFO - Running setup.py install for mozsystemmonitor 06:18:22 INFO - Successfully installed mozsystemmonitor 06:18:22 INFO - Cleaning up... 06:18:22 INFO - Return code: 0 06:18:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:22 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 0x14b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f570>, '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 0x1770470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1770900>, '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': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', '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 06:18:22 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 06:18:22 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 06:18:22 INFO - Using env: {'DISPLAY': ':0', 06:18:22 INFO - 'HOME': '/home/cltbld', 06:18:22 INFO - 'LANG': 'en_US.UTF-8', 06:18:22 INFO - 'LANGUAGE': 'en_US:en', 06:18:22 INFO - 'LOGNAME': 'cltbld', 06:18:22 INFO - 'MAIL': '/var/mail/cltbld', 06:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:22 INFO - 'MOZ_NO_REMOTE': '1', 06:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:22 INFO - 'NO_EM_RESTART': '1', 06:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:22 INFO - 'PWD': '/builds/slave/test', 06:18:22 INFO - 'SHELL': '/bin/bash', 06:18:22 INFO - 'SHLVL': '1', 06:18:22 INFO - 'TERM': 'linux', 06:18:22 INFO - 'TMOUT': '86400', 06:18:22 INFO - 'USER': 'cltbld', 06:18:22 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', 06:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:22 INFO - '_': '/tools/buildbot/bin/python'} 06:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:22 INFO - Downloading/unpacking jsonschema==2.5.1 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:18:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:18:24 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 06:18:24 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 06:18:24 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 06:18:24 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 06:18:24 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 06:18:24 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 06:18:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:18:25 INFO - warning: no files found matching '*.txt' 06:18:25 INFO - no previously-included directories found matching 'build' 06:18:25 INFO - no previously-included directories found matching 'dist' 06:18:25 INFO - no previously-included directories found matching '.git*' 06:18:25 INFO - Installing collected packages: jsonschema, functools32 06:18:25 INFO - Running setup.py install for functools32 06:18:25 INFO - warning: no files found matching '*.txt' 06:18:25 INFO - no previously-included directories found matching 'build' 06:18:25 INFO - no previously-included directories found matching 'dist' 06:18:25 INFO - no previously-included directories found matching '.git*' 06:18:25 INFO - Successfully installed jsonschema functools32 06:18:25 INFO - Cleaning up... 06:18:25 INFO - Return code: 0 06:18:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:25 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 0x14b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f570>, '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 0x1770470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1770900>, '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': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', '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 06:18:25 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 06:18:25 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 06:18:25 INFO - Using env: {'DISPLAY': ':0', 06:18:25 INFO - 'HOME': '/home/cltbld', 06:18:25 INFO - 'LANG': 'en_US.UTF-8', 06:18:25 INFO - 'LANGUAGE': 'en_US:en', 06:18:25 INFO - 'LOGNAME': 'cltbld', 06:18:25 INFO - 'MAIL': '/var/mail/cltbld', 06:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:25 INFO - 'MOZ_NO_REMOTE': '1', 06:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:25 INFO - 'NO_EM_RESTART': '1', 06:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:25 INFO - 'PWD': '/builds/slave/test', 06:18:25 INFO - 'SHELL': '/bin/bash', 06:18:25 INFO - 'SHLVL': '1', 06:18:25 INFO - 'TERM': 'linux', 06:18:25 INFO - 'TMOUT': '86400', 06:18:25 INFO - 'USER': 'cltbld', 06:18:25 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', 06:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:25 INFO - '_': '/tools/buildbot/bin/python'} 06:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:18:25 INFO - Cleaning up... 06:18:25 INFO - Return code: 0 06:18:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:25 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 0x14b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f570>, '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 0x1770470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1770900>, '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': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', '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 06:18:25 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 06:18:25 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 06:18:25 INFO - Using env: {'DISPLAY': ':0', 06:18:25 INFO - 'HOME': '/home/cltbld', 06:18:25 INFO - 'LANG': 'en_US.UTF-8', 06:18:25 INFO - 'LANGUAGE': 'en_US:en', 06:18:25 INFO - 'LOGNAME': 'cltbld', 06:18:25 INFO - 'MAIL': '/var/mail/cltbld', 06:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:25 INFO - 'MOZ_NO_REMOTE': '1', 06:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:25 INFO - 'NO_EM_RESTART': '1', 06:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:25 INFO - 'PWD': '/builds/slave/test', 06:18:25 INFO - 'SHELL': '/bin/bash', 06:18:25 INFO - 'SHLVL': '1', 06:18:25 INFO - 'TERM': 'linux', 06:18:25 INFO - 'TMOUT': '86400', 06:18:25 INFO - 'USER': 'cltbld', 06:18:25 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', 06:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:25 INFO - '_': '/tools/buildbot/bin/python'} 06:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:25 INFO - Downloading/unpacking blobuploader==1.2.4 06:18:25 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 06:18:25 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 06:18:25 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 06:18:25 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 06:18:25 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 06:18:25 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 06:18:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:18:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:18:27 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 06:18:27 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 06:18:27 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 06:18:27 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 06:18:27 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 06:18:27 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 06:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:18:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:28 INFO - Downloading docopt-0.6.1.tar.gz 06:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:18:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:18:28 INFO - Running setup.py install for blobuploader 06:18:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:18:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:18:28 INFO - Running setup.py install for requests 06:18:28 INFO - Running setup.py install for docopt 06:18:28 INFO - Successfully installed blobuploader requests docopt 06:18:28 INFO - Cleaning up... 06:18:28 INFO - Return code: 0 06:18:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:28 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 0x14b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f570>, '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 0x1770470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1770900>, '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': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', '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 06:18:28 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 06:18:28 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 06:18:28 INFO - Using env: {'DISPLAY': ':0', 06:18:28 INFO - 'HOME': '/home/cltbld', 06:18:28 INFO - 'LANG': 'en_US.UTF-8', 06:18:28 INFO - 'LANGUAGE': 'en_US:en', 06:18:28 INFO - 'LOGNAME': 'cltbld', 06:18:28 INFO - 'MAIL': '/var/mail/cltbld', 06:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:28 INFO - 'MOZ_NO_REMOTE': '1', 06:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:28 INFO - 'NO_EM_RESTART': '1', 06:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:28 INFO - 'PWD': '/builds/slave/test', 06:18:28 INFO - 'SHELL': '/bin/bash', 06:18:28 INFO - 'SHLVL': '1', 06:18:28 INFO - 'TERM': 'linux', 06:18:28 INFO - 'TMOUT': '86400', 06:18:28 INFO - 'USER': 'cltbld', 06:18:28 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', 06:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:28 INFO - '_': '/tools/buildbot/bin/python'} 06:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:29 INFO - Running setup.py (path:/tmp/pip-oihK_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:29 INFO - Running setup.py (path:/tmp/pip-DUACV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:29 INFO - Running setup.py (path:/tmp/pip-UVXmBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:29 INFO - Running setup.py (path:/tmp/pip-TbhzD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:29 INFO - Running setup.py (path:/tmp/pip-jTBRpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:29 INFO - Running setup.py (path:/tmp/pip-DdCApU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:29 INFO - Running setup.py (path:/tmp/pip-JPZjFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:29 INFO - Running setup.py (path:/tmp/pip-DWAFjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:29 INFO - Running setup.py (path:/tmp/pip-IvhWuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:29 INFO - Running setup.py (path:/tmp/pip-2o8HWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:29 INFO - Running setup.py (path:/tmp/pip-t7jGm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:29 INFO - Running setup.py (path:/tmp/pip-B7VA3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:30 INFO - Running setup.py (path:/tmp/pip-pMG2MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:30 INFO - Running setup.py (path:/tmp/pip-EX5WE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:30 INFO - Running setup.py (path:/tmp/pip-tEH6YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:30 INFO - Running setup.py (path:/tmp/pip-sWKa4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:30 INFO - Running setup.py (path:/tmp/pip-fpAFB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:18:30 INFO - Running setup.py install for manifestparser 06:18:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:18:30 INFO - Running setup.py install for mozcrash 06:18:30 INFO - Running setup.py install for mozdebug 06:18:30 INFO - Running setup.py install for mozdevice 06:18:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:18:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:18:30 INFO - Running setup.py install for mozfile 06:18:30 INFO - Running setup.py install for mozhttpd 06:18:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Running setup.py install for mozinfo 06:18:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Running setup.py install for mozInstall 06:18:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Running setup.py install for mozleak 06:18:31 INFO - Running setup.py install for mozlog 06:18:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Running setup.py install for moznetwork 06:18:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Running setup.py install for mozprocess 06:18:31 INFO - Running setup.py install for mozprofile 06:18:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Running setup.py install for mozrunner 06:18:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:18:31 INFO - Running setup.py install for mozscreenshot 06:18:31 INFO - Running setup.py install for moztest 06:18:32 INFO - Running setup.py install for mozversion 06:18:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:18:32 INFO - Cleaning up... 06:18:32 INFO - Return code: 0 06:18:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:32 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 0x14b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f570>, '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 0x1770470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1770900>, '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': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', '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 06:18:32 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 06:18:32 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 06:18:32 INFO - Using env: {'DISPLAY': ':0', 06:18:32 INFO - 'HOME': '/home/cltbld', 06:18:32 INFO - 'LANG': 'en_US.UTF-8', 06:18:32 INFO - 'LANGUAGE': 'en_US:en', 06:18:32 INFO - 'LOGNAME': 'cltbld', 06:18:32 INFO - 'MAIL': '/var/mail/cltbld', 06:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:32 INFO - 'MOZ_NO_REMOTE': '1', 06:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:32 INFO - 'NO_EM_RESTART': '1', 06:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:32 INFO - 'PWD': '/builds/slave/test', 06:18:32 INFO - 'SHELL': '/bin/bash', 06:18:32 INFO - 'SHLVL': '1', 06:18:32 INFO - 'TERM': 'linux', 06:18:32 INFO - 'TMOUT': '86400', 06:18:32 INFO - 'USER': 'cltbld', 06:18:32 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', 06:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:32 INFO - '_': '/tools/buildbot/bin/python'} 06:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:32 INFO - Running setup.py (path:/tmp/pip-xX1A5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:32 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)) 06:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:32 INFO - Running setup.py (path:/tmp/pip-mH9MMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:32 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)) 06:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:32 INFO - Running setup.py (path:/tmp/pip-H_QFKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:32 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)) 06:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:32 INFO - Running setup.py (path:/tmp/pip-LlWL4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:32 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)) 06:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:32 INFO - Running setup.py (path:/tmp/pip-JW3M_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:32 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)) 06:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:32 INFO - Running setup.py (path:/tmp/pip-i_VsGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:32 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)) 06:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:32 INFO - Running setup.py (path:/tmp/pip-AJI3MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:32 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)) 06:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:32 INFO - Running setup.py (path:/tmp/pip-nmHpQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:32 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)) 06:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:32 INFO - Running setup.py (path:/tmp/pip-udJLFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:33 INFO - Running setup.py (path:/tmp/pip-z5PVzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:33 INFO - Running setup.py (path:/tmp/pip-ttZvrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:33 INFO - Running setup.py (path:/tmp/pip-ml_n5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:33 INFO - Running setup.py (path:/tmp/pip-vK4bKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:33 INFO - Running setup.py (path:/tmp/pip-aE9z3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:33 INFO - Running setup.py (path:/tmp/pip-u8t6UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:33 INFO - Running setup.py (path:/tmp/pip-DWVu4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:33 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)) 06:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:33 INFO - Running setup.py (path:/tmp/pip-AsBUFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:33 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)) 06:18:33 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)) 06:18:33 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)) 06:18:33 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)) 06:18:33 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)) 06:18:33 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)) 06:18:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:35 INFO - Downloading blessings-1.6.tar.gz 06:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:18:35 INFO - Installing collected packages: blessings 06:18:35 INFO - Running setup.py install for blessings 06:18:35 INFO - Successfully installed blessings 06:18:35 INFO - Cleaning up... 06:18:35 INFO - Return code: 0 06:18:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:35 INFO - Reading from file tmpfile_stdout 06:18:35 INFO - Current package versions: 06:18:35 INFO - argparse == 1.2.1 06:18:35 INFO - blessings == 1.6 06:18:35 INFO - blobuploader == 1.2.4 06:18:35 INFO - docopt == 0.6.1 06:18:35 INFO - functools32 == 3.2.3-2 06:18:35 INFO - jsonschema == 2.5.1 06:18:35 INFO - manifestparser == 1.1 06:18:35 INFO - mozInstall == 1.12 06:18:35 INFO - mozcrash == 0.17 06:18:35 INFO - mozdebug == 0.1 06:18:35 INFO - mozdevice == 0.48 06:18:35 INFO - mozfile == 1.2 06:18:35 INFO - mozhttpd == 0.7 06:18:35 INFO - mozinfo == 0.9 06:18:35 INFO - mozleak == 0.1 06:18:35 INFO - mozlog == 3.3 06:18:35 INFO - moznetwork == 0.27 06:18:35 INFO - mozprocess == 0.23 06:18:35 INFO - mozprofile == 0.28 06:18:35 INFO - mozrunner == 6.12 06:18:35 INFO - mozscreenshot == 0.1 06:18:35 INFO - mozsystemmonitor == 0.3 06:18:35 INFO - moztest == 0.7 06:18:35 INFO - mozversion == 1.4 06:18:35 INFO - psutil == 3.1.1 06:18:35 INFO - requests == 1.2.3 06:18:35 INFO - wsgiref == 0.1.2 06:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:35 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 0x14b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f570>, '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 0x1770470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1770900>, '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': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', '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 06:18:35 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 06:18:35 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 06:18:35 INFO - Using env: {'DISPLAY': ':0', 06:18:35 INFO - 'HOME': '/home/cltbld', 06:18:35 INFO - 'LANG': 'en_US.UTF-8', 06:18:35 INFO - 'LANGUAGE': 'en_US:en', 06:18:35 INFO - 'LOGNAME': 'cltbld', 06:18:35 INFO - 'MAIL': '/var/mail/cltbld', 06:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:35 INFO - 'MOZ_NO_REMOTE': '1', 06:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:35 INFO - 'NO_EM_RESTART': '1', 06:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:35 INFO - 'PWD': '/builds/slave/test', 06:18:35 INFO - 'SHELL': '/bin/bash', 06:18:35 INFO - 'SHLVL': '1', 06:18:35 INFO - 'TERM': 'linux', 06:18:35 INFO - 'TMOUT': '86400', 06:18:35 INFO - 'USER': 'cltbld', 06:18:35 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', 06:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:35 INFO - '_': '/tools/buildbot/bin/python'} 06:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 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)) 06:18:36 INFO - Cleaning up... 06:18:36 INFO - Return code: 0 06:18:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176f570>, '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 0x1770470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1770900>, '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': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', '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 06:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:18:36 INFO - Using env: {'DISPLAY': ':0', 06:18:36 INFO - 'HOME': '/home/cltbld', 06:18:36 INFO - 'LANG': 'en_US.UTF-8', 06:18:36 INFO - 'LANGUAGE': 'en_US:en', 06:18:36 INFO - 'LOGNAME': 'cltbld', 06:18:36 INFO - 'MAIL': '/var/mail/cltbld', 06:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:36 INFO - 'MOZ_NO_REMOTE': '1', 06:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:36 INFO - 'NO_EM_RESTART': '1', 06:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:36 INFO - 'PWD': '/builds/slave/test', 06:18:36 INFO - 'SHELL': '/bin/bash', 06:18:36 INFO - 'SHLVL': '1', 06:18:36 INFO - 'TERM': 'linux', 06:18:36 INFO - 'TMOUT': '86400', 06:18:36 INFO - 'USER': 'cltbld', 06:18:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', 06:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:36 INFO - '_': '/tools/buildbot/bin/python'} 06:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:18:36 INFO - Cleaning up... 06:18:36 INFO - Return code: 0 06:18:36 INFO - Running post-action listener: _resource_record_post_action 06:18:36 INFO - Running post-action listener: _start_resource_monitoring 06:18:36 INFO - Starting resource monitoring. 06:18:36 INFO - [mozharness: 2016-07-29 13:18:36.445784Z] Finished create-virtualenv step (success) 06:18:36 INFO - [mozharness: 2016-07-29 13:18:36.446211Z] Running install step. 06:18:36 INFO - Running pre-action listener: _resource_record_pre_action 06:18:36 INFO - Running main action method: install 06:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:36 INFO - Reading from file tmpfile_stdout 06:18:36 INFO - Detecting whether we're running mozinstall >=1.0... 06:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:18:36 INFO - Reading from file tmpfile_stdout 06:18:36 INFO - Output received: 06:18:36 INFO - Usage: mozinstall [options] installer 06:18:36 INFO - Options: 06:18:36 INFO - -h, --help show this help message and exit 06:18:36 INFO - -d DEST, --destination=DEST 06:18:36 INFO - Directory to install application into. [default: 06:18:36 INFO - "/builds/slave/test"] 06:18:36 INFO - --app=APP Application being installed. [default: firefox] 06:18:36 INFO - mkdir: /builds/slave/test/build/application 06:18:36 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'] 06:18:36 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 06:18:53 INFO - Reading from file tmpfile_stdout 06:18:53 INFO - Output received: 06:18:53 INFO - /builds/slave/test/build/application/firefox/firefox 06:18:53 INFO - Running post-action listener: _resource_record_post_action 06:18:53 INFO - [mozharness: 2016-07-29 13:18:53.148342Z] Finished install step (success) 06:18:53 INFO - [mozharness: 2016-07-29 13:18:53.148618Z] Running run-tests step. 06:18:53 INFO - Running pre-action listener: _resource_record_pre_action 06:18:53 INFO - Running main action method: run_tests 06:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:18:53 INFO - Python 2.7.3 06:18:53 INFO - Return code: 0 06:18:53 INFO - grabbing minidump binary from tooltool 06:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:53 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 0x176f570>, '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 0x1770470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1770900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:18:53 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 06:18:53 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 06:18:53 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 06:18:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:18:53 INFO - Return code: 0 06:18:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:18:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:18:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:18:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:18:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 06:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 06:18:53 INFO - Using env: {'DISPLAY': ':0', 06:18:53 INFO - 'HOME': '/home/cltbld', 06:18:53 INFO - 'LANG': 'en_US.UTF-8', 06:18:53 INFO - 'LANGUAGE': 'en_US:en', 06:18:53 INFO - 'LOGNAME': 'cltbld', 06:18:53 INFO - 'MAIL': '/var/mail/cltbld', 06:18:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:18:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:53 INFO - 'MOZ_NO_REMOTE': '1', 06:18:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:53 INFO - 'NO_EM_RESTART': '1', 06:18:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:53 INFO - 'PWD': '/builds/slave/test', 06:18:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:18:53 INFO - 'SHELL': '/bin/bash', 06:18:53 INFO - 'SHLVL': '1', 06:18:53 INFO - 'TERM': 'linux', 06:18:53 INFO - 'TMOUT': '86400', 06:18:53 INFO - 'USER': 'cltbld', 06:18:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317', 06:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:53 INFO - '_': '/tools/buildbot/bin/python'} 06:18:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 06:18:53 INFO - mozversion application_buildid: 20160729045425 06:18:53 INFO - mozversion application_changeset: f3d6887279f8175b0d1e3835d1ca2a152bc4453f 06:18:53 INFO - mozversion application_display_name: Nightly 06:18:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:18:53 INFO - mozversion application_name: Firefox 06:18:53 INFO - mozversion application_remotingname: firefox 06:18:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:18:53 INFO - mozversion application_vendor: Mozilla 06:18:53 INFO - mozversion application_version: 50.0a1 06:18:53 INFO - mozversion platform_buildid: 20160729045425 06:18:53 INFO - mozversion platform_changeset: f3d6887279f8175b0d1e3835d1ca2a152bc4453f 06:18:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:18:53 INFO - mozversion platform_version: 50.0a1 06:18:53 INFO - using testdate: 1469798333 06:18:53 INFO - actual date: 1469798333 06:18:53 INFO - starting webserver on 'localhost:54177' 06:18:53 INFO - SUITE-START | Running 2 tests 06:18:53 INFO - TEST-START | dromaeo_css 06:18:53 INFO - operating with platform_type : linux_ 06:18:53 INFO - Initialising browser for dromaeo_css test... 06:18:53 INFO - TEST-INFO | started process 6378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplxnL9V/profile http://localhost:54177/getInfo.html) 06:18:57 INFO - PROCESS | 6378 | JavaScript error: , line 0: uncaught exception: undefined 06:18:58 INFO - PROCESS | 6378 | __metrics Screen width/height:1600/1200 06:18:58 INFO - PROCESS | 6378 | colorDepth:24 06:18:58 INFO - PROCESS | 6378 | Browser inner width/height: 1024/697 06:18:58 INFO - PROCESS | 6378 | __metrics 06:18:59 ERROR - PROCESS | 6378 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:19:00 INFO - TEST-INFO | 6378: exit 0 06:19:00 INFO - Browser initialized. 06:19:00 INFO - Running cycle 1/1 for dromaeo_css test... 06:19:00 INFO - TEST-INFO | started process 6496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplxnL9V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:12 INFO - PROCESS | 6496 | RSS: Main: 165847040 06:19:12 INFO - PROCESS | 6496 | 06:20:01 INFO - PROCESS | 6496 | 1469798401665 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] 06:22:14 INFO - PROCESS | 6496 | Cycle 1(1): loaded http://localhost:54177/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54177/tests/dromaeo/cssquery-ext.html) 06:22:15 INFO - PROCESS | 6496 | RSS: Main: 168517632 06:22:15 INFO - PROCESS | 6496 | 06:25:17 INFO - PROCESS | 6496 | Cycle 1(1): loaded http://localhost:54177/tests/dromaeo/cssquery-ext.html (next: http://localhost:54177/tests/dromaeo/cssquery-jquery.html) 06:25:18 INFO - PROCESS | 6496 | RSS: Main: 167624704 06:25:18 INFO - PROCESS | 6496 | 06:28:20 INFO - PROCESS | 6496 | Cycle 1(1): loaded http://localhost:54177/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54177/tests/dromaeo/cssquery-mootools.html) 06:28:20 INFO - PROCESS | 6496 | RSS: Main: 171380736 06:28:20 INFO - PROCESS | 6496 | 06:31:22 INFO - PROCESS | 6496 | Cycle 1(1): loaded http://localhost:54177/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54177/tests/dromaeo/cssquery-prototype.html) 06:31:23 INFO - PROCESS | 6496 | RSS: Main: 165056512 06:31:23 INFO - PROCESS | 6496 | 06:34:26 INFO - PROCESS | 6496 | Cycle 1(1): loaded http://localhost:54177/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54177/tests/dromaeo/cssquery-yui.html) 06:34:26 INFO - PROCESS | 6496 | RSS: Main: 168153088 06:34:26 INFO - PROCESS | 6496 | 06:37:29 INFO - PROCESS | 6496 | Cycle 1(1): loaded http://localhost:54177/tests/dromaeo/cssquery-yui.html (next: http://localhost:54177/tests/dromaeo/cssquery-dojo.html) 06:37:29 INFO - PROCESS | 6496 | RSS: Main: 171139072 06:37:29 INFO - PROCESS | 6496 | 06:37:29 INFO - PROCESS | 6496 | __start_tp_report 06:37:29 INFO - PROCESS | 6496 | _x_x_mozilla_page_load 06:37:29 INFO - PROCESS | 6496 | _x_x_mozilla_page_load_details 06:37:29 INFO - PROCESS | 6496 | |i|pagename|runs| 06:37:29 INFO - PROCESS | 6496 | |0;dojo.html;2679.3167742225737;2696.32591852037;2713.47087317973;2722.142525104592;2728.7407696268847;4786.712797232169;4889.5599396054395;4901.2403077522995;4948.554630083292;4951.900961980758;4858.757062146888;4864.902701945959;4884.072026314998;4915.3610030696045;4924.482929292427;4529.365888775574;4533.387992621004;4536.977315113428;4651.139539185245;4664.067186562684;4613.76931153441;4620.3069539569;4626.953730462703;4645.163870503308;4666.39336886206;4387.605115539584;4408.493023302297;4456.710313829591;4507.346434766973;4536.933820552184;4506.639468842484;4513.7517436540975;4526.072155208174;4546.54534546546;4558.088382323515;4456.376107344974;4478.596926276651;4495.797689103998;4505.43682039745;4553.203189441834;4680.134175177569;4782.832600858988;4817.108834865561;4856.61147108234;4877.585405240558;5282.920756188661;5293.285406470116;5306.177542480922;5334.519893209591;5343.706096164709;5308.70802105884;5308.92036619451;5320.281761962125;5321.973390133063;5356.384015838151;4767.642426818003;4862.854114376574;4889.022195560902;4920.876978075541;4936.234883593049;5402.621816472888;5422.105352616774;5438.401775804658;5456.154296084113;5479.369872464637;5183.81856635016;5190.351206099238;5198.6880787152895;5206.323177986837;5241.24002019705;5103.209002604603;5168.870778230575;5194.740262986836;5304.38999515053;5317.361916570037;5221.738913054332;5226.5818734501145;5252.579793616502;5281.9207711884355;5292.285541451854;5164.354455693038;5201.08980928336;5211.5049070338255;5222.060029194781;5274.182501712241;4335.7181783184;4432.512423633398;4451.198784218872;4491.797869095833;4506.324051392317;3885.669718073995;3898.2593307271527;3927;3938.2714197873483;3957.762534247954;4455.353973673864;4540.341650460665;4547.363369128325;4553.908921821611;4595.448546174481;5033.521815427602;5238.188080847474;5274.182501712241;5287.048331300326;5305.814296499604;4541.5231400703115;4574.108048930493;4591.655625828076;4614.031053478807;4617.376654151646;4782.904341913142;4785.545373189541;4790.856274311776;4797.760111994457;4834.9604834960655;4789.95210047909;4894.853154405374;4941.357623508921;4965.950340496549;4969.254611808257;5316.494932981361;5326.600504962066;5327.22755200486;5336.7598458068705;5376.838694839161;4953;4973.303737476684;4983.501649834988;4985.501449855131;5003.749812509433;5021.974890125526;5054.873628159326;5070.543651071422;5246.3704355477585;5257.973710131425;5192.818251361185;5241.868953276198;5271.762770675406;5279.52484276417;5367.946320536745;5077.9238311424615;5093.439721630692;5111.284420181252;5144.948550514597;5194.922076168936;4902.63230257725;5115.974420127875;5128.435872054146;5137.588992880485;5147.5881929446305;4946.060248552763;4949.257611358325;5001.474845141353;5036.320096786887;5041.7227052511;5154.072266991978;5176.7152806594495;5179.093658609803;5187.896242075062;5234.712090835041;4857.514248575114;5022.171341728574;5046.621503387188;5070.670406423571;5088.363954505687 06:37:29 INFO - PROCESS | 6496 | |1;ext.html;546.0907588864538;556.2462862820877;581.3808294166712;586.7095787585145;592.2744637818676;34404.82797586012;38160.618393816054;38189.80905095474;38220.61779382205;38229.235415291674;38518;39088.21823563527;39119;39158.80420597893;39217;7658.88511672324;7753.806154846146;7804.375649948019;7808.297253247207;7818.296353328199;7698.461107722434;7758.418118641096;7764.417668674843;7773.844523109535;7782.805429864242;7776.494527855672;7800.453968222227;7832.56920869352;7846.136924938281;7864.606769661494;7763.456558040939;7796.454248202628;7826.021747281618;7838.725644602411;7851.5681637509915;7686.3082322591235;7716.4212684048925;7721.459497835153;7747.690092396298;7774.416918731118;36649.267014659825;37017.62982370196;37256;37283.06792330186;37379;2555.4378036831868;2909.86905589249;2932.648082230146;2981.0311648714037;2984.910452686423;24730.876345618155;25899.96400143992;26745.197644070515;26950.326241843915;27574.724252757416;2696.433748912711;2720.986395068032;2727.3727042780074;2768.9169324920285;2840.786940979435;226878;227252;228064;228120;229008;28725.42549149047;31782.205444864063;31822.363552728817;31909;31921.840390797897;29849;31927.680723192472;31959;32117.839410803263;32139.839300803815;13680.93159534196;13872;13873.58379248624;13875.514356997659;13929.651758706113;11062.446877656084;11117.55529778816;11122.555097795997;11129.443527823576;11153.330800151854;7730.188330225358;7751.651175697107;7792.7781798218475;7825.256600622932;7845.9215407845195;3047.832369219714;3066.7853250272265;3099.6900309969274;3129.6244450666068;3141.3246152076954;840.8612578924409;863.9136086391311;876.2902049339928;928.7956649537226;1035.9855559706139;28052.579211311848;29541.556876646868;29699.257518562208;30381.69618303833;32343.51484727731;898.0615257056392;927.6567669962158;934.7709811096325;940.872982147415;991;14561.490347837987;14755.262236888113;14936.775948360782;15142.9399942003;15207.619809504851;414384;420784;421109;421918;423575;48663.51336486661;48797.75601121972;49117.26324105141;49167.26249106266;49240.261396079084;1185.4546908422221;1197.988020119805;1216.2398500936915;1225.2954551133134;1227.0735594626;26159;27023;27575.72424275812;27768.583471248352;27970.860145699142;42319.1536169281;42992.785036074616;43010.35484467673;43036.84815759262;43099.56900430955;362059;362297;363859;363929;364268;25166.62250066287;25248.621270680585;25712.742872571034;25738.19832611774;25739.485210296065;41439.58560414357;41533.169336613704;41550.792246038574;41653.583464166186;41752.164956700086;33818.66181338155;35477.82261088678;36248.09379765527;36876.81561592175;37488.25023499569;34956;35244.47133292951;35286;35667.10832229111;35747;34931.12672183114;35099.82450087733;36352.63647363493;37412.25175496529;37691.24617507689;30910.22724431907;33127.17182070467;33316;33396.66603334033;33592.49611255784;24844;25301.62047569251;25379.092576030976;25616.487670246865;26025.609615856156 06:37:29 INFO - PROCESS | 6496 | |2;jquery.html;367.353457914071;379.7455704677865;381.12911996088934;384.76144790230063;385.52387801065663;15677.45128920488;16243.187840607967;16900.83099169008;17390.30438782447;17441.65116697665;16162.2726977286;16638.75041874373;16984.065876376793;17054.23255953482;17070.48788536343;5019;5212.4266330703595;5220.843374698765;5227.980543793961;5241.449647786984;5054.519820617035;5108.208227724708;5108.386993560778;5125;5132.384113906336;5099.286099946011;5111.386633603973;5124.743762811863;5130.02529519392;5130.307408499861;4964.354633897588;5006;5030.89938201234;5084.034033533654;5117.360329958755;4501.527339629324;4571.2000399929875;4582.221022426195;4592.563706447882;4616.28447590624;13408.46366145353;13422.86577134226;13469.797953030713;20393.592128157503;20607.175712971613;1733.5232810976956;1808.7467754514246;1888.792232854385;1891.9527011824678;1903.077007651288;8902.243309318716;9136.223421009223;9235.215006724437;9301.534923253877;9368.90631093687;1534.8311685714561;1652.0913497576284;1662.717338052534;1686.4519031314871;1711.845933865958;75264.24735752627;76034.61982690051;76391.61804190943;77982;78613;9264.768380790534;9295.628174872929;9414.670486533076;9556.617735290649;9850.359726617748;13058.542950996669;13098.541551045668;13101.213927164401;13119.934400328128;13121.803172952414;6840.486963477759;7044.894326585106;7051.400630946325;7270.818229544304;7312.561246325237;6564.113844631009;6728.6635668216395;6883.8967415488805;6913.654317284116;6927.7228910843005;3810.8094595270127;3972.4041393791163;4039.131586708813;4101.630853223224;4115.432626623028;1824.917878695462;1833.9266429342676;1859.1076283384052;1862.6274745051044;1879.2670858365248;795.8010497375656;814.2020819596828;831.268483734322;869.2177040663327;874.6151693254948;15955.680886382439;16110.275037623334;16389.426370077228;16474.83525164733;16926.558607204166;814.8329592433655;833.8189805890509;841.4110122913985;844.4679851693517;849.9362547808939;8828.558572071372;9172.724818255463;9257.583408746623;9368.859467107999;9648.421094734338;372187;383295;386066;387699;388627;79371.60314198393;80303;80805;81923.59038204771;82968.58515707383;876.4565969099199;893.65147592439;900.8424822549956;921.5622579274925;925.9027802080819;14453.710925781636;14550.781738274147;14751.188684622448;14926.477573284883;15200.543983680507;36714.4492832613;36848.44727329039;36907.446388304736;37298.25403491969;38090.428643569816;50501.242481362075;52277;52999;53110;53497;7564.962175189089;7630.504017238862;7787.221277872168;7866.646000929857;7915.208479152038;8560.529170895661;11106.222564420736;11896;11898.048156147313;12246.510139594317;10282.383057016305;10308.12380947628;10327.277090603586;10334.173266138841;10431.061204491329;9608.66369677058;10359.844602331123;10761.677149685522;10781.897529981577;10931.726706832393;10272.075513203847;10308.381497110197;10453.216008799218;10526.842097368699;10756.139508839118;7753.573553454614;7846.5292082475235;7862.208915834796;7940.801479962816;8086.9191308086165;7423.331900129015;9592.66425675098;10243.590256389662;10353.63762268317;10784.137269018303 06:37:29 INFO - PROCESS | 6496 | |3;mootools.html;1309.6791286134896;1360.7278544291141;1367.9794803077955;1653.6031352475409;1654.6856097341497;6872;7582.090149182092;7630.313271805537;8217.91782082179;8224.506529608228;7861.2531809478005;7925.048994120713;7936.841263174733;7974.362051035918;7979.601019949008;2119.480727221829;2159.7948194921537;2159.967600485994;2161.481244501324;2164.39396968849;2112.725345705056;2158.8920553972316;2190.9014094365793;2196.1105752170397;2197.2090047582856;2137.9465513362134;2151.0535364439675;2161.6217161996665;2161.6541353383464;2177.7604463509;2069.1619893942825;2087.8642888212294;2093.57081798231;2094.4030951178993;2094.926677566293;2044.6524090904581;2105.26315789474;2108.3042595943302;2108.536122053146;2111.292716939827;7890.80272993174;7929.722459713882;7984.960075199587;7993.680252789882;8014.519128852287;4587.105514424688;4741.075490279397;4772.260299653559;4785.377900872899;4796.856094317176;2919.3139612191117;2945.6907024762304;2969.510030844908;3025.9394812103856;3042.878284868603;880.6609455359669;934.9995504809856;951.3103000324778;951.7240000399876;957.7366224288306;10803.945980270128;10837.241393102486;10853.457327133612;10916.235863489559;10930.453477326182;4164.68764842638;4280.828766849291;4420.248557745191;4435.667324950641;4461.866144015685;9327.440353578808;9369;9370.156685898302;9385.483798391155;9415.293852961055;4868.391451068616;4895.6083513318845;4898.583620392235;4910.48439913811;4916.852494425173;3773.4339849022317;4144.274751918402;4292.377605247221;4444.1111777643955;4461.063176732922;3621.8732344367822;3657.8536858525363;3750.5311836020496;3777.20678657485;3784.564775050849;1165.3299352871963;1216.5559570756786;1237.8205160251714;1241.9813702794465;1246.7755803955374;793.1552896165565;842.1368097699907;849.8555245608138;852.6972924611797;861.8190180062131;5133.6919784813035;5380.7309634518115;5392.487713667196;5558.221848941152;5581.246531718247;410.0875551897065;410.1284769864039;413.05616665918234;415.91265834175164;419.8446574767295;3510.104923244556;3575.1419659281587;3650.2699460107556;3675.1179716868296;3694.556653201633;9519.857202141973;9863.654772083086;9901;9916.603335866628;10010.199184065257;9854.852177217348;9870.111689947938;9898.851517227247;9911.45486998222;9926.255530835071;6957.478189135733;7259.382952448996;7293.635318234067;7365.2634736525915;7414.073240844895;5503.807366742145;5660.433956604306;5661.433856614306;5695.487406133468;5699.145128230799;8702.91297087021;8745.30037596978;9203.953980230055;9244;9273.489958052372;8970.506622135845;9044.728658140004;9312.394694344846;9351.064893510595;9457.38526995743;6385.93614063872;6779.389854913082;6888.207856096613;7091.468139889425;7171.49799514029;7450.031495905498;7561.546307221584;7609;7611.467197296358;7643.159252482334;6735.831604209934;6781.525293229427;6832.180138383425;6981.720731170696;7096.325849044332;6682.766103186365;6698.39714425704;6760.797176084725;6856.314368563104;7012.719491220294;5951.494122999594;6021.126936594257;6023.698815059317;6036.63780173191;6057.7879774207695;4411.64706823447;4501.122281155143;4583.770811459481;4608.677392582487;4616.630669546361;4462.687611867138;4514.751688657024;4566.360709500606;4613.215753321876;4698.765061746831 06:37:29 INFO - PROCESS | 6496 | |4;prototype.html;306.80824484697064;312.8592133539907;312.95305704144374;314.42460297655293;314.8803454687218;5097.286379906816;5152.40747314059;5155.4586768389345;5157.638965272433;5159;5047.747612619363;5049.671771334861;5063.721495317756;5064.24036394541;5086;3781.2626537825067;3901.1807520420743;3917.1773927475265;3969.30537155998;3981.601839816024;3966.4050392441077;3974.9205015899665;3980.4626375439234;3983.2033593281317;4037.838486460538;3989.880303590897;4001.859934902279;4016.598340165989;4034.213328400963;4035.515738111431;3746.6253374662315;3941.2511622791862;3973.1060511384994;4035.8901302142;4040.272815849319;3441.9827900860337;3445.913852153716;3447.931041379158;3452;3456.844442000091;4993.725345106018;5015.548600625962;5026;5032.71011689684;5037.0681423936685;4285.764282964436;4515.164694531522;4529;4551.34005569194;4559.270516717309;5334.253204551366;5335.973320133413;5337.3061502004875;5367.087595108841;5373.865653358658;3762.567304759933;3771.9057023574355;3775.4336849472797;3787.9242415151816;3801.239752049601;5369.248305237309;5657.915131273035;5679.687617181054;5707.486326230618;5711.314642242957;3809.1619843634357;3823.311803875329;3845.4808600839087;3855.4602355670227;3862.4550179928256;3927.1752931884625;3934.5081864766903;3936;3937.586553411908;3941.684665226775;4519.350437090504;4524.683272170916;4526.321051842184;4527.117212143667;4541.6375087473625;5061.291419201315;5353.411124776271;5360.3031605891765;5389.946100539023;5400.864978375572;1347.8408568630969;1363.5363976248123;1367.0089185340548;1369.3084992078936;1370.6984463418032;829.324100857811;856.1267507142804;856.2379482260793;877.88587483628;883.1345281624044;4544.818207271672;4682.41469816273;4682.81268749253;4704.153252414599;4709.434867815884;5553;5559.19391688211;5564.527015203672;5568.610197286151;5600.887982240332;4472.524067057863;4738.573528382393;4742.245369213413;4750.786214620351;4755.857324280277;2934.855406391509;2992.1023692892045;2995.8951436699613;3002.2194229500487;3005.7144571265694;5211.5049070338255;5223.4776522347465;5233.764480598382;5237.73811309433;5267.051930652519;5440.347158341025;5738.655680659173;5743.8564035899435;5750;5768.480836724715;5214.139666954986;5257.710825904535;5263.763130659053;5267.552258058031;5287.41838397776;5596.804111856066;5637.689927054052;5640.54875609942;5657.745401456862;5674.716264186856;5197.283941981502;5463.863403414946;5469.234307196916;5494.5054945055135;5534.972325138348;5210.635255532076;5218.904030153711;5259.8422047338645;5266.473352664703;5300.6024548158275;3820.67524260441;3888.5333759948985;3915.8448257763457;3920.8039598020555;3922.8626998056075;5547.8890422192135;5559.27729395176;5569.939122524692;5570.164475328733;5593.608447408642;5358.650843222986;5389.191621256686;5396.652456181573;5408.864778380572;5412.485813847678;5141.203113517411;5324.307839980777;5387.488188622075;5394.676319420847;5401.000814849265;5238.76425560843;5258.842234732964;5266.315379000705;5269.262303277467;5283.973580132075;5212.739363031757;5235.528802407802;5321.521063104339;5403.675779453245;5419.972900135474;5221.399539052905;5235.973820131027;5279.841604751864;5319.813806516753;5321.308229930084 06:37:29 INFO - PROCESS | 6496 | |5;yui.html;565.9066254068078;581.8399940016495;583.7052288594259;584.3221862639339;618.4155972605887;10839.13286937045;10936.835947460784;11049.83425248621;13240.139390939583;13893.374798134082;12710.110292279544;12885.484580616787;12897.613071607844;12927.288999105045;13073.803892941614;750.4371721209106;766.6894907562446;771.3135309574483;771.9961400192991;772.4592785050459;623.2552100240215;743.3087228877142;759.6050053971932;767.7428061599371;770.0297624992522;813.2721214513007;815.592203898051;815.8123631564744;817.7873752824249;818.811673315135;800.5516910530122;801.7274126796888;802.1336956087441;808.1151139502235;810.4772421787914;586.7330364684101;591.4174538079988;591.5563327504372;591.7278052096041;592.0586267834165;11946.761064778742;12000.57997970067;12038.518459261619;12107;12111.515539378413;12215.450304736309;12309;12675.112742108056;12850.742985140338;12873.098883078188;9756.95121524395;9853.753656158582;9867.555959981819;9927.106560409526;9934.403935763805;3067.371188906269;3102.7828052036366;3104.736097431721;3105.549695294192;3130.6086739157604;61554.38445615531;61628.383716162716;62688;63781.999999999534;64096;9083.273338132933;9204.815903681889;9529.90470095304;9777.9022209777;10374.688759337232;17462.38881639162;17578.12109394525;17599.20803563843;17614.471565853044;17643.382481613084;6305.873882522324;6373.203349581302;6542.869142617216;6594.670266486753;6690.732370705215;3469.2020835208045;3511.4030614795547;3602.3335682898746;3608.296382205445;3671.5594128704724;2708.647875776176;2782.1236310562513;2790.6790719067567;2801.7058208887775;2805.312698388908;480.6179087625346;482.08644618447846;484.1648156929339;490.2058664962712;492.3894370979959;451.109059607273;497.3484734997093;521.304059081131;528.7092099345344;530.4112435196928;6744.763933262312;6810.489213309022;7136.286371362822;7215.0792660092375;7396.630168491554;454.1915390604729;479.64026979765174;481.2348366097921;505.9696418214919;520.5809323494548;3440.6559344065395;3673.430618254175;3691.8154092295276;3759.6804271637216;3990.840366385312;63293;106161;106451.4677426608;108369;108843;78096.60951695206;91587.54206228926;92837;94907.52546237224;95540.52229738807;74978;80088;81416.18583814205;81631.5918420404;86199.56900215584;7625.6949722010495;7641.847163056596;7657.961710191414;7906.209379062047;7951.363890888831;46611.53388466072;47089;47362.52637473581;47374;48440;70277;71976.28023719696;72427;73320.90018649831;74055;9320.161185493067;9469.242460602998;9621.422714637145;9731.416115032838;9804.852927205955;10439.164866810484;10666.57333706674;10686.946565267124;10756.677299681021;10761.946190268998;10169.186465082923;10177.491125443847;10218.284720069523;10350;11135.220534562826;9412.435253884789;9780.315377923476;9783.315167938175;9848.11366976947;10407.895921040996;9616.182624476998;9860.950695246478;9938.701838944844;10113.393196408239;10364.533595988349;8033.718819841278;8080;8109.351251899951;8219.30135938428;8270;7937.206279372017;8019.799505012421;8334.20825021622;8418.158184181533;8574.65701371963 06:37:29 INFO - PROCESS | 6496 | __end_tp_report 06:37:29 INFO - PROCESS | 6496 | __start_cc_report 06:37:29 INFO - PROCESS | 6496 | _x_x_mozilla_cycle_collect,358 06:37:29 INFO - PROCESS | 6496 | __end_cc_report 06:37:29 INFO - PROCESS | 6496 | __startTimestamp1469799449509__endTimestamp 06:37:29 INFO - PROCESS | 6496 | 06:37:29 INFO - PROCESS | 6496 | ------- Summary: start ------- 06:37:29 INFO - PROCESS | 6496 | Number of tests: 6 06:37:29 INFO - PROCESS | 6496 | 06:37:29 INFO - PROCESS | 6496 | [#0] dojo.html Cycles:165 Average:4860.60 Median:4953.00 stddev:513.95 (10.4%) stddev-sans-first:486.21 06:37:29 INFO - PROCESS | 6496 | Values: 2679.3 2696.3 2713.5 2722.1 2728.7 4786.7 4889.6 4901.2 4948.6 4951.9 4858.8 4864.9 4884.1 4915.4 4924.5 4529.4 4533.4 4537.0 4651.1 4664.1 4613.8 4620.3 4627.0 4645.2 4666.4 4387.6 4408.5 4456.7 4507.3 4536.9 4506.6 4513.8 4526.1 4546.5 4558.1 4456.4 4478.6 4495.8 4505.4 4553.2 4680.1 4782.8 4817.1 4856.6 4877.6 5282.9 5293.3 5306.2 5334.5 5343.7 5308.7 5308.9 5320.3 5322.0 5356.4 4767.6 4862.9 4889.0 4920.9 4936.2 5402.6 5422.1 5438.4 5456.2 5479.4 5183.8 5190.4 5198.7 5206.3 5241.2 5103.2 5168.9 5194.7 5304.4 5317.4 5221.7 5226.6 5252.6 5281.9 5292.3 5164.4 5201.1 5211.5 5222.1 5274.2 4335.7 4432.5 4451.2 4491.8 4506.3 3885.7 3898.3 3927.0 3938.3 3957.8 4455.4 4540.3 4547.4 4553.9 4595.4 5033.5 5238.2 5274.2 5287.0 5305.8 4541.5 4574.1 4591.7 4614.0 4617.4 4782.9 4785.5 4790.9 4797.8 4835.0 4790.0 4894.9 4941.4 4966.0 4969.3 5316.5 5326.6 5327.2 5336.8 5376.8 4953.0 4973.3 4983.5 4985.5 5003.7 5022.0 5054.9 5070.5 5246.4 5258.0 5192.8 5241.9 5271.8 5279.5 5367.9 5077.9 5093.4 5111.3 5144.9 5194.9 4902.6 5116.0 5128.4 5137.6 5147.6 4946.1 4949.3 5001.5 5036.3 5041.7 5154.1 5176.7 5179.1 5187.9 5234.7 4857.5 5022.2 5046.6 5070.7 5088.4 06:37:29 INFO - PROCESS | 6496 | 06:37:29 INFO - PROCESS | 6496 | [#1] ext.html Cycles:180 Average:47096.34 Median:198903.00 stddev:91926.46 (46.2%) stddev-sans-first:92117.90 06:37:29 INFO - PROCESS | 6496 | Values: 546.1 556.2 581.4 586.7 592.3 34404.8 38160.6 38189.8 38220.6 38229.2 38518.0 39088.2 39119.0 39158.8 39217.0 7658.9 7753.8 7804.4 7808.3 7818.3 7698.5 7758.4 7764.4 7773.8 7782.8 7776.5 7800.5 7832.6 7846.1 7864.6 7763.5 7796.5 7826.0 7838.7 7851.6 7686.3 7716.4 7721.5 7747.7 7774.4 36649.3 37017.6 37256.0 37283.1 37379.0 2555.4 2909.9 2932.6 2981.0 2984.9 24730.9 25900.0 26745.2 26950.3 27574.7 2696.4 2721.0 2727.4 2768.9 2840.8 226878.0 227252.0 228064.0 228120.0 229008.0 28725.4 31782.2 31822.4 31909.0 31921.8 29849.0 31927.7 31959.0 32117.8 32139.8 13680.9 13872.0 13873.6 13875.5 13929.7 11062.4 11117.6 11122.6 11129.4 11153.3 7730.2 7751.7 7792.8 7825.3 7845.9 3047.8 3066.8 3099.7 3129.6 3141.3 840.9 863.9 876.3 928.8 1036.0 28052.6 29541.6 29699.3 30381.7 32343.5 898.1 927.7 934.8 940.9 991.0 14561.5 14755.3 14936.8 15142.9 15207.6 414384.0 420784.0 421109.0 421918.0 423575.0 48663.5 48797.8 49117.3 49167.3 49240.3 1185.5 1198.0 1216.2 1225.3 1227.1 26159.0 27023.0 27575.7 27768.6 27970.9 42319.2 42992.8 43010.4 43036.8 43099.6 362059.0 362297.0 363859.0 363929.0 364268.0 25166.6 25248.6 25712.7 25738.2 25739.5 41439.6 41533.2 41550.8 41653.6 41752.2 33818.7 35477.8 36248.1 36876.8 37488.3 34956.0 35244.5 35286.0 35667.1 35747.0 34931.1 35099.8 36352.6 37412.3 37691.2 30910.2 33127.2 33316.0 33396.7 33592.5 24844.0 25301.6 25379.1 25616.5 26025.6 06:37:29 INFO - PROCESS | 6496 | 06:37:29 INFO - PROCESS | 6496 | [#2] jquery.html Cycles:180 Average:24224.97 Median:4790.32 stddev:63715.52 (1330.1%) stddev-sans-first:63869.07 06:37:29 INFO - PROCESS | 6496 | Values: 367.4 379.7 381.1 384.8 385.5 15677.5 16243.2 16900.8 17390.3 17441.7 16162.3 16638.8 16984.1 17054.2 17070.5 5019.0 5212.4 5220.8 5228.0 5241.4 5054.5 5108.2 5108.4 5125.0 5132.4 5099.3 5111.4 5124.7 5130.0 5130.3 4964.4 5006.0 5030.9 5084.0 5117.4 4501.5 4571.2 4582.2 4592.6 4616.3 13408.5 13422.9 13469.8 20393.6 20607.2 1733.5 1808.7 1888.8 1892.0 1903.1 8902.2 9136.2 9235.2 9301.5 9368.9 1534.8 1652.1 1662.7 1686.5 1711.8 75264.2 76034.6 76391.6 77982.0 78613.0 9264.8 9295.6 9414.7 9556.6 9850.4 13058.5 13098.5 13101.2 13119.9 13121.8 6840.5 7044.9 7051.4 7270.8 7312.6 6564.1 6728.7 6883.9 6913.7 6927.7 3810.8 3972.4 4039.1 4101.6 4115.4 1824.9 1833.9 1859.1 1862.6 1879.3 795.8 814.2 831.3 869.2 874.6 15955.7 16110.3 16389.4 16474.8 16926.6 814.8 833.8 841.4 844.5 849.9 8828.6 9172.7 9257.6 9368.9 9648.4 372187.0 383295.0 386066.0 387699.0 388627.0 79371.6 80303.0 80805.0 81923.6 82968.6 876.5 893.7 900.8 921.6 925.9 14453.7 14550.8 14751.2 14926.5 15200.5 36714.4 36848.4 36907.4 37298.3 38090.4 50501.2 52277.0 52999.0 53110.0 53497.0 7565.0 7630.5 7787.2 7866.6 7915.2 8560.5 11106.2 11896.0 11898.0 12246.5 10282.4 10308.1 10327.3 10334.2 10431.1 9608.7 10359.8 10761.7 10781.9 10931.7 10272.1 10308.4 10453.2 10526.8 10756.1 7753.6 7846.5 7862.2 7940.8 8086.9 7423.3 9592.7 10243.6 10353.6 10784.1 06:37:29 INFO - PROCESS | 6496 | 06:37:29 INFO - PROCESS | 6496 | [#3] mootools.html Cycles:180 Average:5208.01 Median:5025.27 stddev:2963.35 (59.0%) stddev-sans-first:2957.18 06:37:29 INFO - PROCESS | 6496 | Values: 1309.7 1360.7 1368.0 1653.6 1654.7 6872.0 7582.1 7630.3 8217.9 8224.5 7861.3 7925.0 7936.8 7974.4 7979.6 2119.5 2159.8 2160.0 2161.5 2164.4 2112.7 2158.9 2190.9 2196.1 2197.2 2137.9 2151.1 2161.6 2161.7 2177.8 2069.2 2087.9 2093.6 2094.4 2094.9 2044.7 2105.3 2108.3 2108.5 2111.3 7890.8 7929.7 7985.0 7993.7 8014.5 4587.1 4741.1 4772.3 4785.4 4796.9 2919.3 2945.7 2969.5 3025.9 3042.9 880.7 935.0 951.3 951.7 957.7 10803.9 10837.2 10853.5 10916.2 10930.5 4164.7 4280.8 4420.2 4435.7 4461.9 9327.4 9369.0 9370.2 9385.5 9415.3 4868.4 4895.6 4898.6 4910.5 4916.9 3773.4 4144.3 4292.4 4444.1 4461.1 3621.9 3657.9 3750.5 3777.2 3784.6 1165.3 1216.6 1237.8 1242.0 1246.8 793.2 842.1 849.9 852.7 861.8 5133.7 5380.7 5392.5 5558.2 5581.2 410.1 410.1 413.1 415.9 419.8 3510.1 3575.1 3650.3 3675.1 3694.6 9519.9 9863.7 9901.0 9916.6 10010.2 9854.9 9870.1 9898.9 9911.5 9926.3 6957.5 7259.4 7293.6 7365.3 7414.1 5503.8 5660.4 5661.4 5695.5 5699.1 8702.9 8745.3 9204.0 9244.0 9273.5 8970.5 9044.7 9312.4 9351.1 9457.4 6385.9 6779.4 6888.2 7091.5 7171.5 7450.0 7561.5 7609.0 7611.5 7643.2 6735.8 6781.5 6832.2 6981.7 7096.3 6682.8 6698.4 6760.8 6856.3 7012.7 5951.5 6021.1 6023.7 6036.6 6057.8 4411.6 4501.1 4583.8 4608.7 4616.6 4462.7 4514.8 4566.4 4613.2 4698.8 06:37:29 INFO - PROCESS | 6496 | 06:37:29 INFO - PROCESS | 6496 | [#4] prototype.html Cycles:180 Average:4455.38 Median:5091.64 stddev:1310.38 (25.7%) stddev-sans-first:1276.53 06:37:29 INFO - PROCESS | 6496 | Values: 306.8 312.9 313.0 314.4 314.9 5097.3 5152.4 5155.5 5157.6 5159.0 5047.7 5049.7 5063.7 5064.2 5086.0 3781.3 3901.2 3917.2 3969.3 3981.6 3966.4 3974.9 3980.5 3983.2 4037.8 3989.9 4001.9 4016.6 4034.2 4035.5 3746.6 3941.3 3973.1 4035.9 4040.3 3442.0 3445.9 3447.9 3452.0 3456.8 4993.7 5015.5 5026.0 5032.7 5037.1 4285.8 4515.2 4529.0 4551.3 4559.3 5334.3 5336.0 5337.3 5367.1 5373.9 3762.6 3771.9 3775.4 3787.9 3801.2 5369.2 5657.9 5679.7 5707.5 5711.3 3809.2 3823.3 3845.5 3855.5 3862.5 3927.2 3934.5 3936.0 3937.6 3941.7 4519.4 4524.7 4526.3 4527.1 4541.6 5061.3 5353.4 5360.3 5389.9 5400.9 1347.8 1363.5 1367.0 1369.3 1370.7 829.3 856.1 856.2 877.9 883.1 4544.8 4682.4 4682.8 4704.2 4709.4 5553.0 5559.2 5564.5 5568.6 5600.9 4472.5 4738.6 4742.2 4750.8 4755.9 2934.9 2992.1 2995.9 3002.2 3005.7 5211.5 5223.5 5233.8 5237.7 5267.1 5440.3 5738.7 5743.9 5750.0 5768.5 5214.1 5257.7 5263.8 5267.6 5287.4 5596.8 5637.7 5640.5 5657.7 5674.7 5197.3 5463.9 5469.2 5494.5 5535.0 5210.6 5218.9 5259.8 5266.5 5300.6 3820.7 3888.5 3915.8 3920.8 3922.9 5547.9 5559.3 5569.9 5570.2 5593.6 5358.7 5389.2 5396.7 5408.9 5412.5 5141.2 5324.3 5387.5 5394.7 5401.0 5238.8 5258.8 5266.3 5269.3 5284.0 5212.7 5235.5 5321.5 5403.7 5420.0 5221.4 5236.0 5279.8 5319.8 5321.3 06:37:29 INFO - PROCESS | 6496 | 06:37:29 INFO - PROCESS | 6496 | [#5] yui.html Cycles:180 Average:17953.35 Median:591.89 stddev:27270.73 (4607.4%) stddev-sans-first:27315.98 06:37:29 INFO - PROCESS | 6496 | Values: 565.9 581.8 583.7 584.3 618.4 10839.1 10936.8 11049.8 13240.1 13893.4 12710.1 12885.5 12897.6 12927.3 13073.8 750.4 766.7 771.3 772.0 772.5 623.3 743.3 759.6 767.7 770.0 813.3 815.6 815.8 817.8 818.8 800.6 801.7 802.1 808.1 810.5 586.7 591.4 591.6 591.7 592.1 11946.8 12000.6 12038.5 12107.0 12111.5 12215.5 12309.0 12675.1 12850.7 12873.1 9757.0 9853.8 9867.6 9927.1 9934.4 3067.4 3102.8 3104.7 3105.5 3130.6 61554.4 61628.4 62688.0 63782.0 64096.0 9083.3 9204.8 9529.9 9777.9 10374.7 17462.4 17578.1 17599.2 17614.5 17643.4 6305.9 6373.2 6542.9 6594.7 6690.7 3469.2 3511.4 3602.3 3608.3 3671.6 2708.6 2782.1 2790.7 2801.7 2805.3 480.6 482.1 484.2 490.2 492.4 451.1 497.3 521.3 528.7 530.4 6744.8 6810.5 7136.3 7215.1 7396.6 454.2 479.6 481.2 506.0 520.6 3440.7 3673.4 3691.8 3759.7 3990.8 63293.0 106161.0 106451.5 108369.0 108843.0 78096.6 91587.5 92837.0 94907.5 95540.5 74978.0 80088.0 81416.2 81631.6 86199.6 7625.7 7641.8 7658.0 7906.2 7951.4 46611.5 47089.0 47362.5 47374.0 48440.0 70277.0 71976.3 72427.0 73320.9 74055.0 9320.2 9469.2 9621.4 9731.4 9804.9 10439.2 10666.6 10686.9 10756.7 10761.9 10169.2 10177.5 10218.3 10350.0 11135.2 9412.4 9780.3 9783.3 9848.1 10407.9 9616.2 9861.0 9938.7 10113.4 10364.5 8033.7 8080.0 8109.4 8219.3 8270.0 7937.2 8019.8 8334.2 8418.2 8574.7 06:37:29 INFO - PROCESS | 6496 | -------- Summary: end -------- 06:37:29 INFO - PROCESS | 6496 | 06:37:30 INFO - TEST-INFO | 6496: exit 0 06:37:30 INFO - TEST-OK | dromaeo_css | took 1116930ms 06:37:30 INFO - TEST-START | kraken 06:37:30 INFO - operating with platform_type : linux_ 06:37:30 INFO - Initialising browser for kraken test... 06:37:30 INFO - TEST-INFO | started process 6739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZpcEFd/profile http://localhost:54177/getInfo.html) 06:37:33 INFO - PROCESS | 6739 | JavaScript error: , line 0: uncaught exception: undefined 06:37:35 INFO - PROCESS | 6739 | __metrics Screen width/height:1600/1200 06:37:35 INFO - PROCESS | 6739 | colorDepth:24 06:37:35 INFO - PROCESS | 6739 | Browser inner width/height: 1024/697 06:37:35 INFO - PROCESS | 6739 | __metrics 06:37:35 ERROR - PROCESS | 6739 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:37:36 INFO - TEST-INFO | 6739: exit 0 06:37:36 INFO - Browser initialized. 06:37:36 INFO - Running cycle 1/1 for kraken test... 06:37:36 INFO - TEST-INFO | started process 6854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZpcEFd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:48 INFO - PROCESS | 6854 | RSS: Main: 166318080 06:37:48 INFO - PROCESS | 6854 | 06:37:51 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54177/tests/kraken/driver.html?testName=audio-beat-detection) 06:37:52 INFO - PROCESS | 6854 | RSS: Main: 171716608 06:37:52 INFO - PROCESS | 6854 | 06:37:55 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54177/tests/kraken/driver.html?testName=audio-dft) 06:37:55 INFO - PROCESS | 6854 | RSS: Main: 170639360 06:37:55 INFO - PROCESS | 6854 | 06:37:58 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54177/tests/kraken/driver.html?testName=audio-fft) 06:37:59 INFO - PROCESS | 6854 | RSS: Main: 166801408 06:37:59 INFO - PROCESS | 6854 | 06:38:01 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54177/tests/kraken/driver.html?testName=audio-oscillator) 06:38:02 INFO - PROCESS | 6854 | RSS: Main: 167243776 06:38:02 INFO - PROCESS | 6854 | 06:38:04 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54177/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:38:04 INFO - PROCESS | 6854 | RSS: Main: 167895040 06:38:04 INFO - PROCESS | 6854 | 06:38:08 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54177/tests/kraken/driver.html?testName=imaging-darkroom) 06:38:08 INFO - PROCESS | 6854 | RSS: Main: 168472576 06:38:08 INFO - PROCESS | 6854 | 06:38:12 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54177/tests/kraken/driver.html?testName=imaging-desaturate) 06:38:13 INFO - PROCESS | 6854 | RSS: Main: 165171200 06:38:13 INFO - PROCESS | 6854 | 06:38:15 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54177/tests/kraken/driver.html?testName=json-parse-financial) 06:38:16 INFO - PROCESS | 6854 | RSS: Main: 167329792 06:38:16 INFO - PROCESS | 6854 | 06:38:18 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54177/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:38:18 INFO - PROCESS | 6854 | RSS: Main: 167272448 06:38:18 INFO - PROCESS | 6854 | 06:38:20 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54177/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:38:21 INFO - PROCESS | 6854 | RSS: Main: 167391232 06:38:21 INFO - PROCESS | 6854 | 06:38:23 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54177/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:38:24 INFO - PROCESS | 6854 | RSS: Main: 168529920 06:38:24 INFO - PROCESS | 6854 | 06:38:27 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54177/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:38:27 INFO - PROCESS | 6854 | RSS: Main: 168013824 06:38:27 INFO - PROCESS | 6854 | 06:38:30 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54177/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:38:31 INFO - PROCESS | 6854 | RSS: Main: 168411136 06:38:31 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:54177/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54177/tests/kraken/driver.html?testName=ai-astar) 06:38:33 INFO - PROCESS | 6854 | RSS: Main: 169197568 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | __start_tp_report 06:38:33 INFO - PROCESS | 6854 | _x_x_mozilla_page_load 06:38:33 INFO - PROCESS | 6854 | _x_x_mozilla_page_load_details 06:38:33 INFO - PROCESS | 6854 | |i|pagename|runs| 06:38:33 INFO - PROCESS | 6854 | |0;ai-astar;104;117;107;115;114;114;115;115;114;114 06:38:33 INFO - PROCESS | 6854 | |1;audio-beat-detection;157;122;145;192;124;145;149;124;186;123 06:38:33 INFO - PROCESS | 6854 | |2;audio-dft;167;164;162;166;169;163;163;163;162;163 06:38:33 INFO - PROCESS | 6854 | |3;audio-fft;75;77;76;186;78;78;76;75;166;76 06:38:33 INFO - PROCESS | 6854 | |4;audio-oscillator;87;85;162;87;86;86;138;85;85;137 06:38:33 INFO - PROCESS | 6854 | |5;imaging-gaussian-blur;117;118;120;118;118;118;118;122;119;117 06:38:33 INFO - PROCESS | 6854 | |6;imaging-darkroom;149;149;148;147;147;149;149;149;151;147 06:38:33 INFO - PROCESS | 6854 | |7;imaging-desaturate;95;96;95;95;96;98;96;96;101;95 06:38:33 INFO - PROCESS | 6854 | |8;json-parse-financial;62;62;63;62;63;62;62;61;62;73 06:38:33 INFO - PROCESS | 6854 | |9;json-stringify-tinderbox;66;67;66;66;67;65;66;67;67;67 06:38:33 INFO - PROCESS | 6854 | |10;stanford-crypto-aes;86;91;80;79;83;80;79;80;85;81 06:38:33 INFO - PROCESS | 6854 | |11;stanford-crypto-ccm;135;132;146;131;155;130;133;137;169;135 06:38:33 INFO - PROCESS | 6854 | |12;stanford-crypto-pbkdf2;173;172;168;163;167;170;165;177;166;167 06:38:33 INFO - PROCESS | 6854 | |13;stanford-crypto-sha256-iterative;67;70;68;66;73;70;67;67;67;66 06:38:33 INFO - PROCESS | 6854 | __end_tp_report 06:38:33 INFO - PROCESS | 6854 | __start_cc_report 06:38:33 INFO - PROCESS | 6854 | _x_x_mozilla_cycle_collect,971 06:38:33 INFO - PROCESS | 6854 | __end_cc_report 06:38:33 INFO - PROCESS | 6854 | __startTimestamp1469799513335__endTimestamp 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | ------- Summary: start ------- 06:38:33 INFO - PROCESS | 6854 | Number of tests: 14 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.50 stddev:4.07 (3.6%) stddev-sans-first:2.76 06:38:33 INFO - PROCESS | 6854 | Values: 104.0 117.0 107.0 115.0 114.0 114.0 115.0 115.0 114.0 114.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:147.00 stddev:25.64 (17.4%) stddev-sans-first:26.92 06:38:33 INFO - PROCESS | 6854 | Values: 157.0 122.0 145.0 192.0 124.0 145.0 149.0 124.0 186.0 123.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:2.35 (1.4%) stddev-sans-first:2.26 06:38:33 INFO - PROCESS | 6854 | Values: 167.0 164.0 162.0 166.0 169.0 163.0 163.0 163.0 162.0 163.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#3] audio-fft Cycles:10 Average:96.30 Median:76.00 stddev:42.28 (55.6%) stddev-sans-first:44.14 06:38:33 INFO - PROCESS | 6854 | Values: 75.0 77.0 76.0 186.0 78.0 78.0 76.0 75.0 166.0 76.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:85.50 stddev:29.66 (34.7%) stddev-sans-first:30.83 06:38:33 INFO - PROCESS | 6854 | Values: 87.0 85.0 162.0 87.0 86.0 86.0 138.0 85.0 85.0 137.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:1.51 (1.3%) stddev-sans-first:1.50 06:38:33 INFO - PROCESS | 6854 | Values: 117.0 118.0 120.0 118.0 118.0 118.0 118.0 122.0 119.0 117.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:1.27 (0.9%) stddev-sans-first:1.33 06:38:33 INFO - PROCESS | 6854 | Values: 149.0 149.0 148.0 147.0 147.0 149.0 149.0 149.0 151.0 147.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.89 (2.0%) stddev-sans-first:1.94 06:38:33 INFO - PROCESS | 6854 | Values: 95.0 96.0 95.0 95.0 96.0 98.0 96.0 96.0 101.0 95.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:62.00 stddev:3.49 (5.6%) stddev-sans-first:3.67 06:38:33 INFO - PROCESS | 6854 | Values: 62.0 62.0 63.0 62.0 63.0 62.0 62.0 61.0 62.0 73.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 06:38:33 INFO - PROCESS | 6854 | Values: 66.0 67.0 66.0 66.0 67.0 65.0 66.0 67.0 67.0 67.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:3.89 (4.7%) stddev-sans-first:3.91 06:38:33 INFO - PROCESS | 6854 | Values: 86.0 91.0 80.0 79.0 83.0 80.0 79.0 80.0 85.0 81.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:136.00 stddev:12.71 (9.3%) stddev-sans-first:13.34 06:38:33 INFO - PROCESS | 6854 | Values: 135.0 132.0 146.0 131.0 155.0 130.0 133.0 137.0 169.0 135.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.00 stddev:4.21 (2.5%) stddev-sans-first:4.18 06:38:33 INFO - PROCESS | 6854 | Values: 173.0 172.0 168.0 163.0 167.0 170.0 165.0 177.0 166.0 167.0 06:38:33 INFO - PROCESS | 6854 | 06:38:33 INFO - PROCESS | 6854 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.50 stddev:2.23 (3.3%) stddev-sans-first:2.33 06:38:33 INFO - PROCESS | 6854 | Values: 67.0 70.0 68.0 66.0 73.0 70.0 67.0 67.0 67.0 66.0 06:38:33 INFO - PROCESS | 6854 | -------- Summary: end -------- 06:38:33 INFO - PROCESS | 6854 | 06:38:34 INFO - TEST-INFO | 6854: exit 0 06:38:34 INFO - TEST-OK | kraken | took 64103ms 06:38:34 INFO - SUITE-END | took 1181s 06:38:34 INFO - Completed test suite (00:19:41) 06:38:34 INFO - javascript benchmark 06:38:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6314.221606015993, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2679.3167742225737, 2696.32591852037, 2713.47087317973, 2722.142525104592, 2728.7407696268847, 4786.712797232169, 4889.5599396054395, 4901.2403077522995, 4948.554630083292, 4951.900961980758, 4858.757062146888, 4864.902701945959, 4884.072026314998, 4915.3610030696045, 4924.482929292427, 4529.365888775574, 4533.387992621004, 4536.977315113428, 4651.139539185245, 4664.067186562684, 4613.76931153441, 4620.3069539569, 4626.953730462703, 4645.163870503308, 4666.39336886206, 4387.605115539584, 4408.493023302297, 4456.710313829591, 4507.346434766973, 4536.933820552184, 4506.639468842484, 4513.7517436540975, 4526.072155208174, 4546.54534546546, 4558.088382323515, 4456.376107344974, 4478.596926276651, 4495.797689103998, 4505.43682039745, 4553.203189441834, 4680.134175177569, 4782.832600858988, 4817.108834865561, 4856.61147108234, 4877.585405240558, 5282.920756188661, 5293.285406470116, 5306.177542480922, 5334.519893209591, 5343.706096164709, 5308.70802105884, 5308.92036619451, 5320.281761962125, 5321.973390133063, 5356.384015838151, 4767.642426818003, 4862.854114376574, 4889.022195560902, 4920.876978075541, 4936.234883593049, 5402.621816472888, 5422.105352616774, 5438.401775804658, 5456.154296084113, 5479.369872464637, 5183.81856635016, 5190.351206099238, 5198.6880787152895, 5206.323177986837, 5241.24002019705, 5103.209002604603, 5168.870778230575, 5194.740262986836, 5304.38999515053, 5317.361916570037, 5221.738913054332, 5226.5818734501145, 5252.579793616502, 5281.9207711884355, 5292.285541451854, 5164.354455693038, 5201.08980928336, 5211.5049070338255, 5222.060029194781, 5274.182501712241, 4335.7181783184, 4432.512423633398, 4451.198784218872, 4491.797869095833, 4506.324051392317, 3885.669718073995, 3898.2593307271527, 3927.0, 3938.2714197873483, 3957.762534247954, 4455.353973673864, 4540.341650460665, 4547.363369128325, 4553.908921821611, 4595.448546174481, 5033.521815427602, 5238.188080847474, 5274.182501712241, 5287.048331300326, 5305.814296499604, 4541.5231400703115, 4574.108048930493, 4591.655625828076, 4614.031053478807, 4617.376654151646, 4782.904341913142, 4785.545373189541, 4790.856274311776, 4797.760111994457, 4834.9604834960655, 4789.95210047909, 4894.853154405374, 4941.357623508921, 4965.950340496549, 4969.254611808257, 5316.494932981361, 5326.600504962066, 5327.22755200486, 5336.7598458068705, 5376.838694839161, 4953.0, 4973.303737476684, 4983.501649834988, 4985.501449855131, 5003.749812509433, 5021.974890125526, 5054.873628159326, 5070.543651071422, 5246.3704355477585, 5257.973710131425, 5192.818251361185, 5241.868953276198, 5271.762770675406, 5279.52484276417, 5367.946320536745, 5077.9238311424615, 5093.439721630692, 5111.284420181252, 5144.948550514597, 5194.922076168936, 4902.63230257725, 5115.974420127875, 5128.435872054146, 5137.588992880485, 5147.5881929446305, 4946.060248552763, 4949.257611358325, 5001.474845141353, 5036.320096786887, 5041.7227052511, 5154.072266991978, 5176.7152806594495, 5179.093658609803, 5187.896242075062, 5234.712090835041, 4857.514248575114, 5022.171341728574, 5046.621503387188, 5070.670406423571, 5088.363954505687], "value": 4827.3067490024805, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.0907588864538, 556.2462862820877, 581.3808294166712, 586.7095787585145, 592.2744637818676, 34404.82797586012, 38160.618393816054, 38189.80905095474, 38220.61779382205, 38229.235415291674, 38518.0, 39088.21823563527, 39119.0, 39158.80420597893, 39217.0, 7658.88511672324, 7753.806154846146, 7804.375649948019, 7808.297253247207, 7818.296353328199, 7698.461107722434, 7758.418118641096, 7764.417668674843, 7773.844523109535, 7782.805429864242, 7776.494527855672, 7800.453968222227, 7832.56920869352, 7846.136924938281, 7864.606769661494, 7763.456558040939, 7796.454248202628, 7826.021747281618, 7838.725644602411, 7851.5681637509915, 7686.3082322591235, 7716.4212684048925, 7721.459497835153, 7747.690092396298, 7774.416918731118, 36649.267014659825, 37017.62982370196, 37256.0, 37283.06792330186, 37379.0, 2555.4378036831868, 2909.86905589249, 2932.648082230146, 2981.0311648714037, 2984.910452686423, 24730.876345618155, 25899.96400143992, 26745.197644070515, 26950.326241843915, 27574.724252757416, 2696.433748912711, 2720.986395068032, 2727.3727042780074, 2768.9169324920285, 2840.786940979435, 226878.0, 227252.0, 228064.0, 228120.0, 229008.0, 28725.42549149047, 31782.205444864063, 31822.363552728817, 31909.0, 31921.840390797897, 29849.0, 31927.680723192472, 31959.0, 32117.839410803263, 32139.839300803815, 13680.93159534196, 13872.0, 13873.58379248624, 13875.514356997659, 13929.651758706113, 11062.446877656084, 11117.55529778816, 11122.555097795997, 11129.443527823576, 11153.330800151854, 7730.188330225358, 7751.651175697107, 7792.7781798218475, 7825.256600622932, 7845.9215407845195, 3047.832369219714, 3066.7853250272265, 3099.6900309969274, 3129.6244450666068, 3141.3246152076954, 840.8612578924409, 863.9136086391311, 876.2902049339928, 928.7956649537226, 1035.9855559706139, 28052.579211311848, 29541.556876646868, 29699.257518562208, 30381.69618303833, 32343.51484727731, 898.0615257056392, 927.6567669962158, 934.7709811096325, 940.872982147415, 991.0, 14561.490347837987, 14755.262236888113, 14936.775948360782, 15142.9399942003, 15207.619809504851, 414384.0, 420784.0, 421109.0, 421918.0, 423575.0, 48663.51336486661, 48797.75601121972, 49117.26324105141, 49167.26249106266, 49240.261396079084, 1185.4546908422221, 1197.988020119805, 1216.2398500936915, 1225.2954551133134, 1227.0735594626, 26159.0, 27023.0, 27575.72424275812, 27768.583471248352, 27970.860145699142, 42319.1536169281, 42992.785036074616, 43010.35484467673, 43036.84815759262, 43099.56900430955, 362059.0, 362297.0, 363859.0, 363929.0, 364268.0, 25166.62250066287, 25248.621270680585, 25712.742872571034, 25738.19832611774, 25739.485210296065, 41439.58560414357, 41533.169336613704, 41550.792246038574, 41653.583464166186, 41752.164956700086, 33818.66181338155, 35477.82261088678, 36248.09379765527, 36876.81561592175, 37488.25023499569, 34956.0, 35244.47133292951, 35286.0, 35667.10832229111, 35747.0, 34931.12672183114, 35099.82450087733, 36352.63647363493, 37412.25175496529, 37691.24617507689, 30910.22724431907, 33127.17182070467, 33316.0, 33396.66603334033, 33592.49611255784, 24844.0, 25301.62047569251, 25379.092576030976, 25616.487670246865, 26025.609615856156], "value": 16062.966150401036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.353457914071, 379.7455704677865, 381.12911996088934, 384.76144790230063, 385.52387801065663, 15677.45128920488, 16243.187840607967, 16900.83099169008, 17390.30438782447, 17441.65116697665, 16162.2726977286, 16638.75041874373, 16984.065876376793, 17054.23255953482, 17070.48788536343, 5019.0, 5212.4266330703595, 5220.843374698765, 5227.980543793961, 5241.449647786984, 5054.519820617035, 5108.208227724708, 5108.386993560778, 5125.0, 5132.384113906336, 5099.286099946011, 5111.386633603973, 5124.743762811863, 5130.02529519392, 5130.307408499861, 4964.354633897588, 5006.0, 5030.89938201234, 5084.034033533654, 5117.360329958755, 4501.527339629324, 4571.2000399929875, 4582.221022426195, 4592.563706447882, 4616.28447590624, 13408.46366145353, 13422.86577134226, 13469.797953030713, 20393.592128157503, 20607.175712971613, 1733.5232810976956, 1808.7467754514246, 1888.792232854385, 1891.9527011824678, 1903.077007651288, 8902.243309318716, 9136.223421009223, 9235.215006724437, 9301.534923253877, 9368.90631093687, 1534.8311685714561, 1652.0913497576284, 1662.717338052534, 1686.4519031314871, 1711.845933865958, 75264.24735752627, 76034.61982690051, 76391.61804190943, 77982.0, 78613.0, 9264.768380790534, 9295.628174872929, 9414.670486533076, 9556.617735290649, 9850.359726617748, 13058.542950996669, 13098.541551045668, 13101.213927164401, 13119.934400328128, 13121.803172952414, 6840.486963477759, 7044.894326585106, 7051.400630946325, 7270.818229544304, 7312.561246325237, 6564.113844631009, 6728.6635668216395, 6883.8967415488805, 6913.654317284116, 6927.7228910843005, 3810.8094595270127, 3972.4041393791163, 4039.131586708813, 4101.630853223224, 4115.432626623028, 1824.917878695462, 1833.9266429342676, 1859.1076283384052, 1862.6274745051044, 1879.2670858365248, 795.8010497375656, 814.2020819596828, 831.268483734322, 869.2177040663327, 874.6151693254948, 15955.680886382439, 16110.275037623334, 16389.426370077228, 16474.83525164733, 16926.558607204166, 814.8329592433655, 833.8189805890509, 841.4110122913985, 844.4679851693517, 849.9362547808939, 8828.558572071372, 9172.724818255463, 9257.583408746623, 9368.859467107999, 9648.421094734338, 372187.0, 383295.0, 386066.0, 387699.0, 388627.0, 79371.60314198393, 80303.0, 80805.0, 81923.59038204771, 82968.58515707383, 876.4565969099199, 893.65147592439, 900.8424822549956, 921.5622579274925, 925.9027802080819, 14453.710925781636, 14550.781738274147, 14751.188684622448, 14926.477573284883, 15200.543983680507, 36714.4492832613, 36848.44727329039, 36907.446388304736, 37298.25403491969, 38090.428643569816, 50501.242481362075, 52277.0, 52999.0, 53110.0, 53497.0, 7564.962175189089, 7630.504017238862, 7787.221277872168, 7866.646000929857, 7915.208479152038, 8560.529170895661, 11106.222564420736, 11896.0, 11898.048156147313, 12246.510139594317, 10282.383057016305, 10308.12380947628, 10327.277090603586, 10334.173266138841, 10431.061204491329, 9608.66369677058, 10359.844602331123, 10761.677149685522, 10781.897529981577, 10931.726706832393, 10272.075513203847, 10308.381497110197, 10453.216008799218, 10526.842097368699, 10756.139508839118, 7753.573553454614, 7846.5292082475235, 7862.208915834796, 7940.801479962816, 8086.9191308086165, 7423.331900129015, 9592.66425675098, 10243.590256389662, 10353.63762268317, 10784.137269018303], "value": 8007.712777901028, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.6791286134896, 1360.7278544291141, 1367.9794803077955, 1653.6031352475409, 1654.6856097341497, 6872.0, 7582.090149182092, 7630.313271805537, 8217.91782082179, 8224.506529608228, 7861.2531809478005, 7925.048994120713, 7936.841263174733, 7974.362051035918, 7979.601019949008, 2119.480727221829, 2159.7948194921537, 2159.967600485994, 2161.481244501324, 2164.39396968849, 2112.725345705056, 2158.8920553972316, 2190.9014094365793, 2196.1105752170397, 2197.2090047582856, 2137.9465513362134, 2151.0535364439675, 2161.6217161996665, 2161.6541353383464, 2177.7604463509, 2069.1619893942825, 2087.8642888212294, 2093.57081798231, 2094.4030951178993, 2094.926677566293, 2044.6524090904581, 2105.26315789474, 2108.3042595943302, 2108.536122053146, 2111.292716939827, 7890.80272993174, 7929.722459713882, 7984.960075199587, 7993.680252789882, 8014.519128852287, 4587.105514424688, 4741.075490279397, 4772.260299653559, 4785.377900872899, 4796.856094317176, 2919.3139612191117, 2945.6907024762304, 2969.510030844908, 3025.9394812103856, 3042.878284868603, 880.6609455359669, 934.9995504809856, 951.3103000324778, 951.7240000399876, 957.7366224288306, 10803.945980270128, 10837.241393102486, 10853.457327133612, 10916.235863489559, 10930.453477326182, 4164.68764842638, 4280.828766849291, 4420.248557745191, 4435.667324950641, 4461.866144015685, 9327.440353578808, 9369.0, 9370.156685898302, 9385.483798391155, 9415.293852961055, 4868.391451068616, 4895.6083513318845, 4898.583620392235, 4910.48439913811, 4916.852494425173, 3773.4339849022317, 4144.274751918402, 4292.377605247221, 4444.1111777643955, 4461.063176732922, 3621.8732344367822, 3657.8536858525363, 3750.5311836020496, 3777.20678657485, 3784.564775050849, 1165.3299352871963, 1216.5559570756786, 1237.8205160251714, 1241.9813702794465, 1246.7755803955374, 793.1552896165565, 842.1368097699907, 849.8555245608138, 852.6972924611797, 861.8190180062131, 5133.6919784813035, 5380.7309634518115, 5392.487713667196, 5558.221848941152, 5581.246531718247, 410.0875551897065, 410.1284769864039, 413.05616665918234, 415.91265834175164, 419.8446574767295, 3510.104923244556, 3575.1419659281587, 3650.2699460107556, 3675.1179716868296, 3694.556653201633, 9519.857202141973, 9863.654772083086, 9901.0, 9916.603335866628, 10010.199184065257, 9854.852177217348, 9870.111689947938, 9898.851517227247, 9911.45486998222, 9926.255530835071, 6957.478189135733, 7259.382952448996, 7293.635318234067, 7365.2634736525915, 7414.073240844895, 5503.807366742145, 5660.433956604306, 5661.433856614306, 5695.487406133468, 5699.145128230799, 8702.91297087021, 8745.30037596978, 9203.953980230055, 9244.0, 9273.489958052372, 8970.506622135845, 9044.728658140004, 9312.394694344846, 9351.064893510595, 9457.38526995743, 6385.93614063872, 6779.389854913082, 6888.207856096613, 7091.468139889425, 7171.49799514029, 7450.031495905498, 7561.546307221584, 7609.0, 7611.467197296358, 7643.159252482334, 6735.831604209934, 6781.525293229427, 6832.180138383425, 6981.720731170696, 7096.325849044332, 6682.766103186365, 6698.39714425704, 6760.797176084725, 6856.314368563104, 7012.719491220294, 5951.494122999594, 6021.126936594257, 6023.698815059317, 6036.63780173191, 6057.7879774207695, 4411.64706823447, 4501.122281155143, 4583.770811459481, 4608.677392582487, 4616.630669546361, 4462.687611867138, 4514.751688657024, 4566.360709500606, 4613.215753321876, 4698.765061746831], "value": 4105.169764438098, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.80824484697064, 312.8592133539907, 312.95305704144374, 314.42460297655293, 314.8803454687218, 5097.286379906816, 5152.40747314059, 5155.4586768389345, 5157.638965272433, 5159.0, 5047.747612619363, 5049.671771334861, 5063.721495317756, 5064.24036394541, 5086.0, 3781.2626537825067, 3901.1807520420743, 3917.1773927475265, 3969.30537155998, 3981.601839816024, 3966.4050392441077, 3974.9205015899665, 3980.4626375439234, 3983.2033593281317, 4037.838486460538, 3989.880303590897, 4001.859934902279, 4016.598340165989, 4034.213328400963, 4035.515738111431, 3746.6253374662315, 3941.2511622791862, 3973.1060511384994, 4035.8901302142, 4040.272815849319, 3441.9827900860337, 3445.913852153716, 3447.931041379158, 3452.0, 3456.844442000091, 4993.725345106018, 5015.548600625962, 5026.0, 5032.71011689684, 5037.0681423936685, 4285.764282964436, 4515.164694531522, 4529.0, 4551.34005569194, 4559.270516717309, 5334.253204551366, 5335.973320133413, 5337.3061502004875, 5367.087595108841, 5373.865653358658, 3762.567304759933, 3771.9057023574355, 3775.4336849472797, 3787.9242415151816, 3801.239752049601, 5369.248305237309, 5657.915131273035, 5679.687617181054, 5707.486326230618, 5711.314642242957, 3809.1619843634357, 3823.311803875329, 3845.4808600839087, 3855.4602355670227, 3862.4550179928256, 3927.1752931884625, 3934.5081864766903, 3936.0, 3937.586553411908, 3941.684665226775, 4519.350437090504, 4524.683272170916, 4526.321051842184, 4527.117212143667, 4541.6375087473625, 5061.291419201315, 5353.411124776271, 5360.3031605891765, 5389.946100539023, 5400.864978375572, 1347.8408568630969, 1363.5363976248123, 1367.0089185340548, 1369.3084992078936, 1370.6984463418032, 829.324100857811, 856.1267507142804, 856.2379482260793, 877.88587483628, 883.1345281624044, 4544.818207271672, 4682.41469816273, 4682.81268749253, 4704.153252414599, 4709.434867815884, 5553.0, 5559.19391688211, 5564.527015203672, 5568.610197286151, 5600.887982240332, 4472.524067057863, 4738.573528382393, 4742.245369213413, 4750.786214620351, 4755.857324280277, 2934.855406391509, 2992.1023692892045, 2995.8951436699613, 3002.2194229500487, 3005.7144571265694, 5211.5049070338255, 5223.4776522347465, 5233.764480598382, 5237.73811309433, 5267.051930652519, 5440.347158341025, 5738.655680659173, 5743.8564035899435, 5750.0, 5768.480836724715, 5214.139666954986, 5257.710825904535, 5263.763130659053, 5267.552258058031, 5287.41838397776, 5596.804111856066, 5637.689927054052, 5640.54875609942, 5657.745401456862, 5674.716264186856, 5197.283941981502, 5463.863403414946, 5469.234307196916, 5494.5054945055135, 5534.972325138348, 5210.635255532076, 5218.904030153711, 5259.8422047338645, 5266.473352664703, 5300.6024548158275, 3820.67524260441, 3888.5333759948985, 3915.8448257763457, 3920.8039598020555, 3922.8626998056075, 5547.8890422192135, 5559.27729395176, 5569.939122524692, 5570.164475328733, 5593.608447408642, 5358.650843222986, 5389.191621256686, 5396.652456181573, 5408.864778380572, 5412.485813847678, 5141.203113517411, 5324.307839980777, 5387.488188622075, 5394.676319420847, 5401.000814849265, 5238.76425560843, 5258.842234732964, 5266.315379000705, 5269.262303277467, 5283.973580132075, 5212.739363031757, 5235.528802407802, 5321.521063104339, 5403.675779453245, 5419.972900135474, 5221.399539052905, 5235.973820131027, 5279.841604751864, 5319.813806516753, 5321.308229930084], "value": 4034.3048130657353, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9066254068078, 581.8399940016495, 583.7052288594259, 584.3221862639339, 618.4155972605887, 10839.13286937045, 10936.835947460784, 11049.83425248621, 13240.139390939583, 13893.374798134082, 12710.110292279544, 12885.484580616787, 12897.613071607844, 12927.288999105045, 13073.803892941614, 750.4371721209106, 766.6894907562446, 771.3135309574483, 771.9961400192991, 772.4592785050459, 623.2552100240215, 743.3087228877142, 759.6050053971932, 767.7428061599371, 770.0297624992522, 813.2721214513007, 815.592203898051, 815.8123631564744, 817.7873752824249, 818.811673315135, 800.5516910530122, 801.7274126796888, 802.1336956087441, 808.1151139502235, 810.4772421787914, 586.7330364684101, 591.4174538079988, 591.5563327504372, 591.7278052096041, 592.0586267834165, 11946.761064778742, 12000.57997970067, 12038.518459261619, 12107.0, 12111.515539378413, 12215.450304736309, 12309.0, 12675.112742108056, 12850.742985140338, 12873.098883078188, 9756.95121524395, 9853.753656158582, 9867.555959981819, 9927.106560409526, 9934.403935763805, 3067.371188906269, 3102.7828052036366, 3104.736097431721, 3105.549695294192, 3130.6086739157604, 61554.38445615531, 61628.383716162716, 62688.0, 63781.999999999534, 64096.0, 9083.273338132933, 9204.815903681889, 9529.90470095304, 9777.9022209777, 10374.688759337232, 17462.38881639162, 17578.12109394525, 17599.20803563843, 17614.471565853044, 17643.382481613084, 6305.873882522324, 6373.203349581302, 6542.869142617216, 6594.670266486753, 6690.732370705215, 3469.2020835208045, 3511.4030614795547, 3602.3335682898746, 3608.296382205445, 3671.5594128704724, 2708.647875776176, 2782.1236310562513, 2790.6790719067567, 2801.7058208887775, 2805.312698388908, 480.6179087625346, 482.08644618447846, 484.1648156929339, 490.2058664962712, 492.3894370979959, 451.109059607273, 497.3484734997093, 521.304059081131, 528.7092099345344, 530.4112435196928, 6744.763933262312, 6810.489213309022, 7136.286371362822, 7215.0792660092375, 7396.630168491554, 454.1915390604729, 479.64026979765174, 481.2348366097921, 505.9696418214919, 520.5809323494548, 3440.6559344065395, 3673.430618254175, 3691.8154092295276, 3759.6804271637216, 3990.840366385312, 63293.0, 106161.0, 106451.4677426608, 108369.0, 108843.0, 78096.60951695206, 91587.54206228926, 92837.0, 94907.52546237224, 95540.52229738807, 74978.0, 80088.0, 81416.18583814205, 81631.5918420404, 86199.56900215584, 7625.6949722010495, 7641.847163056596, 7657.961710191414, 7906.209379062047, 7951.363890888831, 46611.53388466072, 47089.0, 47362.52637473581, 47374.0, 48440.0, 70277.0, 71976.28023719696, 72427.0, 73320.90018649831, 74055.0, 9320.161185493067, 9469.242460602998, 9621.422714637145, 9731.416115032838, 9804.852927205955, 10439.164866810484, 10666.57333706674, 10686.946565267124, 10756.677299681021, 10761.946190268998, 10169.186465082923, 10177.491125443847, 10218.284720069523, 10350.0, 11135.220534562826, 9412.435253884789, 9780.315377923476, 9783.315167938175, 9848.11366976947, 10407.895921040996, 9616.182624476998, 9860.950695246478, 9938.701838944844, 10113.393196408239, 10364.533595988349, 8033.718819841278, 8080.0, 8109.351251899951, 8219.30135938428, 8270.0, 7937.206279372017, 8019.799505012421, 8334.20825021622, 8418.158184181533, 8574.65701371963], "value": 6162.224260761439, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 107.0, 115.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 122.0, 145.0, 192.0, 124.0, 145.0, 149.0, 124.0, 186.0, 123.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 162.0, 166.0, 169.0, 163.0, 163.0, 163.0, 162.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 186.0, 78.0, 78.0, 76.0, 75.0, 166.0, 76.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 162.0, 87.0, 86.0, 86.0, 138.0, 85.0, 85.0, 137.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 120.0, 118.0, 118.0, 118.0, 118.0, 122.0, 119.0, 117.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 147.0, 147.0, 149.0, 149.0, 149.0, 151.0, 147.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 98.0, 96.0, 96.0, 101.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 61.0, 62.0, 73.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 65.0, 66.0, 67.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 80.0, 79.0, 83.0, 80.0, 79.0, 80.0, 85.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 146.0, 131.0, 155.0, 130.0, 133.0, 137.0, 169.0, 135.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 168.0, 163.0, 167.0, 170.0, 165.0, 177.0, 166.0, 167.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 66.0, 73.0, 70.0, 67.0, 67.0, 67.0, 66.0], "value": 68.1, "unit": "score"}]}]} 06:38:34 INFO - Return code: 0 06:38:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:38:34 ERROR - # TBPL SUCCESS # 06:38:34 INFO - Running post-action listener: _resource_record_post_action 06:38:34 INFO - [mozharness: 2016-07-29 13:38:34.621775Z] Finished run-tests step (success) 06:38:34 INFO - Running post-run listener: _resource_record_post_run 06:38:34 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552964096; Read time: 16; Write time: 512652 06:38:34 INFO - TinderboxPrint: CPU usage
13.3% 06:38:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:38:34 INFO - TinderboxPrint: I/O write bytes / time
552,964,096 / 512,652 06:38:34 INFO - TinderboxPrint: CPU idle
8,285.4 (86.7%) 06:38:34 INFO - TinderboxPrint: CPU user
1,217.4 (12.7%) 06:38:34 INFO - TinderboxPrint: Swap in / out
0 / 0 06:38:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251179008; Read time: 0; Write time: 278932 06:38:34 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 301785088; Read time: 16; Write time: 233720 06:38:35 INFO - Running post-run listener: _upload_blobber_files 06:38:35 INFO - Blob upload gear active. 06:38:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:38:35 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 06:38:35 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:38:35 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:38:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:38:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:38:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:38:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:36 INFO - (blobuploader) - INFO - Done attempting. 06:38:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:38:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:38:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:37 INFO - (blobuploader) - INFO - Done attempting. 06:38:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:38:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:38:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:40 INFO - (blobuploader) - INFO - Done attempting. 06:38:40 INFO - (blobuploader) - INFO - Iteration through files over. 06:38:40 INFO - Return code: 0 06:38:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:38:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:38:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/97afd9ba3fbb449ff6e6612e5843f01c10e58ee8d36d7d337c1c8eba7847ac0bd83448db4a98a36cf3e31349bcc5072a89979ed4ef5bf793678c78b33bab6fc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b939cb4e3edd5eab76a27ee49ebf846e33c0ad733ff63a6600b4daf0868b9e69577eebc425c566b0a4a52aeffd5899a2a56dbb6cc732edd0a0de1676bfb6cf22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd74790fae7c13bbf5be6447dcf6ca64ff3e1df47e9fc06b8d5945b2914a68afc43376ce79146d588fdf1126e267992bf0bcde35ff31c6d0bfc24cbb4c763259"} 06:38:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:38:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:38:40 INFO - Contents: 06:38:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/97afd9ba3fbb449ff6e6612e5843f01c10e58ee8d36d7d337c1c8eba7847ac0bd83448db4a98a36cf3e31349bcc5072a89979ed4ef5bf793678c78b33bab6fc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b939cb4e3edd5eab76a27ee49ebf846e33c0ad733ff63a6600b4daf0868b9e69577eebc425c566b0a4a52aeffd5899a2a56dbb6cc732edd0a0de1676bfb6cf22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd74790fae7c13bbf5be6447dcf6ca64ff3e1df47e9fc06b8d5945b2914a68afc43376ce79146d588fdf1126e267992bf0bcde35ff31c6d0bfc24cbb4c763259"} 06:38:40 INFO - Running post-run listener: copy_logs_to_upload_dir 06:38:40 INFO - Copying logs to upload dir... 06:38:40 INFO - mkdir: /builds/slave/test/build/upload/logs 06:38:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.703201 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-29 06:38:40.169839) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 06:38:40.173747) ========= 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=920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317 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-Non-PGO/sha512/97afd9ba3fbb449ff6e6612e5843f01c10e58ee8d36d7d337c1c8eba7847ac0bd83448db4a98a36cf3e31349bcc5072a89979ed4ef5bf793678c78b33bab6fc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b939cb4e3edd5eab76a27ee49ebf846e33c0ad733ff63a6600b4daf0868b9e69577eebc425c566b0a4a52aeffd5899a2a56dbb6cc732edd0a0de1676bfb6cf22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd74790fae7c13bbf5be6447dcf6ca64ff3e1df47e9fc06b8d5945b2914a68afc43376ce79146d588fdf1126e267992bf0bcde35ff31c6d0bfc24cbb4c763259"} build_url:https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/GGIP2XLkTimS7vjVi-eshw/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-Non-PGO/sha512/97afd9ba3fbb449ff6e6612e5843f01c10e58ee8d36d7d337c1c8eba7847ac0bd83448db4a98a36cf3e31349bcc5072a89979ed4ef5bf793678c78b33bab6fc5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b939cb4e3edd5eab76a27ee49ebf846e33c0ad733ff63a6600b4daf0868b9e69577eebc425c566b0a4a52aeffd5899a2a56dbb6cc732edd0a0de1676bfb6cf22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd74790fae7c13bbf5be6447dcf6ca64ff3e1df47e9fc06b8d5945b2914a68afc43376ce79146d588fdf1126e267992bf0bcde35ff31c6d0bfc24cbb4c763259"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 06:38:40.198737) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:38:40.199044) ========= 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=920470bf432669ad7e3a5387000001ca-1469798284.90911-846767317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:38:40.284035) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 06:38:40.284433) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 06:38:40.284720) ========= ========= Total master_lag: 0.16 =========