builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1469938556.77 results: success (0) buildid: 20160730183002 builduid: d0fb05c6265546ed8df35b06346e48dd revision: c761bfb5fd83eb0d767adbf34012b7dda384dce9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:56.772703) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:56.773172) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:56.773500) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:56.826987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:56.827319) ========= 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=232498196343f89f466a4a9a000001c8-1469934319.965841-738445851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 21:15:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-07-30 21:15:58 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133158 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:56.984773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:56.985056) ========= 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=232498196343f89f466a4a9a000001c8-1469934319.965841-738445851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017831 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:57.051439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:57.051750) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c761bfb5fd83eb0d767adbf34012b7dda384dce9 --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 c761bfb5fd83eb0d767adbf34012b7dda384dce9 --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=232498196343f89f466a4a9a000001c8-1469934319.965841-738445851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 21:15:58,592 truncating revision to first 12 chars 2016-07-30 21:15:58,592 Setting DEBUG logging. 2016-07-30 21:15:58,592 attempt 1/10 2016-07-30 21:15:58,592 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c761bfb5fd83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 21:15:58,889 unpacking tar archive at: autoland-c761bfb5fd83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643005 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:57.714810) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:57.715085) ========= script_repo_revision: c761bfb5fd83eb0d767adbf34012b7dda384dce9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:57.715529) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:57.715809) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 21:15:57.730188) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-30 21:15:57.730477) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1469934319.965841-738445851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:15:59 INFO - MultiFileLogger online at 20160730 21:15:59 in /builds/slave/test 21:15:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:15:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:15:59 INFO - {'append_to_log': False, 21:15:59 INFO - 'base_work_dir': '/builds/slave/test', 21:15:59 INFO - 'blob_upload_branch': 'Autoland', 21:15:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:15:59 INFO - 'branch': 'Autoland', 21:15:59 INFO - 'buildbot_json_path': 'buildprops.json', 21:15:59 INFO - 'config_files': ('talos/linux_config.py',), 21:15:59 INFO - 'default_actions': ('clobber', 21:15:59 INFO - 'read-buildbot-config', 21:15:59 INFO - 'download-and-extract', 21:15:59 INFO - 'populate-webroot', 21:15:59 INFO - 'create-virtualenv', 21:15:59 INFO - 'install', 21:15:59 INFO - 'run-tests'), 21:15:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:15:59 INFO - 'download_minidump_stackwalk': True, 21:15:59 INFO - 'download_symbols': 'ondemand', 21:15:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:15:59 INFO - 'tooltool.py': '/tools/tooltool.py', 21:15:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:15:59 INFO - '/tools/misc-python/virtualenv.py')}, 21:15:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:15:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:15:59 INFO - 'installer_path': 'installer.exe', 21:15:59 INFO - 'log_level': 'info', 21:15:59 INFO - 'log_name': 'talos', 21:15:59 INFO - 'log_to_console': True, 21:15:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:15:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:15:59 INFO - 'opt_config_files': (), 21:15:59 INFO - 'pip_index': False, 21:15:59 INFO - 'sps_profile': False, 21:15:59 INFO - 'sps_profile_interval': 0, 21:15:59 INFO - 'suite': 'dromaeojs-e10s', 21:15:59 INFO - 'system_bits': '32', 21:15:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:15:59 INFO - 'title': 'talos-linux64-ix-025', 21:15:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:15:59 INFO - 'use_talos_json': True, 21:15:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:15:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:15:59 INFO - 'work_dir': 'build'} 21:15:59 INFO - [mozharness: 2016-07-31 04:15:59.354881Z] Running clobber step. 21:15:59 INFO - Running pre-action listener: _resource_record_pre_action 21:15:59 INFO - Running main action method: clobber 21:15:59 INFO - rmtree: /builds/slave/test/build 21:15:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:16:00 INFO - Running post-action listener: _resource_record_post_action 21:16:00 INFO - [mozharness: 2016-07-31 04:16:00.337117Z] Finished clobber step (success) 21:16:00 INFO - [mozharness: 2016-07-31 04:16:00.337220Z] Running read-buildbot-config step. 21:16:00 INFO - Running pre-action listener: _resource_record_pre_action 21:16:00 INFO - Running main action method: read_buildbot_config 21:16:00 INFO - Using buildbot properties: 21:16:00 INFO - { 21:16:00 INFO - "project": "", 21:16:00 INFO - "product": "firefox", 21:16:00 INFO - "script_repo_revision": "production", 21:16:00 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 21:16:00 INFO - "repository": "", 21:16:00 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 21:16:00 INFO - "buildid": "20160730183002", 21:16:00 INFO - "pgo_build": "True", 21:16:00 INFO - "basedir": "/builds/slave/test", 21:16:00 INFO - "buildnumber": 81, 21:16:00 INFO - "slavename": "talos-linux64-ix-025", 21:16:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:16:00 INFO - "platform": "ubuntu64_hw", 21:16:00 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:16:00 INFO - "branch": "autoland", 21:16:00 INFO - "repo_path": "integration/autoland", 21:16:00 INFO - "revision": "c761bfb5fd83eb0d767adbf34012b7dda384dce9", 21:16:00 INFO - "stage_platform": "linux64-pgo", 21:16:00 INFO - "builduid": "d0fb05c6265546ed8df35b06346e48dd", 21:16:00 INFO - "slavebuilddir": "test" 21:16:00 INFO - } 21:16:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:16:00 INFO - Running post-action listener: _resource_record_post_action 21:16:00 INFO - [mozharness: 2016-07-31 04:16:00.339698Z] Finished read-buildbot-config step (success) 21:16:00 INFO - [mozharness: 2016-07-31 04:16:00.339789Z] Running download-and-extract step. 21:16:00 INFO - Running pre-action listener: _resource_record_pre_action 21:16:00 INFO - Running main action method: download_and_extract 21:16:00 INFO - mkdir: /builds/slave/test/build/tests 21:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:00 INFO - https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:16:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:16:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:16:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/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 21:16:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/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 21:16:06 INFO - Downloaded 1361 bytes. 21:16:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:16:06 INFO - Using the following test package requirements: 21:16:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:16:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:16:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:16:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:06 INFO - u'jsshell-linux-x86_64.zip'], 21:16:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:16:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:16:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:16:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:16:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:16:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:16:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:16:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:16: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')]} 21:16:06 INFO - https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:16:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:16:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:16:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/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 21:16:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/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 21:16:10 INFO - Downloaded 21804745 bytes. 21:16: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'] 21:16: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 21:16:11 INFO - Return code: 0 21:16:11 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 21:16: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')]} 21:16:11 INFO - https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:16:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:16:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:16:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/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 21:16:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/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 21:16:17 INFO - Downloaded 21804745 bytes. 21:16:17 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'] 21:16:17 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 21:16:18 INFO - Return code: 0 21:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:18 INFO - https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/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 21:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/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 21:16:19 INFO - Downloaded 14413723 bytes. 21:16:19 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'] 21:16:19 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 21:16:19 INFO - Return code: 0 21:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:19 INFO - https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:16:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:16:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:16:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/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 21:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NBR_0zPUStW62YCBUyWDfg/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 21:16:21 INFO - Downloaded 59380776 bytes. 21:16:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:16:21 INFO - mkdir: /builds/slave/test/properties 21:16:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:16:21 INFO - Writing to file /builds/slave/test/properties/build_url 21:16:21 INFO - Contents: 21:16:21 INFO - build_url:https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:16:22 INFO - Running post-action listener: _resource_record_post_action 21:16:22 INFO - Running post-action listener: set_extra_try_arguments 21:16:22 INFO - [mozharness: 2016-07-31 04:16:22.337810Z] Finished download-and-extract step (success) 21:16:22 INFO - [mozharness: 2016-07-31 04:16:22.338141Z] Running populate-webroot step. 21:16:22 INFO - Running pre-action listener: _resource_record_pre_action 21:16:22 INFO - Running main action method: populate_webroot 21:16:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:16:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:16:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:16:22 INFO - '--tppagecycles', 21:16:22 INFO - '7'], 21:16:22 INFO - 'tests': ['tsvgm']}}, 21:16:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:16:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:16:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:16:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:16:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:16:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:16:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:22 INFO - 'talos_options': ['--disable-e10s'], 21:16:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:16:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:16:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:22 INFO - 'talos_options': ['--disable-e10s'], 21:16:22 INFO - 'tests': ['damp', 'tps']}, 21:16:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:22 INFO - 'tests': ['damp', 'tps']}, 21:16:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:16:22 INFO - 'tests': ['dromaeo_dom']}, 21:16:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:16:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:16:22 INFO - 'tests': ['basic_compositor_video']}, 21:16:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:16:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:16:22 INFO - 'tests': ['a11yr', 21:16:22 INFO - 'ts_paint', 21:16:22 INFO - 'tpaint', 21:16:22 INFO - 'sessionrestore', 21:16:22 INFO - 'sessionrestore_no_auto_restore', 21:16:22 INFO - 'tabpaint']}, 21:16:22 INFO - 'other-e10s': {'tests': ['a11yr', 21:16:22 INFO - 'ts_paint', 21:16:22 INFO - 'tpaint', 21:16:22 INFO - 'sessionrestore', 21:16:22 INFO - 'sessionrestore_no_auto_restore', 21:16:22 INFO - 'tabpaint']}, 21:16:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:16:22 INFO - 'ts_paint', 21:16:22 INFO - 'tpaint', 21:16:22 INFO - 'sessionrestore', 21:16:22 INFO - 'sessionrestore_no_auto_restore', 21:16:22 INFO - 'tabpaint']}, 21:16:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:16:22 INFO - 'ts_paint', 21:16:22 INFO - 'tpaint', 21:16:22 INFO - 'sessionrestore', 21:16:22 INFO - 'sessionrestore_no_auto_restore', 21:16:22 INFO - 'tabpaint']}, 21:16:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:16:22 INFO - 'tests': ['a11yr', 21:16:22 INFO - 'ts_paint', 21:16:22 INFO - 'tpaint', 21:16:22 INFO - 'sessionrestore', 21:16:22 INFO - 'sessionrestore_no_auto_restore', 21:16:22 INFO - 'tabpaint']}, 21:16:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:16:22 INFO - 'tests': ['a11yr', 21:16:22 INFO - 'ts_paint', 21:16:22 INFO - 'tpaint', 21:16:22 INFO - 'sessionrestore', 21:16:22 INFO - 'sessionrestore_no_auto_restore', 21:16:22 INFO - 'tabpaint']}, 21:16:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:16:22 INFO - 'tests': ['tsvgx', 21:16:22 INFO - 'tsvgr_opacity', 21:16:22 INFO - 'tart', 21:16:22 INFO - 'tscrollx', 21:16:22 INFO - 'cart']}, 21:16:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:16:22 INFO - 'tsvgr_opacity', 21:16:22 INFO - 'tart', 21:16:22 INFO - 'tscrollx', 21:16:22 INFO - 'cart']}, 21:16:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:22 INFO - 'talos_options': ['--disable-e10s'], 21:16:22 INFO - 'tests': ['tp5o']}, 21:16:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:22 INFO - 'tests': ['tp5o']}, 21:16:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:22 INFO - 'talos_options': ['--disable-e10s', 21:16:22 INFO - '--xperf_path', 21:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:16:22 INFO - 'tests': ['tp5n']}, 21:16:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:16:22 INFO - 'talos_options': ['--xperf_path', 21:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:16:22 INFO - 'tests': ['tp5n']}}, 21:16:22 INFO - 'talos.zip': {'path': '', 21:16:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:16:22 INFO - Running post-action listener: _resource_record_post_action 21:16:22 INFO - [mozharness: 2016-07-31 04:16:22.355320Z] Finished populate-webroot step (success) 21:16:22 INFO - [mozharness: 2016-07-31 04:16:22.355411Z] Running create-virtualenv step. 21:16:22 INFO - Running pre-action listener: _resource_record_pre_action 21:16:22 INFO - Running main action method: create_virtualenv 21:16:22 INFO - Creating virtualenv /builds/slave/test/build/venv 21:16:22 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 21:16:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:16:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:16:22 INFO - Using real prefix '/usr' 21:16:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:16:22 INFO - Installing distribute.............................................................................................................................................................................................done. 21:16:24 INFO - Installing pip.................done. 21:16:24 INFO - Return code: 0 21:16:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:16:24 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')]} 21:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:24 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')]} 21:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:24 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 0xbbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d3b0>, '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 0xe7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e740>, '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': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', '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 21:16:24 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 21:16:24 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 21:16:24 INFO - Using env: {'DISPLAY': ':0', 21:16:24 INFO - 'HOME': '/home/cltbld', 21:16:24 INFO - 'LANG': 'en_US.UTF-8', 21:16:24 INFO - 'LANGUAGE': 'en_US:en', 21:16:24 INFO - 'LOGNAME': 'cltbld', 21:16:24 INFO - 'MAIL': '/var/mail/cltbld', 21:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:24 INFO - 'MOZ_NO_REMOTE': '1', 21:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:24 INFO - 'NO_EM_RESTART': '1', 21:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:24 INFO - 'PWD': '/builds/slave/test', 21:16:24 INFO - 'SHELL': '/bin/bash', 21:16:24 INFO - 'SHLVL': '1', 21:16:24 INFO - 'TERM': 'linux', 21:16:24 INFO - 'TMOUT': '86400', 21:16:24 INFO - 'USER': 'cltbld', 21:16:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', 21:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:24 INFO - '_': '/tools/buildbot/bin/python'} 21:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:25 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 21:16:25 INFO - Cleaning up... 21:16:25 INFO - Return code: 0 21:16:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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', '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 0xbbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d3b0>, '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 0xe7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e740>, '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': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', '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 21:16: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:16: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 psutil>=3.1.1 21:16:25 INFO - Using env: {'DISPLAY': ':0', 21:16:25 INFO - 'HOME': '/home/cltbld', 21:16:25 INFO - 'LANG': 'en_US.UTF-8', 21:16:25 INFO - 'LANGUAGE': 'en_US:en', 21:16:25 INFO - 'LOGNAME': 'cltbld', 21:16:25 INFO - 'MAIL': '/var/mail/cltbld', 21:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:25 INFO - 'MOZ_NO_REMOTE': '1', 21:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:25 INFO - 'NO_EM_RESTART': '1', 21:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:25 INFO - 'PWD': '/builds/slave/test', 21:16:25 INFO - 'SHELL': '/bin/bash', 21:16:25 INFO - 'SHLVL': '1', 21:16:25 INFO - 'TERM': 'linux', 21:16:25 INFO - 'TMOUT': '86400', 21:16:25 INFO - 'USER': 'cltbld', 21:16:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', 21:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:25 INFO - '_': '/tools/buildbot/bin/python'} 21:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:25 INFO - Downloading/unpacking psutil>=3.1.1 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:16:27 INFO - Installing collected packages: psutil 21:16:27 INFO - Running setup.py install for psutil 21:16:27 INFO - building 'psutil._psutil_linux' extension 21:16:27 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 21:16:27 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 21:16:27 INFO - building 'psutil._psutil_posix' extension 21:16:27 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 21:16:27 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 21:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:16:27 INFO - Successfully installed psutil 21:16:27 INFO - Cleaning up... 21:16:27 INFO - Return code: 0 21:16:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:27 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 0xbbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d3b0>, '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 0xe7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e740>, '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': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', '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 21:16:27 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 21:16:27 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 21:16:27 INFO - Using env: {'DISPLAY': ':0', 21:16:27 INFO - 'HOME': '/home/cltbld', 21:16:27 INFO - 'LANG': 'en_US.UTF-8', 21:16:27 INFO - 'LANGUAGE': 'en_US:en', 21:16:27 INFO - 'LOGNAME': 'cltbld', 21:16:27 INFO - 'MAIL': '/var/mail/cltbld', 21:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:27 INFO - 'MOZ_NO_REMOTE': '1', 21:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:27 INFO - 'NO_EM_RESTART': '1', 21:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:27 INFO - 'PWD': '/builds/slave/test', 21:16:27 INFO - 'SHELL': '/bin/bash', 21:16:27 INFO - 'SHLVL': '1', 21:16:27 INFO - 'TERM': 'linux', 21:16:27 INFO - 'TMOUT': '86400', 21:16:27 INFO - 'USER': 'cltbld', 21:16:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', 21:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:27 INFO - '_': '/tools/buildbot/bin/python'} 21:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:16:30 INFO - Installing collected packages: mozsystemmonitor 21:16:30 INFO - Running setup.py install for mozsystemmonitor 21:16:30 INFO - Successfully installed mozsystemmonitor 21:16:30 INFO - Cleaning up... 21:16:30 INFO - Return code: 0 21:16:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d3b0>, '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 0xe7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e740>, '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': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', '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 21:16:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:16:30 INFO - Using env: {'DISPLAY': ':0', 21:16:30 INFO - 'HOME': '/home/cltbld', 21:16:30 INFO - 'LANG': 'en_US.UTF-8', 21:16:30 INFO - 'LANGUAGE': 'en_US:en', 21:16:30 INFO - 'LOGNAME': 'cltbld', 21:16:30 INFO - 'MAIL': '/var/mail/cltbld', 21:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:30 INFO - 'MOZ_NO_REMOTE': '1', 21:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:30 INFO - 'NO_EM_RESTART': '1', 21:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:30 INFO - 'PWD': '/builds/slave/test', 21:16:30 INFO - 'SHELL': '/bin/bash', 21:16:30 INFO - 'SHLVL': '1', 21:16:30 INFO - 'TERM': 'linux', 21:16:30 INFO - 'TMOUT': '86400', 21:16:30 INFO - 'USER': 'cltbld', 21:16:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', 21:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:30 INFO - '_': '/tools/buildbot/bin/python'} 21:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:30 INFO - Downloading/unpacking jsonschema==2.5.1 21:16:30 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 21:16:30 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 21:16:30 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 21:16:30 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 21:16:30 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 21:16:30 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 21:16:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:16:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:16:32 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 21:16:32 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 21:16:32 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 21:16:32 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 21:16:32 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 21:16:32 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 21:16:32 INFO - Downloading functools32-3.2.3-2.tar.gz 21:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:16:32 INFO - warning: no files found matching '*.txt' 21:16:32 INFO - no previously-included directories found matching 'build' 21:16:32 INFO - no previously-included directories found matching 'dist' 21:16:32 INFO - no previously-included directories found matching '.git*' 21:16:32 INFO - Installing collected packages: jsonschema, functools32 21:16:32 INFO - Running setup.py install for functools32 21:16:32 INFO - warning: no files found matching '*.txt' 21:16:32 INFO - no previously-included directories found matching 'build' 21:16:32 INFO - no previously-included directories found matching 'dist' 21:16:32 INFO - no previously-included directories found matching '.git*' 21:16:32 INFO - Successfully installed jsonschema functools32 21:16:32 INFO - Cleaning up... 21:16:32 INFO - Return code: 0 21:16:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:16: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')]} 21:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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')]} 21:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d3b0>, '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 0xe7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e740>, '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': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', '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 21:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:16:32 INFO - Using env: {'DISPLAY': ':0', 21:16:32 INFO - 'HOME': '/home/cltbld', 21:16:32 INFO - 'LANG': 'en_US.UTF-8', 21:16:32 INFO - 'LANGUAGE': 'en_US:en', 21:16:32 INFO - 'LOGNAME': 'cltbld', 21:16:32 INFO - 'MAIL': '/var/mail/cltbld', 21:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:32 INFO - 'MOZ_NO_REMOTE': '1', 21:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:32 INFO - 'NO_EM_RESTART': '1', 21:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:32 INFO - 'PWD': '/builds/slave/test', 21:16:32 INFO - 'SHELL': '/bin/bash', 21:16:32 INFO - 'SHLVL': '1', 21:16:32 INFO - 'TERM': 'linux', 21:16:32 INFO - 'TMOUT': '86400', 21:16:32 INFO - 'USER': 'cltbld', 21:16:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', 21:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:32 INFO - '_': '/tools/buildbot/bin/python'} 21:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:16:32 INFO - Cleaning up... 21:16:32 INFO - Return code: 0 21:16:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:16: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')]} 21:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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')]} 21:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d3b0>, '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 0xe7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e740>, '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': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', '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 21:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:16:32 INFO - Using env: {'DISPLAY': ':0', 21:16:32 INFO - 'HOME': '/home/cltbld', 21:16:32 INFO - 'LANG': 'en_US.UTF-8', 21:16:32 INFO - 'LANGUAGE': 'en_US:en', 21:16:32 INFO - 'LOGNAME': 'cltbld', 21:16:32 INFO - 'MAIL': '/var/mail/cltbld', 21:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:32 INFO - 'MOZ_NO_REMOTE': '1', 21:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:32 INFO - 'NO_EM_RESTART': '1', 21:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:32 INFO - 'PWD': '/builds/slave/test', 21:16:32 INFO - 'SHELL': '/bin/bash', 21:16:32 INFO - 'SHLVL': '1', 21:16:32 INFO - 'TERM': 'linux', 21:16:32 INFO - 'TMOUT': '86400', 21:16:32 INFO - 'USER': 'cltbld', 21:16:32 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', 21:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:32 INFO - '_': '/tools/buildbot/bin/python'} 21:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:33 INFO - Downloading/unpacking blobuploader==1.2.4 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16:35 INFO - Downloading blobuploader-1.2.4.tar.gz 21:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:16:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:16:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:16:35 INFO - Downloading docopt-0.6.1.tar.gz 21:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:16:36 INFO - Installing collected packages: blobuploader, requests, docopt 21:16:36 INFO - Running setup.py install for blobuploader 21:16:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:16:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:16:36 INFO - Running setup.py install for requests 21:16:36 INFO - Running setup.py install for docopt 21:16:36 INFO - Successfully installed blobuploader requests docopt 21:16:36 INFO - Cleaning up... 21:16:36 INFO - Return code: 0 21:16:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16: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')]} 21:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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')]} 21:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:36 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 0xbbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d3b0>, '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 0xe7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e740>, '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': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', '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 21:16:36 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 21:16:36 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 21:16:36 INFO - Using env: {'DISPLAY': ':0', 21:16:36 INFO - 'HOME': '/home/cltbld', 21:16:36 INFO - 'LANG': 'en_US.UTF-8', 21:16:36 INFO - 'LANGUAGE': 'en_US:en', 21:16:36 INFO - 'LOGNAME': 'cltbld', 21:16:36 INFO - 'MAIL': '/var/mail/cltbld', 21:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:36 INFO - 'MOZ_NO_REMOTE': '1', 21:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:36 INFO - 'NO_EM_RESTART': '1', 21:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:36 INFO - 'PWD': '/builds/slave/test', 21:16:36 INFO - 'SHELL': '/bin/bash', 21:16:36 INFO - 'SHLVL': '1', 21:16:36 INFO - 'TERM': 'linux', 21:16:36 INFO - 'TMOUT': '86400', 21:16:36 INFO - 'USER': 'cltbld', 21:16:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', 21:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:36 INFO - '_': '/tools/buildbot/bin/python'} 21:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:16:36 INFO - Running setup.py (path:/tmp/pip-lc2v1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:16:36 INFO - Running setup.py (path:/tmp/pip-mpdOPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:16:36 INFO - Running setup.py (path:/tmp/pip-IMM1Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:16:37 INFO - Running setup.py (path:/tmp/pip-XMzI8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:16:37 INFO - Running setup.py (path:/tmp/pip-5xA7tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:16:37 INFO - Running setup.py (path:/tmp/pip-436Cql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:16:37 INFO - Running setup.py (path:/tmp/pip-eJrqPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:16:37 INFO - Running setup.py (path:/tmp/pip-yycOP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:16:37 INFO - Running setup.py (path:/tmp/pip-tp3UOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:16:37 INFO - Running setup.py (path:/tmp/pip-d744g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:16:37 INFO - Running setup.py (path:/tmp/pip-mazLfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:16:37 INFO - Running setup.py (path:/tmp/pip-1hZDYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:16:37 INFO - Running setup.py (path:/tmp/pip-cN8dQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:16:37 INFO - Running setup.py (path:/tmp/pip-Gbfv75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:37 INFO - Running setup.py (path:/tmp/pip-w0RBJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:16:37 INFO - Running setup.py (path:/tmp/pip-FtiKkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:16:37 INFO - Running setup.py (path:/tmp/pip-_1J1UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:16:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:16:38 INFO - Running setup.py install for manifestparser 21:16:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:16:38 INFO - Running setup.py install for mozcrash 21:16:38 INFO - Running setup.py install for mozdebug 21:16:38 INFO - Running setup.py install for mozdevice 21:16:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:16:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:16:38 INFO - Running setup.py install for mozfile 21:16:38 INFO - Running setup.py install for mozhttpd 21:16:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:16:38 INFO - Running setup.py install for mozinfo 21:16:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:16:38 INFO - Running setup.py install for mozInstall 21:16:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:16:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:16:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:16:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:16:38 INFO - Running setup.py install for mozleak 21:16:38 INFO - Running setup.py install for mozlog 21:16:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:16:39 INFO - Running setup.py install for moznetwork 21:16:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:16:39 INFO - Running setup.py install for mozprocess 21:16:39 INFO - Running setup.py install for mozprofile 21:16:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:16:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:16:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:16:39 INFO - Running setup.py install for mozrunner 21:16:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:16:39 INFO - Running setup.py install for mozscreenshot 21:16:39 INFO - Running setup.py install for moztest 21:16:39 INFO - Running setup.py install for mozversion 21:16:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:16:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:16:39 INFO - Cleaning up... 21:16:39 INFO - Return code: 0 21:16:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:39 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 0xbbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d3b0>, '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 0xe7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e740>, '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': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', '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 21:16:39 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 21:16:39 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 21:16:39 INFO - Using env: {'DISPLAY': ':0', 21:16:39 INFO - 'HOME': '/home/cltbld', 21:16:39 INFO - 'LANG': 'en_US.UTF-8', 21:16:39 INFO - 'LANGUAGE': 'en_US:en', 21:16:39 INFO - 'LOGNAME': 'cltbld', 21:16:39 INFO - 'MAIL': '/var/mail/cltbld', 21:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:39 INFO - 'MOZ_NO_REMOTE': '1', 21:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:39 INFO - 'NO_EM_RESTART': '1', 21:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:39 INFO - 'PWD': '/builds/slave/test', 21:16:39 INFO - 'SHELL': '/bin/bash', 21:16:39 INFO - 'SHLVL': '1', 21:16:39 INFO - 'TERM': 'linux', 21:16:39 INFO - 'TMOUT': '86400', 21:16:39 INFO - 'USER': 'cltbld', 21:16:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', 21:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:39 INFO - '_': '/tools/buildbot/bin/python'} 21:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:16:40 INFO - Running setup.py (path:/tmp/pip-DCRpSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:16:40 INFO - Running setup.py (path:/tmp/pip-6bBTzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:16:40 INFO - Running setup.py (path:/tmp/pip-BkRGOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:16:40 INFO - Running setup.py (path:/tmp/pip-GSoMT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:16:40 INFO - Running setup.py (path:/tmp/pip-yUWmKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:16:40 INFO - Running setup.py (path:/tmp/pip-bjTk0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:16:40 INFO - Running setup.py (path:/tmp/pip-kgeWXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:16:40 INFO - Running setup.py (path:/tmp/pip-TpswR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:16:40 INFO - Running setup.py (path:/tmp/pip-_mxkyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:16:40 INFO - Running setup.py (path:/tmp/pip-QN_FCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:16:40 INFO - Running setup.py (path:/tmp/pip-96jXDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:16:40 INFO - Running setup.py (path:/tmp/pip-amMHng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:16:40 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)) 21:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:16:40 INFO - Running setup.py (path:/tmp/pip-WKEjIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:16:41 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)) 21:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:16:41 INFO - Running setup.py (path:/tmp/pip-kR_F0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:16:41 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)) 21:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:41 INFO - Running setup.py (path:/tmp/pip-C00nPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:16:41 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)) 21:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:16:41 INFO - Running setup.py (path:/tmp/pip-CYXnN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:16:41 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)) 21:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:16:41 INFO - Running setup.py (path:/tmp/pip-Az_BOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:16:41 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)) 21:16:41 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)) 21:16:41 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)) 21:16:41 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)) 21:16:41 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)) 21:16:41 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)) 21:16:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:16:41 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 21:16:41 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 21:16:41 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 21:16:41 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 21:16:41 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 21:16:41 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 21:16:43 INFO - Downloading blessings-1.6.tar.gz 21:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:16:43 INFO - Installing collected packages: blessings 21:16:43 INFO - Running setup.py install for blessings 21:16:43 INFO - Successfully installed blessings 21:16:43 INFO - Cleaning up... 21:16:43 INFO - Return code: 0 21:16:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:16:43 INFO - Reading from file tmpfile_stdout 21:16:43 INFO - Current package versions: 21:16:43 INFO - argparse == 1.2.1 21:16:43 INFO - blessings == 1.6 21:16:43 INFO - blobuploader == 1.2.4 21:16:43 INFO - docopt == 0.6.1 21:16:43 INFO - functools32 == 3.2.3-2 21:16:43 INFO - jsonschema == 2.5.1 21:16:43 INFO - manifestparser == 1.1 21:16:43 INFO - mozInstall == 1.12 21:16:43 INFO - mozcrash == 0.17 21:16:43 INFO - mozdebug == 0.1 21:16:43 INFO - mozdevice == 0.48 21:16:43 INFO - mozfile == 1.2 21:16:43 INFO - mozhttpd == 0.7 21:16:43 INFO - mozinfo == 0.9 21:16:43 INFO - mozleak == 0.1 21:16:43 INFO - mozlog == 3.3 21:16:43 INFO - moznetwork == 0.27 21:16:43 INFO - mozprocess == 0.23 21:16:43 INFO - mozprofile == 0.28 21:16:43 INFO - mozrunner == 6.12 21:16:43 INFO - mozscreenshot == 0.1 21:16:43 INFO - mozsystemmonitor == 0.3 21:16:43 INFO - moztest == 0.7 21:16:43 INFO - mozversion == 1.4 21:16:43 INFO - psutil == 3.1.1 21:16:43 INFO - requests == 1.2.3 21:16:43 INFO - wsgiref == 0.1.2 21:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:43 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 0xbbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d3b0>, '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 0xe7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e740>, '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': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', '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 21:16:43 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 21:16:43 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 21:16:43 INFO - Using env: {'DISPLAY': ':0', 21:16:43 INFO - 'HOME': '/home/cltbld', 21:16:43 INFO - 'LANG': 'en_US.UTF-8', 21:16:43 INFO - 'LANGUAGE': 'en_US:en', 21:16:43 INFO - 'LOGNAME': 'cltbld', 21:16:43 INFO - 'MAIL': '/var/mail/cltbld', 21:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:43 INFO - 'MOZ_NO_REMOTE': '1', 21:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:43 INFO - 'NO_EM_RESTART': '1', 21:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:43 INFO - 'PWD': '/builds/slave/test', 21:16:43 INFO - 'SHELL': '/bin/bash', 21:16:43 INFO - 'SHLVL': '1', 21:16:43 INFO - 'TERM': 'linux', 21:16:43 INFO - 'TMOUT': '86400', 21:16:43 INFO - 'USER': 'cltbld', 21:16:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', 21:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:43 INFO - '_': '/tools/buildbot/bin/python'} 21:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:43 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)) 21:16:43 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)) 21:16:43 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)) 21:16:43 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)) 21:16:43 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)) 21:16:43 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)) 21:16:43 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)) 21:16:43 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)) 21:16:43 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)) 21:16:43 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)) 21:16:43 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)) 21:16:43 INFO - Cleaning up... 21:16:43 INFO - Return code: 0 21:16:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:43 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 0xbbe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d3b0>, '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 0xe7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e740>, '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': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', '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 21:16:43 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 21:16:43 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 21:16:43 INFO - Using env: {'DISPLAY': ':0', 21:16:43 INFO - 'HOME': '/home/cltbld', 21:16:43 INFO - 'LANG': 'en_US.UTF-8', 21:16:43 INFO - 'LANGUAGE': 'en_US:en', 21:16:43 INFO - 'LOGNAME': 'cltbld', 21:16:43 INFO - 'MAIL': '/var/mail/cltbld', 21:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:43 INFO - 'MOZ_NO_REMOTE': '1', 21:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:43 INFO - 'NO_EM_RESTART': '1', 21:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:43 INFO - 'PWD': '/builds/slave/test', 21:16:43 INFO - 'SHELL': '/bin/bash', 21:16:43 INFO - 'SHLVL': '1', 21:16:43 INFO - 'TERM': 'linux', 21:16:43 INFO - 'TMOUT': '86400', 21:16:43 INFO - 'USER': 'cltbld', 21:16:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', 21:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:43 INFO - '_': '/tools/buildbot/bin/python'} 21:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:16:44 INFO - Cleaning up... 21:16:44 INFO - Return code: 0 21:16:44 INFO - Running post-action listener: _resource_record_post_action 21:16:44 INFO - Running post-action listener: _start_resource_monitoring 21:16:44 INFO - Starting resource monitoring. 21:16:44 INFO - [mozharness: 2016-07-31 04:16:44.151317Z] Finished create-virtualenv step (success) 21:16:44 INFO - [mozharness: 2016-07-31 04:16:44.151806Z] Running install step. 21:16:44 INFO - Running pre-action listener: _resource_record_pre_action 21:16:44 INFO - Running main action method: install 21:16:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:16:44 INFO - Reading from file tmpfile_stdout 21:16:44 INFO - Detecting whether we're running mozinstall >=1.0... 21:16:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:16:44 INFO - Reading from file tmpfile_stdout 21:16:44 INFO - Output received: 21:16:44 INFO - Usage: mozinstall [options] installer 21:16:44 INFO - Options: 21:16:44 INFO - -h, --help show this help message and exit 21:16:44 INFO - -d DEST, --destination=DEST 21:16:44 INFO - Directory to install application into. [default: 21:16:44 INFO - "/builds/slave/test"] 21:16:44 INFO - --app=APP Application being installed. [default: firefox] 21:16:44 INFO - mkdir: /builds/slave/test/build/application 21:16:44 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'] 21:16:44 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 21:17:01 INFO - Reading from file tmpfile_stdout 21:17:01 INFO - Output received: 21:17:01 INFO - /builds/slave/test/build/application/firefox/firefox 21:17:01 INFO - Running post-action listener: _resource_record_post_action 21:17:01 INFO - [mozharness: 2016-07-31 04:17:01.330972Z] Finished install step (success) 21:17:01 INFO - [mozharness: 2016-07-31 04:17:01.331256Z] Running run-tests step. 21:17:01 INFO - Running pre-action listener: _resource_record_pre_action 21:17:01 INFO - Running main action method: run_tests 21:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:17:01 INFO - Python 2.7.3 21:17:01 INFO - Return code: 0 21:17:01 INFO - grabbing minidump binary from tooltool 21:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:01 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 0xe7d3b0>, '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 0xe7e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:17:01 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 21:17:01 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 21:17:01 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 21:17:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:17:01 INFO - Return code: 0 21:17:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:17:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:17:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:17:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:17:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 21:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 21:17:01 INFO - Using env: {'DISPLAY': ':0', 21:17:01 INFO - 'HOME': '/home/cltbld', 21:17:01 INFO - 'LANG': 'en_US.UTF-8', 21:17:01 INFO - 'LANGUAGE': 'en_US:en', 21:17:01 INFO - 'LOGNAME': 'cltbld', 21:17:01 INFO - 'MAIL': '/var/mail/cltbld', 21:17:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:17:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:01 INFO - 'MOZ_NO_REMOTE': '1', 21:17:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:01 INFO - 'NO_EM_RESTART': '1', 21:17:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:01 INFO - 'PWD': '/builds/slave/test', 21:17:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:17:01 INFO - 'SHELL': '/bin/bash', 21:17:01 INFO - 'SHLVL': '1', 21:17:01 INFO - 'TERM': 'linux', 21:17:01 INFO - 'TMOUT': '86400', 21:17:01 INFO - 'USER': 'cltbld', 21:17:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469934319.965841-738445851', 21:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:01 INFO - '_': '/tools/buildbot/bin/python'} 21:17:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 21:17:01 INFO - mozversion application_buildid: 20160730183002 21:17:01 INFO - mozversion application_changeset: c761bfb5fd83eb0d767adbf34012b7dda384dce9 21:17:01 INFO - mozversion application_display_name: Nightly 21:17:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:17:01 INFO - mozversion application_name: Firefox 21:17:01 INFO - mozversion application_remotingname: firefox 21:17:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:17:01 INFO - mozversion application_vendor: Mozilla 21:17:01 INFO - mozversion application_version: 50.0a1 21:17:01 INFO - mozversion platform_buildid: 20160730183002 21:17:01 INFO - mozversion platform_changeset: c761bfb5fd83eb0d767adbf34012b7dda384dce9 21:17:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:17:01 INFO - mozversion platform_version: 50.0a1 21:17:01 INFO - using testdate: 1469938621 21:17:01 INFO - actual date: 1469938621 21:17:01 INFO - starting webserver on 'localhost:34151' 21:17:01 INFO - SUITE-START | Running 2 tests 21:17:01 INFO - TEST-START | dromaeo_css 21:17:01 INFO - operating with platform_type : linux_ 21:17:01 INFO - Initialising browser for dromaeo_css test... 21:17:01 INFO - TEST-INFO | started process 16427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6YYQP/profile http://localhost:34151/getInfo.html) 21:17:05 INFO - PROCESS | 16427 | __metrics Screen width/height:1600/1200 21:17:05 INFO - PROCESS | 16427 | colorDepth:24 21:17:05 INFO - PROCESS | 16427 | Browser inner width/height: 1024/697 21:17:05 INFO - PROCESS | 16427 | __metrics 21:17:06 ERROR - PROCESS | 16427 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 21:17:07 INFO - TEST-INFO | 16427: exit 0 21:17:07 INFO - Browser initialized. 21:17:07 INFO - Running cycle 1/1 for dromaeo_css test... 21:17:07 INFO - TEST-INFO | started process 16548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6YYQP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:17:19 INFO - PROCESS | 16548 | RSS: Main: 162803712 21:17:19 INFO - PROCESS | 16548 | 21:18:08 INFO - PROCESS | 16548 | 1469938688831 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] 21:20:17 INFO - PROCESS | 16548 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34151/tests/dromaeo/cssquery-ext.html) 21:20:18 INFO - PROCESS | 16548 | RSS: Main: 168361984 21:20:18 INFO - PROCESS | 16548 | 21:23:20 INFO - PROCESS | 16548 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-ext.html (next: http://localhost:34151/tests/dromaeo/cssquery-jquery.html) 21:23:21 INFO - PROCESS | 16548 | RSS: Main: 166031360 21:23:21 INFO - PROCESS | 16548 | 21:26:23 INFO - PROCESS | 16548 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34151/tests/dromaeo/cssquery-mootools.html) 21:26:23 INFO - PROCESS | 16548 | RSS: Main: 169660416 21:26:23 INFO - PROCESS | 16548 | 21:29:25 INFO - PROCESS | 16548 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34151/tests/dromaeo/cssquery-prototype.html) 21:29:25 INFO - PROCESS | 16548 | RSS: Main: 164016128 21:29:25 INFO - PROCESS | 16548 | 21:32:28 INFO - PROCESS | 16548 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34151/tests/dromaeo/cssquery-yui.html) 21:32:29 INFO - PROCESS | 16548 | RSS: Main: 166576128 21:32:29 INFO - PROCESS | 16548 | 21:35:31 INFO - PROCESS | 16548 | Cycle 1(1): loaded http://localhost:34151/tests/dromaeo/cssquery-yui.html (next: http://localhost:34151/tests/dromaeo/cssquery-dojo.html) 21:35:32 INFO - PROCESS | 16548 | RSS: Main: 169340928 21:35:32 INFO - PROCESS | 16548 | 21:35:32 INFO - PROCESS | 16548 | __start_tp_report 21:35:32 INFO - PROCESS | 16548 | _x_x_mozilla_page_load 21:35:32 INFO - PROCESS | 16548 | _x_x_mozilla_page_load_details 21:35:32 INFO - PROCESS | 16548 | |i|pagename|runs| 21:35:32 INFO - PROCESS | 16548 | |0;dojo.html;3041.452538543062;3058.311879827038;3083.984580077099;3089.11960091374;3094.706002929722;5311.495407936245;5323.520883120518;5355.08963476209;5380.704061276629;5396.055690254205;5336.252924590561;5363.383210930744;5380.757865896035;5398.78404863805;5436.673799572019;4795.832145874886;4907.2148456247005;4917.237828136645;4975.9004819903585;5082.822101226458;5040.16837221858;5070.391553013644;5078.542931136197;5107.46371630979;5111.105556527611;4785.617150627959;4840.201366774478;4888.9755551222015;4950;4952.603791696673;4932.728699921503;4941.579965702919;4951.950480495221;4975.104481193383;4994.101061808873;4873.049755297719;4887.218045112765;4896.387951506062;4929.975350123263;4953.43035550909;5146.228065790124;5300.337457817773;5384.138537833967;5387.515123638852;5451.700156491392;5793.188953546507;5795.536357091422;5797.797077102324;5825.359210486843;5830.679312637803;5760.596758226926;5780.393058728815;5782.624129431616;5795.594308398414;5810.1865738796605;5240.764165612519;5352.839414817523;5352.91970620441;5387.892242155174;5435.402105768362;5970.671613061323;5974.761009559656;5980.13288073227;5995.640261584319;6018.247719035121;5681.375048744635;5698.088305871041;5699.173619825102;5714.257146570919;5722.685252311079;5521.1442226454965;5574.693391863487;5612.494875461228;5745.798897038583;5798.304203495523;5544.251526044013;5562.916556251659;5612.410696876851;5651.717414129277;5706.28671416073;5700.686462244534;5724.971375143181;5764.481196692318;5775.364709881909;5824.854378640568;4442.577955094261;4448.2839551176585;4455.977720111378;4460.687751857404;4487.326900964881;3853.903652408656;3874.12832112778;3898.90252743678;3907.5701672815967;4005.619466150711;5504.669719816824;5564.1931919871395;5567.832965011056;5594.636348637407;5617.325920889438;5794.710264486759;5807.593468457168;5840.094785308284;5840.8247752567495;5860.033094539439;5342;5447.618666693373;5500.697461639648;5541.612087153861;5563.721813909288;4874.171390863562;4885.267209918541;4888.780004899788;4913.778879950411;4928.236123400879;5966.254218222723;6028.216331876915;6037.9396206038255;6052.182955301066;6053.061775424816;5653.321601407857;5707.429257074259;5749.051406518045;5763.221965034667;5793.507551858139;5987.970060149672;5989.910151347821;6012.549058820518;6034.818955431344;6044;5671.432856714296;5691.914621280601;5713.285839270091;5729.026065568946;5750.9424905752085;5618.297712785902;5686.9715651421475;5691.231683722644;5786.739596718242;5850.063989761617;5633.38032816398;5636.154576813511;5640.32316122068;5680.091185410314;5685.914711279417;5594.1049432092295;5643.887122257614;5656.43435656431;5657.236273103243;5659.688717120598;5496.367917689517;5601.327840659147;5631.549476041825;5653.152027195953;5660.349059858169;5661.348944871393;5685.829425117253;5688.146777983336;5726.828195154152;5758.078707406795;5480.177973304037;5527.336719593674;5540.36285827135;5543.445655434424;5545.7781688732 21:35:32 INFO - PROCESS | 16548 | |1;ext.html;556.1729815473947;579.2383016333519;592.5822295281826;607.4623957797348;609.6951524237884;42498.36252456216;43608;43689.34465983009;43831.78084109575;48090.51909480904;45034.54965450353;45228.773856130756;45520.54479455204;45651.31523027149;45664.31503527441;8984.8652270216;9099;9121.635134594608;9124.863127053099;9136.406133601327;8956.776080597972;9020.458772473672;9022.86465703015;9032.819343613124;9035.141661542142;9042.050584688612;9104.544772761335;9108.134727200906;9117.133872282122;9135.634574617008;9023.729288121334;9036.63853445868;9047.773805654846;9061.411008284473;9119.088091190893;8878.422902511316;8964.462132272085;8970.686025989124;8986.730398088068;9001.684941027099;43253.56746432527;43310.78344608288;43373.56626433758;43542;43556.34665479988;3521.9471707924404;3602.873899413534;4191.413202151702;4287.292596721537;4369.6285815705705;34058.31883362344;34726;34782.65217347819;34958.47562286568;34965.82517087424;3890.824912878927;4187.392828039917;4348.391225228471;4378.321360189176;4477.037436951038;282248;374895;376265;376271;377838;61821;62880;62989.37010629927;63067.36932630707;63070.68464657739;35605.64394356023;35773.28453430917;35998.28003439916;37786.898768666426;65526.67236663786;13345;13361.198328100345;13437.731245375038;13446.462141514425;13473.932630336982;10389.84415233772;10451.68644940653;10475.685729428129;10482.842757358645;10504.002119798606;19346.175079452663;19373.32193373225;19472.70790938137;19480.887492480684;19579.412617621496;6849.657517124124;7379.81550461232;7409.110906691124;7472.9252707473315;7543;927.893292271384;1046.210111365914;1062.4475272858072;1092.268180319188;1104.817705078653;33719.32561348759;34076.31847363039;34160;34326.167487094666;34405.48391774125;1117.2458590451574;1154.4500660469091;1166.1953252256085;1187.655579881842;1243.720162963326;17519.299228030737;17808.3767068152;17834.821651783575;17903.552411189565;18095.63808723818;557409;557976;564036;564132;567575;61696;62251;62289.68855155695;62404;62701.372986270464;1284.7751643462357;1297.47452281826;1324.205476713964;1334.486222804208;1339.8995075369387;32313.676863232005;33047.33905321928;33864.22963469429;34198.14504637404;34536;53681;56361.39121218583;56970.145447817486;57351;61264.69367653133;545856;548979;549130;549641;554727;45535.089298214516;45587.54412455833;45682.771586143186;46155.07689846252;46188.7690561545;49794.751026246086;50518;50954.74522627363;52137.47862521326;52251;42094.36858447064;42172.789136054125;42352;42590.361144583476;44293.11413771771;42642.78678606587;42656.360154598326;42872;44369.33445998377;44444.55555444404;43136;43307.783461082494;43831.34252986144;44350.778246108566;44550.3317450245;37145;38608.42087368636;38968.6103138965;39342.40986385149;39792.60207397889;29465.85267073651;29568.112956611338;29815;30192.5471117929;30222.395552088394 21:35:32 INFO - PROCESS | 16548 | |2;jquery.html;370.11727031031;378.8087016056892;386.2140543992974;387.3763241181695;397.94627725257084;17630.294788208474;19325.4202373929;19767.308144214938;20371.08330125144;20476.385708428752;18393.98833064181;18606.813931860677;19012.334568290113;19090.427287181406;19374.515637109078;5227.5295223429885;5732.770689172438;5876.353601103875;5903.439173278553;5927.081302398114;5842.123681447795;5858.7949421770245;5870.236869206997;5881.764729410818;5881.764729410818;5734.283214598176;5755.769769209227;5758.798442054529;5790.073588225885;5818.06910894257;5578.135389014709;5771;5771.884562308751;5785.074388097884;5794.333651630074;5047.3848368522085;5081.390233172006;5144.022635699205;5180.559652429548;5191.714455704935;22802.543949120925;22922.09823756385;23003;23132.76867231323;23278.883605582032;2443.022790883661;2516.0564788204424;2991.7008299170125;3068.9079327620207;3077.322988942429;14447.133172009713;14549.199794011325;14578.489752858599;14651.63370915725;14978.625534361729;1942.2522328903333;1999.9900050474562;2028.6551286281367;2062.092679221138;2083.7082808406835;75369;77234;77258;77963;79092;9976.752905886764;10239.385636861663;10342.896571034193;10452.947735261427;10828.133749300037;14610.954466374717;14661.266936653125;14728.26358682083;14745.11529308245;14753.557393278219;7122.786316410516;7358.264173582599;7364.815879602946;7566.583837888859;7626.809329766689;6832.521723479309;6853.862922741518;7032;7082.150141982892;7103.6093014883645;6417.593402474072;6609.173853268341;6618.073469714244;6657.667116644148;6663.867982048429;1892.2431027589075;1935.129191863667;1940.6506828770957;1952.7851936286997;1959.2163134746215;950.9952450237705;973.1436336024253;981.7005813227034;993.4982833669095;1002.6941782756184;19442.5139371514;20095.698564521543;20175.899120504302;20328.796712032985;20421.69367459489;982.2436723722693;1006.5822683586376;1013.5084484025242;1018.7300365403174;1044.2116202267391;11126.666200014013;11411.426403338764;11666.591669291534;11746.941265293619;11814.291142531476;439124;440816;442601;480117;497167;45443;59096;64096.35903640904;75418.62290688622;77678;984.3404918704629;1006.7030226083323;1026.6868605075374;1027.1166796554958;1032.2413026425572;15216.315265813286;17761.822381776015;17995;18010.459686209433;18186.727199091758;37664.246715066096;37813.24373512459;41691.37462937998;42330.36504452497;42673.93698942811;57430.42569574251;57590.7120464395;57595;57988.42011579999;60577;7272.709091636275;7392.593407362647;7651.5409075455655;7819.123410381581;7847.9607601961625;12359.073069520002;13214.471421143047;13365.799513007118;13578.93210533941;13687.794683079961;10943.890561094606;11703.473343699383;11745.119116066158;11800.17398782077;12063.095267855122;11570.363630000431;11571.710707232387;11635;11640.476178571815;11821.940890295493;11769;11907.52369905194;11951.521939122686;12021.338826364285;12171.208871423329;7459.403247740276;7629.809254768676;7658.410727564;7699.615019249127;7972.162922893012;8910.064443233367;10906;11473.311601303949;11770.76458470843;11788 21:35:32 INFO - PROCESS | 16548 | |3;mootools.html;1469.7721853112764;1495.0879963222435;1569.960750981226;1694.0682624556491;1715.7169067103928;7601.733939312126;8632.30941524678;8668.696595619154;8991.415557988727;9016.909830901697;8728.738137855858;8943.284537237021;8953.91046089539;8982.910170898289;9047.230985366235;2330.557194133109;2339.0643742502966;2363.0783994242174;2365.420471984366;2367.538330025646;2296.494771150344;2330.755270696578;2354.6114891042957;2367.230650038736;2378.5480758655885;2305.13557415969;2305.4121199094207;2314.93055208344;2357.7170739511284;2357.8113750899975;2300.608896487601;2303.4586872085047;2306.907723691067;2322.593546129429;2328.5459335429596;2252.6283163278204;2264.116994372196;2270.3529494094105;2270.5345404192103;2274.727032756063;8954.910450895539;9009.639614415415;9018.458892466473;9030.954845225731;9105.180533751927;5066.189409694468;5206.349206349207;5245.501677340647;5249.527542521153;5274.604404669665;3190.1865024418858;3201.807891526516;3341.682540158681;3344.3144155448076;3393.6436674149104;1077.620645573667;1088.6244245735209;1101.719061639285;1103.332483847277;1112.0380870546999;12510.874891251062;12545;12642.55751048709;12652.68368290791;12744.044196685285;4456.309272062836;4534.161180181677;4723.385959825269;4726.716397016121;4765.904681906342;10573.894261057445;10580.100691441314;10585.523651435704;10596.841047384296;10619.256652034437;5351.3043304370185;5373.811916582901;5388.91916621251;5389.973050134724;5398.406175320712;4308.978455107705;4708.364370809897;4833.202521583969;4851.95148048515;4923.163062279421;3756.417755247941;3866.8839934802;3880.767153970771;3929.8035098245546;3967.5238971323047;1228.8402507673945;1230.4401497318877;1232.4700378837185;1241.937903104841;1247.476060054761;1035.166690813902;1035.6168217759478;1046.6755305855208;1052.58422922945;1061.7080302916606;6135.558143836195;6214.689265536705;6330.177076979963;6401.07184458251;6421.036844473367;934.5514153206499;951.2152474208806;971.7667759737753;985.2413641496008;999.1207737191226;4255.340422234559;4462.754548499864;4473.060657261946;4519.480259770103;4581.473130589959;10959.232853700323;11272.154588405903;11337.093032557375;11361.261518001304;11377.37424441647;10959.3424394535;10978.505967231495;11219.102471802236;11236.719082023015;11247.437628118561;8298.419110662317;8372.246497815104;8401.70594029206;8409.159084091541;8498.23515883561;6195.16365290698;6220.688965551613;6294.464970477561;6381.266154392304;6394.584352017104;10091.495425228855;10097.646582369582;10125.848112278174;10136.543855526372;10151.492425378849;10371.014753598396;10402;10506.94746526293;10512.894871051498;10559.419231942316;6512.446442052478;7182.856342873218;7271.963640181765;7281;7458.552486850589;8719.869201961848;8747.431416957877;8825.867611985697;8840.425372350777;8870.15733505316;7710.961445192738;7875.369970402239;7890.605469726376;7942.6028698566;8005.599720014093;7685.884711729217;7706.653200605874;7759.7672069838;7835.451518393657;7861.60691965388;7067.82330441743;7109.324614161646;7175.282471752783;7224.927750722425;7225.855482890418;5440.972795135999;5508.3114610673665;5508.641938274;5545.722713864371;5688.516476099578;5408.3509978802795;5420.403755586961;5479.17812328138;5596.020696378199;5611.158326251095 21:35:32 INFO - PROCESS | 16548 | |4;prototype.html;323.5712680698075;326.7304473809107;330.82135646750754;334.32966901362767;337.276541817801;5536.141898005811;5600.803971860985;5604.41153678864;5620.971895140528;5637.0698834692275;5461.290032295796;5479.17812328151;5499.752511136999;5508.14623733321;5521.337439507255;4089.50925888893;4152.252594532983;4248.065425606362;4281.935770963438;4288.249556327646;4272.910407845995;4274.5893855027925;4284.335927931175;4287.162989124731;4287.799416163463;4243.342281946288;4248.107897341547;4254.851080212193;4262.318029115342;4264.8507302244425;4002.1595464952247;4185.644220241283;4227.556106608792;4249.830006799724;4276.87169384919;3716.628337166289;3723.646253605903;3724.404095344732;3733.869314574004;3742.120601658608;5257.369115706139;5374.328208973879;5381.865453363658;5383.407825139231;5383.865403364947;4605;4779.952200477986;4845.248986407078;4878.804847806084;4896.583790377822;5677.700531284836;5677.914831277534;5682.857928551778;5688.544916406678;5703.3441154267375;4053.4730485037053;4054.1080962188566;4054.776987265699;4055.6958228133008;4058.208649313385;5832.854178645568;5886.264216972879;5946.345901950782;5948.940510594882;5979.252593425822;4169.624733773975;4176.206520761046;4177.164567086595;4179.874603761892;4186.309258972296;4199.370094485852;4226.4716910386205;4240.38514415408;4241.533431322552;4266.168097221012;4754.904901902012;4804.759762011886;4813.542713442217;4851.611871050308;4897.9714260005085;5746.396628353963;5751.827445176651;5753.108268218432;5759.976012593338;5775.162601422854;1445.775904734768;1447.905886117399;1458.4603696632314;1461.0705535401664;1461.4519555166812;901.4230892228978;932.8600709893434;941.2846236859899;947.2090804178588;985.6939555089535;5521.365043020104;5534.118399744107;5539.612227144061;5569.805056822992;5596.776128954796;5749.68376739275;5797.927383434078;5835.9708201458725;5925.259342582177;5953.732082056318;5358.5981051421295;5467.4532546745;5531.257653839109;5550.528205102531;5586.273784408001;3105.2547388626567;3120.329129237225;3132.3688101994435;3134.341788224453;3145.88989385375;5886.8822623547285;6120.755169793248;6120.755169793248;6136.202293701879;6141.232345956755;6027.78902738402;6031.095335699592;6051.909221361683;6089.604175728564;6091.329953705089;6141.170941922784;6145.293291271561;6160.537959653044;6193.783217587453;6201.96899015502;5662.886742265049;5939.406059394026;5974.522038236843;5984.251968503937;5994.970025149846;5874.676892770768;5908.852278693067;5930.406959304035;5941.465268125889;5947.226860508279;5897.233359663216;6102.497975829889;6192.938070619236;6202.2867370253;6213.782517611862;4315.8489452869;4350.564943505624;4362.105768317424;4371.497277813092;4381.474223093249;5899.852503687443;5977.6114552553945;5981.850453738692;5988.910166347596;5998.770252098397;5623.156526520891;5770.5095066919785;5774.162746401832;5803.3616302207565;5864.179014937998;5737.627054241461;5796.275465566804;5812.82561523155;5814.30228372581;5816.82549523515;5583.2462617547735;5786.450287222707;5788.594798364074;5794.304683438015;5808.94191058084;5816.248519704851;5818.301803783573;5823.796167134299;5833.154192641959;5857.531397488276;5674.971625141848;5694.800681976111;5694.971525142348;5749.195112684144;5752.165935939349 21:35:32 INFO - PROCESS | 16548 | |5;yui.html;736.8894665800129;771.5679219637;772.4438404348869;794.8489786940481;834.7495751274618;15212.315445804938;16273;16334.509964701077;16346.91826540867;16396.344146234165;14719.632009199775;14889.55331340059;14931.477398291063;14936.850631493682;14963.476278330261;635.8537536366639;761.9390448764113;772.7990722412158;779.6452614060589;785.140271402813;780.5472825761045;785.6582386661792;786.6302837666316;786.6499407763547;786.7600381883523;826.0954255090666;828.6022709099636;829.9419040667126;831.9974430810888;832.0223737108903;823.6417158536026;824;824.7278398128603;824.9628766705482;825.5005721538442;604.5284677951205;604.6130476495002;604.6462819250744;604.6885853785304;606.8664893723374;14944.551663450005;14961.57865002823;14967.326470308863;14971.401143954228;15023.173725445096;14832;15118.546443606709;15310.157941313224;15355.923220383938;15537.378504859793;11644.941775291069;11678.88321116795;11681.415929203591;11735.647930562096;11918;3937.5471820740695;3988.062805240766;3991.3613821788376;4076.8980775480554;4107.507099148092;74759.25240747577;75131.62434187849;76308.61845690737;76687;76828.61585692035;12007.639770806889;12014.939925300492;12021.847080358863;12088.516459341703;12211.412516372815;22671.773282266968;22691.43271418195;22710.97800598977;22737.31788046361;22773.31680049601;8336.458130221516;8362.080171181165;8641.308695304486;8858.955705221433;8888.866667;4732.479427262998;4773.64197685175;4776.307435421844;4874.122657921537;4945.727984960789;3502.124468882779;3598.9280214395567;3620.094976255936;3621.909452263662;3623.8188090595363;668.7960172147444;687.5702685821361;700.6916956539106;718.1740997852511;720.4920531025614;628.2837565175703;706.2549010793559;753.0511555440075;771.5447885747436;775.9650815713306;10234.692959211236;10369.274150809371;10434.38290048269;10447.216458765472;10602.628907988183;713.4470785141557;761.3338328962158;767.6737386610669;770.1566784371105;772.2432016623741;4947.282644016597;5189.273501709764;5260.105782017066;5260.579153667774;5284.39229488606;70532.29467705257;71390.2860971394;71459.64270178616;71754.28245717476;119917.40041299738;60894.086588701204;74522.62738686272;83242.16757832344;106887.46556267324;111589;58814;94968.52515737516;101470;102219.48890255501;102924.48537757264;9763.170130538983;9830.901690982999;10077.395356278646;10143.137833284254;10181.33821301613;54677;55921.161182583106;56513.15230271467;56639;58378.416215838995;73492.63253683697;80455;85376;86948.130518694;88826.55586722025;11576.479058442223;11730.648080557597;11779.764404712028;11847.940760296144;11908;13978.860211398163;13985.44058237659;14161.221132837793;14396.568102956928;14945.551633451014;13162.276074815976;13230.140040897311;13303.933480332924;13812.447502099803;14213.360398781873;12555.183913045623;12639.241645501299;12762.61712148637;12829.294388808705;12911.418986145458;12324.198927069712;12460.127791054902;12663.303518306213;13094.083414160918;13111.344432778515;11630.360330181922;11680.76638467209;12074.215176013531;12387.07096967749;12436.937815310866;11968.67007036321;12593.521773406013;12641.431135598736;12813.743725125632;12867.935660321638 21:35:32 INFO - PROCESS | 16548 | __end_tp_report 21:35:32 INFO - PROCESS | 16548 | __start_cc_report 21:35:32 INFO - PROCESS | 16548 | _x_x_mozilla_cycle_collect,345 21:35:32 INFO - PROCESS | 16548 | __end_cc_report 21:35:32 INFO - PROCESS | 16548 | __startTimestamp1469939732042__endTimestamp 21:35:32 INFO - PROCESS | 16548 | 21:35:32 INFO - PROCESS | 16548 | ------- Summary: start ------- 21:35:32 INFO - PROCESS | 16548 | Number of tests: 6 21:35:32 INFO - PROCESS | 16548 | 21:35:32 INFO - PROCESS | 16548 | [#0] dojo.html Cycles:165 Average:5365.70 Median:5574.69 stddev:615.27 (11.0%) stddev-sans-first:589.52 21:35:32 INFO - PROCESS | 16548 | Values: 3041.5 3058.3 3084.0 3089.1 3094.7 5311.5 5323.5 5355.1 5380.7 5396.1 5336.3 5363.4 5380.8 5398.8 5436.7 4795.8 4907.2 4917.2 4975.9 5082.8 5040.2 5070.4 5078.5 5107.5 5111.1 4785.6 4840.2 4889.0 4950.0 4952.6 4932.7 4941.6 4952.0 4975.1 4994.1 4873.0 4887.2 4896.4 4930.0 4953.4 5146.2 5300.3 5384.1 5387.5 5451.7 5793.2 5795.5 5797.8 5825.4 5830.7 5760.6 5780.4 5782.6 5795.6 5810.2 5240.8 5352.8 5352.9 5387.9 5435.4 5970.7 5974.8 5980.1 5995.6 6018.2 5681.4 5698.1 5699.2 5714.3 5722.7 5521.1 5574.7 5612.5 5745.8 5798.3 5544.3 5562.9 5612.4 5651.7 5706.3 5700.7 5725.0 5764.5 5775.4 5824.9 4442.6 4448.3 4456.0 4460.7 4487.3 3853.9 3874.1 3898.9 3907.6 4005.6 5504.7 5564.2 5567.8 5594.6 5617.3 5794.7 5807.6 5840.1 5840.8 5860.0 5342.0 5447.6 5500.7 5541.6 5563.7 4874.2 4885.3 4888.8 4913.8 4928.2 5966.3 6028.2 6037.9 6052.2 6053.1 5653.3 5707.4 5749.1 5763.2 5793.5 5988.0 5989.9 6012.5 6034.8 6044.0 5671.4 5691.9 5713.3 5729.0 5750.9 5618.3 5687.0 5691.2 5786.7 5850.1 5633.4 5636.2 5640.3 5680.1 5685.9 5594.1 5643.9 5656.4 5657.2 5659.7 5496.4 5601.3 5631.5 5653.2 5660.3 5661.3 5685.8 5688.1 5726.8 5758.1 5480.2 5527.3 5540.4 5543.4 5545.8 21:35:32 INFO - PROCESS | 16548 | 21:35:32 INFO - PROCESS | 16548 | [#1] ext.html Cycles:180 Average:65302.80 Median:43648.67 stddev:132720.06 (304.1%) stddev-sans-first:133003.35 21:35:32 INFO - PROCESS | 16548 | Values: 556.2 579.2 592.6 607.5 609.7 42498.4 43608.0 43689.3 43831.8 48090.5 45034.5 45228.8 45520.5 45651.3 45664.3 8984.9 9099.0 9121.6 9124.9 9136.4 8956.8 9020.5 9022.9 9032.8 9035.1 9042.1 9104.5 9108.1 9117.1 9135.6 9023.7 9036.6 9047.8 9061.4 9119.1 8878.4 8964.5 8970.7 8986.7 9001.7 43253.6 43310.8 43373.6 43542.0 43556.3 3521.9 3602.9 4191.4 4287.3 4369.6 34058.3 34726.0 34782.7 34958.5 34965.8 3890.8 4187.4 4348.4 4378.3 4477.0 282248.0 374895.0 376265.0 376271.0 377838.0 61821.0 62880.0 62989.4 63067.4 63070.7 35605.6 35773.3 35998.3 37786.9 65526.7 13345.0 13361.2 13437.7 13446.5 13473.9 10389.8 10451.7 10475.7 10482.8 10504.0 19346.2 19373.3 19472.7 19480.9 19579.4 6849.7 7379.8 7409.1 7472.9 7543.0 927.9 1046.2 1062.4 1092.3 1104.8 33719.3 34076.3 34160.0 34326.2 34405.5 1117.2 1154.5 1166.2 1187.7 1243.7 17519.3 17808.4 17834.8 17903.6 18095.6 557409.0 557976.0 564036.0 564132.0 567575.0 61696.0 62251.0 62289.7 62404.0 62701.4 1284.8 1297.5 1324.2 1334.5 1339.9 32313.7 33047.3 33864.2 34198.1 34536.0 53681.0 56361.4 56970.1 57351.0 61264.7 545856.0 548979.0 549130.0 549641.0 554727.0 45535.1 45587.5 45682.8 46155.1 46188.8 49794.8 50518.0 50954.7 52137.5 52251.0 42094.4 42172.8 42352.0 42590.4 44293.1 42642.8 42656.4 42872.0 44369.3 44444.6 43136.0 43307.8 43831.3 44350.8 44550.3 37145.0 38608.4 38968.6 39342.4 39792.6 29465.9 29568.1 29815.0 30192.5 30222.4 21:35:32 INFO - PROCESS | 16548 | 21:35:32 INFO - PROCESS | 16548 | [#2] jquery.html Cycles:180 Average:27353.93 Median:3073.12 stddev:75545.39 (2458.3%) stddev-sans-first:75730.15 21:35:32 INFO - PROCESS | 16548 | Values: 370.1 378.8 386.2 387.4 397.9 17630.3 19325.4 19767.3 20371.1 20476.4 18394.0 18606.8 19012.3 19090.4 19374.5 5227.5 5732.8 5876.4 5903.4 5927.1 5842.1 5858.8 5870.2 5881.8 5881.8 5734.3 5755.8 5758.8 5790.1 5818.1 5578.1 5771.0 5771.9 5785.1 5794.3 5047.4 5081.4 5144.0 5180.6 5191.7 22802.5 22922.1 23003.0 23132.8 23278.9 2443.0 2516.1 2991.7 3068.9 3077.3 14447.1 14549.2 14578.5 14651.6 14978.6 1942.3 2000.0 2028.7 2062.1 2083.7 75369.0 77234.0 77258.0 77963.0 79092.0 9976.8 10239.4 10342.9 10452.9 10828.1 14611.0 14661.3 14728.3 14745.1 14753.6 7122.8 7358.3 7364.8 7566.6 7626.8 6832.5 6853.9 7032.0 7082.2 7103.6 6417.6 6609.2 6618.1 6657.7 6663.9 1892.2 1935.1 1940.7 1952.8 1959.2 951.0 973.1 981.7 993.5 1002.7 19442.5 20095.7 20175.9 20328.8 20421.7 982.2 1006.6 1013.5 1018.7 1044.2 11126.7 11411.4 11666.6 11746.9 11814.3 439124.0 440816.0 442601.0 480117.0 497167.0 45443.0 59096.0 64096.4 75418.6 77678.0 984.3 1006.7 1026.7 1027.1 1032.2 15216.3 17761.8 17995.0 18010.5 18186.7 37664.2 37813.2 41691.4 42330.4 42673.9 57430.4 57590.7 57595.0 57988.4 60577.0 7272.7 7392.6 7651.5 7819.1 7848.0 12359.1 13214.5 13365.8 13578.9 13687.8 10943.9 11703.5 11745.1 11800.2 12063.1 11570.4 11571.7 11635.0 11640.5 11821.9 11769.0 11907.5 11951.5 12021.3 12171.2 7459.4 7629.8 7658.4 7699.6 7972.2 8910.1 10906.0 11473.3 11770.8 11788.0 21:35:32 INFO - PROCESS | 16548 | 21:35:32 INFO - PROCESS | 16548 | [#3] mootools.html Cycles:180 Average:5906.99 Median:4526.82 stddev:3369.63 (74.4%) stddev-sans-first:3362.58 21:35:32 INFO - PROCESS | 16548 | Values: 1469.8 1495.1 1570.0 1694.1 1715.7 7601.7 8632.3 8668.7 8991.4 9016.9 8728.7 8943.3 8953.9 8982.9 9047.2 2330.6 2339.1 2363.1 2365.4 2367.5 2296.5 2330.8 2354.6 2367.2 2378.5 2305.1 2305.4 2314.9 2357.7 2357.8 2300.6 2303.5 2306.9 2322.6 2328.5 2252.6 2264.1 2270.4 2270.5 2274.7 8954.9 9009.6 9018.5 9031.0 9105.2 5066.2 5206.3 5245.5 5249.5 5274.6 3190.2 3201.8 3341.7 3344.3 3393.6 1077.6 1088.6 1101.7 1103.3 1112.0 12510.9 12545.0 12642.6 12652.7 12744.0 4456.3 4534.2 4723.4 4726.7 4765.9 10573.9 10580.1 10585.5 10596.8 10619.3 5351.3 5373.8 5388.9 5390.0 5398.4 4309.0 4708.4 4833.2 4852.0 4923.2 3756.4 3866.9 3880.8 3929.8 3967.5 1228.8 1230.4 1232.5 1241.9 1247.5 1035.2 1035.6 1046.7 1052.6 1061.7 6135.6 6214.7 6330.2 6401.1 6421.0 934.6 951.2 971.8 985.2 999.1 4255.3 4462.8 4473.1 4519.5 4581.5 10959.2 11272.2 11337.1 11361.3 11377.4 10959.3 10978.5 11219.1 11236.7 11247.4 8298.4 8372.2 8401.7 8409.2 8498.2 6195.2 6220.7 6294.5 6381.3 6394.6 10091.5 10097.6 10125.8 10136.5 10151.5 10371.0 10402.0 10506.9 10512.9 10559.4 6512.4 7182.9 7272.0 7281.0 7458.6 8719.9 8747.4 8825.9 8840.4 8870.2 7711.0 7875.4 7890.6 7942.6 8005.6 7685.9 7706.7 7759.8 7835.5 7861.6 7067.8 7109.3 7175.3 7224.9 7225.9 5441.0 5508.3 5508.6 5545.7 5688.5 5408.4 5420.4 5479.2 5596.0 5611.2 21:35:32 INFO - PROCESS | 16548 | 21:35:32 INFO - PROCESS | 16548 | [#4] prototype.html Cycles:180 Average:4854.83 Median:5591.52 stddev:1444.70 (25.8%) stddev-sans-first:1408.15 21:35:32 INFO - PROCESS | 16548 | Values: 323.6 326.7 330.8 334.3 337.3 5536.1 5600.8 5604.4 5621.0 5637.1 5461.3 5479.2 5499.8 5508.1 5521.3 4089.5 4152.3 4248.1 4281.9 4288.2 4272.9 4274.6 4284.3 4287.2 4287.8 4243.3 4248.1 4254.9 4262.3 4264.9 4002.2 4185.6 4227.6 4249.8 4276.9 3716.6 3723.6 3724.4 3733.9 3742.1 5257.4 5374.3 5381.9 5383.4 5383.9 4605.0 4780.0 4845.2 4878.8 4896.6 5677.7 5677.9 5682.9 5688.5 5703.3 4053.5 4054.1 4054.8 4055.7 4058.2 5832.9 5886.3 5946.3 5948.9 5979.3 4169.6 4176.2 4177.2 4179.9 4186.3 4199.4 4226.5 4240.4 4241.5 4266.2 4754.9 4804.8 4813.5 4851.6 4898.0 5746.4 5751.8 5753.1 5760.0 5775.2 1445.8 1447.9 1458.5 1461.1 1461.5 901.4 932.9 941.3 947.2 985.7 5521.4 5534.1 5539.6 5569.8 5596.8 5749.7 5797.9 5836.0 5925.3 5953.7 5358.6 5467.5 5531.3 5550.5 5586.3 3105.3 3120.3 3132.4 3134.3 3145.9 5886.9 6120.8 6120.8 6136.2 6141.2 6027.8 6031.1 6051.9 6089.6 6091.3 6141.2 6145.3 6160.5 6193.8 6202.0 5662.9 5939.4 5974.5 5984.3 5995.0 5874.7 5908.9 5930.4 5941.5 5947.2 5897.2 6102.5 6192.9 6202.3 6213.8 4315.8 4350.6 4362.1 4371.5 4381.5 5899.9 5977.6 5981.9 5988.9 5998.8 5623.2 5770.5 5774.2 5803.4 5864.2 5737.6 5796.3 5812.8 5814.3 5816.8 5583.2 5786.5 5788.6 5794.3 5808.9 5816.2 5818.3 5823.8 5833.2 5857.5 5675.0 5694.8 5695.0 5749.2 5752.2 21:35:32 INFO - PROCESS | 16548 | 21:35:32 INFO - PROCESS | 16548 | [#5] yui.html Cycles:180 Average:20187.16 Median:3989.71 stddev:28057.36 (703.2%) stddev-sans-first:28098.05 21:35:32 INFO - PROCESS | 16548 | Values: 736.9 771.6 772.4 794.8 834.7 15212.3 16273.0 16334.5 16346.9 16396.3 14719.6 14889.6 14931.5 14936.9 14963.5 635.9 761.9 772.8 779.6 785.1 780.5 785.7 786.6 786.6 786.8 826.1 828.6 829.9 832.0 832.0 823.6 824.0 824.7 825.0 825.5 604.5 604.6 604.6 604.7 606.9 14944.6 14961.6 14967.3 14971.4 15023.2 14832.0 15118.5 15310.2 15355.9 15537.4 11644.9 11678.9 11681.4 11735.6 11918.0 3937.5 3988.1 3991.4 4076.9 4107.5 74759.3 75131.6 76308.6 76687.0 76828.6 12007.6 12014.9 12021.8 12088.5 12211.4 22671.8 22691.4 22711.0 22737.3 22773.3 8336.5 8362.1 8641.3 8859.0 8888.9 4732.5 4773.6 4776.3 4874.1 4945.7 3502.1 3598.9 3620.1 3621.9 3623.8 668.8 687.6 700.7 718.2 720.5 628.3 706.3 753.1 771.5 776.0 10234.7 10369.3 10434.4 10447.2 10602.6 713.4 761.3 767.7 770.2 772.2 4947.3 5189.3 5260.1 5260.6 5284.4 70532.3 71390.3 71459.6 71754.3 119917.4 60894.1 74522.6 83242.2 106887.5 111589.0 58814.0 94968.5 101470.0 102219.5 102924.5 9763.2 9830.9 10077.4 10143.1 10181.3 54677.0 55921.2 56513.2 56639.0 58378.4 73492.6 80455.0 85376.0 86948.1 88826.6 11576.5 11730.6 11779.8 11847.9 11908.0 13978.9 13985.4 14161.2 14396.6 14945.6 13162.3 13230.1 13303.9 13812.4 14213.4 12555.2 12639.2 12762.6 12829.3 12911.4 12324.2 12460.1 12663.3 13094.1 13111.3 11630.4 11680.8 12074.2 12387.1 12436.9 11968.7 12593.5 12641.4 12813.7 12867.9 21:35:32 INFO - PROCESS | 16548 | -------- Summary: end -------- 21:35:32 INFO - PROCESS | 16548 | 21:35:32 INFO - TEST-INFO | 16548: exit 0 21:35:32 INFO - TEST-OK | dromaeo_css | took 1111163ms 21:35:32 INFO - TEST-START | kraken 21:35:32 INFO - operating with platform_type : linux_ 21:35:32 INFO - Initialising browser for kraken test... 21:35:32 INFO - TEST-INFO | started process 16790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqWurfH/profile http://localhost:34151/getInfo.html) 21:35:37 INFO - PROCESS | 16790 | __metrics Screen width/height:1600/1200 21:35:37 INFO - PROCESS | 16790 | colorDepth:24 21:35:37 INFO - PROCESS | 16790 | Browser inner width/height: 1024/697 21:35:37 INFO - PROCESS | 16790 | __metrics 21:35:37 ERROR - PROCESS | 16790 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 21:35:38 INFO - TEST-INFO | 16790: exit 0 21:35:38 INFO - Browser initialized. 21:35:38 INFO - Running cycle 1/1 for kraken test... 21:35:38 INFO - TEST-INFO | started process 16910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqWurfH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:35:50 INFO - PROCESS | 16910 | RSS: Main: 163020800 21:35:50 INFO - PROCESS | 16910 | 21:35:52 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34151/tests/kraken/driver.html?testName=audio-beat-detection) 21:35:53 INFO - PROCESS | 16910 | RSS: Main: 168693760 21:35:53 INFO - PROCESS | 16910 | 21:35:56 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34151/tests/kraken/driver.html?testName=audio-dft) 21:35:57 INFO - PROCESS | 16910 | RSS: Main: 167227392 21:35:57 INFO - PROCESS | 16910 | 21:36:00 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34151/tests/kraken/driver.html?testName=audio-fft) 21:36:00 INFO - PROCESS | 16910 | RSS: Main: 163020800 21:36:00 INFO - PROCESS | 16910 | 21:36:02 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34151/tests/kraken/driver.html?testName=audio-oscillator) 21:36:03 INFO - PROCESS | 16910 | RSS: Main: 164651008 21:36:03 INFO - PROCESS | 16910 | 21:36:05 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34151/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:36:06 INFO - PROCESS | 16910 | RSS: Main: 165220352 21:36:06 INFO - PROCESS | 16910 | 21:36:09 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34151/tests/kraken/driver.html?testName=imaging-darkroom) 21:36:09 INFO - PROCESS | 16910 | RSS: Main: 165523456 21:36:09 INFO - PROCESS | 16910 | 21:36:13 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34151/tests/kraken/driver.html?testName=imaging-desaturate) 21:36:14 INFO - PROCESS | 16910 | RSS: Main: 165892096 21:36:14 INFO - PROCESS | 16910 | 21:36:16 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34151/tests/kraken/driver.html?testName=json-parse-financial) 21:36:17 INFO - PROCESS | 16910 | RSS: Main: 166092800 21:36:17 INFO - PROCESS | 16910 | 21:36:19 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34151/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:36:19 INFO - PROCESS | 16910 | RSS: Main: 165855232 21:36:19 INFO - PROCESS | 16910 | 21:36:21 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:36:22 INFO - PROCESS | 16910 | RSS: Main: 165486592 21:36:22 INFO - PROCESS | 16910 | 21:36:24 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:36:24 INFO - PROCESS | 16910 | RSS: Main: 166236160 21:36:24 INFO - PROCESS | 16910 | 21:36:27 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:36:28 INFO - PROCESS | 16910 | RSS: Main: 166371328 21:36:28 INFO - PROCESS | 16910 | 21:36:30 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:36:31 INFO - PROCESS | 16910 | RSS: Main: 166047744 21:36:31 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | Cycle 1(1): loaded http://localhost:34151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34151/tests/kraken/driver.html?testName=ai-astar) 21:36:33 INFO - PROCESS | 16910 | RSS: Main: 167284736 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | __start_tp_report 21:36:33 INFO - PROCESS | 16910 | _x_x_mozilla_page_load 21:36:33 INFO - PROCESS | 16910 | _x_x_mozilla_page_load_details 21:36:33 INFO - PROCESS | 16910 | |i|pagename|runs| 21:36:33 INFO - PROCESS | 16910 | |0;ai-astar;102;112;106;112;114;112;115;113;110;110 21:36:33 INFO - PROCESS | 16910 | |1;audio-beat-detection;151;119;144;185;123;159;156;119;186;119 21:36:33 INFO - PROCESS | 16910 | |2;audio-dft;163;162;164;163;162;164;176;164;162;164 21:36:33 INFO - PROCESS | 16910 | |3;audio-fft;74;76;75;175;76;75;81;76;178;75 21:36:33 INFO - PROCESS | 16910 | |4;audio-oscillator;84;86;152;85;84;84;136;84;84;146 21:36:33 INFO - PROCESS | 16910 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;118;117;118 21:36:33 INFO - PROCESS | 16910 | |6;imaging-darkroom;148;148;147;147;148;147;147;148;147;147 21:36:33 INFO - PROCESS | 16910 | |7;imaging-desaturate;96;98;95;96;96;96;96;96;95;96 21:36:33 INFO - PROCESS | 16910 | |8;json-parse-financial;55;57;54;54;54;55;61;53;55;54 21:36:33 INFO - PROCESS | 16910 | |9;json-stringify-tinderbox;63;64;64;63;66;64;63;65;64;65 21:36:33 INFO - PROCESS | 16910 | |10;stanford-crypto-aes;79;76;77;75;82;76;77;80;80;76 21:36:33 INFO - PROCESS | 16910 | |11;stanford-crypto-ccm;125;123;140;131;121;131;128;121;166;136 21:36:33 INFO - PROCESS | 16910 | |12;stanford-crypto-pbkdf2;165;164;161;158;166;160;159;158;158;159 21:36:33 INFO - PROCESS | 16910 | |13;stanford-crypto-sha256-iterative;64;66;65;65;66;66;66;70;66;64 21:36:33 INFO - PROCESS | 16910 | __end_tp_report 21:36:33 INFO - PROCESS | 16910 | __start_cc_report 21:36:33 INFO - PROCESS | 16910 | _x_x_mozilla_cycle_collect,854 21:36:33 INFO - PROCESS | 16910 | __end_cc_report 21:36:33 INFO - PROCESS | 16910 | __startTimestamp1469939793295__endTimestamp 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | ------- Summary: start ------- 21:36:33 INFO - PROCESS | 16910 | Number of tests: 14 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.92 (3.5%) stddev-sans-first:2.65 21:36:33 INFO - PROCESS | 16910 | Values: 102.0 112.0 106.0 112.0 114.0 112.0 115.0 113.0 110.0 110.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:153.50 stddev:26.11 (17.0%) stddev-sans-first:27.63 21:36:33 INFO - PROCESS | 16910 | Values: 151.0 119.0 144.0 185.0 123.0 159.0 156.0 119.0 186.0 119.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:4.17 (2.5%) stddev-sans-first:4.39 21:36:33 INFO - PROCESS | 16910 | Values: 163.0 162.0 164.0 163.0 162.0 164.0 176.0 164.0 162.0 164.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#3] audio-fft Cycles:10 Average:96.10 Median:75.50 stddev:42.42 (56.2%) stddev-sans-first:44.24 21:36:33 INFO - PROCESS | 16910 | Values: 74.0 76.0 75.0 175.0 76.0 75.0 81.0 76.0 178.0 75.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.00 stddev:29.35 (34.9%) stddev-sans-first:30.36 21:36:33 INFO - PROCESS | 16910 | Values: 84.0 86.0 152.0 85.0 84.0 84.0 136.0 84.0 84.0 146.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:36:33 INFO - PROCESS | 16910 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 21:36:33 INFO - PROCESS | 16910 | Values: 148.0 148.0 147.0 147.0 148.0 147.0 147.0 148.0 147.0 147.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 21:36:33 INFO - PROCESS | 16910 | Values: 96.0 98.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:2.30 (4.2%) stddev-sans-first:2.44 21:36:33 INFO - PROCESS | 16910 | Values: 55.0 57.0 54.0 54.0 54.0 55.0 61.0 53.0 55.0 54.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:0.97 21:36:33 INFO - PROCESS | 16910 | Values: 63.0 64.0 64.0 63.0 66.0 64.0 63.0 65.0 64.0 65.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:78.00 stddev:2.30 (2.9%) stddev-sans-first:2.40 21:36:33 INFO - PROCESS | 16910 | Values: 79.0 76.0 77.0 75.0 82.0 76.0 77.0 80.0 80.0 76.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:131.00 stddev:13.44 (10.3%) stddev-sans-first:14.00 21:36:33 INFO - PROCESS | 16910 | Values: 125.0 123.0 140.0 131.0 121.0 131.0 128.0 121.0 166.0 136.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:160.50 stddev:3.08 (1.9%) stddev-sans-first:2.87 21:36:33 INFO - PROCESS | 16910 | Values: 165.0 164.0 161.0 158.0 166.0 160.0 159.0 158.0 158.0 159.0 21:36:33 INFO - PROCESS | 16910 | 21:36:33 INFO - PROCESS | 16910 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.69 (2.6%) stddev-sans-first:1.66 21:36:33 INFO - PROCESS | 16910 | Values: 64.0 66.0 65.0 65.0 66.0 66.0 66.0 70.0 66.0 64.0 21:36:33 INFO - PROCESS | 16910 | -------- Summary: end -------- 21:36:33 INFO - PROCESS | 16910 | 21:36:34 INFO - TEST-INFO | 16910: exit 0 21:36:34 INFO - TEST-OK | kraken | took 61511ms 21:36:34 INFO - SUITE-END | took 1172s 21:36:34 INFO - Completed test suite (00:19:32) 21:36:34 INFO - javascript benchmark 21:36:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7370.066908391514, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3041.452538543062, 3058.311879827038, 3083.984580077099, 3089.11960091374, 3094.706002929722, 5311.495407936245, 5323.520883120518, 5355.08963476209, 5380.704061276629, 5396.055690254205, 5336.252924590561, 5363.383210930744, 5380.757865896035, 5398.78404863805, 5436.673799572019, 4795.832145874886, 4907.2148456247005, 4917.237828136645, 4975.9004819903585, 5082.822101226458, 5040.16837221858, 5070.391553013644, 5078.542931136197, 5107.46371630979, 5111.105556527611, 4785.617150627959, 4840.201366774478, 4888.9755551222015, 4950.0, 4952.603791696673, 4932.728699921503, 4941.579965702919, 4951.950480495221, 4975.104481193383, 4994.101061808873, 4873.049755297719, 4887.218045112765, 4896.387951506062, 4929.975350123263, 4953.43035550909, 5146.228065790124, 5300.337457817773, 5384.138537833967, 5387.515123638852, 5451.700156491392, 5793.188953546507, 5795.536357091422, 5797.797077102324, 5825.359210486843, 5830.679312637803, 5760.596758226926, 5780.393058728815, 5782.624129431616, 5795.594308398414, 5810.1865738796605, 5240.764165612519, 5352.839414817523, 5352.91970620441, 5387.892242155174, 5435.402105768362, 5970.671613061323, 5974.761009559656, 5980.13288073227, 5995.640261584319, 6018.247719035121, 5681.375048744635, 5698.088305871041, 5699.173619825102, 5714.257146570919, 5722.685252311079, 5521.1442226454965, 5574.693391863487, 5612.494875461228, 5745.798897038583, 5798.304203495523, 5544.251526044013, 5562.916556251659, 5612.410696876851, 5651.717414129277, 5706.28671416073, 5700.686462244534, 5724.971375143181, 5764.481196692318, 5775.364709881909, 5824.854378640568, 4442.577955094261, 4448.2839551176585, 4455.977720111378, 4460.687751857404, 4487.326900964881, 3853.903652408656, 3874.12832112778, 3898.90252743678, 3907.5701672815967, 4005.619466150711, 5504.669719816824, 5564.1931919871395, 5567.832965011056, 5594.636348637407, 5617.325920889438, 5794.710264486759, 5807.593468457168, 5840.094785308284, 5840.8247752567495, 5860.033094539439, 5342.0, 5447.618666693373, 5500.697461639648, 5541.612087153861, 5563.721813909288, 4874.171390863562, 4885.267209918541, 4888.780004899788, 4913.778879950411, 4928.236123400879, 5966.254218222723, 6028.216331876915, 6037.9396206038255, 6052.182955301066, 6053.061775424816, 5653.321601407857, 5707.429257074259, 5749.051406518045, 5763.221965034667, 5793.507551858139, 5987.970060149672, 5989.910151347821, 6012.549058820518, 6034.818955431344, 6044.0, 5671.432856714296, 5691.914621280601, 5713.285839270091, 5729.026065568946, 5750.9424905752085, 5618.297712785902, 5686.9715651421475, 5691.231683722644, 5786.739596718242, 5850.063989761617, 5633.38032816398, 5636.154576813511, 5640.32316122068, 5680.091185410314, 5685.914711279417, 5594.1049432092295, 5643.887122257614, 5656.43435656431, 5657.236273103243, 5659.688717120598, 5496.367917689517, 5601.327840659147, 5631.549476041825, 5653.152027195953, 5660.349059858169, 5661.348944871393, 5685.829425117253, 5688.146777983336, 5726.828195154152, 5758.078707406795, 5480.177973304037, 5527.336719593674, 5540.36285827135, 5543.445655434424, 5545.7781688732], "value": 5323.361778817769, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.1729815473947, 579.2383016333519, 592.5822295281826, 607.4623957797348, 609.6951524237884, 42498.36252456216, 43608.0, 43689.34465983009, 43831.78084109575, 48090.51909480904, 45034.54965450353, 45228.773856130756, 45520.54479455204, 45651.31523027149, 45664.31503527441, 8984.8652270216, 9099.0, 9121.635134594608, 9124.863127053099, 9136.406133601327, 8956.776080597972, 9020.458772473672, 9022.86465703015, 9032.819343613124, 9035.141661542142, 9042.050584688612, 9104.544772761335, 9108.134727200906, 9117.133872282122, 9135.634574617008, 9023.729288121334, 9036.63853445868, 9047.773805654846, 9061.411008284473, 9119.088091190893, 8878.422902511316, 8964.462132272085, 8970.686025989124, 8986.730398088068, 9001.684941027099, 43253.56746432527, 43310.78344608288, 43373.56626433758, 43542.0, 43556.34665479988, 3521.9471707924404, 3602.873899413534, 4191.413202151702, 4287.292596721537, 4369.6285815705705, 34058.31883362344, 34726.0, 34782.65217347819, 34958.47562286568, 34965.82517087424, 3890.824912878927, 4187.392828039917, 4348.391225228471, 4378.321360189176, 4477.037436951038, 282248.0, 374895.0, 376265.0, 376271.0, 377838.0, 61821.0, 62880.0, 62989.37010629927, 63067.36932630707, 63070.68464657739, 35605.64394356023, 35773.28453430917, 35998.28003439916, 37786.898768666426, 65526.67236663786, 13345.0, 13361.198328100345, 13437.731245375038, 13446.462141514425, 13473.932630336982, 10389.84415233772, 10451.68644940653, 10475.685729428129, 10482.842757358645, 10504.002119798606, 19346.175079452663, 19373.32193373225, 19472.70790938137, 19480.887492480684, 19579.412617621496, 6849.657517124124, 7379.81550461232, 7409.110906691124, 7472.9252707473315, 7543.0, 927.893292271384, 1046.210111365914, 1062.4475272858072, 1092.268180319188, 1104.817705078653, 33719.32561348759, 34076.31847363039, 34160.0, 34326.167487094666, 34405.48391774125, 1117.2458590451574, 1154.4500660469091, 1166.1953252256085, 1187.655579881842, 1243.720162963326, 17519.299228030737, 17808.3767068152, 17834.821651783575, 17903.552411189565, 18095.63808723818, 557409.0, 557976.0, 564036.0, 564132.0, 567575.0, 61696.0, 62251.0, 62289.68855155695, 62404.0, 62701.372986270464, 1284.7751643462357, 1297.47452281826, 1324.205476713964, 1334.486222804208, 1339.8995075369387, 32313.676863232005, 33047.33905321928, 33864.22963469429, 34198.14504637404, 34536.0, 53681.0, 56361.39121218583, 56970.145447817486, 57351.0, 61264.69367653133, 545856.0, 548979.0, 549130.0, 549641.0, 554727.0, 45535.089298214516, 45587.54412455833, 45682.771586143186, 46155.07689846252, 46188.7690561545, 49794.751026246086, 50518.0, 50954.74522627363, 52137.47862521326, 52251.0, 42094.36858447064, 42172.789136054125, 42352.0, 42590.361144583476, 44293.11413771771, 42642.78678606587, 42656.360154598326, 42872.0, 44369.33445998377, 44444.55555444404, 43136.0, 43307.783461082494, 43831.34252986144, 44350.778246108566, 44550.3317450245, 37145.0, 38608.42087368636, 38968.6103138965, 39342.40986385149, 39792.60207397889, 29465.85267073651, 29568.112956611338, 29815.0, 30192.5471117929, 30222.395552088394], "value": 20795.680798974427, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.11727031031, 378.8087016056892, 386.2140543992974, 387.3763241181695, 397.94627725257084, 17630.294788208474, 19325.4202373929, 19767.308144214938, 20371.08330125144, 20476.385708428752, 18393.98833064181, 18606.813931860677, 19012.334568290113, 19090.427287181406, 19374.515637109078, 5227.5295223429885, 5732.770689172438, 5876.353601103875, 5903.439173278553, 5927.081302398114, 5842.123681447795, 5858.7949421770245, 5870.236869206997, 5881.764729410818, 5881.764729410818, 5734.283214598176, 5755.769769209227, 5758.798442054529, 5790.073588225885, 5818.06910894257, 5578.135389014709, 5771.0, 5771.884562308751, 5785.074388097884, 5794.333651630074, 5047.3848368522085, 5081.390233172006, 5144.022635699205, 5180.559652429548, 5191.714455704935, 22802.543949120925, 22922.09823756385, 23003.0, 23132.76867231323, 23278.883605582032, 2443.022790883661, 2516.0564788204424, 2991.7008299170125, 3068.9079327620207, 3077.322988942429, 14447.133172009713, 14549.199794011325, 14578.489752858599, 14651.63370915725, 14978.625534361729, 1942.2522328903333, 1999.9900050474562, 2028.6551286281367, 2062.092679221138, 2083.7082808406835, 75369.0, 77234.0, 77258.0, 77963.0, 79092.0, 9976.752905886764, 10239.385636861663, 10342.896571034193, 10452.947735261427, 10828.133749300037, 14610.954466374717, 14661.266936653125, 14728.26358682083, 14745.11529308245, 14753.557393278219, 7122.786316410516, 7358.264173582599, 7364.815879602946, 7566.583837888859, 7626.809329766689, 6832.521723479309, 6853.862922741518, 7032.0, 7082.150141982892, 7103.6093014883645, 6417.593402474072, 6609.173853268341, 6618.073469714244, 6657.667116644148, 6663.867982048429, 1892.2431027589075, 1935.129191863667, 1940.6506828770957, 1952.7851936286997, 1959.2163134746215, 950.9952450237705, 973.1436336024253, 981.7005813227034, 993.4982833669095, 1002.6941782756184, 19442.5139371514, 20095.698564521543, 20175.899120504302, 20328.796712032985, 20421.69367459489, 982.2436723722693, 1006.5822683586376, 1013.5084484025242, 1018.7300365403174, 1044.2116202267391, 11126.666200014013, 11411.426403338764, 11666.591669291534, 11746.941265293619, 11814.291142531476, 439124.0, 440816.0, 442601.0, 480117.0, 497167.0, 45443.0, 59096.0, 64096.35903640904, 75418.62290688622, 77678.0, 984.3404918704629, 1006.7030226083323, 1026.6868605075374, 1027.1166796554958, 1032.2413026425572, 15216.315265813286, 17761.822381776015, 17995.0, 18010.459686209433, 18186.727199091758, 37664.246715066096, 37813.24373512459, 41691.37462937998, 42330.36504452497, 42673.93698942811, 57430.42569574251, 57590.7120464395, 57595.0, 57988.42011579999, 60577.0, 7272.709091636275, 7392.593407362647, 7651.5409075455655, 7819.123410381581, 7847.9607601961625, 12359.073069520002, 13214.471421143047, 13365.799513007118, 13578.93210533941, 13687.794683079961, 10943.890561094606, 11703.473343699383, 11745.119116066158, 11800.17398782077, 12063.095267855122, 11570.363630000431, 11571.710707232387, 11635.0, 11640.476178571815, 11821.940890295493, 11769.0, 11907.52369905194, 11951.521939122686, 12021.338826364285, 12171.208871423329, 7459.403247740276, 7629.809254768676, 7658.410727564, 7699.615019249127, 7972.162922893012, 8910.064443233367, 10906.0, 11473.311601303949, 11770.76458470843, 11788.0], "value": 9189.694092059159, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.7721853112764, 1495.0879963222435, 1569.960750981226, 1694.0682624556491, 1715.7169067103928, 7601.733939312126, 8632.30941524678, 8668.696595619154, 8991.415557988727, 9016.909830901697, 8728.738137855858, 8943.284537237021, 8953.91046089539, 8982.910170898289, 9047.230985366235, 2330.557194133109, 2339.0643742502966, 2363.0783994242174, 2365.420471984366, 2367.538330025646, 2296.494771150344, 2330.755270696578, 2354.6114891042957, 2367.230650038736, 2378.5480758655885, 2305.13557415969, 2305.4121199094207, 2314.93055208344, 2357.7170739511284, 2357.8113750899975, 2300.608896487601, 2303.4586872085047, 2306.907723691067, 2322.593546129429, 2328.5459335429596, 2252.6283163278204, 2264.116994372196, 2270.3529494094105, 2270.5345404192103, 2274.727032756063, 8954.910450895539, 9009.639614415415, 9018.458892466473, 9030.954845225731, 9105.180533751927, 5066.189409694468, 5206.349206349207, 5245.501677340647, 5249.527542521153, 5274.604404669665, 3190.1865024418858, 3201.807891526516, 3341.682540158681, 3344.3144155448076, 3393.6436674149104, 1077.620645573667, 1088.6244245735209, 1101.719061639285, 1103.332483847277, 1112.0380870546999, 12510.874891251062, 12545.0, 12642.55751048709, 12652.68368290791, 12744.044196685285, 4456.309272062836, 4534.161180181677, 4723.385959825269, 4726.716397016121, 4765.904681906342, 10573.894261057445, 10580.100691441314, 10585.523651435704, 10596.841047384296, 10619.256652034437, 5351.3043304370185, 5373.811916582901, 5388.91916621251, 5389.973050134724, 5398.406175320712, 4308.978455107705, 4708.364370809897, 4833.202521583969, 4851.95148048515, 4923.163062279421, 3756.417755247941, 3866.8839934802, 3880.767153970771, 3929.8035098245546, 3967.5238971323047, 1228.8402507673945, 1230.4401497318877, 1232.4700378837185, 1241.937903104841, 1247.476060054761, 1035.166690813902, 1035.6168217759478, 1046.6755305855208, 1052.58422922945, 1061.7080302916606, 6135.558143836195, 6214.689265536705, 6330.177076979963, 6401.07184458251, 6421.036844473367, 934.5514153206499, 951.2152474208806, 971.7667759737753, 985.2413641496008, 999.1207737191226, 4255.340422234559, 4462.754548499864, 4473.060657261946, 4519.480259770103, 4581.473130589959, 10959.232853700323, 11272.154588405903, 11337.093032557375, 11361.261518001304, 11377.37424441647, 10959.3424394535, 10978.505967231495, 11219.102471802236, 11236.719082023015, 11247.437628118561, 8298.419110662317, 8372.246497815104, 8401.70594029206, 8409.159084091541, 8498.23515883561, 6195.16365290698, 6220.688965551613, 6294.464970477561, 6381.266154392304, 6394.584352017104, 10091.495425228855, 10097.646582369582, 10125.848112278174, 10136.543855526372, 10151.492425378849, 10371.014753598396, 10402.0, 10506.94746526293, 10512.894871051498, 10559.419231942316, 6512.446442052478, 7182.856342873218, 7271.963640181765, 7281.0, 7458.552486850589, 8719.869201961848, 8747.431416957877, 8825.867611985697, 8840.425372350777, 8870.15733505316, 7710.961445192738, 7875.369970402239, 7890.605469726376, 7942.6028698566, 8005.599720014093, 7685.884711729217, 7706.653200605874, 7759.7672069838, 7835.451518393657, 7861.60691965388, 7067.82330441743, 7109.324614161646, 7175.282471752783, 7224.927750722425, 7225.855482890418, 5440.972795135999, 5508.3114610673665, 5508.641938274, 5545.722713864371, 5688.516476099578, 5408.3509978802795, 5420.403755586961, 5479.17812328138, 5596.020696378199, 5611.158326251095], "value": 4716.115281579585, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.5712680698075, 326.7304473809107, 330.82135646750754, 334.32966901362767, 337.276541817801, 5536.141898005811, 5600.803971860985, 5604.41153678864, 5620.971895140528, 5637.0698834692275, 5461.290032295796, 5479.17812328151, 5499.752511136999, 5508.14623733321, 5521.337439507255, 4089.50925888893, 4152.252594532983, 4248.065425606362, 4281.935770963438, 4288.249556327646, 4272.910407845995, 4274.5893855027925, 4284.335927931175, 4287.162989124731, 4287.799416163463, 4243.342281946288, 4248.107897341547, 4254.851080212193, 4262.318029115342, 4264.8507302244425, 4002.1595464952247, 4185.644220241283, 4227.556106608792, 4249.830006799724, 4276.87169384919, 3716.628337166289, 3723.646253605903, 3724.404095344732, 3733.869314574004, 3742.120601658608, 5257.369115706139, 5374.328208973879, 5381.865453363658, 5383.407825139231, 5383.865403364947, 4605.0, 4779.952200477986, 4845.248986407078, 4878.804847806084, 4896.583790377822, 5677.700531284836, 5677.914831277534, 5682.857928551778, 5688.544916406678, 5703.3441154267375, 4053.4730485037053, 4054.1080962188566, 4054.776987265699, 4055.6958228133008, 4058.208649313385, 5832.854178645568, 5886.264216972879, 5946.345901950782, 5948.940510594882, 5979.252593425822, 4169.624733773975, 4176.206520761046, 4177.164567086595, 4179.874603761892, 4186.309258972296, 4199.370094485852, 4226.4716910386205, 4240.38514415408, 4241.533431322552, 4266.168097221012, 4754.904901902012, 4804.759762011886, 4813.542713442217, 4851.611871050308, 4897.9714260005085, 5746.396628353963, 5751.827445176651, 5753.108268218432, 5759.976012593338, 5775.162601422854, 1445.775904734768, 1447.905886117399, 1458.4603696632314, 1461.0705535401664, 1461.4519555166812, 901.4230892228978, 932.8600709893434, 941.2846236859899, 947.2090804178588, 985.6939555089535, 5521.365043020104, 5534.118399744107, 5539.612227144061, 5569.805056822992, 5596.776128954796, 5749.68376739275, 5797.927383434078, 5835.9708201458725, 5925.259342582177, 5953.732082056318, 5358.5981051421295, 5467.4532546745, 5531.257653839109, 5550.528205102531, 5586.273784408001, 3105.2547388626567, 3120.329129237225, 3132.3688101994435, 3134.341788224453, 3145.88989385375, 5886.8822623547285, 6120.755169793248, 6120.755169793248, 6136.202293701879, 6141.232345956755, 6027.78902738402, 6031.095335699592, 6051.909221361683, 6089.604175728564, 6091.329953705089, 6141.170941922784, 6145.293291271561, 6160.537959653044, 6193.783217587453, 6201.96899015502, 5662.886742265049, 5939.406059394026, 5974.522038236843, 5984.251968503937, 5994.970025149846, 5874.676892770768, 5908.852278693067, 5930.406959304035, 5941.465268125889, 5947.226860508279, 5897.233359663216, 6102.497975829889, 6192.938070619236, 6202.2867370253, 6213.782517611862, 4315.8489452869, 4350.564943505624, 4362.105768317424, 4371.497277813092, 4381.474223093249, 5899.852503687443, 5977.6114552553945, 5981.850453738692, 5988.910166347596, 5998.770252098397, 5623.156526520891, 5770.5095066919785, 5774.162746401832, 5803.3616302207565, 5864.179014937998, 5737.627054241461, 5796.275465566804, 5812.82561523155, 5814.30228372581, 5816.82549523515, 5583.2462617547735, 5786.450287222707, 5788.594798364074, 5794.304683438015, 5808.94191058084, 5816.248519704851, 5818.301803783573, 5823.796167134299, 5833.154192641959, 5857.531397488276, 5674.971625141848, 5694.800681976111, 5694.971525142348, 5749.195112684144, 5752.165935939349], "value": 4386.6534041823425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.8894665800129, 771.5679219637, 772.4438404348869, 794.8489786940481, 834.7495751274618, 15212.315445804938, 16273.0, 16334.509964701077, 16346.91826540867, 16396.344146234165, 14719.632009199775, 14889.55331340059, 14931.477398291063, 14936.850631493682, 14963.476278330261, 635.8537536366639, 761.9390448764113, 772.7990722412158, 779.6452614060589, 785.140271402813, 780.5472825761045, 785.6582386661792, 786.6302837666316, 786.6499407763547, 786.7600381883523, 826.0954255090666, 828.6022709099636, 829.9419040667126, 831.9974430810888, 832.0223737108903, 823.6417158536026, 824.0, 824.7278398128603, 824.9628766705482, 825.5005721538442, 604.5284677951205, 604.6130476495002, 604.6462819250744, 604.6885853785304, 606.8664893723374, 14944.551663450005, 14961.57865002823, 14967.326470308863, 14971.401143954228, 15023.173725445096, 14832.0, 15118.546443606709, 15310.157941313224, 15355.923220383938, 15537.378504859793, 11644.941775291069, 11678.88321116795, 11681.415929203591, 11735.647930562096, 11918.0, 3937.5471820740695, 3988.062805240766, 3991.3613821788376, 4076.8980775480554, 4107.507099148092, 74759.25240747577, 75131.62434187849, 76308.61845690737, 76687.0, 76828.61585692035, 12007.639770806889, 12014.939925300492, 12021.847080358863, 12088.516459341703, 12211.412516372815, 22671.773282266968, 22691.43271418195, 22710.97800598977, 22737.31788046361, 22773.31680049601, 8336.458130221516, 8362.080171181165, 8641.308695304486, 8858.955705221433, 8888.866667, 4732.479427262998, 4773.64197685175, 4776.307435421844, 4874.122657921537, 4945.727984960789, 3502.124468882779, 3598.9280214395567, 3620.094976255936, 3621.909452263662, 3623.8188090595363, 668.7960172147444, 687.5702685821361, 700.6916956539106, 718.1740997852511, 720.4920531025614, 628.2837565175703, 706.2549010793559, 753.0511555440075, 771.5447885747436, 775.9650815713306, 10234.692959211236, 10369.274150809371, 10434.38290048269, 10447.216458765472, 10602.628907988183, 713.4470785141557, 761.3338328962158, 767.6737386610669, 770.1566784371105, 772.2432016623741, 4947.282644016597, 5189.273501709764, 5260.105782017066, 5260.579153667774, 5284.39229488606, 70532.29467705257, 71390.2860971394, 71459.64270178616, 71754.28245717476, 119917.40041299738, 60894.086588701204, 74522.62738686272, 83242.16757832344, 106887.46556267324, 111589.0, 58814.0, 94968.52515737516, 101470.0, 102219.48890255501, 102924.48537757264, 9763.170130538983, 9830.901690982999, 10077.395356278646, 10143.137833284254, 10181.33821301613, 54677.0, 55921.161182583106, 56513.15230271467, 56639.0, 58378.416215838995, 73492.63253683697, 80455.0, 85376.0, 86948.130518694, 88826.55586722025, 11576.479058442223, 11730.648080557597, 11779.764404712028, 11847.940760296144, 11908.0, 13978.860211398163, 13985.44058237659, 14161.221132837793, 14396.568102956928, 14945.551633451014, 13162.276074815976, 13230.140040897311, 13303.933480332924, 13812.447502099803, 14213.360398781873, 12555.183913045623, 12639.241645501299, 12762.61712148637, 12829.294388808705, 12911.418986145458, 12324.198927069712, 12460.127791054902, 12663.303518306213, 13094.083414160918, 13111.344432778515, 11630.360330181922, 11680.76638467209, 12074.215176013531, 12387.07096967749, 12436.937815310866, 11968.67007036321, 12593.521773406013, 12641.431135598736, 12813.743725125632, 12867.935660321638], "value": 7613.886281231456, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 106.0, 112.0, 114.0, 112.0, 115.0, 113.0, 110.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 119.0, 144.0, 185.0, 123.0, 159.0, 156.0, 119.0, 186.0, 119.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 163.0, 162.0, 164.0, 176.0, 164.0, 162.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 175.0, 76.0, 75.0, 81.0, 76.0, 178.0, 75.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 152.0, 85.0, 84.0, 84.0, 136.0, 84.0, 84.0, 146.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 54.0, 54.0, 54.0, 55.0, 61.0, 53.0, 55.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 66.0, 64.0, 63.0, 65.0, 64.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 77.0, 75.0, 82.0, 76.0, 77.0, 80.0, 80.0, 76.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 140.0, 131.0, 121.0, 131.0, 128.0, 121.0, 166.0, 136.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 161.0, 158.0, 166.0, 160.0, 159.0, 158.0, 158.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 70.0, 66.0, 64.0], "value": 65.8, "unit": "score"}]}]} 21:36:34 INFO - Return code: 0 21:36:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:36:34 ERROR - # TBPL SUCCESS # 21:36:34 INFO - Running post-action listener: _resource_record_post_action 21:36:34 INFO - [mozharness: 2016-07-31 04:36:34.617987Z] Finished run-tests step (success) 21:36:34 INFO - Running post-run listener: _resource_record_post_run 21:36:34 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540958720; Read time: 16; Write time: 464856 21:36:34 INFO - TinderboxPrint: CPU usage
13.3% 21:36:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:36:34 INFO - TinderboxPrint: I/O write bytes / time
540,958,720 / 464,856 21:36:34 INFO - TinderboxPrint: CPU idle
8,231.3 (86.7%) 21:36:34 INFO - TinderboxPrint: CPU user
1,205.5 (12.7%) 21:36:34 INFO - TinderboxPrint: Swap in / out
0 / 0 21:36:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247623680; Read time: 0; Write time: 263792 21:36:34 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 292970496; Read time: 0; Write time: 201008 21:36:35 INFO - Running post-run listener: _upload_blobber_files 21:36:35 INFO - Blob upload gear active. 21:36:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:36: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 21:36: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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:36: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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:36:35 INFO - (blobuploader) - INFO - Open directory for files ... 21:36:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:36:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:40 INFO - (blobuploader) - INFO - Done attempting. 21:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:40 INFO - (blobuploader) - INFO - Done attempting. 21:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:41 INFO - (blobuploader) - INFO - Done attempting. 21:36:41 INFO - (blobuploader) - INFO - Iteration through files over. 21:36:41 INFO - Return code: 0 21:36:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:36:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:36:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f12b7527d0c79a3a01aa8fa8c05635ae09b9645fcfe30809120255c5c8ed6b3537ea6afc312683b0e09451cd07cb29f458e939ce952c3a8da28bcee8fb78136c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1860bdd2ea6954d388ed0b708022c7a66698048efbf95fb24e8c0a9451707d60096eb046825137343d4c907658a0bc889475433bda7dd7d5e1f93bb273da2a35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22b6cd65f3d77976cfe525c16d6348aecdb1ba66b581bf2211f3f044b9b90fbee2576627bc83a598320513361c0f065af31fa2023807d85d36c0104e97442b02"} 21:36:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:36:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:36:41 INFO - Contents: 21:36:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f12b7527d0c79a3a01aa8fa8c05635ae09b9645fcfe30809120255c5c8ed6b3537ea6afc312683b0e09451cd07cb29f458e939ce952c3a8da28bcee8fb78136c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1860bdd2ea6954d388ed0b708022c7a66698048efbf95fb24e8c0a9451707d60096eb046825137343d4c907658a0bc889475433bda7dd7d5e1f93bb273da2a35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22b6cd65f3d77976cfe525c16d6348aecdb1ba66b581bf2211f3f044b9b90fbee2576627bc83a598320513361c0f065af31fa2023807d85d36c0104e97442b02"} 21:36:41 INFO - Running post-run listener: copy_logs_to_upload_dir 21:36:41 INFO - Copying logs to upload dir... 21:36:41 INFO - mkdir: /builds/slave/test/build/upload/logs 21:36:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.367811 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-30 21:36:40.108259) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 21:36:40.111755) ========= 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=232498196343f89f466a4a9a000001c8-1469934319.965841-738445851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f12b7527d0c79a3a01aa8fa8c05635ae09b9645fcfe30809120255c5c8ed6b3537ea6afc312683b0e09451cd07cb29f458e939ce952c3a8da28bcee8fb78136c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1860bdd2ea6954d388ed0b708022c7a66698048efbf95fb24e8c0a9451707d60096eb046825137343d4c907658a0bc889475433bda7dd7d5e1f93bb273da2a35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22b6cd65f3d77976cfe525c16d6348aecdb1ba66b581bf2211f3f044b9b90fbee2576627bc83a598320513361c0f065af31fa2023807d85d36c0104e97442b02"} build_url:https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/NBR_0zPUStW62YCBUyWDfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f12b7527d0c79a3a01aa8fa8c05635ae09b9645fcfe30809120255c5c8ed6b3537ea6afc312683b0e09451cd07cb29f458e939ce952c3a8da28bcee8fb78136c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1860bdd2ea6954d388ed0b708022c7a66698048efbf95fb24e8c0a9451707d60096eb046825137343d4c907658a0bc889475433bda7dd7d5e1f93bb273da2a35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22b6cd65f3d77976cfe525c16d6348aecdb1ba66b581bf2211f3f044b9b90fbee2576627bc83a598320513361c0f065af31fa2023807d85d36c0104e97442b02"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 21:36:40.137770) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 21:36:40.138096) ========= 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=232498196343f89f466a4a9a000001c8-1469934319.965841-738445851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 21:36:40.222173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 21:36:40.222500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 21:36:40.222797) ========= ========= Total master_lag: 0.20 =========