builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1469903100.19 results: success (0) buildid: 20160730083018 builduid: ddfd5044e6274c229969bf630c5fe947 revision: 5b500a963fd364f41d32422d5249233a124f85e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:00.187995) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:00.188464) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:00.188752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:00.250731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:00.251000) ========= 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=d2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 11:25:00-- 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% 227M=0s 2016-07-30 11:25:00 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139066 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:00.474566) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:00.474854) ========= 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=d2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017929 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:00.523888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:00.524212) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5b500a963fd364f41d32422d5249233a124f85e7 --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 5b500a963fd364f41d32422d5249233a124f85e7 --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=d2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 11:25:00,662 truncating revision to first 12 chars 2016-07-30 11:25:00,662 Setting DEBUG logging. 2016-07-30 11:25:00,662 attempt 1/10 2016-07-30 11:25:00,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5b500a963fd3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 11:25:00,989 unpacking tar archive at: fx-team-5b500a963fd3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.913877 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:01.454794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:01.455111) ========= script_repo_revision: 5b500a963fd364f41d32422d5249233a124f85e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:01.455565) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:01.455862) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 11:25:01.466964) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-30 11:25:01.467264) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:25:01 INFO - MultiFileLogger online at 20160730 11:25:01 in /builds/slave/test 11:25:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:25:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:25:01 INFO - {'append_to_log': False, 11:25:01 INFO - 'base_work_dir': '/builds/slave/test', 11:25:01 INFO - 'blob_upload_branch': 'Fx-Team', 11:25:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:25:01 INFO - 'branch': 'Fx-Team', 11:25:01 INFO - 'buildbot_json_path': 'buildprops.json', 11:25:01 INFO - 'config_files': ('talos/linux_config.py',), 11:25:01 INFO - 'default_actions': ('clobber', 11:25:01 INFO - 'read-buildbot-config', 11:25:01 INFO - 'download-and-extract', 11:25:01 INFO - 'populate-webroot', 11:25:01 INFO - 'create-virtualenv', 11:25:01 INFO - 'install', 11:25:01 INFO - 'run-tests'), 11:25:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:25:01 INFO - 'download_minidump_stackwalk': True, 11:25:01 INFO - 'download_symbols': 'ondemand', 11:25:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:25:01 INFO - 'tooltool.py': '/tools/tooltool.py', 11:25:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:25:01 INFO - '/tools/misc-python/virtualenv.py')}, 11:25:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:25:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:25:01 INFO - 'installer_path': 'installer.exe', 11:25:01 INFO - 'log_level': 'info', 11:25:01 INFO - 'log_name': 'talos', 11:25:01 INFO - 'log_to_console': True, 11:25:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:25:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:25:01 INFO - 'opt_config_files': (), 11:25:01 INFO - 'pip_index': False, 11:25:01 INFO - 'sps_profile': False, 11:25:01 INFO - 'sps_profile_interval': 0, 11:25:01 INFO - 'suite': 'dromaeojs', 11:25:01 INFO - 'system_bits': '32', 11:25:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:25:01 INFO - 'title': 'talos-linux64-ix-043', 11:25:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:25:01 INFO - 'use_talos_json': True, 11:25:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:25:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:25:01 INFO - 'work_dir': 'build'} 11:25:01 INFO - [mozharness: 2016-07-30 18:25:01.780818Z] Running clobber step. 11:25:01 INFO - Running pre-action listener: _resource_record_pre_action 11:25:01 INFO - Running main action method: clobber 11:25:01 INFO - rmtree: /builds/slave/test/build 11:25:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:25:02 INFO - Running post-action listener: _resource_record_post_action 11:25:02 INFO - [mozharness: 2016-07-30 18:25:02.202774Z] Finished clobber step (success) 11:25:02 INFO - [mozharness: 2016-07-30 18:25:02.202876Z] Running read-buildbot-config step. 11:25:02 INFO - Running pre-action listener: _resource_record_pre_action 11:25:02 INFO - Running main action method: read_buildbot_config 11:25:02 INFO - Using buildbot properties: 11:25:02 INFO - { 11:25:02 INFO - "project": "", 11:25:02 INFO - "product": "firefox", 11:25:02 INFO - "script_repo_revision": "production", 11:25:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:25:02 INFO - "repository": "", 11:25:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:25:02 INFO - "buildid": "20160730083018", 11:25:02 INFO - "pgo_build": "True", 11:25:02 INFO - "basedir": "/builds/slave/test", 11:25:02 INFO - "buildnumber": 326, 11:25:02 INFO - "slavename": "talos-linux64-ix-043", 11:25:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:25:02 INFO - "platform": "ubuntu64_hw", 11:25:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:25:02 INFO - "branch": "fx-team", 11:25:02 INFO - "repo_path": "integration/fx-team", 11:25:02 INFO - "revision": "5b500a963fd364f41d32422d5249233a124f85e7", 11:25:02 INFO - "stage_platform": "linux64-pgo", 11:25:02 INFO - "builduid": "ddfd5044e6274c229969bf630c5fe947", 11:25:02 INFO - "slavebuilddir": "test" 11:25:02 INFO - } 11:25:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:25:02 INFO - Running post-action listener: _resource_record_post_action 11:25:02 INFO - [mozharness: 2016-07-30 18:25:02.205309Z] Finished read-buildbot-config step (success) 11:25:02 INFO - [mozharness: 2016-07-30 18:25:02.205399Z] Running download-and-extract step. 11:25:02 INFO - Running pre-action listener: _resource_record_pre_action 11:25:02 INFO - Running main action method: download_and_extract 11:25:02 INFO - mkdir: /builds/slave/test/build/tests 11:25: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')]} 11:25:02 INFO - https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:25:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:25:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:25:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:25:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:25:05 INFO - Downloaded 1361 bytes. 11:25:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:25:05 INFO - Using the following test package requirements: 11:25:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:25:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:25:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:25:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:05 INFO - u'jsshell-linux-x86_64.zip'], 11:25:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:25:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:25:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:25:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:25:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:25:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:25:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:25:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:25:05 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')]} 11:25:05 INFO - https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:25:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:25:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:25:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:25:13 INFO - Downloaded 21803667 bytes. 11:25:13 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'] 11:25:13 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 11:25:14 INFO - Return code: 0 11:25:14 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 11:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:14 INFO - https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:25:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:25:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:25:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:25:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:25:20 INFO - Downloaded 21803667 bytes. 11:25:20 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'] 11:25:20 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 11:25:21 INFO - Return code: 0 11:25:21 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')]} 11:25:21 INFO - https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:25:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:25:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:25:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:25:22 INFO - Downloaded 14413723 bytes. 11:25:22 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'] 11:25:22 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 11:25:23 INFO - Return code: 0 11:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:23 INFO - https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:25:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:25:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:25:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:25:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:25:24 INFO - Downloaded 59376860 bytes. 11:25:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:25:24 INFO - mkdir: /builds/slave/test/properties 11:25:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:25:24 INFO - Writing to file /builds/slave/test/properties/build_url 11:25:24 INFO - Contents: 11:25:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:25:24 INFO - Running post-action listener: _resource_record_post_action 11:25:24 INFO - Running post-action listener: set_extra_try_arguments 11:25:24 INFO - [mozharness: 2016-07-30 18:25:24.895730Z] Finished download-and-extract step (success) 11:25:24 INFO - [mozharness: 2016-07-30 18:25:24.895891Z] Running populate-webroot step. 11:25:24 INFO - Running pre-action listener: _resource_record_pre_action 11:25:24 INFO - Running main action method: populate_webroot 11:25:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:25:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:25:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:25:24 INFO - '--tppagecycles', 11:25:24 INFO - '7'], 11:25:24 INFO - 'tests': ['tsvgm']}}, 11:25:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:25:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:25:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:25:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:25:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:25:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:25:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:24 INFO - 'talos_options': ['--disable-e10s'], 11:25:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:24 INFO - 'talos_options': ['--disable-e10s'], 11:25:24 INFO - 'tests': ['damp', 'tps']}, 11:25:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:24 INFO - 'tests': ['damp', 'tps']}, 11:25:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:25:24 INFO - 'tests': ['dromaeo_dom']}, 11:25:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:25:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:25:24 INFO - 'tests': ['basic_compositor_video']}, 11:25:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:25:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:25:24 INFO - 'tests': ['a11yr', 11:25:24 INFO - 'ts_paint', 11:25:24 INFO - 'tpaint', 11:25:24 INFO - 'sessionrestore', 11:25:24 INFO - 'sessionrestore_no_auto_restore', 11:25:24 INFO - 'tabpaint']}, 11:25:24 INFO - 'other-e10s': {'tests': ['a11yr', 11:25:24 INFO - 'ts_paint', 11:25:24 INFO - 'tpaint', 11:25:24 INFO - 'sessionrestore', 11:25:24 INFO - 'sessionrestore_no_auto_restore', 11:25:24 INFO - 'tabpaint']}, 11:25:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:25:24 INFO - 'ts_paint', 11:25:24 INFO - 'tpaint', 11:25:24 INFO - 'sessionrestore', 11:25:24 INFO - 'sessionrestore_no_auto_restore', 11:25:24 INFO - 'tabpaint']}, 11:25:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:25:24 INFO - 'ts_paint', 11:25:24 INFO - 'tpaint', 11:25:24 INFO - 'sessionrestore', 11:25:24 INFO - 'sessionrestore_no_auto_restore', 11:25:24 INFO - 'tabpaint']}, 11:25:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:25:24 INFO - 'tests': ['a11yr', 11:25:24 INFO - 'ts_paint', 11:25:24 INFO - 'tpaint', 11:25:24 INFO - 'sessionrestore', 11:25:24 INFO - 'sessionrestore_no_auto_restore', 11:25:24 INFO - 'tabpaint']}, 11:25:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:25:24 INFO - 'tests': ['a11yr', 11:25:24 INFO - 'ts_paint', 11:25:24 INFO - 'tpaint', 11:25:24 INFO - 'sessionrestore', 11:25:24 INFO - 'sessionrestore_no_auto_restore', 11:25:24 INFO - 'tabpaint']}, 11:25:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:25:24 INFO - 'tests': ['tsvgx', 11:25:24 INFO - 'tsvgr_opacity', 11:25:24 INFO - 'tart', 11:25:24 INFO - 'tscrollx', 11:25:24 INFO - 'cart']}, 11:25:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:25:24 INFO - 'tsvgr_opacity', 11:25:24 INFO - 'tart', 11:25:24 INFO - 'tscrollx', 11:25:24 INFO - 'cart']}, 11:25:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:24 INFO - 'talos_options': ['--disable-e10s'], 11:25:24 INFO - 'tests': ['tp5o']}, 11:25:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:24 INFO - 'tests': ['tp5o']}, 11:25:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:24 INFO - 'talos_options': ['--disable-e10s', 11:25:24 INFO - '--xperf_path', 11:25:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:24 INFO - 'tests': ['tp5n']}, 11:25:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:24 INFO - 'talos_options': ['--xperf_path', 11:25:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:24 INFO - 'tests': ['tp5n']}}, 11:25:24 INFO - 'talos.zip': {'path': '', 11:25:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:25:24 INFO - Running post-action listener: _resource_record_post_action 11:25:24 INFO - [mozharness: 2016-07-30 18:25:24.913433Z] Finished populate-webroot step (success) 11:25:24 INFO - [mozharness: 2016-07-30 18:25:24.913522Z] Running create-virtualenv step. 11:25:24 INFO - Running pre-action listener: _resource_record_pre_action 11:25:24 INFO - Running main action method: create_virtualenv 11:25:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:25:24 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 11:25:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:25:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:25:25 INFO - Using real prefix '/usr' 11:25:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:25:25 INFO - Installing distribute.............................................................................................................................................................................................done. 11:25:27 INFO - Installing pip.................done. 11:25:27 INFO - Return code: 0 11:25:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb3b0>, '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 0x23ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec740>, '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': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', '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 11:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:25:27 INFO - Using env: {'DISPLAY': ':0', 11:25:27 INFO - 'HOME': '/home/cltbld', 11:25:27 INFO - 'LANG': 'en_US.UTF-8', 11:25:27 INFO - 'LANGUAGE': 'en_US:en', 11:25:27 INFO - 'LOGNAME': 'cltbld', 11:25:27 INFO - 'MAIL': '/var/mail/cltbld', 11:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:27 INFO - 'MOZ_NO_REMOTE': '1', 11:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:27 INFO - 'NO_EM_RESTART': '1', 11:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:27 INFO - 'PWD': '/builds/slave/test', 11:25:27 INFO - 'SHELL': '/bin/bash', 11:25:27 INFO - 'SHLVL': '1', 11:25:27 INFO - 'TERM': 'linux', 11:25:27 INFO - 'TMOUT': '86400', 11:25:27 INFO - 'USER': 'cltbld', 11:25:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', 11:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:27 INFO - '_': '/tools/buildbot/bin/python'} 11:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:28 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 11:25:28 INFO - Cleaning up... 11:25:28 INFO - Return code: 0 11:25:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:28 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 0x212c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb3b0>, '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 0x23ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec740>, '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': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', '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 11:25:28 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 11:25:28 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 11:25:28 INFO - Using env: {'DISPLAY': ':0', 11:25:28 INFO - 'HOME': '/home/cltbld', 11:25:28 INFO - 'LANG': 'en_US.UTF-8', 11:25:28 INFO - 'LANGUAGE': 'en_US:en', 11:25:28 INFO - 'LOGNAME': 'cltbld', 11:25:28 INFO - 'MAIL': '/var/mail/cltbld', 11:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:28 INFO - 'MOZ_NO_REMOTE': '1', 11:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:28 INFO - 'NO_EM_RESTART': '1', 11:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:28 INFO - 'PWD': '/builds/slave/test', 11:25:28 INFO - 'SHELL': '/bin/bash', 11:25:28 INFO - 'SHLVL': '1', 11:25:28 INFO - 'TERM': 'linux', 11:25:28 INFO - 'TMOUT': '86400', 11:25:28 INFO - 'USER': 'cltbld', 11:25:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', 11:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:28 INFO - '_': '/tools/buildbot/bin/python'} 11:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:28 INFO - Downloading/unpacking psutil>=3.1.1 11:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:30 INFO - Installing collected packages: psutil 11:25:30 INFO - Running setup.py install for psutil 11:25:30 INFO - building 'psutil._psutil_linux' extension 11:25:30 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 11:25:31 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 11:25:31 INFO - building 'psutil._psutil_posix' extension 11:25:31 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 11:25:31 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 11:25:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:31 INFO - Successfully installed psutil 11:25:31 INFO - Cleaning up... 11:25:31 INFO - Return code: 0 11:25:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25:31 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')]} 11:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:31 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')]} 11:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:31 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 0x212c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb3b0>, '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 0x23ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec740>, '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': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', '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 11:25:31 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 11:25:31 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 11:25:31 INFO - Using env: {'DISPLAY': ':0', 11:25:31 INFO - 'HOME': '/home/cltbld', 11:25:31 INFO - 'LANG': 'en_US.UTF-8', 11:25:31 INFO - 'LANGUAGE': 'en_US:en', 11:25:31 INFO - 'LOGNAME': 'cltbld', 11:25:31 INFO - 'MAIL': '/var/mail/cltbld', 11:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:31 INFO - 'MOZ_NO_REMOTE': '1', 11:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:31 INFO - 'NO_EM_RESTART': '1', 11:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:31 INFO - 'PWD': '/builds/slave/test', 11:25:31 INFO - 'SHELL': '/bin/bash', 11:25:31 INFO - 'SHLVL': '1', 11:25:31 INFO - 'TERM': 'linux', 11:25:31 INFO - 'TMOUT': '86400', 11:25:31 INFO - 'USER': 'cltbld', 11:25:31 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', 11:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:31 INFO - '_': '/tools/buildbot/bin/python'} 11:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:34 INFO - Installing collected packages: mozsystemmonitor 11:25:34 INFO - Running setup.py install for mozsystemmonitor 11:25:34 INFO - Successfully installed mozsystemmonitor 11:25:34 INFO - Cleaning up... 11:25:34 INFO - Return code: 0 11:25:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25:34 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')]} 11:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:34 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')]} 11:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:34 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 0x212c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb3b0>, '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 0x23ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec740>, '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': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', '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 11:25:34 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 11:25:34 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 11:25:34 INFO - Using env: {'DISPLAY': ':0', 11:25:34 INFO - 'HOME': '/home/cltbld', 11:25:34 INFO - 'LANG': 'en_US.UTF-8', 11:25:34 INFO - 'LANGUAGE': 'en_US:en', 11:25:34 INFO - 'LOGNAME': 'cltbld', 11:25:34 INFO - 'MAIL': '/var/mail/cltbld', 11:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:34 INFO - 'MOZ_NO_REMOTE': '1', 11:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:34 INFO - 'NO_EM_RESTART': '1', 11:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:34 INFO - 'PWD': '/builds/slave/test', 11:25:34 INFO - 'SHELL': '/bin/bash', 11:25:34 INFO - 'SHLVL': '1', 11:25:34 INFO - 'TERM': 'linux', 11:25:34 INFO - 'TMOUT': '86400', 11:25:34 INFO - 'USER': 'cltbld', 11:25:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', 11:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:34 INFO - '_': '/tools/buildbot/bin/python'} 11:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:34 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:34 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 11:25:34 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 11:25:34 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 11:25:34 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 11:25:34 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 11:25:34 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 11:25:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25:36 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 11:25:36 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 11:25:36 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 11:25:36 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 11:25:36 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 11:25:36 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 11:25:36 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:36 INFO - warning: no files found matching '*.txt' 11:25:36 INFO - no previously-included directories found matching 'build' 11:25:36 INFO - no previously-included directories found matching 'dist' 11:25:36 INFO - no previously-included directories found matching '.git*' 11:25:36 INFO - Installing collected packages: jsonschema, functools32 11:25:36 INFO - Running setup.py install for functools32 11:25:36 INFO - warning: no files found matching '*.txt' 11:25:36 INFO - no previously-included directories found matching 'build' 11:25:36 INFO - no previously-included directories found matching 'dist' 11:25:36 INFO - no previously-included directories found matching '.git*' 11:25:36 INFO - Successfully installed jsonschema functools32 11:25:36 INFO - Cleaning up... 11:25:36 INFO - Return code: 0 11:25:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x212c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb3b0>, '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 0x23ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec740>, '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': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', '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 11:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:25:36 INFO - Using env: {'DISPLAY': ':0', 11:25:36 INFO - 'HOME': '/home/cltbld', 11:25:36 INFO - 'LANG': 'en_US.UTF-8', 11:25:36 INFO - 'LANGUAGE': 'en_US:en', 11:25:36 INFO - 'LOGNAME': 'cltbld', 11:25:36 INFO - 'MAIL': '/var/mail/cltbld', 11:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:36 INFO - 'MOZ_NO_REMOTE': '1', 11:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:36 INFO - 'NO_EM_RESTART': '1', 11:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:36 INFO - 'PWD': '/builds/slave/test', 11:25:36 INFO - 'SHELL': '/bin/bash', 11:25:36 INFO - 'SHLVL': '1', 11:25:36 INFO - 'TERM': 'linux', 11:25:36 INFO - 'TMOUT': '86400', 11:25:36 INFO - 'USER': 'cltbld', 11:25:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', 11:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:36 INFO - '_': '/tools/buildbot/bin/python'} 11:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:25:37 INFO - Cleaning up... 11:25:37 INFO - Return code: 0 11:25:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:37 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')]} 11:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:37 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')]} 11:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:37 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 0x212c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb3b0>, '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 0x23ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec740>, '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': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', '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 11:25:37 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 11:25:37 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 11:25:37 INFO - Using env: {'DISPLAY': ':0', 11:25:37 INFO - 'HOME': '/home/cltbld', 11:25:37 INFO - 'LANG': 'en_US.UTF-8', 11:25:37 INFO - 'LANGUAGE': 'en_US:en', 11:25:37 INFO - 'LOGNAME': 'cltbld', 11:25:37 INFO - 'MAIL': '/var/mail/cltbld', 11:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:37 INFO - 'MOZ_NO_REMOTE': '1', 11:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:37 INFO - 'NO_EM_RESTART': '1', 11:25:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:37 INFO - 'PWD': '/builds/slave/test', 11:25:37 INFO - 'SHELL': '/bin/bash', 11:25:37 INFO - 'SHLVL': '1', 11:25:37 INFO - 'TERM': 'linux', 11:25:37 INFO - 'TMOUT': '86400', 11:25:37 INFO - 'USER': 'cltbld', 11:25:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', 11:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:37 INFO - '_': '/tools/buildbot/bin/python'} 11:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:37 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:37 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 11:25:37 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 11:25:37 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 11:25:37 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 11:25:37 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 11:25:37 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 11:25:39 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:39 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 11:25:39 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 11:25:39 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 11:25:39 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 11:25:39 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 11:25:39 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 11:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:39 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 11:25:39 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 11:25:39 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 11:25:39 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 11:25:39 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 11:25:39 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 11:25:39 INFO - Downloading docopt-0.6.1.tar.gz 11:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:39 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:39 INFO - Running setup.py install for blobuploader 11:25:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:39 INFO - Running setup.py install for requests 11:25:40 INFO - Running setup.py install for docopt 11:25:40 INFO - Successfully installed blobuploader requests docopt 11:25:40 INFO - Cleaning up... 11:25:40 INFO - Return code: 0 11:25:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:40 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')]} 11:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:40 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')]} 11:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:40 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 0x212c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb3b0>, '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 0x23ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec740>, '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': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', '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 11:25:40 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 11:25:40 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 11:25:40 INFO - Using env: {'DISPLAY': ':0', 11:25:40 INFO - 'HOME': '/home/cltbld', 11:25:40 INFO - 'LANG': 'en_US.UTF-8', 11:25:40 INFO - 'LANGUAGE': 'en_US:en', 11:25:40 INFO - 'LOGNAME': 'cltbld', 11:25:40 INFO - 'MAIL': '/var/mail/cltbld', 11:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:40 INFO - 'MOZ_NO_REMOTE': '1', 11:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:40 INFO - 'NO_EM_RESTART': '1', 11:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:40 INFO - 'PWD': '/builds/slave/test', 11:25:40 INFO - 'SHELL': '/bin/bash', 11:25:40 INFO - 'SHLVL': '1', 11:25:40 INFO - 'TERM': 'linux', 11:25:40 INFO - 'TMOUT': '86400', 11:25:40 INFO - 'USER': 'cltbld', 11:25:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', 11:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:40 INFO - '_': '/tools/buildbot/bin/python'} 11:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:40 INFO - Running setup.py (path:/tmp/pip-222eb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:40 INFO - Running setup.py (path:/tmp/pip-YAv67q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:40 INFO - Running setup.py (path:/tmp/pip-oh5GWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:40 INFO - Running setup.py (path:/tmp/pip-I1lED2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:40 INFO - Running setup.py (path:/tmp/pip-8qsWNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:41 INFO - Running setup.py (path:/tmp/pip-NwsZgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:41 INFO - Running setup.py (path:/tmp/pip-yVdXur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:41 INFO - Running setup.py (path:/tmp/pip-oGHfN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:41 INFO - Running setup.py (path:/tmp/pip-Wyi1dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:41 INFO - Running setup.py (path:/tmp/pip-yIopeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:41 INFO - Running setup.py (path:/tmp/pip-TzTcdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:41 INFO - Running setup.py (path:/tmp/pip-KbDv7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:41 INFO - Running setup.py (path:/tmp/pip-fvKMa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:41 INFO - Running setup.py (path:/tmp/pip-MjJdFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:41 INFO - Running setup.py (path:/tmp/pip-ByzJVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:41 INFO - Running setup.py (path:/tmp/pip-9UJzFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:41 INFO - Running setup.py (path:/tmp/pip-DH4GVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:41 INFO - Running setup.py install for manifestparser 11:25:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Running setup.py install for mozcrash 11:25:42 INFO - Running setup.py install for mozdebug 11:25:42 INFO - Running setup.py install for mozdevice 11:25:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Running setup.py install for mozfile 11:25:42 INFO - Running setup.py install for mozhttpd 11:25:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Running setup.py install for mozinfo 11:25:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Running setup.py install for mozInstall 11:25:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Running setup.py install for mozleak 11:25:42 INFO - Running setup.py install for mozlog 11:25:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:42 INFO - Running setup.py install for moznetwork 11:25:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Running setup.py install for mozprocess 11:25:43 INFO - Running setup.py install for mozprofile 11:25:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Running setup.py install for mozrunner 11:25:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Running setup.py install for mozscreenshot 11:25:43 INFO - Running setup.py install for moztest 11:25:43 INFO - Running setup.py install for mozversion 11:25:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:43 INFO - Cleaning up... 11:25:43 INFO - Return code: 0 11:25:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:43 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 0x212c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb3b0>, '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 0x23ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec740>, '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': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', '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 11:25:43 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 11:25:43 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 11:25:43 INFO - Using env: {'DISPLAY': ':0', 11:25:43 INFO - 'HOME': '/home/cltbld', 11:25:43 INFO - 'LANG': 'en_US.UTF-8', 11:25:43 INFO - 'LANGUAGE': 'en_US:en', 11:25:43 INFO - 'LOGNAME': 'cltbld', 11:25:43 INFO - 'MAIL': '/var/mail/cltbld', 11:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:43 INFO - 'MOZ_NO_REMOTE': '1', 11:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:43 INFO - 'NO_EM_RESTART': '1', 11:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:43 INFO - 'PWD': '/builds/slave/test', 11:25:43 INFO - 'SHELL': '/bin/bash', 11:25:43 INFO - 'SHLVL': '1', 11:25:43 INFO - 'TERM': 'linux', 11:25:43 INFO - 'TMOUT': '86400', 11:25:43 INFO - 'USER': 'cltbld', 11:25:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', 11:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:43 INFO - '_': '/tools/buildbot/bin/python'} 11:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:43 INFO - Running setup.py (path:/tmp/pip-4m1vl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:43 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)) 11:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:43 INFO - Running setup.py (path:/tmp/pip-e45z3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:44 INFO - Running setup.py (path:/tmp/pip-mx7rkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:44 INFO - Running setup.py (path:/tmp/pip-vnSIrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:44 INFO - Running setup.py (path:/tmp/pip-9UGTTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:44 INFO - Running setup.py (path:/tmp/pip-_6J_zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:44 INFO - Running setup.py (path:/tmp/pip-IlDu3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:44 INFO - Running setup.py (path:/tmp/pip-CMZBoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:44 INFO - Running setup.py (path:/tmp/pip-Q9U9dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:44 INFO - Running setup.py (path:/tmp/pip-tzfMnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:44 INFO - Running setup.py (path:/tmp/pip-iaLyMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:44 INFO - Running setup.py (path:/tmp/pip-FEbKc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:44 INFO - Running setup.py (path:/tmp/pip-1AkGHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:44 INFO - Running setup.py (path:/tmp/pip-zfG3sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:44 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)) 11:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:44 INFO - Running setup.py (path:/tmp/pip-FhWN1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:45 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)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:45 INFO - Running setup.py (path:/tmp/pip-YlYIpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:45 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)) 11:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:45 INFO - Running setup.py (path:/tmp/pip-oWmsr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:45 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)) 11:25:45 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)) 11:25:45 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)) 11:25:45 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)) 11:25:45 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)) 11:25:45 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)) 11:25:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:45 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 11:25:45 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 11:25:45 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 11:25:45 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 11:25:45 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 11:25:45 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 11:25:47 INFO - Downloading blessings-1.6.tar.gz 11:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:47 INFO - Installing collected packages: blessings 11:25:47 INFO - Running setup.py install for blessings 11:25:47 INFO - Successfully installed blessings 11:25:47 INFO - Cleaning up... 11:25:47 INFO - Return code: 0 11:25:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:47 INFO - Reading from file tmpfile_stdout 11:25:47 INFO - Current package versions: 11:25:47 INFO - argparse == 1.2.1 11:25:47 INFO - blessings == 1.6 11:25:47 INFO - blobuploader == 1.2.4 11:25:47 INFO - docopt == 0.6.1 11:25:47 INFO - functools32 == 3.2.3-2 11:25:47 INFO - jsonschema == 2.5.1 11:25:47 INFO - manifestparser == 1.1 11:25:47 INFO - mozInstall == 1.12 11:25:47 INFO - mozcrash == 0.17 11:25:47 INFO - mozdebug == 0.1 11:25:47 INFO - mozdevice == 0.48 11:25:47 INFO - mozfile == 1.2 11:25:47 INFO - mozhttpd == 0.7 11:25:47 INFO - mozinfo == 0.9 11:25:47 INFO - mozleak == 0.1 11:25:47 INFO - mozlog == 3.3 11:25:47 INFO - moznetwork == 0.27 11:25:47 INFO - mozprocess == 0.23 11:25:47 INFO - mozprofile == 0.28 11:25:47 INFO - mozrunner == 6.12 11:25:47 INFO - mozscreenshot == 0.1 11:25:47 INFO - mozsystemmonitor == 0.3 11:25:47 INFO - moztest == 0.7 11:25:47 INFO - mozversion == 1.4 11:25:47 INFO - psutil == 3.1.1 11:25:47 INFO - requests == 1.2.3 11:25:47 INFO - wsgiref == 0.1.2 11:25:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:47 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 0x212c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb3b0>, '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 0x23ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec740>, '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': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', '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 11:25:47 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 11:25:47 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 11:25:47 INFO - Using env: {'DISPLAY': ':0', 11:25:47 INFO - 'HOME': '/home/cltbld', 11:25:47 INFO - 'LANG': 'en_US.UTF-8', 11:25:47 INFO - 'LANGUAGE': 'en_US:en', 11:25:47 INFO - 'LOGNAME': 'cltbld', 11:25:47 INFO - 'MAIL': '/var/mail/cltbld', 11:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:47 INFO - 'MOZ_NO_REMOTE': '1', 11:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:47 INFO - 'NO_EM_RESTART': '1', 11:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:47 INFO - 'PWD': '/builds/slave/test', 11:25:47 INFO - 'SHELL': '/bin/bash', 11:25:47 INFO - 'SHLVL': '1', 11:25:47 INFO - 'TERM': 'linux', 11:25:47 INFO - 'TMOUT': '86400', 11:25:47 INFO - 'USER': 'cltbld', 11:25:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', 11:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:47 INFO - '_': '/tools/buildbot/bin/python'} 11:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:47 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)) 11:25:47 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)) 11:25:47 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)) 11:25:47 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)) 11:25:47 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)) 11:25:47 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)) 11:25:47 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)) 11:25:47 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)) 11:25:47 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)) 11:25:47 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)) 11:25:47 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)) 11:25:47 INFO - Cleaning up... 11:25:47 INFO - Return code: 0 11:25:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ed180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23eb3b0>, '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 0x23ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec740>, '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': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', '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 11:25: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', 'jsonschema'] in /builds/slave/test/build 11:25: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 jsonschema 11:25:47 INFO - Using env: {'DISPLAY': ':0', 11:25:47 INFO - 'HOME': '/home/cltbld', 11:25:47 INFO - 'LANG': 'en_US.UTF-8', 11:25:47 INFO - 'LANGUAGE': 'en_US:en', 11:25:47 INFO - 'LOGNAME': 'cltbld', 11:25:47 INFO - 'MAIL': '/var/mail/cltbld', 11:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:47 INFO - 'MOZ_NO_REMOTE': '1', 11:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:47 INFO - 'NO_EM_RESTART': '1', 11:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:47 INFO - 'PWD': '/builds/slave/test', 11:25:47 INFO - 'SHELL': '/bin/bash', 11:25:47 INFO - 'SHLVL': '1', 11:25:47 INFO - 'TERM': 'linux', 11:25:47 INFO - 'TMOUT': '86400', 11:25:47 INFO - 'USER': 'cltbld', 11:25:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', 11:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:47 INFO - '_': '/tools/buildbot/bin/python'} 11:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:47 INFO - Cleaning up... 11:25:47 INFO - Return code: 0 11:25:47 INFO - Running post-action listener: _resource_record_post_action 11:25:47 INFO - Running post-action listener: _start_resource_monitoring 11:25:48 INFO - Starting resource monitoring. 11:25:48 INFO - [mozharness: 2016-07-30 18:25:48.005839Z] Finished create-virtualenv step (success) 11:25:48 INFO - [mozharness: 2016-07-30 18:25:48.006929Z] Running install step. 11:25:48 INFO - Running pre-action listener: _resource_record_pre_action 11:25:48 INFO - Running main action method: install 11:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:48 INFO - Reading from file tmpfile_stdout 11:25:48 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:48 INFO - Reading from file tmpfile_stdout 11:25:48 INFO - Output received: 11:25:48 INFO - Usage: mozinstall [options] installer 11:25:48 INFO - Options: 11:25:48 INFO - -h, --help show this help message and exit 11:25:48 INFO - -d DEST, --destination=DEST 11:25:48 INFO - Directory to install application into. [default: 11:25:48 INFO - "/builds/slave/test"] 11:25:48 INFO - --app=APP Application being installed. [default: firefox] 11:25:48 INFO - mkdir: /builds/slave/test/build/application 11:25:48 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'] 11:25:48 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 11:26:05 INFO - Reading from file tmpfile_stdout 11:26:05 INFO - Output received: 11:26:05 INFO - /builds/slave/test/build/application/firefox/firefox 11:26:05 INFO - Running post-action listener: _resource_record_post_action 11:26:05 INFO - [mozharness: 2016-07-30 18:26:05.157988Z] Finished install step (success) 11:26:05 INFO - [mozharness: 2016-07-30 18:26:05.158323Z] Running run-tests step. 11:26:05 INFO - Running pre-action listener: _resource_record_pre_action 11:26:05 INFO - Running main action method: run_tests 11:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:26:05 INFO - Python 2.7.3 11:26:05 INFO - Return code: 0 11:26:05 INFO - grabbing minidump binary from tooltool 11:26:05 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')]} 11:26:05 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 0x23eb3b0>, '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 0x23ec2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ec740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:26:05 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 11:26:05 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 11:26:05 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 11:26:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:26:05 INFO - Return code: 0 11:26:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:26:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:26:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:26:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:26:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 11:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 11:26:05 INFO - Using env: {'DISPLAY': ':0', 11:26:05 INFO - 'HOME': '/home/cltbld', 11:26:05 INFO - 'LANG': 'en_US.UTF-8', 11:26:05 INFO - 'LANGUAGE': 'en_US:en', 11:26:05 INFO - 'LOGNAME': 'cltbld', 11:26:05 INFO - 'MAIL': '/var/mail/cltbld', 11:26:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:05 INFO - 'MOZ_NO_REMOTE': '1', 11:26:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:05 INFO - 'NO_EM_RESTART': '1', 11:26:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:05 INFO - 'PWD': '/builds/slave/test', 11:26:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:05 INFO - 'SHELL': '/bin/bash', 11:26:05 INFO - 'SHLVL': '1', 11:26:05 INFO - 'TERM': 'linux', 11:26:05 INFO - 'TMOUT': '86400', 11:26:05 INFO - 'USER': 'cltbld', 11:26:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351', 11:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:05 INFO - '_': '/tools/buildbot/bin/python'} 11:26:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 11:26:05 INFO - mozversion application_buildid: 20160730083018 11:26:05 INFO - mozversion application_changeset: 5b500a963fd364f41d32422d5249233a124f85e7 11:26:05 INFO - mozversion application_display_name: Nightly 11:26:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:26:05 INFO - mozversion application_name: Firefox 11:26:05 INFO - mozversion application_remotingname: firefox 11:26:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:26:05 INFO - mozversion application_vendor: Mozilla 11:26:05 INFO - mozversion application_version: 50.0a1 11:26:05 INFO - mozversion platform_buildid: 20160730083018 11:26:05 INFO - mozversion platform_changeset: 5b500a963fd364f41d32422d5249233a124f85e7 11:26:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:26:05 INFO - mozversion platform_version: 50.0a1 11:26:05 INFO - using testdate: 1469903165 11:26:05 INFO - actual date: 1469903165 11:26:05 INFO - starting webserver on 'localhost:60049' 11:26:05 INFO - SUITE-START | Running 2 tests 11:26:05 INFO - TEST-START | dromaeo_css 11:26:05 INFO - operating with platform_type : linux_ 11:26:05 INFO - Initialising browser for dromaeo_css test... 11:26:05 INFO - TEST-INFO | started process 3337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE51V8a/profile http://localhost:60049/getInfo.html) 11:26:10 INFO - PROCESS | 3337 | __metrics Screen width/height:1600/1200 11:26:10 INFO - PROCESS | 3337 | colorDepth:24 11:26:10 INFO - PROCESS | 3337 | Browser inner width/height: 1024/697 11:26:10 INFO - PROCESS | 3337 | __metrics 11:26:11 INFO - PROCESS | 3337 | 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" 11:26:11 INFO - PROCESS | 3337 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:26:12 INFO - PROCESS | 3337 | console.error: PushService: 11:26:12 INFO - PROCESS | 3337 | stateChangeProcessEnqueue: Error transitioning state 11:26:12 INFO - PROCESS | 3337 | UnknownError 11:26:12 INFO - TEST-INFO | 3337: exit 0 11:26:12 INFO - Browser initialized. 11:26:12 INFO - Running cycle 1/1 for dromaeo_css test... 11:26:12 INFO - TEST-INFO | started process 3418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE51V8a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:24 INFO - PROCESS | 3418 | RSS: Main: 156278784 11:26:24 INFO - PROCESS | 3418 | 11:27:15 INFO - PROCESS | 3418 | 1469903235139 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] 11:29:24 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60049/tests/dromaeo/cssquery-ext.html) 11:29:25 INFO - PROCESS | 3418 | RSS: Main: 282484736 11:29:25 INFO - PROCESS | 3418 | 11:32:28 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60049/tests/dromaeo/cssquery-ext.html (next: http://localhost:60049/tests/dromaeo/cssquery-jquery.html) 11:32:28 INFO - PROCESS | 3418 | RSS: Main: 238546944 11:32:28 INFO - PROCESS | 3418 | 11:35:30 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60049/tests/dromaeo/cssquery-mootools.html) 11:35:31 INFO - PROCESS | 3418 | RSS: Main: 185778176 11:35:31 INFO - PROCESS | 3418 | 11:38:33 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60049/tests/dromaeo/cssquery-prototype.html) 11:38:33 INFO - PROCESS | 3418 | RSS: Main: 214065152 11:38:33 INFO - PROCESS | 3418 | 11:41:36 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60049/tests/dromaeo/cssquery-yui.html) 11:41:36 INFO - PROCESS | 3418 | RSS: Main: 187637760 11:41:36 INFO - PROCESS | 3418 | 11:44:39 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60049/tests/dromaeo/cssquery-yui.html (next: http://localhost:60049/tests/dromaeo/cssquery-dojo.html) 11:44:40 INFO - PROCESS | 3418 | RSS: Main: 277196800 11:44:40 INFO - PROCESS | 3418 | 11:44:40 INFO - PROCESS | 3418 | __start_tp_report 11:44:40 INFO - PROCESS | 3418 | _x_x_mozilla_page_load 11:44:40 INFO - PROCESS | 3418 | _x_x_mozilla_page_load_details 11:44:40 INFO - PROCESS | 3418 | |i|pagename|runs| 11:44:40 INFO - PROCESS | 3418 | |0;dojo.html;3061.142879993602;3072.692730726926;3089.3512362403894;3107.8601462934166;3126.8436578171086;5250.921236181461;5255.816046438375;5376.784928602856;5439.292891924049;5459.645123067003;5279.472052794718;5319.627626066177;5365.7585408656605;5373.086575282202;5439.5104440600335;4818.229083346657;4884.951150488503;4907.11671899058;4916.606671466274;4971.37857767779;4923;4952.579030782388;4958.305837182797;4976.552110310071;4979.925301120486;4768.928466073012;4801.207800712878;4813.3983252093485;4840.975795121037;4927.482614325498;4844.442889067767;4856.878578035542;4858.854234372974;4860.8298709545;4961.826336078256;4877.609791216694;4889.9511004889855;4912.091263116335;4912.189488734354;4936.827211047596;5240.082985477527;5287.867803304948;5349.946500534984;5354.571634269288;5442.047641662693;5760.567957403212;5773.509251713609;5810.564207684399;5814.709264536798;5816.796412125555;5808.651480911159;5811.4479124483105;5847.532197424196;5871.588988770788;5879.235699359056;5292.497212764782;5330.706811125387;5377.677339359651;5378.46215378463;5438.15708565173;6006.369331220247;6009.699515024231;6010.188624535632;6013.037913933749;6019.849503762353;5702.971485142631;5707.771689132388;5753.05074662676;5758.568107391879;5761.88476230473;5613.129964855372;5692.0608099663095;5727.255456790674;5745.971270143623;5863.3257175424515;5748.022836117786;5760.049591817303;5761.279840019997;5766.0197766379815;5795.594308398456;5720.685362305113;5726.627769194989;5773.509251713652;5781.248437703071;5783.450572195635;4372.366006928977;4402.889927751768;4410.1400226956075;4448.221561226773;4449.955500444954;3984.083660757984;4008.5590585035625;4009.3184158693093;4010.7794071325775;4011.578784227614;5396.703181325065;5425.972870135703;5478.534324582455;5485.122380419193;5491.7254137292975;5812.186293918855;5815.9709201453725;5828.154917537018;5861.472467477862;5873.911891321633;5378.865528361744;5432.130859062531;5432.320959880015;5444.26502422168;5449.591280653967;4842.249451335048;4917.065757506062;4956.628252881048;4974.1543937530705;4998.400191976986;5974.61165024272;6042.788502402483;6049.062395328643;6093.421124993207;6104.4505994460715;5730.627509211888;5767.68277744728;5777.74000169985;5787.247657804459;5796.8550786229;5872.29532456108;5924.348321684525;6015.759369625166;6044.123602077762;6057.333693293822;5625.071863142699;5685.857853553694;5688;5734.827955161351;5748.971255143698;5781.306243250837;5783.016887129283;5788.160716696139;5789.2763404574425;5791.218185544897;5452.563794896478;5544.029794785977;5636.239107720406;5636.464535869086;5640.520555752807;5576.60963732551;5621.831345059655;5627.803026894039;5670.461306175906;5680.233168522197;5561.6663000220115;5622.88754224905;5625.803096891589;5628.521575666115;5639.605227634026;5538.307711536058;5597.132444471114;5656.37779844225;5712;5722.399148089391;5491.890162196813;5545.611807173621;5550.139728342114;5604.8038318658655;5605.943940560705 11:44:40 INFO - PROCESS | 3418 | |1;ext.html;589.2840199158022;617.4011209127148;631.0660222870152;639.322318342557;657.0768070860443;30395.84802075989;31015.84492077542;33711.66288337116;33801.1549711257;33819.32361352771;44395.556044439545;45454.09091818162;45564.316535252;49143.50856491434;49278;8853.645854165825;8983.460992340448;8984.955075224614;8991.460512369245;8997.100289971017;8857.734267971971;8972.8654070189;8976.102389761038;8978.955105224464;8982.146696063863;8993;9028.232600228988;9041.593128309241;9047.185753282203;9049.638014479413;8959.28325733943;8990.05604411534;9003.684871029482;9009.864852027225;9018.458892466473;8832.293416526663;8881.42270752399;8957.149070838324;8957.193852553302;8970.686025989058;41319.7934010331;41438.585614143776;41461.1707765846;41473;41495.585044149775;3182.5703530023616;3230.337780754963;3375.1562109472634;3507.6316986716283;3846.903827404309;31427.84286078578;31462.370752585048;31780;32159.6784032159;32363.51454728181;4167.604077612622;4224.493060832689;4238.766867822269;4300.65594752419;4421.159979603865;271032;272292;272444;272457;273706;55325.170122448195;56039.71980140073;56087.15869261965;56162.15756763652;56220;53214.73392633012;59820.70089649524;59840.70079649661;60007.39992600105;60008;15995.680086398439;16673.33306667744;16682.666346673;16692.58268543296;16739.497815065566;13045.934770326277;13249.801252981213;13254.271015094262;13255.204687718768;13259.138156019828;15194.240287985556;16509.91745041291;17006.659866802594;17239.138043098046;17262.136893155293;6459.806205813833;6567.638779867058;6698.363655452724;6784.660766961632;6882.105326307548;919.2140719684573;1015.8730158730159;1171.6133675886938;1184.5025089462447;1196.0960063738603;33999.83000084984;34015.65984340174;34056.48915266273;34147.4877876832;34197.316053678784;1112.6328311657135;1137.971550711239;1182.532899504708;1192.952281908714;1199.7960346741074;16667.91666041662;17509.64980700379;17641.209128933308;17784.288628454717;17833.821661783477;534431;539255;546323;547229;548001;57994.4200557989;58004.70997644985;58069.41930580725;58244.708776455846;58365.41634583685;1294.223465920459;1346.986530134686;1349.838019437654;1352.2697743218748;1382.0601990646255;31354;33275.50086748749;33420.498692520116;33535.66464335325;34370.484442733876;52028.739856300475;52336;52421.7378913103;52516.47483525116;52650.736746316026;499651;500803.97588072415;501374;501721;502973;36262;42050;43208;43328;43389.783051085804;49179.754101229264;49353;49449.50550494449;49538.25692614542;51186.48813511966;41695.7915210422;42582;42867.785661071495;43039.35440968451;44728.32907506325;41953;42009.78995105005;42496.362554561085;43539.78230108829;44141.558584413746;42073.36889946715;42101.78949105235;43424;43804.78097609492;43810.78094609507;34344.48483272703;38262.6173738259;38297.808510957264;38343;38696.613033870424;28770;29065.418691625626;29128.7087129126;29346.55980160342;29377.55933660954 11:44:40 INFO - PROCESS | 3418 | |2;jquery.html;364.15697659917305;371.99256014879705;376.4877937914099;386.6423558208657;404.4156194299237;17335.13324333783;19458.983857502073;19582.11880465379;19778.90110549447;20005.499862503446;18669.626607467842;18955.724764511997;19153.52116197096;19191.232350705955;19328.613427731438;5302.416734159258;5777.826665200051;5954.07711804671;6005.879882402372;6006;5848.707564621752;5901.557383196256;5926.466618004379;5932.9406705932815;5941.85145371367;5671.376148623648;5807.361190269067;5848.2689663792025;5910.172575839386;5917.230760001194;5831.067029275296;5849.093390524433;5872.354041055481;5873.353931067579;5874.676892770896;5089.745512724349;5104.3619547556555;5235.110031294689;5236.24074509194;5237.895242095136;23379.88310058439;23444.882775586182;23532.29403117909;23580.29259122229;23618.527629447315;2343.4727186383097;2612.712601613821;2655.309619498925;3033.4388138194504;3088.984555077233;14118;14579.562613121623;15142.621434464116;15624.92187539055;15636;1816.2553353125156;1838.209569884949;1868.9252429902788;1906.780720217179;1991.6614175590184;78402.6079869597;78642;78812;80109;81463.59268203621;10259.743506412251;10261.486925653688;10492.842607360895;10502.579896804042;10802;14756.335964881606;14828.555143345717;14834.10995340283;14845.851541484446;14859.925700371645;8012.238837310446;8130.227628375294;8305;8324.958375208085;8400.621972011275;8047;8118.512889226666;8142.837143257102;8347.874781878276;8384.790380240544;6319.747210111636;6435.742570297136;6576.86846263072;6585.83535411609;6713.1272934519175;1864.9254029838926;1866.6640004799267;1887.7074053521726;1916.4154932745646;1929.3729537900238;928.1368327455531;1009.6213919780082;1022.6267412394571;1032.8244198486275;1116.6723164968278;19894.30369937045;20854.497460304556;20892.26877059326;21032.51046128729;21130;1002.674130907458;1010.1060561403211;1011.6206422591529;1022.616518805448;1044.9320794148357;11108.62195140169;11679.591214307458;11938.164328496921;11945.761084778256;11955.103367247491;515786;527794;528793;529401;536945;59836.10245846316;73104;73497.22141852338;76004.61997689976;76747.23252767402;968.8110818390346;995.0845222395413;1004.6785028790863;1008.5864795433837;1013.7110923386799;17638.82361176423;18107.728384073987;18446.81553184451;18453.907730461262;18514;39954.60045399509;40090.19819603533;40272.3959140619;40363.798181008904;40383;51277.7436112817;52108.73945630248;52247.21629175641;52523;52531;6860.794176174722;7584.924150758422;7691.692332306645;7917.099896025028;8146.592670366339;12789.232646041268;13078.149920255153;13090.345482725636;13115.540956066492;13127.737445251232;10909.127269818237;11051.58897621375;11352.432378381212;11777.88222117802;11922.52309907594;8438.198371154731;11317.943410283226;11527.711807204887;11622.88377116218;11644.941775291069;11523.942380288045;11804.461811439362;11831.940840295743;12144.14990950625;12200.938995304967;7332.560046397233;7618.504797188165;7724.884126737991;7753.92246077532;7964.522128672298;11107;11595.942020289845;11760.411979401168;11988.76022479563;12011.63965081049 11:44:40 INFO - PROCESS | 3418 | |3;mootools.html;1298.2340419152697;1453.8982271241011;1494.0438119603455;1590.2366863905324;1738.5740493579067;8576.485410875344;8849.734507964764;8934.061923498028;9189.862152067724;9199.080091990798;9008;9094.86357704635;9099.95450022749;9105.180533751962;9107;2354.6703461515403;2384.5350156719446;2395.9520809583796;2397.892094855727;2398.760123987596;2280.8631482111045;2336.4509340305017;2337.2170322941834;2340.9882950585306;2355.8704271265074;2293.873836938976;2298.7241531016302;2304.3893368257427;2351.2123438648073;2351.2240960483;2259.830512711553;2268.115434980359;2284.0749496453964;2287.714035745532;2301.6777651128855;2234.128689810975;2236.4520692430297;2238.9664155037685;2240.574290884727;2243.0354947372625;8959.552022398853;9080.909190908073;9090.2273306769;9154.267658587298;9161.633534658606;5127.692338459704;5310;5320.600954928396;5322.520973112439;5324.627276090675;3299.7525185611175;3310.4372256716415;3311.768176227665;3350.1959529712935;3356.8153751543655;1061.495789499989;1061.861957945462;1073.1951036722458;1085.9022687958043;1088.1729885287239;12589.622311330675;12717.809232861515;12743.299118548568;12753.10728249023;12769.425375858109;4306.569343065668;4368.213721530155;4517.638588912879;4520.073384956077;4563.748993805372;9886.406815591088;9894.703158905244;9895.109440150422;9908.35595686278;9909.752256193653;5261.631685782035;5281.841544753664;5285.392179899361;5294.100002999499;5296.629235953446;4293.957060429419;4757.452892917289;4869.513048695173;4915.0415668944925;4944.53026962438;3759.605241449663;3775.452559378875;3855.749376290532;3877.0501227199516;3933.940990885139;1104.640991677708;1110.21729680575;1117.8658560972572;1121.9495122719497;1122.966311010671;872.9214370706667;936.9016253293443;940.9790377440416;952.1383148250844;964.5225613321451;5921.638023254675;5975.223220981245;6179.351168127372;6183.907241391383;6225.782097626561;925.6713866577268;961.4087336288133;982.2387649571497;1007.7833265847878;1020.4234607446917;3916.6670832979516;4174.499060112806;4252.29837076885;4335.783210839445;4353.760543170093;11261.831072533918;11580.305181689126;11626.430431891755;11630.069594432425;11652.53389864396;11397.373144476967;11471.254368466023;11485.712857178638;11514.366709830872;11516.884831151749;8008.7597372078935;8343.999999999878;8351.29014033814;8457.238848503664;8635.395522313378;6104.26748790148;6124.356942521149;6227.688615569113;6245.188125543832;6343.555951083565;10303.639372621923;10555.261131720707;10584.153267738717;10617.734556636145;10654.254202205771;10484.52819623134;10825.945870270598;10973.122150227802;10977.39624320638;10979.61571345031;7253.891191632024;7277.781666550012;7459.545388649161;8100.108988011196;8171.468854524437;8664.090270521756;8776.429532080394;8934.553272336227;8954;8955.552222388724;7601.353884919844;7879.4843609472455;7924.524528528307;8019.5990200490905;8187.590620469072;7249.383802376646;7441.888371674538;7443.81390465221;7450.329470347695;7462.776116716507;6984.615846128511;7081.221065682874;7087.397571206505;7090.6100164491445;7095.645217739196;5123.462036486116;5246.186841039645;5253.763580638957;5261.5264626183825;5436.45635436469;5206.323177986837;5206.921896171636;5289.814856480005;5293.814716484904;5546.251256080377 11:44:40 INFO - PROCESS | 3418 | |4;prototype.html;316.26941764523934;324.39176543980034;331.27946715892926;332.8136243703526;335.2858411583327;5199.142141546645;5219.086659834523;5232.241325007872;5234.267202591635;5237.240600112981;4890.902181956359;4996.800127994885;5107.948920510794;5136.820211292606;5158.504033830194;4044.858429954952;4057.492813398318;4058.9391159132488;4062.1266427718033;4070.4301397804184;4059.8985025374304;4061.253660925801;4074.9388759168637;4075.7962101894936;4077.5106987161435;3843.8078096095223;3864.458975743384;3995.9001024974464;4025.8188381522755;4040.131371755072;3987.76379322411;4008.158286759784;4008.619181177798;4009.7946129628585;4014.7791871447057;3564.1446052947367;3575.5530558680166;3576.624454432273;3578.7315951303494;3592.263585964871;4854.635902307341;5022.522860328263;5025.321581586476;5053.949460505385;5060.367454068241;4522.525134860858;4529.411176547061;4542.387452454364;4564.2240819060835;4591.288350305708;5348.5186333230195;5359.758810853521;5384.6769193848495;5389.218563308337;5399.379071406799;3754.793486358249;3822.4075268333454;3839.9232015359535;3852.903677408059;3853.1715681128694;5494.36814766303;5513.862153446196;5564.86087847803;5586.24585680936;5605.859853503695;3938.8030598470536;3966.4050392441363;3968.7420317679257;3971.126352202511;3975.900602484903;4027.9798601006805;4030.972102113942;4033.3949907514107;4033.4554835096887;4052.3111071117983;4370.125974804988;4601.12578610063;4606.631469482433;4614.653900957442;4625.838095666635;5422.240886275925;5422.3764267109;5430.805222850967;5438.483344082306;5443.285365109978;1395.1280449718927;1401.173307748413;1402.9968572470732;1403.6561042544643;1408.4929425406845;867.9392442528963;882.1134759566595;940.7836197674574;943.1417410156724;957.0716405087054;5117.488251174853;5140.280360749498;5144.922826157611;5163.425155327661;5174.076646694605;5480.862978425571;5482.122860342326;5492.69790161537;5500.202470641734;5513.04286978125;5005.874853128701;5159.845204643867;5176.637635365489;5202.323697919246;5281.947180528223;2923.166897434221;2943.2936095336963;2947.5578663200263;2963.3480634260427;2972.7473164781236;5671.858203544944;5796.565257605612;5813.302403711582;5814.854628634318;5817.825465236049;5608.214849921014;5627.606067575312;5639.464250896241;5645;5655.349634791969;5724.79963201286;5745.770169193269;5765.538756899522;5790.855228619234;5799.594028418054;5341.261067455419;5529.668219906818;5536.557075433875;5554;5562.3047119110115;5485.780568777204;5491.697956612425;5497.697626630414;5502.009638265151;5508.476694713996;5777;5777.566682498746;5791.449812267828;5792.21805056312;5819.447152520504;3847.5767665556205;3914.119323152268;3936.9409458858713;3943.329633962176;3956.4263181839046;5262.342207224097;5409.83770486886;5501.449855014466;5522.282103326542;5580.776768929198;5396.7571459283645;5439.972800136133;5446.128619420873;5450.645708028966;5453.7818487260065;5230.686158830483;5399.109146990702;5436.592255580927;5444.074507333842;5450.809221677222;5380.273663055437;5395.298611180521;5397.27136836522;5420.647657902224;5429.67421954684;5460.208269800777;5460.672359658433;5474.248240562982;5474.808381706621;5482.205080263259;5212.791488340576;5338.946610534001;5341.786328546815;5357.410684824588;5364.088105022078 11:44:40 INFO - PROCESS | 3418 | |5;yui.html;754.4379437319199;760.8212070163511;782.8903953446517;841.2092632925046;850.91065438129;14304.35630396632;14484.348204330805;14818.110913345206;14832.406703731851;15150.924245378785;13549.458021679146;13769;13794.103383280104;13806.792898106536;13810.654733631663;665.2881416883912;791.8693415586421;802.6147449224361;804.1355542791523;804.9557274349909;803.1566854802463;810.2019510781876;810.5744484145841;810.8945837041176;811.8335741173075;844.771911583872;848.6987119572556;850.0946491986015;850.5067061104545;851.833892390984;679.8810208213592;829.4567058576642;838.5220424358088;839.5886015852219;839.8446287436843;624.3849807939176;629.1317981185935;629.232336549409;629.6662768732579;629.7355110853453;13984;13998.370073346723;14015.789763153562;14017;14018.789718154236;14591.927040364837;14741.852581474155;14816.925915370462;15042;15073.263814501268;13136.60590182296;13192.274424906625;13214.207147571176;13401.731965360736;13437.328133593379;4487.596116349511;4494.73031618104;4512.774361281956;4591.678582499227;4720.527947205286;83272;84096;84655.57672211662;86222.5688871558;90428;10388.168946484264;10433.530491127765;10498.160147188206;10595.417252051056;11796.4691588877;21258.574828503344;21548.892255538936;21590.352289431343;21595.352139435843;21599.56800863974;8681.348898832613;8688.609012594448;9028.729138125867;9064.54677266134;9099.043705603328;4659.743714095689;4833.3958255218095;4861.29511220871;4988.276699878497;5014.373203349582;3636.61815509373;3747.025773298962;3752.6434988676033;3753.6809371203753;3760.6239376062176;641.1408712325506;649.084790445479;653.8757636049136;655.4101308822098;657.8256761958085;668.8461653819649;696.9686364113627;698.7379732600275;732.3006528765123;747.709829165635;9731.367461115005;9788.951055244821;9911.256655750847;10076.546555405024;10185.796284074277;599.8440405494603;609.8841220168154;720.6144712578745;733.4572416411817;746.8244962433823;4527.275635898241;4668.276417155346;4752.5485078917445;5167.346449136316;5200.2979597754575;105465.47267263768;111510;111623;111923.44038279756;113120.43439782913;95717.52141239388;97171;98422;99454;100065.49967250117;86826;87305.56347218351;88298;89698.10301896898;91555.62666560007;9641.469719165232;9650.662226822027;9685.467299298607;9744.902550974399;9797.216222702024;48661.75669121632;50109.49890501194;50454.24318635297;51402.485975141266;52110;59325.70337148459;70822.64588677023;70838;72147;73938.63030684812;12102.939485302517;12241;12558.874411256136;12598.055145863913;12870.356482175666;12686.873131268569;12811.167274127152;13270.867291326964;13920.930395347958;14353.354099065358;13389.464421423034;13431.12697674648;13553.661158471117;13865.379266499878;14075.577732668036;13327.133736307109;13599.60781789261;13647.79528307096;13968.371423285773;14264.572062838131;12586.622401327975;12987.155834870704;13262.644113439459;13281.335933203109;13713.725725485236;11218.270812397168;11242.381669007957;11476.770464590829;11478.29196340785;11668.241564298294;10878.728031799268;11166.665000050012;11309.491072901574;11380.317180969168;11574.363410012531 11:44:40 INFO - PROCESS | 3418 | __end_tp_report 11:44:40 INFO - PROCESS | 3418 | __start_cc_report 11:44:40 INFO - PROCESS | 3418 | _x_x_mozilla_cycle_collect,1061 11:44:40 INFO - PROCESS | 3418 | __end_cc_report 11:44:40 INFO - PROCESS | 3418 | __startTimestamp1469904280215__endTimestamp 11:44:40 INFO - PROCESS | 3418 | 11:44:40 INFO - PROCESS | 3418 | ------- Summary: start ------- 11:44:40 INFO - PROCESS | 3418 | Number of tests: 6 11:44:40 INFO - PROCESS | 3418 | 11:44:40 INFO - PROCESS | 3418 | [#0] dojo.html Cycles:165 Average:5364.28 Median:5576.61 stddev:618.49 (11.1%) stddev-sans-first:593.41 11:44:40 INFO - PROCESS | 3418 | Values: 3061.1 3072.7 3089.4 3107.9 3126.8 5250.9 5255.8 5376.8 5439.3 5459.6 5279.5 5319.6 5365.8 5373.1 5439.5 4818.2 4885.0 4907.1 4916.6 4971.4 4923.0 4952.6 4958.3 4976.6 4979.9 4768.9 4801.2 4813.4 4841.0 4927.5 4844.4 4856.9 4858.9 4860.8 4961.8 4877.6 4890.0 4912.1 4912.2 4936.8 5240.1 5287.9 5349.9 5354.6 5442.0 5760.6 5773.5 5810.6 5814.7 5816.8 5808.7 5811.4 5847.5 5871.6 5879.2 5292.5 5330.7 5377.7 5378.5 5438.2 6006.4 6009.7 6010.2 6013.0 6019.8 5703.0 5707.8 5753.1 5758.6 5761.9 5613.1 5692.1 5727.3 5746.0 5863.3 5748.0 5760.0 5761.3 5766.0 5795.6 5720.7 5726.6 5773.5 5781.2 5783.5 4372.4 4402.9 4410.1 4448.2 4450.0 3984.1 4008.6 4009.3 4010.8 4011.6 5396.7 5426.0 5478.5 5485.1 5491.7 5812.2 5816.0 5828.2 5861.5 5873.9 5378.9 5432.1 5432.3 5444.3 5449.6 4842.2 4917.1 4956.6 4974.2 4998.4 5974.6 6042.8 6049.1 6093.4 6104.5 5730.6 5767.7 5777.7 5787.2 5796.9 5872.3 5924.3 6015.8 6044.1 6057.3 5625.1 5685.9 5688.0 5734.8 5749.0 5781.3 5783.0 5788.2 5789.3 5791.2 5452.6 5544.0 5636.2 5636.5 5640.5 5576.6 5621.8 5627.8 5670.5 5680.2 5561.7 5622.9 5625.8 5628.5 5639.6 5538.3 5597.1 5656.4 5712.0 5722.4 5491.9 5545.6 5550.1 5604.8 5605.9 11:44:40 INFO - PROCESS | 3418 | 11:44:40 INFO - PROCESS | 3418 | [#1] ext.html Cycles:180 Average:60445.04 Median:42724.89 stddev:120911.16 (283.0%) stddev-sans-first:121166.83 11:44:40 INFO - PROCESS | 3418 | Values: 589.3 617.4 631.1 639.3 657.1 30395.8 31015.8 33711.7 33801.2 33819.3 44395.6 45454.1 45564.3 49143.5 49278.0 8853.6 8983.5 8985.0 8991.5 8997.1 8857.7 8972.9 8976.1 8979.0 8982.1 8993.0 9028.2 9041.6 9047.2 9049.6 8959.3 8990.1 9003.7 9009.9 9018.5 8832.3 8881.4 8957.1 8957.2 8970.7 41319.8 41438.6 41461.2 41473.0 41495.6 3182.6 3230.3 3375.2 3507.6 3846.9 31427.8 31462.4 31780.0 32159.7 32363.5 4167.6 4224.5 4238.8 4300.7 4421.2 271032.0 272292.0 272444.0 272457.0 273706.0 55325.2 56039.7 56087.2 56162.2 56220.0 53214.7 59820.7 59840.7 60007.4 60008.0 15995.7 16673.3 16682.7 16692.6 16739.5 13045.9 13249.8 13254.3 13255.2 13259.1 15194.2 16509.9 17006.7 17239.1 17262.1 6459.8 6567.6 6698.4 6784.7 6882.1 919.2 1015.9 1171.6 1184.5 1196.1 33999.8 34015.7 34056.5 34147.5 34197.3 1112.6 1138.0 1182.5 1193.0 1199.8 16667.9 17509.6 17641.2 17784.3 17833.8 534431.0 539255.0 546323.0 547229.0 548001.0 57994.4 58004.7 58069.4 58244.7 58365.4 1294.2 1347.0 1349.8 1352.3 1382.1 31354.0 33275.5 33420.5 33535.7 34370.5 52028.7 52336.0 52421.7 52516.5 52650.7 499651.0 500804.0 501374.0 501721.0 502973.0 36262.0 42050.0 43208.0 43328.0 43389.8 49179.8 49353.0 49449.5 49538.3 51186.5 41695.8 42582.0 42867.8 43039.4 44728.3 41953.0 42009.8 42496.4 43539.8 44141.6 42073.4 42101.8 43424.0 43804.8 43810.8 34344.5 38262.6 38297.8 38343.0 38696.6 28770.0 29065.4 29128.7 29346.6 29377.6 11:44:40 INFO - PROCESS | 3418 | 11:44:40 INFO - PROCESS | 3418 | [#2] jquery.html Cycles:180 Average:29444.95 Median:23599.41 stddev:86379.93 (366.0%) stddev-sans-first:86594.65 11:44:40 INFO - PROCESS | 3418 | Values: 364.2 372.0 376.5 386.6 404.4 17335.1 19459.0 19582.1 19778.9 20005.5 18669.6 18955.7 19153.5 19191.2 19328.6 5302.4 5777.8 5954.1 6005.9 6006.0 5848.7 5901.6 5926.5 5932.9 5941.9 5671.4 5807.4 5848.3 5910.2 5917.2 5831.1 5849.1 5872.4 5873.4 5874.7 5089.7 5104.4 5235.1 5236.2 5237.9 23379.9 23444.9 23532.3 23580.3 23618.5 2343.5 2612.7 2655.3 3033.4 3089.0 14118.0 14579.6 15142.6 15624.9 15636.0 1816.3 1838.2 1868.9 1906.8 1991.7 78402.6 78642.0 78812.0 80109.0 81463.6 10259.7 10261.5 10492.8 10502.6 10802.0 14756.3 14828.6 14834.1 14845.9 14859.9 8012.2 8130.2 8305.0 8325.0 8400.6 8047.0 8118.5 8142.8 8347.9 8384.8 6319.7 6435.7 6576.9 6585.8 6713.1 1864.9 1866.7 1887.7 1916.4 1929.4 928.1 1009.6 1022.6 1032.8 1116.7 19894.3 20854.5 20892.3 21032.5 21130.0 1002.7 1010.1 1011.6 1022.6 1044.9 11108.6 11679.6 11938.2 11945.8 11955.1 515786.0 527794.0 528793.0 529401.0 536945.0 59836.1 73104.0 73497.2 76004.6 76747.2 968.8 995.1 1004.7 1008.6 1013.7 17638.8 18107.7 18446.8 18453.9 18514.0 39954.6 40090.2 40272.4 40363.8 40383.0 51277.7 52108.7 52247.2 52523.0 52531.0 6860.8 7584.9 7691.7 7917.1 8146.6 12789.2 13078.1 13090.3 13115.5 13127.7 10909.1 11051.6 11352.4 11777.9 11922.5 8438.2 11317.9 11527.7 11622.9 11644.9 11523.9 11804.5 11831.9 12144.1 12200.9 7332.6 7618.5 7724.9 7753.9 7964.5 11107.0 11595.9 11760.4 11988.8 12011.6 11:44:40 INFO - PROCESS | 3418 | 11:44:40 INFO - PROCESS | 3418 | [#3] mootools.html Cycles:180 Average:5906.23 Median:4929.79 stddev:3444.55 (69.9%) stddev-sans-first:3436.80 11:44:40 INFO - PROCESS | 3418 | Values: 1298.2 1453.9 1494.0 1590.2 1738.6 8576.5 8849.7 8934.1 9189.9 9199.1 9008.0 9094.9 9100.0 9105.2 9107.0 2354.7 2384.5 2396.0 2397.9 2398.8 2280.9 2336.5 2337.2 2341.0 2355.9 2293.9 2298.7 2304.4 2351.2 2351.2 2259.8 2268.1 2284.1 2287.7 2301.7 2234.1 2236.5 2239.0 2240.6 2243.0 8959.6 9080.9 9090.2 9154.3 9161.6 5127.7 5310.0 5320.6 5322.5 5324.6 3299.8 3310.4 3311.8 3350.2 3356.8 1061.5 1061.9 1073.2 1085.9 1088.2 12589.6 12717.8 12743.3 12753.1 12769.4 4306.6 4368.2 4517.6 4520.1 4563.7 9886.4 9894.7 9895.1 9908.4 9909.8 5261.6 5281.8 5285.4 5294.1 5296.6 4294.0 4757.5 4869.5 4915.0 4944.5 3759.6 3775.5 3855.7 3877.1 3933.9 1104.6 1110.2 1117.9 1121.9 1123.0 872.9 936.9 941.0 952.1 964.5 5921.6 5975.2 6179.4 6183.9 6225.8 925.7 961.4 982.2 1007.8 1020.4 3916.7 4174.5 4252.3 4335.8 4353.8 11261.8 11580.3 11626.4 11630.1 11652.5 11397.4 11471.3 11485.7 11514.4 11516.9 8008.8 8344.0 8351.3 8457.2 8635.4 6104.3 6124.4 6227.7 6245.2 6343.6 10303.6 10555.3 10584.2 10617.7 10654.3 10484.5 10825.9 10973.1 10977.4 10979.6 7253.9 7277.8 7459.5 8100.1 8171.5 8664.1 8776.4 8934.6 8954.0 8955.6 7601.4 7879.5 7924.5 8019.6 8187.6 7249.4 7441.9 7443.8 7450.3 7462.8 6984.6 7081.2 7087.4 7090.6 7095.6 5123.5 5246.2 5253.8 5261.5 5436.5 5206.3 5206.9 5289.8 5293.8 5546.3 11:44:40 INFO - PROCESS | 3418 | 11:44:40 INFO - PROCESS | 3418 | [#4] prototype.html Cycles:180 Average:4556.56 Median:5215.94 stddev:1339.07 (25.7%) stddev-sans-first:1304.45 11:44:40 INFO - PROCESS | 3418 | Values: 316.3 324.4 331.3 332.8 335.3 5199.1 5219.1 5232.2 5234.3 5237.2 4890.9 4996.8 5107.9 5136.8 5158.5 4044.9 4057.5 4058.9 4062.1 4070.4 4059.9 4061.3 4074.9 4075.8 4077.5 3843.8 3864.5 3995.9 4025.8 4040.1 3987.8 4008.2 4008.6 4009.8 4014.8 3564.1 3575.6 3576.6 3578.7 3592.3 4854.6 5022.5 5025.3 5053.9 5060.4 4522.5 4529.4 4542.4 4564.2 4591.3 5348.5 5359.8 5384.7 5389.2 5399.4 3754.8 3822.4 3839.9 3852.9 3853.2 5494.4 5513.9 5564.9 5586.2 5605.9 3938.8 3966.4 3968.7 3971.1 3975.9 4028.0 4031.0 4033.4 4033.5 4052.3 4370.1 4601.1 4606.6 4614.7 4625.8 5422.2 5422.4 5430.8 5438.5 5443.3 1395.1 1401.2 1403.0 1403.7 1408.5 867.9 882.1 940.8 943.1 957.1 5117.5 5140.3 5144.9 5163.4 5174.1 5480.9 5482.1 5492.7 5500.2 5513.0 5005.9 5159.8 5176.6 5202.3 5281.9 2923.2 2943.3 2947.6 2963.3 2972.7 5671.9 5796.6 5813.3 5814.9 5817.8 5608.2 5627.6 5639.5 5645.0 5655.3 5724.8 5745.8 5765.5 5790.9 5799.6 5341.3 5529.7 5536.6 5554.0 5562.3 5485.8 5491.7 5497.7 5502.0 5508.5 5777.0 5777.6 5791.4 5792.2 5819.4 3847.6 3914.1 3936.9 3943.3 3956.4 5262.3 5409.8 5501.4 5522.3 5580.8 5396.8 5440.0 5446.1 5450.6 5453.8 5230.7 5399.1 5436.6 5444.1 5450.8 5380.3 5395.3 5397.3 5420.6 5429.7 5460.2 5460.7 5474.2 5474.8 5482.2 5212.8 5338.9 5341.8 5357.4 5364.1 11:44:40 INFO - PROCESS | 3418 | 11:44:40 INFO - PROCESS | 3418 | [#5] yui.html Cycles:180 Average:20795.27 Median:4736.54 stddev:29923.00 (631.7%) stddev-sans-first:29969.10 11:44:40 INFO - PROCESS | 3418 | Values: 754.4 760.8 782.9 841.2 850.9 14304.4 14484.3 14818.1 14832.4 15150.9 13549.5 13769.0 13794.1 13806.8 13810.7 665.3 791.9 802.6 804.1 805.0 803.2 810.2 810.6 810.9 811.8 844.8 848.7 850.1 850.5 851.8 679.9 829.5 838.5 839.6 839.8 624.4 629.1 629.2 629.7 629.7 13984.0 13998.4 14015.8 14017.0 14018.8 14591.9 14741.9 14816.9 15042.0 15073.3 13136.6 13192.3 13214.2 13401.7 13437.3 4487.6 4494.7 4512.8 4591.7 4720.5 83272.0 84096.0 84655.6 86222.6 90428.0 10388.2 10433.5 10498.2 10595.4 11796.5 21258.6 21548.9 21590.4 21595.4 21599.6 8681.3 8688.6 9028.7 9064.5 9099.0 4659.7 4833.4 4861.3 4988.3 5014.4 3636.6 3747.0 3752.6 3753.7 3760.6 641.1 649.1 653.9 655.4 657.8 668.8 697.0 698.7 732.3 747.7 9731.4 9789.0 9911.3 10076.5 10185.8 599.8 609.9 720.6 733.5 746.8 4527.3 4668.3 4752.5 5167.3 5200.3 105465.5 111510.0 111623.0 111923.4 113120.4 95717.5 97171.0 98422.0 99454.0 100065.5 86826.0 87305.6 88298.0 89698.1 91555.6 9641.5 9650.7 9685.5 9744.9 9797.2 48661.8 50109.5 50454.2 51402.5 52110.0 59325.7 70822.6 70838.0 72147.0 73938.6 12102.9 12241.0 12558.9 12598.1 12870.4 12686.9 12811.2 13270.9 13920.9 14353.4 13389.5 13431.1 13553.7 13865.4 14075.6 13327.1 13599.6 13647.8 13968.4 14264.6 12586.6 12987.2 13262.6 13281.3 13713.7 11218.3 11242.4 11476.8 11478.3 11668.2 10878.7 11166.7 11309.5 11380.3 11574.4 11:44:40 INFO - PROCESS | 3418 | -------- Summary: end -------- 11:44:40 INFO - PROCESS | 3418 | 11:44:41 INFO - TEST-INFO | 3418: exit 0 11:44:41 INFO - TEST-OK | dromaeo_css | took 1115524ms 11:44:41 INFO - TEST-START | kraken 11:44:41 INFO - operating with platform_type : linux_ 11:44:41 INFO - Initialising browser for kraken test... 11:44:41 INFO - TEST-INFO | started process 3612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptN7uul/profile http://localhost:60049/getInfo.html) 11:44:44 INFO - PROCESS | 3612 | __metrics Screen width/height:1600/1200 11:44:44 INFO - PROCESS | 3612 | colorDepth:24 11:44:44 INFO - PROCESS | 3612 | Browser inner width/height: 1024/697 11:44:44 INFO - PROCESS | 3612 | __metrics 11:44:45 INFO - PROCESS | 3612 | 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" 11:44:45 INFO - PROCESS | 3612 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:44:46 INFO - TEST-INFO | 3612: exit 0 11:44:46 INFO - Browser initialized. 11:44:46 INFO - Running cycle 1/1 for kraken test... 11:44:46 INFO - TEST-INFO | started process 3692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptN7uul/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:58 INFO - PROCESS | 3692 | RSS: Main: 156274688 11:44:58 INFO - PROCESS | 3692 | 11:45:00 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60049/tests/kraken/driver.html?testName=audio-beat-detection) 11:45:01 INFO - PROCESS | 3692 | RSS: Main: 211951616 11:45:01 INFO - PROCESS | 3692 | 11:45:04 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60049/tests/kraken/driver.html?testName=audio-dft) 11:45:04 INFO - PROCESS | 3692 | RSS: Main: 186277888 11:45:04 INFO - PROCESS | 3692 | 11:45:07 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60049/tests/kraken/driver.html?testName=audio-fft) 11:45:08 INFO - PROCESS | 3692 | RSS: Main: 269545472 11:45:08 INFO - PROCESS | 3692 | 11:45:10 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60049/tests/kraken/driver.html?testName=audio-oscillator) 11:45:11 INFO - PROCESS | 3692 | RSS: Main: 180076544 11:45:11 INFO - PROCESS | 3692 | 11:45:13 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:45:13 INFO - PROCESS | 3692 | RSS: Main: 184172544 11:45:13 INFO - PROCESS | 3692 | 11:45:16 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60049/tests/kraken/driver.html?testName=imaging-darkroom) 11:45:17 INFO - PROCESS | 3692 | RSS: Main: 218583040 11:45:17 INFO - PROCESS | 3692 | 11:45:20 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60049/tests/kraken/driver.html?testName=imaging-desaturate) 11:45:21 INFO - PROCESS | 3692 | RSS: Main: 219582464 11:45:21 INFO - PROCESS | 3692 | 11:45:24 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60049/tests/kraken/driver.html?testName=json-parse-financial) 11:45:24 INFO - PROCESS | 3692 | RSS: Main: 219136000 11:45:24 INFO - PROCESS | 3692 | 11:45:26 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:45:27 INFO - PROCESS | 3692 | RSS: Main: 183676928 11:45:27 INFO - PROCESS | 3692 | 11:45:28 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60049/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:29 INFO - PROCESS | 3692 | RSS: Main: 188563456 11:45:29 INFO - PROCESS | 3692 | 11:45:31 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:32 INFO - PROCESS | 3692 | RSS: Main: 194433024 11:45:32 INFO - PROCESS | 3692 | 11:45:34 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:35 INFO - PROCESS | 3692 | RSS: Main: 189911040 11:45:35 INFO - PROCESS | 3692 | 11:45:37 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:38 INFO - PROCESS | 3692 | RSS: Main: 192409600 11:45:38 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | Cycle 1(1): loaded http://localhost:60049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60049/tests/kraken/driver.html?testName=ai-astar) 11:45:40 INFO - PROCESS | 3692 | RSS: Main: 244596736 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | __start_tp_report 11:45:40 INFO - PROCESS | 3692 | _x_x_mozilla_page_load 11:45:40 INFO - PROCESS | 3692 | _x_x_mozilla_page_load_details 11:45:40 INFO - PROCESS | 3692 | |i|pagename|runs| 11:45:40 INFO - PROCESS | 3692 | |0;ai-astar;102;112;112;110;109;113;113;110;111;111 11:45:40 INFO - PROCESS | 3692 | |1;audio-beat-detection;144;116;118;181;120;116;150;118;163;122 11:45:40 INFO - PROCESS | 3692 | |2;audio-dft;161;161;162;161;160;159;159;164;160;160 11:45:40 INFO - PROCESS | 3692 | |3;audio-fft;73;74;75;130;75;75;75;74;103;75 11:45:40 INFO - PROCESS | 3692 | |4;audio-oscillator;84;84;121;84;84;84;114;84;85;131 11:45:40 INFO - PROCESS | 3692 | |5;imaging-gaussian-blur;117;118;117;117;117;118;118;117;117;117 11:45:40 INFO - PROCESS | 3692 | |6;imaging-darkroom;147;146;146;145;145;145;146;145;145;145 11:45:40 INFO - PROCESS | 3692 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 11:45:40 INFO - PROCESS | 3692 | |8;json-parse-financial;55;54;54;54;54;56;52;53;53;53 11:45:40 INFO - PROCESS | 3692 | |9;json-stringify-tinderbox;62;62;62;62;63;61;62;62;62;62 11:45:40 INFO - PROCESS | 3692 | |10;stanford-crypto-aes;77;76;77;86;81;86;79;84;81;84 11:45:40 INFO - PROCESS | 3692 | |11;stanford-crypto-ccm;127;127;128;120;126;118;136;120;154;130 11:45:40 INFO - PROCESS | 3692 | |12;stanford-crypto-pbkdf2;156;158;162;155;155;157;159;161;158;159 11:45:40 INFO - PROCESS | 3692 | |13;stanford-crypto-sha256-iterative;63;62;63;63;62;62;66;63;65;66 11:45:40 INFO - PROCESS | 3692 | __end_tp_report 11:45:40 INFO - PROCESS | 3692 | __start_cc_report 11:45:40 INFO - PROCESS | 3692 | _x_x_mozilla_cycle_collect,1657 11:45:40 INFO - PROCESS | 3692 | __end_cc_report 11:45:40 INFO - PROCESS | 3692 | __startTimestamp1469904340450__endTimestamp 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | ------- Summary: start ------- 11:45:40 INFO - PROCESS | 3692 | Number of tests: 14 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.20 (2.9%) stddev-sans-first:1.39 11:45:40 INFO - PROCESS | 3692 | Values: 102.0 112.0 112.0 110.0 109.0 113.0 113.0 110.0 111.0 111.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:133.00 stddev:23.33 (17.5%) stddev-sans-first:24.51 11:45:40 INFO - PROCESS | 3692 | Values: 144.0 116.0 118.0 181.0 120.0 116.0 150.0 118.0 163.0 122.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 11:45:40 INFO - PROCESS | 3692 | Values: 161.0 161.0 162.0 161.0 160.0 159.0 159.0 164.0 160.0 160.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:18.83 (25.1%) stddev-sans-first:19.63 11:45:40 INFO - PROCESS | 3692 | Values: 73.0 74.0 75.0 130.0 75.0 75.0 75.0 74.0 103.0 75.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:18.73 (22.3%) stddev-sans-first:19.40 11:45:40 INFO - PROCESS | 3692 | Values: 84.0 84.0 121.0 84.0 84.0 84.0 114.0 84.0 85.0 131.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:45:40 INFO - PROCESS | 3692 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 11:45:40 INFO - PROCESS | 3692 | Values: 147.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:45:40 INFO - PROCESS | 3692 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.14 (2.1%) stddev-sans-first:1.12 11:45:40 INFO - PROCESS | 3692 | Values: 55.0 54.0 54.0 54.0 54.0 56.0 52.0 53.0 53.0 53.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 11:45:40 INFO - PROCESS | 3692 | Values: 62.0 62.0 62.0 62.0 63.0 61.0 62.0 62.0 62.0 62.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:82.50 stddev:3.78 (4.6%) stddev-sans-first:3.71 11:45:40 INFO - PROCESS | 3692 | Values: 77.0 76.0 77.0 86.0 81.0 86.0 79.0 84.0 81.0 84.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:127.50 stddev:10.41 (8.2%) stddev-sans-first:11.02 11:45:40 INFO - PROCESS | 3692 | Values: 127.0 127.0 128.0 120.0 126.0 118.0 136.0 120.0 154.0 130.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.50 stddev:2.36 (1.5%) stddev-sans-first:2.39 11:45:40 INFO - PROCESS | 3692 | Values: 156.0 158.0 162.0 155.0 155.0 157.0 159.0 161.0 158.0 159.0 11:45:40 INFO - PROCESS | 3692 | 11:45:40 INFO - PROCESS | 3692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.67 11:45:40 INFO - PROCESS | 3692 | Values: 63.0 62.0 63.0 63.0 62.0 62.0 66.0 63.0 65.0 66.0 11:45:40 INFO - PROCESS | 3692 | -------- Summary: end -------- 11:45:40 INFO - PROCESS | 3692 | 11:45:41 INFO - TEST-INFO | 3692: exit 0 11:45:41 INFO - TEST-OK | kraken | took 60779ms 11:45:41 INFO - SUITE-END | took 1176s 11:45:42 INFO - Completed test suite (00:19:36) 11:45:42 INFO - javascript benchmark 11:45:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.142879993602, 3072.692730726926, 3089.3512362403894, 3107.8601462934166, 3126.8436578171086, 5250.921236181461, 5255.816046438375, 5376.784928602856, 5439.292891924049, 5459.645123067003, 5279.472052794718, 5319.627626066177, 5365.7585408656605, 5373.086575282202, 5439.5104440600335, 4818.229083346657, 4884.951150488503, 4907.11671899058, 4916.606671466274, 4971.37857767779, 4923.0, 4952.579030782388, 4958.305837182797, 4976.552110310071, 4979.925301120486, 4768.928466073012, 4801.207800712878, 4813.3983252093485, 4840.975795121037, 4927.482614325498, 4844.442889067767, 4856.878578035542, 4858.854234372974, 4860.8298709545, 4961.826336078256, 4877.609791216694, 4889.9511004889855, 4912.091263116335, 4912.189488734354, 4936.827211047596, 5240.082985477527, 5287.867803304948, 5349.946500534984, 5354.571634269288, 5442.047641662693, 5760.567957403212, 5773.509251713609, 5810.564207684399, 5814.709264536798, 5816.796412125555, 5808.651480911159, 5811.4479124483105, 5847.532197424196, 5871.588988770788, 5879.235699359056, 5292.497212764782, 5330.706811125387, 5377.677339359651, 5378.46215378463, 5438.15708565173, 6006.369331220247, 6009.699515024231, 6010.188624535632, 6013.037913933749, 6019.849503762353, 5702.971485142631, 5707.771689132388, 5753.05074662676, 5758.568107391879, 5761.88476230473, 5613.129964855372, 5692.0608099663095, 5727.255456790674, 5745.971270143623, 5863.3257175424515, 5748.022836117786, 5760.049591817303, 5761.279840019997, 5766.0197766379815, 5795.594308398456, 5720.685362305113, 5726.627769194989, 5773.509251713652, 5781.248437703071, 5783.450572195635, 4372.366006928977, 4402.889927751768, 4410.1400226956075, 4448.221561226773, 4449.955500444954, 3984.083660757984, 4008.5590585035625, 4009.3184158693093, 4010.7794071325775, 4011.578784227614, 5396.703181325065, 5425.972870135703, 5478.534324582455, 5485.122380419193, 5491.7254137292975, 5812.186293918855, 5815.9709201453725, 5828.154917537018, 5861.472467477862, 5873.911891321633, 5378.865528361744, 5432.130859062531, 5432.320959880015, 5444.26502422168, 5449.591280653967, 4842.249451335048, 4917.065757506062, 4956.628252881048, 4974.1543937530705, 4998.400191976986, 5974.61165024272, 6042.788502402483, 6049.062395328643, 6093.421124993207, 6104.4505994460715, 5730.627509211888, 5767.68277744728, 5777.74000169985, 5787.247657804459, 5796.8550786229, 5872.29532456108, 5924.348321684525, 6015.759369625166, 6044.123602077762, 6057.333693293822, 5625.071863142699, 5685.857853553694, 5688.0, 5734.827955161351, 5748.971255143698, 5781.306243250837, 5783.016887129283, 5788.160716696139, 5789.2763404574425, 5791.218185544897, 5452.563794896478, 5544.029794785977, 5636.239107720406, 5636.464535869086, 5640.520555752807, 5576.60963732551, 5621.831345059655, 5627.803026894039, 5670.461306175906, 5680.233168522197, 5561.6663000220115, 5622.88754224905, 5625.803096891589, 5628.521575666115, 5639.605227634026, 5538.307711536058, 5597.132444471114, 5656.37779844225, 5712.0, 5722.399148089391, 5491.890162196813, 5545.611807173621, 5550.139728342114, 5604.8038318658655, 5605.943940560705], "value": 5321.9419388418555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.2840199158022, 617.4011209127148, 631.0660222870152, 639.322318342557, 657.0768070860443, 30395.84802075989, 31015.84492077542, 33711.66288337116, 33801.1549711257, 33819.32361352771, 44395.556044439545, 45454.09091818162, 45564.316535252, 49143.50856491434, 49278.0, 8853.645854165825, 8983.460992340448, 8984.955075224614, 8991.460512369245, 8997.100289971017, 8857.734267971971, 8972.8654070189, 8976.102389761038, 8978.955105224464, 8982.146696063863, 8993.0, 9028.232600228988, 9041.593128309241, 9047.185753282203, 9049.638014479413, 8959.28325733943, 8990.05604411534, 9003.684871029482, 9009.864852027225, 9018.458892466473, 8832.293416526663, 8881.42270752399, 8957.149070838324, 8957.193852553302, 8970.686025989058, 41319.7934010331, 41438.585614143776, 41461.1707765846, 41473.0, 41495.585044149775, 3182.5703530023616, 3230.337780754963, 3375.1562109472634, 3507.6316986716283, 3846.903827404309, 31427.84286078578, 31462.370752585048, 31780.0, 32159.6784032159, 32363.51454728181, 4167.604077612622, 4224.493060832689, 4238.766867822269, 4300.65594752419, 4421.159979603865, 271032.0, 272292.0, 272444.0, 272457.0, 273706.0, 55325.170122448195, 56039.71980140073, 56087.15869261965, 56162.15756763652, 56220.0, 53214.73392633012, 59820.70089649524, 59840.70079649661, 60007.39992600105, 60008.0, 15995.680086398439, 16673.33306667744, 16682.666346673, 16692.58268543296, 16739.497815065566, 13045.934770326277, 13249.801252981213, 13254.271015094262, 13255.204687718768, 13259.138156019828, 15194.240287985556, 16509.91745041291, 17006.659866802594, 17239.138043098046, 17262.136893155293, 6459.806205813833, 6567.638779867058, 6698.363655452724, 6784.660766961632, 6882.105326307548, 919.2140719684573, 1015.8730158730159, 1171.6133675886938, 1184.5025089462447, 1196.0960063738603, 33999.83000084984, 34015.65984340174, 34056.48915266273, 34147.4877876832, 34197.316053678784, 1112.6328311657135, 1137.971550711239, 1182.532899504708, 1192.952281908714, 1199.7960346741074, 16667.91666041662, 17509.64980700379, 17641.209128933308, 17784.288628454717, 17833.821661783477, 534431.0, 539255.0, 546323.0, 547229.0, 548001.0, 57994.4200557989, 58004.70997644985, 58069.41930580725, 58244.708776455846, 58365.41634583685, 1294.223465920459, 1346.986530134686, 1349.838019437654, 1352.2697743218748, 1382.0601990646255, 31354.0, 33275.50086748749, 33420.498692520116, 33535.66464335325, 34370.484442733876, 52028.739856300475, 52336.0, 52421.7378913103, 52516.47483525116, 52650.736746316026, 499651.0, 500803.97588072415, 501374.0, 501721.0, 502973.0, 36262.0, 42050.0, 43208.0, 43328.0, 43389.783051085804, 49179.754101229264, 49353.0, 49449.50550494449, 49538.25692614542, 51186.48813511966, 41695.7915210422, 42582.0, 42867.785661071495, 43039.35440968451, 44728.32907506325, 41953.0, 42009.78995105005, 42496.362554561085, 43539.78230108829, 44141.558584413746, 42073.36889946715, 42101.78949105235, 43424.0, 43804.78097609492, 43810.78094609507, 34344.48483272703, 38262.6173738259, 38297.808510957264, 38343.0, 38696.613033870424, 28770.0, 29065.418691625626, 29128.7087129126, 29346.55980160342, 29377.55933660954], "value": 20305.288095806292, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.15697659917305, 371.99256014879705, 376.4877937914099, 386.6423558208657, 404.4156194299237, 17335.13324333783, 19458.983857502073, 19582.11880465379, 19778.90110549447, 20005.499862503446, 18669.626607467842, 18955.724764511997, 19153.52116197096, 19191.232350705955, 19328.613427731438, 5302.416734159258, 5777.826665200051, 5954.07711804671, 6005.879882402372, 6006.0, 5848.707564621752, 5901.557383196256, 5926.466618004379, 5932.9406705932815, 5941.85145371367, 5671.376148623648, 5807.361190269067, 5848.2689663792025, 5910.172575839386, 5917.230760001194, 5831.067029275296, 5849.093390524433, 5872.354041055481, 5873.353931067579, 5874.676892770896, 5089.745512724349, 5104.3619547556555, 5235.110031294689, 5236.24074509194, 5237.895242095136, 23379.88310058439, 23444.882775586182, 23532.29403117909, 23580.29259122229, 23618.527629447315, 2343.4727186383097, 2612.712601613821, 2655.309619498925, 3033.4388138194504, 3088.984555077233, 14118.0, 14579.562613121623, 15142.621434464116, 15624.92187539055, 15636.0, 1816.2553353125156, 1838.209569884949, 1868.9252429902788, 1906.780720217179, 1991.6614175590184, 78402.6079869597, 78642.0, 78812.0, 80109.0, 81463.59268203621, 10259.743506412251, 10261.486925653688, 10492.842607360895, 10502.579896804042, 10802.0, 14756.335964881606, 14828.555143345717, 14834.10995340283, 14845.851541484446, 14859.925700371645, 8012.238837310446, 8130.227628375294, 8305.0, 8324.958375208085, 8400.621972011275, 8047.0, 8118.512889226666, 8142.837143257102, 8347.874781878276, 8384.790380240544, 6319.747210111636, 6435.742570297136, 6576.86846263072, 6585.83535411609, 6713.1272934519175, 1864.9254029838926, 1866.6640004799267, 1887.7074053521726, 1916.4154932745646, 1929.3729537900238, 928.1368327455531, 1009.6213919780082, 1022.6267412394571, 1032.8244198486275, 1116.6723164968278, 19894.30369937045, 20854.497460304556, 20892.26877059326, 21032.51046128729, 21130.0, 1002.674130907458, 1010.1060561403211, 1011.6206422591529, 1022.616518805448, 1044.9320794148357, 11108.62195140169, 11679.591214307458, 11938.164328496921, 11945.761084778256, 11955.103367247491, 515786.0, 527794.0, 528793.0, 529401.0, 536945.0, 59836.10245846316, 73104.0, 73497.22141852338, 76004.61997689976, 76747.23252767402, 968.8110818390346, 995.0845222395413, 1004.6785028790863, 1008.5864795433837, 1013.7110923386799, 17638.82361176423, 18107.728384073987, 18446.81553184451, 18453.907730461262, 18514.0, 39954.60045399509, 40090.19819603533, 40272.3959140619, 40363.798181008904, 40383.0, 51277.7436112817, 52108.73945630248, 52247.21629175641, 52523.0, 52531.0, 6860.794176174722, 7584.924150758422, 7691.692332306645, 7917.099896025028, 8146.592670366339, 12789.232646041268, 13078.149920255153, 13090.345482725636, 13115.540956066492, 13127.737445251232, 10909.127269818237, 11051.58897621375, 11352.432378381212, 11777.88222117802, 11922.52309907594, 8438.198371154731, 11317.943410283226, 11527.711807204887, 11622.88377116218, 11644.941775291069, 11523.942380288045, 11804.461811439362, 11831.940840295743, 12144.14990950625, 12200.938995304967, 7332.560046397233, 7618.504797188165, 7724.884126737991, 7753.92246077532, 7964.522128672298, 11107.0, 11595.942020289845, 11760.411979401168, 11988.76022479563, 12011.63965081049], "value": 9315.690689882362, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.2340419152697, 1453.8982271241011, 1494.0438119603455, 1590.2366863905324, 1738.5740493579067, 8576.485410875344, 8849.734507964764, 8934.061923498028, 9189.862152067724, 9199.080091990798, 9008.0, 9094.86357704635, 9099.95450022749, 9105.180533751962, 9107.0, 2354.6703461515403, 2384.5350156719446, 2395.9520809583796, 2397.892094855727, 2398.760123987596, 2280.8631482111045, 2336.4509340305017, 2337.2170322941834, 2340.9882950585306, 2355.8704271265074, 2293.873836938976, 2298.7241531016302, 2304.3893368257427, 2351.2123438648073, 2351.2240960483, 2259.830512711553, 2268.115434980359, 2284.0749496453964, 2287.714035745532, 2301.6777651128855, 2234.128689810975, 2236.4520692430297, 2238.9664155037685, 2240.574290884727, 2243.0354947372625, 8959.552022398853, 9080.909190908073, 9090.2273306769, 9154.267658587298, 9161.633534658606, 5127.692338459704, 5310.0, 5320.600954928396, 5322.520973112439, 5324.627276090675, 3299.7525185611175, 3310.4372256716415, 3311.768176227665, 3350.1959529712935, 3356.8153751543655, 1061.495789499989, 1061.861957945462, 1073.1951036722458, 1085.9022687958043, 1088.1729885287239, 12589.622311330675, 12717.809232861515, 12743.299118548568, 12753.10728249023, 12769.425375858109, 4306.569343065668, 4368.213721530155, 4517.638588912879, 4520.073384956077, 4563.748993805372, 9886.406815591088, 9894.703158905244, 9895.109440150422, 9908.35595686278, 9909.752256193653, 5261.631685782035, 5281.841544753664, 5285.392179899361, 5294.100002999499, 5296.629235953446, 4293.957060429419, 4757.452892917289, 4869.513048695173, 4915.0415668944925, 4944.53026962438, 3759.605241449663, 3775.452559378875, 3855.749376290532, 3877.0501227199516, 3933.940990885139, 1104.640991677708, 1110.21729680575, 1117.8658560972572, 1121.9495122719497, 1122.966311010671, 872.9214370706667, 936.9016253293443, 940.9790377440416, 952.1383148250844, 964.5225613321451, 5921.638023254675, 5975.223220981245, 6179.351168127372, 6183.907241391383, 6225.782097626561, 925.6713866577268, 961.4087336288133, 982.2387649571497, 1007.7833265847878, 1020.4234607446917, 3916.6670832979516, 4174.499060112806, 4252.29837076885, 4335.783210839445, 4353.760543170093, 11261.831072533918, 11580.305181689126, 11626.430431891755, 11630.069594432425, 11652.53389864396, 11397.373144476967, 11471.254368466023, 11485.712857178638, 11514.366709830872, 11516.884831151749, 8008.7597372078935, 8343.999999999878, 8351.29014033814, 8457.238848503664, 8635.395522313378, 6104.26748790148, 6124.356942521149, 6227.688615569113, 6245.188125543832, 6343.555951083565, 10303.639372621923, 10555.261131720707, 10584.153267738717, 10617.734556636145, 10654.254202205771, 10484.52819623134, 10825.945870270598, 10973.122150227802, 10977.39624320638, 10979.61571345031, 7253.891191632024, 7277.781666550012, 7459.545388649161, 8100.108988011196, 8171.468854524437, 8664.090270521756, 8776.429532080394, 8934.553272336227, 8954.0, 8955.552222388724, 7601.353884919844, 7879.4843609472455, 7924.524528528307, 8019.5990200490905, 8187.590620469072, 7249.383802376646, 7441.888371674538, 7443.81390465221, 7450.329470347695, 7462.776116716507, 6984.615846128511, 7081.221065682874, 7087.397571206505, 7090.6100164491445, 7095.645217739196, 5123.462036486116, 5246.186841039645, 5253.763580638957, 5261.5264626183825, 5436.45635436469, 5206.323177986837, 5206.921896171636, 5289.814856480005, 5293.814716484904, 5546.251256080377], "value": 4667.440348722658, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.26941764523934, 324.39176543980034, 331.27946715892926, 332.8136243703526, 335.2858411583327, 5199.142141546645, 5219.086659834523, 5232.241325007872, 5234.267202591635, 5237.240600112981, 4890.902181956359, 4996.800127994885, 5107.948920510794, 5136.820211292606, 5158.504033830194, 4044.858429954952, 4057.492813398318, 4058.9391159132488, 4062.1266427718033, 4070.4301397804184, 4059.8985025374304, 4061.253660925801, 4074.9388759168637, 4075.7962101894936, 4077.5106987161435, 3843.8078096095223, 3864.458975743384, 3995.9001024974464, 4025.8188381522755, 4040.131371755072, 3987.76379322411, 4008.158286759784, 4008.619181177798, 4009.7946129628585, 4014.7791871447057, 3564.1446052947367, 3575.5530558680166, 3576.624454432273, 3578.7315951303494, 3592.263585964871, 4854.635902307341, 5022.522860328263, 5025.321581586476, 5053.949460505385, 5060.367454068241, 4522.525134860858, 4529.411176547061, 4542.387452454364, 4564.2240819060835, 4591.288350305708, 5348.5186333230195, 5359.758810853521, 5384.6769193848495, 5389.218563308337, 5399.379071406799, 3754.793486358249, 3822.4075268333454, 3839.9232015359535, 3852.903677408059, 3853.1715681128694, 5494.36814766303, 5513.862153446196, 5564.86087847803, 5586.24585680936, 5605.859853503695, 3938.8030598470536, 3966.4050392441363, 3968.7420317679257, 3971.126352202511, 3975.900602484903, 4027.9798601006805, 4030.972102113942, 4033.3949907514107, 4033.4554835096887, 4052.3111071117983, 4370.125974804988, 4601.12578610063, 4606.631469482433, 4614.653900957442, 4625.838095666635, 5422.240886275925, 5422.3764267109, 5430.805222850967, 5438.483344082306, 5443.285365109978, 1395.1280449718927, 1401.173307748413, 1402.9968572470732, 1403.6561042544643, 1408.4929425406845, 867.9392442528963, 882.1134759566595, 940.7836197674574, 943.1417410156724, 957.0716405087054, 5117.488251174853, 5140.280360749498, 5144.922826157611, 5163.425155327661, 5174.076646694605, 5480.862978425571, 5482.122860342326, 5492.69790161537, 5500.202470641734, 5513.04286978125, 5005.874853128701, 5159.845204643867, 5176.637635365489, 5202.323697919246, 5281.947180528223, 2923.166897434221, 2943.2936095336963, 2947.5578663200263, 2963.3480634260427, 2972.7473164781236, 5671.858203544944, 5796.565257605612, 5813.302403711582, 5814.854628634318, 5817.825465236049, 5608.214849921014, 5627.606067575312, 5639.464250896241, 5645.0, 5655.349634791969, 5724.79963201286, 5745.770169193269, 5765.538756899522, 5790.855228619234, 5799.594028418054, 5341.261067455419, 5529.668219906818, 5536.557075433875, 5554.0, 5562.3047119110115, 5485.780568777204, 5491.697956612425, 5497.697626630414, 5502.009638265151, 5508.476694713996, 5777.0, 5777.566682498746, 5791.449812267828, 5792.21805056312, 5819.447152520504, 3847.5767665556205, 3914.119323152268, 3936.9409458858713, 3943.329633962176, 3956.4263181839046, 5262.342207224097, 5409.83770486886, 5501.449855014466, 5522.282103326542, 5580.776768929198, 5396.7571459283645, 5439.972800136133, 5446.128619420873, 5450.645708028966, 5453.7818487260065, 5230.686158830483, 5399.109146990702, 5436.592255580927, 5444.074507333842, 5450.809221677222, 5380.273663055437, 5395.298611180521, 5397.27136836522, 5420.647657902224, 5429.67421954684, 5460.208269800777, 5460.672359658433, 5474.248240562982, 5474.808381706621, 5482.205080263259, 5212.791488340576, 5338.946610534001, 5341.786328546815, 5357.410684824588, 5364.088105022078], "value": 4131.437791457829, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.4379437319199, 760.8212070163511, 782.8903953446517, 841.2092632925046, 850.91065438129, 14304.35630396632, 14484.348204330805, 14818.110913345206, 14832.406703731851, 15150.924245378785, 13549.458021679146, 13769.0, 13794.103383280104, 13806.792898106536, 13810.654733631663, 665.2881416883912, 791.8693415586421, 802.6147449224361, 804.1355542791523, 804.9557274349909, 803.1566854802463, 810.2019510781876, 810.5744484145841, 810.8945837041176, 811.8335741173075, 844.771911583872, 848.6987119572556, 850.0946491986015, 850.5067061104545, 851.833892390984, 679.8810208213592, 829.4567058576642, 838.5220424358088, 839.5886015852219, 839.8446287436843, 624.3849807939176, 629.1317981185935, 629.232336549409, 629.6662768732579, 629.7355110853453, 13984.0, 13998.370073346723, 14015.789763153562, 14017.0, 14018.789718154236, 14591.927040364837, 14741.852581474155, 14816.925915370462, 15042.0, 15073.263814501268, 13136.60590182296, 13192.274424906625, 13214.207147571176, 13401.731965360736, 13437.328133593379, 4487.596116349511, 4494.73031618104, 4512.774361281956, 4591.678582499227, 4720.527947205286, 83272.0, 84096.0, 84655.57672211662, 86222.5688871558, 90428.0, 10388.168946484264, 10433.530491127765, 10498.160147188206, 10595.417252051056, 11796.4691588877, 21258.574828503344, 21548.892255538936, 21590.352289431343, 21595.352139435843, 21599.56800863974, 8681.348898832613, 8688.609012594448, 9028.729138125867, 9064.54677266134, 9099.043705603328, 4659.743714095689, 4833.3958255218095, 4861.29511220871, 4988.276699878497, 5014.373203349582, 3636.61815509373, 3747.025773298962, 3752.6434988676033, 3753.6809371203753, 3760.6239376062176, 641.1408712325506, 649.084790445479, 653.8757636049136, 655.4101308822098, 657.8256761958085, 668.8461653819649, 696.9686364113627, 698.7379732600275, 732.3006528765123, 747.709829165635, 9731.367461115005, 9788.951055244821, 9911.256655750847, 10076.546555405024, 10185.796284074277, 599.8440405494603, 609.8841220168154, 720.6144712578745, 733.4572416411817, 746.8244962433823, 4527.275635898241, 4668.276417155346, 4752.5485078917445, 5167.346449136316, 5200.2979597754575, 105465.47267263768, 111510.0, 111623.0, 111923.44038279756, 113120.43439782913, 95717.52141239388, 97171.0, 98422.0, 99454.0, 100065.49967250117, 86826.0, 87305.56347218351, 88298.0, 89698.10301896898, 91555.62666560007, 9641.469719165232, 9650.662226822027, 9685.467299298607, 9744.902550974399, 9797.216222702024, 48661.75669121632, 50109.49890501194, 50454.24318635297, 51402.485975141266, 52110.0, 59325.70337148459, 70822.64588677023, 70838.0, 72147.0, 73938.63030684812, 12102.939485302517, 12241.0, 12558.874411256136, 12598.055145863913, 12870.356482175666, 12686.873131268569, 12811.167274127152, 13270.867291326964, 13920.930395347958, 14353.354099065358, 13389.464421423034, 13431.12697674648, 13553.661158471117, 13865.379266499878, 14075.577732668036, 13327.133736307109, 13599.60781789261, 13647.79528307096, 13968.371423285773, 14264.572062838131, 12586.622401327975, 12987.155834870704, 13262.644113439459, 13281.335933203109, 13713.725725485236, 11218.270812397168, 11242.381669007957, 11476.770464590829, 11478.29196340785, 11668.241564298294, 10878.728031799268, 11166.665000050012, 11309.491072901574, 11380.317180969168, 11574.363410012531], "value": 7583.054869523589, "unit": "score"}], "name": "dromaeo_css", "value": 7266.537127545832, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 110.0, 109.0, 113.0, 113.0, 110.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 118.0, 181.0, 120.0, 116.0, 150.0, 118.0, 163.0, 122.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 160.0, 159.0, 159.0, 164.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 130.0, 75.0, 75.0, 75.0, 74.0, 103.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 121.0, 84.0, 84.0, 84.0, 114.0, 84.0, 85.0, 131.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 56.0, 52.0, 53.0, 53.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 86.0, 81.0, 86.0, 79.0, 84.0, 81.0, 84.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 128.0, 120.0, 126.0, 118.0, 136.0, 120.0, 154.0, 130.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 162.0, 155.0, 155.0, 157.0, 159.0, 161.0, 158.0, 159.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 62.0, 62.0, 66.0, 63.0, 65.0, 66.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1488.9999999999998, "alertThreshold": 2.0}]} 11:45:42 INFO - Return code: 0 11:45:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:42 INFO - # TBPL SUCCESS # 11:45:42 INFO - Running post-action listener: _resource_record_post_action 11:45:42 INFO - [mozharness: 2016-07-30 18:45:42.249117Z] Finished run-tests step (success) 11:45:42 INFO - Running post-run listener: _resource_record_post_run 11:45:42 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7770112; Write bytes: 460091392; Read time: 1124; Write time: 363136 11:45:42 INFO - TinderboxPrint: CPU usage
13.0% 11:45:42 INFO - TinderboxPrint: I/O read bytes / time
7,770,112 / 1,124 11:45:42 INFO - TinderboxPrint: I/O write bytes / time
460,091,392 / 363,136 11:45:42 INFO - TinderboxPrint: CPU idle
8,292.1 (87.0%) 11:45:42 INFO - TinderboxPrint: CPU user
1,191.9 (12.5%) 11:45:42 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 82264064; Read time: 112; Write time: 63120 11:45:42 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 5525504; Write bytes: 377827328; Read time: 852; Write time: 300016 11:45:42 INFO - Running post-run listener: _upload_blobber_files 11:45:42 INFO - Blob upload gear active. 11:45:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:42 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 11:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:45:43 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:47 INFO - (blobuploader) - INFO - Done attempting. 11:45:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:45:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:45:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:48 INFO - (blobuploader) - INFO - Done attempting. 11:45:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:45:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:45:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:49 INFO - (blobuploader) - INFO - Done attempting. 11:45:49 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:49 INFO - Return code: 0 11:45:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22a8aaa21ed06608c5ddd0e4fdfd8aec41275270dcbbbb069d3b8b60cd023b949a89f9821ab320862a7409fd338769f91b086678a193f95f6c279954ea568ceb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9516e685537dfdcdb00f0cbade5be8355bb63b91aacbee50cfa76a3e159e44164c24c0ddb6c273ef3ec5362ffcdcd743dbd92b8597fb894f974fc1e8c257d2db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d75019b703be23b01e4d74a03f44e82406fdf516a7d553cee6e955414df8ffb499e70f38128c001a46db1c20e2d976d2841aeee79f1f314f0ff9da9e8e15934a"} 11:45:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:49 INFO - Contents: 11:45:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22a8aaa21ed06608c5ddd0e4fdfd8aec41275270dcbbbb069d3b8b60cd023b949a89f9821ab320862a7409fd338769f91b086678a193f95f6c279954ea568ceb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9516e685537dfdcdb00f0cbade5be8355bb63b91aacbee50cfa76a3e159e44164c24c0ddb6c273ef3ec5362ffcdcd743dbd92b8597fb894f974fc1e8c257d2db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d75019b703be23b01e4d74a03f44e82406fdf516a7d553cee6e955414df8ffb499e70f38128c001a46db1c20e2d976d2841aeee79f1f314f0ff9da9e8e15934a"} 11:45:49 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:49 INFO - Copying logs to upload dir... 11:45:49 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.929678 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-30 11:45:49.408905) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 11:45:49.412645) ========= 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=d2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22a8aaa21ed06608c5ddd0e4fdfd8aec41275270dcbbbb069d3b8b60cd023b949a89f9821ab320862a7409fd338769f91b086678a193f95f6c279954ea568ceb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9516e685537dfdcdb00f0cbade5be8355bb63b91aacbee50cfa76a3e159e44164c24c0ddb6c273ef3ec5362ffcdcd743dbd92b8597fb894f974fc1e8c257d2db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d75019b703be23b01e4d74a03f44e82406fdf516a7d553cee6e955414df8ffb499e70f38128c001a46db1c20e2d976d2841aeee79f1f314f0ff9da9e8e15934a"} build_url:https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22a8aaa21ed06608c5ddd0e4fdfd8aec41275270dcbbbb069d3b8b60cd023b949a89f9821ab320862a7409fd338769f91b086678a193f95f6c279954ea568ceb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9516e685537dfdcdb00f0cbade5be8355bb63b91aacbee50cfa76a3e159e44164c24c0ddb6c273ef3ec5362ffcdcd743dbd92b8597fb894f974fc1e8c257d2db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d75019b703be23b01e4d74a03f44e82406fdf516a7d553cee6e955414df8ffb499e70f38128c001a46db1c20e2d976d2841aeee79f1f314f0ff9da9e8e15934a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 11:45:49.439274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:45:49.439765) ========= 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=d2a8c569965ab8367867b893000001a1-1469897083.595737-2028516351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:45:49.524088) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 11:45:49.524406) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 11:45:49.524684) ========= ========= Total master_lag: 0.24 =========