builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1469725491.32 results: success (0) buildid: 20160728083025 builduid: 694b256057a24bbca4631e115bb66af2 revision: 75f7f076c3a84c8095b81ecfb208e82c5d74db32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:51.318987) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:51.319522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:51.320885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:51.678002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:51.678408) ========= 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=745a4373a2a16df560f216e000000264-1469725488.70771-205285961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 10:04:51-- 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% 48.9M=0s 2016-07-28 10:04:51 (48.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099724 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:51.792835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:51.793172) ========= 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=745a4373a2a16df560f216e000000264-1469725488.70771-205285961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015427 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:51.843459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:51.843863) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 75f7f076c3a84c8095b81ecfb208e82c5d74db32 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 75f7f076c3a84c8095b81ecfb208e82c5d74db32 --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=745a4373a2a16df560f216e000000264-1469725488.70771-205285961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 10:04:51,925 truncating revision to first 12 chars 2016-07-28 10:04:51,926 Setting DEBUG logging. 2016-07-28 10:04:51,926 attempt 1/10 2016-07-28 10:04:51,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/75f7f076c3a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 10:04:52,454 unpacking tar archive at: fx-team-75f7f076c3a8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.878764 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:52.792442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:52.792777) ========= script_repo_revision: 75f7f076c3a84c8095b81ecfb208e82c5d74db32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:52.793192) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:52.793489) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 10:04:52.803806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-28 10:04:52.804209) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1469725488.70771-205285961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:52 INFO - MultiFileLogger online at 20160728 10:04:52 in /builds/slave/test 10:04:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:04:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:52 INFO - {'append_to_log': False, 10:04:52 INFO - 'base_work_dir': '/builds/slave/test', 10:04:52 INFO - 'blob_upload_branch': 'Fx-Team', 10:04:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:52 INFO - 'branch': 'Fx-Team', 10:04:52 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:52 INFO - 'config_files': ('talos/linux_config.py',), 10:04:52 INFO - 'default_actions': ('clobber', 10:04:52 INFO - 'read-buildbot-config', 10:04:52 INFO - 'download-and-extract', 10:04:52 INFO - 'populate-webroot', 10:04:52 INFO - 'create-virtualenv', 10:04:52 INFO - 'install', 10:04:52 INFO - 'run-tests'), 10:04:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:52 INFO - 'download_minidump_stackwalk': True, 10:04:52 INFO - 'download_symbols': 'ondemand', 10:04:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:52 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:52 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:52 INFO - 'installer_path': 'installer.exe', 10:04:52 INFO - 'log_level': 'info', 10:04:52 INFO - 'log_name': 'talos', 10:04:52 INFO - 'log_to_console': True, 10:04:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:52 INFO - 'opt_config_files': (), 10:04:52 INFO - 'pip_index': False, 10:04:52 INFO - 'sps_profile': False, 10:04:52 INFO - 'sps_profile_interval': 0, 10:04:52 INFO - 'suite': 'dromaeojs', 10:04:52 INFO - 'system_bits': '32', 10:04:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:52 INFO - 'title': 'talos-linux64-ix-032', 10:04:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:52 INFO - 'use_talos_json': True, 10:04:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:52 INFO - 'work_dir': 'build'} 10:04:52 INFO - [mozharness: 2016-07-28 17:04:52.922557Z] Running clobber step. 10:04:52 INFO - Running pre-action listener: _resource_record_pre_action 10:04:52 INFO - Running main action method: clobber 10:04:52 INFO - rmtree: /builds/slave/test/build 10:04:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:53 INFO - Running post-action listener: _resource_record_post_action 10:04:53 INFO - [mozharness: 2016-07-28 17:04:53.410153Z] Finished clobber step (success) 10:04:53 INFO - [mozharness: 2016-07-28 17:04:53.410254Z] Running read-buildbot-config step. 10:04:53 INFO - Running pre-action listener: _resource_record_pre_action 10:04:53 INFO - Running main action method: read_buildbot_config 10:04:53 INFO - Using buildbot properties: 10:04:53 INFO - { 10:04:53 INFO - "project": "", 10:04:53 INFO - "product": "firefox", 10:04:53 INFO - "script_repo_revision": "production", 10:04:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:04:53 INFO - "repository": "", 10:04:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:04:53 INFO - "buildid": "20160728083025", 10:04:53 INFO - "pgo_build": "True", 10:04:53 INFO - "basedir": "/builds/slave/test", 10:04:53 INFO - "buildnumber": 1379, 10:04:53 INFO - "slavename": "talos-linux64-ix-032", 10:04:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:04:53 INFO - "platform": "ubuntu64_hw", 10:04:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:04:53 INFO - "branch": "fx-team", 10:04:53 INFO - "repo_path": "integration/fx-team", 10:04:53 INFO - "revision": "75f7f076c3a84c8095b81ecfb208e82c5d74db32", 10:04:53 INFO - "stage_platform": "linux64-pgo", 10:04:53 INFO - "builduid": "694b256057a24bbca4631e115bb66af2", 10:04:53 INFO - "slavebuilddir": "test" 10:04:53 INFO - } 10:04:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:04:53 INFO - Running post-action listener: _resource_record_post_action 10:04:53 INFO - [mozharness: 2016-07-28 17:04:53.412677Z] Finished read-buildbot-config step (success) 10:04:53 INFO - [mozharness: 2016-07-28 17:04:53.412765Z] Running download-and-extract step. 10:04:53 INFO - Running pre-action listener: _resource_record_pre_action 10:04:53 INFO - Running main action method: download_and_extract 10:04:53 INFO - mkdir: /builds/slave/test/build/tests 10:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:53 INFO - https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:04:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:04:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:04:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/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 10:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/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 10:04:54 INFO - Downloaded 1361 bytes. 10:04:54 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:04:54 INFO - Using the following test package requirements: 10:04:54 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:04:54 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:04:54 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:04:54 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:54 INFO - u'jsshell-linux-x86_64.zip'], 10:04:54 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:04:54 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:04:54 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:04:54 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:04:54 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:04:54 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:04:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:04:54 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:54 INFO - https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:04:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:04:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/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 10:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/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 10:04:55 INFO - Downloaded 24318177 bytes. 10:04:55 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'] 10:04:55 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 10:04:56 INFO - Return code: 0 10:04:56 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 10:04:56 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')]} 10:04:56 INFO - https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:04:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:04:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/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 10:04:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/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 10:04:57 INFO - Downloaded 24318177 bytes. 10:04:57 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'] 10:04:57 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 10:04:58 INFO - Return code: 0 10:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:58 INFO - https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:04:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:04:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/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 10:04:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/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 10:04:59 INFO - Downloaded 14413725 bytes. 10:04:59 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'] 10:04:59 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 10:05:00 INFO - Return code: 0 10:05: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')]} 10:05:00 INFO - https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:05:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/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 10:05:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IKf2l6vcSa-3Zviav_a3jg/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 10:05:01 INFO - Downloaded 60985297 bytes. 10:05:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:01 INFO - mkdir: /builds/slave/test/properties 10:05:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:01 INFO - Contents: 10:05:01 INFO - build_url:https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:05:02 INFO - Running post-action listener: _resource_record_post_action 10:05:02 INFO - Running post-action listener: set_extra_try_arguments 10:05:02 INFO - [mozharness: 2016-07-28 17:05:02.105026Z] Finished download-and-extract step (success) 10:05:02 INFO - [mozharness: 2016-07-28 17:05:02.105258Z] Running populate-webroot step. 10:05:02 INFO - Running pre-action listener: _resource_record_pre_action 10:05:02 INFO - Running main action method: populate_webroot 10:05:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:02 INFO - '--tppagecycles', 10:05:02 INFO - '7'], 10:05:02 INFO - 'tests': ['tsvgm']}}, 10:05:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:02 INFO - 'talos_options': ['--disable-e10s'], 10:05:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:02 INFO - 'talos_options': ['--disable-e10s'], 10:05:02 INFO - 'tests': ['damp', 'tps']}, 10:05:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:02 INFO - 'tests': ['damp', 'tps']}, 10:05:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:02 INFO - 'tests': ['dromaeo_dom']}, 10:05:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:05:02 INFO - 'tests': ['basic_compositor_video']}, 10:05:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:05:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:02 INFO - 'tests': ['a11yr', 10:05:02 INFO - 'ts_paint', 10:05:02 INFO - 'tpaint', 10:05:02 INFO - 'sessionrestore', 10:05:02 INFO - 'sessionrestore_no_auto_restore', 10:05:02 INFO - 'tabpaint']}, 10:05:02 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:02 INFO - 'ts_paint', 10:05:02 INFO - 'tpaint', 10:05:02 INFO - 'sessionrestore', 10:05:02 INFO - 'sessionrestore_no_auto_restore', 10:05:02 INFO - 'tabpaint']}, 10:05:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:02 INFO - 'ts_paint', 10:05:02 INFO - 'tpaint', 10:05:02 INFO - 'sessionrestore', 10:05:02 INFO - 'sessionrestore_no_auto_restore', 10:05:02 INFO - 'tabpaint']}, 10:05:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:02 INFO - 'ts_paint', 10:05:02 INFO - 'tpaint', 10:05:02 INFO - 'sessionrestore', 10:05:02 INFO - 'sessionrestore_no_auto_restore', 10:05:02 INFO - 'tabpaint']}, 10:05:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:02 INFO - 'tests': ['a11yr', 10:05:02 INFO - 'ts_paint', 10:05:02 INFO - 'tpaint', 10:05:02 INFO - 'sessionrestore', 10:05:02 INFO - 'sessionrestore_no_auto_restore', 10:05:02 INFO - 'tabpaint']}, 10:05:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:02 INFO - 'tests': ['a11yr', 10:05:02 INFO - 'ts_paint', 10:05:02 INFO - 'tpaint', 10:05:02 INFO - 'sessionrestore', 10:05:02 INFO - 'sessionrestore_no_auto_restore', 10:05:02 INFO - 'tabpaint']}, 10:05:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:02 INFO - 'tests': ['tsvgx', 10:05:02 INFO - 'tsvgr_opacity', 10:05:02 INFO - 'tart', 10:05:02 INFO - 'tscrollx', 10:05:02 INFO - 'cart']}, 10:05:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:02 INFO - 'tsvgr_opacity', 10:05:02 INFO - 'tart', 10:05:02 INFO - 'tscrollx', 10:05:02 INFO - 'cart']}, 10:05:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:02 INFO - 'talos_options': ['--disable-e10s'], 10:05:02 INFO - 'tests': ['tp5o']}, 10:05:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:02 INFO - 'tests': ['tp5o']}, 10:05:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:02 INFO - 'talos_options': ['--disable-e10s', 10:05:02 INFO - '--xperf_path', 10:05:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:02 INFO - 'tests': ['tp5n']}, 10:05:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:02 INFO - 'talos_options': ['--xperf_path', 10:05:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:02 INFO - 'tests': ['tp5n']}}, 10:05:02 INFO - 'talos.zip': {'path': '', 10:05:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:02 INFO - Running post-action listener: _resource_record_post_action 10:05:02 INFO - [mozharness: 2016-07-28 17:05:02.123693Z] Finished populate-webroot step (success) 10:05:02 INFO - [mozharness: 2016-07-28 17:05:02.123782Z] Running create-virtualenv step. 10:05:02 INFO - Running pre-action listener: _resource_record_pre_action 10:05:02 INFO - Running main action method: create_virtualenv 10:05:02 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:02 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 10:05:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:02 INFO - Using real prefix '/usr' 10:05:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:02 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:04 INFO - Installing pip.................done. 10:05:04 INFO - Return code: 0 10:05:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:04 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')]} 10:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:04 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')]} 10:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:04 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 0x270f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce3b0>, '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 0x29cf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cf740>, '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': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', '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 10:05:04 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 10:05:04 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 10:05:04 INFO - Using env: {'DISPLAY': ':0', 10:05:04 INFO - 'HOME': '/home/cltbld', 10:05:04 INFO - 'LANG': 'en_US.UTF-8', 10:05:04 INFO - 'LANGUAGE': 'en_US:en', 10:05:04 INFO - 'LOGNAME': 'cltbld', 10:05:04 INFO - 'MAIL': '/var/mail/cltbld', 10:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:04 INFO - 'MOZ_NO_REMOTE': '1', 10:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:04 INFO - 'NO_EM_RESTART': '1', 10:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:04 INFO - 'PWD': '/builds/slave/test', 10:05:04 INFO - 'SHELL': '/bin/bash', 10:05:04 INFO - 'SHLVL': '1', 10:05:04 INFO - 'TERM': 'linux', 10:05:04 INFO - 'TMOUT': '86400', 10:05:04 INFO - 'USER': 'cltbld', 10:05:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', 10:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:04 INFO - '_': '/tools/buildbot/bin/python'} 10:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:04 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 10:05:04 INFO - Cleaning up... 10:05:04 INFO - Return code: 0 10:05:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:05:04 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')]} 10:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:04 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')]} 10:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:04 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 0x270f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce3b0>, '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 0x29cf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cf740>, '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': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', '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 10:05:04 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 10:05:04 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 10:05:04 INFO - Using env: {'DISPLAY': ':0', 10:05:04 INFO - 'HOME': '/home/cltbld', 10:05:04 INFO - 'LANG': 'en_US.UTF-8', 10:05:04 INFO - 'LANGUAGE': 'en_US:en', 10:05:04 INFO - 'LOGNAME': 'cltbld', 10:05:04 INFO - 'MAIL': '/var/mail/cltbld', 10:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:04 INFO - 'MOZ_NO_REMOTE': '1', 10:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:04 INFO - 'NO_EM_RESTART': '1', 10:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:04 INFO - 'PWD': '/builds/slave/test', 10:05:04 INFO - 'SHELL': '/bin/bash', 10:05:04 INFO - 'SHLVL': '1', 10:05:04 INFO - 'TERM': 'linux', 10:05:04 INFO - 'TMOUT': '86400', 10:05:04 INFO - 'USER': 'cltbld', 10:05:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', 10:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:04 INFO - '_': '/tools/buildbot/bin/python'} 10:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:05 INFO - Downloading/unpacking psutil>=3.1.1 10:05:05 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 10:05:05 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 10:05:05 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 10:05:05 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 10:05:05 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 10:05:05 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 10:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:07 INFO - Installing collected packages: psutil 10:05:07 INFO - Running setup.py install for psutil 10:05:07 INFO - building 'psutil._psutil_linux' extension 10:05:07 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 10:05:07 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 10:05:07 INFO - building 'psutil._psutil_posix' extension 10:05:07 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 10:05:07 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 10:05:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:07 INFO - Successfully installed psutil 10:05:07 INFO - Cleaning up... 10:05:07 INFO - Return code: 0 10:05:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:07 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 0x270f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce3b0>, '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 0x29cf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cf740>, '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': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', '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 10:05:07 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 10:05:07 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 10:05:07 INFO - Using env: {'DISPLAY': ':0', 10:05:07 INFO - 'HOME': '/home/cltbld', 10:05:07 INFO - 'LANG': 'en_US.UTF-8', 10:05:07 INFO - 'LANGUAGE': 'en_US:en', 10:05:07 INFO - 'LOGNAME': 'cltbld', 10:05:07 INFO - 'MAIL': '/var/mail/cltbld', 10:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:07 INFO - 'MOZ_NO_REMOTE': '1', 10:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:07 INFO - 'NO_EM_RESTART': '1', 10:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:07 INFO - 'PWD': '/builds/slave/test', 10:05:07 INFO - 'SHELL': '/bin/bash', 10:05:07 INFO - 'SHLVL': '1', 10:05:07 INFO - 'TERM': 'linux', 10:05:07 INFO - 'TMOUT': '86400', 10:05:07 INFO - 'USER': 'cltbld', 10:05:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', 10:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:07 INFO - '_': '/tools/buildbot/bin/python'} 10:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:05:07 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 10:05:07 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 10:05:07 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 10:05:07 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 10:05:07 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 10:05:07 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 10:05:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:05:09 INFO - Installing collected packages: mozsystemmonitor 10:05:09 INFO - Running setup.py install for mozsystemmonitor 10:05:09 INFO - Successfully installed mozsystemmonitor 10:05:09 INFO - Cleaning up... 10:05:10 INFO - Return code: 0 10:05:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:10 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 0x270f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce3b0>, '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 0x29cf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cf740>, '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': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', '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 10:05:10 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 10:05:10 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 10:05:10 INFO - Using env: {'DISPLAY': ':0', 10:05:10 INFO - 'HOME': '/home/cltbld', 10:05:10 INFO - 'LANG': 'en_US.UTF-8', 10:05:10 INFO - 'LANGUAGE': 'en_US:en', 10:05:10 INFO - 'LOGNAME': 'cltbld', 10:05:10 INFO - 'MAIL': '/var/mail/cltbld', 10:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:10 INFO - 'MOZ_NO_REMOTE': '1', 10:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:10 INFO - 'NO_EM_RESTART': '1', 10:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:10 INFO - 'PWD': '/builds/slave/test', 10:05:10 INFO - 'SHELL': '/bin/bash', 10:05:10 INFO - 'SHLVL': '1', 10:05:10 INFO - 'TERM': 'linux', 10:05:10 INFO - 'TMOUT': '86400', 10:05:10 INFO - 'USER': 'cltbld', 10:05:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', 10:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:10 INFO - '_': '/tools/buildbot/bin/python'} 10:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:10 INFO - Downloading/unpacking jsonschema==2.5.1 10:05:10 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 10:05:10 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 10:05:10 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 10:05:10 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 10:05:10 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 10:05:10 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 10:05:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:12 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:12 INFO - warning: no files found matching '*.txt' 10:05:12 INFO - no previously-included directories found matching 'build' 10:05:12 INFO - no previously-included directories found matching 'dist' 10:05:12 INFO - no previously-included directories found matching '.git*' 10:05:12 INFO - Installing collected packages: jsonschema, functools32 10:05:12 INFO - Running setup.py install for functools32 10:05:12 INFO - warning: no files found matching '*.txt' 10:05:12 INFO - no previously-included directories found matching 'build' 10:05:12 INFO - no previously-included directories found matching 'dist' 10:05:12 INFO - no previously-included directories found matching '.git*' 10:05:12 INFO - Successfully installed jsonschema functools32 10:05:12 INFO - Cleaning up... 10:05:12 INFO - Return code: 0 10:05:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x270f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce3b0>, '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 0x29cf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cf740>, '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': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', '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 10:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:05:12 INFO - Using env: {'DISPLAY': ':0', 10:05:12 INFO - 'HOME': '/home/cltbld', 10:05:12 INFO - 'LANG': 'en_US.UTF-8', 10:05:12 INFO - 'LANGUAGE': 'en_US:en', 10:05:12 INFO - 'LOGNAME': 'cltbld', 10:05:12 INFO - 'MAIL': '/var/mail/cltbld', 10:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:12 INFO - 'MOZ_NO_REMOTE': '1', 10:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:12 INFO - 'NO_EM_RESTART': '1', 10:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:12 INFO - 'PWD': '/builds/slave/test', 10:05:12 INFO - 'SHELL': '/bin/bash', 10:05:12 INFO - 'SHLVL': '1', 10:05:12 INFO - 'TERM': 'linux', 10:05:12 INFO - 'TMOUT': '86400', 10:05:12 INFO - 'USER': 'cltbld', 10:05:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', 10:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:12 INFO - '_': '/tools/buildbot/bin/python'} 10:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:05:12 INFO - Cleaning up... 10:05:12 INFO - Return code: 0 10:05:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x270f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce3b0>, '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 0x29cf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cf740>, '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': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', '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 10:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:05:12 INFO - Using env: {'DISPLAY': ':0', 10:05:12 INFO - 'HOME': '/home/cltbld', 10:05:12 INFO - 'LANG': 'en_US.UTF-8', 10:05:12 INFO - 'LANGUAGE': 'en_US:en', 10:05:12 INFO - 'LOGNAME': 'cltbld', 10:05:12 INFO - 'MAIL': '/var/mail/cltbld', 10:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:12 INFO - 'MOZ_NO_REMOTE': '1', 10:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:12 INFO - 'NO_EM_RESTART': '1', 10:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:12 INFO - 'PWD': '/builds/slave/test', 10:05:12 INFO - 'SHELL': '/bin/bash', 10:05:12 INFO - 'SHLVL': '1', 10:05:12 INFO - 'TERM': 'linux', 10:05:12 INFO - 'TMOUT': '86400', 10:05:12 INFO - 'USER': 'cltbld', 10:05:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', 10:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:12 INFO - '_': '/tools/buildbot/bin/python'} 10:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:13 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:13 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 10:05:13 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 10:05:13 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 10:05:13 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 10:05:13 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 10:05:13 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 10:05:15 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:15 INFO - Downloading docopt-0.6.1.tar.gz 10:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:15 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:15 INFO - Running setup.py install for blobuploader 10:05:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:15 INFO - Running setup.py install for requests 10:05:16 INFO - Running setup.py install for docopt 10:05:16 INFO - Successfully installed blobuploader requests docopt 10:05:16 INFO - Cleaning up... 10:05:16 INFO - Return code: 0 10:05:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:16 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 0x270f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce3b0>, '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 0x29cf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cf740>, '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': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', '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 10:05:16 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 10:05:16 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 10:05:16 INFO - Using env: {'DISPLAY': ':0', 10:05:16 INFO - 'HOME': '/home/cltbld', 10:05:16 INFO - 'LANG': 'en_US.UTF-8', 10:05:16 INFO - 'LANGUAGE': 'en_US:en', 10:05:16 INFO - 'LOGNAME': 'cltbld', 10:05:16 INFO - 'MAIL': '/var/mail/cltbld', 10:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:16 INFO - 'MOZ_NO_REMOTE': '1', 10:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:16 INFO - 'NO_EM_RESTART': '1', 10:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:16 INFO - 'PWD': '/builds/slave/test', 10:05:16 INFO - 'SHELL': '/bin/bash', 10:05:16 INFO - 'SHLVL': '1', 10:05:16 INFO - 'TERM': 'linux', 10:05:16 INFO - 'TMOUT': '86400', 10:05:16 INFO - 'USER': 'cltbld', 10:05:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', 10:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:16 INFO - '_': '/tools/buildbot/bin/python'} 10:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:16 INFO - Running setup.py (path:/tmp/pip-UG14zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:16 INFO - Running setup.py (path:/tmp/pip-IX9egJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:16 INFO - Running setup.py (path:/tmp/pip-1MYYVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:16 INFO - Running setup.py (path:/tmp/pip-yujAgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:16 INFO - Running setup.py (path:/tmp/pip-48_Ays-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:16 INFO - Running setup.py (path:/tmp/pip-hmgU7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:17 INFO - Running setup.py (path:/tmp/pip-2yXam2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:17 INFO - Running setup.py (path:/tmp/pip-CNk1Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:17 INFO - Running setup.py (path:/tmp/pip-8WEqtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:17 INFO - Running setup.py (path:/tmp/pip-F2vkMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:17 INFO - Running setup.py (path:/tmp/pip-OOhhuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:17 INFO - Running setup.py (path:/tmp/pip-6Gcren-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:17 INFO - Running setup.py (path:/tmp/pip-g6UgpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:17 INFO - Running setup.py (path:/tmp/pip-BfTEGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:17 INFO - Running setup.py (path:/tmp/pip-K2s6BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:17 INFO - Running setup.py (path:/tmp/pip-AYu1cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:17 INFO - Running setup.py (path:/tmp/pip-2uwFLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:17 INFO - Running setup.py install for manifestparser 10:05:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:17 INFO - Running setup.py install for mozcrash 10:05:18 INFO - Running setup.py install for mozdebug 10:05:18 INFO - Running setup.py install for mozdevice 10:05:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:18 INFO - Running setup.py install for mozfile 10:05:18 INFO - Running setup.py install for mozhttpd 10:05:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:18 INFO - Running setup.py install for mozinfo 10:05:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:18 INFO - Running setup.py install for mozInstall 10:05:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:18 INFO - Running setup.py install for mozleak 10:05:18 INFO - Running setup.py install for mozlog 10:05:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:18 INFO - Running setup.py install for moznetwork 10:05:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:18 INFO - Running setup.py install for mozprocess 10:05:19 INFO - Running setup.py install for mozprofile 10:05:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:19 INFO - Running setup.py install for mozrunner 10:05:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:19 INFO - Running setup.py install for mozscreenshot 10:05:19 INFO - Running setup.py install for moztest 10:05:19 INFO - Running setup.py install for mozversion 10:05:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:19 INFO - Cleaning up... 10:05:19 INFO - Return code: 0 10:05:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:19 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 0x270f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce3b0>, '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 0x29cf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cf740>, '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': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', '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 10:05:19 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 10:05:19 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 10:05:19 INFO - Using env: {'DISPLAY': ':0', 10:05:19 INFO - 'HOME': '/home/cltbld', 10:05:19 INFO - 'LANG': 'en_US.UTF-8', 10:05:19 INFO - 'LANGUAGE': 'en_US:en', 10:05:19 INFO - 'LOGNAME': 'cltbld', 10:05:19 INFO - 'MAIL': '/var/mail/cltbld', 10:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:19 INFO - 'MOZ_NO_REMOTE': '1', 10:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:19 INFO - 'NO_EM_RESTART': '1', 10:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:19 INFO - 'PWD': '/builds/slave/test', 10:05:19 INFO - 'SHELL': '/bin/bash', 10:05:19 INFO - 'SHLVL': '1', 10:05:19 INFO - 'TERM': 'linux', 10:05:19 INFO - 'TMOUT': '86400', 10:05:19 INFO - 'USER': 'cltbld', 10:05:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', 10:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:19 INFO - '_': '/tools/buildbot/bin/python'} 10:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:19 INFO - Running setup.py (path:/tmp/pip-HHMvge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:19 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)) 10:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:19 INFO - Running setup.py (path:/tmp/pip-HWE3Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:19 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)) 10:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:19 INFO - Running setup.py (path:/tmp/pip-s_6qSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:20 INFO - Running setup.py (path:/tmp/pip-sjk2Q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:20 INFO - Running setup.py (path:/tmp/pip-xglcHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:20 INFO - Running setup.py (path:/tmp/pip-oXKuwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:20 INFO - Running setup.py (path:/tmp/pip-74xAv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:20 INFO - Running setup.py (path:/tmp/pip-otPFto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:20 INFO - Running setup.py (path:/tmp/pip-42LmyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:20 INFO - Running setup.py (path:/tmp/pip-1qTcOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:20 INFO - Running setup.py (path:/tmp/pip-nIJL34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:20 INFO - Running setup.py (path:/tmp/pip-mAJGIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:20 INFO - Running setup.py (path:/tmp/pip-7MHMHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:20 INFO - Running setup.py (path:/tmp/pip-T_GaV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:20 INFO - Running setup.py (path:/tmp/pip-Po7eok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:20 INFO - Running setup.py (path:/tmp/pip-T205he-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:20 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)) 10:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:21 INFO - Running setup.py (path:/tmp/pip-uIS4h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:21 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)) 10:05:21 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)) 10:05:21 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)) 10:05:21 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)) 10:05:21 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)) 10:05:21 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)) 10:05:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:21 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 10:05:21 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 10:05:21 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 10:05:21 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 10:05:21 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 10:05:21 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 10:05:22 INFO - Downloading blessings-1.6.tar.gz 10:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:23 INFO - Installing collected packages: blessings 10:05:23 INFO - Running setup.py install for blessings 10:05:23 INFO - Successfully installed blessings 10:05:23 INFO - Cleaning up... 10:05:23 INFO - Return code: 0 10:05:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:23 INFO - Reading from file tmpfile_stdout 10:05:23 INFO - Current package versions: 10:05:23 INFO - argparse == 1.2.1 10:05:23 INFO - blessings == 1.6 10:05:23 INFO - blobuploader == 1.2.4 10:05:23 INFO - docopt == 0.6.1 10:05:23 INFO - functools32 == 3.2.3-2 10:05:23 INFO - jsonschema == 2.5.1 10:05:23 INFO - manifestparser == 1.1 10:05:23 INFO - mozInstall == 1.12 10:05:23 INFO - mozcrash == 0.17 10:05:23 INFO - mozdebug == 0.1 10:05:23 INFO - mozdevice == 0.48 10:05:23 INFO - mozfile == 1.2 10:05:23 INFO - mozhttpd == 0.7 10:05:23 INFO - mozinfo == 0.9 10:05:23 INFO - mozleak == 0.1 10:05:23 INFO - mozlog == 3.3 10:05:23 INFO - moznetwork == 0.27 10:05:23 INFO - mozprocess == 0.23 10:05:23 INFO - mozprofile == 0.28 10:05:23 INFO - mozrunner == 6.12 10:05:23 INFO - mozscreenshot == 0.1 10:05:23 INFO - mozsystemmonitor == 0.3 10:05:23 INFO - moztest == 0.7 10:05:23 INFO - mozversion == 1.4 10:05:23 INFO - psutil == 3.1.1 10:05:23 INFO - requests == 1.2.3 10:05:23 INFO - wsgiref == 0.1.2 10:05:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:23 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 0x270f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce3b0>, '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 0x29cf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cf740>, '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': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', '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 10:05:23 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 10:05:23 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 10:05:23 INFO - Using env: {'DISPLAY': ':0', 10:05:23 INFO - 'HOME': '/home/cltbld', 10:05:23 INFO - 'LANG': 'en_US.UTF-8', 10:05:23 INFO - 'LANGUAGE': 'en_US:en', 10:05:23 INFO - 'LOGNAME': 'cltbld', 10:05:23 INFO - 'MAIL': '/var/mail/cltbld', 10:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:23 INFO - 'MOZ_NO_REMOTE': '1', 10:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:23 INFO - 'NO_EM_RESTART': '1', 10:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:23 INFO - 'PWD': '/builds/slave/test', 10:05:23 INFO - 'SHELL': '/bin/bash', 10:05:23 INFO - 'SHLVL': '1', 10:05:23 INFO - 'TERM': 'linux', 10:05:23 INFO - 'TMOUT': '86400', 10:05:23 INFO - 'USER': 'cltbld', 10:05:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', 10:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:23 INFO - '_': '/tools/buildbot/bin/python'} 10:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:23 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)) 10:05:23 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)) 10:05:23 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)) 10:05:23 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)) 10:05:23 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)) 10:05:23 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)) 10:05:23 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)) 10:05:23 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)) 10:05:23 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)) 10:05:23 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)) 10:05:23 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)) 10:05:23 INFO - Cleaning up... 10:05:23 INFO - Return code: 0 10:05:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:23 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 0x270f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce3b0>, '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 0x29cf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cf740>, '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': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', '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 10:05:23 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 10:05:23 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 10:05:23 INFO - Using env: {'DISPLAY': ':0', 10:05:23 INFO - 'HOME': '/home/cltbld', 10:05:23 INFO - 'LANG': 'en_US.UTF-8', 10:05:23 INFO - 'LANGUAGE': 'en_US:en', 10:05:23 INFO - 'LOGNAME': 'cltbld', 10:05:23 INFO - 'MAIL': '/var/mail/cltbld', 10:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:23 INFO - 'MOZ_NO_REMOTE': '1', 10:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:23 INFO - 'NO_EM_RESTART': '1', 10:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:23 INFO - 'PWD': '/builds/slave/test', 10:05:23 INFO - 'SHELL': '/bin/bash', 10:05:23 INFO - 'SHLVL': '1', 10:05:23 INFO - 'TERM': 'linux', 10:05:23 INFO - 'TMOUT': '86400', 10:05:23 INFO - 'USER': 'cltbld', 10:05:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', 10:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:23 INFO - '_': '/tools/buildbot/bin/python'} 10:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:05:23 INFO - Cleaning up... 10:05:23 INFO - Return code: 0 10:05:23 INFO - Running post-action listener: _resource_record_post_action 10:05:23 INFO - Running post-action listener: _start_resource_monitoring 10:05:23 INFO - Starting resource monitoring. 10:05:23 INFO - [mozharness: 2016-07-28 17:05:23.931693Z] Finished create-virtualenv step (success) 10:05:23 INFO - [mozharness: 2016-07-28 17:05:23.932169Z] Running install step. 10:05:23 INFO - Running pre-action listener: _resource_record_pre_action 10:05:23 INFO - Running main action method: install 10:05:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:24 INFO - Reading from file tmpfile_stdout 10:05:24 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:24 INFO - Reading from file tmpfile_stdout 10:05:24 INFO - Output received: 10:05:24 INFO - Usage: mozinstall [options] installer 10:05:24 INFO - Options: 10:05:24 INFO - -h, --help show this help message and exit 10:05:24 INFO - -d DEST, --destination=DEST 10:05:24 INFO - Directory to install application into. [default: 10:05:24 INFO - "/builds/slave/test"] 10:05:24 INFO - --app=APP Application being installed. [default: firefox] 10:05:24 INFO - mkdir: /builds/slave/test/build/application 10:05:24 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'] 10:05:24 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 10:05:41 INFO - Reading from file tmpfile_stdout 10:05:41 INFO - Output received: 10:05:41 INFO - /builds/slave/test/build/application/firefox/firefox 10:05:41 INFO - Running post-action listener: _resource_record_post_action 10:05:41 INFO - [mozharness: 2016-07-28 17:05:41.489064Z] Finished install step (success) 10:05:41 INFO - [mozharness: 2016-07-28 17:05:41.489466Z] Running run-tests step. 10:05:41 INFO - Running pre-action listener: _resource_record_pre_action 10:05:41 INFO - Running main action method: run_tests 10:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:41 INFO - Python 2.7.3 10:05:41 INFO - Return code: 0 10:05:41 INFO - grabbing minidump binary from tooltool 10:05:41 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')]} 10:05:41 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 0x29ce3b0>, '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 0x29cf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29cf740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:41 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 10:05:41 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 10:05:41 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 10:05:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:41 INFO - Return code: 0 10:05:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:05:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:05:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:05:41 INFO - Using env: {'DISPLAY': ':0', 10:05:41 INFO - 'HOME': '/home/cltbld', 10:05:41 INFO - 'LANG': 'en_US.UTF-8', 10:05:41 INFO - 'LANGUAGE': 'en_US:en', 10:05:41 INFO - 'LOGNAME': 'cltbld', 10:05:41 INFO - 'MAIL': '/var/mail/cltbld', 10:05:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:41 INFO - 'MOZ_NO_REMOTE': '1', 10:05:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:41 INFO - 'NO_EM_RESTART': '1', 10:05:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:41 INFO - 'PWD': '/builds/slave/test', 10:05:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:41 INFO - 'SHELL': '/bin/bash', 10:05:41 INFO - 'SHLVL': '1', 10:05:41 INFO - 'TERM': 'linux', 10:05:41 INFO - 'TMOUT': '86400', 10:05:41 INFO - 'USER': 'cltbld', 10:05:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469725488.70771-205285961', 10:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:41 INFO - '_': '/tools/buildbot/bin/python'} 10:05:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:05:41 INFO - mozversion application_buildid: 20160728083025 10:05:41 INFO - mozversion application_changeset: 75f7f076c3a84c8095b81ecfb208e82c5d74db32 10:05:41 INFO - mozversion application_display_name: Nightly 10:05:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:41 INFO - mozversion application_name: Firefox 10:05:41 INFO - mozversion application_remotingname: firefox 10:05:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:05:41 INFO - mozversion application_vendor: Mozilla 10:05:41 INFO - mozversion application_version: 50.0a1 10:05:41 INFO - mozversion platform_buildid: 20160728083025 10:05:41 INFO - mozversion platform_changeset: 75f7f076c3a84c8095b81ecfb208e82c5d74db32 10:05:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:05:41 INFO - mozversion platform_version: 50.0a1 10:05:41 INFO - using testdate: 1469725541 10:05:41 INFO - actual date: 1469725541 10:05:41 INFO - starting webserver on 'localhost:48224' 10:05:41 INFO - SUITE-START | Running 2 tests 10:05:41 INFO - TEST-START | dromaeo_css 10:05:41 INFO - operating with platform_type : linux_ 10:05:41 INFO - Initialising browser for dromaeo_css test... 10:05:41 INFO - TEST-INFO | started process 7402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMUraMR/profile http://localhost:48224/getInfo.html) 10:05:45 INFO - PROCESS | 7402 | JavaScript error: , line 0: uncaught exception: undefined 10:05:46 INFO - PROCESS | 7402 | __metrics Screen width/height:1600/1200 10:05:46 INFO - PROCESS | 7402 | colorDepth:24 10:05:46 INFO - PROCESS | 7402 | Browser inner width/height: 1024/697 10:05:46 INFO - PROCESS | 7402 | __metrics 10:05:47 INFO - PROCESS | 7402 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:05:47 INFO - PROCESS | 7402 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:48 INFO - PROCESS | 7402 | console.error: PushService: 10:05:48 INFO - PROCESS | 7402 | stateChangeProcessEnqueue: Error transitioning state 10:05:48 INFO - PROCESS | 7402 | UnknownError 10:05:48 INFO - TEST-INFO | 7402: exit 0 10:05:48 INFO - Browser initialized. 10:05:48 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:48 INFO - TEST-INFO | started process 7483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMUraMR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:00 INFO - PROCESS | 7483 | RSS: Main: 157081600 10:06:00 INFO - PROCESS | 7483 | 10:06:52 INFO - PROCESS | 7483 | 1469725612092 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] 10:09:00 INFO - PROCESS | 7483 | Cycle 1(1): loaded http://localhost:48224/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48224/tests/dromaeo/cssquery-ext.html) 10:09:01 INFO - PROCESS | 7483 | RSS: Main: 270716928 10:09:01 INFO - PROCESS | 7483 | 10:12:03 INFO - PROCESS | 7483 | Cycle 1(1): loaded http://localhost:48224/tests/dromaeo/cssquery-ext.html (next: http://localhost:48224/tests/dromaeo/cssquery-jquery.html) 10:12:04 INFO - PROCESS | 7483 | RSS: Main: 255459328 10:12:04 INFO - PROCESS | 7483 | 10:15:06 INFO - PROCESS | 7483 | Cycle 1(1): loaded http://localhost:48224/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48224/tests/dromaeo/cssquery-mootools.html) 10:15:07 INFO - PROCESS | 7483 | RSS: Main: 186077184 10:15:07 INFO - PROCESS | 7483 | 10:18:09 INFO - PROCESS | 7483 | Cycle 1(1): loaded http://localhost:48224/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48224/tests/dromaeo/cssquery-prototype.html) 10:18:09 INFO - PROCESS | 7483 | RSS: Main: 184274944 10:18:09 INFO - PROCESS | 7483 | 10:21:12 INFO - PROCESS | 7483 | Cycle 1(1): loaded http://localhost:48224/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48224/tests/dromaeo/cssquery-yui.html) 10:21:12 INFO - PROCESS | 7483 | RSS: Main: 188153856 10:21:12 INFO - PROCESS | 7483 | 10:24:15 INFO - PROCESS | 7483 | Cycle 1(1): loaded http://localhost:48224/tests/dromaeo/cssquery-yui.html (next: http://localhost:48224/tests/dromaeo/cssquery-dojo.html) 10:24:15 INFO - PROCESS | 7483 | RSS: Main: 278671360 10:24:15 INFO - PROCESS | 7483 | 10:24:15 INFO - PROCESS | 7483 | __start_tp_report 10:24:15 INFO - PROCESS | 7483 | _x_x_mozilla_page_load 10:24:15 INFO - PROCESS | 7483 | _x_x_mozilla_page_load_details 10:24:15 INFO - PROCESS | 7483 | |i|pagename|runs| 10:24:15 INFO - PROCESS | 7483 | |0;dojo.html;3074.908407515332;3101.8914337998176;3114.7041031102053;3124.828134452604;3138.2468207630177;5364.383095943967;5372.462753724625;5453.481919217673;5457.945420545793;5461.344638643368;5379.220013098108;5417.918731219035;5529.944700552994;5532.612717109804;5583.3858275589755;4825.517448255173;4903.558679718824;4917.704937703731;4967.577755890736;5085.491450854922;4980.950190498103;5015.423226328982;5029.195328747401;5036.244563315514;5042.647014708972;4866.951330486703;4887.584555312803;4900.142475066885;4924.458309585961;5020.648554601179;4858.684185527929;4866.537678920497;4867.951320486785;4874.122657921573;4978.054169707781;4904.828331008433;4918.262260660894;4931.506849315076;4947.233178857283;4963.379577552806;5285.920711189336;5341.0653135701095;5405.135178371481;5438.075527160392;5461.890762184774;5874.530037596982;5916.704164791743;5928.614640048426;5929.495992840613;5931.762729490858;5923.141144534018;5957;5960.582759206857;5975.611585246945;5978.342382337939;5275.57795376369;5353.6787792732175;5417.891642167135;5547.639403438763;5562;5950.940490595125;5999.670018148957;6004.219451471368;6007.699615019232;6008.66952317618;5777.335606405233;5796.333421656479;5797.072468405035;5802.071668533014;5808.244928159397;5714.05718056516;5764.942350576441;5813.476787089182;5855.912161317584;5908.527317814564;5778.27771528559;5819.941800582024;5822.039363504974;5853.502452291603;5876.500497457764;5761.481466667936;5799.3620701722775;5822.0684690449325;5832.883342333214;5839.620424672383;4366.388705581221;4383.145286669069;4399.560043995639;4450.310201918708;4494.977525112354;3914.8434062637175;3933.449317095609;3955.0903292242947;3975.363941769303;3997.620226078518;5431.375391829911;5432.782688692487;5439.864003399946;5440.211169380417;5463.426340234298;5576.163575463713;5815.156802263648;5827.271591051119;5893.14549390336;5925.940740592625;5567.276254086943;5591.664500130005;5618.747156377973;5630;5656.236408084938;5111.182210846247;5117.1045067113855;5125.538701516882;5131.640785145004;5190.792368305301;5825.1844741736195;5926.051831706906;5942.70286485674;6128.448439640454;6130.724117414727;5810;5814.854628634318;5822.359540450631;5859;5877.764889404376;5916.201312822714;5920.993431116634;5925.822225333247;5925.851853703692;5928.584999050025;5554.472325129106;5686.2607860977805;5689.459501347365;5730.398308177581;5748.310202775694;5826.329972053099;5879.059350503899;5882.558808089325;5913.408659134052;5935.940640593539;5753.1945527627;5756.56825738063;5764.279465066867;5764.625299355528;5766.192733017465;5541.750621221974;5685.317761868602;5701.971490142523;5718.3423906249645;5729.4843464088435;5739.856503587277;5754.108113242454;5759.539236861125;5801.825945221482;5808.5643576732755;5800.796972105956;5815.447532484407;5869.853253668693;5873.647581145145;5874;5429.131338985743;5535.308086489189;5549.972250138885;5668.603197776116;5670.603057785916 10:24:15 INFO - PROCESS | 7483 | |1;ext.html;597.4921316880652;610.8625559249169;631.0565704272113;638.1034646321916;649.610233859684;30542.23644408891;30985.535216971763;44328.11343773126;44940.32589511152;45069.0986180277;42590;47147.76426117864;47518.762406188005;47759;47812.2828157577;8906.376553641265;9055.728328150166;9056.41133326335;9057.682981095662;9062;8806.427582207169;8871.733847984571;8895.4662720237;8922.464652120862;8937.150970657776;8974.685885993991;8999.055099214587;8999.145081217273;9015.639374425014;9017.278617710568;8943.552822358855;8968.910310896872;8982.595783189772;8985.146411090936;8986.056464071244;8946.329025323126;9018.188363047291;9026.50354230517;9028.097190280985;9028.683996060172;44104.117917641466;44292.3356149658;44371.33442998357;44379.334309985374;44406.55593444056;3555.1467647764607;3624.873129440457;3812.3519001769764;4003.4795476587856;4214.810333534998;32563.6743632563;33401.16497087568;33575.832120839485;33673.83163084193;34129.488057679155;4062.3906414037833;4292.635126014293;4437.090396468716;4463.955360446386;4483.260262056757;373065;375091;375513;376043;377352;34283.48574771381;62714.686426567576;62954;63366.36633633605;63493.682531587045;34874.47688284678;36373;36406.635933640326;36494.27011459756;36622.26755464876;13486.258255796025;13642.317884105754;13656.931715341558;13661;13665.658358540917;12363.567275145328;12433.875661243454;12445.37773111359;12518.687032824253;12549.372531373394;8245.216704413071;8261.17388261169;8321.791955201048;8374.078851326349;8398.328133749286;3191.1702957230823;3240.6759324067407;3269.7547683923326;3281.917952051218;3326.185084654275;989.4113002763488;1023.4473384372504;1055.9472026398803;1057.1859668055554;1107.9058280046286;32642.183945401554;33124.1718957028;33280.500792488136;33528.4089209695;33624.32751344959;1120.2662256222188;1123.6291724096588;1127.785720713062;1129.1249281806665;1129.9943500282611;16501;17669.809400398066;17735;17780.199891004937;17925.551861203574;575857;587637;589257;589784.1532377017;591096;61132;61739.38260617336;61787.69106154441;61802.69098654568;62018;1205.5238180918489;1316.27604817352;1332.320516536554;1356.9796453053211;1368.9794653080012;30019.24951876133;34432.65567344295;34519.30961380708;34531.202382082665;34539.13652158716;52684;53046.204306934655;53271.73364133154;53283.73358133184;53395;435662;435892;436181;436329;436353;24899.875500623104;27779.44441111207;29112.56331154992;29462.263443414085;29516;45199;48672;49038.75480622574;49585;50528.24207636815;42181.78909105435;42971.78514107534;43696.344554832336;44087.77956110199;45314.773426132655;42214.288204040764;42598;43239.13521729485;43504.56495435132;43603.781981089895;31947.68052319447;41399.1720165601;41932.79033604812;42579;42810.35784463173;34840;38555.42166867555;38558.80720596379;38570.228595427376;38855.80572097121;28414;28677.28306792347;28683.28291792722;28726.85636571804;28775 10:24:15 INFO - PROCESS | 7483 | |2;jquery.html;362.8639260277396;381.1481339206873;381.8243607940347;384.78452066842567;398.418309268468;15767.60580985476;17596.56008599784;18024.639507209864;19660.21359145636;20223;18843.152058157382;19272.421827345166;19328.613427731438;19347.709784353247;19777.110030048647;5643.294588176478;5696.800611978592;5858.853528661775;5866.823995280127;5898.705064746767;6448.193975753031;6461.515386346019;6499.9350006500035;6536.215654121512;6542.738290468375;5603.411641777616;5853.209816674737;5895.793647222348;6463.25672547656;6465.838354041163;5920.822375328747;5938.495227905633;5953.910691339612;5958.285005799288;5961.791337303173;5599.776008959678;5800.7679692812235;5829.242198514166;5846.766129354821;5848.912266316009;13859.514916977958;14019.859801401957;18288;23121.190758323548;23329.88335058331;2364.775346342095;2441.584930561809;2537.3402915241986;2566.358410397401;2687.072959828856;9963.800723985552;10294.124999375063;10426.530806113667;10500.422476763775;10578.824375337084;1914.6457905287566;1975.259277770836;2012.8892910889895;2024.0790440349606;2035.328341647253;80250;81656.77514837282;81954.59022704908;83757;85399.5730021352;10448.477576121315;10732.678019659423;10738.570457181626;11173.10615150786;11188.608398706006;15149.318280677397;15167.848321516864;15179.924100379427;15195;15201.315940782692;7637.579933103621;8094.554799485967;8147.9185208147155;8219.753407397788;8220.63007164679;7754.7673569793;7816.921830781733;7982;8000.8398782176255;8055.113937466874;4553.635709143261;4614.930776038362;4674.111918735497;4689.7655117244;4790.688605240648;1964.430315208602;1979.6832506798844;1981.118402310958;1993.2226431691652;1999.6300684373437;866.3978534918298;959.9664011759555;970.3401686852867;988.3593235229484;1088.6189833558192;19387.806121938884;19952.800471995386;20324.79675203229;20586.691199632016;20590.485237869172;967.2842096848282;982.4841957972122;993.478423827482;1015.6699072801222;1081.70793885652;10814.188935829845;11515.25150865191;11540.307581545134;11544.480498377594;11547;501720;506727;508142;508330;522811;83582.58208708918;93488;95365.75488348208;97689;97786.64386814834;938.1134827588;976.7558110472382;995.2784231432298;1000.5747557287978;1002.6190047781796;17313.826861731726;17642.38251661186;18054.819451805313;18095.728564071287;18165.636687265916;42650.8818941729;43637.345439819066;43697.78151109224;43875.34186987262;44724.55275447204;55098.44901550933;59223;60451;61106.694466527384;61579;6131.96934015345;7358.411327093712;8328.375371847014;8491.702790402307;8637;9543.141117299476;12531.812022819482;12611.117221794753;12707.872921271039;13342.533011344945;11014.779704405706;11380.03269722083;11511.942440287745;11699.88300117022;11835.881641183478;10780.946095269474;10836.729081773019;11142.052925501423;11208.215424920178;11289.604863829727;11716.765664686829;11869.703257418289;11896.702582435508;11934.283942963102;11964.162508624313;7476.177620461636;7599.734009309647;7775.961120194589;8013.6794528218215;8581.785455363666;11659.650210493699;11751.823722643996;11838.940805295919;11903.226290291102;12118.939405302917 10:24:15 INFO - PROCESS | 7483 | |3;mootools.html;1293.5020017293339;1464.1507925403266;1522.8172619285683;1603.7113319602468;1764.5500397398662;8010.879836802445;8884.289256859453;9166.770830729236;9182.449053056804;9478.431294122358;9250.213731832786;9321;9323.487208203545;9323.813523729521;9324.580393882274;2359.315798418461;2380.3454050136265;2385.5467461182407;2386.6181410974245;2386.904523819054;2308.4575124845646;2335.392797872557;2370.514044620857;2373.371056669984;2376.9049238030457;2296.781805728453;2327.7206735191717;2338.2634470141934;2393.4375421775867;2394.2577800881695;2276.6129757941026;2317.582835089683;2325.360525855386;2329.5690297295055;2341.1922886604093;2287.5424915016897;2296.2307626944994;2297.9425514362106;2299.413649519362;2302.6661134135625;9348.813023739487;9359.251259899193;9421.48181849998;9433.716988490356;9439.24486041115;5231.8168864089575;5393.6763794172475;5397.757100930428;5404.378496472917;5430.321209848769;3410.693037626601;3477.3393055319407;3494.650534946485;3539.94690079649;3573.0531409176588;1067.546292825546;1077.1490522487304;2200.9779902200935;2258.0967612954787;2267.0931627349028;12960.546380876624;13189.340532973312;13233.338333083404;13233.404496797571;13240.20558766477;4670.182718024332;4727.858164255009;4748.953244070052;4787.640926930494;4934.284528743312;11122.44387780624;11178.776424471465;11183.888161118284;11186.272892261977;11188.440577971069;5378.946210537844;5385.7307134643115;5396.3524377075;5399.2980912481125;5401.3248343957;4189.2040512302565;4652.348671186037;4844.32179494871;4882.707037577686;4971;4103.297131690315;4126.793660316972;4227.619514243733;4252.681048921343;4268.039691069484;1272.7136394311392;1272.7963525835821;1280.507004803139;1282.1025282302426;1283.4673610451557;898.2948385517337;945.2485274207022;953.9236861051099;964.0889359555154;1003.19744204636;6050.547868511526;6408.070829729663;6412.487001039905;6508.772192973223;6642.269350371455;432.62145622580243;439.9736015838996;444.02979489814857;452.2424938228454;452.60623257765957;4158.272302347077;4345.087531618396;4399.978000110043;4512.796924138422;4603.332516785047;11849.466773995191;11873.406329683654;11944.223625464318;12006.75986480283;12029.338386388832;11872.821907671392;11891.524339026515;11895.464704088337;11897.88102118985;11903.523859045714;8103.594820258963;8484.151584841466;8501.957490212633;8692.261157801531;8695.652173913099;6129.233845769279;6197.597156184834;6200.131981522681;6247.12540244357;6348.873022539616;10631;10679.733006674895;10804.297720648447;10804.567817287221;10911.78176436451;11133.053690436403;11203.99164075237;11289.20975531705;11298.83051754208;11299.887001130212;7385.03994480714;7617.619119043915;7620.80947976305;7835.84328313442;8056.637451314822;8377.28793052573;8623.310135189295;8889.4666320021;8953.194212520904;9226.35415520907;7747.883781743166;7853.764387068169;8004.599770011359;8042.235987581171;8192.303654189222;7775.805604859924;7828.84342313162;7892.644830982735;7899.249571290718;7958.602069896367;7188.424926005802;7287.12554493443;7288.927110728825;7292;7292.890606641011;5374.973125134506;5504.587155963399;5526.115821468546;5553.861153471195;5743.4256574342235;5528.612997090326;5531.1426728857095;5605.5515558756015;5699.572532060195;5770.451807078321 10:24:15 INFO - PROCESS | 7483 | |4;prototype.html;332.5610194543203;335.3410548272644;342.41276211297617;343.11818626130844;343.20205522160984;5353.411124776271;5380.112281473557;5439.211314359421;5460.453954604538;5471.151971444422;5329.440408757083;5350.839474815752;5394.217838413428;5439.129739241722;5439.156930675742;3730.9067273318115;4029.355303151496;4078.327076032466;4133.462649855514;4225.873223803291;4200.852970146046;4205.663546916239;4208.095259519203;4216.620504154641;4221.810018549158;4170.749755014694;4178.937315940263;4193.35003074524;4218.228344095472;4234.640055595262;4023.758574485511;4133.152703695735;4189.2668782962855;4243.936340954888;4266.637335826458;3729.272791805599;3736.4955730976512;3739.2147648993746;3761.6426439488205;3768.4535742317485;5241.606879484016;5266.815661451869;5283.494204151798;5284.973575132138;5320.122179840322;4704.411948506437;4800.975995120037;4806.447258565275;4811.566958973674;4836.758162091881;5507.5593952483705;5515.034868897927;5524;5524.502794748492;5585.8269763349745;4102.5076990761;4114.835406583733;4121.5466298707415;4123.670106391512;4126.607972242632;5600.6079574429805;5726.942730572724;5733.741981610838;5852.4147585241135;5861.886241614122;4130.574951641679;4145.274576949082;4152.771597562102;4159.817739429339;4165.729227600196;4195.328747400462;4236.792514133457;4245.97877010613;4258.595433433881;4264.211120942636;4659.906801863944;4815.951840481621;4821.710697358169;4821.975890120527;4829.251466022772;5562.471565201299;5573.916391254134;5575.553955683536;5642;5686.346070201897;1443.6607397261635;1467.8532146785235;1470.6543962168882;1473.4916453823414;1477.3573495529479;908.4519500638302;932.8227636748996;933.9906600933904;938.1603464899014;961.7691753978995;4771;4801.879953001203;4804.399450068741;4829.95170048302;4848.448496481092;5048.848534543969;5063.8987220255385;5079.517445842639;5083.779892825769;5088.6946783193125;4552.317152427162;4757.644071439623;4799.680087975835;4825.276208568673;4865;2673.893044278246;2678.383971686484;2706.499297629945;2726.6319046928807;2739.8082134250412;5230.320058392384;5256.816011439581;5271.551918087006;5277.868053298622;5311.273836003237;4805.8946442318465;5161.799684195747;5179.715115668674;5198.402183748917;5526.281583394133;5777.566682498829;5834.299884013945;5902.7343769531335;5916.556258280646;5932.4364185401455;5728.513076388554;5737.971310143423;5759.481646651821;5776.740046697824;5785.392533783892;5500.724963751876;5657.377688454185;5678.346990096192;5681.829545113488;5712.571557133148;5860.531157507475;5907.4683278505145;5910.822675319747;5913.172155898264;5923.614965027259;4193.559676234074;4199.118185181146;4207.326827707552;4207.726497777635;4211.620954114144;5527.44725527444;5669.461401166883;5691.3170419549915;5695.544356451391;5708.058170401837;5560.638558493685;5582.804601838916;5583.69289689071;5625.606207565595;5649.378568357395;5339.492748188916;5527.226188333717;5635.520980716685;5669.234653321913;5670.9432905672065;5524.33707955048;5542.72286385671;5547.4175211603815;5552.639078459887;5558.583106266965;5595.272614560081;5620.662760234399;5666.858328541654;5667.688277144796;5684.687342196054;5282.3132992712235;5424.701641409602;5475.589330800126;5476.589255805751;5499.202615620793 10:24:15 INFO - PROCESS | 7483 | |5;yui.html;792.3423558446486;796.4942261663844;807.297651043592;813.0365516862519;895.7894894699748;15445.227738613066;16177.433789817358;16190.75713864293;16197.757033644504;16208.432704855333;15075.472358467456;15385.230738463088;15389.615259618487;15393.230338483087;15393.307301171446;663.2372771312993;675.3820254467157;678.0879716780922;681.17237556369;792.6433105102727;821.5153059694779;828.1470085811624;828.295948443821;828.3207769628907;828.4697793412221;871.6426265231256;879.973600791974;883.1301168349171;883.8630012348096;883.9867401988976;878.4904755241944;878.6924576398274;878.7583414561046;878.8022694893693;879.0945326313907;512.4030504462297;615.5106690181271;641.0608458608115;642.4828013449171;642.5181114164377;14787.186704731235;15306.311215995307;15397.153156576383;15400.768988465183;15413.3834646614;14320.35558399864;14508.170138455782;14825.406983720639;14859.554213373616;15064.924675376662;13591.932040339834;13815.723685526335;13836.100653457494;13889.097208681404;13925.373358198804;4422.579854913778;4465.218586747306;4572.9314060289125;4614.238650622643;4716.2454007359;81996.59001704953;83415.16584834135;84951;84967;85546.14453855444;11594.710132246593;11599.420028998516;11704.70738231534;11719.355435451133;11897;20763.58472830565;20806.895965520074;20859.165633374494;20894.582108357747;20909.790902090783;8601.698940537051;8813.823723525622;8848.513331766815;8863.689770857989;9190.218831399272;4781.187198176319;4810.086083644096;4828.637852161102;4915.238138088602;4959.181735013754;3592.317459682652;3696.537932758405;3706.8517259309865;3707.962920370762;3711.925761484755;608.9299730530958;615.3692465223182;663.8274048747361;704.4610872682402;711.5659447736876;758.135725273189;771.1286246541372;776.3595034096779;781.144646611959;790.067720090299;9972.900270997343;10081.572265429642;10273.794524109477;10555.894441055645;10811.35131892089;683.8871586188322;718.7196993172666;724.3648182647033;745.8284594543286;754.2156157596039;4817.373741413664;4925;5241.73791310433;5294.444083371268;5316.627836051439;96645;98986.05069746485;100223;107790;131218;91336.54331728432;91609.54195228982;94639;94760.52619736857;96579.51710241544;53703.19445208325;54778.17832732512;77671;81969;82305;9950.303478756417;10015.048570385801;10177.84733229017;10194.341796203023;10413.323133996266;49906;50265;50353.244701330244;50957;51735;67943;70616.6469167651;72832.895888014;73595;74224;12108.394580270775;12243.632691019284;12249.448774804978;12568.37158142071;12952.227269104942;13639.113457625223;13833.584992450242;14005.789913151515;14414;14445.422183112558;13975.720485590027;14067.718645627236;14427.206503642401;14661.04703194289;15075.321610527772;13877.930610346884;14177.574672759834;14221.928890355895;14270.143791372551;14667.266636668337;13008.113981890625;13072.869271307545;13471.663208419868;13492.5277615283;13493.932530337679;10333.689989300334;10890.836637450602;10950.52779345876;10955.56177752881;11270.585430779329;11906.226095303777;11913.285202887855;11995.820062698893;12411.193272437262;12431.875681243071 10:24:15 INFO - PROCESS | 7483 | __end_tp_report 10:24:15 INFO - PROCESS | 7483 | __start_cc_report 10:24:15 INFO - PROCESS | 7483 | _x_x_mozilla_cycle_collect,1006 10:24:15 INFO - PROCESS | 7483 | __end_cc_report 10:24:15 INFO - PROCESS | 7483 | __startTimestamp1469726655921__endTimestamp 10:24:15 INFO - PROCESS | 7483 | 10:24:15 INFO - PROCESS | 7483 | ------- Summary: start ------- 10:24:15 INFO - PROCESS | 7483 | Number of tests: 6 10:24:15 INFO - PROCESS | 7483 | 10:24:15 INFO - PROCESS | 7483 | [#0] dojo.html Cycles:165 Average:5423.58 Median:5670.60 stddev:630.71 (11.1%) stddev-sans-first:605.13 10:24:15 INFO - PROCESS | 7483 | Values: 3074.9 3101.9 3114.7 3124.8 3138.2 5364.4 5372.5 5453.5 5457.9 5461.3 5379.2 5417.9 5529.9 5532.6 5583.4 4825.5 4903.6 4917.7 4967.6 5085.5 4981.0 5015.4 5029.2 5036.2 5042.6 4867.0 4887.6 4900.1 4924.5 5020.6 4858.7 4866.5 4868.0 4874.1 4978.1 4904.8 4918.3 4931.5 4947.2 4963.4 5285.9 5341.1 5405.1 5438.1 5461.9 5874.5 5916.7 5928.6 5929.5 5931.8 5923.1 5957.0 5960.6 5975.6 5978.3 5275.6 5353.7 5417.9 5547.6 5562.0 5950.9 5999.7 6004.2 6007.7 6008.7 5777.3 5796.3 5797.1 5802.1 5808.2 5714.1 5764.9 5813.5 5855.9 5908.5 5778.3 5819.9 5822.0 5853.5 5876.5 5761.5 5799.4 5822.1 5832.9 5839.6 4366.4 4383.1 4399.6 4450.3 4495.0 3914.8 3933.4 3955.1 3975.4 3997.6 5431.4 5432.8 5439.9 5440.2 5463.4 5576.2 5815.2 5827.3 5893.1 5925.9 5567.3 5591.7 5618.7 5630.0 5656.2 5111.2 5117.1 5125.5 5131.6 5190.8 5825.2 5926.1 5942.7 6128.4 6130.7 5810.0 5814.9 5822.4 5859.0 5877.8 5916.2 5921.0 5925.8 5925.9 5928.6 5554.5 5686.3 5689.5 5730.4 5748.3 5826.3 5879.1 5882.6 5913.4 5935.9 5753.2 5756.6 5764.3 5764.6 5766.2 5541.8 5685.3 5702.0 5718.3 5729.5 5739.9 5754.1 5759.5 5801.8 5808.6 5800.8 5815.4 5869.9 5873.6 5874.0 5429.1 5535.3 5550.0 5668.6 5670.6 10:24:15 INFO - PROCESS | 7483 | 10:24:15 INFO - PROCESS | 7483 | [#1] ext.html Cycles:180 Average:61650.98 Median:42704.18 stddev:126288.41 (295.7%) stddev-sans-first:126559.49 10:24:15 INFO - PROCESS | 7483 | Values: 597.5 610.9 631.1 638.1 649.6 30542.2 30985.5 44328.1 44940.3 45069.1 42590.0 47147.8 47518.8 47759.0 47812.3 8906.4 9055.7 9056.4 9057.7 9062.0 8806.4 8871.7 8895.5 8922.5 8937.2 8974.7 8999.1 8999.1 9015.6 9017.3 8943.6 8968.9 8982.6 8985.1 8986.1 8946.3 9018.2 9026.5 9028.1 9028.7 44104.1 44292.3 44371.3 44379.3 44406.6 3555.1 3624.9 3812.4 4003.5 4214.8 32563.7 33401.2 33575.8 33673.8 34129.5 4062.4 4292.6 4437.1 4464.0 4483.3 373065.0 375091.0 375513.0 376043.0 377352.0 34283.5 62714.7 62954.0 63366.4 63493.7 34874.5 36373.0 36406.6 36494.3 36622.3 13486.3 13642.3 13656.9 13661.0 13665.7 12363.6 12433.9 12445.4 12518.7 12549.4 8245.2 8261.2 8321.8 8374.1 8398.3 3191.2 3240.7 3269.8 3281.9 3326.2 989.4 1023.4 1055.9 1057.2 1107.9 32642.2 33124.2 33280.5 33528.4 33624.3 1120.3 1123.6 1127.8 1129.1 1130.0 16501.0 17669.8 17735.0 17780.2 17925.6 575857.0 587637.0 589257.0 589784.2 591096.0 61132.0 61739.4 61787.7 61802.7 62018.0 1205.5 1316.3 1332.3 1357.0 1369.0 30019.2 34432.7 34519.3 34531.2 34539.1 52684.0 53046.2 53271.7 53283.7 53395.0 435662.0 435892.0 436181.0 436329.0 436353.0 24899.9 27779.4 29112.6 29462.3 29516.0 45199.0 48672.0 49038.8 49585.0 50528.2 42181.8 42971.8 43696.3 44087.8 45314.8 42214.3 42598.0 43239.1 43504.6 43603.8 31947.7 41399.2 41932.8 42579.0 42810.4 34840.0 38555.4 38558.8 38570.2 38855.8 28414.0 28677.3 28683.3 28726.9 28775.0 10:24:15 INFO - PROCESS | 7483 | 10:24:15 INFO - PROCESS | 7483 | [#2] jquery.html Cycles:180 Average:29597.36 Median:383.30 stddev:84025.28 (21921.3%) stddev-sans-first:84232.32 10:24:15 INFO - PROCESS | 7483 | Values: 362.9 381.1 381.8 384.8 398.4 15767.6 17596.6 18024.6 19660.2 20223.0 18843.2 19272.4 19328.6 19347.7 19777.1 5643.3 5696.8 5858.9 5866.8 5898.7 6448.2 6461.5 6499.9 6536.2 6542.7 5603.4 5853.2 5895.8 6463.3 6465.8 5920.8 5938.5 5953.9 5958.3 5961.8 5599.8 5800.8 5829.2 5846.8 5848.9 13859.5 14019.9 18288.0 23121.2 23329.9 2364.8 2441.6 2537.3 2566.4 2687.1 9963.8 10294.1 10426.5 10500.4 10578.8 1914.6 1975.3 2012.9 2024.1 2035.3 80250.0 81656.8 81954.6 83757.0 85399.6 10448.5 10732.7 10738.6 11173.1 11188.6 15149.3 15167.8 15179.9 15195.0 15201.3 7637.6 8094.6 8147.9 8219.8 8220.6 7754.8 7816.9 7982.0 8000.8 8055.1 4553.6 4614.9 4674.1 4689.8 4790.7 1964.4 1979.7 1981.1 1993.2 1999.6 866.4 960.0 970.3 988.4 1088.6 19387.8 19952.8 20324.8 20586.7 20590.5 967.3 982.5 993.5 1015.7 1081.7 10814.2 11515.3 11540.3 11544.5 11547.0 501720.0 506727.0 508142.0 508330.0 522811.0 83582.6 93488.0 95365.8 97689.0 97786.6 938.1 976.8 995.3 1000.6 1002.6 17313.8 17642.4 18054.8 18095.7 18165.6 42650.9 43637.3 43697.8 43875.3 44724.6 55098.4 59223.0 60451.0 61106.7 61579.0 6132.0 7358.4 8328.4 8491.7 8637.0 9543.1 12531.8 12611.1 12707.9 13342.5 11014.8 11380.0 11511.9 11699.9 11835.9 10780.9 10836.7 11142.1 11208.2 11289.6 11716.8 11869.7 11896.7 11934.3 11964.2 7476.2 7599.7 7776.0 8013.7 8581.8 11659.7 11751.8 11838.9 11903.2 12118.9 10:24:15 INFO - PROCESS | 7483 | 10:24:15 INFO - PROCESS | 7483 | [#3] mootools.html Cycles:180 Average:6105.03 Median:2527.97 stddev:3570.16 (141.2%) stddev-sans-first:3561.87 10:24:15 INFO - PROCESS | 7483 | Values: 1293.5 1464.2 1522.8 1603.7 1764.6 8010.9 8884.3 9166.8 9182.4 9478.4 9250.2 9321.0 9323.5 9323.8 9324.6 2359.3 2380.3 2385.5 2386.6 2386.9 2308.5 2335.4 2370.5 2373.4 2376.9 2296.8 2327.7 2338.3 2393.4 2394.3 2276.6 2317.6 2325.4 2329.6 2341.2 2287.5 2296.2 2297.9 2299.4 2302.7 9348.8 9359.3 9421.5 9433.7 9439.2 5231.8 5393.7 5397.8 5404.4 5430.3 3410.7 3477.3 3494.7 3539.9 3573.1 1067.5 1077.1 2201.0 2258.1 2267.1 12960.5 13189.3 13233.3 13233.4 13240.2 4670.2 4727.9 4749.0 4787.6 4934.3 11122.4 11178.8 11183.9 11186.3 11188.4 5378.9 5385.7 5396.4 5399.3 5401.3 4189.2 4652.3 4844.3 4882.7 4971.0 4103.3 4126.8 4227.6 4252.7 4268.0 1272.7 1272.8 1280.5 1282.1 1283.5 898.3 945.2 953.9 964.1 1003.2 6050.5 6408.1 6412.5 6508.8 6642.3 432.6 440.0 444.0 452.2 452.6 4158.3 4345.1 4400.0 4512.8 4603.3 11849.5 11873.4 11944.2 12006.8 12029.3 11872.8 11891.5 11895.5 11897.9 11903.5 8103.6 8484.2 8502.0 8692.3 8695.7 6129.2 6197.6 6200.1 6247.1 6348.9 10631.0 10679.7 10804.3 10804.6 10911.8 11133.1 11204.0 11289.2 11298.8 11299.9 7385.0 7617.6 7620.8 7835.8 8056.6 8377.3 8623.3 8889.5 8953.2 9226.4 7747.9 7853.8 8004.6 8042.2 8192.3 7775.8 7828.8 7892.6 7899.2 7958.6 7188.4 7287.1 7288.9 7292.0 7292.9 5375.0 5504.6 5526.1 5553.9 5743.4 5528.6 5531.1 5605.6 5699.6 5770.5 10:24:15 INFO - PROCESS | 7483 | 10:24:15 INFO - PROCESS | 7483 | [#4] prototype.html Cycles:180 Average:4633.68 Median:5249.21 stddev:1347.40 (25.7%) stddev-sans-first:1311.93 10:24:15 INFO - PROCESS | 7483 | Values: 332.6 335.3 342.4 343.1 343.2 5353.4 5380.1 5439.2 5460.5 5471.2 5329.4 5350.8 5394.2 5439.1 5439.2 3730.9 4029.4 4078.3 4133.5 4225.9 4200.9 4205.7 4208.1 4216.6 4221.8 4170.7 4178.9 4193.4 4218.2 4234.6 4023.8 4133.2 4189.3 4243.9 4266.6 3729.3 3736.5 3739.2 3761.6 3768.5 5241.6 5266.8 5283.5 5285.0 5320.1 4704.4 4801.0 4806.4 4811.6 4836.8 5507.6 5515.0 5524.0 5524.5 5585.8 4102.5 4114.8 4121.5 4123.7 4126.6 5600.6 5726.9 5733.7 5852.4 5861.9 4130.6 4145.3 4152.8 4159.8 4165.7 4195.3 4236.8 4246.0 4258.6 4264.2 4659.9 4816.0 4821.7 4822.0 4829.3 5562.5 5573.9 5575.6 5642.0 5686.3 1443.7 1467.9 1470.7 1473.5 1477.4 908.5 932.8 934.0 938.2 961.8 4771.0 4801.9 4804.4 4830.0 4848.4 5048.8 5063.9 5079.5 5083.8 5088.7 4552.3 4757.6 4799.7 4825.3 4865.0 2673.9 2678.4 2706.5 2726.6 2739.8 5230.3 5256.8 5271.6 5277.9 5311.3 4805.9 5161.8 5179.7 5198.4 5526.3 5777.6 5834.3 5902.7 5916.6 5932.4 5728.5 5738.0 5759.5 5776.7 5785.4 5500.7 5657.4 5678.3 5681.8 5712.6 5860.5 5907.5 5910.8 5913.2 5923.6 4193.6 4199.1 4207.3 4207.7 4211.6 5527.4 5669.5 5691.3 5695.5 5708.1 5560.6 5582.8 5583.7 5625.6 5649.4 5339.5 5527.2 5635.5 5669.2 5670.9 5524.3 5542.7 5547.4 5552.6 5558.6 5595.3 5620.7 5666.9 5667.7 5684.7 5282.3 5424.7 5475.6 5476.6 5499.2 10:24:15 INFO - PROCESS | 7483 | 10:24:15 INFO - PROCESS | 7483 | [#5] yui.html Cycles:180 Average:20309.97 Median:4748.72 stddev:28335.76 (596.7%) stddev-sans-first:28377.35 10:24:15 INFO - PROCESS | 7483 | Values: 792.3 796.5 807.3 813.0 895.8 15445.2 16177.4 16190.8 16197.8 16208.4 15075.5 15385.2 15389.6 15393.2 15393.3 663.2 675.4 678.1 681.2 792.6 821.5 828.1 828.3 828.3 828.5 871.6 880.0 883.1 883.9 884.0 878.5 878.7 878.8 878.8 879.1 512.4 615.5 641.1 642.5 642.5 14787.2 15306.3 15397.2 15400.8 15413.4 14320.4 14508.2 14825.4 14859.6 15064.9 13591.9 13815.7 13836.1 13889.1 13925.4 4422.6 4465.2 4572.9 4614.2 4716.2 81996.6 83415.2 84951.0 84967.0 85546.1 11594.7 11599.4 11704.7 11719.4 11897.0 20763.6 20806.9 20859.2 20894.6 20909.8 8601.7 8813.8 8848.5 8863.7 9190.2 4781.2 4810.1 4828.6 4915.2 4959.2 3592.3 3696.5 3706.9 3708.0 3711.9 608.9 615.4 663.8 704.5 711.6 758.1 771.1 776.4 781.1 790.1 9972.9 10081.6 10273.8 10555.9 10811.4 683.9 718.7 724.4 745.8 754.2 4817.4 4925.0 5241.7 5294.4 5316.6 96645.0 98986.1 100223.0 107790.0 131218.0 91336.5 91609.5 94639.0 94760.5 96579.5 53703.2 54778.2 77671.0 81969.0 82305.0 9950.3 10015.0 10177.8 10194.3 10413.3 49906.0 50265.0 50353.2 50957.0 51735.0 67943.0 70616.6 72832.9 73595.0 74224.0 12108.4 12243.6 12249.4 12568.4 12952.2 13639.1 13833.6 14005.8 14414.0 14445.4 13975.7 14067.7 14427.2 14661.0 15075.3 13877.9 14177.6 14221.9 14270.1 14667.3 13008.1 13072.9 13471.7 13492.5 13493.9 10333.7 10890.8 10950.5 10955.6 11270.6 11906.2 11913.3 11995.8 12411.2 12431.9 10:24:15 INFO - PROCESS | 7483 | -------- Summary: end -------- 10:24:15 INFO - PROCESS | 7483 | 10:24:16 INFO - TEST-INFO | 7483: exit 0 10:24:16 INFO - TEST-OK | dromaeo_css | took 1114920ms 10:24:16 INFO - TEST-START | kraken 10:24:16 INFO - operating with platform_type : linux_ 10:24:16 INFO - Initialising browser for kraken test... 10:24:16 INFO - TEST-INFO | started process 7675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIagEnO/profile http://localhost:48224/getInfo.html) 10:24:20 INFO - PROCESS | 7675 | JavaScript error: , line 0: uncaught exception: undefined 10:24:21 INFO - PROCESS | 7675 | __metrics Screen width/height:1600/1200 10:24:21 INFO - PROCESS | 7675 | colorDepth:24 10:24:21 INFO - PROCESS | 7675 | Browser inner width/height: 1024/697 10:24:21 INFO - PROCESS | 7675 | __metrics 10:24:22 INFO - PROCESS | 7675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:24:22 INFO - PROCESS | 7675 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:24:23 INFO - TEST-INFO | 7675: exit 0 10:24:23 INFO - Browser initialized. 10:24:23 INFO - Running cycle 1/1 for kraken test... 10:24:23 INFO - TEST-INFO | started process 7759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIagEnO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:35 INFO - PROCESS | 7759 | RSS: Main: 157741056 10:24:35 INFO - PROCESS | 7759 | 10:24:37 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48224/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:38 INFO - PROCESS | 7759 | RSS: Main: 214417408 10:24:38 INFO - PROCESS | 7759 | 10:24:41 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48224/tests/kraken/driver.html?testName=audio-dft) 10:24:41 INFO - PROCESS | 7759 | RSS: Main: 193327104 10:24:41 INFO - PROCESS | 7759 | 10:24:45 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48224/tests/kraken/driver.html?testName=audio-fft) 10:24:45 INFO - PROCESS | 7759 | RSS: Main: 271519744 10:24:45 INFO - PROCESS | 7759 | 10:24:47 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48224/tests/kraken/driver.html?testName=audio-oscillator) 10:24:48 INFO - PROCESS | 7759 | RSS: Main: 181260288 10:24:48 INFO - PROCESS | 7759 | 10:24:50 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48224/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:51 INFO - PROCESS | 7759 | RSS: Main: 186298368 10:24:51 INFO - PROCESS | 7759 | 10:24:54 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48224/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:54 INFO - PROCESS | 7759 | RSS: Main: 220565504 10:24:54 INFO - PROCESS | 7759 | 10:24:58 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48224/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:58 INFO - PROCESS | 7759 | RSS: Main: 221548544 10:24:58 INFO - PROCESS | 7759 | 10:25:01 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48224/tests/kraken/driver.html?testName=json-parse-financial) 10:25:02 INFO - PROCESS | 7759 | RSS: Main: 221319168 10:25:02 INFO - PROCESS | 7759 | 10:25:03 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48224/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:04 INFO - PROCESS | 7759 | RSS: Main: 185683968 10:25:04 INFO - PROCESS | 7759 | 10:25:05 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48224/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:06 INFO - PROCESS | 7759 | RSS: Main: 190275584 10:25:06 INFO - PROCESS | 7759 | 10:25:08 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48224/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:09 INFO - PROCESS | 7759 | RSS: Main: 195284992 10:25:09 INFO - PROCESS | 7759 | 10:25:11 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:12 INFO - PROCESS | 7759 | RSS: Main: 189509632 10:25:12 INFO - PROCESS | 7759 | 10:25:15 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:15 INFO - PROCESS | 7759 | RSS: Main: 194068480 10:25:15 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | Cycle 1(1): loaded http://localhost:48224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48224/tests/kraken/driver.html?testName=ai-astar) 10:25:17 INFO - PROCESS | 7759 | RSS: Main: 244477952 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | __start_tp_report 10:25:17 INFO - PROCESS | 7759 | _x_x_mozilla_page_load 10:25:17 INFO - PROCESS | 7759 | _x_x_mozilla_page_load_details 10:25:17 INFO - PROCESS | 7759 | |i|pagename|runs| 10:25:17 INFO - PROCESS | 7759 | |0;ai-astar;103;111;110;110;112;111;111;112;110;110 10:25:17 INFO - PROCESS | 7759 | |1;audio-beat-detection;139;116;122;174;116;119;139;117;157;118 10:25:17 INFO - PROCESS | 7759 | |2;audio-dft;161;161;161;161;160;162;163;159;162;163 10:25:17 INFO - PROCESS | 7759 | |3;audio-fft;75;75;76;124;76;76;74;74;103;74 10:25:17 INFO - PROCESS | 7759 | |4;audio-oscillator;83;84;117;82;83;84;123;83;82;127 10:25:17 INFO - PROCESS | 7759 | |5;imaging-gaussian-blur;116;117;117;117;118;117;116;117;116;117 10:25:17 INFO - PROCESS | 7759 | |6;imaging-darkroom;146;147;145;147;147;146;146;147;147;147 10:25:17 INFO - PROCESS | 7759 | |7;imaging-desaturate;96;95;95;95;95;95;94;95;95;95 10:25:17 INFO - PROCESS | 7759 | |8;json-parse-financial;53;53;53;52;53;53;54;53;51;52 10:25:17 INFO - PROCESS | 7759 | |9;json-stringify-tinderbox;62;63;63;62;63;62;62;62;62;62 10:25:17 INFO - PROCESS | 7759 | |10;stanford-crypto-aes;76;75;75;76;81;76;75;74;83;79 10:25:17 INFO - PROCESS | 7759 | |11;stanford-crypto-ccm;128;135;118;119;128;138;128;115;165;131 10:25:17 INFO - PROCESS | 7759 | |12;stanford-crypto-pbkdf2;162;164;160;161;156;158;160;157;159;166 10:25:17 INFO - PROCESS | 7759 | |13;stanford-crypto-sha256-iterative;63;63;64;64;64;63;66;64;63;63 10:25:17 INFO - PROCESS | 7759 | __end_tp_report 10:25:17 INFO - PROCESS | 7759 | __start_cc_report 10:25:17 INFO - PROCESS | 7759 | _x_x_mozilla_cycle_collect,1759 10:25:17 INFO - PROCESS | 7759 | __end_cc_report 10:25:17 INFO - PROCESS | 7759 | __startTimestamp1469726717630__endTimestamp 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | ------- Summary: start ------- 10:25:17 INFO - PROCESS | 7759 | Number of tests: 14 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.58 (2.3%) stddev-sans-first:0.83 10:25:17 INFO - PROCESS | 7759 | Values: 103.0 111.0 110.0 110.0 112.0 111.0 111.0 112.0 110.0 110.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:130.50 stddev:20.24 (15.5%) stddev-sans-first:21.30 10:25:17 INFO - PROCESS | 7759 | Values: 139.0 116.0 122.0 174.0 116.0 119.0 139.0 117.0 157.0 118.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 10:25:17 INFO - PROCESS | 7759 | Values: 161.0 161.0 161.0 161.0 160.0 162.0 163.0 159.0 162.0 163.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.00 stddev:16.99 (22.7%) stddev-sans-first:17.79 10:25:17 INFO - PROCESS | 7759 | Values: 75.0 75.0 76.0 124.0 76.0 76.0 74.0 74.0 103.0 74.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:83.00 stddev:19.16 (23.1%) stddev-sans-first:19.84 10:25:17 INFO - PROCESS | 7759 | Values: 83.0 84.0 117.0 82.0 83.0 84.0 123.0 83.0 82.0 127.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 10:25:17 INFO - PROCESS | 7759 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 116.0 117.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 10:25:17 INFO - PROCESS | 7759 | Values: 146.0 147.0 145.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 10:25:17 INFO - PROCESS | 7759 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 10:25:17 INFO - PROCESS | 7759 | Values: 53.0 53.0 53.0 52.0 53.0 53.0 54.0 53.0 51.0 52.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 10:25:17 INFO - PROCESS | 7759 | Values: 62.0 63.0 63.0 62.0 63.0 62.0 62.0 62.0 62.0 62.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.00 stddev:2.98 (3.9%) stddev-sans-first:3.14 10:25:17 INFO - PROCESS | 7759 | Values: 76.0 75.0 75.0 76.0 81.0 76.0 75.0 74.0 83.0 79.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:129.50 stddev:14.20 (11.0%) stddev-sans-first:15.03 10:25:17 INFO - PROCESS | 7759 | Values: 128.0 135.0 118.0 119.0 128.0 138.0 128.0 115.0 165.0 131.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.50 stddev:3.09 (1.9%) stddev-sans-first:3.22 10:25:17 INFO - PROCESS | 7759 | Values: 162.0 164.0 160.0 161.0 156.0 158.0 160.0 157.0 159.0 166.0 10:25:17 INFO - PROCESS | 7759 | 10:25:17 INFO - PROCESS | 7759 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:0.95 (1.5%) stddev-sans-first:0.97 10:25:17 INFO - PROCESS | 7759 | Values: 63.0 63.0 64.0 64.0 64.0 63.0 66.0 64.0 63.0 63.0 10:25:17 INFO - PROCESS | 7759 | -------- Summary: end -------- 10:25:17 INFO - PROCESS | 7759 | 10:25:18 INFO - TEST-INFO | 7759: exit 0 10:25:18 INFO - TEST-OK | kraken | took 61945ms 10:25:18 INFO - SUITE-END | took 1176s 10:25:18 INFO - Completed test suite (00:19:36) 10:25:18 INFO - javascript benchmark 10:25:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.908407515332, 3101.8914337998176, 3114.7041031102053, 3124.828134452604, 3138.2468207630177, 5364.383095943967, 5372.462753724625, 5453.481919217673, 5457.945420545793, 5461.344638643368, 5379.220013098108, 5417.918731219035, 5529.944700552994, 5532.612717109804, 5583.3858275589755, 4825.517448255173, 4903.558679718824, 4917.704937703731, 4967.577755890736, 5085.491450854922, 4980.950190498103, 5015.423226328982, 5029.195328747401, 5036.244563315514, 5042.647014708972, 4866.951330486703, 4887.584555312803, 4900.142475066885, 4924.458309585961, 5020.648554601179, 4858.684185527929, 4866.537678920497, 4867.951320486785, 4874.122657921573, 4978.054169707781, 4904.828331008433, 4918.262260660894, 4931.506849315076, 4947.233178857283, 4963.379577552806, 5285.920711189336, 5341.0653135701095, 5405.135178371481, 5438.075527160392, 5461.890762184774, 5874.530037596982, 5916.704164791743, 5928.614640048426, 5929.495992840613, 5931.762729490858, 5923.141144534018, 5957.0, 5960.582759206857, 5975.611585246945, 5978.342382337939, 5275.57795376369, 5353.6787792732175, 5417.891642167135, 5547.639403438763, 5562.0, 5950.940490595125, 5999.670018148957, 6004.219451471368, 6007.699615019232, 6008.66952317618, 5777.335606405233, 5796.333421656479, 5797.072468405035, 5802.071668533014, 5808.244928159397, 5714.05718056516, 5764.942350576441, 5813.476787089182, 5855.912161317584, 5908.527317814564, 5778.27771528559, 5819.941800582024, 5822.039363504974, 5853.502452291603, 5876.500497457764, 5761.481466667936, 5799.3620701722775, 5822.0684690449325, 5832.883342333214, 5839.620424672383, 4366.388705581221, 4383.145286669069, 4399.560043995639, 4450.310201918708, 4494.977525112354, 3914.8434062637175, 3933.449317095609, 3955.0903292242947, 3975.363941769303, 3997.620226078518, 5431.375391829911, 5432.782688692487, 5439.864003399946, 5440.211169380417, 5463.426340234298, 5576.163575463713, 5815.156802263648, 5827.271591051119, 5893.14549390336, 5925.940740592625, 5567.276254086943, 5591.664500130005, 5618.747156377973, 5630.0, 5656.236408084938, 5111.182210846247, 5117.1045067113855, 5125.538701516882, 5131.640785145004, 5190.792368305301, 5825.1844741736195, 5926.051831706906, 5942.70286485674, 6128.448439640454, 6130.724117414727, 5810.0, 5814.854628634318, 5822.359540450631, 5859.0, 5877.764889404376, 5916.201312822714, 5920.993431116634, 5925.822225333247, 5925.851853703692, 5928.584999050025, 5554.472325129106, 5686.2607860977805, 5689.459501347365, 5730.398308177581, 5748.310202775694, 5826.329972053099, 5879.059350503899, 5882.558808089325, 5913.408659134052, 5935.940640593539, 5753.1945527627, 5756.56825738063, 5764.279465066867, 5764.625299355528, 5766.192733017465, 5541.750621221974, 5685.317761868602, 5701.971490142523, 5718.3423906249645, 5729.4843464088435, 5739.856503587277, 5754.108113242454, 5759.539236861125, 5801.825945221482, 5808.5643576732755, 5800.796972105956, 5815.447532484407, 5869.853253668693, 5873.647581145145, 5874.0, 5429.131338985743, 5535.308086489189, 5549.972250138885, 5668.603197776116, 5670.603057785916], "value": 5379.741811836737, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.4921316880652, 610.8625559249169, 631.0565704272113, 638.1034646321916, 649.610233859684, 30542.23644408891, 30985.535216971763, 44328.11343773126, 44940.32589511152, 45069.0986180277, 42590.0, 47147.76426117864, 47518.762406188005, 47759.0, 47812.2828157577, 8906.376553641265, 9055.728328150166, 9056.41133326335, 9057.682981095662, 9062.0, 8806.427582207169, 8871.733847984571, 8895.4662720237, 8922.464652120862, 8937.150970657776, 8974.685885993991, 8999.055099214587, 8999.145081217273, 9015.639374425014, 9017.278617710568, 8943.552822358855, 8968.910310896872, 8982.595783189772, 8985.146411090936, 8986.056464071244, 8946.329025323126, 9018.188363047291, 9026.50354230517, 9028.097190280985, 9028.683996060172, 44104.117917641466, 44292.3356149658, 44371.33442998357, 44379.334309985374, 44406.55593444056, 3555.1467647764607, 3624.873129440457, 3812.3519001769764, 4003.4795476587856, 4214.810333534998, 32563.6743632563, 33401.16497087568, 33575.832120839485, 33673.83163084193, 34129.488057679155, 4062.3906414037833, 4292.635126014293, 4437.090396468716, 4463.955360446386, 4483.260262056757, 373065.0, 375091.0, 375513.0, 376043.0, 377352.0, 34283.48574771381, 62714.686426567576, 62954.0, 63366.36633633605, 63493.682531587045, 34874.47688284678, 36373.0, 36406.635933640326, 36494.27011459756, 36622.26755464876, 13486.258255796025, 13642.317884105754, 13656.931715341558, 13661.0, 13665.658358540917, 12363.567275145328, 12433.875661243454, 12445.37773111359, 12518.687032824253, 12549.372531373394, 8245.216704413071, 8261.17388261169, 8321.791955201048, 8374.078851326349, 8398.328133749286, 3191.1702957230823, 3240.6759324067407, 3269.7547683923326, 3281.917952051218, 3326.185084654275, 989.4113002763488, 1023.4473384372504, 1055.9472026398803, 1057.1859668055554, 1107.9058280046286, 32642.183945401554, 33124.1718957028, 33280.500792488136, 33528.4089209695, 33624.32751344959, 1120.2662256222188, 1123.6291724096588, 1127.785720713062, 1129.1249281806665, 1129.9943500282611, 16501.0, 17669.809400398066, 17735.0, 17780.199891004937, 17925.551861203574, 575857.0, 587637.0, 589257.0, 589784.1532377017, 591096.0, 61132.0, 61739.38260617336, 61787.69106154441, 61802.69098654568, 62018.0, 1205.5238180918489, 1316.27604817352, 1332.320516536554, 1356.9796453053211, 1368.9794653080012, 30019.24951876133, 34432.65567344295, 34519.30961380708, 34531.202382082665, 34539.13652158716, 52684.0, 53046.204306934655, 53271.73364133154, 53283.73358133184, 53395.0, 435662.0, 435892.0, 436181.0, 436329.0, 436353.0, 24899.875500623104, 27779.44441111207, 29112.56331154992, 29462.263443414085, 29516.0, 45199.0, 48672.0, 49038.75480622574, 49585.0, 50528.24207636815, 42181.78909105435, 42971.78514107534, 43696.344554832336, 44087.77956110199, 45314.773426132655, 42214.288204040764, 42598.0, 43239.13521729485, 43504.56495435132, 43603.781981089895, 31947.68052319447, 41399.1720165601, 41932.79033604812, 42579.0, 42810.35784463173, 34840.0, 38555.42166867555, 38558.80720596379, 38570.228595427376, 38855.80572097121, 28414.0, 28677.28306792347, 28683.28291792722, 28726.85636571804, 28775.0], "value": 19237.454414304113, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.8639260277396, 381.1481339206873, 381.8243607940347, 384.78452066842567, 398.418309268468, 15767.60580985476, 17596.56008599784, 18024.639507209864, 19660.21359145636, 20223.0, 18843.152058157382, 19272.421827345166, 19328.613427731438, 19347.709784353247, 19777.110030048647, 5643.294588176478, 5696.800611978592, 5858.853528661775, 5866.823995280127, 5898.705064746767, 6448.193975753031, 6461.515386346019, 6499.9350006500035, 6536.215654121512, 6542.738290468375, 5603.411641777616, 5853.209816674737, 5895.793647222348, 6463.25672547656, 6465.838354041163, 5920.822375328747, 5938.495227905633, 5953.910691339612, 5958.285005799288, 5961.791337303173, 5599.776008959678, 5800.7679692812235, 5829.242198514166, 5846.766129354821, 5848.912266316009, 13859.514916977958, 14019.859801401957, 18288.0, 23121.190758323548, 23329.88335058331, 2364.775346342095, 2441.584930561809, 2537.3402915241986, 2566.358410397401, 2687.072959828856, 9963.800723985552, 10294.124999375063, 10426.530806113667, 10500.422476763775, 10578.824375337084, 1914.6457905287566, 1975.259277770836, 2012.8892910889895, 2024.0790440349606, 2035.328341647253, 80250.0, 81656.77514837282, 81954.59022704908, 83757.0, 85399.5730021352, 10448.477576121315, 10732.678019659423, 10738.570457181626, 11173.10615150786, 11188.608398706006, 15149.318280677397, 15167.848321516864, 15179.924100379427, 15195.0, 15201.315940782692, 7637.579933103621, 8094.554799485967, 8147.9185208147155, 8219.753407397788, 8220.63007164679, 7754.7673569793, 7816.921830781733, 7982.0, 8000.8398782176255, 8055.113937466874, 4553.635709143261, 4614.930776038362, 4674.111918735497, 4689.7655117244, 4790.688605240648, 1964.430315208602, 1979.6832506798844, 1981.118402310958, 1993.2226431691652, 1999.6300684373437, 866.3978534918298, 959.9664011759555, 970.3401686852867, 988.3593235229484, 1088.6189833558192, 19387.806121938884, 19952.800471995386, 20324.79675203229, 20586.691199632016, 20590.485237869172, 967.2842096848282, 982.4841957972122, 993.478423827482, 1015.6699072801222, 1081.70793885652, 10814.188935829845, 11515.25150865191, 11540.307581545134, 11544.480498377594, 11547.0, 501720.0, 506727.0, 508142.0, 508330.0, 522811.0, 83582.58208708918, 93488.0, 95365.75488348208, 97689.0, 97786.64386814834, 938.1134827588, 976.7558110472382, 995.2784231432298, 1000.5747557287978, 1002.6190047781796, 17313.826861731726, 17642.38251661186, 18054.819451805313, 18095.728564071287, 18165.636687265916, 42650.8818941729, 43637.345439819066, 43697.78151109224, 43875.34186987262, 44724.55275447204, 55098.44901550933, 59223.0, 60451.0, 61106.694466527384, 61579.0, 6131.96934015345, 7358.411327093712, 8328.375371847014, 8491.702790402307, 8637.0, 9543.141117299476, 12531.812022819482, 12611.117221794753, 12707.872921271039, 13342.533011344945, 11014.779704405706, 11380.03269722083, 11511.942440287745, 11699.88300117022, 11835.881641183478, 10780.946095269474, 10836.729081773019, 11142.052925501423, 11208.215424920178, 11289.604863829727, 11716.765664686829, 11869.703257418289, 11896.702582435508, 11934.283942963102, 11964.162508624313, 7476.177620461636, 7599.734009309647, 7775.961120194589, 8013.6794528218215, 8581.785455363666, 11659.650210493699, 11751.823722643996, 11838.940805295919, 11903.226290291102, 12118.939405302917], "value": 9220.820589873223, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.5020017293339, 1464.1507925403266, 1522.8172619285683, 1603.7113319602468, 1764.5500397398662, 8010.879836802445, 8884.289256859453, 9166.770830729236, 9182.449053056804, 9478.431294122358, 9250.213731832786, 9321.0, 9323.487208203545, 9323.813523729521, 9324.580393882274, 2359.315798418461, 2380.3454050136265, 2385.5467461182407, 2386.6181410974245, 2386.904523819054, 2308.4575124845646, 2335.392797872557, 2370.514044620857, 2373.371056669984, 2376.9049238030457, 2296.781805728453, 2327.7206735191717, 2338.2634470141934, 2393.4375421775867, 2394.2577800881695, 2276.6129757941026, 2317.582835089683, 2325.360525855386, 2329.5690297295055, 2341.1922886604093, 2287.5424915016897, 2296.2307626944994, 2297.9425514362106, 2299.413649519362, 2302.6661134135625, 9348.813023739487, 9359.251259899193, 9421.48181849998, 9433.716988490356, 9439.24486041115, 5231.8168864089575, 5393.6763794172475, 5397.757100930428, 5404.378496472917, 5430.321209848769, 3410.693037626601, 3477.3393055319407, 3494.650534946485, 3539.94690079649, 3573.0531409176588, 1067.546292825546, 1077.1490522487304, 2200.9779902200935, 2258.0967612954787, 2267.0931627349028, 12960.546380876624, 13189.340532973312, 13233.338333083404, 13233.404496797571, 13240.20558766477, 4670.182718024332, 4727.858164255009, 4748.953244070052, 4787.640926930494, 4934.284528743312, 11122.44387780624, 11178.776424471465, 11183.888161118284, 11186.272892261977, 11188.440577971069, 5378.946210537844, 5385.7307134643115, 5396.3524377075, 5399.2980912481125, 5401.3248343957, 4189.2040512302565, 4652.348671186037, 4844.32179494871, 4882.707037577686, 4971.0, 4103.297131690315, 4126.793660316972, 4227.619514243733, 4252.681048921343, 4268.039691069484, 1272.7136394311392, 1272.7963525835821, 1280.507004803139, 1282.1025282302426, 1283.4673610451557, 898.2948385517337, 945.2485274207022, 953.9236861051099, 964.0889359555154, 1003.19744204636, 6050.547868511526, 6408.070829729663, 6412.487001039905, 6508.772192973223, 6642.269350371455, 432.62145622580243, 439.9736015838996, 444.02979489814857, 452.2424938228454, 452.60623257765957, 4158.272302347077, 4345.087531618396, 4399.978000110043, 4512.796924138422, 4603.332516785047, 11849.466773995191, 11873.406329683654, 11944.223625464318, 12006.75986480283, 12029.338386388832, 11872.821907671392, 11891.524339026515, 11895.464704088337, 11897.88102118985, 11903.523859045714, 8103.594820258963, 8484.151584841466, 8501.957490212633, 8692.261157801531, 8695.652173913099, 6129.233845769279, 6197.597156184834, 6200.131981522681, 6247.12540244357, 6348.873022539616, 10631.0, 10679.733006674895, 10804.297720648447, 10804.567817287221, 10911.78176436451, 11133.053690436403, 11203.99164075237, 11289.20975531705, 11298.83051754208, 11299.887001130212, 7385.03994480714, 7617.619119043915, 7620.80947976305, 7835.84328313442, 8056.637451314822, 8377.28793052573, 8623.310135189295, 8889.4666320021, 8953.194212520904, 9226.35415520907, 7747.883781743166, 7853.764387068169, 8004.599770011359, 8042.235987581171, 8192.303654189222, 7775.805604859924, 7828.84342313162, 7892.644830982735, 7899.249571290718, 7958.602069896367, 7188.424926005802, 7287.12554493443, 7288.927110728825, 7292.0, 7292.890606641011, 5374.973125134506, 5504.587155963399, 5526.115821468546, 5553.861153471195, 5743.4256574342235, 5528.612997090326, 5531.1426728857095, 5605.5515558756015, 5699.572532060195, 5770.451807078321], "value": 4776.908921790806, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.5610194543203, 335.3410548272644, 342.41276211297617, 343.11818626130844, 343.20205522160984, 5353.411124776271, 5380.112281473557, 5439.211314359421, 5460.453954604538, 5471.151971444422, 5329.440408757083, 5350.839474815752, 5394.217838413428, 5439.129739241722, 5439.156930675742, 3730.9067273318115, 4029.355303151496, 4078.327076032466, 4133.462649855514, 4225.873223803291, 4200.852970146046, 4205.663546916239, 4208.095259519203, 4216.620504154641, 4221.810018549158, 4170.749755014694, 4178.937315940263, 4193.35003074524, 4218.228344095472, 4234.640055595262, 4023.758574485511, 4133.152703695735, 4189.2668782962855, 4243.936340954888, 4266.637335826458, 3729.272791805599, 3736.4955730976512, 3739.2147648993746, 3761.6426439488205, 3768.4535742317485, 5241.606879484016, 5266.815661451869, 5283.494204151798, 5284.973575132138, 5320.122179840322, 4704.411948506437, 4800.975995120037, 4806.447258565275, 4811.566958973674, 4836.758162091881, 5507.5593952483705, 5515.034868897927, 5524.0, 5524.502794748492, 5585.8269763349745, 4102.5076990761, 4114.835406583733, 4121.5466298707415, 4123.670106391512, 4126.607972242632, 5600.6079574429805, 5726.942730572724, 5733.741981610838, 5852.4147585241135, 5861.886241614122, 4130.574951641679, 4145.274576949082, 4152.771597562102, 4159.817739429339, 4165.729227600196, 4195.328747400462, 4236.792514133457, 4245.97877010613, 4258.595433433881, 4264.211120942636, 4659.906801863944, 4815.951840481621, 4821.710697358169, 4821.975890120527, 4829.251466022772, 5562.471565201299, 5573.916391254134, 5575.553955683536, 5642.0, 5686.346070201897, 1443.6607397261635, 1467.8532146785235, 1470.6543962168882, 1473.4916453823414, 1477.3573495529479, 908.4519500638302, 932.8227636748996, 933.9906600933904, 938.1603464899014, 961.7691753978995, 4771.0, 4801.879953001203, 4804.399450068741, 4829.95170048302, 4848.448496481092, 5048.848534543969, 5063.8987220255385, 5079.517445842639, 5083.779892825769, 5088.6946783193125, 4552.317152427162, 4757.644071439623, 4799.680087975835, 4825.276208568673, 4865.0, 2673.893044278246, 2678.383971686484, 2706.499297629945, 2726.6319046928807, 2739.8082134250412, 5230.320058392384, 5256.816011439581, 5271.551918087006, 5277.868053298622, 5311.273836003237, 4805.8946442318465, 5161.799684195747, 5179.715115668674, 5198.402183748917, 5526.281583394133, 5777.566682498829, 5834.299884013945, 5902.7343769531335, 5916.556258280646, 5932.4364185401455, 5728.513076388554, 5737.971310143423, 5759.481646651821, 5776.740046697824, 5785.392533783892, 5500.724963751876, 5657.377688454185, 5678.346990096192, 5681.829545113488, 5712.571557133148, 5860.531157507475, 5907.4683278505145, 5910.822675319747, 5913.172155898264, 5923.614965027259, 4193.559676234074, 4199.118185181146, 4207.326827707552, 4207.726497777635, 4211.620954114144, 5527.44725527444, 5669.461401166883, 5691.3170419549915, 5695.544356451391, 5708.058170401837, 5560.638558493685, 5582.804601838916, 5583.69289689071, 5625.606207565595, 5649.378568357395, 5339.492748188916, 5527.226188333717, 5635.520980716685, 5669.234653321913, 5670.9432905672065, 5524.33707955048, 5542.72286385671, 5547.4175211603815, 5552.639078459887, 5558.583106266965, 5595.272614560081, 5620.662760234399, 5666.858328541654, 5667.688277144796, 5684.687342196054, 5282.3132992712235, 5424.701641409602, 5475.589330800126, 5476.589255805751, 5499.202615620793], "value": 4207.178940120027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.3423558446486, 796.4942261663844, 807.297651043592, 813.0365516862519, 895.7894894699748, 15445.227738613066, 16177.433789817358, 16190.75713864293, 16197.757033644504, 16208.432704855333, 15075.472358467456, 15385.230738463088, 15389.615259618487, 15393.230338483087, 15393.307301171446, 663.2372771312993, 675.3820254467157, 678.0879716780922, 681.17237556369, 792.6433105102727, 821.5153059694779, 828.1470085811624, 828.295948443821, 828.3207769628907, 828.4697793412221, 871.6426265231256, 879.973600791974, 883.1301168349171, 883.8630012348096, 883.9867401988976, 878.4904755241944, 878.6924576398274, 878.7583414561046, 878.8022694893693, 879.0945326313907, 512.4030504462297, 615.5106690181271, 641.0608458608115, 642.4828013449171, 642.5181114164377, 14787.186704731235, 15306.311215995307, 15397.153156576383, 15400.768988465183, 15413.3834646614, 14320.35558399864, 14508.170138455782, 14825.406983720639, 14859.554213373616, 15064.924675376662, 13591.932040339834, 13815.723685526335, 13836.100653457494, 13889.097208681404, 13925.373358198804, 4422.579854913778, 4465.218586747306, 4572.9314060289125, 4614.238650622643, 4716.2454007359, 81996.59001704953, 83415.16584834135, 84951.0, 84967.0, 85546.14453855444, 11594.710132246593, 11599.420028998516, 11704.70738231534, 11719.355435451133, 11897.0, 20763.58472830565, 20806.895965520074, 20859.165633374494, 20894.582108357747, 20909.790902090783, 8601.698940537051, 8813.823723525622, 8848.513331766815, 8863.689770857989, 9190.218831399272, 4781.187198176319, 4810.086083644096, 4828.637852161102, 4915.238138088602, 4959.181735013754, 3592.317459682652, 3696.537932758405, 3706.8517259309865, 3707.962920370762, 3711.925761484755, 608.9299730530958, 615.3692465223182, 663.8274048747361, 704.4610872682402, 711.5659447736876, 758.135725273189, 771.1286246541372, 776.3595034096779, 781.144646611959, 790.067720090299, 9972.900270997343, 10081.572265429642, 10273.794524109477, 10555.894441055645, 10811.35131892089, 683.8871586188322, 718.7196993172666, 724.3648182647033, 745.8284594543286, 754.2156157596039, 4817.373741413664, 4925.0, 5241.73791310433, 5294.444083371268, 5316.627836051439, 96645.0, 98986.05069746485, 100223.0, 107790.0, 131218.0, 91336.54331728432, 91609.54195228982, 94639.0, 94760.52619736857, 96579.51710241544, 53703.19445208325, 54778.17832732512, 77671.0, 81969.0, 82305.0, 9950.303478756417, 10015.048570385801, 10177.84733229017, 10194.341796203023, 10413.323133996266, 49906.0, 50265.0, 50353.244701330244, 50957.0, 51735.0, 67943.0, 70616.6469167651, 72832.895888014, 73595.0, 74224.0, 12108.394580270775, 12243.632691019284, 12249.448774804978, 12568.37158142071, 12952.227269104942, 13639.113457625223, 13833.584992450242, 14005.789913151515, 14414.0, 14445.422183112558, 13975.720485590027, 14067.718645627236, 14427.206503642401, 14661.04703194289, 15075.321610527772, 13877.930610346884, 14177.574672759834, 14221.928890355895, 14270.143791372551, 14667.266636668337, 13008.113981890625, 13072.869271307545, 13471.663208419868, 13492.5277615283, 13493.932530337679, 10333.689989300334, 10890.836637450602, 10950.52779345876, 10955.56177752881, 11270.585430779329, 11906.226095303777, 11913.285202887855, 11995.820062698893, 12411.193272437262, 12431.875681243071], "value": 7701.6868181456275, "unit": "score"}], "name": "dromaeo_css", "value": 7270.6653578436735, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 110.0, 112.0, 111.0, 111.0, 112.0, 110.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 116.0, 122.0, 174.0, 116.0, 119.0, 139.0, 117.0, 157.0, 118.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 162.0, 163.0, 159.0, 162.0, 163.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 124.0, 76.0, 76.0, 74.0, 74.0, 103.0, 74.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 117.0, 82.0, 83.0, 84.0, 123.0, 83.0, 82.0, 127.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 54.0, 53.0, 51.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 76.0, 81.0, 76.0, 75.0, 74.0, 83.0, 79.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 135.0, 118.0, 119.0, 128.0, 138.0, 128.0, 115.0, 165.0, 131.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 160.0, 161.0, 156.0, 158.0, 160.0, 157.0, 159.0, 166.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 63.0, 66.0, 64.0, 63.0, 63.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1485.3, "alertThreshold": 2.0}]} 10:25:18 INFO - Return code: 0 10:25:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:25:18 INFO - # TBPL SUCCESS # 10:25:18 INFO - Running post-action listener: _resource_record_post_action 10:25:18 INFO - [mozharness: 2016-07-28 17:25:18.932754Z] Finished run-tests step (success) 10:25:18 INFO - Running post-run listener: _resource_record_post_run 10:25:19 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553684992; Read time: 20; Write time: 1128288 10:25:19 INFO - TinderboxPrint: CPU usage
13.1% 10:25:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 10:25:19 INFO - TinderboxPrint: I/O write bytes / time
553,684,992 / 1,128,288 10:25:19 INFO - TinderboxPrint: CPU idle
8,278.4 (86.9%) 10:25:19 INFO - TinderboxPrint: CPU user
1,198.5 (12.6%) 10:25:19 INFO - TinderboxPrint: Swap in / out
0 / 0 10:25:19 INFO - install - Wall time: 18s; CPU: 16.0%; Read bytes: 0; Write bytes: 257155072; Read time: 0; Write time: 636000 10:25:19 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289763328; Read time: 0; Write time: 487484 10:25:19 INFO - Running post-run listener: _upload_blobber_files 10:25:19 INFO - Blob upload gear active. 10:25:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:19 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 10:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:25:20 INFO - (blobuploader) - INFO - Open directory for files ... 10:25:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:25:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:25:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:25 INFO - (blobuploader) - INFO - Done attempting. 10:25:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:25:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:25:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:26 INFO - (blobuploader) - INFO - Done attempting. 10:25:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:25:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:25:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:27 INFO - (blobuploader) - INFO - Done attempting. 10:25:27 INFO - (blobuploader) - INFO - Iteration through files over. 10:25:27 INFO - Return code: 0 10:25:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:25:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:25:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/650c6a790a416735f7c0f29896d3d93cd63d72bb967ac6275b285b7ef2ab451a9a4744f817f0f67333a8e866aad25a82be163ea99db678238171e63ee67e3af3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d79e96eaad5f1705d14b9174f57fd139deb52ad0347963b320464185ae04be8e62922f04d66943051d7a101765c47be76f6d038e28d4b22df9a722f70a1c435b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b94b8832ed27f64020db3b31494917d5a2ac83f14424062411fd86629d64c784b98c37a7ce9742b83aae495c760d4fdee8e7ef4e2117bbf3b18a0c05b69d0f8a"} 10:25:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:25:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:25:27 INFO - Contents: 10:25:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/650c6a790a416735f7c0f29896d3d93cd63d72bb967ac6275b285b7ef2ab451a9a4744f817f0f67333a8e866aad25a82be163ea99db678238171e63ee67e3af3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d79e96eaad5f1705d14b9174f57fd139deb52ad0347963b320464185ae04be8e62922f04d66943051d7a101765c47be76f6d038e28d4b22df9a722f70a1c435b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b94b8832ed27f64020db3b31494917d5a2ac83f14424062411fd86629d64c784b98c37a7ce9742b83aae495c760d4fdee8e7ef4e2117bbf3b18a0c05b69d0f8a"} 10:25:27 INFO - Running post-run listener: copy_logs_to_upload_dir 10:25:27 INFO - Copying logs to upload dir... 10:25:27 INFO - mkdir: /builds/slave/test/build/upload/logs 10:25:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.509952 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-28 10:25:27.335241) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 10:25:27.338846) ========= 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=745a4373a2a16df560f216e000000264-1469725488.70771-205285961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/650c6a790a416735f7c0f29896d3d93cd63d72bb967ac6275b285b7ef2ab451a9a4744f817f0f67333a8e866aad25a82be163ea99db678238171e63ee67e3af3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d79e96eaad5f1705d14b9174f57fd139deb52ad0347963b320464185ae04be8e62922f04d66943051d7a101765c47be76f6d038e28d4b22df9a722f70a1c435b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b94b8832ed27f64020db3b31494917d5a2ac83f14424062411fd86629d64c784b98c37a7ce9742b83aae495c760d4fdee8e7ef4e2117bbf3b18a0c05b69d0f8a"} build_url:https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/IKf2l6vcSa-3Zviav_a3jg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/650c6a790a416735f7c0f29896d3d93cd63d72bb967ac6275b285b7ef2ab451a9a4744f817f0f67333a8e866aad25a82be163ea99db678238171e63ee67e3af3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d79e96eaad5f1705d14b9174f57fd139deb52ad0347963b320464185ae04be8e62922f04d66943051d7a101765c47be76f6d038e28d4b22df9a722f70a1c435b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b94b8832ed27f64020db3b31494917d5a2ac83f14424062411fd86629d64c784b98c37a7ce9742b83aae495c760d4fdee8e7ef4e2117bbf3b18a0c05b69d0f8a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 10:25:27.365330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:25:27.365730) ========= 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=745a4373a2a16df560f216e000000264-1469725488.70771-205285961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:25:27.447565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 10:25:27.447900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 10:25:27.448234) ========= ========= Total master_lag: 0.23 =========