builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1469995736.76 results: success (0) buildid: 20160731103030 builduid: 2e86b29c76844143b62cd8791181b073 revision: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:56.760535) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:56.761551) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:56.762262) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:56.813634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:56.813953) ========= 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=62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-31 13:08:57-- 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% 56.0K=0.2s 2016-07-31 13:08:57 (56.0 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.335490 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:57.168456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:57.169269) ========= 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=62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017778 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:57.223883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:57.224285) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 --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=62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-31 13:08:57,956 truncating revision to first 12 chars 2016-07-31 13:08:57,956 Setting DEBUG logging. 2016-07-31 13:08:57,956 attempt 1/10 2016-07-31 13:08:57,957 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4a18b5cacb1b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-31 13:08:58,274 unpacking tar archive at: mozilla-central-4a18b5cacb1b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660344 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:57.903491) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:57.904210) ========= script_repo_revision: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:57.905262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:57.905987) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 13:08:57.924085) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-31 13:08:57.924460) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:08:58 INFO - MultiFileLogger online at 20160731 13:08:58 in /builds/slave/test 13:08:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:08:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:08:58 INFO - {'append_to_log': False, 13:08:58 INFO - 'base_work_dir': '/builds/slave/test', 13:08:58 INFO - 'blob_upload_branch': 'Firefox', 13:08:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:08:58 INFO - 'branch': 'Firefox', 13:08:58 INFO - 'buildbot_json_path': 'buildprops.json', 13:08:58 INFO - 'config_files': ('talos/linux_config.py',), 13:08:58 INFO - 'default_actions': ('clobber', 13:08:58 INFO - 'read-buildbot-config', 13:08:58 INFO - 'download-and-extract', 13:08:58 INFO - 'populate-webroot', 13:08:58 INFO - 'create-virtualenv', 13:08:58 INFO - 'install', 13:08:58 INFO - 'run-tests'), 13:08:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:08:58 INFO - 'download_minidump_stackwalk': True, 13:08:58 INFO - 'download_symbols': 'ondemand', 13:08:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:08:58 INFO - 'tooltool.py': '/tools/tooltool.py', 13:08:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:08:58 INFO - '/tools/misc-python/virtualenv.py')}, 13:08:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:08:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:08:58 INFO - 'installer_path': 'installer.exe', 13:08:58 INFO - 'log_level': 'info', 13:08:58 INFO - 'log_name': 'talos', 13:08:58 INFO - 'log_to_console': True, 13:08:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:08:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:08:58 INFO - 'opt_config_files': (), 13:08:58 INFO - 'pip_index': False, 13:08:58 INFO - 'sps_profile': False, 13:08:58 INFO - 'sps_profile_interval': 0, 13:08:58 INFO - 'suite': 'dromaeojs', 13:08:58 INFO - 'system_bits': '32', 13:08:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:08:58 INFO - 'title': 'talos-linux64-ix-018', 13:08:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:08:58 INFO - 'use_talos_json': True, 13:08:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:08:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:08:58 INFO - 'work_dir': 'build'} 13:08:58 INFO - [mozharness: 2016-07-31 20:08:58.751029Z] Running clobber step. 13:08:58 INFO - Running pre-action listener: _resource_record_pre_action 13:08:58 INFO - Running main action method: clobber 13:08:58 INFO - rmtree: /builds/slave/test/build 13:08:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:08:59 INFO - Running post-action listener: _resource_record_post_action 13:08:59 INFO - [mozharness: 2016-07-31 20:08:59.211129Z] Finished clobber step (success) 13:08:59 INFO - [mozharness: 2016-07-31 20:08:59.211229Z] Running read-buildbot-config step. 13:08:59 INFO - Running pre-action listener: _resource_record_pre_action 13:08:59 INFO - Running main action method: read_buildbot_config 13:08:59 INFO - Using buildbot properties: 13:08:59 INFO - { 13:08:59 INFO - "project": "", 13:08:59 INFO - "product": "firefox", 13:08:59 INFO - "script_repo_revision": "production", 13:08:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:08:59 INFO - "repository": "", 13:08:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 13:08:59 INFO - "buildid": "20160731103030", 13:08:59 INFO - "pgo_build": "True", 13:08:59 INFO - "basedir": "/builds/slave/test", 13:08:59 INFO - "buildnumber": 816, 13:08:59 INFO - "slavename": "talos-linux64-ix-018", 13:08:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:08:59 INFO - "platform": "ubuntu64_hw", 13:08:59 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:08:59 INFO - "branch": "mozilla-central", 13:08:59 INFO - "repo_path": "mozilla-central", 13:08:59 INFO - "revision": "4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1", 13:08:59 INFO - "stage_platform": "linux64-pgo", 13:08:59 INFO - "builduid": "2e86b29c76844143b62cd8791181b073", 13:08:59 INFO - "slavebuilddir": "test" 13:08:59 INFO - } 13:08:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:08:59 INFO - Running post-action listener: _resource_record_post_action 13:08:59 INFO - [mozharness: 2016-07-31 20:08:59.213638Z] Finished read-buildbot-config step (success) 13:08:59 INFO - [mozharness: 2016-07-31 20:08:59.213725Z] Running download-and-extract step. 13:08:59 INFO - Running pre-action listener: _resource_record_pre_action 13:08:59 INFO - Running main action method: download_and_extract 13:08:59 INFO - mkdir: /builds/slave/test/build/tests 13:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:59 INFO - https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/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 13:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/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 13:09:04 INFO - Downloaded 1361 bytes. 13:09:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:09:04 INFO - Using the following test package requirements: 13:09:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:09:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:09:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:09:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:04 INFO - u'jsshell-linux-x86_64.zip'], 13:09:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:09:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:09:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:09:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:09:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:09:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:09:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:04 INFO - https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:09:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/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 13:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/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 13:09:07 INFO - Downloaded 21809071 bytes. 13:09:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:09:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:09:08 INFO - Return code: 0 13:09:08 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 13:09:08 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')]} 13:09:08 INFO - https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:09:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/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 13:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/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 13:09:17 INFO - Downloaded 21809071 bytes. 13:09:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:09:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:09:18 INFO - Return code: 0 13:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:18 INFO - https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:09:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:09:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:09:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/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 13:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/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 13:09:19 INFO - Downloaded 14413723 bytes. 13:09:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:09:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:09:20 INFO - Return code: 0 13:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:20 INFO - https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/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 13:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I98--iz9TR-7l3IIeXKKuA/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 13:09:21 INFO - Downloaded 59377098 bytes. 13:09:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:21 INFO - mkdir: /builds/slave/test/properties 13:09:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:09:21 INFO - Writing to file /builds/slave/test/properties/build_url 13:09:21 INFO - Contents: 13:09:21 INFO - build_url:https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:22 INFO - Running post-action listener: _resource_record_post_action 13:09:22 INFO - Running post-action listener: set_extra_try_arguments 13:09:22 INFO - [mozharness: 2016-07-31 20:09:22.079250Z] Finished download-and-extract step (success) 13:09:22 INFO - [mozharness: 2016-07-31 20:09:22.079576Z] Running populate-webroot step. 13:09:22 INFO - Running pre-action listener: _resource_record_pre_action 13:09:22 INFO - Running main action method: populate_webroot 13:09:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:09:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:09:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:09:22 INFO - '--tppagecycles', 13:09:22 INFO - '7'], 13:09:22 INFO - 'tests': ['tsvgm']}}, 13:09:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:09:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:09:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:09:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:09:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['damp', 'tps']}, 13:09:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'tests': ['damp', 'tps']}, 13:09:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['dromaeo_dom']}, 13:09:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:09:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['basic_compositor_video']}, 13:09:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:09:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'other-e10s': {'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['a11yr', 13:09:22 INFO - 'ts_paint', 13:09:22 INFO - 'tpaint', 13:09:22 INFO - 'sessionrestore', 13:09:22 INFO - 'sessionrestore_no_auto_restore', 13:09:22 INFO - 'tabpaint']}, 13:09:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['tsvgx', 13:09:22 INFO - 'tsvgr_opacity', 13:09:22 INFO - 'tart', 13:09:22 INFO - 'tscrollx', 13:09:22 INFO - 'cart']}, 13:09:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:09:22 INFO - 'tsvgr_opacity', 13:09:22 INFO - 'tart', 13:09:22 INFO - 'tscrollx', 13:09:22 INFO - 'cart']}, 13:09:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'talos_options': ['--disable-e10s'], 13:09:22 INFO - 'tests': ['tp5o']}, 13:09:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'tests': ['tp5o']}, 13:09:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'talos_options': ['--disable-e10s', 13:09:22 INFO - '--xperf_path', 13:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:22 INFO - 'tests': ['tp5n']}, 13:09:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:22 INFO - 'talos_options': ['--xperf_path', 13:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:22 INFO - 'tests': ['tp5n']}}, 13:09:22 INFO - 'talos.zip': {'path': '', 13:09:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:09:22 INFO - Running post-action listener: _resource_record_post_action 13:09:22 INFO - [mozharness: 2016-07-31 20:09:22.100845Z] Finished populate-webroot step (success) 13:09:22 INFO - [mozharness: 2016-07-31 20:09:22.100934Z] Running create-virtualenv step. 13:09:22 INFO - Running pre-action listener: _resource_record_pre_action 13:09:22 INFO - Running main action method: create_virtualenv 13:09:22 INFO - Creating virtualenv /builds/slave/test/build/venv 13:09:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:09:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:09:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:09:22 INFO - Using real prefix '/usr' 13:09:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:09:22 INFO - Installing distribute.............................................................................................................................................................................................done. 13:09:24 INFO - Installing pip.................done. 13:09:24 INFO - Return code: 0 13:09:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d33b0>, '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 0x29d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d4740>, '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': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', '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 13:09:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:09:24 INFO - Using env: {'DISPLAY': ':0', 13:09:24 INFO - 'HOME': '/home/cltbld', 13:09:24 INFO - 'LANG': 'en_US.UTF-8', 13:09:24 INFO - 'LANGUAGE': 'en_US:en', 13:09:24 INFO - 'LOGNAME': 'cltbld', 13:09:24 INFO - 'MAIL': '/var/mail/cltbld', 13:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:24 INFO - 'MOZ_NO_REMOTE': '1', 13:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:24 INFO - 'NO_EM_RESTART': '1', 13:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:24 INFO - 'PWD': '/builds/slave/test', 13:09:24 INFO - 'SHELL': '/bin/bash', 13:09:24 INFO - 'SHLVL': '1', 13:09:24 INFO - 'TERM': 'linux', 13:09:24 INFO - 'TMOUT': '86400', 13:09:24 INFO - 'USER': 'cltbld', 13:09:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', 13:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:24 INFO - '_': '/tools/buildbot/bin/python'} 13:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:24 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 13:09:24 INFO - Cleaning up... 13:09:24 INFO - Return code: 0 13:09:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d33b0>, '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 0x29d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d4740>, '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': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', '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 13:09:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:09:24 INFO - Using env: {'DISPLAY': ':0', 13:09:24 INFO - 'HOME': '/home/cltbld', 13:09:24 INFO - 'LANG': 'en_US.UTF-8', 13:09:24 INFO - 'LANGUAGE': 'en_US:en', 13:09:24 INFO - 'LOGNAME': 'cltbld', 13:09:24 INFO - 'MAIL': '/var/mail/cltbld', 13:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:24 INFO - 'MOZ_NO_REMOTE': '1', 13:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:24 INFO - 'NO_EM_RESTART': '1', 13:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:24 INFO - 'PWD': '/builds/slave/test', 13:09:24 INFO - 'SHELL': '/bin/bash', 13:09:24 INFO - 'SHLVL': '1', 13:09:24 INFO - 'TERM': 'linux', 13:09:24 INFO - 'TMOUT': '86400', 13:09:24 INFO - 'USER': 'cltbld', 13:09:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', 13:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:24 INFO - '_': '/tools/buildbot/bin/python'} 13:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:25 INFO - Downloading/unpacking psutil>=3.1.1 13:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:27 INFO - Installing collected packages: psutil 13:09:27 INFO - Running setup.py install for psutil 13:09:27 INFO - building 'psutil._psutil_linux' extension 13:09:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:09:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:09:27 INFO - building 'psutil._psutil_posix' extension 13:09:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:09:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:27 INFO - Successfully installed psutil 13:09:27 INFO - Cleaning up... 13:09:27 INFO - Return code: 0 13:09:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d33b0>, '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 0x29d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d4740>, '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': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', '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 13:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:09:27 INFO - Using env: {'DISPLAY': ':0', 13:09:27 INFO - 'HOME': '/home/cltbld', 13:09:27 INFO - 'LANG': 'en_US.UTF-8', 13:09:27 INFO - 'LANGUAGE': 'en_US:en', 13:09:27 INFO - 'LOGNAME': 'cltbld', 13:09:27 INFO - 'MAIL': '/var/mail/cltbld', 13:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:27 INFO - 'MOZ_NO_REMOTE': '1', 13:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:27 INFO - 'NO_EM_RESTART': '1', 13:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:27 INFO - 'PWD': '/builds/slave/test', 13:09:27 INFO - 'SHELL': '/bin/bash', 13:09:27 INFO - 'SHLVL': '1', 13:09:27 INFO - 'TERM': 'linux', 13:09:27 INFO - 'TMOUT': '86400', 13:09:27 INFO - 'USER': 'cltbld', 13:09:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', 13:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:27 INFO - '_': '/tools/buildbot/bin/python'} 13:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:09:29 INFO - Installing collected packages: mozsystemmonitor 13:09:29 INFO - Running setup.py install for mozsystemmonitor 13:09:29 INFO - Successfully installed mozsystemmonitor 13:09:29 INFO - Cleaning up... 13:09:29 INFO - Return code: 0 13:09:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:09:29 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')]} 13:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:29 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')]} 13:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:29 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 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d33b0>, '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 0x29d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d4740>, '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': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', '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 13:09:29 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 13:09:29 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 13:09:29 INFO - Using env: {'DISPLAY': ':0', 13:09:29 INFO - 'HOME': '/home/cltbld', 13:09:29 INFO - 'LANG': 'en_US.UTF-8', 13:09:29 INFO - 'LANGUAGE': 'en_US:en', 13:09:29 INFO - 'LOGNAME': 'cltbld', 13:09:29 INFO - 'MAIL': '/var/mail/cltbld', 13:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:29 INFO - 'MOZ_NO_REMOTE': '1', 13:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:29 INFO - 'NO_EM_RESTART': '1', 13:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:29 INFO - 'PWD': '/builds/slave/test', 13:09:29 INFO - 'SHELL': '/bin/bash', 13:09:29 INFO - 'SHLVL': '1', 13:09:29 INFO - 'TERM': 'linux', 13:09:29 INFO - 'TMOUT': '86400', 13:09:29 INFO - 'USER': 'cltbld', 13:09:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', 13:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:29 INFO - '_': '/tools/buildbot/bin/python'} 13:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:30 INFO - Downloading/unpacking jsonschema==2.5.1 13:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:09:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:09:31 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 13:09:31 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 13:09:31 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 13:09:31 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 13:09:31 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 13:09:31 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 13:09:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:09:32 INFO - warning: no files found matching '*.txt' 13:09:32 INFO - no previously-included directories found matching 'build' 13:09:32 INFO - no previously-included directories found matching 'dist' 13:09:32 INFO - no previously-included directories found matching '.git*' 13:09:32 INFO - Installing collected packages: jsonschema, functools32 13:09:32 INFO - Running setup.py install for functools32 13:09:32 INFO - warning: no files found matching '*.txt' 13:09:32 INFO - no previously-included directories found matching 'build' 13:09:32 INFO - no previously-included directories found matching 'dist' 13:09:32 INFO - no previously-included directories found matching '.git*' 13:09:32 INFO - Successfully installed jsonschema functools32 13:09:32 INFO - Cleaning up... 13:09:32 INFO - Return code: 0 13:09:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d33b0>, '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 0x29d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d4740>, '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': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', '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 13:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:09:32 INFO - Using env: {'DISPLAY': ':0', 13:09:32 INFO - 'HOME': '/home/cltbld', 13:09:32 INFO - 'LANG': 'en_US.UTF-8', 13:09:32 INFO - 'LANGUAGE': 'en_US:en', 13:09:32 INFO - 'LOGNAME': 'cltbld', 13:09:32 INFO - 'MAIL': '/var/mail/cltbld', 13:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:32 INFO - 'MOZ_NO_REMOTE': '1', 13:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:32 INFO - 'NO_EM_RESTART': '1', 13:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:32 INFO - 'PWD': '/builds/slave/test', 13:09:32 INFO - 'SHELL': '/bin/bash', 13:09:32 INFO - 'SHLVL': '1', 13:09:32 INFO - 'TERM': 'linux', 13:09:32 INFO - 'TMOUT': '86400', 13:09:32 INFO - 'USER': 'cltbld', 13:09:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', 13:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:32 INFO - '_': '/tools/buildbot/bin/python'} 13:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:09:32 INFO - Cleaning up... 13:09:32 INFO - Return code: 0 13:09:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d33b0>, '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 0x29d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d4740>, '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': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', '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 13:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:09:32 INFO - Using env: {'DISPLAY': ':0', 13:09:32 INFO - 'HOME': '/home/cltbld', 13:09:32 INFO - 'LANG': 'en_US.UTF-8', 13:09:32 INFO - 'LANGUAGE': 'en_US:en', 13:09:32 INFO - 'LOGNAME': 'cltbld', 13:09:32 INFO - 'MAIL': '/var/mail/cltbld', 13:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:32 INFO - 'MOZ_NO_REMOTE': '1', 13:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:32 INFO - 'NO_EM_RESTART': '1', 13:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:32 INFO - 'PWD': '/builds/slave/test', 13:09:32 INFO - 'SHELL': '/bin/bash', 13:09:32 INFO - 'SHLVL': '1', 13:09:32 INFO - 'TERM': 'linux', 13:09:32 INFO - 'TMOUT': '86400', 13:09:32 INFO - 'USER': 'cltbld', 13:09:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', 13:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:32 INFO - '_': '/tools/buildbot/bin/python'} 13:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:32 INFO - Downloading/unpacking blobuploader==1.2.4 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09:34 INFO - Downloading blobuploader-1.2.4.tar.gz 13:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:09:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09: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 13:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:09:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:35 INFO - Downloading docopt-0.6.1.tar.gz 13:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:09:35 INFO - Installing collected packages: blobuploader, requests, docopt 13:09:35 INFO - Running setup.py install for blobuploader 13:09:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:09:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:09:35 INFO - Running setup.py install for requests 13:09:35 INFO - Running setup.py install for docopt 13:09:36 INFO - Successfully installed blobuploader requests docopt 13:09:36 INFO - Cleaning up... 13:09:36 INFO - Return code: 0 13:09:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d33b0>, '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 0x29d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d4740>, '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': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', '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 13:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:09:36 INFO - Using env: {'DISPLAY': ':0', 13:09:36 INFO - 'HOME': '/home/cltbld', 13:09:36 INFO - 'LANG': 'en_US.UTF-8', 13:09:36 INFO - 'LANGUAGE': 'en_US:en', 13:09:36 INFO - 'LOGNAME': 'cltbld', 13:09:36 INFO - 'MAIL': '/var/mail/cltbld', 13:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:36 INFO - 'MOZ_NO_REMOTE': '1', 13:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:36 INFO - 'NO_EM_RESTART': '1', 13:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:36 INFO - 'PWD': '/builds/slave/test', 13:09:36 INFO - 'SHELL': '/bin/bash', 13:09:36 INFO - 'SHLVL': '1', 13:09:36 INFO - 'TERM': 'linux', 13:09:36 INFO - 'TMOUT': '86400', 13:09:36 INFO - 'USER': 'cltbld', 13:09:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', 13:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:36 INFO - '_': '/tools/buildbot/bin/python'} 13:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:36 INFO - Running setup.py (path:/tmp/pip-_ySOT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:36 INFO - Running setup.py (path:/tmp/pip-AnvRoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:36 INFO - Running setup.py (path:/tmp/pip-XJKcEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:36 INFO - Running setup.py (path:/tmp/pip-4TxWyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:36 INFO - Running setup.py (path:/tmp/pip-9bL7T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:36 INFO - Running setup.py (path:/tmp/pip-ScsEMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:36 INFO - Running setup.py (path:/tmp/pip-XulpqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:36 INFO - Running setup.py (path:/tmp/pip-DdLAzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:36 INFO - Running setup.py (path:/tmp/pip-2OYlUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:36 INFO - Running setup.py (path:/tmp/pip-5qzBnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:37 INFO - Running setup.py (path:/tmp/pip-rxjh0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:37 INFO - Running setup.py (path:/tmp/pip-Kc3urZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:37 INFO - Running setup.py (path:/tmp/pip-eQv6rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:37 INFO - Running setup.py (path:/tmp/pip-Em0yMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:37 INFO - Running setup.py (path:/tmp/pip-R9_Vh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:37 INFO - Running setup.py (path:/tmp/pip-D2F0Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:37 INFO - Running setup.py (path:/tmp/pip-xgHgFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:09:37 INFO - Running setup.py install for manifestparser 13:09:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:09:37 INFO - Running setup.py install for mozcrash 13:09:37 INFO - Running setup.py install for mozdebug 13:09:37 INFO - Running setup.py install for mozdevice 13:09:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:09:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:09:37 INFO - Running setup.py install for mozfile 13:09:38 INFO - Running setup.py install for mozhttpd 13:09:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for mozinfo 13:09:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for mozInstall 13:09:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for mozleak 13:09:38 INFO - Running setup.py install for mozlog 13:09:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for moznetwork 13:09:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for mozprocess 13:09:38 INFO - Running setup.py install for mozprofile 13:09:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:09:38 INFO - Running setup.py install for mozrunner 13:09:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:09:39 INFO - Running setup.py install for mozscreenshot 13:09:39 INFO - Running setup.py install for moztest 13:09:39 INFO - Running setup.py install for mozversion 13:09:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:09:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:09:39 INFO - Cleaning up... 13:09:39 INFO - Return code: 0 13:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d33b0>, '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 0x29d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d4740>, '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': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', '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 13:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:09:39 INFO - Using env: {'DISPLAY': ':0', 13:09:39 INFO - 'HOME': '/home/cltbld', 13:09:39 INFO - 'LANG': 'en_US.UTF-8', 13:09:39 INFO - 'LANGUAGE': 'en_US:en', 13:09:39 INFO - 'LOGNAME': 'cltbld', 13:09:39 INFO - 'MAIL': '/var/mail/cltbld', 13:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:39 INFO - 'MOZ_NO_REMOTE': '1', 13:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:39 INFO - 'NO_EM_RESTART': '1', 13:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:39 INFO - 'PWD': '/builds/slave/test', 13:09:39 INFO - 'SHELL': '/bin/bash', 13:09:39 INFO - 'SHLVL': '1', 13:09:39 INFO - 'TERM': 'linux', 13:09:39 INFO - 'TMOUT': '86400', 13:09:39 INFO - 'USER': 'cltbld', 13:09:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', 13:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:39 INFO - '_': '/tools/buildbot/bin/python'} 13:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:39 INFO - Running setup.py (path:/tmp/pip-w3jvUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:39 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)) 13:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:39 INFO - Running setup.py (path:/tmp/pip-GUoSoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:39 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)) 13:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:39 INFO - Running setup.py (path:/tmp/pip-uXcmMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:39 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)) 13:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:39 INFO - Running setup.py (path:/tmp/pip-XOq71c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:39 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)) 13:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:39 INFO - Running setup.py (path:/tmp/pip-TataGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:39 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)) 13:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:39 INFO - Running setup.py (path:/tmp/pip-hXsDMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:40 INFO - Running setup.py (path:/tmp/pip-OqUJa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:40 INFO - Running setup.py (path:/tmp/pip-wRTBjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:40 INFO - Running setup.py (path:/tmp/pip-LcntnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:40 INFO - Running setup.py (path:/tmp/pip-pDHHX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:40 INFO - Running setup.py (path:/tmp/pip-lvTKlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:40 INFO - Running setup.py (path:/tmp/pip-HKIuqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:40 INFO - Running setup.py (path:/tmp/pip-k1l3Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:40 INFO - Running setup.py (path:/tmp/pip-WUYyXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:40 INFO - Running setup.py (path:/tmp/pip-h98Gyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:40 INFO - Running setup.py (path:/tmp/pip-T370GE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:40 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)) 13:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:40 INFO - Running setup.py (path:/tmp/pip-clVffs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:40 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)) 13:09:40 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)) 13:09:40 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)) 13:09:40 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)) 13:09:40 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)) 13:09:40 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)) 13:09:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:40 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 13:09:40 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 13:09:40 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 13:09:40 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 13:09:40 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 13:09:40 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 13:09:42 INFO - Downloading blessings-1.6.tar.gz 13:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:09:42 INFO - Installing collected packages: blessings 13:09:42 INFO - Running setup.py install for blessings 13:09:42 INFO - Successfully installed blessings 13:09:42 INFO - Cleaning up... 13:09:42 INFO - Return code: 0 13:09:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:09:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:43 INFO - Reading from file tmpfile_stdout 13:09:43 INFO - Current package versions: 13:09:43 INFO - argparse == 1.2.1 13:09:43 INFO - blessings == 1.6 13:09:43 INFO - blobuploader == 1.2.4 13:09:43 INFO - docopt == 0.6.1 13:09:43 INFO - functools32 == 3.2.3-2 13:09:43 INFO - jsonschema == 2.5.1 13:09:43 INFO - manifestparser == 1.1 13:09:43 INFO - mozInstall == 1.12 13:09:43 INFO - mozcrash == 0.17 13:09:43 INFO - mozdebug == 0.1 13:09:43 INFO - mozdevice == 0.48 13:09:43 INFO - mozfile == 1.2 13:09:43 INFO - mozhttpd == 0.7 13:09:43 INFO - mozinfo == 0.9 13:09:43 INFO - mozleak == 0.1 13:09:43 INFO - mozlog == 3.3 13:09:43 INFO - moznetwork == 0.27 13:09:43 INFO - mozprocess == 0.23 13:09:43 INFO - mozprofile == 0.28 13:09:43 INFO - mozrunner == 6.12 13:09:43 INFO - mozscreenshot == 0.1 13:09:43 INFO - mozsystemmonitor == 0.3 13:09:43 INFO - moztest == 0.7 13:09:43 INFO - mozversion == 1.4 13:09:43 INFO - psutil == 3.1.1 13:09:43 INFO - requests == 1.2.3 13:09:43 INFO - wsgiref == 0.1.2 13:09:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d33b0>, '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 0x29d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d4740>, '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': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', '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 13:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:09:43 INFO - Using env: {'DISPLAY': ':0', 13:09:43 INFO - 'HOME': '/home/cltbld', 13:09:43 INFO - 'LANG': 'en_US.UTF-8', 13:09:43 INFO - 'LANGUAGE': 'en_US:en', 13:09:43 INFO - 'LOGNAME': 'cltbld', 13:09:43 INFO - 'MAIL': '/var/mail/cltbld', 13:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:43 INFO - 'MOZ_NO_REMOTE': '1', 13:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:43 INFO - 'NO_EM_RESTART': '1', 13:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:43 INFO - 'PWD': '/builds/slave/test', 13:09:43 INFO - 'SHELL': '/bin/bash', 13:09:43 INFO - 'SHLVL': '1', 13:09:43 INFO - 'TERM': 'linux', 13:09:43 INFO - 'TMOUT': '86400', 13:09:43 INFO - 'USER': 'cltbld', 13:09:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', 13:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:43 INFO - '_': '/tools/buildbot/bin/python'} 13:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:09:43 INFO - Cleaning up... 13:09:43 INFO - Return code: 0 13:09:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d33b0>, '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 0x29d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d4740>, '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': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', '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 13:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:09:43 INFO - Using env: {'DISPLAY': ':0', 13:09:43 INFO - 'HOME': '/home/cltbld', 13:09:43 INFO - 'LANG': 'en_US.UTF-8', 13:09:43 INFO - 'LANGUAGE': 'en_US:en', 13:09:43 INFO - 'LOGNAME': 'cltbld', 13:09:43 INFO - 'MAIL': '/var/mail/cltbld', 13:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:43 INFO - 'MOZ_NO_REMOTE': '1', 13:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:43 INFO - 'NO_EM_RESTART': '1', 13:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:43 INFO - 'PWD': '/builds/slave/test', 13:09:43 INFO - 'SHELL': '/bin/bash', 13:09:43 INFO - 'SHLVL': '1', 13:09:43 INFO - 'TERM': 'linux', 13:09:43 INFO - 'TMOUT': '86400', 13:09:43 INFO - 'USER': 'cltbld', 13:09:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', 13:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:43 INFO - '_': '/tools/buildbot/bin/python'} 13:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:09:43 INFO - Cleaning up... 13:09:43 INFO - Return code: 0 13:09:43 INFO - Running post-action listener: _resource_record_post_action 13:09:43 INFO - Running post-action listener: _start_resource_monitoring 13:09:43 INFO - Starting resource monitoring. 13:09:43 INFO - [mozharness: 2016-07-31 20:09:43.638372Z] Finished create-virtualenv step (success) 13:09:43 INFO - [mozharness: 2016-07-31 20:09:43.638953Z] Running install step. 13:09:43 INFO - Running pre-action listener: _resource_record_pre_action 13:09:43 INFO - Running main action method: install 13:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:43 INFO - Reading from file tmpfile_stdout 13:09:43 INFO - Detecting whether we're running mozinstall >=1.0... 13:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:09:43 INFO - Reading from file tmpfile_stdout 13:09:43 INFO - Output received: 13:09:43 INFO - Usage: mozinstall [options] installer 13:09:43 INFO - Options: 13:09:43 INFO - -h, --help show this help message and exit 13:09:43 INFO - -d DEST, --destination=DEST 13:09:43 INFO - Directory to install application into. [default: 13:09:43 INFO - "/builds/slave/test"] 13:09:43 INFO - --app=APP Application being installed. [default: firefox] 13:09:43 INFO - mkdir: /builds/slave/test/build/application 13:09:43 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'] 13:09:43 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 13:10:00 INFO - Reading from file tmpfile_stdout 13:10:00 INFO - Output received: 13:10:00 INFO - /builds/slave/test/build/application/firefox/firefox 13:10:00 INFO - Running post-action listener: _resource_record_post_action 13:10:00 INFO - [mozharness: 2016-07-31 20:10:00.827037Z] Finished install step (success) 13:10:00 INFO - [mozharness: 2016-07-31 20:10:00.827313Z] Running run-tests step. 13:10:00 INFO - Running pre-action listener: _resource_record_pre_action 13:10:00 INFO - Running main action method: run_tests 13:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:10:00 INFO - Python 2.7.3 13:10:00 INFO - Return code: 0 13:10:00 INFO - grabbing minidump binary from tooltool 13:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:00 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 0x29d33b0>, '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 0x29d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:10:00 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 13:10:00 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 13:10:00 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 13:10:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:10:00 INFO - Return code: 0 13:10:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:10:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:10:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:10:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:10:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 13:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 13:10:00 INFO - Using env: {'DISPLAY': ':0', 13:10:00 INFO - 'HOME': '/home/cltbld', 13:10:00 INFO - 'LANG': 'en_US.UTF-8', 13:10:00 INFO - 'LANGUAGE': 'en_US:en', 13:10:00 INFO - 'LOGNAME': 'cltbld', 13:10:00 INFO - 'MAIL': '/var/mail/cltbld', 13:10:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:10:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:00 INFO - 'MOZ_NO_REMOTE': '1', 13:10:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:00 INFO - 'NO_EM_RESTART': '1', 13:10:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:00 INFO - 'PWD': '/builds/slave/test', 13:10:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:10:00 INFO - 'SHELL': '/bin/bash', 13:10:00 INFO - 'SHLVL': '1', 13:10:00 INFO - 'TERM': 'linux', 13:10:00 INFO - 'TMOUT': '86400', 13:10:00 INFO - 'USER': 'cltbld', 13:10:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741', 13:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:00 INFO - '_': '/tools/buildbot/bin/python'} 13:10:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 13:10:01 INFO - mozversion application_buildid: 20160731103030 13:10:01 INFO - mozversion application_changeset: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 13:10:01 INFO - mozversion application_display_name: Nightly 13:10:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:10:01 INFO - mozversion application_name: Firefox 13:10:01 INFO - mozversion application_remotingname: firefox 13:10:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:10:01 INFO - mozversion application_vendor: Mozilla 13:10:01 INFO - mozversion application_version: 50.0a1 13:10:01 INFO - mozversion platform_buildid: 20160731103030 13:10:01 INFO - mozversion platform_changeset: 4a18b5cacb1b21a3e8b4b1dada6b2dd3dba51cb1 13:10:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:10:01 INFO - mozversion platform_version: 50.0a1 13:10:01 INFO - using testdate: 1469995801 13:10:01 INFO - actual date: 1469995801 13:10:01 INFO - starting webserver on 'localhost:43426' 13:10:01 INFO - SUITE-START | Running 2 tests 13:10:01 INFO - TEST-START | dromaeo_css 13:10:01 INFO - operating with platform_type : linux_ 13:10:01 INFO - Initialising browser for dromaeo_css test... 13:10:01 INFO - TEST-INFO | started process 5426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPdBmuY/profile http://localhost:43426/getInfo.html) 13:10:04 INFO - PROCESS | 5426 | __metrics Screen width/height:1600/1200 13:10:04 INFO - PROCESS | 5426 | colorDepth:24 13:10:04 INFO - PROCESS | 5426 | Browser inner width/height: 1024/697 13:10:04 INFO - PROCESS | 5426 | __metrics 13:10:05 INFO - PROCESS | 5426 | 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" 13:10:05 INFO - PROCESS | 5426 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:10:06 INFO - TEST-INFO | 5426: exit 0 13:10:06 INFO - Browser initialized. 13:10:06 INFO - Running cycle 1/1 for dromaeo_css test... 13:10:06 INFO - TEST-INFO | started process 5506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPdBmuY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:18 INFO - PROCESS | 5506 | RSS: Main: 156368896 13:10:18 INFO - PROCESS | 5506 | 13:11:09 INFO - PROCESS | 5506 | 1469995869485 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] 13:13:17 INFO - PROCESS | 5506 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43426/tests/dromaeo/cssquery-ext.html) 13:13:18 INFO - PROCESS | 5506 | RSS: Main: 272384000 13:13:18 INFO - PROCESS | 5506 | 13:16:20 INFO - PROCESS | 5506 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-ext.html (next: http://localhost:43426/tests/dromaeo/cssquery-jquery.html) 13:16:21 INFO - PROCESS | 5506 | RSS: Main: 234381312 13:16:21 INFO - PROCESS | 5506 | 13:19:23 INFO - PROCESS | 5506 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43426/tests/dromaeo/cssquery-mootools.html) 13:19:24 INFO - PROCESS | 5506 | RSS: Main: 186015744 13:19:24 INFO - PROCESS | 5506 | 13:22:26 INFO - PROCESS | 5506 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43426/tests/dromaeo/cssquery-prototype.html) 13:22:26 INFO - PROCESS | 5506 | RSS: Main: 233332736 13:22:26 INFO - PROCESS | 5506 | 13:25:29 INFO - PROCESS | 5506 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43426/tests/dromaeo/cssquery-yui.html) 13:25:30 INFO - PROCESS | 5506 | RSS: Main: 186843136 13:25:30 INFO - PROCESS | 5506 | 13:28:32 INFO - PROCESS | 5506 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-yui.html (next: http://localhost:43426/tests/dromaeo/cssquery-dojo.html) 13:28:32 INFO - PROCESS | 5506 | RSS: Main: 271405056 13:28:32 INFO - PROCESS | 5506 | 13:28:32 INFO - PROCESS | 5506 | __start_tp_report 13:28:32 INFO - PROCESS | 5506 | _x_x_mozilla_page_load 13:28:32 INFO - PROCESS | 5506 | _x_x_mozilla_page_load_details 13:28:32 INFO - PROCESS | 5506 | |i|pagename|runs| 13:28:32 INFO - PROCESS | 5506 | |0;dojo.html;2944.92637684058;2987.7908546401754;3015.0351887396027;3021.8186908785488;3043.9391212175756;5109.386873575167;5161.354830646169;5164.2770012198325;5259.421463639002;5264.105102132642;5175.223716442535;5191.558717509016;5205.453427390126;5217.113090774568;5274.5780337573;4671.112488627158;4752.097101550694;4801.951980480186;4808.927866082012;4905.779239934193;4789.497102804207;4827.975860120712;4840.298156767267;4843.249296359052;4868.342773725555;4668;4724.74013929232;4753.857384278477;4757.333973243749;4789.090072886141;4779.498152693952;4783.449903261135;4784.425868895755;4791.2813078038225;4823.758812059418;4757.976210118962;4765.594924431392;4775.068861571995;4789.521047895218;4792.257200133985;5156.845294641167;5161.251618515332;5211.973940130275;5268.973655131738;5306.177542480922;5631.943680563183;5638.210650508932;5639.802606908779;5640.407757185519;5643.6049476536655;5660.60375773696;5676.744546495376;5684.63049901755;5690.886182276331;5692;5124.231365295198;5226.581873450153;5283.524482796567;5287.497687719622;5360.088784906575;5788.739506722208;5792.82621521355;5845.269341332333;5846.912296315559;5850.034744267234;5610.551155907518;5612.915806262909;5624.015797235467;5625.324961004706;5630.971845140748;5388.9730551347775;5484.533814625722;5498.422665620133;5563;5643.717814109278;5519.613627046068;5573.080441727069;5574.16387541872;5575.470330318613;5615.185798059259;5521.199426083195;5571.60998730085;5578.888422231533;5582.162675598693;5588.161775733591;4212.810423530948;4253.553376895444;4286.828526858891;4299.914001719948;4339.913201736011;3856.2094770571966;3866.284737323604;3874.2057878134915;3898.922021559553;3904.04350934023;5324.227986941872;5333.599980001515;5334.039872822929;5335.439778823167;5383.946160538423;5475.5072043516275;5570.053090974544;5595.580331475156;5620.606557540933;5708.514776244066;5266.973665131726;5302.045631786315;5303.708296043755;5303.867403314948;5305.31030965972;4775.044991001813;4779.737114458669;4790.113828941588;4794.472608013116;4833.10587541306;5556.833295001156;5696.3449203341315;5728.140778883201;5732.598718089777;5852.970735146297;5561.944380556142;5566.972165139148;5568.248286481436;5571.693556854412;5573.6098473106495;5773.076307790733;5782.392848750989;5782.942170578241;5784.971075144597;5785.392533783892;5371.919421208607;5458.5087342139395;5481.5340696041285;5506.366767821592;5575.804846830341;5572.665640061609;5618.016847051668;5622.971885140548;5627.8874422512135;5628.915566266427;5451;5519.9448005521035;5520.447955204608;5523.6685798852195;5561.110222364402;5274.920876186937;5389.0299746046085;5426.810061647823;5435.347758269033;5524.392316845224;5410.2696136022705;5411.864703382447;5415.864603384947;5421.457854214547;5421.891562168814;5491.28613280271;5496.587755918242;5532.059549876451;5532.0595498766115;5532.1425179097305;5209.166533354645;5268.420473747808;5325.627206095691;5325.760340784596;5386.13821788512 13:28:32 INFO - PROCESS | 5506 | |1;ext.html;585.6895845202044;606.9757209711611;610.7282259394572;625.8060001399565;626.5676683088672;32744.345113097752;45101.77449112754;45843.541564584346;45909;46066.53933460664;46091.30863037057;46510.30234546476;46515.53484465154;46557.53442465574;46627;8998.955005224965;9148.954255228715;9149.634014639407;9161.633534658638;9167.679131230409;8888.06675299094;8958.820823583525;8968.865467017968;8974.326925480615;8995.550222488882;8909.287257019423;9002.234810041155;9016.909830901706;9022.09779022099;9023.503707296097;8993.865092023625;9030.86453703195;9032.638694452247;9035.051319611412;9042.412243204237;8899.688510902151;8939.597718102701;8982.416142950688;8987.595558199897;8992.415492993;43839;44096.3385549217;44138.779306103585;44340.3348949766;44387.778061109486;3632.4551317302617;3640.9453858192146;3723.8882833514767;3977.1846771411792;4064.5122585289955;33786.83106584451;33982.66017339844;34207.657923420695;34209.82895085509;34445.82777086098;4505.121501307246;4570.885727856797;4621.676482646216;4685.601723853477;4745.810167593292;337690;338554;339256;339943;340403.297983511;54338;59254;60631.69684151551;61039.38960610426;61311.38688613146;59452.405475945554;65126.67436662786;65272.673636631516;65671.67164164245;65702.34297656962;13962.162270263816;14043.929780351033;14052.578422647337;14062.085964412281;14062.507812226728;10088.344257623232;10795.244332896622;11092.722681932855;11193.27243729155;11197.60808371703;18305.267789288544;18607.06964651762;18638.53403664892;18739.25042998292;19050.333238336592;6128.8774224516155;6188.1027251048345;6256.405641464054;6294.65379404128;6310.305866354697;924.7688077980505;929.5816882402946;1059.433203236265;1063.7925604507047;1079.4548752879746;33566.83216583901;33637.327253454794;33883.32233355319;33960;34766.47850282248;1074.333912973961;1090.5310716391868;1105.6240878101323;1120.5965852293168;1212.8969037631723;16675.83324166767;17472.563185920455;17555.34783282431;17665.911670441565;17816.109194540222;530457;530765;530922;531396;532159;60015.699921500986;60162;60295.39704602986;60301.39698603046;60365;1294.4692676002794;1329.1759109352263;1332.1274565159836;1332.3138583629438;1332.8667133286594;31291.374172515967;32666.51000235046;33156.33687326288;33473.66526334705;33582.832085839415;54387.72806135944;54524.72737636286;54699.45300546943;54899.451005491035;54900.45099548953;447037;449816;451058;451548;454919;33757.49363759496;43116;44717.77641111774;44745.55254447544;46885.29672054854;48500.2724959133;48581.27128093152;48886;48948.265776012675;49742.50257497379;40370.79814600908;40816.79591602023;41914;43144.137117258106;43776.781116094215;42208.36687449752;42296.5770342305;42370.576294236664;44141.33787993118;44262.55737442713;42061.78969105135;44965;45082;45939.77030114828;46145.30782038205;35565.28869422649;37696.43455348227;37981.430278546395;38206.32555721184;38957.2208555833;28817.711822882342;28849.567256491588;29077.418451630427;29225.415491690474;29388.412231755672 13:28:32 INFO - PROCESS | 5506 | |2;jquery.html;362.1507564760635;369.4495202148797;377.3867465368776;381.9293430715317;384.5270317509463;18658.253669853206;19597.51006224845;20016.899915500402;20188.596228075447;20279.188832446685;11146.554137834477;11380.886191138086;11479.426028698574;11488.885111148886;11703.18077734559;4871.658983871131;5104.948950510485;5159.76781044852;5184.066867963765;5188.299579556749;3866.5553461351883;5174.767135478913;5219.530242278194;5488.9725551372185;5787.363390027114;5744.195812586241;5793.391693872146;5797.942020579782;5817.0983497557945;5825.388334224887;5553.389127196006;5646.802361917313;5730.68481233532;5741.856453588652;5777.624454410471;5587.692676902769;5606.635568688022;5622.240997465331;5627.662340259598;5629.380768115504;25330.1134460293;25694.614580781305;25755.871220643778;27243.727562724318;27411.86294068517;2306.169778879602;2549.3244290263096;3092.6288845338477;3151.4642510772997;3374.9156271093175;16013.919930400274;16114.75827862583;16452.670946581122;16510.587235319093;16908.66182676352;2037.7860324665994;2151.9031643576077;2306.5386922615544;2311.7572654871333;2390.6772585700883;88216;96794.5160274194;99402;100016;101724.49137754338;17592.912035439742;17841.7323740144;17955.37156199553;18381.54046148857;18938.337158199396;33140.66859331424;33177;33239.3352132956;33558.66441335555;33617.663823361945;8851.69019084329;8957;9214.76963075915;9266.258699304175;9428.198603118812;7382.446316526282;7471.626418679044;7607.961960190164;7612.657430415645;7670.578118203441;8978.506182159914;9321.161095501302;9333.253339732804;9377.343585949055;9390.248780097576;2721.9591706124424;3166.9597186700566;3299.653536378694;3571.9642803571633;3736.159364143046;836.5357226739218;911.1253196930888;937.3906960475609;965.8551217317458;995.004995004995;17819.821801782076;19267.80732192688;19842.801571984382;20042.39872803818;20075.49811254701;924.4499522783933;924.6624981881699;963.8746962894779;998.6255154317131;1010.9797804043878;8678.479291242546;10506.632267870587;11112.944435277772;11179.385133817717;11181.496832642551;430526;436529;438632;445610;458852;87381.1261887373;87959.56020219858;88314.55842720874;89473;89791.55104224567;944.2351695126832;947.308464820671;956.1251454918671;960.5341409416427;965.3773316211004;17268.568285792455;17604.207810648295;17857.374991875222;17887.910560447115;18287.359942401952;41679.79160104301;42201.82568963345;42505.787471062446;42942.57057429386;43566.34650480182;56467.435325647864;58622.7068864653;59111.704441477516;59588;63528.682356587924;7793.37652987771;7875.921240787518;8095.5142691438705;8095.878561821695;8267.214614611603;10045.799084018425;13473.595792126252;13541.86458135406;13587.93206034003;13620.18278903269;11591.76816463683;11827.20356207544;12108.636740897788;12312.81530777057;12371.072169587136;11454.140939429743;11682.824757628472;11779.116566257737;11780.234284771463;11898.76202475963;11879.881201187878;11939.582114625946;12039.09706771978;12065.758684826078;12172.330521821385;7930.405219608668;8088.393370497354;8136.023677158542;8197.057338406159;8321.791955201168;11020.228583999044;11719.472623732123;11807.815554122515;11811.704707382385;11899.524019039141 13:28:32 INFO - PROCESS | 5506 | |3;mootools.html;1307.6665450310181;1456.4829485532637;1517.142814309915;1623.4561421923654;1744.1889521372568;7731.6907323707055;8078.757637270891;8091.069527004396;8240.958795206016;8248.216419440143;8090.474119182264;8205.276891852718;8205.95897020514;8210.794730131749;8238.794030149249;2266.0709109265204;2286.2683941138757;2286.371247906822;2286.4626812699084;2287.359539328982;2274.442761523429;2303.8617682938993;2309.988450057756;2310.0182422470466;2310.722713274409;2248.696425982496;2249.1116009176367;2271.852329598579;2312.6415405612074;2313.525727225923;2259.164109279569;2260.107257633242;2262.7171603549555;2265.048679554591;2267.1498188179435;2230.4200907763934;2238.5746708125403;2240.798328150458;2244.2930476899887;2244.461329280977;8171.67313307467;8174.182581741778;8211.137830527769;8276.751697449086;8278.337732981347;4926.802927882881;5107.7446127693465;5118.07874582575;5128.333316668809;5134.306868572732;3213.0682102190335;3292;3355.463125899869;3381.3913495570787;3405.5572775539267;1073.457903758597;1079.4063265204106;1081.864766904137;1085.907697845684;1109.05176074456;11100;11115;11209.047230985376;11227.214095013353;11238.606648767336;4147.91704165915;4277.994671252253;4340.891477713019;4352.086061926968;4370.781460927004;8964.820703585892;8999.10008999108;9000.63997440095;9011.954940225258;9019.77450563728;4936.456989731127;4945.826896058621;4947.1837146871085;4954.207326827763;4958.801647934042;4013.779242141652;4493.213687604656;4599.264117741212;4633.235516139799;4638.97680511602;3515.068506845688;3528.8588456461453;3613.728970327236;3642.6903713184674;3676.283124790694;1057.9788404232027;1097;1097.7091070866227;1101.4492753623188;1122.8484154639182;1010.7119470950744;1012.2205901455837;1018.4856647393167;1026.7022563456662;1036.264252380818;5811.506021988093;5947.256592925884;5963.642181469126;6008.969955150196;6095.293317871004;416.87702127872353;449.3708807669289;454.45238487622333;460.1257610539934;466.6616702890377;4109.650679692199;4185.707000509996;4237.00430398856;4263.5096963849555;4312.892177695583;9909.504524773733;10082.143017843418;10169.44068076263;10171.389716617026;10199.898001020043;9514.571844267024;9962.302638815358;10120.848187277197;10125.594976201017;10138.442385668859;7656.693732250759;7841.019872515935;7845.960770196227;7855.33229675484;7858.764237072897;5670.489655930986;5773.1051686988585;5785.537157027512;5928.140419639214;6033.095035744674;9066.546672666209;9112.316576256675;9113.088691130833;9119.589618467053;9124.726258212264;9006.054364291655;9192.632294708405;9208.677696280598;9311.534423278674;9367;6614.768483103068;6927.064846245692;7052.858942821217;7056.788296351117;7163.31948464895;8035.276825085771;8100.473469224482;8109.107998120084;8120.309773669304;8122.7157049502985;7215.422766178798;7241.203467618452;7285.817854553678;7336.229695881855;7496.7376141834775;7032.824179395556;7165.390941770008;7172.641367931478;7189.604571748604;7223.061002069698;6354.682265886595;6452.870942581216;6566.8358291041195;6620.536562440583;6625.105610742488;4917.950820491892;4919.729414882216;4995.975020124876;5086.033653605803;5091.92362114576;4910.189818679878;4974.7512624369365;5069.138246498178;5142.537171654569;5230.660007099526 13:28:32 INFO - PROCESS | 5506 | |4;prototype.html;297.56109738136263;310.82904402578606;312.49220017471606;320.78347115696914;320.96790320967904;4839.516048395168;5054.494550544944;5267.157254839227;5271.55032366099;5291.814786482474;5174.404943431507;5183.53348198662;5187.144121220003;5189.844304670866;5193.896122077556;4058;4058.452108965289;4064.6138616831354;4067.227226826908;4092.8362865485346;3940.7438516496336;3960.5643379228263;4068.8575899843513;4078.3678529827775;4097.79511024449;4016.6987475939422;4024.4969378827645;4032.9596704033024;4055.8783236502804;4067.572904844993;4043.433919251307;4050.4936882889638;4061.8375264989363;4067.97966010171;4071.857484988041;3591.1740299730945;3609.7292703047115;3611.5485564304463;3614.8734794282072;3639.9272014559824;4876.366072410599;5005.774740136702;5025.472325405853;5026.396832380101;5053.418856831475;4604.447466304032;4611.584957353821;4612.423447069116;4617.261238201905;4631.397918270637;5178.152016391007;5378.569714422876;5380.811671591515;5381.461853814626;5388.622796404254;3860.4981352424006;3865.4781604483314;3870.3807390817615;3871.9806400967814;3872.244912242114;5358.303420555342;5408.2428460015235;5590.440955904418;5616.185653080322;5643.209950606918;3904.3557812960544;3917.490726205632;3923.7449565778134;3942.6254505821903;3962.5443074046275;3992.940105898414;3993.221321842213;4002.2195671844293;4013.6387725104883;4041.7574945503366;4617.291602107175;4639.744814035193;4644.58198762113;4646.395968524071;4647.395838540968;5237.973810130925;5461.972690136603;5468.179773034077;5476.2333273341765;5479.972600136974;1364.4746772492663;1378.3935068569797;1379.475799196299;1387.5213051497217;1388.167099740168;841.9410641255054;859.4113032572708;880.7181701855345;892.312919052339;898.8404957604747;4739;4740.762961851894;4752.619790416758;4757.238841785298;4758.191107511731;4901.485344038824;4925.926111108336;4941.851744447672;4972.160300688768;4977.552020318189;4414.448193975753;4708.88227794301;4721.4117270874385;4740.976295118571;4773.451053128865;2600.973990260111;2606.9869650651626;2612.046602989895;2612.2163350994624;2640.696319923195;5057.72182529957;5068.746562671851;5087.618428617794;5102.234664800236;5139.768710407966;4829.589484893753;5007.399112106497;5011.118606801104;5016.598672106223;5049.419316778544;5057.418396884332;5079.492050794891;5087.109755792721;5090.516400941905;5115.130427827204;4890.657653964331;4926.965337279212;4927.634735327135;4958.2810492477665;5019.970905964342;4853.344798452164;4895.33912921751;4901.387326584177;5153.561947234527;5536.557075433875;5576.525995290283;5685.800996965087;5781.624194427349;5790.681512516852;5841.912371314349;3982.482277303932;4035.41486484464;4055;4068.2880495913687;4070.1656160487623;5609.887802244014;5625.184348269396;5633.971830140823;5638.85902852432;5665.376808551138;5322.354187381656;5417.458254174709;5511.153763489276;5518.641288316247;5525.640833345819;5448.692313844728;5471;5471.85091130851;5476.80831170923;5479.698616575967;5280.6303558750515;5434.83695489136;5466.180072989084;5470.659688376373;5505.339359276913;5505.935274272148;5526.226328313959;5535.699110709061;5536.806211782568;5539.944600553943;5386.218998245311;5402.838389746224;5405.162199859028;5422.566194704335;5437.8368648940595 13:28:32 INFO - PROCESS | 5506 | |5;yui.html;728.8943103250032;774.2760518914815;774.7985523763822;808.0989696488415;851.7146755836794;13978.3709733062;14750.704985900276;14866.55400337989;14890.553283401501;14896.553103406888;14817.333220005099;14954.252287385641;14967.625809354771;14979.251037448139;14979.700405991875;650.3106706890711;780.7345502529139;789.0294937227214;809.360605121953;811.6915572082601;803.6986130201175;806.2944923192207;806.330745481252;806.3629732511338;806.5080301016404;859.7377799771067;860.371928492201;861.0399404663787;861.4271509446211;861.67687117331;688.2360579756466;822.6627082896043;839.4795226959325;844.0673056272792;853.5177624642089;612.1032687113355;617.1421723803916;617.3579477343602;617.9443850053472;618.3229363846626;14556.927215363961;14586.854131458656;14612.634684132876;14653.853461465462;14669.119852808759;14103.506377276848;14119.78820317696;14351.425942962269;14482.855171448256;14627.853721462756;13167.341632918316;13195.2742599157;13534.458621655122;13722.588322350346;13921.443142274296;4374.759388233646;4413.095315460323;4433.334999750031;4473.105378924228;4514.977425112854;81203;81498;82805.58597207036;83100;84924.57537712334;11711.121665874924;11713.297202167727;11778.52885884555;11815.350155741346;11831.053515718722;21535.67696484554;21582.89208553947;21605.135794568043;21685.566288674137;21695.13219471235;8099.352051835839;8105.351571874236;8201.58992050407;8242.464239824512;8319.126491718403;4484.349769283435;4535.229011068126;4599.7470139142;4690.179218636725;4696.342512048248;3093.706097920694;3188.649248582654;3193.616765988096;3193.9041828745176;3198.648148703641;551.9972400137974;553.2475832867298;553.3691591585596;554.789180111555;571.4314257313916;617.237711426388;617.8548041210312;643.6427782580713;670.289493137276;694.1808665774333;8752.256058234994;8875.822483550293;8978.281737460988;9076.500792456347;9109.90890091104;615.4368752591329;646.3633321178635;714.4995509430258;737.9815504612428;747.9476436649383;4292.89267768302;4523.163214805271;4523.340038247709;4572.474165470947;4573.748443835621;73072.63463682648;74386.25613743793;98519;100011;102777;95390.52304738433;96690.51654741821;96963;97029.51485242529;97754;83590;83678.16321836825;85355;85370;87238.99999999873;9293.303002274992;9559.235261179228;9582.185514231369;9805.411675299505;9951.552180151766;40364.59635403608;41225;47531;47579.24207579214;49324.26013609727;65726;66223.66888165528;72161.63919180371;75314.6234268847;79595.60202198951;12104.818427723767;12223.877761222275;12365.567205147776;12497.312647804458;12938.288394138413;13497.190168589916;13586.252756098509;13860.376283067488;13964.231967241492;14337.283135843374;13100;13390;13606.93196534011;13642.727145457235;13673.658158546115;11305.547778088785;11325.660230193107;11445.084393248353;12817.359132043173;13427.664308392368;12116.15186936906;12960.740785184433;13024.088313817942;13268.27024513661;13959.651008724457;9336.253099752139;9945;9951.601935922483;10042.648507302209;10780.245382823126;10587.417692027013;10964.945175274073;11228.66314010581;11283.513296049403;11494.94252528732 13:28:32 INFO - PROCESS | 5506 | __end_tp_report 13:28:32 INFO - PROCESS | 5506 | __start_cc_report 13:28:32 INFO - PROCESS | 5506 | _x_x_mozilla_cycle_collect,1037 13:28:32 INFO - PROCESS | 5506 | __end_cc_report 13:28:32 INFO - PROCESS | 5506 | __startTimestamp1469996912809__endTimestamp 13:28:32 INFO - PROCESS | 5506 | 13:28:32 INFO - PROCESS | 5506 | ------- Summary: start ------- 13:28:32 INFO - PROCESS | 5506 | Number of tests: 6 13:28:32 INFO - PROCESS | 5506 | 13:28:32 INFO - PROCESS | 5506 | [#0] dojo.html Cycles:165 Average:5204.19 Median:5388.97 stddev:588.41 (10.9%) stddev-sans-first:562.89 13:28:32 INFO - PROCESS | 5506 | Values: 2944.9 2987.8 3015.0 3021.8 3043.9 5109.4 5161.4 5164.3 5259.4 5264.1 5175.2 5191.6 5205.5 5217.1 5274.6 4671.1 4752.1 4802.0 4808.9 4905.8 4789.5 4828.0 4840.3 4843.2 4868.3 4668.0 4724.7 4753.9 4757.3 4789.1 4779.5 4783.4 4784.4 4791.3 4823.8 4758.0 4765.6 4775.1 4789.5 4792.3 5156.8 5161.3 5212.0 5269.0 5306.2 5631.9 5638.2 5639.8 5640.4 5643.6 5660.6 5676.7 5684.6 5690.9 5692.0 5124.2 5226.6 5283.5 5287.5 5360.1 5788.7 5792.8 5845.3 5846.9 5850.0 5610.6 5612.9 5624.0 5625.3 5631.0 5389.0 5484.5 5498.4 5563.0 5643.7 5519.6 5573.1 5574.2 5575.5 5615.2 5521.2 5571.6 5578.9 5582.2 5588.2 4212.8 4253.6 4286.8 4299.9 4339.9 3856.2 3866.3 3874.2 3898.9 3904.0 5324.2 5333.6 5334.0 5335.4 5383.9 5475.5 5570.1 5595.6 5620.6 5708.5 5267.0 5302.0 5303.7 5303.9 5305.3 4775.0 4779.7 4790.1 4794.5 4833.1 5556.8 5696.3 5728.1 5732.6 5853.0 5561.9 5567.0 5568.2 5571.7 5573.6 5773.1 5782.4 5782.9 5785.0 5785.4 5371.9 5458.5 5481.5 5506.4 5575.8 5572.7 5618.0 5623.0 5627.9 5628.9 5451.0 5519.9 5520.4 5523.7 5561.1 5274.9 5389.0 5426.8 5435.3 5524.4 5410.3 5411.9 5415.9 5421.5 5421.9 5491.3 5496.6 5532.1 5532.1 5532.1 5209.2 5268.4 5325.6 5325.8 5386.1 13:28:32 INFO - PROCESS | 5506 | 13:28:32 INFO - PROCESS | 5506 | [#1] ext.html Cycles:180 Average:61316.04 Median:247390.50 stddev:118457.40 (47.9%) stddev-sans-first:118701.95 13:28:32 INFO - PROCESS | 5506 | Values: 585.7 607.0 610.7 625.8 626.6 32744.3 45101.8 45843.5 45909.0 46066.5 46091.3 46510.3 46515.5 46557.5 46627.0 8999.0 9149.0 9149.6 9161.6 9167.7 8888.1 8958.8 8968.9 8974.3 8995.6 8909.3 9002.2 9016.9 9022.1 9023.5 8993.9 9030.9 9032.6 9035.1 9042.4 8899.7 8939.6 8982.4 8987.6 8992.4 43839.0 44096.3 44138.8 44340.3 44387.8 3632.5 3640.9 3723.9 3977.2 4064.5 33786.8 33982.7 34207.7 34209.8 34445.8 4505.1 4570.9 4621.7 4685.6 4745.8 337690.0 338554.0 339256.0 339943.0 340403.3 54338.0 59254.0 60631.7 61039.4 61311.4 59452.4 65126.7 65272.7 65671.7 65702.3 13962.2 14043.9 14052.6 14062.1 14062.5 10088.3 10795.2 11092.7 11193.3 11197.6 18305.3 18607.1 18638.5 18739.3 19050.3 6128.9 6188.1 6256.4 6294.7 6310.3 924.8 929.6 1059.4 1063.8 1079.5 33566.8 33637.3 33883.3 33960.0 34766.5 1074.3 1090.5 1105.6 1120.6 1212.9 16675.8 17472.6 17555.3 17665.9 17816.1 530457.0 530765.0 530922.0 531396.0 532159.0 60015.7 60162.0 60295.4 60301.4 60365.0 1294.5 1329.2 1332.1 1332.3 1332.9 31291.4 32666.5 33156.3 33473.7 33582.8 54387.7 54524.7 54699.5 54899.5 54900.5 447037.0 449816.0 451058.0 451548.0 454919.0 33757.5 43116.0 44717.8 44745.6 46885.3 48500.3 48581.3 48886.0 48948.3 49742.5 40370.8 40816.8 41914.0 43144.1 43776.8 42208.4 42296.6 42370.6 44141.3 44262.6 42061.8 44965.0 45082.0 45939.8 46145.3 35565.3 37696.4 37981.4 38206.3 38957.2 28817.7 28849.6 29077.4 29225.4 29388.4 13:28:32 INFO - PROCESS | 5506 | 13:28:32 INFO - PROCESS | 5506 | [#2] jquery.html Cycles:180 Average:29010.00 Median:383.23 stddev:73397.32 (19152.4%) stddev-sans-first:73571.70 13:28:32 INFO - PROCESS | 5506 | Values: 362.2 369.4 377.4 381.9 384.5 18658.3 19597.5 20016.9 20188.6 20279.2 11146.6 11380.9 11479.4 11488.9 11703.2 4871.7 5104.9 5159.8 5184.1 5188.3 3866.6 5174.8 5219.5 5489.0 5787.4 5744.2 5793.4 5797.9 5817.1 5825.4 5553.4 5646.8 5730.7 5741.9 5777.6 5587.7 5606.6 5622.2 5627.7 5629.4 25330.1 25694.6 25755.9 27243.7 27411.9 2306.2 2549.3 3092.6 3151.5 3374.9 16013.9 16114.8 16452.7 16510.6 16908.7 2037.8 2151.9 2306.5 2311.8 2390.7 88216.0 96794.5 99402.0 100016.0 101724.5 17592.9 17841.7 17955.4 18381.5 18938.3 33140.7 33177.0 33239.3 33558.7 33617.7 8851.7 8957.0 9214.8 9266.3 9428.2 7382.4 7471.6 7608.0 7612.7 7670.6 8978.5 9321.2 9333.3 9377.3 9390.2 2722.0 3167.0 3299.7 3572.0 3736.2 836.5 911.1 937.4 965.9 995.0 17819.8 19267.8 19842.8 20042.4 20075.5 924.4 924.7 963.9 998.6 1011.0 8678.5 10506.6 11112.9 11179.4 11181.5 430526.0 436529.0 438632.0 445610.0 458852.0 87381.1 87959.6 88314.6 89473.0 89791.6 944.2 947.3 956.1 960.5 965.4 17268.6 17604.2 17857.4 17887.9 18287.4 41679.8 42201.8 42505.8 42942.6 43566.3 56467.4 58622.7 59111.7 59588.0 63528.7 7793.4 7875.9 8095.5 8095.9 8267.2 10045.8 13473.6 13541.9 13587.9 13620.2 11591.8 11827.2 12108.6 12312.8 12371.1 11454.1 11682.8 11779.1 11780.2 11898.8 11879.9 11939.6 12039.1 12065.8 12172.3 7930.4 8088.4 8136.0 8197.1 8321.8 11020.2 11719.5 11807.8 11811.7 11899.5 13:28:32 INFO - PROCESS | 5506 | 13:28:32 INFO - PROCESS | 5506 | [#3] mootools.html Cycles:180 Average:5425.27 Median:4931.63 stddev:2995.75 (60.7%) stddev-sans-first:2988.17 13:28:32 INFO - PROCESS | 5506 | Values: 1307.7 1456.5 1517.1 1623.5 1744.2 7731.7 8078.8 8091.1 8241.0 8248.2 8090.5 8205.3 8206.0 8210.8 8238.8 2266.1 2286.3 2286.4 2286.5 2287.4 2274.4 2303.9 2310.0 2310.0 2310.7 2248.7 2249.1 2271.9 2312.6 2313.5 2259.2 2260.1 2262.7 2265.0 2267.1 2230.4 2238.6 2240.8 2244.3 2244.5 8171.7 8174.2 8211.1 8276.8 8278.3 4926.8 5107.7 5118.1 5128.3 5134.3 3213.1 3292.0 3355.5 3381.4 3405.6 1073.5 1079.4 1081.9 1085.9 1109.1 11100.0 11115.0 11209.0 11227.2 11238.6 4147.9 4278.0 4340.9 4352.1 4370.8 8964.8 8999.1 9000.6 9012.0 9019.8 4936.5 4945.8 4947.2 4954.2 4958.8 4013.8 4493.2 4599.3 4633.2 4639.0 3515.1 3528.9 3613.7 3642.7 3676.3 1058.0 1097.0 1097.7 1101.4 1122.8 1010.7 1012.2 1018.5 1026.7 1036.3 5811.5 5947.3 5963.6 6009.0 6095.3 416.9 449.4 454.5 460.1 466.7 4109.7 4185.7 4237.0 4263.5 4312.9 9909.5 10082.1 10169.4 10171.4 10199.9 9514.6 9962.3 10120.8 10125.6 10138.4 7656.7 7841.0 7846.0 7855.3 7858.8 5670.5 5773.1 5785.5 5928.1 6033.1 9066.5 9112.3 9113.1 9119.6 9124.7 9006.1 9192.6 9208.7 9311.5 9367.0 6614.8 6927.1 7052.9 7056.8 7163.3 8035.3 8100.5 8109.1 8120.3 8122.7 7215.4 7241.2 7285.8 7336.2 7496.7 7032.8 7165.4 7172.6 7189.6 7223.1 6354.7 6452.9 6566.8 6620.5 6625.1 4918.0 4919.7 4996.0 5086.0 5091.9 4910.2 4974.8 5069.1 5142.5 5230.7 13:28:32 INFO - PROCESS | 5506 | 13:28:32 INFO - PROCESS | 5506 | [#4] prototype.html Cycles:180 Average:4442.24 Median:4934.74 stddev:1291.94 (26.2%) stddev-sans-first:1257.55 13:28:32 INFO - PROCESS | 5506 | Values: 297.6 310.8 312.5 320.8 321.0 4839.5 5054.5 5267.2 5271.6 5291.8 5174.4 5183.5 5187.1 5189.8 5193.9 4058.0 4058.5 4064.6 4067.2 4092.8 3940.7 3960.6 4068.9 4078.4 4097.8 4016.7 4024.5 4033.0 4055.9 4067.6 4043.4 4050.5 4061.8 4068.0 4071.9 3591.2 3609.7 3611.5 3614.9 3639.9 4876.4 5005.8 5025.5 5026.4 5053.4 4604.4 4611.6 4612.4 4617.3 4631.4 5178.2 5378.6 5380.8 5381.5 5388.6 3860.5 3865.5 3870.4 3872.0 3872.2 5358.3 5408.2 5590.4 5616.2 5643.2 3904.4 3917.5 3923.7 3942.6 3962.5 3992.9 3993.2 4002.2 4013.6 4041.8 4617.3 4639.7 4644.6 4646.4 4647.4 5238.0 5462.0 5468.2 5476.2 5480.0 1364.5 1378.4 1379.5 1387.5 1388.2 841.9 859.4 880.7 892.3 898.8 4739.0 4740.8 4752.6 4757.2 4758.2 4901.5 4925.9 4941.9 4972.2 4977.6 4414.4 4708.9 4721.4 4741.0 4773.5 2601.0 2607.0 2612.0 2612.2 2640.7 5057.7 5068.7 5087.6 5102.2 5139.8 4829.6 5007.4 5011.1 5016.6 5049.4 5057.4 5079.5 5087.1 5090.5 5115.1 4890.7 4927.0 4927.6 4958.3 5020.0 4853.3 4895.3 4901.4 5153.6 5536.6 5576.5 5685.8 5781.6 5790.7 5841.9 3982.5 4035.4 4055.0 4068.3 4070.2 5609.9 5625.2 5634.0 5638.9 5665.4 5322.4 5417.5 5511.2 5518.6 5525.6 5448.7 5471.0 5471.9 5476.8 5479.7 5280.6 5434.8 5466.2 5470.7 5505.3 5505.9 5526.2 5535.7 5536.8 5539.9 5386.2 5402.8 5405.2 5422.6 5437.8 13:28:32 INFO - PROCESS | 5506 | 13:28:32 INFO - PROCESS | 5506 | [#5] yui.html Cycles:180 Average:19800.29 Median:26113.67 stddev:27881.19 (106.8%) stddev-sans-first:27922.63 13:28:32 INFO - PROCESS | 5506 | Values: 728.9 774.3 774.8 808.1 851.7 13978.4 14750.7 14866.6 14890.6 14896.6 14817.3 14954.3 14967.6 14979.3 14979.7 650.3 780.7 789.0 809.4 811.7 803.7 806.3 806.3 806.4 806.5 859.7 860.4 861.0 861.4 861.7 688.2 822.7 839.5 844.1 853.5 612.1 617.1 617.4 617.9 618.3 14556.9 14586.9 14612.6 14653.9 14669.1 14103.5 14119.8 14351.4 14482.9 14627.9 13167.3 13195.3 13534.5 13722.6 13921.4 4374.8 4413.1 4433.3 4473.1 4515.0 81203.0 81498.0 82805.6 83100.0 84924.6 11711.1 11713.3 11778.5 11815.4 11831.1 21535.7 21582.9 21605.1 21685.6 21695.1 8099.4 8105.4 8201.6 8242.5 8319.1 4484.3 4535.2 4599.7 4690.2 4696.3 3093.7 3188.6 3193.6 3193.9 3198.6 552.0 553.2 553.4 554.8 571.4 617.2 617.9 643.6 670.3 694.2 8752.3 8875.8 8978.3 9076.5 9109.9 615.4 646.4 714.5 738.0 747.9 4292.9 4523.2 4523.3 4572.5 4573.7 73072.6 74386.3 98519.0 100011.0 102777.0 95390.5 96690.5 96963.0 97029.5 97754.0 83590.0 83678.2 85355.0 85370.0 87239.0 9293.3 9559.2 9582.2 9805.4 9951.6 40364.6 41225.0 47531.0 47579.2 49324.3 65726.0 66223.7 72161.6 75314.6 79595.6 12104.8 12223.9 12365.6 12497.3 12938.3 13497.2 13586.3 13860.4 13964.2 14337.3 13100.0 13390.0 13606.9 13642.7 13673.7 11305.5 11325.7 11445.1 12817.4 13427.7 12116.2 12960.7 13024.1 13268.3 13959.7 9336.3 9945.0 9951.6 10042.6 10780.2 10587.4 10964.9 11228.7 11283.5 11494.9 13:28:32 INFO - PROCESS | 5506 | -------- Summary: end -------- 13:28:32 INFO - PROCESS | 5506 | 13:28:33 INFO - TEST-INFO | 5506: exit 0 13:28:33 INFO - TEST-OK | dromaeo_css | took 1112507ms 13:28:33 INFO - TEST-START | kraken 13:28:33 INFO - operating with platform_type : linux_ 13:28:33 INFO - Initialising browser for kraken test... 13:28:33 INFO - TEST-INFO | started process 5706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmoXozy/profile http://localhost:43426/getInfo.html) 13:28:37 INFO - PROCESS | 5706 | __metrics Screen width/height:1600/1200 13:28:37 INFO - PROCESS | 5706 | colorDepth:24 13:28:37 INFO - PROCESS | 5706 | Browser inner width/height: 1024/697 13:28:37 INFO - PROCESS | 5706 | __metrics 13:28:38 INFO - PROCESS | 5706 | 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" 13:28:38 INFO - PROCESS | 5706 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:28:38 INFO - TEST-INFO | 5706: exit 0 13:28:38 INFO - Browser initialized. 13:28:38 INFO - Running cycle 1/1 for kraken test... 13:28:38 INFO - TEST-INFO | started process 5784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmoXozy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:50 INFO - PROCESS | 5784 | RSS: Main: 156397568 13:28:50 INFO - PROCESS | 5784 | 13:28:53 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43426/tests/kraken/driver.html?testName=audio-beat-detection) 13:28:54 INFO - PROCESS | 5784 | RSS: Main: 212500480 13:28:54 INFO - PROCESS | 5784 | 13:28:56 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43426/tests/kraken/driver.html?testName=audio-dft) 13:28:57 INFO - PROCESS | 5784 | RSS: Main: 191758336 13:28:57 INFO - PROCESS | 5784 | 13:29:00 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43426/tests/kraken/driver.html?testName=audio-fft) 13:29:00 INFO - PROCESS | 5784 | RSS: Main: 270176256 13:29:00 INFO - PROCESS | 5784 | 13:29:03 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43426/tests/kraken/driver.html?testName=audio-oscillator) 13:29:03 INFO - PROCESS | 5784 | RSS: Main: 179109888 13:29:03 INFO - PROCESS | 5784 | 13:29:05 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43426/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:29:06 INFO - PROCESS | 5784 | RSS: Main: 184008704 13:29:06 INFO - PROCESS | 5784 | 13:29:09 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43426/tests/kraken/driver.html?testName=imaging-darkroom) 13:29:10 INFO - PROCESS | 5784 | RSS: Main: 218771456 13:29:10 INFO - PROCESS | 5784 | 13:29:13 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43426/tests/kraken/driver.html?testName=imaging-desaturate) 13:29:13 INFO - PROCESS | 5784 | RSS: Main: 219295744 13:29:13 INFO - PROCESS | 5784 | 13:29:16 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43426/tests/kraken/driver.html?testName=json-parse-financial) 13:29:17 INFO - PROCESS | 5784 | RSS: Main: 219299840 13:29:17 INFO - PROCESS | 5784 | 13:29:18 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43426/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:29:19 INFO - PROCESS | 5784 | RSS: Main: 183422976 13:29:19 INFO - PROCESS | 5784 | 13:29:21 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:29:21 INFO - PROCESS | 5784 | RSS: Main: 189558784 13:29:21 INFO - PROCESS | 5784 | 13:29:23 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:29:24 INFO - PROCESS | 5784 | RSS: Main: 193576960 13:29:24 INFO - PROCESS | 5784 | 13:29:27 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:29:27 INFO - PROCESS | 5784 | RSS: Main: 188366848 13:29:27 INFO - PROCESS | 5784 | 13:29:30 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:29:30 INFO - PROCESS | 5784 | RSS: Main: 192483328 13:29:30 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43426/tests/kraken/driver.html?testName=ai-astar) 13:29:32 INFO - PROCESS | 5784 | RSS: Main: 243572736 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | __start_tp_report 13:29:32 INFO - PROCESS | 5784 | _x_x_mozilla_page_load 13:29:32 INFO - PROCESS | 5784 | _x_x_mozilla_page_load_details 13:29:32 INFO - PROCESS | 5784 | |i|pagename|runs| 13:29:32 INFO - PROCESS | 5784 | |0;ai-astar;104;111;110;113;113;109;112;108;109;113 13:29:32 INFO - PROCESS | 5784 | |1;audio-beat-detection;144;116;118;182;120;119;147;117;153;119 13:29:32 INFO - PROCESS | 5784 | |2;audio-dft;160;160;160;161;160;160;161;161;165;161 13:29:32 INFO - PROCESS | 5784 | |3;audio-fft;75;77;76;110;75;76;74;74;99;73 13:29:32 INFO - PROCESS | 5784 | |4;audio-oscillator;84;84;108;84;84;84;128;83;84;130 13:29:32 INFO - PROCESS | 5784 | |5;imaging-gaussian-blur;117;118;117;117;116;116;117;117;117;117 13:29:32 INFO - PROCESS | 5784 | |6;imaging-darkroom;145;145;146;145;145;146;145;146;146;146 13:29:32 INFO - PROCESS | 5784 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;94;95 13:29:32 INFO - PROCESS | 5784 | |8;json-parse-financial;52;51;54;52;51;53;52;51;52;52 13:29:32 INFO - PROCESS | 5784 | |9;json-stringify-tinderbox;61;62;61;62;62;61;61;61;62;62 13:29:32 INFO - PROCESS | 5784 | |10;stanford-crypto-aes;75;75;75;75;76;74;75;75;74;84 13:29:32 INFO - PROCESS | 5784 | |11;stanford-crypto-ccm;138;131;121;126;119;130;118;118;189;120 13:29:32 INFO - PROCESS | 5784 | |12;stanford-crypto-pbkdf2;161;161;163;158;157;164;159;158;158;157 13:29:32 INFO - PROCESS | 5784 | |13;stanford-crypto-sha256-iterative;64;63;63;63;64;64;65;63;62;62 13:29:32 INFO - PROCESS | 5784 | __end_tp_report 13:29:32 INFO - PROCESS | 5784 | __start_cc_report 13:29:32 INFO - PROCESS | 5784 | _x_x_mozilla_cycle_collect,1617 13:29:32 INFO - PROCESS | 5784 | __end_cc_report 13:29:32 INFO - PROCESS | 5784 | __startTimestamp1469996972880__endTimestamp 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | ------- Summary: start ------- 13:29:32 INFO - PROCESS | 5784 | Number of tests: 14 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:2.86 (2.6%) stddev-sans-first:1.96 13:29:32 INFO - PROCESS | 5784 | Values: 104.0 111.0 110.0 113.0 113.0 109.0 112.0 108.0 109.0 113.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:132.00 stddev:22.23 (16.8%) stddev-sans-first:23.25 13:29:32 INFO - PROCESS | 5784 | Values: 144.0 116.0 118.0 182.0 120.0 119.0 147.0 117.0 153.0 119.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.52 (0.9%) stddev-sans-first:1.58 13:29:32 INFO - PROCESS | 5784 | Values: 160.0 160.0 160.0 161.0 160.0 160.0 161.0 161.0 165.0 161.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.50 stddev:12.76 (16.9%) stddev-sans-first:13.35 13:29:32 INFO - PROCESS | 5784 | Values: 75.0 77.0 76.0 110.0 75.0 76.0 74.0 74.0 99.0 73.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.00 stddev:19.30 (23.0%) stddev-sans-first:20.03 13:29:32 INFO - PROCESS | 5784 | Values: 84.0 84.0 108.0 84.0 84.0 84.0 128.0 83.0 84.0 130.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:29:32 INFO - PROCESS | 5784 | Values: 117.0 118.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:29:32 INFO - PROCESS | 5784 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:29:32 INFO - PROCESS | 5784 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 13:29:32 INFO - PROCESS | 5784 | Values: 52.0 51.0 54.0 52.0 51.0 53.0 52.0 51.0 52.0 52.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 13:29:32 INFO - PROCESS | 5784 | Values: 61.0 62.0 61.0 62.0 62.0 61.0 61.0 61.0 62.0 62.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.00 stddev:2.94 (3.9%) stddev-sans-first:3.10 13:29:32 INFO - PROCESS | 5784 | Values: 75.0 75.0 75.0 75.0 76.0 74.0 75.0 75.0 74.0 84.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:128.00 stddev:21.45 (16.8%) stddev-sans-first:22.60 13:29:32 INFO - PROCESS | 5784 | Values: 138.0 131.0 121.0 126.0 119.0 130.0 118.0 118.0 189.0 120.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:160.00 stddev:2.50 (1.6%) stddev-sans-first:2.60 13:29:32 INFO - PROCESS | 5784 | Values: 161.0 161.0 163.0 158.0 157.0 164.0 159.0 158.0 158.0 157.0 13:29:32 INFO - PROCESS | 5784 | 13:29:32 INFO - PROCESS | 5784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 13:29:32 INFO - PROCESS | 5784 | Values: 64.0 63.0 63.0 63.0 64.0 64.0 65.0 63.0 62.0 62.0 13:29:32 INFO - PROCESS | 5784 | -------- Summary: end -------- 13:29:32 INFO - PROCESS | 5784 | 13:29:33 INFO - TEST-INFO | 5784: exit 0 13:29:33 INFO - TEST-OK | kraken | took 60324ms 13:29:33 INFO - SUITE-END | took 1172s 13:29:34 INFO - Completed test suite (00:19:32) 13:29:34 INFO - javascript benchmark 13:29:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2944.92637684058, 2987.7908546401754, 3015.0351887396027, 3021.8186908785488, 3043.9391212175756, 5109.386873575167, 5161.354830646169, 5164.2770012198325, 5259.421463639002, 5264.105102132642, 5175.223716442535, 5191.558717509016, 5205.453427390126, 5217.113090774568, 5274.5780337573, 4671.112488627158, 4752.097101550694, 4801.951980480186, 4808.927866082012, 4905.779239934193, 4789.497102804207, 4827.975860120712, 4840.298156767267, 4843.249296359052, 4868.342773725555, 4668.0, 4724.74013929232, 4753.857384278477, 4757.333973243749, 4789.090072886141, 4779.498152693952, 4783.449903261135, 4784.425868895755, 4791.2813078038225, 4823.758812059418, 4757.976210118962, 4765.594924431392, 4775.068861571995, 4789.521047895218, 4792.257200133985, 5156.845294641167, 5161.251618515332, 5211.973940130275, 5268.973655131738, 5306.177542480922, 5631.943680563183, 5638.210650508932, 5639.802606908779, 5640.407757185519, 5643.6049476536655, 5660.60375773696, 5676.744546495376, 5684.63049901755, 5690.886182276331, 5692.0, 5124.231365295198, 5226.581873450153, 5283.524482796567, 5287.497687719622, 5360.088784906575, 5788.739506722208, 5792.82621521355, 5845.269341332333, 5846.912296315559, 5850.034744267234, 5610.551155907518, 5612.915806262909, 5624.015797235467, 5625.324961004706, 5630.971845140748, 5388.9730551347775, 5484.533814625722, 5498.422665620133, 5563.0, 5643.717814109278, 5519.613627046068, 5573.080441727069, 5574.16387541872, 5575.470330318613, 5615.185798059259, 5521.199426083195, 5571.60998730085, 5578.888422231533, 5582.162675598693, 5588.161775733591, 4212.810423530948, 4253.553376895444, 4286.828526858891, 4299.914001719948, 4339.913201736011, 3856.2094770571966, 3866.284737323604, 3874.2057878134915, 3898.922021559553, 3904.04350934023, 5324.227986941872, 5333.599980001515, 5334.039872822929, 5335.439778823167, 5383.946160538423, 5475.5072043516275, 5570.053090974544, 5595.580331475156, 5620.606557540933, 5708.514776244066, 5266.973665131726, 5302.045631786315, 5303.708296043755, 5303.867403314948, 5305.31030965972, 4775.044991001813, 4779.737114458669, 4790.113828941588, 4794.472608013116, 4833.10587541306, 5556.833295001156, 5696.3449203341315, 5728.140778883201, 5732.598718089777, 5852.970735146297, 5561.944380556142, 5566.972165139148, 5568.248286481436, 5571.693556854412, 5573.6098473106495, 5773.076307790733, 5782.392848750989, 5782.942170578241, 5784.971075144597, 5785.392533783892, 5371.919421208607, 5458.5087342139395, 5481.5340696041285, 5506.366767821592, 5575.804846830341, 5572.665640061609, 5618.016847051668, 5622.971885140548, 5627.8874422512135, 5628.915566266427, 5451.0, 5519.9448005521035, 5520.447955204608, 5523.6685798852195, 5561.110222364402, 5274.920876186937, 5389.0299746046085, 5426.810061647823, 5435.347758269033, 5524.392316845224, 5410.2696136022705, 5411.864703382447, 5415.864603384947, 5421.457854214547, 5421.891562168814, 5491.28613280271, 5496.587755918242, 5532.059549876451, 5532.0595498766115, 5532.1425179097305, 5209.166533354645, 5268.420473747808, 5325.627206095691, 5325.760340784596, 5386.13821788512], "value": 5164.423117662852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.6895845202044, 606.9757209711611, 610.7282259394572, 625.8060001399565, 626.5676683088672, 32744.345113097752, 45101.77449112754, 45843.541564584346, 45909.0, 46066.53933460664, 46091.30863037057, 46510.30234546476, 46515.53484465154, 46557.53442465574, 46627.0, 8998.955005224965, 9148.954255228715, 9149.634014639407, 9161.633534658638, 9167.679131230409, 8888.06675299094, 8958.820823583525, 8968.865467017968, 8974.326925480615, 8995.550222488882, 8909.287257019423, 9002.234810041155, 9016.909830901706, 9022.09779022099, 9023.503707296097, 8993.865092023625, 9030.86453703195, 9032.638694452247, 9035.051319611412, 9042.412243204237, 8899.688510902151, 8939.597718102701, 8982.416142950688, 8987.595558199897, 8992.415492993, 43839.0, 44096.3385549217, 44138.779306103585, 44340.3348949766, 44387.778061109486, 3632.4551317302617, 3640.9453858192146, 3723.8882833514767, 3977.1846771411792, 4064.5122585289955, 33786.83106584451, 33982.66017339844, 34207.657923420695, 34209.82895085509, 34445.82777086098, 4505.121501307246, 4570.885727856797, 4621.676482646216, 4685.601723853477, 4745.810167593292, 337690.0, 338554.0, 339256.0, 339943.0, 340403.297983511, 54338.0, 59254.0, 60631.69684151551, 61039.38960610426, 61311.38688613146, 59452.405475945554, 65126.67436662786, 65272.673636631516, 65671.67164164245, 65702.34297656962, 13962.162270263816, 14043.929780351033, 14052.578422647337, 14062.085964412281, 14062.507812226728, 10088.344257623232, 10795.244332896622, 11092.722681932855, 11193.27243729155, 11197.60808371703, 18305.267789288544, 18607.06964651762, 18638.53403664892, 18739.25042998292, 19050.333238336592, 6128.8774224516155, 6188.1027251048345, 6256.405641464054, 6294.65379404128, 6310.305866354697, 924.7688077980505, 929.5816882402946, 1059.433203236265, 1063.7925604507047, 1079.4548752879746, 33566.83216583901, 33637.327253454794, 33883.32233355319, 33960.0, 34766.47850282248, 1074.333912973961, 1090.5310716391868, 1105.6240878101323, 1120.5965852293168, 1212.8969037631723, 16675.83324166767, 17472.563185920455, 17555.34783282431, 17665.911670441565, 17816.109194540222, 530457.0, 530765.0, 530922.0, 531396.0, 532159.0, 60015.699921500986, 60162.0, 60295.39704602986, 60301.39698603046, 60365.0, 1294.4692676002794, 1329.1759109352263, 1332.1274565159836, 1332.3138583629438, 1332.8667133286594, 31291.374172515967, 32666.51000235046, 33156.33687326288, 33473.66526334705, 33582.832085839415, 54387.72806135944, 54524.72737636286, 54699.45300546943, 54899.451005491035, 54900.45099548953, 447037.0, 449816.0, 451058.0, 451548.0, 454919.0, 33757.49363759496, 43116.0, 44717.77641111774, 44745.55254447544, 46885.29672054854, 48500.2724959133, 48581.27128093152, 48886.0, 48948.265776012675, 49742.50257497379, 40370.79814600908, 40816.79591602023, 41914.0, 43144.137117258106, 43776.781116094215, 42208.36687449752, 42296.5770342305, 42370.576294236664, 44141.33787993118, 44262.55737442713, 42061.78969105135, 44965.0, 45082.0, 45939.77030114828, 46145.30782038205, 35565.28869422649, 37696.43455348227, 37981.430278546395, 38206.32555721184, 38957.2208555833, 28817.711822882342, 28849.567256491588, 29077.418451630427, 29225.415491690474, 29388.412231755672], "value": 20573.901779794334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.1507564760635, 369.4495202148797, 377.3867465368776, 381.9293430715317, 384.5270317509463, 18658.253669853206, 19597.51006224845, 20016.899915500402, 20188.596228075447, 20279.188832446685, 11146.554137834477, 11380.886191138086, 11479.426028698574, 11488.885111148886, 11703.18077734559, 4871.658983871131, 5104.948950510485, 5159.76781044852, 5184.066867963765, 5188.299579556749, 3866.5553461351883, 5174.767135478913, 5219.530242278194, 5488.9725551372185, 5787.363390027114, 5744.195812586241, 5793.391693872146, 5797.942020579782, 5817.0983497557945, 5825.388334224887, 5553.389127196006, 5646.802361917313, 5730.68481233532, 5741.856453588652, 5777.624454410471, 5587.692676902769, 5606.635568688022, 5622.240997465331, 5627.662340259598, 5629.380768115504, 25330.1134460293, 25694.614580781305, 25755.871220643778, 27243.727562724318, 27411.86294068517, 2306.169778879602, 2549.3244290263096, 3092.6288845338477, 3151.4642510772997, 3374.9156271093175, 16013.919930400274, 16114.75827862583, 16452.670946581122, 16510.587235319093, 16908.66182676352, 2037.7860324665994, 2151.9031643576077, 2306.5386922615544, 2311.7572654871333, 2390.6772585700883, 88216.0, 96794.5160274194, 99402.0, 100016.0, 101724.49137754338, 17592.912035439742, 17841.7323740144, 17955.37156199553, 18381.54046148857, 18938.337158199396, 33140.66859331424, 33177.0, 33239.3352132956, 33558.66441335555, 33617.663823361945, 8851.69019084329, 8957.0, 9214.76963075915, 9266.258699304175, 9428.198603118812, 7382.446316526282, 7471.626418679044, 7607.961960190164, 7612.657430415645, 7670.578118203441, 8978.506182159914, 9321.161095501302, 9333.253339732804, 9377.343585949055, 9390.248780097576, 2721.9591706124424, 3166.9597186700566, 3299.653536378694, 3571.9642803571633, 3736.159364143046, 836.5357226739218, 911.1253196930888, 937.3906960475609, 965.8551217317458, 995.004995004995, 17819.821801782076, 19267.80732192688, 19842.801571984382, 20042.39872803818, 20075.49811254701, 924.4499522783933, 924.6624981881699, 963.8746962894779, 998.6255154317131, 1010.9797804043878, 8678.479291242546, 10506.632267870587, 11112.944435277772, 11179.385133817717, 11181.496832642551, 430526.0, 436529.0, 438632.0, 445610.0, 458852.0, 87381.1261887373, 87959.56020219858, 88314.55842720874, 89473.0, 89791.55104224567, 944.2351695126832, 947.308464820671, 956.1251454918671, 960.5341409416427, 965.3773316211004, 17268.568285792455, 17604.207810648295, 17857.374991875222, 17887.910560447115, 18287.359942401952, 41679.79160104301, 42201.82568963345, 42505.787471062446, 42942.57057429386, 43566.34650480182, 56467.435325647864, 58622.7068864653, 59111.704441477516, 59588.0, 63528.682356587924, 7793.37652987771, 7875.921240787518, 8095.5142691438705, 8095.878561821695, 8267.214614611603, 10045.799084018425, 13473.595792126252, 13541.86458135406, 13587.93206034003, 13620.18278903269, 11591.76816463683, 11827.20356207544, 12108.636740897788, 12312.81530777057, 12371.072169587136, 11454.140939429743, 11682.824757628472, 11779.116566257737, 11780.234284771463, 11898.76202475963, 11879.881201187878, 11939.582114625946, 12039.09706771978, 12065.758684826078, 12172.330521821385, 7930.405219608668, 8088.393370497354, 8136.023677158542, 8197.057338406159, 8321.791955201168, 11020.228583999044, 11719.472623732123, 11807.815554122515, 11811.704707382385, 11899.524019039141], "value": 9913.239610792656, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.6665450310181, 1456.4829485532637, 1517.142814309915, 1623.4561421923654, 1744.1889521372568, 7731.6907323707055, 8078.757637270891, 8091.069527004396, 8240.958795206016, 8248.216419440143, 8090.474119182264, 8205.276891852718, 8205.95897020514, 8210.794730131749, 8238.794030149249, 2266.0709109265204, 2286.2683941138757, 2286.371247906822, 2286.4626812699084, 2287.359539328982, 2274.442761523429, 2303.8617682938993, 2309.988450057756, 2310.0182422470466, 2310.722713274409, 2248.696425982496, 2249.1116009176367, 2271.852329598579, 2312.6415405612074, 2313.525727225923, 2259.164109279569, 2260.107257633242, 2262.7171603549555, 2265.048679554591, 2267.1498188179435, 2230.4200907763934, 2238.5746708125403, 2240.798328150458, 2244.2930476899887, 2244.461329280977, 8171.67313307467, 8174.182581741778, 8211.137830527769, 8276.751697449086, 8278.337732981347, 4926.802927882881, 5107.7446127693465, 5118.07874582575, 5128.333316668809, 5134.306868572732, 3213.0682102190335, 3292.0, 3355.463125899869, 3381.3913495570787, 3405.5572775539267, 1073.457903758597, 1079.4063265204106, 1081.864766904137, 1085.907697845684, 1109.05176074456, 11100.0, 11115.0, 11209.047230985376, 11227.214095013353, 11238.606648767336, 4147.91704165915, 4277.994671252253, 4340.891477713019, 4352.086061926968, 4370.781460927004, 8964.820703585892, 8999.10008999108, 9000.63997440095, 9011.954940225258, 9019.77450563728, 4936.456989731127, 4945.826896058621, 4947.1837146871085, 4954.207326827763, 4958.801647934042, 4013.779242141652, 4493.213687604656, 4599.264117741212, 4633.235516139799, 4638.97680511602, 3515.068506845688, 3528.8588456461453, 3613.728970327236, 3642.6903713184674, 3676.283124790694, 1057.9788404232027, 1097.0, 1097.7091070866227, 1101.4492753623188, 1122.8484154639182, 1010.7119470950744, 1012.2205901455837, 1018.4856647393167, 1026.7022563456662, 1036.264252380818, 5811.506021988093, 5947.256592925884, 5963.642181469126, 6008.969955150196, 6095.293317871004, 416.87702127872353, 449.3708807669289, 454.45238487622333, 460.1257610539934, 466.6616702890377, 4109.650679692199, 4185.707000509996, 4237.00430398856, 4263.5096963849555, 4312.892177695583, 9909.504524773733, 10082.143017843418, 10169.44068076263, 10171.389716617026, 10199.898001020043, 9514.571844267024, 9962.302638815358, 10120.848187277197, 10125.594976201017, 10138.442385668859, 7656.693732250759, 7841.019872515935, 7845.960770196227, 7855.33229675484, 7858.764237072897, 5670.489655930986, 5773.1051686988585, 5785.537157027512, 5928.140419639214, 6033.095035744674, 9066.546672666209, 9112.316576256675, 9113.088691130833, 9119.589618467053, 9124.726258212264, 9006.054364291655, 9192.632294708405, 9208.677696280598, 9311.534423278674, 9367.0, 6614.768483103068, 6927.064846245692, 7052.858942821217, 7056.788296351117, 7163.31948464895, 8035.276825085771, 8100.473469224482, 8109.107998120084, 8120.309773669304, 8122.7157049502985, 7215.422766178798, 7241.203467618452, 7285.817854553678, 7336.229695881855, 7496.7376141834775, 7032.824179395556, 7165.390941770008, 7172.641367931478, 7189.604571748604, 7223.061002069698, 6354.682265886595, 6452.870942581216, 6566.8358291041195, 6620.536562440583, 6625.105610742488, 4917.950820491892, 4919.729414882216, 4995.975020124876, 5086.033653605803, 5091.92362114576, 4910.189818679878, 4974.7512624369365, 5069.138246498178, 5142.537171654569, 5230.660007099526], "value": 4321.644505810791, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.56109738136263, 310.82904402578606, 312.49220017471606, 320.78347115696914, 320.96790320967904, 4839.516048395168, 5054.494550544944, 5267.157254839227, 5271.55032366099, 5291.814786482474, 5174.404943431507, 5183.53348198662, 5187.144121220003, 5189.844304670866, 5193.896122077556, 4058.0, 4058.452108965289, 4064.6138616831354, 4067.227226826908, 4092.8362865485346, 3940.7438516496336, 3960.5643379228263, 4068.8575899843513, 4078.3678529827775, 4097.79511024449, 4016.6987475939422, 4024.4969378827645, 4032.9596704033024, 4055.8783236502804, 4067.572904844993, 4043.433919251307, 4050.4936882889638, 4061.8375264989363, 4067.97966010171, 4071.857484988041, 3591.1740299730945, 3609.7292703047115, 3611.5485564304463, 3614.8734794282072, 3639.9272014559824, 4876.366072410599, 5005.774740136702, 5025.472325405853, 5026.396832380101, 5053.418856831475, 4604.447466304032, 4611.584957353821, 4612.423447069116, 4617.261238201905, 4631.397918270637, 5178.152016391007, 5378.569714422876, 5380.811671591515, 5381.461853814626, 5388.622796404254, 3860.4981352424006, 3865.4781604483314, 3870.3807390817615, 3871.9806400967814, 3872.244912242114, 5358.303420555342, 5408.2428460015235, 5590.440955904418, 5616.185653080322, 5643.209950606918, 3904.3557812960544, 3917.490726205632, 3923.7449565778134, 3942.6254505821903, 3962.5443074046275, 3992.940105898414, 3993.221321842213, 4002.2195671844293, 4013.6387725104883, 4041.7574945503366, 4617.291602107175, 4639.744814035193, 4644.58198762113, 4646.395968524071, 4647.395838540968, 5237.973810130925, 5461.972690136603, 5468.179773034077, 5476.2333273341765, 5479.972600136974, 1364.4746772492663, 1378.3935068569797, 1379.475799196299, 1387.5213051497217, 1388.167099740168, 841.9410641255054, 859.4113032572708, 880.7181701855345, 892.312919052339, 898.8404957604747, 4739.0, 4740.762961851894, 4752.619790416758, 4757.238841785298, 4758.191107511731, 4901.485344038824, 4925.926111108336, 4941.851744447672, 4972.160300688768, 4977.552020318189, 4414.448193975753, 4708.88227794301, 4721.4117270874385, 4740.976295118571, 4773.451053128865, 2600.973990260111, 2606.9869650651626, 2612.046602989895, 2612.2163350994624, 2640.696319923195, 5057.72182529957, 5068.746562671851, 5087.618428617794, 5102.234664800236, 5139.768710407966, 4829.589484893753, 5007.399112106497, 5011.118606801104, 5016.598672106223, 5049.419316778544, 5057.418396884332, 5079.492050794891, 5087.109755792721, 5090.516400941905, 5115.130427827204, 4890.657653964331, 4926.965337279212, 4927.634735327135, 4958.2810492477665, 5019.970905964342, 4853.344798452164, 4895.33912921751, 4901.387326584177, 5153.561947234527, 5536.557075433875, 5576.525995290283, 5685.800996965087, 5781.624194427349, 5790.681512516852, 5841.912371314349, 3982.482277303932, 4035.41486484464, 4055.0, 4068.2880495913687, 4070.1656160487623, 5609.887802244014, 5625.184348269396, 5633.971830140823, 5638.85902852432, 5665.376808551138, 5322.354187381656, 5417.458254174709, 5511.153763489276, 5518.641288316247, 5525.640833345819, 5448.692313844728, 5471.0, 5471.85091130851, 5476.80831170923, 5479.698616575967, 5280.6303558750515, 5434.83695489136, 5466.180072989084, 5470.659688376373, 5505.339359276913, 5505.935274272148, 5526.226328313959, 5535.699110709061, 5536.806211782568, 5539.944600553943, 5386.218998245311, 5402.838389746224, 5405.162199859028, 5422.566194704335, 5437.8368648940595], "value": 4026.9539468153134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.8943103250032, 774.2760518914815, 774.7985523763822, 808.0989696488415, 851.7146755836794, 13978.3709733062, 14750.704985900276, 14866.55400337989, 14890.553283401501, 14896.553103406888, 14817.333220005099, 14954.252287385641, 14967.625809354771, 14979.251037448139, 14979.700405991875, 650.3106706890711, 780.7345502529139, 789.0294937227214, 809.360605121953, 811.6915572082601, 803.6986130201175, 806.2944923192207, 806.330745481252, 806.3629732511338, 806.5080301016404, 859.7377799771067, 860.371928492201, 861.0399404663787, 861.4271509446211, 861.67687117331, 688.2360579756466, 822.6627082896043, 839.4795226959325, 844.0673056272792, 853.5177624642089, 612.1032687113355, 617.1421723803916, 617.3579477343602, 617.9443850053472, 618.3229363846626, 14556.927215363961, 14586.854131458656, 14612.634684132876, 14653.853461465462, 14669.119852808759, 14103.506377276848, 14119.78820317696, 14351.425942962269, 14482.855171448256, 14627.853721462756, 13167.341632918316, 13195.2742599157, 13534.458621655122, 13722.588322350346, 13921.443142274296, 4374.759388233646, 4413.095315460323, 4433.334999750031, 4473.105378924228, 4514.977425112854, 81203.0, 81498.0, 82805.58597207036, 83100.0, 84924.57537712334, 11711.121665874924, 11713.297202167727, 11778.52885884555, 11815.350155741346, 11831.053515718722, 21535.67696484554, 21582.89208553947, 21605.135794568043, 21685.566288674137, 21695.13219471235, 8099.352051835839, 8105.351571874236, 8201.58992050407, 8242.464239824512, 8319.126491718403, 4484.349769283435, 4535.229011068126, 4599.7470139142, 4690.179218636725, 4696.342512048248, 3093.706097920694, 3188.649248582654, 3193.616765988096, 3193.9041828745176, 3198.648148703641, 551.9972400137974, 553.2475832867298, 553.3691591585596, 554.789180111555, 571.4314257313916, 617.237711426388, 617.8548041210312, 643.6427782580713, 670.289493137276, 694.1808665774333, 8752.256058234994, 8875.822483550293, 8978.281737460988, 9076.500792456347, 9109.90890091104, 615.4368752591329, 646.3633321178635, 714.4995509430258, 737.9815504612428, 747.9476436649383, 4292.89267768302, 4523.163214805271, 4523.340038247709, 4572.474165470947, 4573.748443835621, 73072.63463682648, 74386.25613743793, 98519.0, 100011.0, 102777.0, 95390.52304738433, 96690.51654741821, 96963.0, 97029.51485242529, 97754.0, 83590.0, 83678.16321836825, 85355.0, 85370.0, 87238.99999999873, 9293.303002274992, 9559.235261179228, 9582.185514231369, 9805.411675299505, 9951.552180151766, 40364.59635403608, 41225.0, 47531.0, 47579.24207579214, 49324.26013609727, 65726.0, 66223.66888165528, 72161.63919180371, 75314.6234268847, 79595.60202198951, 12104.818427723767, 12223.877761222275, 12365.567205147776, 12497.312647804458, 12938.288394138413, 13497.190168589916, 13586.252756098509, 13860.376283067488, 13964.231967241492, 14337.283135843374, 13100.0, 13390.0, 13606.93196534011, 13642.727145457235, 13673.658158546115, 11305.547778088785, 11325.660230193107, 11445.084393248353, 12817.359132043173, 13427.664308392368, 12116.15186936906, 12960.740785184433, 13024.088313817942, 13268.27024513661, 13959.651008724457, 9336.253099752139, 9945.0, 9951.601935922483, 10042.648507302209, 10780.245382823126, 10587.417692027013, 10964.945175274073, 11228.66314010581, 11283.513296049403, 11494.94252528732], "value": 7329.979534734711, "unit": "score"}], "name": "dromaeo_css", "value": 7156.85974942354, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 110.0, 113.0, 113.0, 109.0, 112.0, 108.0, 109.0, 113.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 118.0, 182.0, 120.0, 119.0, 147.0, 117.0, 153.0, 119.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 165.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 110.0, 75.0, 76.0, 74.0, 74.0, 99.0, 73.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 108.0, 84.0, 84.0, 84.0, 128.0, 83.0, 84.0, 130.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 54.0, 52.0, 51.0, 53.0, 52.0, 51.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 76.0, 74.0, 75.0, 75.0, 74.0, 84.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 131.0, 121.0, 126.0, 119.0, 130.0, 118.0, 118.0, 189.0, 120.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 158.0, 157.0, 164.0, 159.0, 158.0, 158.0, 157.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 65.0, 63.0, 62.0, 62.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1481.1, "alertThreshold": 2.0}]} 13:29:34 INFO - Return code: 0 13:29:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:29:34 INFO - # TBPL SUCCESS # 13:29:34 INFO - Running post-action listener: _resource_record_post_action 13:29:34 INFO - [mozharness: 2016-07-31 20:29:34.163177Z] Finished run-tests step (success) 13:29:34 INFO - Running post-run listener: _resource_record_post_run 13:29:34 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542474240; Read time: 8; Write time: 512224 13:29:34 INFO - TinderboxPrint: CPU usage
13.0% 13:29:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:29:34 INFO - TinderboxPrint: I/O write bytes / time
542,474,240 / 512,224 13:29:34 INFO - TinderboxPrint: CPU idle
8,261.4 (87.0%) 13:29:34 INFO - TinderboxPrint: CPU user
1,191.1 (12.5%) 13:29:34 INFO - TinderboxPrint: Swap in / out
0 / 0 13:29:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247566336; Read time: 0; Write time: 296620 13:29:34 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294477824; Read time: 8; Write time: 215504 13:29:34 INFO - Running post-run listener: _upload_blobber_files 13:29:34 INFO - Blob upload gear active. 13:29:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:34 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 13:29:34 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:29:34 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:29:35 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:29:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:29:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:35 INFO - (blobuploader) - INFO - Done attempting. 13:29:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:29:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:29:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:36 INFO - (blobuploader) - INFO - Done attempting. 13:29:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:29:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:40 INFO - (blobuploader) - INFO - Done attempting. 13:29:40 INFO - (blobuploader) - INFO - Iteration through files over. 13:29:40 INFO - Return code: 0 13:29:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:29:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:29:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe33a977552f2e6fc4719d6ab8bfc9be442d2ec4b35f764473dfd7f0a6f37517c7731f056ad9fe7aa2b26e1c0cf9ae80c1ee74d2e1d2fc107c09efbd44166a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b0e9b5d7312f5801444fc3a7f66e9404ad3350d208fe0e09e1fefd7e8078ecbcfaf7662f5e0537915c84d5cc90d482f15f90669134cef4815dfe45b96ae2418", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a5cd19aa80e66059757895a3dfd471b23f0988bd8400e6e16bc51ad2f1e86203ac1621a42bff84964348957e978da2565637f97b4b0dd3cc1f37593d727a879"} 13:29:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:29:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:29:40 INFO - Contents: 13:29:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe33a977552f2e6fc4719d6ab8bfc9be442d2ec4b35f764473dfd7f0a6f37517c7731f056ad9fe7aa2b26e1c0cf9ae80c1ee74d2e1d2fc107c09efbd44166a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b0e9b5d7312f5801444fc3a7f66e9404ad3350d208fe0e09e1fefd7e8078ecbcfaf7662f5e0537915c84d5cc90d482f15f90669134cef4815dfe45b96ae2418", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a5cd19aa80e66059757895a3dfd471b23f0988bd8400e6e16bc51ad2f1e86203ac1621a42bff84964348957e978da2565637f97b4b0dd3cc1f37593d727a879"} 13:29:40 INFO - Running post-run listener: copy_logs_to_upload_dir 13:29:40 INFO - Copying logs to upload dir... 13:29:40 INFO - mkdir: /builds/slave/test/build/upload/logs 13:29:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.209617 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-31 13:29:40.155547) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 13:29:40.158773) ========= 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=62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe33a977552f2e6fc4719d6ab8bfc9be442d2ec4b35f764473dfd7f0a6f37517c7731f056ad9fe7aa2b26e1c0cf9ae80c1ee74d2e1d2fc107c09efbd44166a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b0e9b5d7312f5801444fc3a7f66e9404ad3350d208fe0e09e1fefd7e8078ecbcfaf7662f5e0537915c84d5cc90d482f15f90669134cef4815dfe45b96ae2418", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a5cd19aa80e66059757895a3dfd471b23f0988bd8400e6e16bc51ad2f1e86203ac1621a42bff84964348957e978da2565637f97b4b0dd3cc1f37593d727a879"} build_url:https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/I98--iz9TR-7l3IIeXKKuA/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/Firefox/sha512/ffe33a977552f2e6fc4719d6ab8bfc9be442d2ec4b35f764473dfd7f0a6f37517c7731f056ad9fe7aa2b26e1c0cf9ae80c1ee74d2e1d2fc107c09efbd44166a3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b0e9b5d7312f5801444fc3a7f66e9404ad3350d208fe0e09e1fefd7e8078ecbcfaf7662f5e0537915c84d5cc90d482f15f90669134cef4815dfe45b96ae2418", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a5cd19aa80e66059757895a3dfd471b23f0988bd8400e6e16bc51ad2f1e86203ac1621a42bff84964348957e978da2565637f97b4b0dd3cc1f37593d727a879"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 13:29:40.183989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 13:29:40.184328) ========= 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=62c568580acbfdaac3eec7be000001dc-1469992263.814344-1978833741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 13:29:40.271094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 13:29:40.271957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 13:29:40.272695) ========= ========= Total master_lag: 0.19 =========