builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1466226039.32 results: success (0) buildid: 20160617203824 builduid: c39a5cc8d29a486c83c711c7c21b1780 revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:39.316134) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:39.316563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:39.316840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:39.349793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:39.350165) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 22:00:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-17 22:00:39 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095549 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:39.466201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:39.466629) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016510 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:39.517494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:39.517969) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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=8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 22:00:40,097 truncating revision to first 12 chars 2016-06-17 22:00:40,097 Setting DEBUG logging. 2016-06-17 22:00:40,097 attempt 1/10 2016-06-17 22:00:40,097 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3ce53bd1e25b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 22:00:40,425 unpacking tar archive at: fx-team-3ce53bd1e25b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680971 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:40.216009) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:40.216285) ========= script_repo_revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:40.216662) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:40.216924) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 22:00:40.226727) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-17 22:00:40.227091) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:40 INFO - MultiFileLogger online at 20160617 22:00:40 in /builds/slave/test 22:00:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:00:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:00:40 INFO - {'append_to_log': False, 22:00:40 INFO - 'base_work_dir': '/builds/slave/test', 22:00:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:00:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:00:40 INFO - 'branch': 'Fx-Team-Non-PGO', 22:00:40 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:40 INFO - 'config_files': ('talos/linux_config.py',), 22:00:40 INFO - 'default_actions': ('clobber', 22:00:40 INFO - 'read-buildbot-config', 22:00:40 INFO - 'download-and-extract', 22:00:40 INFO - 'populate-webroot', 22:00:40 INFO - 'create-virtualenv', 22:00:40 INFO - 'install', 22:00:40 INFO - 'run-tests'), 22:00:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:40 INFO - 'download_minidump_stackwalk': True, 22:00:40 INFO - 'download_symbols': 'ondemand', 22:00:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:40 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:40 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:40 INFO - 'installer_path': 'installer.exe', 22:00:40 INFO - 'log_level': 'info', 22:00:40 INFO - 'log_name': 'talos', 22:00:40 INFO - 'log_to_console': True, 22:00:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:40 INFO - 'opt_config_files': (), 22:00:40 INFO - 'pip_index': False, 22:00:40 INFO - 'sps_profile': False, 22:00:40 INFO - 'sps_profile_interval': 0, 22:00:40 INFO - 'suite': 'dromaeojs-e10s', 22:00:40 INFO - 'system_bits': '32', 22:00:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:40 INFO - 'title': 'talos-linux64-ix-001', 22:00:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:40 INFO - 'use_talos_json': True, 22:00:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:00:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:40 INFO - 'work_dir': 'build'} 22:00:40 INFO - ##### 22:00:40 INFO - ##### Running clobber step. 22:00:40 INFO - ##### 22:00:40 INFO - Running pre-action listener: _resource_record_pre_action 22:00:40 INFO - Running main action method: clobber 22:00:40 INFO - rmtree: /builds/slave/test/build 22:00:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:00:41 INFO - Running post-action listener: _resource_record_post_action 22:00:41 INFO - ##### 22:00:41 INFO - ##### Finished clobber step (success) 22:00:41 INFO - ##### 22:00:41 INFO - ##### 22:00:41 INFO - ##### Running read-buildbot-config step. 22:00:41 INFO - ##### 22:00:41 INFO - Running pre-action listener: _resource_record_pre_action 22:00:41 INFO - Running main action method: read_buildbot_config 22:00:41 INFO - Using buildbot properties: 22:00:41 INFO - { 22:00:41 INFO - "project": "", 22:00:41 INFO - "product": "firefox", 22:00:41 INFO - "script_repo_revision": "production", 22:00:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:00:41 INFO - "repository": "", 22:00:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:00:41 INFO - "buildid": "20160617203824", 22:00:41 INFO - "pgo_build": "False", 22:00:41 INFO - "basedir": "/builds/slave/test", 22:00:41 INFO - "buildnumber": 1597, 22:00:41 INFO - "slavename": "talos-linux64-ix-001", 22:00:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:00:41 INFO - "platform": "ubuntu64_hw", 22:00:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:00:41 INFO - "branch": "fx-team", 22:00:41 INFO - "repo_path": "integration/fx-team", 22:00:41 INFO - "revision": "3ce53bd1e25b93140484d3933c9339a829e0c1eb", 22:00:41 INFO - "stage_platform": "linux64", 22:00:41 INFO - "builduid": "c39a5cc8d29a486c83c711c7c21b1780", 22:00:41 INFO - "slavebuilddir": "test" 22:00:41 INFO - } 22:00:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:00:41 INFO - Running post-action listener: _resource_record_post_action 22:00:41 INFO - ##### 22:00:41 INFO - ##### Finished read-buildbot-config step (success) 22:00:41 INFO - ##### 22:00:41 INFO - ##### 22:00:41 INFO - ##### Running download-and-extract step. 22:00:41 INFO - ##### 22:00:41 INFO - Running pre-action listener: _resource_record_pre_action 22:00:41 INFO - Running main action method: download_and_extract 22:00:41 INFO - mkdir: /builds/slave/test/build/tests 22:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:41 INFO - https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:00:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:00:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:00:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/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 22:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/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 22:00:53 INFO - Downloaded 1361 bytes. 22:00:53 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:00:53 INFO - Using the following test package requirements: 22:00:53 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:53 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:00:53 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:00:53 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:53 INFO - u'jsshell-linux-x86_64.zip'], 22:00:53 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:00:53 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:53 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:00:53 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:00:53 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:00:53 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:00:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:53 INFO - https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:00:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:00:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:00:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/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 22:00:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/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 22:01:02 INFO - Downloaded 22654592 bytes. 22:01:02 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'] 22:01:02 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 22:01:03 INFO - Return code: 0 22:01:03 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 22:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:03 INFO - https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:01:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:01:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/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 22:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/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 22:01:04 INFO - Downloaded 22654592 bytes. 22:01:04 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'] 22:01:04 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 22:01:06 INFO - Return code: 0 22:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:06 INFO - https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:01:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/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 22:01:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/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 22:01:07 INFO - Downloaded 14405384 bytes. 22:01:07 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'] 22:01:07 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 22:01:07 INFO - Return code: 0 22:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:07 INFO - https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:01:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/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 22:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/el0TtMs7RuC0U8ZBejxYCQ/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 22:01:08 INFO - Downloaded 56226218 bytes. 22:01:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:08 INFO - mkdir: /builds/slave/test/properties 22:01:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:01:08 INFO - Writing to file /builds/slave/test/properties/build_url 22:01:08 INFO - Contents: 22:01:08 INFO - build_url:https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:09 INFO - Running post-action listener: _resource_record_post_action 22:01:09 INFO - Running post-action listener: set_extra_try_arguments 22:01:09 INFO - ##### 22:01:09 INFO - ##### Finished download-and-extract step (success) 22:01:09 INFO - ##### 22:01:09 INFO - ##### 22:01:09 INFO - ##### Running populate-webroot step. 22:01:09 INFO - ##### 22:01:09 INFO - Running pre-action listener: _resource_record_pre_action 22:01:09 INFO - Running main action method: populate_webroot 22:01:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:01:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:01:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:01:09 INFO - '--tppagecycles', 22:01:09 INFO - '7'], 22:01:09 INFO - 'tests': ['tsvgm']}}, 22:01:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:01:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:01:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:01:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:01:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:01:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:01:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:09 INFO - 'talos_options': ['--disable-e10s'], 22:01:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:09 INFO - 'talos_options': ['--disable-e10s'], 22:01:09 INFO - 'tests': ['damp', 'tps']}, 22:01:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:09 INFO - 'tests': ['damp', 'tps']}, 22:01:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:01:09 INFO - 'tests': ['dromaeo_dom']}, 22:01:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:01:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:01:09 INFO - 'tests': ['basic_compositor_video']}, 22:01:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:01:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:01:09 INFO - 'tests': ['a11yr', 22:01:09 INFO - 'ts_paint', 22:01:09 INFO - 'tpaint', 22:01:09 INFO - 'sessionrestore', 22:01:09 INFO - 'sessionrestore_no_auto_restore', 22:01:09 INFO - 'tabpaint']}, 22:01:09 INFO - 'other-e10s': {'tests': ['a11yr', 22:01:09 INFO - 'ts_paint', 22:01:09 INFO - 'tpaint', 22:01:09 INFO - 'sessionrestore', 22:01:09 INFO - 'sessionrestore_no_auto_restore', 22:01:09 INFO - 'tabpaint']}, 22:01:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:01:09 INFO - 'ts_paint', 22:01:09 INFO - 'tpaint', 22:01:09 INFO - 'sessionrestore', 22:01:09 INFO - 'sessionrestore_no_auto_restore', 22:01:09 INFO - 'tabpaint']}, 22:01:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:01:09 INFO - 'ts_paint', 22:01:09 INFO - 'tpaint', 22:01:09 INFO - 'sessionrestore', 22:01:09 INFO - 'sessionrestore_no_auto_restore', 22:01:09 INFO - 'tabpaint']}, 22:01:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:01:09 INFO - 'tests': ['a11yr', 22:01:09 INFO - 'ts_paint', 22:01:09 INFO - 'tpaint', 22:01:09 INFO - 'sessionrestore', 22:01:09 INFO - 'sessionrestore_no_auto_restore', 22:01:09 INFO - 'tabpaint']}, 22:01:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:01:09 INFO - 'tests': ['a11yr', 22:01:09 INFO - 'ts_paint', 22:01:09 INFO - 'tpaint', 22:01:09 INFO - 'sessionrestore', 22:01:09 INFO - 'sessionrestore_no_auto_restore', 22:01:09 INFO - 'tabpaint']}, 22:01:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:01:09 INFO - 'tests': ['tsvgx', 22:01:09 INFO - 'tsvgr_opacity', 22:01:09 INFO - 'tart', 22:01:09 INFO - 'tscrollx', 22:01:09 INFO - 'cart']}, 22:01:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:01:09 INFO - 'tsvgr_opacity', 22:01:09 INFO - 'tart', 22:01:09 INFO - 'tscrollx', 22:01:09 INFO - 'cart']}, 22:01:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:09 INFO - 'talos_options': ['--disable-e10s'], 22:01:09 INFO - 'tests': ['tp5o']}, 22:01:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:09 INFO - 'tests': ['tp5o']}, 22:01:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:09 INFO - 'talos_options': ['--disable-e10s', 22:01:09 INFO - '--xperf_path', 22:01:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:09 INFO - 'tests': ['tp5n']}, 22:01:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:09 INFO - 'talos_options': ['--xperf_path', 22:01:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:09 INFO - 'tests': ['tp5n']}}, 22:01:09 INFO - 'talos.zip': {'path': '', 22:01:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:09 INFO - Running post-action listener: _resource_record_post_action 22:01:09 INFO - ##### 22:01:09 INFO - ##### Finished populate-webroot step (success) 22:01:09 INFO - ##### 22:01:09 INFO - ##### 22:01:09 INFO - ##### Running create-virtualenv step. 22:01:09 INFO - ##### 22:01:09 INFO - Running pre-action listener: _resource_record_pre_action 22:01:09 INFO - Running main action method: create_virtualenv 22:01:09 INFO - Creating virtualenv /builds/slave/test/build/venv 22:01:09 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 22:01:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:01:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:01:09 INFO - Using real prefix '/usr' 22:01:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:01:10 INFO - Installing distribute.............................................................................................................................................................................................done. 22:01:12 INFO - Installing pip.................done. 22:01:12 INFO - Return code: 0 22:01:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d54b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2047350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d61c0>, '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 0x20d70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d7550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', '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 22:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:01:12 INFO - Using env: {'DISPLAY': ':0', 22:01:12 INFO - 'HOME': '/home/cltbld', 22:01:12 INFO - 'LANG': 'en_US.UTF-8', 22:01:12 INFO - 'LANGUAGE': 'en_US:en', 22:01:12 INFO - 'LOGNAME': 'cltbld', 22:01:12 INFO - 'MAIL': '/var/mail/cltbld', 22:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:12 INFO - 'MOZ_NO_REMOTE': '1', 22:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:12 INFO - 'NO_EM_RESTART': '1', 22:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:12 INFO - 'PWD': '/builds/slave/test', 22:01:12 INFO - 'SHELL': '/bin/bash', 22:01:12 INFO - 'SHLVL': '1', 22:01:12 INFO - 'TERM': 'linux', 22:01:12 INFO - 'TMOUT': '86400', 22:01:12 INFO - 'USER': 'cltbld', 22:01:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', 22:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:12 INFO - '_': '/tools/buildbot/bin/python'} 22:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:12 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 22:01:12 INFO - Cleaning up... 22:01:12 INFO - Return code: 0 22:01:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f95d54b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2047350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d61c0>, '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 0x20d70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d7550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', '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 22:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:01:12 INFO - Using env: {'DISPLAY': ':0', 22:01:12 INFO - 'HOME': '/home/cltbld', 22:01:12 INFO - 'LANG': 'en_US.UTF-8', 22:01:12 INFO - 'LANGUAGE': 'en_US:en', 22:01:12 INFO - 'LOGNAME': 'cltbld', 22:01:12 INFO - 'MAIL': '/var/mail/cltbld', 22:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:12 INFO - 'MOZ_NO_REMOTE': '1', 22:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:12 INFO - 'NO_EM_RESTART': '1', 22:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:12 INFO - 'PWD': '/builds/slave/test', 22:01:12 INFO - 'SHELL': '/bin/bash', 22:01:12 INFO - 'SHLVL': '1', 22:01:12 INFO - 'TERM': 'linux', 22:01:12 INFO - 'TMOUT': '86400', 22:01:12 INFO - 'USER': 'cltbld', 22:01:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', 22:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:12 INFO - '_': '/tools/buildbot/bin/python'} 22:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:12 INFO - Downloading/unpacking psutil>=3.1.1 22:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:01:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:14 INFO - Installing collected packages: psutil 22:01:14 INFO - Running setup.py install for psutil 22:01:14 INFO - building 'psutil._psutil_linux' extension 22:01:14 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 22:01:14 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 22:01:14 INFO - building 'psutil._psutil_posix' extension 22:01:14 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 22:01:15 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 22:01:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:15 INFO - Successfully installed psutil 22:01:15 INFO - Cleaning up... 22:01:15 INFO - Return code: 0 22:01:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:01:15 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')]} 22:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:15 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')]} 22:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:15 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 0x7f95d54b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2047350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d61c0>, '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 0x20d70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d7550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', '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 22:01:15 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 22:01:15 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 22:01:15 INFO - Using env: {'DISPLAY': ':0', 22:01:15 INFO - 'HOME': '/home/cltbld', 22:01:15 INFO - 'LANG': 'en_US.UTF-8', 22:01:15 INFO - 'LANGUAGE': 'en_US:en', 22:01:15 INFO - 'LOGNAME': 'cltbld', 22:01:15 INFO - 'MAIL': '/var/mail/cltbld', 22:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:15 INFO - 'MOZ_NO_REMOTE': '1', 22:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:15 INFO - 'NO_EM_RESTART': '1', 22:01:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:15 INFO - 'PWD': '/builds/slave/test', 22:01:15 INFO - 'SHELL': '/bin/bash', 22:01:15 INFO - 'SHLVL': '1', 22:01:15 INFO - 'TERM': 'linux', 22:01:15 INFO - 'TMOUT': '86400', 22:01:15 INFO - 'USER': 'cltbld', 22:01:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', 22:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:15 INFO - '_': '/tools/buildbot/bin/python'} 22:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:01:17 INFO - Installing collected packages: mozsystemmonitor 22:01:17 INFO - Running setup.py install for mozsystemmonitor 22:01:17 INFO - Successfully installed mozsystemmonitor 22:01:17 INFO - Cleaning up... 22:01:17 INFO - Return code: 0 22:01:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:01:17 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')]} 22:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:17 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')]} 22:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:17 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 0x7f95d54b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2047350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d61c0>, '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 0x20d70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d7550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', '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 22:01:17 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 22:01:17 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 22:01:17 INFO - Using env: {'DISPLAY': ':0', 22:01:17 INFO - 'HOME': '/home/cltbld', 22:01:17 INFO - 'LANG': 'en_US.UTF-8', 22:01:17 INFO - 'LANGUAGE': 'en_US:en', 22:01:17 INFO - 'LOGNAME': 'cltbld', 22:01:17 INFO - 'MAIL': '/var/mail/cltbld', 22:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:17 INFO - 'MOZ_NO_REMOTE': '1', 22:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:17 INFO - 'NO_EM_RESTART': '1', 22:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:17 INFO - 'PWD': '/builds/slave/test', 22:01:17 INFO - 'SHELL': '/bin/bash', 22:01:17 INFO - 'SHLVL': '1', 22:01:17 INFO - 'TERM': 'linux', 22:01:17 INFO - 'TMOUT': '86400', 22:01:17 INFO - 'USER': 'cltbld', 22:01:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', 22:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:17 INFO - '_': '/tools/buildbot/bin/python'} 22:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:17 INFO - Downloading/unpacking jsonschema==2.5.1 22:01:17 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 22:01:17 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 22:01:17 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 22:01:17 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 22:01:17 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 22:01:17 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 22:01:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:01:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:01:19 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 22:01:19 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 22:01:19 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 22:01:19 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 22:01:19 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 22:01:19 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 22:01:19 INFO - Downloading functools32-3.2.3-2.tar.gz 22:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:01:19 INFO - warning: no files found matching '*.txt' 22:01:19 INFO - no previously-included directories found matching 'build' 22:01:19 INFO - no previously-included directories found matching 'dist' 22:01:19 INFO - no previously-included directories found matching '.git*' 22:01:19 INFO - Installing collected packages: jsonschema, functools32 22:01:19 INFO - Running setup.py install for functools32 22:01:20 INFO - warning: no files found matching '*.txt' 22:01:20 INFO - no previously-included directories found matching 'build' 22:01:20 INFO - no previously-included directories found matching 'dist' 22:01:20 INFO - no previously-included directories found matching '.git*' 22:01:20 INFO - Successfully installed jsonschema functools32 22:01:20 INFO - Cleaning up... 22:01:20 INFO - Return code: 0 22:01:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:20 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 0x7f95d54b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2047350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d61c0>, '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 0x20d70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d7550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', '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 22:01:20 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 22:01:20 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 22:01:20 INFO - Using env: {'DISPLAY': ':0', 22:01:20 INFO - 'HOME': '/home/cltbld', 22:01:20 INFO - 'LANG': 'en_US.UTF-8', 22:01:20 INFO - 'LANGUAGE': 'en_US:en', 22:01:20 INFO - 'LOGNAME': 'cltbld', 22:01:20 INFO - 'MAIL': '/var/mail/cltbld', 22:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:20 INFO - 'MOZ_NO_REMOTE': '1', 22:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:20 INFO - 'NO_EM_RESTART': '1', 22:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:20 INFO - 'PWD': '/builds/slave/test', 22:01:20 INFO - 'SHELL': '/bin/bash', 22:01:20 INFO - 'SHLVL': '1', 22:01:20 INFO - 'TERM': 'linux', 22:01:20 INFO - 'TMOUT': '86400', 22:01:20 INFO - 'USER': 'cltbld', 22:01:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', 22:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:20 INFO - '_': '/tools/buildbot/bin/python'} 22:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:20 INFO - Downloading/unpacking blobuploader==1.2.4 22:01:20 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 22:01:20 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 22:01:20 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 22:01:20 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 22:01:20 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 22:01:20 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 22:01:22 INFO - Downloading blobuploader-1.2.4.tar.gz 22:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:01:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:01:22 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 22:01:22 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 22:01:22 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 22:01:22 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 22:01:22 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 22:01:22 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 22:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:01:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:01:22 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 22:01:22 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 22:01:22 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 22:01:22 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 22:01:22 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 22:01:22 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 22:01:22 INFO - Downloading docopt-0.6.1.tar.gz 22:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:01:22 INFO - Installing collected packages: blobuploader, requests, docopt 22:01:22 INFO - Running setup.py install for blobuploader 22:01:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:01:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:01:23 INFO - Running setup.py install for requests 22:01:23 INFO - Running setup.py install for docopt 22:01:23 INFO - Successfully installed blobuploader requests docopt 22:01:23 INFO - Cleaning up... 22:01:23 INFO - Return code: 0 22:01:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:23 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 0x7f95d54b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2047350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d61c0>, '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 0x20d70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d7550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', '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 22:01:23 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 22:01:23 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 22:01:23 INFO - Using env: {'DISPLAY': ':0', 22:01:23 INFO - 'HOME': '/home/cltbld', 22:01:23 INFO - 'LANG': 'en_US.UTF-8', 22:01:23 INFO - 'LANGUAGE': 'en_US:en', 22:01:23 INFO - 'LOGNAME': 'cltbld', 22:01:23 INFO - 'MAIL': '/var/mail/cltbld', 22:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:23 INFO - 'MOZ_NO_REMOTE': '1', 22:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:23 INFO - 'NO_EM_RESTART': '1', 22:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:23 INFO - 'PWD': '/builds/slave/test', 22:01:23 INFO - 'SHELL': '/bin/bash', 22:01:23 INFO - 'SHLVL': '1', 22:01:23 INFO - 'TERM': 'linux', 22:01:23 INFO - 'TMOUT': '86400', 22:01:23 INFO - 'USER': 'cltbld', 22:01:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', 22:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:23 INFO - '_': '/tools/buildbot/bin/python'} 22:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:23 INFO - Running setup.py (path:/tmp/pip-_qo2Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:23 INFO - Running setup.py (path:/tmp/pip-1PHiYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:23 INFO - Running setup.py (path:/tmp/pip-XpD8MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:23 INFO - Running setup.py (path:/tmp/pip-6yhjV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:24 INFO - Running setup.py (path:/tmp/pip-Fzwazh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:24 INFO - Running setup.py (path:/tmp/pip-yTRjhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:24 INFO - Running setup.py (path:/tmp/pip-hq4EGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:24 INFO - Running setup.py (path:/tmp/pip-Q_Rqxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:24 INFO - Running setup.py (path:/tmp/pip-FgINPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:24 INFO - Running setup.py (path:/tmp/pip-vdLD0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:24 INFO - Running setup.py (path:/tmp/pip-B0Xiwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:24 INFO - Running setup.py (path:/tmp/pip-1NHshg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:24 INFO - Running setup.py (path:/tmp/pip-qi9veR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:24 INFO - Running setup.py (path:/tmp/pip-5H9VV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:24 INFO - Running setup.py (path:/tmp/pip-6ubncW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:24 INFO - Running setup.py (path:/tmp/pip-JO9SxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:24 INFO - Running setup.py (path:/tmp/pip-jpXb1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:01:24 INFO - Running setup.py install for manifestparser 22:01:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:01:25 INFO - Running setup.py install for mozcrash 22:01:25 INFO - Running setup.py install for mozdebug 22:01:25 INFO - Running setup.py install for mozdevice 22:01:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:01:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:01:25 INFO - Running setup.py install for mozfile 22:01:25 INFO - Running setup.py install for mozhttpd 22:01:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:01:25 INFO - Running setup.py install for mozinfo 22:01:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:01:25 INFO - Running setup.py install for mozInstall 22:01:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:01:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:01:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:01:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:01:25 INFO - Running setup.py install for mozleak 22:01:25 INFO - Running setup.py install for mozlog 22:01:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Running setup.py install for moznetwork 22:01:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Running setup.py install for mozprocess 22:01:26 INFO - Running setup.py install for mozprofile 22:01:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Running setup.py install for mozrunner 22:01:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Running setup.py install for mozscreenshot 22:01:26 INFO - Running setup.py install for moztest 22:01:26 INFO - Running setup.py install for mozversion 22:01:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:01:26 INFO - Cleaning up... 22:01:26 INFO - Return code: 0 22:01:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:26 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')]} 22:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:26 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')]} 22:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:26 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 0x7f95d54b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2047350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d61c0>, '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 0x20d70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d7550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', '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 22:01:26 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 22:01:26 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 22:01:26 INFO - Using env: {'DISPLAY': ':0', 22:01:26 INFO - 'HOME': '/home/cltbld', 22:01:26 INFO - 'LANG': 'en_US.UTF-8', 22:01:26 INFO - 'LANGUAGE': 'en_US:en', 22:01:26 INFO - 'LOGNAME': 'cltbld', 22:01:26 INFO - 'MAIL': '/var/mail/cltbld', 22:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:26 INFO - 'MOZ_NO_REMOTE': '1', 22:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:26 INFO - 'NO_EM_RESTART': '1', 22:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:26 INFO - 'PWD': '/builds/slave/test', 22:01:26 INFO - 'SHELL': '/bin/bash', 22:01:26 INFO - 'SHLVL': '1', 22:01:26 INFO - 'TERM': 'linux', 22:01:26 INFO - 'TMOUT': '86400', 22:01:26 INFO - 'USER': 'cltbld', 22:01:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', 22:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:26 INFO - '_': '/tools/buildbot/bin/python'} 22:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:27 INFO - Running setup.py (path:/tmp/pip-z6YT4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:27 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:27 INFO - Running setup.py (path:/tmp/pip-cCP1UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:27 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:27 INFO - Running setup.py (path:/tmp/pip-QFmiWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:27 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:27 INFO - Running setup.py (path:/tmp/pip-oGO82x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:27 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:27 INFO - Running setup.py (path:/tmp/pip-ypphGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:27 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:27 INFO - Running setup.py (path:/tmp/pip-iz2IYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:27 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:27 INFO - Running setup.py (path:/tmp/pip-4HjFTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:27 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:27 INFO - Running setup.py (path:/tmp/pip-GcOAug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:27 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:27 INFO - Running setup.py (path:/tmp/pip-qhtCSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:27 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:27 INFO - Running setup.py (path:/tmp/pip-gJgm3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:27 INFO - Running setup.py (path:/tmp/pip-L9k3Qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:27 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:27 INFO - Running setup.py (path:/tmp/pip-IHj49E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:27 INFO - Running setup.py (path:/tmp/pip-1FuW1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:27 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)) 22:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:27 INFO - Running setup.py (path:/tmp/pip-uk3luK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:28 INFO - Running setup.py (path:/tmp/pip-G2Gpou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:28 INFO - Running setup.py (path:/tmp/pip-OtwlFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:28 INFO - Running setup.py (path:/tmp/pip-wS64Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 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)) 22:01:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:30 INFO - Downloading blessings-1.6.tar.gz 22:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:01:30 INFO - Installing collected packages: blessings 22:01:30 INFO - Running setup.py install for blessings 22:01:30 INFO - Successfully installed blessings 22:01:30 INFO - Cleaning up... 22:01:30 INFO - Return code: 0 22:01:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:30 INFO - Reading from file tmpfile_stdout 22:01:30 INFO - Current package versions: 22:01:30 INFO - argparse == 1.2.1 22:01:30 INFO - blessings == 1.6 22:01:30 INFO - blobuploader == 1.2.4 22:01:30 INFO - docopt == 0.6.1 22:01:30 INFO - functools32 == 3.2.3-2 22:01:30 INFO - jsonschema == 2.5.1 22:01:30 INFO - manifestparser == 1.1 22:01:30 INFO - mozInstall == 1.12 22:01:30 INFO - mozcrash == 0.17 22:01:30 INFO - mozdebug == 0.1 22:01:30 INFO - mozdevice == 0.48 22:01:30 INFO - mozfile == 1.2 22:01:30 INFO - mozhttpd == 0.7 22:01:30 INFO - mozinfo == 0.9 22:01:30 INFO - mozleak == 0.1 22:01:30 INFO - mozlog == 3.2 22:01:30 INFO - moznetwork == 0.27 22:01:30 INFO - mozprocess == 0.22 22:01:30 INFO - mozprofile == 0.28 22:01:30 INFO - mozrunner == 6.11 22:01:30 INFO - mozscreenshot == 0.1 22:01:30 INFO - mozsystemmonitor == 0.3 22:01:30 INFO - moztest == 0.7 22:01:30 INFO - mozversion == 1.4 22:01:30 INFO - psutil == 3.1.1 22:01:30 INFO - requests == 1.2.3 22:01:30 INFO - wsgiref == 0.1.2 22:01:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:30 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 0x7f95d54b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2047350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d61c0>, '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 0x20d70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d7550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', '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 22:01:30 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 22:01:30 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 22:01:30 INFO - Using env: {'DISPLAY': ':0', 22:01:30 INFO - 'HOME': '/home/cltbld', 22:01:30 INFO - 'LANG': 'en_US.UTF-8', 22:01:30 INFO - 'LANGUAGE': 'en_US:en', 22:01:30 INFO - 'LOGNAME': 'cltbld', 22:01:30 INFO - 'MAIL': '/var/mail/cltbld', 22:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:30 INFO - 'MOZ_NO_REMOTE': '1', 22:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:30 INFO - 'NO_EM_RESTART': '1', 22:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:30 INFO - 'PWD': '/builds/slave/test', 22:01:30 INFO - 'SHELL': '/bin/bash', 22:01:30 INFO - 'SHLVL': '1', 22:01:30 INFO - 'TERM': 'linux', 22:01:30 INFO - 'TMOUT': '86400', 22:01:30 INFO - 'USER': 'cltbld', 22:01:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', 22:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:30 INFO - '_': '/tools/buildbot/bin/python'} 22:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:30 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)) 22:01:30 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)) 22:01:30 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)) 22:01:30 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)) 22:01:30 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)) 22:01:30 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)) 22:01:30 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)) 22:01:30 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)) 22:01:30 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)) 22:01:30 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)) 22:01:30 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)) 22:01:30 INFO - Cleaning up... 22:01:30 INFO - Return code: 0 22:01:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d54b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2047350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d61c0>, '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 0x20d70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d7550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', '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 22:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:01:30 INFO - Using env: {'DISPLAY': ':0', 22:01:30 INFO - 'HOME': '/home/cltbld', 22:01:30 INFO - 'LANG': 'en_US.UTF-8', 22:01:30 INFO - 'LANGUAGE': 'en_US:en', 22:01:30 INFO - 'LOGNAME': 'cltbld', 22:01:30 INFO - 'MAIL': '/var/mail/cltbld', 22:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:30 INFO - 'MOZ_NO_REMOTE': '1', 22:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:30 INFO - 'NO_EM_RESTART': '1', 22:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:30 INFO - 'PWD': '/builds/slave/test', 22:01:30 INFO - 'SHELL': '/bin/bash', 22:01:30 INFO - 'SHLVL': '1', 22:01:30 INFO - 'TERM': 'linux', 22:01:30 INFO - 'TMOUT': '86400', 22:01:30 INFO - 'USER': 'cltbld', 22:01:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', 22:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:30 INFO - '_': '/tools/buildbot/bin/python'} 22:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:01:30 INFO - Cleaning up... 22:01:31 INFO - Return code: 0 22:01:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d54b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2047350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d61c0>, '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 0x20d70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d7550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', '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 22:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:01:31 INFO - Using env: {'DISPLAY': ':0', 22:01:31 INFO - 'HOME': '/home/cltbld', 22:01:31 INFO - 'LANG': 'en_US.UTF-8', 22:01:31 INFO - 'LANGUAGE': 'en_US:en', 22:01:31 INFO - 'LOGNAME': 'cltbld', 22:01:31 INFO - 'MAIL': '/var/mail/cltbld', 22:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:31 INFO - 'MOZ_NO_REMOTE': '1', 22:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:31 INFO - 'NO_EM_RESTART': '1', 22:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:31 INFO - 'PWD': '/builds/slave/test', 22:01:31 INFO - 'SHELL': '/bin/bash', 22:01:31 INFO - 'SHLVL': '1', 22:01:31 INFO - 'TERM': 'linux', 22:01:31 INFO - 'TMOUT': '86400', 22:01:31 INFO - 'USER': 'cltbld', 22:01:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', 22:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:31 INFO - '_': '/tools/buildbot/bin/python'} 22:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:31 INFO - Downloading/unpacking flake8 22:01: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 22:01: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 22:01: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 22:01: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 22:01: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 22:01: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 22:01:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:01:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:01:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:01:33 INFO - no previously-included directories found matching 'docs/_build' 22:01:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:01:33 INFO - Running setup.py install for pep8 22:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:01:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:01:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:01:33 INFO - no previously-included directories found matching 'docs/_build' 22:01:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:01:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:01:33 INFO - Cleaning up... 22:01:34 INFO - Return code: 0 22:01:34 INFO - Running post-action listener: _resource_record_post_action 22:01:34 INFO - Running post-action listener: _start_resource_monitoring 22:01:34 INFO - Starting resource monitoring. 22:01:34 INFO - ##### 22:01:34 INFO - ##### Finished create-virtualenv step (success) 22:01:34 INFO - ##### 22:01:34 INFO - ##### 22:01:34 INFO - ##### Running install step. 22:01:34 INFO - ##### 22:01:34 INFO - Running pre-action listener: _resource_record_pre_action 22:01:34 INFO - Running main action method: install 22:01:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:34 INFO - Reading from file tmpfile_stdout 22:01:34 INFO - Detecting whether we're running mozinstall >=1.0... 22:01:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:01:34 INFO - Reading from file tmpfile_stdout 22:01:34 INFO - Output received: 22:01:34 INFO - Usage: mozinstall [options] installer 22:01:34 INFO - Options: 22:01:34 INFO - -h, --help show this help message and exit 22:01:34 INFO - -d DEST, --destination=DEST 22:01:34 INFO - Directory to install application into. [default: 22:01:34 INFO - "/builds/slave/test"] 22:01:34 INFO - --app=APP Application being installed. [default: firefox] 22:01:34 INFO - mkdir: /builds/slave/test/build/application 22:01:34 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'] 22:01:34 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 22:01:50 INFO - Reading from file tmpfile_stdout 22:01:50 INFO - Output received: 22:01:50 INFO - /builds/slave/test/build/application/firefox/firefox 22:01:50 INFO - Running post-action listener: _resource_record_post_action 22:01:50 INFO - ##### 22:01:50 INFO - ##### Finished install step (success) 22:01:50 INFO - ##### 22:01:50 INFO - ##### 22:01:50 INFO - ##### Running run-tests step. 22:01:50 INFO - ##### 22:01:50 INFO - Running pre-action listener: _resource_record_pre_action 22:01:50 INFO - Running main action method: run_tests 22:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:01:50 INFO - Python 2.7.3 22:01:50 INFO - Return code: 0 22:01:50 INFO - grabbing minidump binary from tooltool 22:01:50 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')]} 22:01:50 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 0x20d61c0>, '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 0x20d70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d7550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:01:50 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 22:01:50 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 22:01:50 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 22:01:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:50 INFO - Return code: 0 22:01:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:01:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:01:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:01:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:01:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:01:51 INFO - Return code: 0 22:01:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:01:51 INFO - Using env: {'DISPLAY': ':0', 22:01:51 INFO - 'HOME': '/home/cltbld', 22:01:51 INFO - 'LANG': 'en_US.UTF-8', 22:01:51 INFO - 'LANGUAGE': 'en_US:en', 22:01:51 INFO - 'LOGNAME': 'cltbld', 22:01:51 INFO - 'MAIL': '/var/mail/cltbld', 22:01:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:01:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:51 INFO - 'MOZ_NO_REMOTE': '1', 22:01:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:51 INFO - 'NO_EM_RESTART': '1', 22:01:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:51 INFO - 'PWD': '/builds/slave/test', 22:01:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:01:51 INFO - 'SHELL': '/bin/bash', 22:01:51 INFO - 'SHLVL': '1', 22:01:51 INFO - 'TERM': 'linux', 22:01:51 INFO - 'TMOUT': '86400', 22:01:51 INFO - 'USER': 'cltbld', 22:01:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278', 22:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:51 INFO - '_': '/tools/buildbot/bin/python'} 22:01:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:01:51 INFO - mozversion application_buildid: 20160617203824 22:01:51 INFO - mozversion application_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 22:01:51 INFO - mozversion application_display_name: Nightly 22:01:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:51 INFO - mozversion application_name: Firefox 22:01:51 INFO - mozversion application_remotingname: firefox 22:01:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:01:51 INFO - mozversion application_vendor: Mozilla 22:01:51 INFO - mozversion application_version: 50.0a1 22:01:51 INFO - mozversion platform_buildid: 20160617203824 22:01:51 INFO - mozversion platform_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 22:01:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:01:51 INFO - mozversion platform_version: 50.0a1 22:01:51 INFO - using testdate: 1466226111 22:01:51 INFO - actual date: 1466226111 22:01:51 INFO - starting webserver on 'localhost:34669' 22:01:51 INFO - SUITE-START | Running 2 tests 22:01:51 INFO - TEST-START | dromaeo_css 22:01:51 INFO - operating with platform_type : linux_ 22:01:51 INFO - Initialising browser for dromaeo_css test... 22:01:51 INFO - TEST-INFO | started process 15719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBeYd0G/profile http://localhost:34669/getInfo.html) 22:01:57 INFO - PROCESS | 15719 | __metrics Screen width/height:1600/1200 22:01:57 INFO - PROCESS | 15719 | colorDepth:24 22:01:57 INFO - PROCESS | 15719 | Browser inner width/height: 1024/697 22:01:57 INFO - PROCESS | 15719 | __metrics 22:01:58 ERROR - PROCESS | 15719 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 22:01:59 INFO - TEST-INFO | 15719: exit 0 22:01:59 INFO - Browser initialized. 22:01:59 INFO - Running cycle 1/1 for dromaeo_css test... 22:01:59 INFO - TEST-INFO | started process 15837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBeYd0G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:02:11 INFO - PROCESS | 15837 | RSS: Main: 186449920 22:02:11 INFO - PROCESS | 15837 | 22:03:00 INFO - PROCESS | 15837 | 1466226180708 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] 22:05:13 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:34669/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34669/tests/dromaeo/cssquery-ext.html) 22:05:14 INFO - PROCESS | 15837 | RSS: Main: 189296640 22:05:14 INFO - PROCESS | 15837 | 22:08:16 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:34669/tests/dromaeo/cssquery-ext.html (next: http://localhost:34669/tests/dromaeo/cssquery-jquery.html) 22:08:17 INFO - PROCESS | 15837 | RSS: Main: 188166144 22:08:17 INFO - PROCESS | 15837 | 22:11:19 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:34669/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34669/tests/dromaeo/cssquery-mootools.html) 22:11:20 INFO - PROCESS | 15837 | RSS: Main: 189227008 22:11:20 INFO - PROCESS | 15837 | 22:14:21 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:34669/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34669/tests/dromaeo/cssquery-prototype.html) 22:14:22 INFO - PROCESS | 15837 | RSS: Main: 186777600 22:14:22 INFO - PROCESS | 15837 | 22:17:25 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:34669/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34669/tests/dromaeo/cssquery-yui.html) 22:17:25 INFO - PROCESS | 15837 | RSS: Main: 189046784 22:17:25 INFO - PROCESS | 15837 | 22:20:28 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:34669/tests/dromaeo/cssquery-yui.html (next: http://localhost:34669/tests/dromaeo/cssquery-dojo.html) 22:20:28 INFO - PROCESS | 15837 | RSS: Main: 189644800 22:20:28 INFO - PROCESS | 15837 | 22:20:28 INFO - PROCESS | 15837 | __start_tp_report 22:20:28 INFO - PROCESS | 15837 | _x_x_mozilla_page_load 22:20:28 INFO - PROCESS | 15837 | _x_x_mozilla_page_load_details 22:20:28 INFO - PROCESS | 15837 | |i|pagename|runs| 22:20:28 INFO - PROCESS | 15837 | |0;dojo.html;2589.1196993022368;2656.920292391229;2673.144593730006;2689.2604533753215;2691.5828046652764;4738.147133515966;4784.521547845218;4791.832285869995;4894.632902532307;4916.483769204236;4704.317873908281;4836.564709176174;4843.443004054535;4845.636577256702;4889.877753056176;4402.251617225072;4437.312216606415;4575.908481830362;4579.702319349249;4597.678162528624;555.6179673485658;4367.432233809616;4424.3142312941545;4433.911321773563;4491.438570178728;4429.867103986886;4434.35701823237;4478.865634030952;4482.977585112086;4530.79611417487;4442.955570444286;4448.955510444886;4465.843695470676;4471.530489298641;4479.395281637003;4311.655067594585;4394.450693663292;4406.757628330441;4408.228560001987;4413.889652758675;4719.9292010619865;4812.783424745895;4833.734144622044;4834.613230941516;4845.515448455161;5171.3535808024;5221.39953905302;5225;5232.790688372461;5296.020236256305;5260.368755749335;5297.841064768063;5310.7610157543;5326.786928522854;5362.678239305654;4908.803647854082;4914.361133052752;4917.65576409655;4931.284963680247;4949.851504454872;5163.302954101148;5290.365156181283;5294.311739473844;5324.387695415076;5346.625736198429;5147.1507201312115;5165.483451654804;5166.767495462713;5169.198774189931;5204.973975130176;5238.135707608279;5251.36983561975;5260.9741100485035;5262.2632831403635;5310.230016647642;5080.898382032413;5127.410347809975;5157.535821776059;5167.354080739908;5183.403908550489;5166.173412254021;5180.093483640348;5186.559142472932;5200.323957885451;5200.92198617021;4451.399061126771;4451.710638808467;4452.8218871245435;4494.528074552125;4503.639708823286;3767.4348847672522;3814.0655539392474;3818.770873747584;3843.8078096095082;3864.9033774155873;4359.237133501688;4371.890702732457;4425.690201685851;4440.2007638625355;4459.866204013885;5182.97408512955;5184.429712731597;5196.1166601677805;5227.973860130675;5230.816921407809;4364.323529852878;4377.78111094444;4403.889902752393;4420.889477763081;4469.754163520973;4666.510016448224;4684.039771846763;4703.506131856174;4706.88232794176;4743.075100355398;4783.23468245086;4856.975715121402;4866.124097662384;4880.707157570557;4919.311296418576;5098.5411312982005;5140.4859514049795;5181.870453238699;5243.370795504564;5243.764030618555;4911.165101932752;4912.042151780369;4913.213885778258;4915.975420122876;4952.950470495249;5174;5174.094533456555;5179.663321884065;5197.870053248699;5199.324087868553;5126.564242039469;5209.817656382009;5239.580833533232;5275.340582427197;5298.549623282064;5080.974595127001;5082.644214905069;5104.770285337095;5133.8716532087;5152.716600587004;4981.975090124526;5119.155339369111;5120.948790512196;5134.743262836918;5135;4914.803407863788;4960.702357858396;4961.255811628284;5001;5025.597952163891;5103.10695628271;5139.563137133386;5151.768170432265;5153.45888681683;5166.560842328294;4901.58336541398;4965.726885021214;5031.144705400017;5035.194368900959;5050.217216331474 22:20:28 INFO - PROCESS | 15837 | |1;ext.html;540.6452684312982;566.7392999220359;582.9650220986741;594.2542109652387;613.2242712968099;36216.818915905416;40400;40432.79783601078;40436.59563404362;40666.39000414992;38697.61302386975;39204;39278.41082383759;39278.410823837665;39432.80283598585;7693.576853273082;7952.085510166318;7956;7959.602019899011;7967.043954725441;7799.415043871704;7807.921920780776;7879.290863822283;7907.327877130451;7928.682852685914;7874.055113386402;7892.763217103496;7897.012873390826;7909.802254943644;7979.321757650607;7892.842143157133;7961.800954976114;7978.481398709066;7981.082175549799;7984.760457186294;7883.645235964395;7918.208179182036;7954.204579542057;7970.880436793453;7975.920240797634;38429.231415371534;38609.22781544382;38617.806910965264;38666.80666596649;38789.22421551582;2537.6827896512937;2826.7173282671774;2911.8544072796276;3323.4516304809677;3694.353488139565;27785.305367365978;28162.15513534577;28206.435871282665;28406.147815565568;28527.286817829514;3343.3480471308103;3357.6642335766473;3509.298140371936;3519.243362677011;3531.4526248431534;224410;225762;226095;226139;226422;29509.85245073761;30482;32112;32522.837385813393;32668.18329541733;32471.83764081212;32820.343593128004;33087.83456082753;33159.668403316144;33179.66820331814;11796.351200683874;11817.113716471298;11907.226030308002;11927.105467090003;11933.164678472423;11013.669589912315;11126.776054633983;11126.944365278121;11149.05233055183;11183.161262905314;7874.976253087062;7914.525128492309;7931.881021784678;7946.443748937634;7979.3616510679;3065.049834551296;3068.3709839482854;3080.152957936585;3110.53341998702;3140.446352788466;875.1554749666602;889.3107841422949;936.4334577580602;948.3077353531822;965.1747755668943;28723.28191795222;28753.28116797055;28869.422611547652;28935.7106428933;29629;963.3689933093834;1005.4068099820994;1024.882138554076;1041.2398948767443;1068.6259809066764;14833.92583037078;15579.532614021597;15660;15762.527124186292;15793.921030395004;390542;391620;393139;393220;393709;50066.247681331704;50893.74553127211;51307;51307.486925131016;51384.229236561485;1125.6679279612533;1168.4099529737598;1171.9648410547697;1176.823476478535;1182.787098322293;27345.72654273432;28508.429831402842;28605.570916436685;28713;29041.7095829039;44501.554984449744;44674;44928;45010;45095.549044509135;334329;336979;337516;337915;338367;25586.360340991625;26116.608250875874;26398;26398.472030559664;26578.46843063089;43621.56378436175;43683;43803.561964381224;43854.561454385046;44355.77822110869;37601.4359784598;37674.81162594169;38107.23785524219;38138.80930595329;38261.42607860829;37260.627393725714;37274.813625931696;38005.23989520139;38068.42897356597;38293.617063829006;36512;36639.45040824443;37329.25341493101;37342.62657373391;37623.81188094042;32247.03258902237;33071.33857322888;34176.82911585426;34303.14242143966;34330.48504272488;25499;26135.477290453706;26268.343291417867;26272.34319142037;26441.901505266713 22:20:28 INFO - PROCESS | 15837 | |2;jquery.html;354.1005845153312;356.42793316726653;360.4251219305208;373.0319820066929;379.24340939825055;15699.60750981226;16771.41300054497;16831.915840420796;17095.230714617843;17165.82834171658;15778.605534861605;16374.918125409386;17150;17163.91418042911;17172;4924.384451943498;5102.846914592549;5129.179331306992;5130.820421285256;5131.692098474085;3675.871344502943;5018.673786203904;5583.302087239095;5887.676177810219;5902.6458412495385;5843.941560584403;5877.529797616202;5930.080837470199;5939.7921072762465;5957.225560677128;5813.7383817728305;5951.880962380771;5956.255468066492;5957.434043765857;5970.34326224115;4516.254817955033;5025.447200807908;5175.576716402981;5185.248139019821;5191.740412979336;11482.311061336262;12731.936340318332;18817.52956176093;20229.190832366687;20247.696284555597;1774.2814160265114;1813.7823461184742;1919.9616007679908;1936.9515762105918;1994.980050199494;8696.695615653485;8766.123387661246;8894.377393582452;8931.50876701781;9201.769955751093;1592.928318225671;1665.1091665958654;1722.664080504302;1736.0625262358312;1787.9106044697844;65340;65886;67091.66454167747;67111.66444167748;67860.6606966962;9917.752056198653;10016.599336026624;10027.949860250797;10153.695389138338;10244.846327305097;13605.659858503419;13610.387532561059;13753.38109785062;13767.38046787897;13775.311234438239;6756.155480564929;6799.558028728117;6974.721011159497;7003.789886303419;7127.60798156096;6430.131932189188;6453.838654033593;6538.640374779337;6634.635095069818;6795.93204067953;4261;4318.438602981592;4352.717073390283;4371.431713877176;4435.268180750205;1532.7394342961722;1575.8975666581634;1621.2866338810886;1622.732249178896;1754.7455618935182;806.4435539477741;836.3810780022861;866.081953129672;886.4061079077034;907.8017017536788;16195.919020405057;16454.259558319904;16733.66532669364;16849.326026958784;16943;826.5949684654596;840.5167028958373;851.9787005324916;888.9866652000226;910.2808781063019;9031.232345250595;9445.19715824149;9447.102525260227;9528.666496672584;9602.66390676323;372063;387700;394390;399203;402283;71827;73169.6341518289;75057;75224;76456;875.3566128895256;889.7063968890251;897.3942588752566;906.8639704044446;911.544227886057;15009.924950375178;15011.624709382353;15054.924725376302;15099.245037747849;15244;34233.657663423044;35106.82446587751;36087.09782255465;36615.45076823796;36887;47665.761671192806;48439;49496.75251623719;49988.25017624811;50604.74697626635;7317.524360916736;7382.704691812267;7465.552066876005;7597.810054748676;7613.010308659839;10910.509027093642;11480.655580332603;11744.119191060534;11792;11962.940185299018;9760.46317452547;9807;10060;10103.49482525856;10264.486775661337;10307.330023548446;10321.587136514456;10383.844242336521;10462;10523.579056837947;9763.36538125048;9793.902060979584;9899.1585715215;10354.948225258826;10652.62715804943;7477.813054673459;7503.287187717158;7646.770596882103;7647.311741943252;7664.80837979055;9552.57013434411;9618.086281803218;9971.451570163421;10083;10331.22515811302 22:20:28 INFO - PROCESS | 15837 | |3;mootools.html;1339.189790176943;1379.144930143311;1385.5427708856073;1585.6987172437236;1618.8381161883806;6517.967410162954;7098.645067746611;7241.746538871141;7577.810554736135;7591.202923693016;7533.773986780392;7543.8868416973655;7613.314801667849;7617.619119044053;7624.809379765508;2195.791399817019;2232.2075663139594;2236.1502629000956;2237.9888100559474;2238.608243557379;2103.2112957640884;2104.8105670489654;2161.103142195987;2167.241465487075;2175.3473957812594;2139.3047259640603;2149.924752633658;2161.5244646177816;2163.459135216196;2215.3796936857707;2032.0347834778436;2045.3045964372036;2051.7435320584927;2058.0430100003496;2075.1491888325713;2036.297477370305;2048.98975505123;2071.0473182336145;2071.337172104927;2075.2632815350635;7572.864070389431;7686.923130768677;7700.768976930645;7738.61306934651;7741.961290193569;4153.086321009373;4244.660427165819;4269.402283680256;4276.3799249109015;4283.271843786564;2765.363966287765;2779.374640705825;2860.3278229616026;2897.478453878322;2906.549484829855;860.2878578931889;881.8544940084878;886.8758373827604;896.9551522423918;1785.4643606917873;9630.036996300383;10022.298439109265;10046.146077583415;10106.39361638304;10114.747131321703;3725.962740372616;3840.807959602009;3898.9805050975133;3931.9803400983383;3967;7718.96140519305;7753.302202801775;7754.534727916343;7783.805404864924;7821.5698136601895;4360.7819609019425;4366.257736184856;4367.344898265222;4368.5194628590825;4383.057642606855;3528.8588456461966;3866.6326698963553;4011.3180759270995;4022.235775202702;4085.7957102144774;3275.1648329676254;3286.52345409919;3345.7193446220895;3385.441402168664;3413.761036727405;982.9557669904872;984.5766320482118;995.2485873165714;1000.3697670467704;1015.7765291635976;755.5391211361066;765.0054928592807;793.9563324017234;829.7261903571807;847.576211894053;4963.404391472975;4989.376327959005;5044.344235249394;5081.212412076134;5112.207607820794;860.1140824950311;869.4783130121876;877.622622272429;888.440282621957;918.5774543709969;3373.785437242591;3556.644335566474;3558.626344233818;3602.225521512887;3630.455431685268;8977.730668079968;9123.17891389765;9258.907410925805;9283.76790580241;9297.628094876129;9104.635814567475;9150.03924587922;9191.08089191089;9245.72262832116;9249.16757491829;6851.725930962705;6880.071190389233;6945.166580010431;6948.374646281758;6973.372396484239;5199.11615025439;5427.945720542744;5497.8075767347955;5567.721613919369;5580.218769372373;8201.630926608435;8466.830663386574;8476.36427267945;8616.913830861862;8701.8694719578;8094.5143291400345;8663.566821659018;8673.392862499817;8750.69372571957;8808.735737927873;5821.970890145692;6410.743570257324;6600.405963463311;6612.50406219545;6680.766173183915;7219.0976127984;7429.368503677248;7438.73964411243;7459.328660420588;7502.774916752288;6473.643949582818;6635.2037755469655;6642.833929151617;6678.098456708282;6736.528443008942;6676.265610782907;6689.69896354675;6767.830804229934;6793.354631310018;6798.3773665473045;5812.244408226903;5888.057910734262;5910.940890591039;5911.852203694942;5918.822435326947;4330.328799036154;4438.578335058164;4449.243628583214;4461.665375096816;4471.932921006122;4366.737995720267;4442.244818380818;4464.196444639866;4468.731876087445;4504.076664283749 22:20:28 INFO - PROCESS | 15837 | |4;prototype.html;280.7669634203611;285.2810916490444;287.1829644660939;287.88772378772285;289.38938839049587;5111.437741848398;5124.66689665172;5133.459962011396;5163.535281824635;5181;5032.766972091834;5038.7984480620735;5053.115704751672;5068.163752980754;5134.229865520165;3718.456840411226;3804.6385593368586;3941.7634941903434;3942.2115576884594;3955.189186216833;3854.2676891390547;3903.375459926398;3905.7656540607654;3933.174033452978;3938.991114531595;3916.706247031484;3947.5262968443826;3960.7029472789513;3973.423853541249;3974.2051589682032;3842.4428457873732;3904.629060239273;3934.3836348827995;3950.743201691881;3962.3065963456424;3433.8111403872776;3438.5186073949667;3465.203003309253;3475.791452512857;3481.1723844981334;4914.508549145093;4936.456989731127;4951.331570238008;4953.6037117030555;4965.4358876954;4293;4505.639548836085;4523.163214805239;4556.840510582147;4566.40636717228;5254.395744489356;5295.616972362413;5320.148776195829;5360.812371567015;5401.4868587484125;3763.924721505582;3787.5644300905196;3788.109794198361;3788.886333410002;3816.9427458588143;5355.464453554691;5589.35722391922;5600.327960644708;5677.318721753375;5690.089585666315;3862.942055869164;3895.7662540247675;3901.45379646844;3908.550516690617;3913.1195481016543;3951.407288906687;3968.8214030368704;3969.186316805048;3976.1451287973223;3985.103351745834;4517.706349087299;4531.229690952546;4554.134714404253;4566.794494247701;4578.748168850745;5202.297689811902;5341.278927344759;5369.838904832784;5375.489328513785;5396.83809485716;1334.1994803118246;1343.3081962789172;1343.8320209973754;1349.3657980749033;1357.945682172702;838.2916435611899;841.7735090685104;861.7759382560454;882.6557642519423;886.6542048601051;4568.177728008924;4671.929921051187;4695.80257034454;4699.929501057487;4713.468122860084;5572.972135139298;5575.940571291441;5577.3028371453565;5582;5611.102223644198;4433.334999750064;4621.3068039793625;4662.673612847136;4703.905921881543;4721.386219791474;2933.2960089578346;2978.687237840039;2986.3728616990243;2989;2994.970050299469;5228.241904923765;5228.58171346299;5229.9341760005345;5236.371635403776;5246.475352464723;5382.273393091882;5641.661500309994;5659.122835960433;5661.2923384576925;5703.62926409782;5194.428612852583;5234.450382709837;5253.763580638957;5270.657407268515;5274.973625131926;5610.933922554702;5617;5647.802326918538;5671.546276297804;5681.0910254359105;5224.921626175535;5488.588355873405;5518.613697041329;5527.115661494303;5557.805476808292;5148.948510514847;5216.582673386196;5244.475552444877;5245.947540524546;5251.501107394792;3872.438496417947;3935.704822138294;3939.3893946438347;3981.8407263709128;3996.7202295840175;5458.2904222450825;5481.917771233355;5515.172724091419;5528.695921724183;5591.84713885149;5311.946880531145;5322.547583455294;5343.9465605345;5364.90768600254;5385.919211211756;5126.615503837302;5323.414424413389;5393.9730301348245;5394.271773310553;5399.325084364455;5232.607554433509;5271.235670827632;5294.8411547652095;5315.867103322448;5325.9467405327005;5225.790968361375;5269.525742683177;5425.267588875609;5431.6740995540395;5445.101558243004;5310.5836844236555;5311.973440132774;5324.440933702061;5326.813561525328;5337.306150200449 22:20:28 INFO - PROCESS | 15837 | |5;yui.html;617.8177437655891;659.4262991197659;661.7716887673753;664.1598378051768;716.3588588213549;12535.247885126899;12824.67938301543;12949.41727622257;13004.674883127938;13041.478340866353;12199.207051541644;12299.139060265785;12302.815457768118;12318.81521777174;12332.93833530831;625.7966160997694;764.2395816162925;775.371948721536;781.679511400326;794.2216627704853;775.9922400776005;776.320719370548;777.4596655324551;780.5277806926813;780.6096951524238;810.9797255068612;813.5810057820228;816.1675091406762;819.8934138561979;820.1839170025833;797.6769408389582;801.2428255298745;803.2409373142383;806.6531391501652;806.8305655812258;583.2854752927672;586.633354153654;587.4477990688781;587.7149582452507;588.7733222709245;12409.689757756038;12499.687507812287;12547.498100075985;12571.874281257162;12604;13060.151090179108;13235.272060036694;13306.334683265797;13368.131071480322;13617.114887532278;10385.480725963671;10391.896081039169;10442.582296708122;10445.738856528571;10610.840837387444;3259.2177877309514;3301.7853839500594;3310.8841190558455;3335.382954153489;3358.748093892968;57044.71477642627;57078;57210.999999999585;57288;58045.70977145129;10612.787744245226;10682.679519614425;10714.142868570496;10726.785464290826;10795.082417994558;19464;19675.704864427044;19807.405777826687;19815;19953.900230498755;6250.968745156245;6682.431993280626;6804.8298792529595;6813.2846051163915;6818.215905170969;3475.530803341567;3511.596166440841;3635.690966267844;3652.086978255436;3694.704423646102;2727.5908613707707;2844.928876778056;2845.7865660075577;3162.7153556180056;3327.517509961042;576.533008263308;578.23672751967;584.6053913608297;586.8180863932195;587.4712758517284;421.7490593097102;429.48247361929424;457.2409799732428;474.1891365764581;474.3288247130272;7365.300296471826;7473.775786726298;7774;7825.37397008238;7946.483478573874;399.99600003999586;419.16795161604193;452.5112878091653;493.1468559392271;517.9507946745128;3555.839987200582;3665.651763082503;3726.459663348799;3726.925461490809;3745.138618117848;85707.57146214353;88693.11306886977;88994;89762.55118724496;92580;72949.27050729531;81352.59323703461;83358.58320708357;84771.15228847633;84966.57516712377;73365;73921;75247.24752752403;75980.24019759842;76015;6981.581105133709;7117.75087871922;7257.600831954293;7380.926190738024;7405.148407932941;39265.411018834166;39902.40146397865;40477.595224047385;40723;41403;55637.44362556485;60186.39813601808;60811;60847;60872.69563652154;7865.252800983897;7909.564973926489;7933.722319719013;7953.363730901629;8150.83698326042;9583.329166958525;9722.173615242784;9726.36778609388;9759.12167904892;12829.93585032069;12052.457639406073;12469.625911222678;12557.623271301876;12679.858812706902;13348.733025339634;12290.631281061582;12472.937635311766;12684.112112152061;13077.869221307665;13100.934495327463;12400.13199076056;12560.246385216917;12634;13070.411831467416;13326.500251264924;9826.65606703762;9933.801323973625;10081.445520496443;10089.848652270075;10251.7437064074;9766.80466390654;9887.357321774061;9918.717870577859;10057.647982320876;10203.928587498503 22:20:28 INFO - PROCESS | 15837 | __end_tp_report 22:20:28 INFO - PROCESS | 15837 | __start_cc_report 22:20:28 INFO - PROCESS | 15837 | _x_x_mozilla_cycle_collect,394 22:20:28 INFO - PROCESS | 15837 | __end_cc_report 22:20:28 INFO - PROCESS | 15837 | __startTimestamp1466227228696__endTimestamp 22:20:28 INFO - PROCESS | 15837 | 22:20:28 INFO - PROCESS | 15837 | ------- Summary: start ------- 22:20:28 INFO - PROCESS | 15837 | Number of tests: 6 22:20:28 INFO - PROCESS | 15837 | 22:20:28 INFO - PROCESS | 15837 | [#0] dojo.html Cycles:165 Average:4783.14 Median:4919.31 stddev:618.39 (12.6%) stddev-sans-first:595.85 22:20:28 INFO - PROCESS | 15837 | Values: 2589.1 2656.9 2673.1 2689.3 2691.6 4738.1 4784.5 4791.8 4894.6 4916.5 4704.3 4836.6 4843.4 4845.6 4889.9 4402.3 4437.3 4575.9 4579.7 4597.7 555.6 4367.4 4424.3 4433.9 4491.4 4429.9 4434.4 4478.9 4483.0 4530.8 4443.0 4449.0 4465.8 4471.5 4479.4 4311.7 4394.5 4406.8 4408.2 4413.9 4719.9 4812.8 4833.7 4834.6 4845.5 5171.4 5221.4 5225.0 5232.8 5296.0 5260.4 5297.8 5310.8 5326.8 5362.7 4908.8 4914.4 4917.7 4931.3 4949.9 5163.3 5290.4 5294.3 5324.4 5346.6 5147.2 5165.5 5166.8 5169.2 5205.0 5238.1 5251.4 5261.0 5262.3 5310.2 5080.9 5127.4 5157.5 5167.4 5183.4 5166.2 5180.1 5186.6 5200.3 5200.9 4451.4 4451.7 4452.8 4494.5 4503.6 3767.4 3814.1 3818.8 3843.8 3864.9 4359.2 4371.9 4425.7 4440.2 4459.9 5183.0 5184.4 5196.1 5228.0 5230.8 4364.3 4377.8 4403.9 4420.9 4469.8 4666.5 4684.0 4703.5 4706.9 4743.1 4783.2 4857.0 4866.1 4880.7 4919.3 5098.5 5140.5 5181.9 5243.4 5243.8 4911.2 4912.0 4913.2 4916.0 4953.0 5174.0 5174.1 5179.7 5197.9 5199.3 5126.6 5209.8 5239.6 5275.3 5298.5 5081.0 5082.6 5104.8 5133.9 5152.7 4982.0 5119.2 5120.9 5134.7 5135.0 4914.8 4960.7 4961.3 5001.0 5025.6 5103.1 5139.6 5151.8 5153.5 5166.6 4901.6 4965.7 5031.1 5035.2 5050.2 22:20:28 INFO - PROCESS | 15837 | 22:20:28 INFO - PROCESS | 15837 | [#1] ext.html Cycles:180 Average:46125.64 Median:20166.90 stddev:86084.68 (426.9%) stddev-sans-first:86258.13 22:20:28 INFO - PROCESS | 15837 | Values: 540.6 566.7 583.0 594.3 613.2 36216.8 40400.0 40432.8 40436.6 40666.4 38697.6 39204.0 39278.4 39278.4 39432.8 7693.6 7952.1 7956.0 7959.6 7967.0 7799.4 7807.9 7879.3 7907.3 7928.7 7874.1 7892.8 7897.0 7909.8 7979.3 7892.8 7961.8 7978.5 7981.1 7984.8 7883.6 7918.2 7954.2 7970.9 7975.9 38429.2 38609.2 38617.8 38666.8 38789.2 2537.7 2826.7 2911.9 3323.5 3694.4 27785.3 28162.2 28206.4 28406.1 28527.3 3343.3 3357.7 3509.3 3519.2 3531.5 224410.0 225762.0 226095.0 226139.0 226422.0 29509.9 30482.0 32112.0 32522.8 32668.2 32471.8 32820.3 33087.8 33159.7 33179.7 11796.4 11817.1 11907.2 11927.1 11933.2 11013.7 11126.8 11126.9 11149.1 11183.2 7875.0 7914.5 7931.9 7946.4 7979.4 3065.0 3068.4 3080.2 3110.5 3140.4 875.2 889.3 936.4 948.3 965.2 28723.3 28753.3 28869.4 28935.7 29629.0 963.4 1005.4 1024.9 1041.2 1068.6 14833.9 15579.5 15660.0 15762.5 15793.9 390542.0 391620.0 393139.0 393220.0 393709.0 50066.2 50893.7 51307.0 51307.5 51384.2 1125.7 1168.4 1172.0 1176.8 1182.8 27345.7 28508.4 28605.6 28713.0 29041.7 44501.6 44674.0 44928.0 45010.0 45095.5 334329.0 336979.0 337516.0 337915.0 338367.0 25586.4 26116.6 26398.0 26398.5 26578.5 43621.6 43683.0 43803.6 43854.6 44355.8 37601.4 37674.8 38107.2 38138.8 38261.4 37260.6 37274.8 38005.2 38068.4 38293.6 36512.0 36639.5 37329.3 37342.6 37623.8 32247.0 33071.3 34176.8 34303.1 34330.5 25499.0 26135.5 26268.3 26272.3 26441.9 22:20:28 INFO - PROCESS | 15837 | 22:20:28 INFO - PROCESS | 15837 | [#2] jquery.html Cycles:180 Average:23926.36 Median:27210.57 stddev:64494.17 (237.0%) stddev-sans-first:64650.81 22:20:28 INFO - PROCESS | 15837 | Values: 354.1 356.4 360.4 373.0 379.2 15699.6 16771.4 16831.9 17095.2 17165.8 15778.6 16374.9 17150.0 17163.9 17172.0 4924.4 5102.8 5129.2 5130.8 5131.7 3675.9 5018.7 5583.3 5887.7 5902.6 5843.9 5877.5 5930.1 5939.8 5957.2 5813.7 5951.9 5956.3 5957.4 5970.3 4516.3 5025.4 5175.6 5185.2 5191.7 11482.3 12731.9 18817.5 20229.2 20247.7 1774.3 1813.8 1920.0 1937.0 1995.0 8696.7 8766.1 8894.4 8931.5 9201.8 1592.9 1665.1 1722.7 1736.1 1787.9 65340.0 65886.0 67091.7 67111.7 67860.7 9917.8 10016.6 10027.9 10153.7 10244.8 13605.7 13610.4 13753.4 13767.4 13775.3 6756.2 6799.6 6974.7 7003.8 7127.6 6430.1 6453.8 6538.6 6634.6 6795.9 4261.0 4318.4 4352.7 4371.4 4435.3 1532.7 1575.9 1621.3 1622.7 1754.7 806.4 836.4 866.1 886.4 907.8 16195.9 16454.3 16733.7 16849.3 16943.0 826.6 840.5 852.0 889.0 910.3 9031.2 9445.2 9447.1 9528.7 9602.7 372063.0 387700.0 394390.0 399203.0 402283.0 71827.0 73169.6 75057.0 75224.0 76456.0 875.4 889.7 897.4 906.9 911.5 15009.9 15011.6 15054.9 15099.2 15244.0 34233.7 35106.8 36087.1 36615.5 36887.0 47665.8 48439.0 49496.8 49988.3 50604.7 7317.5 7382.7 7465.6 7597.8 7613.0 10910.5 11480.7 11744.1 11792.0 11962.9 9760.5 9807.0 10060.0 10103.5 10264.5 10307.3 10321.6 10383.8 10462.0 10523.6 9763.4 9793.9 9899.2 10354.9 10652.6 7477.8 7503.3 7646.8 7647.3 7664.8 9552.6 9618.1 9971.5 10083.0 10331.2 22:20:28 INFO - PROCESS | 15837 | 22:20:28 INFO - PROCESS | 15837 | [#3] mootools.html Cycles:180 Average:4918.34 Median:5573.97 stddev:2713.69 (48.7%) stddev-sans-first:2707.98 22:20:28 INFO - PROCESS | 15837 | Values: 1339.2 1379.1 1385.5 1585.7 1618.8 6518.0 7098.6 7241.7 7577.8 7591.2 7533.8 7543.9 7613.3 7617.6 7624.8 2195.8 2232.2 2236.2 2238.0 2238.6 2103.2 2104.8 2161.1 2167.2 2175.3 2139.3 2149.9 2161.5 2163.5 2215.4 2032.0 2045.3 2051.7 2058.0 2075.1 2036.3 2049.0 2071.0 2071.3 2075.3 7572.9 7686.9 7700.8 7738.6 7742.0 4153.1 4244.7 4269.4 4276.4 4283.3 2765.4 2779.4 2860.3 2897.5 2906.5 860.3 881.9 886.9 897.0 1785.5 9630.0 10022.3 10046.1 10106.4 10114.7 3726.0 3840.8 3899.0 3932.0 3967.0 7719.0 7753.3 7754.5 7783.8 7821.6 4360.8 4366.3 4367.3 4368.5 4383.1 3528.9 3866.6 4011.3 4022.2 4085.8 3275.2 3286.5 3345.7 3385.4 3413.8 983.0 984.6 995.2 1000.4 1015.8 755.5 765.0 794.0 829.7 847.6 4963.4 4989.4 5044.3 5081.2 5112.2 860.1 869.5 877.6 888.4 918.6 3373.8 3556.6 3558.6 3602.2 3630.5 8977.7 9123.2 9258.9 9283.8 9297.6 9104.6 9150.0 9191.1 9245.7 9249.2 6851.7 6880.1 6945.2 6948.4 6973.4 5199.1 5427.9 5497.8 5567.7 5580.2 8201.6 8466.8 8476.4 8616.9 8701.9 8094.5 8663.6 8673.4 8750.7 8808.7 5822.0 6410.7 6600.4 6612.5 6680.8 7219.1 7429.4 7438.7 7459.3 7502.8 6473.6 6635.2 6642.8 6678.1 6736.5 6676.3 6689.7 6767.8 6793.4 6798.4 5812.2 5888.1 5910.9 5911.9 5918.8 4330.3 4438.6 4449.2 4461.7 4471.9 4366.7 4442.2 4464.2 4468.7 4504.1 22:20:28 INFO - PROCESS | 15837 | 22:20:28 INFO - PROCESS | 15837 | [#4] prototype.html Cycles:180 Average:4446.69 Median:5125.64 stddev:1310.29 (25.6%) stddev-sans-first:1276.11 22:20:28 INFO - PROCESS | 15837 | Values: 280.8 285.3 287.2 287.9 289.4 5111.4 5124.7 5133.5 5163.5 5181.0 5032.8 5038.8 5053.1 5068.2 5134.2 3718.5 3804.6 3941.8 3942.2 3955.2 3854.3 3903.4 3905.8 3933.2 3939.0 3916.7 3947.5 3960.7 3973.4 3974.2 3842.4 3904.6 3934.4 3950.7 3962.3 3433.8 3438.5 3465.2 3475.8 3481.2 4914.5 4936.5 4951.3 4953.6 4965.4 4293.0 4505.6 4523.2 4556.8 4566.4 5254.4 5295.6 5320.1 5360.8 5401.5 3763.9 3787.6 3788.1 3788.9 3816.9 5355.5 5589.4 5600.3 5677.3 5690.1 3862.9 3895.8 3901.5 3908.6 3913.1 3951.4 3968.8 3969.2 3976.1 3985.1 4517.7 4531.2 4554.1 4566.8 4578.7 5202.3 5341.3 5369.8 5375.5 5396.8 1334.2 1343.3 1343.8 1349.4 1357.9 838.3 841.8 861.8 882.7 886.7 4568.2 4671.9 4695.8 4699.9 4713.5 5573.0 5575.9 5577.3 5582.0 5611.1 4433.3 4621.3 4662.7 4703.9 4721.4 2933.3 2978.7 2986.4 2989.0 2995.0 5228.2 5228.6 5229.9 5236.4 5246.5 5382.3 5641.7 5659.1 5661.3 5703.6 5194.4 5234.5 5253.8 5270.7 5275.0 5610.9 5617.0 5647.8 5671.5 5681.1 5224.9 5488.6 5518.6 5527.1 5557.8 5148.9 5216.6 5244.5 5245.9 5251.5 3872.4 3935.7 3939.4 3981.8 3996.7 5458.3 5481.9 5515.2 5528.7 5591.8 5311.9 5322.5 5343.9 5364.9 5385.9 5126.6 5323.4 5394.0 5394.3 5399.3 5232.6 5271.2 5294.8 5315.9 5325.9 5225.8 5269.5 5425.3 5431.7 5445.1 5310.6 5312.0 5324.4 5326.8 5337.3 22:20:28 INFO - PROCESS | 15837 | 22:20:28 INFO - PROCESS | 15837 | [#5] yui.html Cycles:180 Average:17007.69 Median:28077.70 stddev:23998.83 (85.5%) stddev-sans-first:24034.59 22:20:28 INFO - PROCESS | 15837 | Values: 617.8 659.4 661.8 664.2 716.4 12535.2 12824.7 12949.4 13004.7 13041.5 12199.2 12299.1 12302.8 12318.8 12332.9 625.8 764.2 775.4 781.7 794.2 776.0 776.3 777.5 780.5 780.6 811.0 813.6 816.2 819.9 820.2 797.7 801.2 803.2 806.7 806.8 583.3 586.6 587.4 587.7 588.8 12409.7 12499.7 12547.5 12571.9 12604.0 13060.2 13235.3 13306.3 13368.1 13617.1 10385.5 10391.9 10442.6 10445.7 10610.8 3259.2 3301.8 3310.9 3335.4 3358.7 57044.7 57078.0 57211.0 57288.0 58045.7 10612.8 10682.7 10714.1 10726.8 10795.1 19464.0 19675.7 19807.4 19815.0 19953.9 6251.0 6682.4 6804.8 6813.3 6818.2 3475.5 3511.6 3635.7 3652.1 3694.7 2727.6 2844.9 2845.8 3162.7 3327.5 576.5 578.2 584.6 586.8 587.5 421.7 429.5 457.2 474.2 474.3 7365.3 7473.8 7774.0 7825.4 7946.5 400.0 419.2 452.5 493.1 518.0 3555.8 3665.7 3726.5 3726.9 3745.1 85707.6 88693.1 88994.0 89762.6 92580.0 72949.3 81352.6 83358.6 84771.2 84966.6 73365.0 73921.0 75247.2 75980.2 76015.0 6981.6 7117.8 7257.6 7380.9 7405.1 39265.4 39902.4 40477.6 40723.0 41403.0 55637.4 60186.4 60811.0 60847.0 60872.7 7865.3 7909.6 7933.7 7953.4 8150.8 9583.3 9722.2 9726.4 9759.1 12829.9 12052.5 12469.6 12557.6 12679.9 13348.7 12290.6 12472.9 12684.1 13077.9 13100.9 12400.1 12560.2 12634.0 13070.4 13326.5 9826.7 9933.8 10081.4 10089.8 10251.7 9766.8 9887.4 9918.7 10057.6 10203.9 22:20:28 INFO - PROCESS | 15837 | -------- Summary: end -------- 22:20:28 INFO - PROCESS | 15837 | 22:20:29 INFO - TEST-INFO | 15837: exit 0 22:20:29 INFO - TEST-OK | dromaeo_css | took 1117791ms 22:20:29 INFO - TEST-START | kraken 22:20:29 INFO - operating with platform_type : linux_ 22:20:29 INFO - Initialising browser for kraken test... 22:20:29 INFO - TEST-INFO | started process 16071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwjlML3/profile http://localhost:34669/getInfo.html) 22:20:34 INFO - PROCESS | 16071 | __metrics Screen width/height:1600/1200 22:20:34 INFO - PROCESS | 16071 | colorDepth:24 22:20:34 INFO - PROCESS | 16071 | Browser inner width/height: 1024/697 22:20:34 INFO - PROCESS | 16071 | __metrics 22:20:35 ERROR - PROCESS | 16071 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 22:20:36 INFO - TEST-INFO | 16071: exit 0 22:20:36 INFO - Browser initialized. 22:20:36 INFO - Running cycle 1/1 for kraken test... 22:20:36 INFO - TEST-INFO | started process 16194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwjlML3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:48 INFO - PROCESS | 16194 | RSS: Main: 186560512 22:20:48 INFO - PROCESS | 16194 | 22:20:51 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34669/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:52 INFO - PROCESS | 16194 | RSS: Main: 191246336 22:20:52 INFO - PROCESS | 16194 | 22:20:55 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34669/tests/kraken/driver.html?testName=audio-dft) 22:20:55 INFO - PROCESS | 16194 | RSS: Main: 191578112 22:20:55 INFO - PROCESS | 16194 | 22:20:58 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34669/tests/kraken/driver.html?testName=audio-fft) 22:20:59 INFO - PROCESS | 16194 | RSS: Main: 186847232 22:20:59 INFO - PROCESS | 16194 | 22:21:01 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34669/tests/kraken/driver.html?testName=audio-oscillator) 22:21:02 INFO - PROCESS | 16194 | RSS: Main: 187404288 22:21:02 INFO - PROCESS | 16194 | 22:21:04 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34669/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:21:05 INFO - PROCESS | 16194 | RSS: Main: 188211200 22:21:05 INFO - PROCESS | 16194 | 22:21:08 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34669/tests/kraken/driver.html?testName=imaging-darkroom) 22:21:08 INFO - PROCESS | 16194 | RSS: Main: 188403712 22:21:08 INFO - PROCESS | 16194 | 22:21:12 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34669/tests/kraken/driver.html?testName=imaging-desaturate) 22:21:13 INFO - PROCESS | 16194 | RSS: Main: 185290752 22:21:13 INFO - PROCESS | 16194 | 22:21:15 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34669/tests/kraken/driver.html?testName=json-parse-financial) 22:21:16 INFO - PROCESS | 16194 | RSS: Main: 186507264 22:21:16 INFO - PROCESS | 16194 | 22:21:18 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34669/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:21:18 INFO - PROCESS | 16194 | RSS: Main: 187441152 22:21:18 INFO - PROCESS | 16194 | 22:21:20 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34669/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:21:21 INFO - PROCESS | 16194 | RSS: Main: 187711488 22:21:21 INFO - PROCESS | 16194 | 22:21:23 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34669/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:21:24 INFO - PROCESS | 16194 | RSS: Main: 187129856 22:21:24 INFO - PROCESS | 16194 | 22:21:27 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:27 INFO - PROCESS | 16194 | RSS: Main: 187494400 22:21:27 INFO - PROCESS | 16194 | 22:21:30 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:31 INFO - PROCESS | 16194 | RSS: Main: 187047936 22:21:31 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | Cycle 1(1): loaded http://localhost:34669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34669/tests/kraken/driver.html?testName=ai-astar) 22:21:33 INFO - PROCESS | 16194 | RSS: Main: 188338176 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | __start_tp_report 22:21:33 INFO - PROCESS | 16194 | _x_x_mozilla_page_load 22:21:33 INFO - PROCESS | 16194 | _x_x_mozilla_page_load_details 22:21:33 INFO - PROCESS | 16194 | |i|pagename|runs| 22:21:33 INFO - PROCESS | 16194 | |0;ai-astar;113;110;114;114;116;115;113;114;115;115 22:21:33 INFO - PROCESS | 16194 | |1;audio-beat-detection;154;130;155;182;140;157;154;136;198;131 22:21:33 INFO - PROCESS | 16194 | |2;audio-dft;164;165;168;165;164;161;160;163;163;163 22:21:33 INFO - PROCESS | 16194 | |3;audio-fft;77;76;76;171;77;81;75;77;166;76 22:21:33 INFO - PROCESS | 16194 | |4;audio-oscillator;87;87;164;87;86;87;136;87;87;145 22:21:33 INFO - PROCESS | 16194 | |5;imaging-gaussian-blur;118;118;119;118;117;117;118;117;118;117 22:21:33 INFO - PROCESS | 16194 | |6;imaging-darkroom;150;147;147;148;148;148;147;148;148;148 22:21:33 INFO - PROCESS | 16194 | |7;imaging-desaturate;96;95;95;95;95;96;96;95;96;96 22:21:33 INFO - PROCESS | 16194 | |8;json-parse-financial;67;64;66;66;65;64;65;64;64;65 22:21:33 INFO - PROCESS | 16194 | |9;json-stringify-tinderbox;64;64;66;65;66;65;65;65;67;66 22:21:33 INFO - PROCESS | 16194 | |10;stanford-crypto-aes;87;84;85;84;85;85;87;85;111;85 22:21:33 INFO - PROCESS | 16194 | |11;stanford-crypto-ccm;134;143;133;139;143;140;132;136;147;146 22:21:33 INFO - PROCESS | 16194 | |12;stanford-crypto-pbkdf2;184;177;178;176;175;173;176;177;172;172 22:21:33 INFO - PROCESS | 16194 | |13;stanford-crypto-sha256-iterative;69;74;69;70;68;68;68;67;68;68 22:21:33 INFO - PROCESS | 16194 | __end_tp_report 22:21:33 INFO - PROCESS | 16194 | __start_cc_report 22:21:33 INFO - PROCESS | 16194 | _x_x_mozilla_cycle_collect,975 22:21:33 INFO - PROCESS | 16194 | __end_cc_report 22:21:33 INFO - PROCESS | 16194 | __startTimestamp1466227293440__endTimestamp 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | ------- Summary: start ------- 22:21:33 INFO - PROCESS | 16194 | Number of tests: 14 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:1.66 (1.5%) stddev-sans-first:1.73 22:21:33 INFO - PROCESS | 16194 | Values: 113.0 110.0 114.0 114.0 116.0 115.0 113.0 114.0 115.0 115.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:154.50 stddev:22.00 (14.2%) stddev-sans-first:23.33 22:21:33 INFO - PROCESS | 16194 | Values: 154.0 130.0 155.0 182.0 140.0 157.0 154.0 136.0 198.0 131.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:2.22 (1.4%) stddev-sans-first:2.35 22:21:33 INFO - PROCESS | 16194 | Values: 164.0 165.0 168.0 165.0 164.0 161.0 160.0 163.0 163.0 163.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.50 stddev:38.68 (50.6%) stddev-sans-first:40.47 22:21:33 INFO - PROCESS | 16194 | Values: 77.0 76.0 76.0 171.0 77.0 81.0 75.0 77.0 166.0 76.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:87.00 stddev:30.45 (35.0%) stddev-sans-first:31.57 22:21:33 INFO - PROCESS | 16194 | Values: 87.0 87.0 164.0 87.0 86.0 87.0 136.0 87.0 87.0 145.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 22:21:33 INFO - PROCESS | 16194 | Values: 118.0 118.0 119.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.50 22:21:33 INFO - PROCESS | 16194 | Values: 150.0 147.0 147.0 148.0 148.0 148.0 147.0 148.0 148.0 148.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:21:33 INFO - PROCESS | 16194 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.05 (1.6%) stddev-sans-first:0.83 22:21:33 INFO - PROCESS | 16194 | Values: 67.0 64.0 66.0 66.0 65.0 64.0 65.0 64.0 64.0 65.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 22:21:33 INFO - PROCESS | 16194 | Values: 64.0 64.0 66.0 65.0 66.0 65.0 65.0 65.0 67.0 66.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:85.00 stddev:8.22 (9.7%) stddev-sans-first:8.71 22:21:33 INFO - PROCESS | 16194 | Values: 87.0 84.0 85.0 84.0 85.0 85.0 87.0 85.0 111.0 85.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:141.50 stddev:5.42 (3.8%) stddev-sans-first:5.40 22:21:33 INFO - PROCESS | 16194 | Values: 134.0 143.0 133.0 139.0 143.0 140.0 132.0 136.0 147.0 146.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:176.50 stddev:3.53 (2.0%) stddev-sans-first:2.26 22:21:33 INFO - PROCESS | 16194 | Values: 184.0 177.0 178.0 176.0 175.0 173.0 176.0 177.0 172.0 172.0 22:21:33 INFO - PROCESS | 16194 | 22:21:33 INFO - PROCESS | 16194 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:1.97 (2.9%) stddev-sans-first:2.09 22:21:33 INFO - PROCESS | 16194 | Values: 69.0 74.0 69.0 70.0 68.0 68.0 68.0 67.0 68.0 68.0 22:21:33 INFO - PROCESS | 16194 | -------- Summary: end -------- 22:21:33 INFO - PROCESS | 16194 | 22:21:34 INFO - TEST-INFO | 16194: exit 0 22:21:34 INFO - TEST-OK | kraken | took 65061ms 22:21:34 INFO - SUITE-END | took 1182s 22:21:34 INFO - Completed test suite (00:19:42) 22:21:34 INFO - javascript benchmark 22:21:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6312.424578970284, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2589.1196993022368, 2656.920292391229, 2673.144593730006, 2689.2604533753215, 2691.5828046652764, 4738.147133515966, 4784.521547845218, 4791.832285869995, 4894.632902532307, 4916.483769204236, 4704.317873908281, 4836.564709176174, 4843.443004054535, 4845.636577256702, 4889.877753056176, 4402.251617225072, 4437.312216606415, 4575.908481830362, 4579.702319349249, 4597.678162528624, 555.6179673485658, 4367.432233809616, 4424.3142312941545, 4433.911321773563, 4491.438570178728, 4429.867103986886, 4434.35701823237, 4478.865634030952, 4482.977585112086, 4530.79611417487, 4442.955570444286, 4448.955510444886, 4465.843695470676, 4471.530489298641, 4479.395281637003, 4311.655067594585, 4394.450693663292, 4406.757628330441, 4408.228560001987, 4413.889652758675, 4719.9292010619865, 4812.783424745895, 4833.734144622044, 4834.613230941516, 4845.515448455161, 5171.3535808024, 5221.39953905302, 5225.0, 5232.790688372461, 5296.020236256305, 5260.368755749335, 5297.841064768063, 5310.7610157543, 5326.786928522854, 5362.678239305654, 4908.803647854082, 4914.361133052752, 4917.65576409655, 4931.284963680247, 4949.851504454872, 5163.302954101148, 5290.365156181283, 5294.311739473844, 5324.387695415076, 5346.625736198429, 5147.1507201312115, 5165.483451654804, 5166.767495462713, 5169.198774189931, 5204.973975130176, 5238.135707608279, 5251.36983561975, 5260.9741100485035, 5262.2632831403635, 5310.230016647642, 5080.898382032413, 5127.410347809975, 5157.535821776059, 5167.354080739908, 5183.403908550489, 5166.173412254021, 5180.093483640348, 5186.559142472932, 5200.323957885451, 5200.92198617021, 4451.399061126771, 4451.710638808467, 4452.8218871245435, 4494.528074552125, 4503.639708823286, 3767.4348847672522, 3814.0655539392474, 3818.770873747584, 3843.8078096095082, 3864.9033774155873, 4359.237133501688, 4371.890702732457, 4425.690201685851, 4440.2007638625355, 4459.866204013885, 5182.97408512955, 5184.429712731597, 5196.1166601677805, 5227.973860130675, 5230.816921407809, 4364.323529852878, 4377.78111094444, 4403.889902752393, 4420.889477763081, 4469.754163520973, 4666.510016448224, 4684.039771846763, 4703.506131856174, 4706.88232794176, 4743.075100355398, 4783.23468245086, 4856.975715121402, 4866.124097662384, 4880.707157570557, 4919.311296418576, 5098.5411312982005, 5140.4859514049795, 5181.870453238699, 5243.370795504564, 5243.764030618555, 4911.165101932752, 4912.042151780369, 4913.213885778258, 4915.975420122876, 4952.950470495249, 5174.0, 5174.094533456555, 5179.663321884065, 5197.870053248699, 5199.324087868553, 5126.564242039469, 5209.817656382009, 5239.580833533232, 5275.340582427197, 5298.549623282064, 5080.974595127001, 5082.644214905069, 5104.770285337095, 5133.8716532087, 5152.716600587004, 4981.975090124526, 5119.155339369111, 5120.948790512196, 5134.743262836918, 5135.0, 4914.803407863788, 4960.702357858396, 4961.255811628284, 5001.0, 5025.597952163891, 5103.10695628271, 5139.563137133386, 5151.768170432265, 5153.45888681683, 5166.560842328294, 4901.58336541398, 4965.726885021214, 5031.144705400017, 5035.194368900959, 5050.217216331474], "value": 4744.004574239766, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.6452684312982, 566.7392999220359, 582.9650220986741, 594.2542109652387, 613.2242712968099, 36216.818915905416, 40400.0, 40432.79783601078, 40436.59563404362, 40666.39000414992, 38697.61302386975, 39204.0, 39278.41082383759, 39278.410823837665, 39432.80283598585, 7693.576853273082, 7952.085510166318, 7956.0, 7959.602019899011, 7967.043954725441, 7799.415043871704, 7807.921920780776, 7879.290863822283, 7907.327877130451, 7928.682852685914, 7874.055113386402, 7892.763217103496, 7897.012873390826, 7909.802254943644, 7979.321757650607, 7892.842143157133, 7961.800954976114, 7978.481398709066, 7981.082175549799, 7984.760457186294, 7883.645235964395, 7918.208179182036, 7954.204579542057, 7970.880436793453, 7975.920240797634, 38429.231415371534, 38609.22781544382, 38617.806910965264, 38666.80666596649, 38789.22421551582, 2537.6827896512937, 2826.7173282671774, 2911.8544072796276, 3323.4516304809677, 3694.353488139565, 27785.305367365978, 28162.15513534577, 28206.435871282665, 28406.147815565568, 28527.286817829514, 3343.3480471308103, 3357.6642335766473, 3509.298140371936, 3519.243362677011, 3531.4526248431534, 224410.0, 225762.0, 226095.0, 226139.0, 226422.0, 29509.85245073761, 30482.0, 32112.0, 32522.837385813393, 32668.18329541733, 32471.83764081212, 32820.343593128004, 33087.83456082753, 33159.668403316144, 33179.66820331814, 11796.351200683874, 11817.113716471298, 11907.226030308002, 11927.105467090003, 11933.164678472423, 11013.669589912315, 11126.776054633983, 11126.944365278121, 11149.05233055183, 11183.161262905314, 7874.976253087062, 7914.525128492309, 7931.881021784678, 7946.443748937634, 7979.3616510679, 3065.049834551296, 3068.3709839482854, 3080.152957936585, 3110.53341998702, 3140.446352788466, 875.1554749666602, 889.3107841422949, 936.4334577580602, 948.3077353531822, 965.1747755668943, 28723.28191795222, 28753.28116797055, 28869.422611547652, 28935.7106428933, 29629.0, 963.3689933093834, 1005.4068099820994, 1024.882138554076, 1041.2398948767443, 1068.6259809066764, 14833.92583037078, 15579.532614021597, 15660.0, 15762.527124186292, 15793.921030395004, 390542.0, 391620.0, 393139.0, 393220.0, 393709.0, 50066.247681331704, 50893.74553127211, 51307.0, 51307.486925131016, 51384.229236561485, 1125.6679279612533, 1168.4099529737598, 1171.9648410547697, 1176.823476478535, 1182.787098322293, 27345.72654273432, 28508.429831402842, 28605.570916436685, 28713.0, 29041.7095829039, 44501.554984449744, 44674.0, 44928.0, 45010.0, 45095.549044509135, 334329.0, 336979.0, 337516.0, 337915.0, 338367.0, 25586.360340991625, 26116.608250875874, 26398.0, 26398.472030559664, 26578.46843063089, 43621.56378436175, 43683.0, 43803.561964381224, 43854.561454385046, 44355.77822110869, 37601.4359784598, 37674.81162594169, 38107.23785524219, 38138.80930595329, 38261.42607860829, 37260.627393725714, 37274.813625931696, 38005.23989520139, 38068.42897356597, 38293.617063829006, 36512.0, 36639.45040824443, 37329.25341493101, 37342.62657373391, 37623.81188094042, 32247.03258902237, 33071.33857322888, 34176.82911585426, 34303.14242143966, 34330.48504272488, 25499.0, 26135.477290453706, 26268.343291417867, 26272.34319142037, 26441.901505266713], "value": 16414.109081847997, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.1005845153312, 356.42793316726653, 360.4251219305208, 373.0319820066929, 379.24340939825055, 15699.60750981226, 16771.41300054497, 16831.915840420796, 17095.230714617843, 17165.82834171658, 15778.605534861605, 16374.918125409386, 17150.0, 17163.91418042911, 17172.0, 4924.384451943498, 5102.846914592549, 5129.179331306992, 5130.820421285256, 5131.692098474085, 3675.871344502943, 5018.673786203904, 5583.302087239095, 5887.676177810219, 5902.6458412495385, 5843.941560584403, 5877.529797616202, 5930.080837470199, 5939.7921072762465, 5957.225560677128, 5813.7383817728305, 5951.880962380771, 5956.255468066492, 5957.434043765857, 5970.34326224115, 4516.254817955033, 5025.447200807908, 5175.576716402981, 5185.248139019821, 5191.740412979336, 11482.311061336262, 12731.936340318332, 18817.52956176093, 20229.190832366687, 20247.696284555597, 1774.2814160265114, 1813.7823461184742, 1919.9616007679908, 1936.9515762105918, 1994.980050199494, 8696.695615653485, 8766.123387661246, 8894.377393582452, 8931.50876701781, 9201.769955751093, 1592.928318225671, 1665.1091665958654, 1722.664080504302, 1736.0625262358312, 1787.9106044697844, 65340.0, 65886.0, 67091.66454167747, 67111.66444167748, 67860.6606966962, 9917.752056198653, 10016.599336026624, 10027.949860250797, 10153.695389138338, 10244.846327305097, 13605.659858503419, 13610.387532561059, 13753.38109785062, 13767.38046787897, 13775.311234438239, 6756.155480564929, 6799.558028728117, 6974.721011159497, 7003.789886303419, 7127.60798156096, 6430.131932189188, 6453.838654033593, 6538.640374779337, 6634.635095069818, 6795.93204067953, 4261.0, 4318.438602981592, 4352.717073390283, 4371.431713877176, 4435.268180750205, 1532.7394342961722, 1575.8975666581634, 1621.2866338810886, 1622.732249178896, 1754.7455618935182, 806.4435539477741, 836.3810780022861, 866.081953129672, 886.4061079077034, 907.8017017536788, 16195.919020405057, 16454.259558319904, 16733.66532669364, 16849.326026958784, 16943.0, 826.5949684654596, 840.5167028958373, 851.9787005324916, 888.9866652000226, 910.2808781063019, 9031.232345250595, 9445.19715824149, 9447.102525260227, 9528.666496672584, 9602.66390676323, 372063.0, 387700.0, 394390.0, 399203.0, 402283.0, 71827.0, 73169.6341518289, 75057.0, 75224.0, 76456.0, 875.3566128895256, 889.7063968890251, 897.3942588752566, 906.8639704044446, 911.544227886057, 15009.924950375178, 15011.624709382353, 15054.924725376302, 15099.245037747849, 15244.0, 34233.657663423044, 35106.82446587751, 36087.09782255465, 36615.45076823796, 36887.0, 47665.761671192806, 48439.0, 49496.75251623719, 49988.25017624811, 50604.74697626635, 7317.524360916736, 7382.704691812267, 7465.552066876005, 7597.810054748676, 7613.010308659839, 10910.509027093642, 11480.655580332603, 11744.119191060534, 11792.0, 11962.940185299018, 9760.46317452547, 9807.0, 10060.0, 10103.49482525856, 10264.486775661337, 10307.330023548446, 10321.587136514456, 10383.844242336521, 10462.0, 10523.579056837947, 9763.36538125048, 9793.902060979584, 9899.1585715215, 10354.948225258826, 10652.62715804943, 7477.813054673459, 7503.287187717158, 7646.770596882103, 7647.311741943252, 7664.80837979055, 9552.57013434411, 9618.086281803218, 9971.451570163421, 10083.0, 10331.22515811302], "value": 8029.980648036612, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.189790176943, 1379.144930143311, 1385.5427708856073, 1585.6987172437236, 1618.8381161883806, 6517.967410162954, 7098.645067746611, 7241.746538871141, 7577.810554736135, 7591.202923693016, 7533.773986780392, 7543.8868416973655, 7613.314801667849, 7617.619119044053, 7624.809379765508, 2195.791399817019, 2232.2075663139594, 2236.1502629000956, 2237.9888100559474, 2238.608243557379, 2103.2112957640884, 2104.8105670489654, 2161.103142195987, 2167.241465487075, 2175.3473957812594, 2139.3047259640603, 2149.924752633658, 2161.5244646177816, 2163.459135216196, 2215.3796936857707, 2032.0347834778436, 2045.3045964372036, 2051.7435320584927, 2058.0430100003496, 2075.1491888325713, 2036.297477370305, 2048.98975505123, 2071.0473182336145, 2071.337172104927, 2075.2632815350635, 7572.864070389431, 7686.923130768677, 7700.768976930645, 7738.61306934651, 7741.961290193569, 4153.086321009373, 4244.660427165819, 4269.402283680256, 4276.3799249109015, 4283.271843786564, 2765.363966287765, 2779.374640705825, 2860.3278229616026, 2897.478453878322, 2906.549484829855, 860.2878578931889, 881.8544940084878, 886.8758373827604, 896.9551522423918, 1785.4643606917873, 9630.036996300383, 10022.298439109265, 10046.146077583415, 10106.39361638304, 10114.747131321703, 3725.962740372616, 3840.807959602009, 3898.9805050975133, 3931.9803400983383, 3967.0, 7718.96140519305, 7753.302202801775, 7754.534727916343, 7783.805404864924, 7821.5698136601895, 4360.7819609019425, 4366.257736184856, 4367.344898265222, 4368.5194628590825, 4383.057642606855, 3528.8588456461966, 3866.6326698963553, 4011.3180759270995, 4022.235775202702, 4085.7957102144774, 3275.1648329676254, 3286.52345409919, 3345.7193446220895, 3385.441402168664, 3413.761036727405, 982.9557669904872, 984.5766320482118, 995.2485873165714, 1000.3697670467704, 1015.7765291635976, 755.5391211361066, 765.0054928592807, 793.9563324017234, 829.7261903571807, 847.576211894053, 4963.404391472975, 4989.376327959005, 5044.344235249394, 5081.212412076134, 5112.207607820794, 860.1140824950311, 869.4783130121876, 877.622622272429, 888.440282621957, 918.5774543709969, 3373.785437242591, 3556.644335566474, 3558.626344233818, 3602.225521512887, 3630.455431685268, 8977.730668079968, 9123.17891389765, 9258.907410925805, 9283.76790580241, 9297.628094876129, 9104.635814567475, 9150.03924587922, 9191.08089191089, 9245.72262832116, 9249.16757491829, 6851.725930962705, 6880.071190389233, 6945.166580010431, 6948.374646281758, 6973.372396484239, 5199.11615025439, 5427.945720542744, 5497.8075767347955, 5567.721613919369, 5580.218769372373, 8201.630926608435, 8466.830663386574, 8476.36427267945, 8616.913830861862, 8701.8694719578, 8094.5143291400345, 8663.566821659018, 8673.392862499817, 8750.69372571957, 8808.735737927873, 5821.970890145692, 6410.743570257324, 6600.405963463311, 6612.50406219545, 6680.766173183915, 7219.0976127984, 7429.368503677248, 7438.73964411243, 7459.328660420588, 7502.774916752288, 6473.643949582818, 6635.2037755469655, 6642.833929151617, 6678.098456708282, 6736.528443008942, 6676.265610782907, 6689.69896354675, 6767.830804229934, 6793.354631310018, 6798.3773665473045, 5812.244408226903, 5888.057910734262, 5910.940890591039, 5911.852203694942, 5918.822435326947, 4330.328799036154, 4438.578335058164, 4449.243628583214, 4461.665375096816, 4471.932921006122, 4366.737995720267, 4442.244818380818, 4464.196444639866, 4468.731876087445, 4504.076664283749], "value": 3988.577128915663, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.7669634203611, 285.2810916490444, 287.1829644660939, 287.88772378772285, 289.38938839049587, 5111.437741848398, 5124.66689665172, 5133.459962011396, 5163.535281824635, 5181.0, 5032.766972091834, 5038.7984480620735, 5053.115704751672, 5068.163752980754, 5134.229865520165, 3718.456840411226, 3804.6385593368586, 3941.7634941903434, 3942.2115576884594, 3955.189186216833, 3854.2676891390547, 3903.375459926398, 3905.7656540607654, 3933.174033452978, 3938.991114531595, 3916.706247031484, 3947.5262968443826, 3960.7029472789513, 3973.423853541249, 3974.2051589682032, 3842.4428457873732, 3904.629060239273, 3934.3836348827995, 3950.743201691881, 3962.3065963456424, 3433.8111403872776, 3438.5186073949667, 3465.203003309253, 3475.791452512857, 3481.1723844981334, 4914.508549145093, 4936.456989731127, 4951.331570238008, 4953.6037117030555, 4965.4358876954, 4293.0, 4505.639548836085, 4523.163214805239, 4556.840510582147, 4566.40636717228, 5254.395744489356, 5295.616972362413, 5320.148776195829, 5360.812371567015, 5401.4868587484125, 3763.924721505582, 3787.5644300905196, 3788.109794198361, 3788.886333410002, 3816.9427458588143, 5355.464453554691, 5589.35722391922, 5600.327960644708, 5677.318721753375, 5690.089585666315, 3862.942055869164, 3895.7662540247675, 3901.45379646844, 3908.550516690617, 3913.1195481016543, 3951.407288906687, 3968.8214030368704, 3969.186316805048, 3976.1451287973223, 3985.103351745834, 4517.706349087299, 4531.229690952546, 4554.134714404253, 4566.794494247701, 4578.748168850745, 5202.297689811902, 5341.278927344759, 5369.838904832784, 5375.489328513785, 5396.83809485716, 1334.1994803118246, 1343.3081962789172, 1343.8320209973754, 1349.3657980749033, 1357.945682172702, 838.2916435611899, 841.7735090685104, 861.7759382560454, 882.6557642519423, 886.6542048601051, 4568.177728008924, 4671.929921051187, 4695.80257034454, 4699.929501057487, 4713.468122860084, 5572.972135139298, 5575.940571291441, 5577.3028371453565, 5582.0, 5611.102223644198, 4433.334999750064, 4621.3068039793625, 4662.673612847136, 4703.905921881543, 4721.386219791474, 2933.2960089578346, 2978.687237840039, 2986.3728616990243, 2989.0, 2994.970050299469, 5228.241904923765, 5228.58171346299, 5229.9341760005345, 5236.371635403776, 5246.475352464723, 5382.273393091882, 5641.661500309994, 5659.122835960433, 5661.2923384576925, 5703.62926409782, 5194.428612852583, 5234.450382709837, 5253.763580638957, 5270.657407268515, 5274.973625131926, 5610.933922554702, 5617.0, 5647.802326918538, 5671.546276297804, 5681.0910254359105, 5224.921626175535, 5488.588355873405, 5518.613697041329, 5527.115661494303, 5557.805476808292, 5148.948510514847, 5216.582673386196, 5244.475552444877, 5245.947540524546, 5251.501107394792, 3872.438496417947, 3935.704822138294, 3939.3893946438347, 3981.8407263709128, 3996.7202295840175, 5458.2904222450825, 5481.917771233355, 5515.172724091419, 5528.695921724183, 5591.84713885149, 5311.946880531145, 5322.547583455294, 5343.9465605345, 5364.90768600254, 5385.919211211756, 5126.615503837302, 5323.414424413389, 5393.9730301348245, 5394.271773310553, 5399.325084364455, 5232.607554433509, 5271.235670827632, 5294.8411547652095, 5315.867103322448, 5325.9467405327005, 5225.790968361375, 5269.525742683177, 5425.267588875609, 5431.6740995540395, 5445.101558243004, 5310.5836844236555, 5311.973440132774, 5324.440933702061, 5326.813561525328, 5337.306150200449], "value": 4017.114024759141, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.8177437655891, 659.4262991197659, 661.7716887673753, 664.1598378051768, 716.3588588213549, 12535.247885126899, 12824.67938301543, 12949.41727622257, 13004.674883127938, 13041.478340866353, 12199.207051541644, 12299.139060265785, 12302.815457768118, 12318.81521777174, 12332.93833530831, 625.7966160997694, 764.2395816162925, 775.371948721536, 781.679511400326, 794.2216627704853, 775.9922400776005, 776.320719370548, 777.4596655324551, 780.5277806926813, 780.6096951524238, 810.9797255068612, 813.5810057820228, 816.1675091406762, 819.8934138561979, 820.1839170025833, 797.6769408389582, 801.2428255298745, 803.2409373142383, 806.6531391501652, 806.8305655812258, 583.2854752927672, 586.633354153654, 587.4477990688781, 587.7149582452507, 588.7733222709245, 12409.689757756038, 12499.687507812287, 12547.498100075985, 12571.874281257162, 12604.0, 13060.151090179108, 13235.272060036694, 13306.334683265797, 13368.131071480322, 13617.114887532278, 10385.480725963671, 10391.896081039169, 10442.582296708122, 10445.738856528571, 10610.840837387444, 3259.2177877309514, 3301.7853839500594, 3310.8841190558455, 3335.382954153489, 3358.748093892968, 57044.71477642627, 57078.0, 57210.999999999585, 57288.0, 58045.70977145129, 10612.787744245226, 10682.679519614425, 10714.142868570496, 10726.785464290826, 10795.082417994558, 19464.0, 19675.704864427044, 19807.405777826687, 19815.0, 19953.900230498755, 6250.968745156245, 6682.431993280626, 6804.8298792529595, 6813.2846051163915, 6818.215905170969, 3475.530803341567, 3511.596166440841, 3635.690966267844, 3652.086978255436, 3694.704423646102, 2727.5908613707707, 2844.928876778056, 2845.7865660075577, 3162.7153556180056, 3327.517509961042, 576.533008263308, 578.23672751967, 584.6053913608297, 586.8180863932195, 587.4712758517284, 421.7490593097102, 429.48247361929424, 457.2409799732428, 474.1891365764581, 474.3288247130272, 7365.300296471826, 7473.775786726298, 7774.0, 7825.37397008238, 7946.483478573874, 399.99600003999586, 419.16795161604193, 452.5112878091653, 493.1468559392271, 517.9507946745128, 3555.839987200582, 3665.651763082503, 3726.459663348799, 3726.925461490809, 3745.138618117848, 85707.57146214353, 88693.11306886977, 88994.0, 89762.55118724496, 92580.0, 72949.27050729531, 81352.59323703461, 83358.58320708357, 84771.15228847633, 84966.57516712377, 73365.0, 73921.0, 75247.24752752403, 75980.24019759842, 76015.0, 6981.581105133709, 7117.75087871922, 7257.600831954293, 7380.926190738024, 7405.148407932941, 39265.411018834166, 39902.40146397865, 40477.595224047385, 40723.0, 41403.0, 55637.44362556485, 60186.39813601808, 60811.0, 60847.0, 60872.69563652154, 7865.252800983897, 7909.564973926489, 7933.722319719013, 7953.363730901629, 8150.83698326042, 9583.329166958525, 9722.173615242784, 9726.36778609388, 9759.12167904892, 12829.93585032069, 12052.457639406073, 12469.625911222678, 12557.623271301876, 12679.858812706902, 13348.733025339634, 12290.631281061582, 12472.937635311766, 12684.112112152061, 13077.869221307665, 13100.934495327463, 12400.13199076056, 12560.246385216917, 12634.0, 13070.411831467416, 13326.500251264924, 9826.65606703762, 9933.801323973625, 10081.445520496443, 10089.848652270075, 10251.7437064074, 9766.80466390654, 9887.357321774061, 9918.717870577859, 10057.647982320876, 10203.928587498503], "value": 6314.269229023582, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 114.0, 114.0, 116.0, 115.0, 113.0, 114.0, 115.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 155.0, 182.0, 140.0, 157.0, 154.0, 136.0, 198.0, 131.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 168.0, 165.0, 164.0, 161.0, 160.0, 163.0, 163.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 171.0, 77.0, 81.0, 75.0, 77.0, 166.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 164.0, 87.0, 86.0, 87.0, 136.0, 87.0, 87.0, 145.0], "value": 105.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 66.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 67.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 84.0, 85.0, 85.0, 87.0, 85.0, 111.0, 85.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 143.0, 133.0, 139.0, 143.0, 140.0, 132.0, 136.0, 147.0, 146.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 177.0, 178.0, 176.0, 175.0, 173.0, 176.0, 177.0, 172.0, 172.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 69.0, 70.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "value": 68.9, "unit": "score"}]}]} 22:21:34 INFO - Return code: 0 22:21:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:21:34 ERROR - # TBPL SUCCESS # 22:21:34 INFO - Running post-action listener: _resource_record_post_action 22:21:34 INFO - ##### 22:21:34 INFO - ##### Finished run-tests step (success) 22:21:34 INFO - ##### 22:21:34 INFO - Running post-run listener: _resource_record_post_run 22:21:34 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 544026624; Read time: 0; Write time: 574932 22:21:34 INFO - TinderboxPrint: CPU usage
13.4% 22:21:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:21:34 INFO - TinderboxPrint: I/O write bytes / time
544,026,624 / 574,932 22:21:34 INFO - TinderboxPrint: CPU idle
8,284.3 (86.5%) 22:21:34 INFO - TinderboxPrint: CPU user
1,231.2 (12.9%) 22:21:34 INFO - TinderboxPrint: Swap in / out
0 / 0 22:21:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245858304; Read time: 0; Write time: 282072 22:21:34 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 298168320; Read time: 0; Write time: 292860 22:21:35 INFO - Running post-run listener: _upload_blobber_files 22:21:35 INFO - Blob upload gear active. 22:21:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:21:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:21:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:21:35 INFO - (blobuploader) - INFO - Open directory for files ... 22:21:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:21:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:39 INFO - (blobuploader) - INFO - Done attempting. 22:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:39 INFO - (blobuploader) - INFO - Done attempting. 22:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:21:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:40 INFO - (blobuploader) - INFO - Done attempting. 22:21:40 INFO - (blobuploader) - INFO - Iteration through files over. 22:21:40 INFO - Return code: 0 22:21:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:21:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:21:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c24e2283446af774bfd091177d5720ad9602bdbf51ce3fb56308273ec86c4f4e63b95661da3fe73acbb96f83f79fad3e366b8cb24c2b9d5e1ccedde5a0459576", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6cf3877c31a84576ce0dc7f0b1555ca3d2f4944695203a96990abc8dd2b7e5e6f23322841b89b9ef9fab97199378951643f6de6bf7f4d5800b17368dda76dbc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6cf497cd507fe36ae6e66d8d2bdb33c6a58194a5dfe39ae795a014f7a3b806711b537c46cf17263ad5039797c73fa516863031e2375d8c4e0dae404006d4727"} 22:21:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:21:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:21:40 INFO - Contents: 22:21:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c24e2283446af774bfd091177d5720ad9602bdbf51ce3fb56308273ec86c4f4e63b95661da3fe73acbb96f83f79fad3e366b8cb24c2b9d5e1ccedde5a0459576", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6cf3877c31a84576ce0dc7f0b1555ca3d2f4944695203a96990abc8dd2b7e5e6f23322841b89b9ef9fab97199378951643f6de6bf7f4d5800b17368dda76dbc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6cf497cd507fe36ae6e66d8d2bdb33c6a58194a5dfe39ae795a014f7a3b806711b537c46cf17263ad5039797c73fa516863031e2375d8c4e0dae404006d4727"} 22:21:40 INFO - Running post-run listener: copy_logs_to_upload_dir 22:21:40 INFO - Copying logs to upload dir... 22:21:40 INFO - mkdir: /builds/slave/test/build/upload/logs 22:21:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.925707 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-17 22:21:40.169026) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 22:21:40.172904) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c24e2283446af774bfd091177d5720ad9602bdbf51ce3fb56308273ec86c4f4e63b95661da3fe73acbb96f83f79fad3e366b8cb24c2b9d5e1ccedde5a0459576", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6cf3877c31a84576ce0dc7f0b1555ca3d2f4944695203a96990abc8dd2b7e5e6f23322841b89b9ef9fab97199378951643f6de6bf7f4d5800b17368dda76dbc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6cf497cd507fe36ae6e66d8d2bdb33c6a58194a5dfe39ae795a014f7a3b806711b537c46cf17263ad5039797c73fa516863031e2375d8c4e0dae404006d4727"} build_url:https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011530 build_url: 'https://queue.taskcluster.net/v1/task/el0TtMs7RuC0U8ZBejxYCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c24e2283446af774bfd091177d5720ad9602bdbf51ce3fb56308273ec86c4f4e63b95661da3fe73acbb96f83f79fad3e366b8cb24c2b9d5e1ccedde5a0459576", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6cf3877c31a84576ce0dc7f0b1555ca3d2f4944695203a96990abc8dd2b7e5e6f23322841b89b9ef9fab97199378951643f6de6bf7f4d5800b17368dda76dbc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6cf497cd507fe36ae6e66d8d2bdb33c6a58194a5dfe39ae795a014f7a3b806711b537c46cf17263ad5039797c73fa516863031e2375d8c4e0dae404006d4727"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 22:21:40.198695) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 22:21:40.199016) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466207143.901259-1521688278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 22:21:40.284049) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 22:21:40.284526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 22:21:40.285002) ========= ========= Total master_lag: 0.18 =========