builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1469727271.44 results: success (0) buildid: 20160728084630 builduid: 237c846c34534358826c876313073d29 revision: 2d6fced8b624ce179cef1053d9e3952dae7c726b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:31.437462) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:31.437899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:31.438169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:31.505652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:31.505948) ========= 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=923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 10:34:31-- 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% 35.9M=0s 2016-07-28 10:34:31 (35.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108694 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:31.628157) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:31.628485) ========= 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=923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019782 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:31.677850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:31.678229) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2d6fced8b624ce179cef1053d9e3952dae7c726b --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 2d6fced8b624ce179cef1053d9e3952dae7c726b --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=923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 10:34:31,964 truncating revision to first 12 chars 2016-07-28 10:34:31,964 Setting DEBUG logging. 2016-07-28 10:34:31,964 attempt 1/10 2016-07-28 10:34:31,964 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2d6fced8b624?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 10:34:32,308 unpacking tar archive at: fx-team-2d6fced8b624/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679687 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:32.377397) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:32.378319) ========= script_repo_revision: 2d6fced8b624ce179cef1053d9e3952dae7c726b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:32.378720) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:32.378981) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 10:34:32.390682) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-28 10:34:32.391024) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:34:32 INFO - MultiFileLogger online at 20160728 10:34:32 in /builds/slave/test 10:34:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:34:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:34:32 INFO - {'append_to_log': False, 10:34:32 INFO - 'base_work_dir': '/builds/slave/test', 10:34:32 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:34:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:34:32 INFO - 'branch': 'Fx-Team-Non-PGO', 10:34:32 INFO - 'buildbot_json_path': 'buildprops.json', 10:34:32 INFO - 'config_files': ('talos/linux_config.py',), 10:34:32 INFO - 'default_actions': ('clobber', 10:34:32 INFO - 'read-buildbot-config', 10:34:32 INFO - 'download-and-extract', 10:34:32 INFO - 'populate-webroot', 10:34:32 INFO - 'create-virtualenv', 10:34:32 INFO - 'install', 10:34:32 INFO - 'run-tests'), 10:34:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:34:32 INFO - 'download_minidump_stackwalk': True, 10:34:32 INFO - 'download_symbols': 'ondemand', 10:34:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:34:32 INFO - 'tooltool.py': '/tools/tooltool.py', 10:34:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:34:32 INFO - '/tools/misc-python/virtualenv.py')}, 10:34:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:34:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:34:32 INFO - 'installer_path': 'installer.exe', 10:34:32 INFO - 'log_level': 'info', 10:34:32 INFO - 'log_name': 'talos', 10:34:32 INFO - 'log_to_console': True, 10:34:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:34:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:34:32 INFO - 'opt_config_files': (), 10:34:32 INFO - 'pip_index': False, 10:34:32 INFO - 'sps_profile': False, 10:34:32 INFO - 'sps_profile_interval': 0, 10:34:32 INFO - 'suite': 'dromaeojs', 10:34:32 INFO - 'system_bits': '32', 10:34:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:34:32 INFO - 'title': 'talos-linux64-ix-007', 10:34:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:34:32 INFO - 'use_talos_json': True, 10:34:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:34:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:34:32 INFO - 'work_dir': 'build'} 10:34:32 INFO - [mozharness: 2016-07-28 17:34:32.770530Z] Running clobber step. 10:34:32 INFO - Running pre-action listener: _resource_record_pre_action 10:34:32 INFO - Running main action method: clobber 10:34:32 INFO - rmtree: /builds/slave/test/build 10:34:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:34:33 INFO - Running post-action listener: _resource_record_post_action 10:34:33 INFO - [mozharness: 2016-07-28 17:34:33.246995Z] Finished clobber step (success) 10:34:33 INFO - [mozharness: 2016-07-28 17:34:33.247096Z] Running read-buildbot-config step. 10:34:33 INFO - Running pre-action listener: _resource_record_pre_action 10:34:33 INFO - Running main action method: read_buildbot_config 10:34:33 INFO - Using buildbot properties: 10:34:33 INFO - { 10:34:33 INFO - "project": "", 10:34:33 INFO - "product": "firefox", 10:34:33 INFO - "script_repo_revision": "production", 10:34:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:34:33 INFO - "repository": "", 10:34:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:34:33 INFO - "buildid": "20160728084630", 10:34:33 INFO - "pgo_build": "False", 10:34:33 INFO - "basedir": "/builds/slave/test", 10:34:33 INFO - "buildnumber": 2030, 10:34:33 INFO - "slavename": "talos-linux64-ix-007", 10:34:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:34:33 INFO - "platform": "ubuntu64_hw", 10:34:33 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:34:33 INFO - "branch": "fx-team", 10:34:33 INFO - "repo_path": "integration/fx-team", 10:34:33 INFO - "revision": "2d6fced8b624ce179cef1053d9e3952dae7c726b", 10:34:33 INFO - "stage_platform": "linux64", 10:34:33 INFO - "builduid": "237c846c34534358826c876313073d29", 10:34:33 INFO - "slavebuilddir": "test" 10:34:33 INFO - } 10:34:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:34:33 INFO - Running post-action listener: _resource_record_post_action 10:34:33 INFO - [mozharness: 2016-07-28 17:34:33.249537Z] Finished read-buildbot-config step (success) 10:34:33 INFO - [mozharness: 2016-07-28 17:34:33.249626Z] Running download-and-extract step. 10:34:33 INFO - Running pre-action listener: _resource_record_pre_action 10:34:33 INFO - Running main action method: download_and_extract 10:34:33 INFO - mkdir: /builds/slave/test/build/tests 10:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:33 INFO - https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:34:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:34:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:34:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/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:34:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/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:34:33 INFO - Downloaded 1361 bytes. 10:34:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:34:33 INFO - Using the following test package requirements: 10:34:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:34:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:34:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:34:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:33 INFO - u'jsshell-linux-x86_64.zip'], 10:34:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:34:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:34:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:34:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:34:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:34:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:34:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:34:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:33 INFO - https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:34:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:34:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:34:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/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:34:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/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:34:34 INFO - Downloaded 22749779 bytes. 10:34:34 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:34:34 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:34:36 INFO - Return code: 0 10:34:36 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:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:36 INFO - https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:34:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:34:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:34:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/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:34:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/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:34:37 INFO - Downloaded 22749779 bytes. 10:34:37 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:34:37 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:34:38 INFO - Return code: 0 10:34:38 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:34:38 INFO - https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:34:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:34:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:34:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/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:34:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/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:34:39 INFO - Downloaded 14413725 bytes. 10:34:39 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:34:39 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:34:39 INFO - Return code: 0 10:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:39 INFO - https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:34:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:34:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:34:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/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:34:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0crULN1RYOzZHrug_8mGA/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:34:40 INFO - Downloaded 57165745 bytes. 10:34:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:34:40 INFO - mkdir: /builds/slave/test/properties 10:34:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:34:40 INFO - Writing to file /builds/slave/test/properties/build_url 10:34:40 INFO - Contents: 10:34:40 INFO - build_url:https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:34:41 INFO - Running post-action listener: _resource_record_post_action 10:34:41 INFO - Running post-action listener: set_extra_try_arguments 10:34:41 INFO - [mozharness: 2016-07-28 17:34:41.530591Z] Finished download-and-extract step (success) 10:34:41 INFO - [mozharness: 2016-07-28 17:34:41.530825Z] Running populate-webroot step. 10:34:41 INFO - Running pre-action listener: _resource_record_pre_action 10:34:41 INFO - Running main action method: populate_webroot 10:34:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:34:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:34:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:34:41 INFO - '--tppagecycles', 10:34:41 INFO - '7'], 10:34:41 INFO - 'tests': ['tsvgm']}}, 10:34:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:34:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:34:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:34:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:34:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:34:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:34:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:41 INFO - 'talos_options': ['--disable-e10s'], 10:34:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:41 INFO - 'talos_options': ['--disable-e10s'], 10:34:41 INFO - 'tests': ['damp', 'tps']}, 10:34:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:41 INFO - 'tests': ['damp', 'tps']}, 10:34:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:34:41 INFO - 'tests': ['dromaeo_dom']}, 10:34:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:34:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:34:41 INFO - 'tests': ['basic_compositor_video']}, 10:34:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:34:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:34:41 INFO - 'tests': ['a11yr', 10:34:41 INFO - 'ts_paint', 10:34:41 INFO - 'tpaint', 10:34:41 INFO - 'sessionrestore', 10:34:41 INFO - 'sessionrestore_no_auto_restore', 10:34:41 INFO - 'tabpaint']}, 10:34:41 INFO - 'other-e10s': {'tests': ['a11yr', 10:34:41 INFO - 'ts_paint', 10:34:41 INFO - 'tpaint', 10:34:41 INFO - 'sessionrestore', 10:34:41 INFO - 'sessionrestore_no_auto_restore', 10:34:41 INFO - 'tabpaint']}, 10:34:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:34:41 INFO - 'ts_paint', 10:34:41 INFO - 'tpaint', 10:34:41 INFO - 'sessionrestore', 10:34:41 INFO - 'sessionrestore_no_auto_restore', 10:34:41 INFO - 'tabpaint']}, 10:34:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:34:41 INFO - 'ts_paint', 10:34:41 INFO - 'tpaint', 10:34:41 INFO - 'sessionrestore', 10:34:41 INFO - 'sessionrestore_no_auto_restore', 10:34:41 INFO - 'tabpaint']}, 10:34:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:34:41 INFO - 'tests': ['a11yr', 10:34:41 INFO - 'ts_paint', 10:34:41 INFO - 'tpaint', 10:34:41 INFO - 'sessionrestore', 10:34:41 INFO - 'sessionrestore_no_auto_restore', 10:34:41 INFO - 'tabpaint']}, 10:34:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:34:41 INFO - 'tests': ['a11yr', 10:34:41 INFO - 'ts_paint', 10:34:41 INFO - 'tpaint', 10:34:41 INFO - 'sessionrestore', 10:34:41 INFO - 'sessionrestore_no_auto_restore', 10:34:41 INFO - 'tabpaint']}, 10:34:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:34:41 INFO - 'tests': ['tsvgx', 10:34:41 INFO - 'tsvgr_opacity', 10:34:41 INFO - 'tart', 10:34:41 INFO - 'tscrollx', 10:34:41 INFO - 'cart']}, 10:34:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:34:41 INFO - 'tsvgr_opacity', 10:34:41 INFO - 'tart', 10:34:41 INFO - 'tscrollx', 10:34:41 INFO - 'cart']}, 10:34:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:41 INFO - 'talos_options': ['--disable-e10s'], 10:34:41 INFO - 'tests': ['tp5o']}, 10:34:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:41 INFO - 'tests': ['tp5o']}, 10:34:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:41 INFO - 'talos_options': ['--disable-e10s', 10:34:41 INFO - '--xperf_path', 10:34:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:41 INFO - 'tests': ['tp5n']}, 10:34:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:41 INFO - 'talos_options': ['--xperf_path', 10:34:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:41 INFO - 'tests': ['tp5n']}}, 10:34:41 INFO - 'talos.zip': {'path': '', 10:34:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:34:41 INFO - Running post-action listener: _resource_record_post_action 10:34:41 INFO - [mozharness: 2016-07-28 17:34:41.550833Z] Finished populate-webroot step (success) 10:34:41 INFO - [mozharness: 2016-07-28 17:34:41.550922Z] Running create-virtualenv step. 10:34:41 INFO - Running pre-action listener: _resource_record_pre_action 10:34:41 INFO - Running main action method: create_virtualenv 10:34:41 INFO - Creating virtualenv /builds/slave/test/build/venv 10:34:41 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:34:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:34:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:34:41 INFO - Using real prefix '/usr' 10:34:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:34:42 INFO - Installing distribute.............................................................................................................................................................................................done. 10:34:44 INFO - Installing pip.................done. 10:34:44 INFO - Return code: 0 10:34:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:44 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 0x17fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba3b0>, '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 0x1abb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb740>, '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': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', '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:34:44 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:34:44 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:34:44 INFO - Using env: {'DISPLAY': ':0', 10:34:44 INFO - 'HOME': '/home/cltbld', 10:34:44 INFO - 'LANG': 'en_US.UTF-8', 10:34:44 INFO - 'LANGUAGE': 'en_US:en', 10:34:44 INFO - 'LOGNAME': 'cltbld', 10:34:44 INFO - 'MAIL': '/var/mail/cltbld', 10:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:44 INFO - 'MOZ_NO_REMOTE': '1', 10:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:44 INFO - 'NO_EM_RESTART': '1', 10:34:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:44 INFO - 'PWD': '/builds/slave/test', 10:34:44 INFO - 'SHELL': '/bin/bash', 10:34:44 INFO - 'SHLVL': '1', 10:34:44 INFO - 'TERM': 'linux', 10:34:44 INFO - 'TMOUT': '86400', 10:34:44 INFO - 'USER': 'cltbld', 10:34:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', 10:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:44 INFO - '_': '/tools/buildbot/bin/python'} 10:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:44 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:34:44 INFO - Cleaning up... 10:34:44 INFO - Return code: 0 10:34:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:44 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 0x17fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba3b0>, '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 0x1abb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb740>, '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': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', '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:34:44 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:34:44 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:34:44 INFO - Using env: {'DISPLAY': ':0', 10:34:44 INFO - 'HOME': '/home/cltbld', 10:34:44 INFO - 'LANG': 'en_US.UTF-8', 10:34:44 INFO - 'LANGUAGE': 'en_US:en', 10:34:44 INFO - 'LOGNAME': 'cltbld', 10:34:44 INFO - 'MAIL': '/var/mail/cltbld', 10:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:44 INFO - 'MOZ_NO_REMOTE': '1', 10:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:44 INFO - 'NO_EM_RESTART': '1', 10:34:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:44 INFO - 'PWD': '/builds/slave/test', 10:34:44 INFO - 'SHELL': '/bin/bash', 10:34:44 INFO - 'SHLVL': '1', 10:34:44 INFO - 'TERM': 'linux', 10:34:44 INFO - 'TMOUT': '86400', 10:34:44 INFO - 'USER': 'cltbld', 10:34:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', 10:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:44 INFO - '_': '/tools/buildbot/bin/python'} 10:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:44 INFO - Downloading/unpacking psutil>=3.1.1 10:34:44 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:34:44 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:34:44 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:34:44 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:34:44 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:34:44 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:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:34:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:46 INFO - Installing collected packages: psutil 10:34:46 INFO - Running setup.py install for psutil 10:34:46 INFO - building 'psutil._psutil_linux' extension 10:34:46 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:34:46 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:34:46 INFO - building 'psutil._psutil_posix' extension 10:34:46 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:34:47 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:34:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:47 INFO - Successfully installed psutil 10:34:47 INFO - Cleaning up... 10:34:47 INFO - Return code: 0 10:34:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:47 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 0x17fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba3b0>, '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 0x1abb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb740>, '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': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', '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:34:47 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:34:47 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:34:47 INFO - Using env: {'DISPLAY': ':0', 10:34:47 INFO - 'HOME': '/home/cltbld', 10:34:47 INFO - 'LANG': 'en_US.UTF-8', 10:34:47 INFO - 'LANGUAGE': 'en_US:en', 10:34:47 INFO - 'LOGNAME': 'cltbld', 10:34:47 INFO - 'MAIL': '/var/mail/cltbld', 10:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:47 INFO - 'MOZ_NO_REMOTE': '1', 10:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:47 INFO - 'NO_EM_RESTART': '1', 10:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:47 INFO - 'PWD': '/builds/slave/test', 10:34:47 INFO - 'SHELL': '/bin/bash', 10:34:47 INFO - 'SHLVL': '1', 10:34:47 INFO - 'TERM': 'linux', 10:34:47 INFO - 'TMOUT': '86400', 10:34:47 INFO - 'USER': 'cltbld', 10:34:47 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', 10:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:47 INFO - '_': '/tools/buildbot/bin/python'} 10:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:34:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:34:49 INFO - Installing collected packages: mozsystemmonitor 10:34:49 INFO - Running setup.py install for mozsystemmonitor 10:34:49 INFO - Successfully installed mozsystemmonitor 10:34:49 INFO - Cleaning up... 10:34:49 INFO - Return code: 0 10:34:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:49 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 0x17fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba3b0>, '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 0x1abb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb740>, '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': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', '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:34:49 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:34:49 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:34:49 INFO - Using env: {'DISPLAY': ':0', 10:34:49 INFO - 'HOME': '/home/cltbld', 10:34:49 INFO - 'LANG': 'en_US.UTF-8', 10:34:49 INFO - 'LANGUAGE': 'en_US:en', 10:34:49 INFO - 'LOGNAME': 'cltbld', 10:34:49 INFO - 'MAIL': '/var/mail/cltbld', 10:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:49 INFO - 'MOZ_NO_REMOTE': '1', 10:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:49 INFO - 'NO_EM_RESTART': '1', 10:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:49 INFO - 'PWD': '/builds/slave/test', 10:34:49 INFO - 'SHELL': '/bin/bash', 10:34:49 INFO - 'SHLVL': '1', 10:34:49 INFO - 'TERM': 'linux', 10:34:49 INFO - 'TMOUT': '86400', 10:34:49 INFO - 'USER': 'cltbld', 10:34:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', 10:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:49 INFO - '_': '/tools/buildbot/bin/python'} 10:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:49 INFO - Downloading/unpacking jsonschema==2.5.1 10:34:49 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:34:49 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:34:49 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:34:49 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:34:49 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:34:49 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:34:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:34:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:51 INFO - Downloading functools32-3.2.3-2.tar.gz 10:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:34:51 INFO - warning: no files found matching '*.txt' 10:34:51 INFO - no previously-included directories found matching 'build' 10:34:51 INFO - no previously-included directories found matching 'dist' 10:34:51 INFO - no previously-included directories found matching '.git*' 10:34:51 INFO - Installing collected packages: jsonschema, functools32 10:34:51 INFO - Running setup.py install for functools32 10:34:52 INFO - warning: no files found matching '*.txt' 10:34:52 INFO - no previously-included directories found matching 'build' 10:34:52 INFO - no previously-included directories found matching 'dist' 10:34:52 INFO - no previously-included directories found matching '.git*' 10:34:52 INFO - Successfully installed jsonschema functools32 10:34:52 INFO - Cleaning up... 10:34:52 INFO - Return code: 0 10:34:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:34:52 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:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:52 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:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:52 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 0x17fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba3b0>, '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 0x1abb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb740>, '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': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', '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:34:52 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:34:52 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:34:52 INFO - Using env: {'DISPLAY': ':0', 10:34:52 INFO - 'HOME': '/home/cltbld', 10:34:52 INFO - 'LANG': 'en_US.UTF-8', 10:34:52 INFO - 'LANGUAGE': 'en_US:en', 10:34:52 INFO - 'LOGNAME': 'cltbld', 10:34:52 INFO - 'MAIL': '/var/mail/cltbld', 10:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:52 INFO - 'MOZ_NO_REMOTE': '1', 10:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:52 INFO - 'NO_EM_RESTART': '1', 10:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:52 INFO - 'PWD': '/builds/slave/test', 10:34:52 INFO - 'SHELL': '/bin/bash', 10:34:52 INFO - 'SHLVL': '1', 10:34:52 INFO - 'TERM': 'linux', 10:34:52 INFO - 'TMOUT': '86400', 10:34:52 INFO - 'USER': 'cltbld', 10:34:52 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', 10:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:52 INFO - '_': '/tools/buildbot/bin/python'} 10:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:34:52 INFO - Cleaning up... 10:34:52 INFO - Return code: 0 10:34:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:34:52 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:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:52 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:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:52 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 0x17fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba3b0>, '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 0x1abb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb740>, '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': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', '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:34:52 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:34:52 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:34:52 INFO - Using env: {'DISPLAY': ':0', 10:34:52 INFO - 'HOME': '/home/cltbld', 10:34:52 INFO - 'LANG': 'en_US.UTF-8', 10:34:52 INFO - 'LANGUAGE': 'en_US:en', 10:34:52 INFO - 'LOGNAME': 'cltbld', 10:34:52 INFO - 'MAIL': '/var/mail/cltbld', 10:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:52 INFO - 'MOZ_NO_REMOTE': '1', 10:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:52 INFO - 'NO_EM_RESTART': '1', 10:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:52 INFO - 'PWD': '/builds/slave/test', 10:34:52 INFO - 'SHELL': '/bin/bash', 10:34:52 INFO - 'SHLVL': '1', 10:34:52 INFO - 'TERM': 'linux', 10:34:52 INFO - 'TMOUT': '86400', 10:34:52 INFO - 'USER': 'cltbld', 10:34:52 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', 10:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:52 INFO - '_': '/tools/buildbot/bin/python'} 10:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:52 INFO - Downloading/unpacking blobuploader==1.2.4 10:34:52 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:34:52 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:34:52 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:34:52 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:34:52 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:34:52 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:34:54 INFO - Downloading blobuploader-1.2.4.tar.gz 10:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:34:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:34:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:55 INFO - Downloading docopt-0.6.1.tar.gz 10:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:34:55 INFO - Installing collected packages: blobuploader, requests, docopt 10:34:55 INFO - Running setup.py install for blobuploader 10:34:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:34:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:34:55 INFO - Running setup.py install for requests 10:34:55 INFO - Running setup.py install for docopt 10:34:55 INFO - Successfully installed blobuploader requests docopt 10:34:55 INFO - Cleaning up... 10:34:55 INFO - Return code: 0 10:34:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:55 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:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:55 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:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:55 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 0x17fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba3b0>, '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 0x1abb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb740>, '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': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', '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:34:55 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:34:55 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:34:55 INFO - Using env: {'DISPLAY': ':0', 10:34:55 INFO - 'HOME': '/home/cltbld', 10:34:55 INFO - 'LANG': 'en_US.UTF-8', 10:34:55 INFO - 'LANGUAGE': 'en_US:en', 10:34:55 INFO - 'LOGNAME': 'cltbld', 10:34:55 INFO - 'MAIL': '/var/mail/cltbld', 10:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:55 INFO - 'MOZ_NO_REMOTE': '1', 10:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:55 INFO - 'NO_EM_RESTART': '1', 10:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:55 INFO - 'PWD': '/builds/slave/test', 10:34:55 INFO - 'SHELL': '/bin/bash', 10:34:55 INFO - 'SHLVL': '1', 10:34:55 INFO - 'TERM': 'linux', 10:34:55 INFO - 'TMOUT': '86400', 10:34:55 INFO - 'USER': 'cltbld', 10:34:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', 10:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:55 INFO - '_': '/tools/buildbot/bin/python'} 10:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:56 INFO - Running setup.py (path:/tmp/pip-rBU0SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:56 INFO - Running setup.py (path:/tmp/pip-cwQSlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:56 INFO - Running setup.py (path:/tmp/pip-5mfGVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:56 INFO - Running setup.py (path:/tmp/pip-O7qwGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:56 INFO - Running setup.py (path:/tmp/pip-Awe9be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:56 INFO - Running setup.py (path:/tmp/pip-Rsg6AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:56 INFO - Running setup.py (path:/tmp/pip-R5fp5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:56 INFO - Running setup.py (path:/tmp/pip-ZRMvcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:56 INFO - Running setup.py (path:/tmp/pip-PBPSeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:56 INFO - Running setup.py (path:/tmp/pip-JY01db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:56 INFO - Running setup.py (path:/tmp/pip-kF_XaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:56 INFO - Running setup.py (path:/tmp/pip-HaEXER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:56 INFO - Running setup.py (path:/tmp/pip-LEiNx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:56 INFO - Running setup.py (path:/tmp/pip-T4fBBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:57 INFO - Running setup.py (path:/tmp/pip-rl94kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:57 INFO - Running setup.py (path:/tmp/pip-wmlr0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:57 INFO - Running setup.py (path:/tmp/pip-qsktzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:34:57 INFO - Running setup.py install for manifestparser 10:34:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:34:57 INFO - Running setup.py install for mozcrash 10:34:57 INFO - Running setup.py install for mozdebug 10:34:57 INFO - Running setup.py install for mozdevice 10:34:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:34:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:34:57 INFO - Running setup.py install for mozfile 10:34:57 INFO - Running setup.py install for mozhttpd 10:34:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:34:57 INFO - Running setup.py install for mozinfo 10:34:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:34:57 INFO - Running setup.py install for mozInstall 10:34:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:34:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:34:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:34:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:34:58 INFO - Running setup.py install for mozleak 10:34:58 INFO - Running setup.py install for mozlog 10:34:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:34:58 INFO - Running setup.py install for moznetwork 10:34:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:34:58 INFO - Running setup.py install for mozprocess 10:34:58 INFO - Running setup.py install for mozprofile 10:34:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:34:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:34:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:34:58 INFO - Running setup.py install for mozrunner 10:34:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:34:58 INFO - Running setup.py install for mozscreenshot 10:34:58 INFO - Running setup.py install for moztest 10:34:58 INFO - Running setup.py install for mozversion 10:34:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:34:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:34:59 INFO - Cleaning up... 10:34:59 INFO - Return code: 0 10:34:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:59 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:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:59 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:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:59 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 0x17fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba3b0>, '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 0x1abb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb740>, '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': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', '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:34:59 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:34:59 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:34:59 INFO - Using env: {'DISPLAY': ':0', 10:34:59 INFO - 'HOME': '/home/cltbld', 10:34:59 INFO - 'LANG': 'en_US.UTF-8', 10:34:59 INFO - 'LANGUAGE': 'en_US:en', 10:34:59 INFO - 'LOGNAME': 'cltbld', 10:34:59 INFO - 'MAIL': '/var/mail/cltbld', 10:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:59 INFO - 'MOZ_NO_REMOTE': '1', 10:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:59 INFO - 'NO_EM_RESTART': '1', 10:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:59 INFO - 'PWD': '/builds/slave/test', 10:34:59 INFO - 'SHELL': '/bin/bash', 10:34:59 INFO - 'SHLVL': '1', 10:34:59 INFO - 'TERM': 'linux', 10:34:59 INFO - 'TMOUT': '86400', 10:34:59 INFO - 'USER': 'cltbld', 10:34:59 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', 10:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:59 INFO - '_': '/tools/buildbot/bin/python'} 10:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:59 INFO - Running setup.py (path:/tmp/pip-dsCyOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:59 INFO - Running setup.py (path:/tmp/pip-km5wXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:59 INFO - Running setup.py (path:/tmp/pip-Kc5mGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:59 INFO - Running setup.py (path:/tmp/pip-hWrZwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:59 INFO - Running setup.py (path:/tmp/pip-DG5BNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:59 INFO - Running setup.py (path:/tmp/pip-jMYzA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:59 INFO - Running setup.py (path:/tmp/pip-IZmE78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:59 INFO - Running setup.py (path:/tmp/pip-cWVFxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:59 INFO - Running setup.py (path:/tmp/pip-FWh8O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:59 INFO - Running setup.py (path:/tmp/pip-oBTS51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:59 INFO - Running setup.py (path:/tmp/pip-BI__wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:00 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:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:00 INFO - Running setup.py (path:/tmp/pip-tNbyn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:00 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:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:00 INFO - Running setup.py (path:/tmp/pip-HIUiXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:00 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:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:00 INFO - Running setup.py (path:/tmp/pip-px2FTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:00 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:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:00 INFO - Running setup.py (path:/tmp/pip-AnFao4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:00 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:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:00 INFO - Running setup.py (path:/tmp/pip-AF17Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:00 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:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:00 INFO - Running setup.py (path:/tmp/pip-G9Q0Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:00 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:35:00 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:35:00 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:35:00 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:35:00 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:35:00 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:35:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:35:00 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:35:00 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:35:00 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:35:00 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:35:00 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:35:00 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:35:02 INFO - Downloading blessings-1.6.tar.gz 10:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:35:02 INFO - Installing collected packages: blessings 10:35:02 INFO - Running setup.py install for blessings 10:35:02 INFO - Successfully installed blessings 10:35:02 INFO - Cleaning up... 10:35:02 INFO - Return code: 0 10:35:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:35:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:02 INFO - Reading from file tmpfile_stdout 10:35:02 INFO - Current package versions: 10:35:02 INFO - argparse == 1.2.1 10:35:02 INFO - blessings == 1.6 10:35:02 INFO - blobuploader == 1.2.4 10:35:02 INFO - docopt == 0.6.1 10:35:02 INFO - functools32 == 3.2.3-2 10:35:02 INFO - jsonschema == 2.5.1 10:35:02 INFO - manifestparser == 1.1 10:35:02 INFO - mozInstall == 1.12 10:35:02 INFO - mozcrash == 0.17 10:35:02 INFO - mozdebug == 0.1 10:35:02 INFO - mozdevice == 0.48 10:35:02 INFO - mozfile == 1.2 10:35:02 INFO - mozhttpd == 0.7 10:35:02 INFO - mozinfo == 0.9 10:35:02 INFO - mozleak == 0.1 10:35:02 INFO - mozlog == 3.3 10:35:02 INFO - moznetwork == 0.27 10:35:02 INFO - mozprocess == 0.23 10:35:02 INFO - mozprofile == 0.28 10:35:02 INFO - mozrunner == 6.12 10:35:02 INFO - mozscreenshot == 0.1 10:35:02 INFO - mozsystemmonitor == 0.3 10:35:02 INFO - moztest == 0.7 10:35:02 INFO - mozversion == 1.4 10:35:02 INFO - psutil == 3.1.1 10:35:02 INFO - requests == 1.2.3 10:35:02 INFO - wsgiref == 0.1.2 10:35:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:02 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:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:02 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:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:02 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 0x17fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba3b0>, '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 0x1abb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb740>, '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': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', '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:35:02 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:35:02 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:35:02 INFO - Using env: {'DISPLAY': ':0', 10:35:02 INFO - 'HOME': '/home/cltbld', 10:35:02 INFO - 'LANG': 'en_US.UTF-8', 10:35:02 INFO - 'LANGUAGE': 'en_US:en', 10:35:02 INFO - 'LOGNAME': 'cltbld', 10:35:02 INFO - 'MAIL': '/var/mail/cltbld', 10:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:02 INFO - 'MOZ_NO_REMOTE': '1', 10:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:02 INFO - 'NO_EM_RESTART': '1', 10:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:02 INFO - 'PWD': '/builds/slave/test', 10:35:02 INFO - 'SHELL': '/bin/bash', 10:35:02 INFO - 'SHLVL': '1', 10:35:02 INFO - 'TERM': 'linux', 10:35:02 INFO - 'TMOUT': '86400', 10:35:02 INFO - 'USER': 'cltbld', 10:35:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', 10:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:02 INFO - '_': '/tools/buildbot/bin/python'} 10:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 INFO - Cleaning up... 10:35:03 INFO - Return code: 0 10:35:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:03 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 0x17fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abc180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aba3b0>, '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 0x1abb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb740>, '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': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', '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:35:03 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:35:03 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:35:03 INFO - Using env: {'DISPLAY': ':0', 10:35:03 INFO - 'HOME': '/home/cltbld', 10:35:03 INFO - 'LANG': 'en_US.UTF-8', 10:35:03 INFO - 'LANGUAGE': 'en_US:en', 10:35:03 INFO - 'LOGNAME': 'cltbld', 10:35:03 INFO - 'MAIL': '/var/mail/cltbld', 10:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:03 INFO - 'MOZ_NO_REMOTE': '1', 10:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:03 INFO - 'NO_EM_RESTART': '1', 10:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:03 INFO - 'PWD': '/builds/slave/test', 10:35:03 INFO - 'SHELL': '/bin/bash', 10:35:03 INFO - 'SHLVL': '1', 10:35:03 INFO - 'TERM': 'linux', 10:35:03 INFO - 'TMOUT': '86400', 10:35:03 INFO - 'USER': 'cltbld', 10:35:03 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', 10:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:03 INFO - '_': '/tools/buildbot/bin/python'} 10:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:35:03 INFO - Cleaning up... 10:35:03 INFO - Return code: 0 10:35:03 INFO - Running post-action listener: _resource_record_post_action 10:35:03 INFO - Running post-action listener: _start_resource_monitoring 10:35:03 INFO - Starting resource monitoring. 10:35:03 INFO - [mozharness: 2016-07-28 17:35:03.336753Z] Finished create-virtualenv step (success) 10:35:03 INFO - [mozharness: 2016-07-28 17:35:03.337186Z] Running install step. 10:35:03 INFO - Running pre-action listener: _resource_record_pre_action 10:35:03 INFO - Running main action method: install 10:35:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:03 INFO - Reading from file tmpfile_stdout 10:35:03 INFO - Detecting whether we're running mozinstall >=1.0... 10:35:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:35:03 INFO - Reading from file tmpfile_stdout 10:35:03 INFO - Output received: 10:35:03 INFO - Usage: mozinstall [options] installer 10:35:03 INFO - Options: 10:35:03 INFO - -h, --help show this help message and exit 10:35:03 INFO - -d DEST, --destination=DEST 10:35:03 INFO - Directory to install application into. [default: 10:35:03 INFO - "/builds/slave/test"] 10:35:03 INFO - --app=APP Application being installed. [default: firefox] 10:35:03 INFO - mkdir: /builds/slave/test/build/application 10:35:03 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:35:03 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:35:20 INFO - Reading from file tmpfile_stdout 10:35:20 INFO - Output received: 10:35:20 INFO - /builds/slave/test/build/application/firefox/firefox 10:35:20 INFO - Running post-action listener: _resource_record_post_action 10:35:20 INFO - [mozharness: 2016-07-28 17:35:20.035698Z] Finished install step (success) 10:35:20 INFO - [mozharness: 2016-07-28 17:35:20.035981Z] Running run-tests step. 10:35:20 INFO - Running pre-action listener: _resource_record_pre_action 10:35:20 INFO - Running main action method: run_tests 10:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:35:20 INFO - Python 2.7.3 10:35:20 INFO - Return code: 0 10:35:20 INFO - grabbing minidump binary from tooltool 10:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:35:20 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 0x1aba3b0>, '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 0x1abb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abb740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:35:20 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:35:20 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:35:20 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:35:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:35:20 INFO - Return code: 0 10:35:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:35:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:35:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:35:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:35:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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:35:20 INFO - Using env: {'DISPLAY': ':0', 10:35:20 INFO - 'HOME': '/home/cltbld', 10:35:20 INFO - 'LANG': 'en_US.UTF-8', 10:35:20 INFO - 'LANGUAGE': 'en_US:en', 10:35:20 INFO - 'LOGNAME': 'cltbld', 10:35:20 INFO - 'MAIL': '/var/mail/cltbld', 10:35:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:35:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:20 INFO - 'MOZ_NO_REMOTE': '1', 10:35:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:20 INFO - 'NO_EM_RESTART': '1', 10:35:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:20 INFO - 'PWD': '/builds/slave/test', 10:35:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:35:20 INFO - 'SHELL': '/bin/bash', 10:35:20 INFO - 'SHLVL': '1', 10:35:20 INFO - 'TERM': 'linux', 10:35:20 INFO - 'TMOUT': '86400', 10:35:20 INFO - 'USER': 'cltbld', 10:35:20 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961', 10:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:20 INFO - '_': '/tools/buildbot/bin/python'} 10:35:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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:35:20 INFO - mozversion application_buildid: 20160728084630 10:35:20 INFO - mozversion application_changeset: 2d6fced8b624ce179cef1053d9e3952dae7c726b 10:35:20 INFO - mozversion application_display_name: Nightly 10:35:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:35:20 INFO - mozversion application_name: Firefox 10:35:20 INFO - mozversion application_remotingname: firefox 10:35:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:35:20 INFO - mozversion application_vendor: Mozilla 10:35:20 INFO - mozversion application_version: 50.0a1 10:35:20 INFO - mozversion platform_buildid: 20160728084630 10:35:20 INFO - mozversion platform_changeset: 2d6fced8b624ce179cef1053d9e3952dae7c726b 10:35:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:35:20 INFO - mozversion platform_version: 50.0a1 10:35:20 INFO - using testdate: 1469727320 10:35:20 INFO - actual date: 1469727320 10:35:20 INFO - starting webserver on 'localhost:48296' 10:35:20 INFO - SUITE-START | Running 2 tests 10:35:20 INFO - TEST-START | dromaeo_css 10:35:20 INFO - operating with platform_type : linux_ 10:35:20 INFO - Initialising browser for dromaeo_css test... 10:35:20 INFO - TEST-INFO | started process 11725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpziaQWx/profile http://localhost:48296/getInfo.html) 10:35:23 INFO - PROCESS | 11725 | JavaScript error: , line 0: uncaught exception: undefined 10:35:24 INFO - PROCESS | 11725 | __metrics Screen width/height:1600/1200 10:35:24 INFO - PROCESS | 11725 | colorDepth:24 10:35:24 INFO - PROCESS | 11725 | Browser inner width/height: 1024/697 10:35:24 INFO - PROCESS | 11725 | __metrics 10:35:24 INFO - PROCESS | 11725 | 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:35:24 INFO - PROCESS | 11725 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:25 INFO - TEST-INFO | 11725: exit 0 10:35:25 INFO - Browser initialized. 10:35:25 INFO - Running cycle 1/1 for dromaeo_css test... 10:35:25 INFO - TEST-INFO | started process 11803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpziaQWx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:37 INFO - PROCESS | 11803 | RSS: Main: 159510528 10:35:37 INFO - PROCESS | 11803 | 10:36:29 INFO - PROCESS | 11803 | 1469727389235 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:38:40 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48296/tests/dromaeo/cssquery-ext.html) 10:38:41 INFO - PROCESS | 11803 | RSS: Main: 242860032 10:38:41 INFO - PROCESS | 11803 | 10:41:44 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-ext.html (next: http://localhost:48296/tests/dromaeo/cssquery-jquery.html) 10:41:45 INFO - PROCESS | 11803 | RSS: Main: 242700288 10:41:45 INFO - PROCESS | 11803 | 10:44:47 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48296/tests/dromaeo/cssquery-mootools.html) 10:44:47 INFO - PROCESS | 11803 | RSS: Main: 213221376 10:44:47 INFO - PROCESS | 11803 | 10:47:50 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48296/tests/dromaeo/cssquery-prototype.html) 10:47:50 INFO - PROCESS | 11803 | RSS: Main: 186707968 10:47:50 INFO - PROCESS | 11803 | 10:50:53 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48296/tests/dromaeo/cssquery-yui.html) 10:50:54 INFO - PROCESS | 11803 | RSS: Main: 186810368 10:50:54 INFO - PROCESS | 11803 | 10:53:57 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:48296/tests/dromaeo/cssquery-yui.html (next: http://localhost:48296/tests/dromaeo/cssquery-dojo.html) 10:53:57 INFO - PROCESS | 11803 | RSS: Main: 277835776 10:53:57 INFO - PROCESS | 11803 | 10:53:57 INFO - PROCESS | 11803 | __start_tp_report 10:53:57 INFO - PROCESS | 11803 | _x_x_mozilla_page_load 10:53:57 INFO - PROCESS | 11803 | _x_x_mozilla_page_load_details 10:53:57 INFO - PROCESS | 11803 | |i|pagename|runs| 10:53:57 INFO - PROCESS | 11803 | |0;dojo.html;2572.382628169239;2573.3952521157535;2612.229392329263;2630.789536837053;2632.6182703507993;4469.262571675669;4569.977150114253;4674.368960190373;4677.555632214939;4688.859334219975;4604.240300350438;4666.580007799297;4689.835855745049;4693.859184224479;4729.983053643466;4240.512341080785;4274.337477690963;4317.330813723878;4331.4802223733195;4426.933595996063;4244.278472659656;4367.235733746597;4401.889952751191;4406.383106365111;4450.688451808374;4164.7917604119675;4213.094184750263;4325.805338759764;4326.351047342892;4383.430154079981;4186.455760751083;4233.682473814476;4251.574842515754;4268.615824575772;4312.3531470279395;4221.324588065895;4228.830846766125;4234.364845273203;4268.530461649216;4284.635805956497;4535.092981403733;4641.930371044437;4660.953390466119;4679.134360143385;4719.38647975761;4879.975600122012;4910.06708725341;4929.285253638238;4984.22744474607;4996.775145118442;5005.749712514396;5023.32185155003;5026.019926114409;5033.798648054073;5036.84889453317;4547.977260113678;4679.485256621769;4680.485146633868;4684.95315046852;4685.484596694361;5058.822941197041;5102.617303702237;5114.846554603368;5164.354455693038;5185.533302002837;4970.478099799541;4974.07979523782;4974.651774375831;4976.676516026447;4977.104121258136;4806.134895718735;4989.525995030466;5030.270610761419;5035.79856805731;5045.5459008689395;4910.975445122752;4974.27872958419;4979.551840334388;5029.17018691919;5054.671446355975;4955.331030310934;4967.801287948514;4977.352944117241;4983.5763960063805;5025.597952163818;4253.574642535722;4255.319148936155;4258.8296468140925;4269.530351661315;4306.4832220133785;3612.945805812915;3648.343298206348;3712.2204337088974;3764.0401697566945;3799.848006079781;4334.371516130143;4336.82652693895;4353.804078816461;4372.40972468719;4393.912121757611;5088.618353623493;5088.974555127201;5089.083964886356;5098.158803797406;5133.589312854962;4112.136451345251;4258.74447533149;4295.312749959991;4314.223439780807;4373.059792144641;4550.840720574764;4562.041971186088;4575.17646823575;4601.240795268744;4607.562281583244;4783.306420568998;4788.784504697297;4789.209780386336;4797.352357431771;4829.034193161311;4847.442544107473;4955.6531042826655;4963.875903102451;4995.300657907968;5067.037262920034;4728.101660684459;4729.550692684327;4734.242521196592;4747.810087596596;4768.594669452997;4909.4354149273295;4912.189488734319;4930.827421040246;4938.08645400602;4967.776450059829;4915.705057696549;4942.036302921039;4986.052649996489;5010.49895010496;5039.0929632666475;4877.463479017234;4879.243717223836;4885.1450996076255;4925.16272233714;4925.556699897026;4873.415190177201;4877.926831097608;4880;4880.1215781159735;4913.778879950482;4653.953460465352;4736.313234581035;4768.880777980578;4830.9275360870315;4858.927116093332;4892.437369702529;4907.190313598359;4908.263760435963;4947.3073769671555;4956.8760780980765;4794.904101918012;4803.471618122074;4803.5916947058495;4810.95189048119;4837.37114175155 10:53:57 INFO - PROCESS | 11803 | |1;ext.html;559.4978165938865;587.3509771702271;587.8765459253557;598.2073752278233;604.989667255683;26976.190714278553;38281.425778613346;39162.80418597903;39218.215635687266;39227.21545569087;38667.80666096673;39125.80437097818;39219;39244.607553924456;39266.41100383497;7411.592362420065;7785.64964576594;7924.683012679486;7928.80177995549;7932.524048557105;7520.849583008337;7630.580318082503;7636.923630763677;9890.20878329732;10082.243831712614;10162.08541231289;10248.12890904274;10252.077313041826;10254.384736915772;10260.127889129395;10059.144972677295;10099.747506312327;10114.039166279192;10124.645637402655;10125.240606954434;9935.95672454389;10006.79986400268;10010.799784004279;10013.89986100137;10017.39895606266;37935.8103209485;38045.048873778374;38168.427473587915;38194.42708359377;38203.23593528142;2919.5328747400526;2954.763618910482;2966.42154779818;3008.278013276798;3008.714172153642;29026.85486572575;29096.709032909825;29553.70446295531;29710.702892971225;30903.845480772452;3386.881459148918;3456.654334566548;3532.540769699948;3555.982220088909;3567.7502574819773;239944;240975;241965.79017104802;243335.78332108402;244362;50953.961841525925;51093.23360149601;51108.48891511112;51167.744161278955;51194.23208651873;32262.838685806422;33353.3329333412;33402.164945876546;34732.47901281483;34779.478307825404;13325.466981320833;13411.530596429273;13427.12723672958;13453.932730336286;13479.663008424868;11630.88369116298;11737.941310293394;11742.412879356169;11746.94126529379;11752.059835213162;15941.44204952821;17479.825201748074;18006.099695015197;18029.368972085915;18426.63146737058;6710.966445167743;6878.484113691493;6891.310868913069;6937.514373993873;7040.929590704028;901.2834796336928;917.3578495053489;922.7462447826902;945.3099237556622;1017.7710015246511;28299;28709.28226794305;28747;29238.56142157869;29258.853705731333;900.1268769293774;912.4342907397323;955.9330846840654;962.259060523393;983.0218932162401;15122.773158402633;15164.469243576643;15232.771508427382;15441.691166176613;15475.922620386826;387775;460241;474319;476861;791968;49355.25967110496;49903.50096499061;49941.75029124831;49970.250446243335;50015;1199.976000480003;1214.2168301445695;1239.659093749208;1240.0761432732672;1247.5049900199601;27605.171844844688;28571;29103.272418189714;29133.56299655549;29409;42589.5741042598;42757.78621106874;42992.78503607587;43047.13905721805;43271;361093;364309;365063;365087;365494;25484.362890927874;25766.09818656338;25940.740592593833;26115.347116322246;26116.8694156528;41511.169776603696;41534.37698434466;41616.79191604022;41718;41780.791096044326;35493.29013419769;35499.82250088733;35552.822235888656;36112.81943590265;36651.633483664824;35103;35294;35308.47037294391;35730.821345893106;36350;34851.30297393987;35026.299474010884;35167;35346.64653353434;35365.46951795777;30900.690993089782;32174.19564510906;32307.838460807547;32701.18247043843;32935;24887;24916.875415622806;24972.50054998926;25180.49639007246;25395.6190657144 10:53:57 INFO - PROCESS | 11803 | |2;jquery.html;334.1529223418634;342.3409935873444;345.13626417346336;346.6031394053808;359.2670951259431;12807.423665935032;16120.193990300482;16398.590035249126;18145.820521666083;18341.908290458563;17430;17520.737188942145;17555;17559.561010974732;17690.557736056606;5110.540051395374;5293.9735301323435;5536.058869992111;5577.330720313568;5652.321721393439;3473.235888104613;5572.944270557283;5613.494785469307;5614.691191984439;5855.385184555603;6102.72537735803;6173.81478555644;6199.44205021548;6202.9379706203035;6209.658468784215;5489.725513724298;5502.339719233718;5520.91718624221;5831.620944638627;6177.196964394622;5347.652402593858;5351.57187425005;5362.651427657229;5368.32895888014;5369.006733754229;13189.670258243621;20851.791482085137;20939.68590471144;20984;20999.79000210009;1919.712043193532;1932.9613407731767;1963.9410817675493;2140.903659335318;2240.7535171131326;8788.8681669775;9640.42157470547;9875.950620246853;10921.017108460197;13645.727085458235;1717.3130747700895;1782.6256486137927;1789.973150402745;1817.264008076731;1824.2338217948493;66956.6652166741;68554;68952.6552367235;69987.95018074784;70421.6478917602;9685.370450920667;9736.269779766546;9814.803703925882;9863.654772083086;9935.751606209758;13258.204507729373;13304;13326.267055311857;13344.06591538583;13347.332633368487;7060.505764596532;7178.820529486805;7213.314735100157;7339.74310899116;7401.222871598512;6821.386075253251;6965.756198533027;7057.541259818198;7087.562532171893;7101.751438699621;4143.875683729493;4168.062186008185;4194.580541945842;4229.725067870579;4322.654187664979;1696.134971164715;1789.6689112514227;1803.2156012134762;1808.8655386643625;1816.9000704961354;696.5437638346891;809;824.5588610093571;846.2552953400967;914.3188324698009;16846.57883552921;16895.32418703238;17090.743638845426;17249.482515524553;17832.821671783116;791.7783020754198;837.8366218587317;850.1753299299669;860.5181098584687;866.207420210513;9634.13292803651;9797.951010244904;9872.802543949081;9905;9928.553215105338;395124;408700;415985;420715.4821129435;421416;75479;77377;79024.60487697525;81198;81408;940.830650482906;943.297243553557;943.6225509796136;943.7640589852537;974.2790335152079;15990.760138597698;16034.438794642132;16556.586085347964;16671.58321041935;16731.498055058368;38264.80867595644;38560;38863.50228479451;39451.80274098611;40466.1906761869;53956.190657140956;55153;55829.072933726995;56617;56670.43329566817;6784.76253331131;6862.794116176323;7037.296270372922;7077.363037326665;7097.82255443618;10620.362778233331;10856.891431085904;10882.782344353227;10897.237193396386;11009.229353945148;9090.545472726206;9513.762155946157;9613.327067105236;9879.160271376726;9903.801923961337;8923.776905577413;9082.45505269686;9461.621535138518;9763.267754918552;9796.167325777104;9570.234381249344;9582.760430989281;9884.851727223953;9946.701598952042;10005.099541041342;6509.088727578048;6800.659967001531;6882.793516194522;7115.217326094022;7211.459140564583;7820.0224971878515;9612.327137100336;9990.450525221182;10339;10431.843522347323 10:53:57 INFO - PROCESS | 11803 | |3;mootools.html;1330.993345033275;1408.2677007955863;1443.566929921024;1620.4976457298246;1684.3599432215756;7302.123745150576;7840.176781437938;7842.960785196073;7848.450608457396;7862.488938219019;6446.2264528256555;6650.767223147191;7193.3166349196745;7406.148292946313;7649.92350076499;2190.868547887132;2222.5443784024237;2224.065892325219;2226.7105276314055;2227.164813195052;2166.555856049506;2193.111789725156;2209.0390680054147;2211.8562293450955;2213.0705103856417;2177.2162021672184;2184.1045171479695;2185.2897808212315;2188.595109904673;2232.4195709115666;2117.153138744507;2122.8407869409702;2124.1291070660955;2125.8299336053233;2126.340834341351;2071.161179722215;2098.213170061227;2098.223657246828;2100.1074543319182;2101.2540548105353;7644.273793989562;7699;7704.499207551491;7705.383569314441;7712.305892469649;4532.796024178887;4676.228422310314;4679.040796636681;4680.461746899116;4680.976595117037;2733.6992930777596;2800.2859270885997;2897.1887871396043;2901.970980290212;2918.357961248522;851.638053827121;891.3671293381642;904.3850181876321;905.2395987370641;921.1893533690377;10474.58101675932;10502.68491945243;10507.684769456851;10519.526621301984;10524.052835244865;4035.7780322082567;4143.875683729493;4263.253930562139;4285.8285668573535;4292.849750258789;8966.86549701755;8974.775630609156;8982.461052336881;8985.281177505783;8987.46075235488;4626.699264547861;4655.4180727409075;4661.836835710734;4665.743384113906;4666.696664716783;3683.171286460525;3824.29250588642;4059.837606495707;4269.786510674454;4273.1026484438;3522.771019883751;3559.341521818472;3672.7979961102396;3684.0421490412687;3691.1325838427947;1160.4023927677254;1197.6826141072622;1203.939803009846;1205.9457324420423;1222.6759908624222;807.6284908941835;867.0072766682114;870.7823044238941;872.4895935877582;890.3856339125982;5203.349581302337;5222.2427747976335;5302.92045619316;5327.840164795062;5371.006363822706;388.5473423461692;396.2570180910792;399.40688078203846;419.9643030342394;423.0439207391318;3652.196516766307;3826.789526576065;3844.788536630512;3875.8449662013204;3894.6884249260556;9196.724098277062;9559.139677429064;9649.855252171223;9653.758656033655;9673.081057299545;8802.559872006374;9076.09239076087;9506.096920792514;9543.188828949616;9555.569999350046;7043.647817609201;7185.137783466018;7198.388137008413;7220.67506962188;7221.205667376585;5424.321959755031;5487.725613719378;5534.1975413565615;5564.415736347625;5653.208550802973;8430.494170349799;8744.300455963381;8750.168733970262;8787.648494060166;8811.911880881109;8849.4247873888;8893.24407425376;8934.955325223593;8949;8973.416727912665;5889.528837692888;6357.745690172342;6417.7753778617525;6476.579022363531;6479.643619600967;7430.7027718892805;7578.393728501596;7656.4640475168435;7660.73187438437;7671.654775535226;6532;6615;6626.253345583783;6664.7000884959325;6918.757843475454;6518.348165183444;6556.246031706415;6709.630970296681;6759.797206083826;6761.3238676132;6055.576109672281;6130.570860039755;6137.508999279958;6137.785177518944;6138.57030007913;4420.336949457607;4491.528389519184;4511.593956543927;4515.34527493505;4540.931886021646;4537.977310113428;4623.16782979067;4638.1187574360765;4708.199606067045;4819.3252944588485 10:53:57 INFO - PROCESS | 11803 | |4;prototype.html;291.8832467013195;298.1577044848303;299.42360955161314;301.2724270885808;301.8460585101599;4785.258284965836;4785.66500344976;4786.186348320785;4835.347228124207;4844.830430934918;4742.976285118578;4744.217204161309;4757.0723708876785;4778.283257511366;4796.640251981098;3568.803715795637;3673.485712000322;3690.926181476369;3726.366517691999;3734.9813250933707;3776.9046976376817;3792.374258247386;3811.866584669537;3821.2739579479808;3824.827882745283;3743.3823419135947;3761.097336639214;3768.340540405432;3773;3778.6410291022307;3566.8038257895805;3630.9273814523563;3748.925021499582;3762.1347090169415;3794.761090956335;3323.2356557991557;3325.8004519728893;3331.4669652855428;3337.8497967591275;3346.4478361070396;4689.9765501172615;4693.906121877578;4699.7415142167165;4719.339292499053;4761.190597598416;4222.859827846495;4319.524852266248;4319.870403887889;4322.373255877911;4333.133373325316;4953.554180123806;4975.651704380694;4995.300657907896;5003.924941125886;5049.949500505021;3652.6164752700847;3654.104744337654;3658.560972683295;3679;3696.722745794076;5128.769205385729;5228.686278823283;5253.448387919251;5283.829702178662;5292.52367286946;3725.4598083277774;3737.6822970047306;3739.9252014959548;3745.662890339828;3766.886993390203;3788.8484460621817;3828.1769419574925;3833.21419109082;3834.677036422486;3838.136419305634;4300.311950087971;4303.505096913895;4315.784210789448;4333.609975102256;4334.414853994734;4848.7090774552935;5010.448850626428;5051.520105589963;5056.469070747592;5080.949190508121;1313.3498918035443;1319.22825147288;1331.1613683379603;1334.7864341705474;1335.7261761338902;840.6931470013401;864.2265172670425;865.2083343740406;875.4747151709051;882.5675419044622;4224.134052519226;4381.627561657295;4383.7588932609015;4384.6273066789045;4392.7364358137975;5157.793688252428;5165.088917100697;5168.741562921914;5171.4311425743135;5174.6377753557645;4351.97824010878;4360.629346505582;4369.69412141147;4376.277914144131;4385.320275357325;2590.404207032393;2716.4974479721313;2745.805574575066;2746.4507098580366;2757.8758955847034;4881.438634557;4881.926771098437;4889.217725163957;4911.7544122793715;4914.72968986702;5075.365579302587;5281.287026251483;5291.682499050069;5296.947030529645;5332.68003919766;4863.610911127102;4884.1941079722155;4889.608831293559;4897.1674815281485;4920.901581968341;5174.120399532164;5177.171652535576;5179.922301165561;5234.743661521284;5270.973645131749;4955.256711493161;5075;5079.314292570456;5103.77033033507;5116.488351164854;4851.902961940671;4858.319835223142;4904.288878112582;4917.532834380728;4925.876853078702;3752.7373083883867;3758.4362345648374;3765.755225910307;3798.5945200276074;3805.771653700787;4993.750312484434;5276.657017293864;5278.709670968134;5280.257515019957;5285.365756109291;5044.672096313728;5055.545000949932;5079.288899554139;5082.567981721447;5091.567216786615;5079.9238011429115;5083.906960003617;5086.389633243886;5115.769790359368;5168.9741551292;4756.857294281177;4942.184539550934;4997.475265097112;5010.423801262901;5017.598592112695;4865.221564549655;4954.671304486886;5064.5441910228255;5082.602284371827;5158.948410515847;5032.723200224023;5060.316857224375;5062.620303477328;5068.113080210875;5070.670406423571 10:53:57 INFO - PROCESS | 11803 | |5;yui.html;599.0475144520213;638.2914964389527;650.5381179362653;653.0269897852202;671.3219648155361;12158.75682486352;12447.253164810118;14042.859571404295;14617.049891757028;14674.266286685663;14064.437422503113;14218.644533886658;14245;14255.857441425609;14972.775408368883;759.5290919629823;781.2968328504363;783.5103060587134;783.5259667900895;783.6356094416095;646.1954866191599;764.1021799385727;782.0341877780936;784.831261278825;794.3010151067053;797.3262593108814;805.0540614777642;806.1092492795465;806.5604245686116;807.1323327423014;791.936645068396;792.1523969352795;794.3922898982283;795.3438413308985;800.7437619961614;588.1589327262013;588.5938702295402;588.7762650192942;588.9970550147265;590.766647174368;13533.120347177402;13605;13620.727585448334;13635.181889086587;13639.454421823115;12522.248665080124;12561.183523070971;12780.360981950866;12916.483340666362;12960.287184204864;10158;10345.586176552928;10414.791704165875;10488.31825931312;10933.453327333602;3221.806691598488;3246.2209069823307;3271.1331497153274;3287.96712032879;3342.615599206098;61822.454438638946;62776;62843.68578157126;63358.68320658367;63387;9513.619455221851;9638.4216946982;9687.17658998979;9711.5144242789;10098.798024039625;16791.867011978688;18390.540236493925;18397.172127254307;18768.24927002932;18840.246390144515;6468.902966455413;6757.121574195421;6855.383015528626;6890.2420733719255;7037.964810175917;3723.2925744109075;3744.4383342498845;3775.5091838060875;3849.615038496128;3919.0790164311366;2344.718633763959;3132.6710695376655;3285.950710739341;3307.68576985186;3334.616519100286;569.5102212097593;574.9511291540266;580.3500079910527;588.1941739816479;596.385722705614;463.6082510278809;478.7069935011257;501.4759576242835;502.7356199159118;523.2360753300225;7891.842163156704;8258.298044666271;8805.823883522293;9266.44401335922;9701.6119355225;475.7621189405297;540.394757871179;545.2121684166342;552.9549152102529;604.332212904734;3894.6689531389584;4024.6254709721406;4178.101708132705;4212.53662097169;4265.274903266452;89584;93874.53062734642;93984.53007734918;94346.07424589306;99989.50005250072;85890.14109858946;86041;86241.56879215564;86262.13737862666;89686.55156724305;68336.6583167081;75126;76005.61997189978;76490;78774.606126969;7659.387249020177;7871.881921771063;7906.446548741533;7927.881081783893;8070.717524886601;33708;42771.35842962296;43103.568964309954;43244.56755432405;44569.331460027475;63719.36280637134;65634.34365656473;65947.34052659413;66757.66621167057;67664;9837.360571563111;10097.949510252402;10277.229207809294;10296.124829389586;10323.32898361604;11024.669259922215;11350.148738844455;11399.662063395295;12038.578649747216;12041.858652087674;10988.505517251582;11303.321800691985;11435.313881167156;11596.594119205787;11692.298462092302;9608.327417080738;9833.606655733976;9840.40957542521;9869.555869985725;10251.48742562854;10473.68578942633;10847.511861966388;10869.619563315562;11008.449577520933;11067.501962411872;8426.705065322683;8438.240558349778;8608.440451370641;8615.138486151334;8635.956820215859;8578.3334664857;8620.353473489387;8697.6955806549;9198.402103863227;9223.677171298972 10:53:57 INFO - PROCESS | 11803 | __end_tp_report 10:53:57 INFO - PROCESS | 11803 | __start_cc_report 10:53:57 INFO - PROCESS | 11803 | _x_x_mozilla_cycle_collect,959 10:53:57 INFO - PROCESS | 11803 | __end_cc_report 10:53:57 INFO - PROCESS | 11803 | __startTimestamp1469728437900__endTimestamp 10:53:57 INFO - PROCESS | 11803 | 10:53:57 INFO - PROCESS | 11803 | ------- Summary: start ------- 10:53:57 INFO - PROCESS | 11803 | Number of tests: 6 10:53:57 INFO - PROCESS | 11803 | 10:53:57 INFO - PROCESS | 11803 | [#0] dojo.html Cycles:165 Average:4626.57 Median:4768.88 stddev:487.64 (10.2%) stddev-sans-first:461.75 10:53:57 INFO - PROCESS | 11803 | Values: 2572.4 2573.4 2612.2 2630.8 2632.6 4469.3 4570.0 4674.4 4677.6 4688.9 4604.2 4666.6 4689.8 4693.9 4730.0 4240.5 4274.3 4317.3 4331.5 4426.9 4244.3 4367.2 4401.9 4406.4 4450.7 4164.8 4213.1 4325.8 4326.4 4383.4 4186.5 4233.7 4251.6 4268.6 4312.4 4221.3 4228.8 4234.4 4268.5 4284.6 4535.1 4641.9 4661.0 4679.1 4719.4 4880.0 4910.1 4929.3 4984.2 4996.8 5005.7 5023.3 5026.0 5033.8 5036.8 4548.0 4679.5 4680.5 4685.0 4685.5 5058.8 5102.6 5114.8 5164.4 5185.5 4970.5 4974.1 4974.7 4976.7 4977.1 4806.1 4989.5 5030.3 5035.8 5045.5 4911.0 4974.3 4979.6 5029.2 5054.7 4955.3 4967.8 4977.4 4983.6 5025.6 4253.6 4255.3 4258.8 4269.5 4306.5 3612.9 3648.3 3712.2 3764.0 3799.8 4334.4 4336.8 4353.8 4372.4 4393.9 5088.6 5089.0 5089.1 5098.2 5133.6 4112.1 4258.7 4295.3 4314.2 4373.1 4550.8 4562.0 4575.2 4601.2 4607.6 4783.3 4788.8 4789.2 4797.4 4829.0 4847.4 4955.7 4963.9 4995.3 5067.0 4728.1 4729.6 4734.2 4747.8 4768.6 4909.4 4912.2 4930.8 4938.1 4967.8 4915.7 4942.0 4986.1 5010.5 5039.1 4877.5 4879.2 4885.1 4925.2 4925.6 4873.4 4877.9 4880.0 4880.1 4913.8 4654.0 4736.3 4768.9 4830.9 4858.9 4892.4 4907.2 4908.3 4947.3 4956.9 4794.9 4803.5 4803.6 4811.0 4837.4 10:53:57 INFO - PROCESS | 11803 | 10:53:57 INFO - PROCESS | 11803 | [#1] ext.html Cycles:180 Average:51564.27 Median:35064.65 stddev:106768.13 (304.5%) stddev-sans-first:106998.97 10:53:57 INFO - PROCESS | 11803 | Values: 559.5 587.4 587.9 598.2 605.0 26976.2 38281.4 39162.8 39218.2 39227.2 38667.8 39125.8 39219.0 39244.6 39266.4 7411.6 7785.6 7924.7 7928.8 7932.5 7520.8 7630.6 7636.9 9890.2 10082.2 10162.1 10248.1 10252.1 10254.4 10260.1 10059.1 10099.7 10114.0 10124.6 10125.2 9936.0 10006.8 10010.8 10013.9 10017.4 37935.8 38045.0 38168.4 38194.4 38203.2 2919.5 2954.8 2966.4 3008.3 3008.7 29026.9 29096.7 29553.7 29710.7 30903.8 3386.9 3456.7 3532.5 3556.0 3567.8 239944.0 240975.0 241965.8 243335.8 244362.0 50954.0 51093.2 51108.5 51167.7 51194.2 32262.8 33353.3 33402.2 34732.5 34779.5 13325.5 13411.5 13427.1 13453.9 13479.7 11630.9 11737.9 11742.4 11746.9 11752.1 15941.4 17479.8 18006.1 18029.4 18426.6 6711.0 6878.5 6891.3 6937.5 7040.9 901.3 917.4 922.7 945.3 1017.8 28299.0 28709.3 28747.0 29238.6 29258.9 900.1 912.4 955.9 962.3 983.0 15122.8 15164.5 15232.8 15441.7 15475.9 387775.0 460241.0 474319.0 476861.0 791968.0 49355.3 49903.5 49941.8 49970.3 50015.0 1200.0 1214.2 1239.7 1240.1 1247.5 27605.2 28571.0 29103.3 29133.6 29409.0 42589.6 42757.8 42992.8 43047.1 43271.0 361093.0 364309.0 365063.0 365087.0 365494.0 25484.4 25766.1 25940.7 26115.3 26116.9 41511.2 41534.4 41616.8 41718.0 41780.8 35493.3 35499.8 35552.8 36112.8 36651.6 35103.0 35294.0 35308.5 35730.8 36350.0 34851.3 35026.3 35167.0 35346.6 35365.5 30900.7 32174.2 32307.8 32701.2 32935.0 24887.0 24916.9 24972.5 25180.5 25395.6 10:53:57 INFO - PROCESS | 11803 | 10:53:57 INFO - PROCESS | 11803 | [#2] jquery.html Cycles:180 Average:25098.11 Median:30703.20 stddev:68092.16 (221.8%) stddev-sans-first:68257.79 10:53:57 INFO - PROCESS | 11803 | Values: 334.2 342.3 345.1 346.6 359.3 12807.4 16120.2 16398.6 18145.8 18341.9 17430.0 17520.7 17555.0 17559.6 17690.6 5110.5 5294.0 5536.1 5577.3 5652.3 3473.2 5572.9 5613.5 5614.7 5855.4 6102.7 6173.8 6199.4 6202.9 6209.7 5489.7 5502.3 5520.9 5831.6 6177.2 5347.7 5351.6 5362.7 5368.3 5369.0 13189.7 20851.8 20939.7 20984.0 20999.8 1919.7 1933.0 1963.9 2140.9 2240.8 8788.9 9640.4 9876.0 10921.0 13645.7 1717.3 1782.6 1790.0 1817.3 1824.2 66956.7 68554.0 68952.7 69988.0 70421.6 9685.4 9736.3 9814.8 9863.7 9935.8 13258.2 13304.0 13326.3 13344.1 13347.3 7060.5 7178.8 7213.3 7339.7 7401.2 6821.4 6965.8 7057.5 7087.6 7101.8 4143.9 4168.1 4194.6 4229.7 4322.7 1696.1 1789.7 1803.2 1808.9 1816.9 696.5 809.0 824.6 846.3 914.3 16846.6 16895.3 17090.7 17249.5 17832.8 791.8 837.8 850.2 860.5 866.2 9634.1 9798.0 9872.8 9905.0 9928.6 395124.0 408700.0 415985.0 420715.5 421416.0 75479.0 77377.0 79024.6 81198.0 81408.0 940.8 943.3 943.6 943.8 974.3 15990.8 16034.4 16556.6 16671.6 16731.5 38264.8 38560.0 38863.5 39451.8 40466.2 53956.2 55153.0 55829.1 56617.0 56670.4 6784.8 6862.8 7037.3 7077.4 7097.8 10620.4 10856.9 10882.8 10897.2 11009.2 9090.5 9513.8 9613.3 9879.2 9903.8 8923.8 9082.5 9461.6 9763.3 9796.2 9570.2 9582.8 9884.9 9946.7 10005.1 6509.1 6800.7 6882.8 7115.2 7211.5 7820.0 9612.3 9990.5 10339.0 10431.8 10:53:57 INFO - PROCESS | 11803 | 10:53:57 INFO - PROCESS | 11803 | [#3] mootools.html Cycles:180 Average:5069.34 Median:5212.80 stddev:2828.24 (54.3%) stddev-sans-first:2822.22 10:53:57 INFO - PROCESS | 11803 | Values: 1331.0 1408.3 1443.6 1620.5 1684.4 7302.1 7840.2 7843.0 7848.5 7862.5 6446.2 6650.8 7193.3 7406.1 7649.9 2190.9 2222.5 2224.1 2226.7 2227.2 2166.6 2193.1 2209.0 2211.9 2213.1 2177.2 2184.1 2185.3 2188.6 2232.4 2117.2 2122.8 2124.1 2125.8 2126.3 2071.2 2098.2 2098.2 2100.1 2101.3 7644.3 7699.0 7704.5 7705.4 7712.3 4532.8 4676.2 4679.0 4680.5 4681.0 2733.7 2800.3 2897.2 2902.0 2918.4 851.6 891.4 904.4 905.2 921.2 10474.6 10502.7 10507.7 10519.5 10524.1 4035.8 4143.9 4263.3 4285.8 4292.8 8966.9 8974.8 8982.5 8985.3 8987.5 4626.7 4655.4 4661.8 4665.7 4666.7 3683.2 3824.3 4059.8 4269.8 4273.1 3522.8 3559.3 3672.8 3684.0 3691.1 1160.4 1197.7 1203.9 1205.9 1222.7 807.6 867.0 870.8 872.5 890.4 5203.3 5222.2 5302.9 5327.8 5371.0 388.5 396.3 399.4 420.0 423.0 3652.2 3826.8 3844.8 3875.8 3894.7 9196.7 9559.1 9649.9 9653.8 9673.1 8802.6 9076.1 9506.1 9543.2 9555.6 7043.6 7185.1 7198.4 7220.7 7221.2 5424.3 5487.7 5534.2 5564.4 5653.2 8430.5 8744.3 8750.2 8787.6 8811.9 8849.4 8893.2 8935.0 8949.0 8973.4 5889.5 6357.7 6417.8 6476.6 6479.6 7430.7 7578.4 7656.5 7660.7 7671.7 6532.0 6615.0 6626.3 6664.7 6918.8 6518.3 6556.2 6709.6 6759.8 6761.3 6055.6 6130.6 6137.5 6137.8 6138.6 4420.3 4491.5 4511.6 4515.3 4540.9 4538.0 4623.2 4638.1 4708.2 4819.3 10:53:57 INFO - PROCESS | 11803 | 10:53:57 INFO - PROCESS | 11803 | [#4] prototype.html Cycles:180 Average:4199.23 Median:4785.46 stddev:1211.83 (25.3%) stddev-sans-first:1179.21 10:53:57 INFO - PROCESS | 11803 | Values: 291.9 298.2 299.4 301.3 301.8 4785.3 4785.7 4786.2 4835.3 4844.8 4743.0 4744.2 4757.1 4778.3 4796.6 3568.8 3673.5 3690.9 3726.4 3735.0 3776.9 3792.4 3811.9 3821.3 3824.8 3743.4 3761.1 3768.3 3773.0 3778.6 3566.8 3630.9 3748.9 3762.1 3794.8 3323.2 3325.8 3331.5 3337.8 3346.4 4690.0 4693.9 4699.7 4719.3 4761.2 4222.9 4319.5 4319.9 4322.4 4333.1 4953.6 4975.7 4995.3 5003.9 5049.9 3652.6 3654.1 3658.6 3679.0 3696.7 5128.8 5228.7 5253.4 5283.8 5292.5 3725.5 3737.7 3739.9 3745.7 3766.9 3788.8 3828.2 3833.2 3834.7 3838.1 4300.3 4303.5 4315.8 4333.6 4334.4 4848.7 5010.4 5051.5 5056.5 5080.9 1313.3 1319.2 1331.2 1334.8 1335.7 840.7 864.2 865.2 875.5 882.6 4224.1 4381.6 4383.8 4384.6 4392.7 5157.8 5165.1 5168.7 5171.4 5174.6 4352.0 4360.6 4369.7 4376.3 4385.3 2590.4 2716.5 2745.8 2746.5 2757.9 4881.4 4881.9 4889.2 4911.8 4914.7 5075.4 5281.3 5291.7 5296.9 5332.7 4863.6 4884.2 4889.6 4897.2 4920.9 5174.1 5177.2 5179.9 5234.7 5271.0 4955.3 5075.0 5079.3 5103.8 5116.5 4851.9 4858.3 4904.3 4917.5 4925.9 3752.7 3758.4 3765.8 3798.6 3805.8 4993.8 5276.7 5278.7 5280.3 5285.4 5044.7 5055.5 5079.3 5082.6 5091.6 5079.9 5083.9 5086.4 5115.8 5169.0 4756.9 4942.2 4997.5 5010.4 5017.6 4865.2 4954.7 5064.5 5082.6 5158.9 5032.7 5060.3 5062.6 5068.1 5070.7 10:53:57 INFO - PROCESS | 11803 | 10:53:57 INFO - PROCESS | 11803 | [#5] yui.html Cycles:180 Average:17614.74 Median:588.69 stddev:25458.32 (4324.6%) stddev-sans-first:25497.68 10:53:57 INFO - PROCESS | 11803 | Values: 599.0 638.3 650.5 653.0 671.3 12158.8 12447.3 14042.9 14617.0 14674.3 14064.4 14218.6 14245.0 14255.9 14972.8 759.5 781.3 783.5 783.5 783.6 646.2 764.1 782.0 784.8 794.3 797.3 805.1 806.1 806.6 807.1 791.9 792.2 794.4 795.3 800.7 588.2 588.6 588.8 589.0 590.8 13533.1 13605.0 13620.7 13635.2 13639.5 12522.2 12561.2 12780.4 12916.5 12960.3 10158.0 10345.6 10414.8 10488.3 10933.5 3221.8 3246.2 3271.1 3288.0 3342.6 61822.5 62776.0 62843.7 63358.7 63387.0 9513.6 9638.4 9687.2 9711.5 10098.8 16791.9 18390.5 18397.2 18768.2 18840.2 6468.9 6757.1 6855.4 6890.2 7038.0 3723.3 3744.4 3775.5 3849.6 3919.1 2344.7 3132.7 3286.0 3307.7 3334.6 569.5 575.0 580.4 588.2 596.4 463.6 478.7 501.5 502.7 523.2 7891.8 8258.3 8805.8 9266.4 9701.6 475.8 540.4 545.2 553.0 604.3 3894.7 4024.6 4178.1 4212.5 4265.3 89584.0 93874.5 93984.5 94346.1 99989.5 85890.1 86041.0 86241.6 86262.1 89686.6 68336.7 75126.0 76005.6 76490.0 78774.6 7659.4 7871.9 7906.4 7927.9 8070.7 33708.0 42771.4 43103.6 43244.6 44569.3 63719.4 65634.3 65947.3 66757.7 67664.0 9837.4 10097.9 10277.2 10296.1 10323.3 11024.7 11350.1 11399.7 12038.6 12041.9 10988.5 11303.3 11435.3 11596.6 11692.3 9608.3 9833.6 9840.4 9869.6 10251.5 10473.7 10847.5 10869.6 11008.4 11067.5 8426.7 8438.2 8608.4 8615.1 8636.0 8578.3 8620.4 8697.7 9198.4 9223.7 10:53:57 INFO - PROCESS | 11803 | -------- Summary: end -------- 10:53:57 INFO - PROCESS | 11803 | 10:53:58 INFO - TEST-INFO | 11803: exit 0 10:53:58 INFO - TEST-OK | dromaeo_css | took 1118337ms 10:53:58 INFO - TEST-START | kraken 10:53:58 INFO - operating with platform_type : linux_ 10:53:58 INFO - Initialising browser for kraken test... 10:53:58 INFO - TEST-INFO | started process 11989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ6H_yQ/profile http://localhost:48296/getInfo.html) 10:54:01 INFO - PROCESS | 11989 | JavaScript error: , line 0: uncaught exception: undefined 10:54:02 INFO - PROCESS | 11989 | __metrics Screen width/height:1600/1200 10:54:02 INFO - PROCESS | 11989 | colorDepth:24 10:54:02 INFO - PROCESS | 11989 | Browser inner width/height: 1024/697 10:54:02 INFO - PROCESS | 11989 | __metrics 10:54:03 INFO - PROCESS | 11989 | 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:54:03 INFO - PROCESS | 11989 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:54:04 INFO - TEST-INFO | 11989: exit 0 10:54:04 INFO - Browser initialized. 10:54:04 INFO - Running cycle 1/1 for kraken test... 10:54:04 INFO - TEST-INFO | started process 12070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ6H_yQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:16 INFO - PROCESS | 12070 | RSS: Main: 159227904 10:54:16 INFO - PROCESS | 12070 | 10:54:18 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48296/tests/kraken/driver.html?testName=audio-beat-detection) 10:54:19 INFO - PROCESS | 12070 | RSS: Main: 215838720 10:54:19 INFO - PROCESS | 12070 | 10:54:22 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48296/tests/kraken/driver.html?testName=audio-dft) 10:54:23 INFO - PROCESS | 12070 | RSS: Main: 194285568 10:54:23 INFO - PROCESS | 12070 | 10:54:26 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48296/tests/kraken/driver.html?testName=audio-fft) 10:54:26 INFO - PROCESS | 12070 | RSS: Main: 272654336 10:54:26 INFO - PROCESS | 12070 | 10:54:29 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48296/tests/kraken/driver.html?testName=audio-oscillator) 10:54:29 INFO - PROCESS | 12070 | RSS: Main: 182104064 10:54:29 INFO - PROCESS | 12070 | 10:54:31 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:54:32 INFO - PROCESS | 12070 | RSS: Main: 186699776 10:54:32 INFO - PROCESS | 12070 | 10:54:35 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48296/tests/kraken/driver.html?testName=imaging-darkroom) 10:54:36 INFO - PROCESS | 12070 | RSS: Main: 222900224 10:54:36 INFO - PROCESS | 12070 | 10:54:39 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48296/tests/kraken/driver.html?testName=imaging-desaturate) 10:54:40 INFO - PROCESS | 12070 | RSS: Main: 216375296 10:54:40 INFO - PROCESS | 12070 | 10:54:43 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48296/tests/kraken/driver.html?testName=json-parse-financial) 10:54:44 INFO - PROCESS | 12070 | RSS: Main: 220024832 10:54:44 INFO - PROCESS | 12070 | 10:54:45 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:54:46 INFO - PROCESS | 12070 | RSS: Main: 186302464 10:54:46 INFO - PROCESS | 12070 | 10:54:48 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:54:48 INFO - PROCESS | 12070 | RSS: Main: 192802816 10:54:48 INFO - PROCESS | 12070 | 10:54:50 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:54:51 INFO - PROCESS | 12070 | RSS: Main: 196431872 10:54:51 INFO - PROCESS | 12070 | 10:54:54 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:54:55 INFO - PROCESS | 12070 | RSS: Main: 191647744 10:54:55 INFO - PROCESS | 12070 | 10:54:57 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:54:58 INFO - PROCESS | 12070 | RSS: Main: 194588672 10:54:58 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | Cycle 1(1): loaded http://localhost:48296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48296/tests/kraken/driver.html?testName=ai-astar) 10:55:00 INFO - PROCESS | 12070 | RSS: Main: 244420608 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | __start_tp_report 10:55:00 INFO - PROCESS | 12070 | _x_x_mozilla_page_load 10:55:00 INFO - PROCESS | 12070 | _x_x_mozilla_page_load_details 10:55:00 INFO - PROCESS | 12070 | |i|pagename|runs| 10:55:00 INFO - PROCESS | 12070 | |0;ai-astar;104;115;115;114;114;116;113;114;113;113 10:55:00 INFO - PROCESS | 12070 | |1;audio-beat-detection;148;123;130;185;126;124;149;128;180;123 10:55:00 INFO - PROCESS | 12070 | |2;audio-dft;161;160;163;160;162;161;164;163;162;160 10:55:00 INFO - PROCESS | 12070 | |3;audio-fft;75;76;76;119;75;79;74;75;103;77 10:55:00 INFO - PROCESS | 12070 | |4;audio-oscillator;86;91;126;86;85;85;127;85;85;125 10:55:00 INFO - PROCESS | 12070 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;116;117;117 10:55:00 INFO - PROCESS | 12070 | |6;imaging-darkroom;146;146;146;148;146;146;146;146;146;147 10:55:00 INFO - PROCESS | 12070 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 10:55:00 INFO - PROCESS | 12070 | |8;json-parse-financial;64;62;62;63;62;64;62;61;64;63 10:55:00 INFO - PROCESS | 12070 | |9;json-stringify-tinderbox;66;66;65;66;67;66;65;67;66;65 10:55:00 INFO - PROCESS | 12070 | |10;stanford-crypto-aes;80;80;81;81;81;81;90;80;79;83 10:55:00 INFO - PROCESS | 12070 | |11;stanford-crypto-ccm;139;131;128;130;128;127;129;133;174;130 10:55:00 INFO - PROCESS | 12070 | |12;stanford-crypto-pbkdf2;171;164;163;166;166;176;164;165;175;167 10:55:00 INFO - PROCESS | 12070 | |13;stanford-crypto-sha256-iterative;67;68;66;66;66;71;67;66;67;65 10:55:00 INFO - PROCESS | 12070 | __end_tp_report 10:55:00 INFO - PROCESS | 12070 | __start_cc_report 10:55:00 INFO - PROCESS | 12070 | _x_x_mozilla_cycle_collect,2003 10:55:00 INFO - PROCESS | 12070 | __end_cc_report 10:55:00 INFO - PROCESS | 12070 | __startTimestamp1469728500571__endTimestamp 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | ------- Summary: start ------- 10:55:00 INFO - PROCESS | 12070 | Number of tests: 14 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.35 (2.9%) stddev-sans-first:1.05 10:55:00 INFO - PROCESS | 12070 | Values: 104.0 115.0 115.0 114.0 114.0 116.0 113.0 114.0 113.0 113.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:139.00 stddev:23.61 (17.0%) stddev-sans-first:24.93 10:55:00 INFO - PROCESS | 12070 | Values: 148.0 123.0 130.0 185.0 126.0 124.0 149.0 128.0 180.0 123.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.50 10:55:00 INFO - PROCESS | 12070 | Values: 161.0 160.0 163.0 160.0 162.0 161.0 164.0 163.0 162.0 160.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:15.34 (20.3%) stddev-sans-first:16.01 10:55:00 INFO - PROCESS | 12070 | Values: 75.0 76.0 76.0 119.0 75.0 79.0 74.0 75.0 103.0 77.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:85.00 stddev:19.34 (22.8%) stddev-sans-first:20.01 10:55:00 INFO - PROCESS | 12070 | Values: 86.0 91.0 126.0 86.0 85.0 85.0 127.0 85.0 85.0 125.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:55:00 INFO - PROCESS | 12070 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:55:00 INFO - PROCESS | 12070 | Values: 146.0 146.0 146.0 148.0 146.0 146.0 146.0 146.0 146.0 147.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 10:55:00 INFO - PROCESS | 12070 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:1.06 (1.7%) stddev-sans-first:1.01 10:55:00 INFO - PROCESS | 12070 | Values: 64.0 62.0 62.0 63.0 62.0 64.0 62.0 61.0 64.0 63.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 10:55:00 INFO - PROCESS | 12070 | Values: 66.0 66.0 65.0 66.0 67.0 66.0 65.0 67.0 66.0 65.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:3.13 (3.9%) stddev-sans-first:3.27 10:55:00 INFO - PROCESS | 12070 | Values: 80.0 80.0 81.0 81.0 81.0 81.0 90.0 80.0 79.0 83.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:130.50 stddev:14.16 (10.9%) stddev-sans-first:14.94 10:55:00 INFO - PROCESS | 12070 | Values: 139.0 131.0 128.0 130.0 128.0 127.0 129.0 133.0 174.0 130.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:166.50 stddev:4.67 (2.8%) stddev-sans-first:4.80 10:55:00 INFO - PROCESS | 12070 | Values: 171.0 164.0 163.0 166.0 166.0 176.0 164.0 165.0 175.0 167.0 10:55:00 INFO - PROCESS | 12070 | 10:55:00 INFO - PROCESS | 12070 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.66 (2.5%) stddev-sans-first:1.76 10:55:00 INFO - PROCESS | 12070 | Values: 67.0 68.0 66.0 66.0 66.0 71.0 67.0 66.0 67.0 65.0 10:55:00 INFO - PROCESS | 12070 | -------- Summary: end -------- 10:55:00 INFO - PROCESS | 12070 | 10:55:01 INFO - TEST-INFO | 12070: exit 0 10:55:01 INFO - TEST-OK | kraken | took 63011ms 10:55:01 INFO - SUITE-END | took 1181s 10:55:01 INFO - Completed test suite (00:19:41) 10:55:01 INFO - javascript benchmark 10:55:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2572.382628169239, 2573.3952521157535, 2612.229392329263, 2630.789536837053, 2632.6182703507993, 4469.262571675669, 4569.977150114253, 4674.368960190373, 4677.555632214939, 4688.859334219975, 4604.240300350438, 4666.580007799297, 4689.835855745049, 4693.859184224479, 4729.983053643466, 4240.512341080785, 4274.337477690963, 4317.330813723878, 4331.4802223733195, 4426.933595996063, 4244.278472659656, 4367.235733746597, 4401.889952751191, 4406.383106365111, 4450.688451808374, 4164.7917604119675, 4213.094184750263, 4325.805338759764, 4326.351047342892, 4383.430154079981, 4186.455760751083, 4233.682473814476, 4251.574842515754, 4268.615824575772, 4312.3531470279395, 4221.324588065895, 4228.830846766125, 4234.364845273203, 4268.530461649216, 4284.635805956497, 4535.092981403733, 4641.930371044437, 4660.953390466119, 4679.134360143385, 4719.38647975761, 4879.975600122012, 4910.06708725341, 4929.285253638238, 4984.22744474607, 4996.775145118442, 5005.749712514396, 5023.32185155003, 5026.019926114409, 5033.798648054073, 5036.84889453317, 4547.977260113678, 4679.485256621769, 4680.485146633868, 4684.95315046852, 4685.484596694361, 5058.822941197041, 5102.617303702237, 5114.846554603368, 5164.354455693038, 5185.533302002837, 4970.478099799541, 4974.07979523782, 4974.651774375831, 4976.676516026447, 4977.104121258136, 4806.134895718735, 4989.525995030466, 5030.270610761419, 5035.79856805731, 5045.5459008689395, 4910.975445122752, 4974.27872958419, 4979.551840334388, 5029.17018691919, 5054.671446355975, 4955.331030310934, 4967.801287948514, 4977.352944117241, 4983.5763960063805, 5025.597952163818, 4253.574642535722, 4255.319148936155, 4258.8296468140925, 4269.530351661315, 4306.4832220133785, 3612.945805812915, 3648.343298206348, 3712.2204337088974, 3764.0401697566945, 3799.848006079781, 4334.371516130143, 4336.82652693895, 4353.804078816461, 4372.40972468719, 4393.912121757611, 5088.618353623493, 5088.974555127201, 5089.083964886356, 5098.158803797406, 5133.589312854962, 4112.136451345251, 4258.74447533149, 4295.312749959991, 4314.223439780807, 4373.059792144641, 4550.840720574764, 4562.041971186088, 4575.17646823575, 4601.240795268744, 4607.562281583244, 4783.306420568998, 4788.784504697297, 4789.209780386336, 4797.352357431771, 4829.034193161311, 4847.442544107473, 4955.6531042826655, 4963.875903102451, 4995.300657907968, 5067.037262920034, 4728.101660684459, 4729.550692684327, 4734.242521196592, 4747.810087596596, 4768.594669452997, 4909.4354149273295, 4912.189488734319, 4930.827421040246, 4938.08645400602, 4967.776450059829, 4915.705057696549, 4942.036302921039, 4986.052649996489, 5010.49895010496, 5039.0929632666475, 4877.463479017234, 4879.243717223836, 4885.1450996076255, 4925.16272233714, 4925.556699897026, 4873.415190177201, 4877.926831097608, 4880.0, 4880.1215781159735, 4913.778879950482, 4653.953460465352, 4736.313234581035, 4768.880777980578, 4830.9275360870315, 4858.927116093332, 4892.437369702529, 4907.190313598359, 4908.263760435963, 4947.3073769671555, 4956.8760780980765, 4794.904101918012, 4803.471618122074, 4803.5916947058495, 4810.95189048119, 4837.37114175155], "value": 4595.2308628157425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.4978165938865, 587.3509771702271, 587.8765459253557, 598.2073752278233, 604.989667255683, 26976.190714278553, 38281.425778613346, 39162.80418597903, 39218.215635687266, 39227.21545569087, 38667.80666096673, 39125.80437097818, 39219.0, 39244.607553924456, 39266.41100383497, 7411.592362420065, 7785.64964576594, 7924.683012679486, 7928.80177995549, 7932.524048557105, 7520.849583008337, 7630.580318082503, 7636.923630763677, 9890.20878329732, 10082.243831712614, 10162.08541231289, 10248.12890904274, 10252.077313041826, 10254.384736915772, 10260.127889129395, 10059.144972677295, 10099.747506312327, 10114.039166279192, 10124.645637402655, 10125.240606954434, 9935.95672454389, 10006.79986400268, 10010.799784004279, 10013.89986100137, 10017.39895606266, 37935.8103209485, 38045.048873778374, 38168.427473587915, 38194.42708359377, 38203.23593528142, 2919.5328747400526, 2954.763618910482, 2966.42154779818, 3008.278013276798, 3008.714172153642, 29026.85486572575, 29096.709032909825, 29553.70446295531, 29710.702892971225, 30903.845480772452, 3386.881459148918, 3456.654334566548, 3532.540769699948, 3555.982220088909, 3567.7502574819773, 239944.0, 240975.0, 241965.79017104802, 243335.78332108402, 244362.0, 50953.961841525925, 51093.23360149601, 51108.48891511112, 51167.744161278955, 51194.23208651873, 32262.838685806422, 33353.3329333412, 33402.164945876546, 34732.47901281483, 34779.478307825404, 13325.466981320833, 13411.530596429273, 13427.12723672958, 13453.932730336286, 13479.663008424868, 11630.88369116298, 11737.941310293394, 11742.412879356169, 11746.94126529379, 11752.059835213162, 15941.44204952821, 17479.825201748074, 18006.099695015197, 18029.368972085915, 18426.63146737058, 6710.966445167743, 6878.484113691493, 6891.310868913069, 6937.514373993873, 7040.929590704028, 901.2834796336928, 917.3578495053489, 922.7462447826902, 945.3099237556622, 1017.7710015246511, 28299.0, 28709.28226794305, 28747.0, 29238.56142157869, 29258.853705731333, 900.1268769293774, 912.4342907397323, 955.9330846840654, 962.259060523393, 983.0218932162401, 15122.773158402633, 15164.469243576643, 15232.771508427382, 15441.691166176613, 15475.922620386826, 387775.0, 460241.0, 474319.0, 476861.0, 791968.0, 49355.25967110496, 49903.50096499061, 49941.75029124831, 49970.250446243335, 50015.0, 1199.976000480003, 1214.2168301445695, 1239.659093749208, 1240.0761432732672, 1247.5049900199601, 27605.171844844688, 28571.0, 29103.272418189714, 29133.56299655549, 29409.0, 42589.5741042598, 42757.78621106874, 42992.78503607587, 43047.13905721805, 43271.0, 361093.0, 364309.0, 365063.0, 365087.0, 365494.0, 25484.362890927874, 25766.09818656338, 25940.740592593833, 26115.347116322246, 26116.8694156528, 41511.169776603696, 41534.37698434466, 41616.79191604022, 41718.0, 41780.791096044326, 35493.29013419769, 35499.82250088733, 35552.822235888656, 36112.81943590265, 36651.633483664824, 35103.0, 35294.0, 35308.47037294391, 35730.821345893106, 36350.0, 34851.30297393987, 35026.299474010884, 35167.0, 35346.64653353434, 35365.46951795777, 30900.690993089782, 32174.19564510906, 32307.838460807547, 32701.18247043843, 32935.0, 24887.0, 24916.875415622806, 24972.50054998926, 25180.49639007246, 25395.6190657144], "value": 17866.297201144436, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.1529223418634, 342.3409935873444, 345.13626417346336, 346.6031394053808, 359.2670951259431, 12807.423665935032, 16120.193990300482, 16398.590035249126, 18145.820521666083, 18341.908290458563, 17430.0, 17520.737188942145, 17555.0, 17559.561010974732, 17690.557736056606, 5110.540051395374, 5293.9735301323435, 5536.058869992111, 5577.330720313568, 5652.321721393439, 3473.235888104613, 5572.944270557283, 5613.494785469307, 5614.691191984439, 5855.385184555603, 6102.72537735803, 6173.81478555644, 6199.44205021548, 6202.9379706203035, 6209.658468784215, 5489.725513724298, 5502.339719233718, 5520.91718624221, 5831.620944638627, 6177.196964394622, 5347.652402593858, 5351.57187425005, 5362.651427657229, 5368.32895888014, 5369.006733754229, 13189.670258243621, 20851.791482085137, 20939.68590471144, 20984.0, 20999.79000210009, 1919.712043193532, 1932.9613407731767, 1963.9410817675493, 2140.903659335318, 2240.7535171131326, 8788.8681669775, 9640.42157470547, 9875.950620246853, 10921.017108460197, 13645.727085458235, 1717.3130747700895, 1782.6256486137927, 1789.973150402745, 1817.264008076731, 1824.2338217948493, 66956.6652166741, 68554.0, 68952.6552367235, 69987.95018074784, 70421.6478917602, 9685.370450920667, 9736.269779766546, 9814.803703925882, 9863.654772083086, 9935.751606209758, 13258.204507729373, 13304.0, 13326.267055311857, 13344.06591538583, 13347.332633368487, 7060.505764596532, 7178.820529486805, 7213.314735100157, 7339.74310899116, 7401.222871598512, 6821.386075253251, 6965.756198533027, 7057.541259818198, 7087.562532171893, 7101.751438699621, 4143.875683729493, 4168.062186008185, 4194.580541945842, 4229.725067870579, 4322.654187664979, 1696.134971164715, 1789.6689112514227, 1803.2156012134762, 1808.8655386643625, 1816.9000704961354, 696.5437638346891, 809.0, 824.5588610093571, 846.2552953400967, 914.3188324698009, 16846.57883552921, 16895.32418703238, 17090.743638845426, 17249.482515524553, 17832.821671783116, 791.7783020754198, 837.8366218587317, 850.1753299299669, 860.5181098584687, 866.207420210513, 9634.13292803651, 9797.951010244904, 9872.802543949081, 9905.0, 9928.553215105338, 395124.0, 408700.0, 415985.0, 420715.4821129435, 421416.0, 75479.0, 77377.0, 79024.60487697525, 81198.0, 81408.0, 940.830650482906, 943.297243553557, 943.6225509796136, 943.7640589852537, 974.2790335152079, 15990.760138597698, 16034.438794642132, 16556.586085347964, 16671.58321041935, 16731.498055058368, 38264.80867595644, 38560.0, 38863.50228479451, 39451.80274098611, 40466.1906761869, 53956.190657140956, 55153.0, 55829.072933726995, 56617.0, 56670.43329566817, 6784.76253331131, 6862.794116176323, 7037.296270372922, 7077.363037326665, 7097.82255443618, 10620.362778233331, 10856.891431085904, 10882.782344353227, 10897.237193396386, 11009.229353945148, 9090.545472726206, 9513.762155946157, 9613.327067105236, 9879.160271376726, 9903.801923961337, 8923.776905577413, 9082.45505269686, 9461.621535138518, 9763.267754918552, 9796.167325777104, 9570.234381249344, 9582.760430989281, 9884.851727223953, 9946.701598952042, 10005.099541041342, 6509.088727578048, 6800.659967001531, 6882.793516194522, 7115.217326094022, 7211.459140564583, 7820.0224971878515, 9612.327137100336, 9990.450525221182, 10339.0, 10431.843522347323], "value": 8198.36445250942, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.993345033275, 1408.2677007955863, 1443.566929921024, 1620.4976457298246, 1684.3599432215756, 7302.123745150576, 7840.176781437938, 7842.960785196073, 7848.450608457396, 7862.488938219019, 6446.2264528256555, 6650.767223147191, 7193.3166349196745, 7406.148292946313, 7649.92350076499, 2190.868547887132, 2222.5443784024237, 2224.065892325219, 2226.7105276314055, 2227.164813195052, 2166.555856049506, 2193.111789725156, 2209.0390680054147, 2211.8562293450955, 2213.0705103856417, 2177.2162021672184, 2184.1045171479695, 2185.2897808212315, 2188.595109904673, 2232.4195709115666, 2117.153138744507, 2122.8407869409702, 2124.1291070660955, 2125.8299336053233, 2126.340834341351, 2071.161179722215, 2098.213170061227, 2098.223657246828, 2100.1074543319182, 2101.2540548105353, 7644.273793989562, 7699.0, 7704.499207551491, 7705.383569314441, 7712.305892469649, 4532.796024178887, 4676.228422310314, 4679.040796636681, 4680.461746899116, 4680.976595117037, 2733.6992930777596, 2800.2859270885997, 2897.1887871396043, 2901.970980290212, 2918.357961248522, 851.638053827121, 891.3671293381642, 904.3850181876321, 905.2395987370641, 921.1893533690377, 10474.58101675932, 10502.68491945243, 10507.684769456851, 10519.526621301984, 10524.052835244865, 4035.7780322082567, 4143.875683729493, 4263.253930562139, 4285.8285668573535, 4292.849750258789, 8966.86549701755, 8974.775630609156, 8982.461052336881, 8985.281177505783, 8987.46075235488, 4626.699264547861, 4655.4180727409075, 4661.836835710734, 4665.743384113906, 4666.696664716783, 3683.171286460525, 3824.29250588642, 4059.837606495707, 4269.786510674454, 4273.1026484438, 3522.771019883751, 3559.341521818472, 3672.7979961102396, 3684.0421490412687, 3691.1325838427947, 1160.4023927677254, 1197.6826141072622, 1203.939803009846, 1205.9457324420423, 1222.6759908624222, 807.6284908941835, 867.0072766682114, 870.7823044238941, 872.4895935877582, 890.3856339125982, 5203.349581302337, 5222.2427747976335, 5302.92045619316, 5327.840164795062, 5371.006363822706, 388.5473423461692, 396.2570180910792, 399.40688078203846, 419.9643030342394, 423.0439207391318, 3652.196516766307, 3826.789526576065, 3844.788536630512, 3875.8449662013204, 3894.6884249260556, 9196.724098277062, 9559.139677429064, 9649.855252171223, 9653.758656033655, 9673.081057299545, 8802.559872006374, 9076.09239076087, 9506.096920792514, 9543.188828949616, 9555.569999350046, 7043.647817609201, 7185.137783466018, 7198.388137008413, 7220.67506962188, 7221.205667376585, 5424.321959755031, 5487.725613719378, 5534.1975413565615, 5564.415736347625, 5653.208550802973, 8430.494170349799, 8744.300455963381, 8750.168733970262, 8787.648494060166, 8811.911880881109, 8849.4247873888, 8893.24407425376, 8934.955325223593, 8949.0, 8973.416727912665, 5889.528837692888, 6357.745690172342, 6417.7753778617525, 6476.579022363531, 6479.643619600967, 7430.7027718892805, 7578.393728501596, 7656.4640475168435, 7660.73187438437, 7671.654775535226, 6532.0, 6615.0, 6626.253345583783, 6664.7000884959325, 6918.757843475454, 6518.348165183444, 6556.246031706415, 6709.630970296681, 6759.797206083826, 6761.3238676132, 6055.576109672281, 6130.570860039755, 6137.508999279958, 6137.785177518944, 6138.57030007913, 4420.336949457607, 4491.528389519184, 4511.593956543927, 4515.34527493505, 4540.931886021646, 4537.977310113428, 4623.16782979067, 4638.1187574360765, 4708.199606067045, 4819.3252944588485], "value": 4028.369453968473, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.8832467013195, 298.1577044848303, 299.42360955161314, 301.2724270885808, 301.8460585101599, 4785.258284965836, 4785.66500344976, 4786.186348320785, 4835.347228124207, 4844.830430934918, 4742.976285118578, 4744.217204161309, 4757.0723708876785, 4778.283257511366, 4796.640251981098, 3568.803715795637, 3673.485712000322, 3690.926181476369, 3726.366517691999, 3734.9813250933707, 3776.9046976376817, 3792.374258247386, 3811.866584669537, 3821.2739579479808, 3824.827882745283, 3743.3823419135947, 3761.097336639214, 3768.340540405432, 3773.0, 3778.6410291022307, 3566.8038257895805, 3630.9273814523563, 3748.925021499582, 3762.1347090169415, 3794.761090956335, 3323.2356557991557, 3325.8004519728893, 3331.4669652855428, 3337.8497967591275, 3346.4478361070396, 4689.9765501172615, 4693.906121877578, 4699.7415142167165, 4719.339292499053, 4761.190597598416, 4222.859827846495, 4319.524852266248, 4319.870403887889, 4322.373255877911, 4333.133373325316, 4953.554180123806, 4975.651704380694, 4995.300657907896, 5003.924941125886, 5049.949500505021, 3652.6164752700847, 3654.104744337654, 3658.560972683295, 3679.0, 3696.722745794076, 5128.769205385729, 5228.686278823283, 5253.448387919251, 5283.829702178662, 5292.52367286946, 3725.4598083277774, 3737.6822970047306, 3739.9252014959548, 3745.662890339828, 3766.886993390203, 3788.8484460621817, 3828.1769419574925, 3833.21419109082, 3834.677036422486, 3838.136419305634, 4300.311950087971, 4303.505096913895, 4315.784210789448, 4333.609975102256, 4334.414853994734, 4848.7090774552935, 5010.448850626428, 5051.520105589963, 5056.469070747592, 5080.949190508121, 1313.3498918035443, 1319.22825147288, 1331.1613683379603, 1334.7864341705474, 1335.7261761338902, 840.6931470013401, 864.2265172670425, 865.2083343740406, 875.4747151709051, 882.5675419044622, 4224.134052519226, 4381.627561657295, 4383.7588932609015, 4384.6273066789045, 4392.7364358137975, 5157.793688252428, 5165.088917100697, 5168.741562921914, 5171.4311425743135, 5174.6377753557645, 4351.97824010878, 4360.629346505582, 4369.69412141147, 4376.277914144131, 4385.320275357325, 2590.404207032393, 2716.4974479721313, 2745.805574575066, 2746.4507098580366, 2757.8758955847034, 4881.438634557, 4881.926771098437, 4889.217725163957, 4911.7544122793715, 4914.72968986702, 5075.365579302587, 5281.287026251483, 5291.682499050069, 5296.947030529645, 5332.68003919766, 4863.610911127102, 4884.1941079722155, 4889.608831293559, 4897.1674815281485, 4920.901581968341, 5174.120399532164, 5177.171652535576, 5179.922301165561, 5234.743661521284, 5270.973645131749, 4955.256711493161, 5075.0, 5079.314292570456, 5103.77033033507, 5116.488351164854, 4851.902961940671, 4858.319835223142, 4904.288878112582, 4917.532834380728, 4925.876853078702, 3752.7373083883867, 3758.4362345648374, 3765.755225910307, 3798.5945200276074, 3805.771653700787, 4993.750312484434, 5276.657017293864, 5278.709670968134, 5280.257515019957, 5285.365756109291, 5044.672096313728, 5055.545000949932, 5079.288899554139, 5082.567981721447, 5091.567216786615, 5079.9238011429115, 5083.906960003617, 5086.389633243886, 5115.769790359368, 5168.9741551292, 4756.857294281177, 4942.184539550934, 4997.475265097112, 5010.423801262901, 5017.598592112695, 4865.221564549655, 4954.671304486886, 5064.5441910228255, 5082.602284371827, 5158.948410515847, 5032.723200224023, 5060.316857224375, 5062.620303477328, 5068.113080210875, 5070.670406423571], "value": 3814.9026710688436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.0475144520213, 638.2914964389527, 650.5381179362653, 653.0269897852202, 671.3219648155361, 12158.75682486352, 12447.253164810118, 14042.859571404295, 14617.049891757028, 14674.266286685663, 14064.437422503113, 14218.644533886658, 14245.0, 14255.857441425609, 14972.775408368883, 759.5290919629823, 781.2968328504363, 783.5103060587134, 783.5259667900895, 783.6356094416095, 646.1954866191599, 764.1021799385727, 782.0341877780936, 784.831261278825, 794.3010151067053, 797.3262593108814, 805.0540614777642, 806.1092492795465, 806.5604245686116, 807.1323327423014, 791.936645068396, 792.1523969352795, 794.3922898982283, 795.3438413308985, 800.7437619961614, 588.1589327262013, 588.5938702295402, 588.7762650192942, 588.9970550147265, 590.766647174368, 13533.120347177402, 13605.0, 13620.727585448334, 13635.181889086587, 13639.454421823115, 12522.248665080124, 12561.183523070971, 12780.360981950866, 12916.483340666362, 12960.287184204864, 10158.0, 10345.586176552928, 10414.791704165875, 10488.31825931312, 10933.453327333602, 3221.806691598488, 3246.2209069823307, 3271.1331497153274, 3287.96712032879, 3342.615599206098, 61822.454438638946, 62776.0, 62843.68578157126, 63358.68320658367, 63387.0, 9513.619455221851, 9638.4216946982, 9687.17658998979, 9711.5144242789, 10098.798024039625, 16791.867011978688, 18390.540236493925, 18397.172127254307, 18768.24927002932, 18840.246390144515, 6468.902966455413, 6757.121574195421, 6855.383015528626, 6890.2420733719255, 7037.964810175917, 3723.2925744109075, 3744.4383342498845, 3775.5091838060875, 3849.615038496128, 3919.0790164311366, 2344.718633763959, 3132.6710695376655, 3285.950710739341, 3307.68576985186, 3334.616519100286, 569.5102212097593, 574.9511291540266, 580.3500079910527, 588.1941739816479, 596.385722705614, 463.6082510278809, 478.7069935011257, 501.4759576242835, 502.7356199159118, 523.2360753300225, 7891.842163156704, 8258.298044666271, 8805.823883522293, 9266.44401335922, 9701.6119355225, 475.7621189405297, 540.394757871179, 545.2121684166342, 552.9549152102529, 604.332212904734, 3894.6689531389584, 4024.6254709721406, 4178.101708132705, 4212.53662097169, 4265.274903266452, 89584.0, 93874.53062734642, 93984.53007734918, 94346.07424589306, 99989.50005250072, 85890.14109858946, 86041.0, 86241.56879215564, 86262.13737862666, 89686.55156724305, 68336.6583167081, 75126.0, 76005.61997189978, 76490.0, 78774.606126969, 7659.387249020177, 7871.881921771063, 7906.446548741533, 7927.881081783893, 8070.717524886601, 33708.0, 42771.35842962296, 43103.568964309954, 43244.56755432405, 44569.331460027475, 63719.36280637134, 65634.34365656473, 65947.34052659413, 66757.66621167057, 67664.0, 9837.360571563111, 10097.949510252402, 10277.229207809294, 10296.124829389586, 10323.32898361604, 11024.669259922215, 11350.148738844455, 11399.662063395295, 12038.578649747216, 12041.858652087674, 10988.505517251582, 11303.321800691985, 11435.313881167156, 11596.594119205787, 11692.298462092302, 9608.327417080738, 9833.606655733976, 9840.40957542521, 9869.555869985725, 10251.48742562854, 10473.68578942633, 10847.511861966388, 10869.619563315562, 11008.449577520933, 11067.501962411872, 8426.705065322683, 8438.240558349778, 8608.440451370641, 8615.138486151334, 8635.956820215859, 8578.3334664857, 8620.353473489387, 8697.6955806549, 9198.402103863227, 9223.677171298972], "value": 6424.236685294931, "unit": "score"}], "name": "dromaeo_css", "value": 6364.424909783716, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 114.0, 114.0, 116.0, 113.0, 114.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 130.0, 185.0, 126.0, 124.0, 149.0, 128.0, 180.0, 123.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 160.0, 162.0, 161.0, 164.0, 163.0, 162.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 119.0, 75.0, 79.0, 74.0, 75.0, 103.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 126.0, 86.0, 85.0, 85.0, 127.0, 85.0, 85.0, 125.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 63.0, 62.0, 64.0, 62.0, 61.0, 64.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 65.0, 67.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 81.0, 81.0, 81.0, 90.0, 80.0, 79.0, 83.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 131.0, 128.0, 130.0, 128.0, 127.0, 129.0, 133.0, 174.0, 130.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 164.0, 163.0, 166.0, 166.0, 176.0, 164.0, 165.0, 175.0, 167.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 66.0, 71.0, 67.0, 66.0, 67.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1534.8000000000002, "alertThreshold": 2.0}]} 10:55:01 INFO - Return code: 0 10:55:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:55:01 INFO - # TBPL SUCCESS # 10:55:01 INFO - Running post-action listener: _resource_record_post_action 10:55:01 INFO - [mozharness: 2016-07-28 17:55:01.879573Z] Finished run-tests step (success) 10:55:01 INFO - Running post-run listener: _resource_record_post_run 10:55:01 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544141312; Read time: 12; Write time: 433664 10:55:01 INFO - TinderboxPrint: CPU usage
13.0% 10:55:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:55:01 INFO - TinderboxPrint: I/O write bytes / time
544,141,312 / 433,664 10:55:01 INFO - TinderboxPrint: CPU idle
8,321.0 (87.0%) 10:55:01 INFO - TinderboxPrint: CPU user
1,198.5 (12.5%) 10:55:01 INFO - TinderboxPrint: Swap in / out
0 / 0 10:55:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259907584; Read time: 0; Write time: 228812 10:55:01 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 283828224; Read time: 0; Write time: 204816 10:55:02 INFO - Running post-run listener: _upload_blobber_files 10:55:02 INFO - Blob upload gear active. 10:55:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:55:02 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:55:02 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:55:02 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:55:02 INFO - (blobuploader) - INFO - Open directory for files ... 10:55:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:55:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:03 INFO - (blobuploader) - INFO - Done attempting. 10:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:55:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:10 INFO - (blobuploader) - INFO - Done attempting. 10:55:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:55:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:55:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:11 INFO - (blobuploader) - INFO - Done attempting. 10:55:11 INFO - (blobuploader) - INFO - Iteration through files over. 10:55:11 INFO - Return code: 0 10:55:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:55:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:55:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/54e7ad88aef18acbb70298965afaf5eb80c48729305b93724e4d7f72a2137c02d0078a8d1624d98fcaa99079879db38330f6ea3f238b8c020d9936b08fec225e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/362add8fe74a8f3b2a6232c5b9dbcbfed76088b0aada28faed76e3a87160c3be98caef563b96362cef60fade45d6d9e68f486bd923b1893bf25f4d57a3b85314", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16b17d1eabb336d56f7af957a8dde319657e03b434998efb3b617d978cd71db2b13ff50169d476eeeab97ccd226a8aa8d26c406189fa21d160fde103561d596f"} 10:55:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:55:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:55:11 INFO - Contents: 10:55:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/54e7ad88aef18acbb70298965afaf5eb80c48729305b93724e4d7f72a2137c02d0078a8d1624d98fcaa99079879db38330f6ea3f238b8c020d9936b08fec225e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/362add8fe74a8f3b2a6232c5b9dbcbfed76088b0aada28faed76e3a87160c3be98caef563b96362cef60fade45d6d9e68f486bd923b1893bf25f4d57a3b85314", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16b17d1eabb336d56f7af957a8dde319657e03b434998efb3b617d978cd71db2b13ff50169d476eeeab97ccd226a8aa8d26c406189fa21d160fde103561d596f"} 10:55:11 INFO - Running post-run listener: copy_logs_to_upload_dir 10:55:11 INFO - Copying logs to upload dir... 10:55:11 INFO - mkdir: /builds/slave/test/build/upload/logs 10:55:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.023197 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-28 10:55:11.425037) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 10:55:11.428642) ========= 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=923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961 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-Non-PGO/sha512/54e7ad88aef18acbb70298965afaf5eb80c48729305b93724e4d7f72a2137c02d0078a8d1624d98fcaa99079879db38330f6ea3f238b8c020d9936b08fec225e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/362add8fe74a8f3b2a6232c5b9dbcbfed76088b0aada28faed76e3a87160c3be98caef563b96362cef60fade45d6d9e68f486bd923b1893bf25f4d57a3b85314", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16b17d1eabb336d56f7af957a8dde319657e03b434998efb3b617d978cd71db2b13ff50169d476eeeab97ccd226a8aa8d26c406189fa21d160fde103561d596f"} build_url:https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/R0crULN1RYOzZHrug_8mGA/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-Non-PGO/sha512/54e7ad88aef18acbb70298965afaf5eb80c48729305b93724e4d7f72a2137c02d0078a8d1624d98fcaa99079879db38330f6ea3f238b8c020d9936b08fec225e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/362add8fe74a8f3b2a6232c5b9dbcbfed76088b0aada28faed76e3a87160c3be98caef563b96362cef60fade45d6d9e68f486bd923b1893bf25f4d57a3b85314", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16b17d1eabb336d56f7af957a8dde319657e03b434998efb3b617d978cd71db2b13ff50169d476eeeab97ccd226a8aa8d26c406189fa21d160fde103561d596f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 10:55:11.454054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:55:11.454434) ========= 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=923d835db2ba3686ebe126b700000192-1469727270.427399-1429994961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:55:11.536899) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 10:55:11.537234) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 10:55:11.537517) ========= ========= Total master_lag: 0.17 =========