builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1467081133.41 results: success (0) buildid: 20160627191221 builduid: 39d7d20612ab4de3ab0ad00344ea2c7f revision: 0546e2201cab3ce639ee0d695c2b9a422c16c976 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:13.406412) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:13.406957) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:13.407258) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:13.422225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:13.422572) ========= 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=523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 19:32:13-- 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% 45.9M=0s 2016-06-27 19:32:13 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132540 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:13.572363) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:13.573010) ========= 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=523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014502 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:13.623385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:13.623767) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0546e2201cab3ce639ee0d695c2b9a422c16c976 --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 0546e2201cab3ce639ee0d695c2b9a422c16c976 --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=523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 19:32:13,899 truncating revision to first 12 chars 2016-06-27 19:32:13,899 Setting DEBUG logging. 2016-06-27 19:32:13,899 attempt 1/10 2016-06-27 19:32:13,899 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0546e2201cab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 19:32:14,214 unpacking tar archive at: fx-team-0546e2201cab/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635257 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:14.273005) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:14.273346) ========= script_repo_revision: 0546e2201cab3ce639ee0d695c2b9a422c16c976 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:14.273788) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:14.274055) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 19:32:14.283384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-27 19:32:14.283698) ========= /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=523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:32:14 INFO - MultiFileLogger online at 20160627 19:32:14 in /builds/slave/test 19:32:14 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 19:32:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:32:14 INFO - {'append_to_log': False, 19:32:14 INFO - 'base_work_dir': '/builds/slave/test', 19:32:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:32:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:32:14 INFO - 'branch': 'Fx-Team-Non-PGO', 19:32:14 INFO - 'buildbot_json_path': 'buildprops.json', 19:32:14 INFO - 'config_files': ('talos/linux_config.py',), 19:32:14 INFO - 'default_actions': ('clobber', 19:32:14 INFO - 'read-buildbot-config', 19:32:14 INFO - 'download-and-extract', 19:32:14 INFO - 'populate-webroot', 19:32:14 INFO - 'create-virtualenv', 19:32:14 INFO - 'install', 19:32:14 INFO - 'run-tests'), 19:32:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:32:14 INFO - 'download_minidump_stackwalk': True, 19:32:14 INFO - 'download_symbols': 'ondemand', 19:32:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:32:14 INFO - 'tooltool.py': '/tools/tooltool.py', 19:32:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:32:14 INFO - '/tools/misc-python/virtualenv.py')}, 19:32:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:32:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:32:14 INFO - 'installer_path': 'installer.exe', 19:32:14 INFO - 'log_level': 'info', 19:32:14 INFO - 'log_name': 'talos', 19:32:14 INFO - 'log_to_console': True, 19:32:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:32:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:32:14 INFO - 'opt_config_files': (), 19:32:14 INFO - 'pip_index': False, 19:32:14 INFO - 'sps_profile': False, 19:32:14 INFO - 'sps_profile_interval': 0, 19:32:14 INFO - 'suite': 'dromaeojs-e10s', 19:32:14 INFO - 'system_bits': '32', 19:32:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:32:14 INFO - 'title': 'talos-linux64-ix-065', 19:32:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:32:14 INFO - 'use_talos_json': True, 19:32:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:32:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:32:14 INFO - 'work_dir': 'build'} 19:32:14 INFO - ##### 19:32:14 INFO - ##### Running clobber step. 19:32:14 INFO - ##### 19:32:14 INFO - Running pre-action listener: _resource_record_pre_action 19:32:14 INFO - Running main action method: clobber 19:32:14 INFO - rmtree: /builds/slave/test/build 19:32:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:32:15 INFO - Running post-action listener: _resource_record_post_action 19:32:15 INFO - ##### 19:32:15 INFO - ##### Finished clobber step (success) 19:32:15 INFO - ##### 19:32:15 INFO - ##### 19:32:15 INFO - ##### Running read-buildbot-config step. 19:32:15 INFO - ##### 19:32:15 INFO - Running pre-action listener: _resource_record_pre_action 19:32:15 INFO - Running main action method: read_buildbot_config 19:32:15 INFO - Using buildbot properties: 19:32:15 INFO - { 19:32:15 INFO - "project": "", 19:32:15 INFO - "product": "firefox", 19:32:15 INFO - "script_repo_revision": "production", 19:32:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:32:15 INFO - "repository": "", 19:32:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 19:32:15 INFO - "buildid": "20160627191221", 19:32:15 INFO - "pgo_build": "False", 19:32:15 INFO - "basedir": "/builds/slave/test", 19:32:15 INFO - "buildnumber": 1439, 19:32:15 INFO - "slavename": "talos-linux64-ix-065", 19:32:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:32:15 INFO - "platform": "ubuntu64_hw", 19:32:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:32:15 INFO - "branch": "fx-team", 19:32:15 INFO - "repo_path": "integration/fx-team", 19:32:15 INFO - "revision": "0546e2201cab3ce639ee0d695c2b9a422c16c976", 19:32:15 INFO - "stage_platform": "linux64", 19:32:15 INFO - "builduid": "39d7d20612ab4de3ab0ad00344ea2c7f", 19:32:15 INFO - "slavebuilddir": "test" 19:32:15 INFO - } 19:32:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:32:15 INFO - Running post-action listener: _resource_record_post_action 19:32:15 INFO - ##### 19:32:15 INFO - ##### Finished read-buildbot-config step (success) 19:32:15 INFO - ##### 19:32:15 INFO - ##### 19:32:15 INFO - ##### Running download-and-extract step. 19:32:15 INFO - ##### 19:32:15 INFO - Running pre-action listener: _resource_record_pre_action 19:32:15 INFO - Running main action method: download_and_extract 19:32:15 INFO - mkdir: /builds/slave/test/build/tests 19:32: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')]} 19:32:15 INFO - https://queue.taskcluster.net/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/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 19:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/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 19:32:16 INFO - Downloaded 1361 bytes. 19:32:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:32:16 INFO - Using the following test package requirements: 19:32:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:32:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:32:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:32:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:16 INFO - u'jsshell-linux-x86_64.zip'], 19:32:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:32:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:32:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:32:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:32:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:32:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:32:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:32:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:16 INFO - https://queue.taskcluster.net/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/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 19:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/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 19:32:17 INFO - Downloaded 22713809 bytes. 19:32:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:32:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:32:18 INFO - Return code: 0 19:32:18 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 19:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:18 INFO - https://queue.taskcluster.net/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:32:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:32:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:32:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/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 19:32:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/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 19:32:19 INFO - Downloaded 22713809 bytes. 19:32:19 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'] 19:32:19 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 19:32:21 INFO - Return code: 0 19:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:21 INFO - https://queue.taskcluster.net/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:32:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:32:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:32:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/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 19:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/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 19:32:21 INFO - Downloaded 14405245 bytes. 19:32:21 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'] 19:32:21 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 19:32:22 INFO - Return code: 0 19:32:22 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')]} 19:32:22 INFO - https://queue.taskcluster.net/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:32:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:32:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:32:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/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 19:32:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IvPY60H9Q7iFVD5qmRP5JA/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 19:32:23 INFO - Downloaded 56386303 bytes. 19:32:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:32:23 INFO - mkdir: /builds/slave/test/properties 19:32:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:32:23 INFO - Writing to file /builds/slave/test/properties/build_url 19:32:23 INFO - Contents: 19:32:23 INFO - build_url:https://queue.taskcluster.net/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:32:24 INFO - Running post-action listener: _resource_record_post_action 19:32:24 INFO - Running post-action listener: set_extra_try_arguments 19:32:24 INFO - ##### 19:32:24 INFO - ##### Finished download-and-extract step (success) 19:32:24 INFO - ##### 19:32:24 INFO - ##### 19:32:24 INFO - ##### Running populate-webroot step. 19:32:24 INFO - ##### 19:32:24 INFO - Running pre-action listener: _resource_record_pre_action 19:32:24 INFO - Running main action method: populate_webroot 19:32:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:32:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:32:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:32:24 INFO - '--tppagecycles', 19:32:24 INFO - '7'], 19:32:24 INFO - 'tests': ['tsvgm']}}, 19:32:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:32:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:32:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:32:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:32:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:32:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:32:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:24 INFO - 'talos_options': ['--disable-e10s'], 19:32:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:24 INFO - 'talos_options': ['--disable-e10s'], 19:32:24 INFO - 'tests': ['damp', 'tps']}, 19:32:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:24 INFO - 'tests': ['damp', 'tps']}, 19:32:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:32:24 INFO - 'tests': ['dromaeo_dom']}, 19:32:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:32:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:32:24 INFO - 'tests': ['basic_compositor_video']}, 19:32:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:32:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:32:24 INFO - 'tests': ['a11yr', 19:32:24 INFO - 'ts_paint', 19:32:24 INFO - 'tpaint', 19:32:24 INFO - 'sessionrestore', 19:32:24 INFO - 'sessionrestore_no_auto_restore', 19:32:24 INFO - 'tabpaint']}, 19:32:24 INFO - 'other-e10s': {'tests': ['a11yr', 19:32:24 INFO - 'ts_paint', 19:32:24 INFO - 'tpaint', 19:32:24 INFO - 'sessionrestore', 19:32:24 INFO - 'sessionrestore_no_auto_restore', 19:32:24 INFO - 'tabpaint']}, 19:32:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:32:24 INFO - 'ts_paint', 19:32:24 INFO - 'tpaint', 19:32:24 INFO - 'sessionrestore', 19:32:24 INFO - 'sessionrestore_no_auto_restore', 19:32:24 INFO - 'tabpaint']}, 19:32:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:32:24 INFO - 'ts_paint', 19:32:24 INFO - 'tpaint', 19:32:24 INFO - 'sessionrestore', 19:32:24 INFO - 'sessionrestore_no_auto_restore', 19:32:24 INFO - 'tabpaint']}, 19:32:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:32:24 INFO - 'tests': ['a11yr', 19:32:24 INFO - 'ts_paint', 19:32:24 INFO - 'tpaint', 19:32:24 INFO - 'sessionrestore', 19:32:24 INFO - 'sessionrestore_no_auto_restore', 19:32:24 INFO - 'tabpaint']}, 19:32:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:32:24 INFO - 'tests': ['a11yr', 19:32:24 INFO - 'ts_paint', 19:32:24 INFO - 'tpaint', 19:32:24 INFO - 'sessionrestore', 19:32:24 INFO - 'sessionrestore_no_auto_restore', 19:32:24 INFO - 'tabpaint']}, 19:32:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:32:24 INFO - 'tests': ['tsvgx', 19:32:24 INFO - 'tsvgr_opacity', 19:32:24 INFO - 'tart', 19:32:24 INFO - 'tscrollx', 19:32:24 INFO - 'cart']}, 19:32:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:32:24 INFO - 'tsvgr_opacity', 19:32:24 INFO - 'tart', 19:32:24 INFO - 'tscrollx', 19:32:24 INFO - 'cart']}, 19:32:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:24 INFO - 'talos_options': ['--disable-e10s'], 19:32:24 INFO - 'tests': ['tp5o']}, 19:32:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:24 INFO - 'tests': ['tp5o']}, 19:32:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:24 INFO - 'talos_options': ['--disable-e10s', 19:32:24 INFO - '--xperf_path', 19:32:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:24 INFO - 'tests': ['tp5n']}, 19:32:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:32:24 INFO - 'talos_options': ['--xperf_path', 19:32:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:24 INFO - 'tests': ['tp5n']}}, 19:32:24 INFO - 'talos.zip': {'path': '', 19:32:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:32:24 INFO - Running post-action listener: _resource_record_post_action 19:32:24 INFO - ##### 19:32:24 INFO - ##### Finished populate-webroot step (success) 19:32:24 INFO - ##### 19:32:24 INFO - ##### 19:32:24 INFO - ##### Running create-virtualenv step. 19:32:24 INFO - ##### 19:32:24 INFO - Running pre-action listener: _resource_record_pre_action 19:32:24 INFO - Running main action method: create_virtualenv 19:32:24 INFO - Creating virtualenv /builds/slave/test/build/venv 19:32:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:32:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:32:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:32:24 INFO - Using real prefix '/usr' 19:32:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:32:24 INFO - Installing distribute.............................................................................................................................................................................................done. 19:32:26 INFO - Installing pip.................done. 19:32:26 INFO - Return code: 0 19:32:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:32: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')]} 19:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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')]} 19:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:26 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 0x7fc5c41d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17306f0>, '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 0x17315f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731aa0>, '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': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', '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 19:32:26 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 19:32:26 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 19:32:26 INFO - Using env: {'DISPLAY': ':0', 19:32:26 INFO - 'HOME': '/home/cltbld', 19:32:26 INFO - 'LANG': 'en_US.UTF-8', 19:32:26 INFO - 'LANGUAGE': 'en_US:en', 19:32:26 INFO - 'LOGNAME': 'cltbld', 19:32:26 INFO - 'MAIL': '/var/mail/cltbld', 19:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:26 INFO - 'MOZ_NO_REMOTE': '1', 19:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:26 INFO - 'NO_EM_RESTART': '1', 19:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:26 INFO - 'PWD': '/builds/slave/test', 19:32:26 INFO - 'SHELL': '/bin/bash', 19:32:26 INFO - 'SHLVL': '1', 19:32:26 INFO - 'TERM': 'linux', 19:32:26 INFO - 'TMOUT': '86400', 19:32:26 INFO - 'USER': 'cltbld', 19:32:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', 19:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:26 INFO - '_': '/tools/buildbot/bin/python'} 19:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:27 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 19:32:27 INFO - Cleaning up... 19:32:27 INFO - Return code: 0 19:32:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5c41d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17306f0>, '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 0x17315f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731aa0>, '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': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', '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 19:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:32:27 INFO - Using env: {'DISPLAY': ':0', 19:32:27 INFO - 'HOME': '/home/cltbld', 19:32:27 INFO - 'LANG': 'en_US.UTF-8', 19:32:27 INFO - 'LANGUAGE': 'en_US:en', 19:32:27 INFO - 'LOGNAME': 'cltbld', 19:32:27 INFO - 'MAIL': '/var/mail/cltbld', 19:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:27 INFO - 'MOZ_NO_REMOTE': '1', 19:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:27 INFO - 'NO_EM_RESTART': '1', 19:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:27 INFO - 'PWD': '/builds/slave/test', 19:32:27 INFO - 'SHELL': '/bin/bash', 19:32:27 INFO - 'SHLVL': '1', 19:32:27 INFO - 'TERM': 'linux', 19:32:27 INFO - 'TMOUT': '86400', 19:32:27 INFO - 'USER': 'cltbld', 19:32:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', 19:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:27 INFO - '_': '/tools/buildbot/bin/python'} 19:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:27 INFO - Downloading/unpacking psutil>=3.1.1 19:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:32:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:29 INFO - Installing collected packages: psutil 19:32:29 INFO - Running setup.py install for psutil 19:32:29 INFO - building 'psutil._psutil_linux' extension 19:32:29 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 19:32:29 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 19:32:29 INFO - building 'psutil._psutil_posix' extension 19:32:29 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 19:32:29 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 19:32:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:29 INFO - Successfully installed psutil 19:32:29 INFO - Cleaning up... 19:32:29 INFO - Return code: 0 19:32:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5c41d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17306f0>, '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 0x17315f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731aa0>, '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': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', '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 19:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:32:29 INFO - Using env: {'DISPLAY': ':0', 19:32:29 INFO - 'HOME': '/home/cltbld', 19:32:29 INFO - 'LANG': 'en_US.UTF-8', 19:32:29 INFO - 'LANGUAGE': 'en_US:en', 19:32:29 INFO - 'LOGNAME': 'cltbld', 19:32:29 INFO - 'MAIL': '/var/mail/cltbld', 19:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:29 INFO - 'MOZ_NO_REMOTE': '1', 19:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:29 INFO - 'NO_EM_RESTART': '1', 19:32:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:29 INFO - 'PWD': '/builds/slave/test', 19:32:29 INFO - 'SHELL': '/bin/bash', 19:32:29 INFO - 'SHLVL': '1', 19:32:29 INFO - 'TERM': 'linux', 19:32:29 INFO - 'TMOUT': '86400', 19:32:29 INFO - 'USER': 'cltbld', 19:32:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', 19:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:29 INFO - '_': '/tools/buildbot/bin/python'} 19:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:32:31 INFO - Installing collected packages: mozsystemmonitor 19:32:31 INFO - Running setup.py install for mozsystemmonitor 19:32:32 INFO - Successfully installed mozsystemmonitor 19:32:32 INFO - Cleaning up... 19:32:32 INFO - Return code: 0 19:32:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5c41d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17306f0>, '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 0x17315f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731aa0>, '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': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', '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 19:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:32:32 INFO - Using env: {'DISPLAY': ':0', 19:32:32 INFO - 'HOME': '/home/cltbld', 19:32:32 INFO - 'LANG': 'en_US.UTF-8', 19:32:32 INFO - 'LANGUAGE': 'en_US:en', 19:32:32 INFO - 'LOGNAME': 'cltbld', 19:32:32 INFO - 'MAIL': '/var/mail/cltbld', 19:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:32 INFO - 'MOZ_NO_REMOTE': '1', 19:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:32 INFO - 'NO_EM_RESTART': '1', 19:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:32 INFO - 'PWD': '/builds/slave/test', 19:32:32 INFO - 'SHELL': '/bin/bash', 19:32:32 INFO - 'SHLVL': '1', 19:32:32 INFO - 'TERM': 'linux', 19:32:32 INFO - 'TMOUT': '86400', 19:32:32 INFO - 'USER': 'cltbld', 19:32:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', 19:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:32 INFO - '_': '/tools/buildbot/bin/python'} 19:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:32 INFO - Downloading/unpacking jsonschema==2.5.1 19:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:32:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:34 INFO - Downloading functools32-3.2.3-2.tar.gz 19:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:32:34 INFO - warning: no files found matching '*.txt' 19:32:34 INFO - no previously-included directories found matching 'build' 19:32:34 INFO - no previously-included directories found matching 'dist' 19:32:34 INFO - no previously-included directories found matching '.git*' 19:32:34 INFO - Installing collected packages: jsonschema, functools32 19:32:34 INFO - Running setup.py install for functools32 19:32:34 INFO - warning: no files found matching '*.txt' 19:32:34 INFO - no previously-included directories found matching 'build' 19:32:34 INFO - no previously-included directories found matching 'dist' 19:32:34 INFO - no previously-included directories found matching '.git*' 19:32:34 INFO - Successfully installed jsonschema functools32 19:32:34 INFO - Cleaning up... 19:32:34 INFO - Return code: 0 19:32:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5c41d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17306f0>, '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 0x17315f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731aa0>, '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': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', '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 19:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:32:34 INFO - Using env: {'DISPLAY': ':0', 19:32:34 INFO - 'HOME': '/home/cltbld', 19:32:34 INFO - 'LANG': 'en_US.UTF-8', 19:32:34 INFO - 'LANGUAGE': 'en_US:en', 19:32:34 INFO - 'LOGNAME': 'cltbld', 19:32:34 INFO - 'MAIL': '/var/mail/cltbld', 19:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:34 INFO - 'MOZ_NO_REMOTE': '1', 19:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:34 INFO - 'NO_EM_RESTART': '1', 19:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:34 INFO - 'PWD': '/builds/slave/test', 19:32:34 INFO - 'SHELL': '/bin/bash', 19:32:34 INFO - 'SHLVL': '1', 19:32:34 INFO - 'TERM': 'linux', 19:32:34 INFO - 'TMOUT': '86400', 19:32:34 INFO - 'USER': 'cltbld', 19:32:34 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', 19:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:34 INFO - '_': '/tools/buildbot/bin/python'} 19:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:34 INFO - Downloading/unpacking blobuploader==1.2.4 19:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:36 INFO - Downloading blobuploader-1.2.4.tar.gz 19:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:32:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:32:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:37 INFO - Downloading docopt-0.6.1.tar.gz 19:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:32:37 INFO - Installing collected packages: blobuploader, requests, docopt 19:32:37 INFO - Running setup.py install for blobuploader 19:32:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:32:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:32:37 INFO - Running setup.py install for requests 19:32:38 INFO - Running setup.py install for docopt 19:32:38 INFO - Successfully installed blobuploader requests docopt 19:32:38 INFO - Cleaning up... 19:32:38 INFO - Return code: 0 19:32:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:38 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 0x7fc5c41d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17306f0>, '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 0x17315f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731aa0>, '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': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', '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 19:32:38 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 19:32:38 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 19:32:38 INFO - Using env: {'DISPLAY': ':0', 19:32:38 INFO - 'HOME': '/home/cltbld', 19:32:38 INFO - 'LANG': 'en_US.UTF-8', 19:32:38 INFO - 'LANGUAGE': 'en_US:en', 19:32:38 INFO - 'LOGNAME': 'cltbld', 19:32:38 INFO - 'MAIL': '/var/mail/cltbld', 19:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:38 INFO - 'MOZ_NO_REMOTE': '1', 19:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:38 INFO - 'NO_EM_RESTART': '1', 19:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:38 INFO - 'PWD': '/builds/slave/test', 19:32:38 INFO - 'SHELL': '/bin/bash', 19:32:38 INFO - 'SHLVL': '1', 19:32:38 INFO - 'TERM': 'linux', 19:32:38 INFO - 'TMOUT': '86400', 19:32:38 INFO - 'USER': 'cltbld', 19:32:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', 19:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:38 INFO - '_': '/tools/buildbot/bin/python'} 19:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:38 INFO - Running setup.py (path:/tmp/pip-L_O7Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:38 INFO - Running setup.py (path:/tmp/pip-m0_ti0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:38 INFO - Running setup.py (path:/tmp/pip-jxJ4u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:38 INFO - Running setup.py (path:/tmp/pip-SZTvOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:38 INFO - Running setup.py (path:/tmp/pip-gzdiI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:38 INFO - Running setup.py (path:/tmp/pip-fpr3kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:38 INFO - Running setup.py (path:/tmp/pip-JlAA4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:38 INFO - Running setup.py (path:/tmp/pip-_s4Khd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:38 INFO - Running setup.py (path:/tmp/pip-KCoNdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:39 INFO - Running setup.py (path:/tmp/pip-MfcA8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:39 INFO - Running setup.py (path:/tmp/pip-ugvol7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:39 INFO - Running setup.py (path:/tmp/pip-2dtIg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:39 INFO - Running setup.py (path:/tmp/pip-hOLDbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:39 INFO - Running setup.py (path:/tmp/pip-MXMSMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:39 INFO - Running setup.py (path:/tmp/pip-EZslQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:39 INFO - Running setup.py (path:/tmp/pip-Oq99KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:39 INFO - Running setup.py (path:/tmp/pip-rk78pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:32:39 INFO - Running setup.py install for manifestparser 19:32:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:32:39 INFO - Running setup.py install for mozcrash 19:32:39 INFO - Running setup.py install for mozdebug 19:32:39 INFO - Running setup.py install for mozdevice 19:32:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Running setup.py install for mozfile 19:32:40 INFO - Running setup.py install for mozhttpd 19:32:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Running setup.py install for mozinfo 19:32:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Running setup.py install for mozInstall 19:32:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Running setup.py install for mozleak 19:32:40 INFO - Running setup.py install for mozlog 19:32:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Running setup.py install for moznetwork 19:32:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Running setup.py install for mozprocess 19:32:40 INFO - Running setup.py install for mozprofile 19:32:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:32:40 INFO - Running setup.py install for mozrunner 19:32:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:32:41 INFO - Running setup.py install for mozscreenshot 19:32:41 INFO - Running setup.py install for moztest 19:32:41 INFO - Running setup.py install for mozversion 19:32:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:32:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:32:41 INFO - Cleaning up... 19:32:41 INFO - Return code: 0 19:32:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32: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')]} 19:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32: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')]} 19:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:41 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 0x7fc5c41d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17306f0>, '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 0x17315f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731aa0>, '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': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', '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 19:32:41 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 19:32:41 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 19:32:41 INFO - Using env: {'DISPLAY': ':0', 19:32:41 INFO - 'HOME': '/home/cltbld', 19:32:41 INFO - 'LANG': 'en_US.UTF-8', 19:32:41 INFO - 'LANGUAGE': 'en_US:en', 19:32:41 INFO - 'LOGNAME': 'cltbld', 19:32:41 INFO - 'MAIL': '/var/mail/cltbld', 19:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:41 INFO - 'MOZ_NO_REMOTE': '1', 19:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:41 INFO - 'NO_EM_RESTART': '1', 19:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:41 INFO - 'PWD': '/builds/slave/test', 19:32:41 INFO - 'SHELL': '/bin/bash', 19:32:41 INFO - 'SHLVL': '1', 19:32:41 INFO - 'TERM': 'linux', 19:32:41 INFO - 'TMOUT': '86400', 19:32:41 INFO - 'USER': 'cltbld', 19:32:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', 19:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:41 INFO - '_': '/tools/buildbot/bin/python'} 19:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:41 INFO - Running setup.py (path:/tmp/pip-Kci59v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:41 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)) 19:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:41 INFO - Running setup.py (path:/tmp/pip-24sAMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:41 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)) 19:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:41 INFO - Running setup.py (path:/tmp/pip-81KfSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:41 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)) 19:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:41 INFO - Running setup.py (path:/tmp/pip-MeTYe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:41 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)) 19:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:41 INFO - Running setup.py (path:/tmp/pip-JufMNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:42 INFO - Running setup.py (path:/tmp/pip-l7D9Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:42 INFO - Running setup.py (path:/tmp/pip-vMJVeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:42 INFO - Running setup.py (path:/tmp/pip-VmL6f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:42 INFO - Running setup.py (path:/tmp/pip-vdvBGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:42 INFO - Running setup.py (path:/tmp/pip-NMgaEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:42 INFO - Running setup.py (path:/tmp/pip-C2NVL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:42 INFO - Running setup.py (path:/tmp/pip-XmUSaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:42 INFO - Running setup.py (path:/tmp/pip-Vg2nhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:42 INFO - Running setup.py (path:/tmp/pip-YBpeJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:42 INFO - Running setup.py (path:/tmp/pip-fDcDie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:42 INFO - Running setup.py (path:/tmp/pip-_ymmXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:42 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)) 19:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:42 INFO - Running setup.py (path:/tmp/pip-jppHHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:42 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)) 19:32:42 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)) 19:32:42 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)) 19:32:42 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)) 19:32:42 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)) 19:32:42 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)) 19:32:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:32:42 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 19:32:42 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 19:32:42 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 19:32:42 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 19:32:42 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 19:32:42 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 19:32:44 INFO - Downloading blessings-1.6.tar.gz 19:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:32:44 INFO - Installing collected packages: blessings 19:32:44 INFO - Running setup.py install for blessings 19:32:44 INFO - Successfully installed blessings 19:32:44 INFO - Cleaning up... 19:32:45 INFO - Return code: 0 19:32:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:45 INFO - Reading from file tmpfile_stdout 19:32:45 INFO - Current package versions: 19:32:45 INFO - argparse == 1.2.1 19:32:45 INFO - blessings == 1.6 19:32:45 INFO - blobuploader == 1.2.4 19:32:45 INFO - docopt == 0.6.1 19:32:45 INFO - functools32 == 3.2.3-2 19:32:45 INFO - jsonschema == 2.5.1 19:32:45 INFO - manifestparser == 1.1 19:32:45 INFO - mozInstall == 1.12 19:32:45 INFO - mozcrash == 0.17 19:32:45 INFO - mozdebug == 0.1 19:32:45 INFO - mozdevice == 0.48 19:32:45 INFO - mozfile == 1.2 19:32:45 INFO - mozhttpd == 0.7 19:32:45 INFO - mozinfo == 0.9 19:32:45 INFO - mozleak == 0.1 19:32:45 INFO - mozlog == 3.2 19:32:45 INFO - moznetwork == 0.27 19:32:45 INFO - mozprocess == 0.22 19:32:45 INFO - mozprofile == 0.28 19:32:45 INFO - mozrunner == 6.11 19:32:45 INFO - mozscreenshot == 0.1 19:32:45 INFO - mozsystemmonitor == 0.3 19:32:45 INFO - moztest == 0.7 19:32:45 INFO - mozversion == 1.4 19:32:45 INFO - psutil == 3.1.1 19:32:45 INFO - requests == 1.2.3 19:32:45 INFO - wsgiref == 0.1.2 19:32:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:45 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')]} 19:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:45 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')]} 19:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:45 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 0x7fc5c41d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17306f0>, '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 0x17315f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731aa0>, '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': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', '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 19:32:45 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 19:32:45 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 19:32:45 INFO - Using env: {'DISPLAY': ':0', 19:32:45 INFO - 'HOME': '/home/cltbld', 19:32:45 INFO - 'LANG': 'en_US.UTF-8', 19:32:45 INFO - 'LANGUAGE': 'en_US:en', 19:32:45 INFO - 'LOGNAME': 'cltbld', 19:32:45 INFO - 'MAIL': '/var/mail/cltbld', 19:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:45 INFO - 'MOZ_NO_REMOTE': '1', 19:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:45 INFO - 'NO_EM_RESTART': '1', 19:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:45 INFO - 'PWD': '/builds/slave/test', 19:32:45 INFO - 'SHELL': '/bin/bash', 19:32:45 INFO - 'SHLVL': '1', 19:32:45 INFO - 'TERM': 'linux', 19:32:45 INFO - 'TMOUT': '86400', 19:32:45 INFO - 'USER': 'cltbld', 19:32:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', 19:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:45 INFO - '_': '/tools/buildbot/bin/python'} 19:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:45 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)) 19:32:45 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)) 19:32:45 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)) 19:32:45 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)) 19:32:45 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)) 19:32:45 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)) 19:32:45 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)) 19:32:45 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)) 19:32:45 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)) 19:32:45 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)) 19:32:45 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)) 19:32:45 INFO - Cleaning up... 19:32:45 INFO - Return code: 0 19:32:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:32:45 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')]} 19:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:45 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')]} 19:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:45 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 0x7fc5c41d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17306f0>, '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 0x17315f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731aa0>, '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': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', '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 19:32:45 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 19:32:45 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 19:32:45 INFO - Using env: {'DISPLAY': ':0', 19:32:45 INFO - 'HOME': '/home/cltbld', 19:32:45 INFO - 'LANG': 'en_US.UTF-8', 19:32:45 INFO - 'LANGUAGE': 'en_US:en', 19:32:45 INFO - 'LOGNAME': 'cltbld', 19:32:45 INFO - 'MAIL': '/var/mail/cltbld', 19:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:45 INFO - 'MOZ_NO_REMOTE': '1', 19:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:45 INFO - 'NO_EM_RESTART': '1', 19:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:45 INFO - 'PWD': '/builds/slave/test', 19:32:45 INFO - 'SHELL': '/bin/bash', 19:32:45 INFO - 'SHLVL': '1', 19:32:45 INFO - 'TERM': 'linux', 19:32:45 INFO - 'TMOUT': '86400', 19:32:45 INFO - 'USER': 'cltbld', 19:32:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', 19:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:45 INFO - '_': '/tools/buildbot/bin/python'} 19:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:32:45 INFO - Cleaning up... 19:32:45 INFO - Return code: 0 19:32:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:32:45 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')]} 19:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:45 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')]} 19:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:32:45 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 0x7fc5c41d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17306f0>, '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 0x17315f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731aa0>, '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': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', '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 19:32:45 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 19:32:45 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 19:32:45 INFO - Using env: {'DISPLAY': ':0', 19:32:45 INFO - 'HOME': '/home/cltbld', 19:32:45 INFO - 'LANG': 'en_US.UTF-8', 19:32:45 INFO - 'LANGUAGE': 'en_US:en', 19:32:45 INFO - 'LOGNAME': 'cltbld', 19:32:45 INFO - 'MAIL': '/var/mail/cltbld', 19:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:45 INFO - 'MOZ_NO_REMOTE': '1', 19:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:45 INFO - 'NO_EM_RESTART': '1', 19:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:45 INFO - 'PWD': '/builds/slave/test', 19:32:45 INFO - 'SHELL': '/bin/bash', 19:32:45 INFO - 'SHLVL': '1', 19:32:45 INFO - 'TERM': 'linux', 19:32:45 INFO - 'TMOUT': '86400', 19:32:45 INFO - 'USER': 'cltbld', 19:32:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', 19:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:45 INFO - '_': '/tools/buildbot/bin/python'} 19:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:45 INFO - Downloading/unpacking flake8 19:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:32:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:32:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:32:48 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 19:32:48 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 19:32:48 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 19:32:48 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 19:32:48 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 19:32:48 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 19:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:32:48 INFO - no previously-included directories found matching 'docs/_build' 19:32:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:32:48 INFO - Running setup.py install for pep8 19:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:32:48 INFO - no previously-included directories found matching 'docs/_build' 19:32:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:32:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:32:48 INFO - Cleaning up... 19:32:48 INFO - Return code: 0 19:32:48 INFO - Running post-action listener: _resource_record_post_action 19:32:48 INFO - Running post-action listener: _start_resource_monitoring 19:32:48 INFO - Starting resource monitoring. 19:32:48 INFO - ##### 19:32:48 INFO - ##### Finished create-virtualenv step (success) 19:32:48 INFO - ##### 19:32:48 INFO - ##### 19:32:48 INFO - ##### Running install step. 19:32:48 INFO - ##### 19:32:48 INFO - Running pre-action listener: _resource_record_pre_action 19:32:48 INFO - Running main action method: install 19:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:48 INFO - Reading from file tmpfile_stdout 19:32:48 INFO - Detecting whether we're running mozinstall >=1.0... 19:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:32:49 INFO - Reading from file tmpfile_stdout 19:32:49 INFO - Output received: 19:32:49 INFO - Usage: mozinstall [options] installer 19:32:49 INFO - Options: 19:32:49 INFO - -h, --help show this help message and exit 19:32:49 INFO - -d DEST, --destination=DEST 19:32:49 INFO - Directory to install application into. [default: 19:32:49 INFO - "/builds/slave/test"] 19:32:49 INFO - --app=APP Application being installed. [default: firefox] 19:32:49 INFO - mkdir: /builds/slave/test/build/application 19:32:49 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'] 19:32:49 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 19:33:05 INFO - Reading from file tmpfile_stdout 19:33:05 INFO - Output received: 19:33:05 INFO - /builds/slave/test/build/application/firefox/firefox 19:33:05 INFO - Running post-action listener: _resource_record_post_action 19:33:05 INFO - ##### 19:33:05 INFO - ##### Finished install step (success) 19:33:05 INFO - ##### 19:33:05 INFO - ##### 19:33:05 INFO - ##### Running run-tests step. 19:33:05 INFO - ##### 19:33:05 INFO - Running pre-action listener: _resource_record_pre_action 19:33:05 INFO - Running main action method: run_tests 19:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:33:05 INFO - Python 2.7.3 19:33:05 INFO - Return code: 0 19:33:05 INFO - grabbing minidump binary from tooltool 19:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:33:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17306f0>, '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 0x17315f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:33:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:33:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:33:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:33:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:33:05 INFO - Return code: 0 19:33:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:33:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:33:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:33:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:33:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:33:06 INFO - Return code: 0 19:33:06 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/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 19:33:06 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/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 19:33:06 INFO - Using env: {'DISPLAY': ':0', 19:33:06 INFO - 'HOME': '/home/cltbld', 19:33:06 INFO - 'LANG': 'en_US.UTF-8', 19:33:06 INFO - 'LANGUAGE': 'en_US:en', 19:33:06 INFO - 'LOGNAME': 'cltbld', 19:33:06 INFO - 'MAIL': '/var/mail/cltbld', 19:33:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:33:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:33:06 INFO - 'MOZ_NO_REMOTE': '1', 19:33:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:33:06 INFO - 'NO_EM_RESTART': '1', 19:33:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:33:06 INFO - 'PWD': '/builds/slave/test', 19:33:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:33:06 INFO - 'SHELL': '/bin/bash', 19:33:06 INFO - 'SHLVL': '1', 19:33:06 INFO - 'TERM': 'linux', 19:33:06 INFO - 'TMOUT': '86400', 19:33:06 INFO - 'USER': 'cltbld', 19:33:06 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765', 19:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:33:06 INFO - '_': '/tools/buildbot/bin/python'} 19:33:06 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/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 19:33:06 INFO - mozversion application_buildid: 20160627191221 19:33:06 INFO - mozversion application_changeset: 0546e2201cab3ce639ee0d695c2b9a422c16c976 19:33:06 INFO - mozversion application_display_name: Nightly 19:33:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:33:06 INFO - mozversion application_name: Firefox 19:33:06 INFO - mozversion application_remotingname: firefox 19:33:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:33:06 INFO - mozversion application_vendor: Mozilla 19:33:06 INFO - mozversion application_version: 50.0a1 19:33:06 INFO - mozversion platform_buildid: 20160627191221 19:33:06 INFO - mozversion platform_changeset: 0546e2201cab3ce639ee0d695c2b9a422c16c976 19:33:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:33:06 INFO - mozversion platform_version: 50.0a1 19:33:06 INFO - using testdate: 1467081186 19:33:06 INFO - actual date: 1467081186 19:33:06 INFO - starting webserver on 'localhost:41604' 19:33:06 INFO - SUITE-START | Running 2 tests 19:33:06 INFO - TEST-START | dromaeo_css 19:33:06 INFO - operating with platform_type : linux_ 19:33:06 INFO - Initialising browser for dromaeo_css test... 19:33:06 INFO - TEST-INFO | started process 32536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS7ZMcd/profile http://localhost:41604/getInfo.html) 19:33:11 INFO - PROCESS | 32536 | __metrics Screen width/height:1600/1200 19:33:11 INFO - PROCESS | 32536 | colorDepth:24 19:33:11 INFO - PROCESS | 32536 | Browser inner width/height: 1024/697 19:33:11 INFO - PROCESS | 32536 | __metrics 19:33:11 ERROR - PROCESS | 32536 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:33:12 INFO - TEST-INFO | 32536: exit 0 19:33:12 INFO - Browser initialized. 19:33:12 INFO - Running cycle 1/1 for dromaeo_css test... 19:33:12 INFO - TEST-INFO | started process 32654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS7ZMcd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:33:25 INFO - PROCESS | 32654 | RSS: Main: 186175488 19:33:25 INFO - PROCESS | 32654 | 19:34:14 INFO - PROCESS | 32654 | 1467081254680 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] 19:36:26 INFO - PROCESS | 32654 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41604/tests/dromaeo/cssquery-ext.html) 19:36:27 INFO - PROCESS | 32654 | RSS: Main: 189009920 19:36:27 INFO - PROCESS | 32654 | 19:39:30 INFO - PROCESS | 32654 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-ext.html (next: http://localhost:41604/tests/dromaeo/cssquery-jquery.html) 19:39:30 INFO - PROCESS | 32654 | RSS: Main: 188071936 19:39:30 INFO - PROCESS | 32654 | 19:42:32 INFO - PROCESS | 32654 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41604/tests/dromaeo/cssquery-mootools.html) 19:42:33 INFO - PROCESS | 32654 | RSS: Main: 189169664 19:42:33 INFO - PROCESS | 32654 | 19:45:35 INFO - PROCESS | 32654 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41604/tests/dromaeo/cssquery-prototype.html) 19:45:35 INFO - PROCESS | 32654 | RSS: Main: 187645952 19:45:35 INFO - PROCESS | 32654 | 19:48:38 INFO - PROCESS | 32654 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41604/tests/dromaeo/cssquery-yui.html) 19:48:39 INFO - PROCESS | 32654 | RSS: Main: 188739584 19:48:39 INFO - PROCESS | 32654 | 19:51:41 INFO - PROCESS | 32654 | Cycle 1(1): loaded http://localhost:41604/tests/dromaeo/cssquery-yui.html (next: http://localhost:41604/tests/dromaeo/cssquery-dojo.html) 19:51:41 INFO - PROCESS | 32654 | RSS: Main: 189595648 19:51:41 INFO - PROCESS | 32654 | 19:51:41 INFO - PROCESS | 32654 | __start_tp_report 19:51:41 INFO - PROCESS | 32654 | _x_x_mozilla_page_load 19:51:41 INFO - PROCESS | 32654 | _x_x_mozilla_page_load_details 19:51:41 INFO - PROCESS | 32654 | |i|pagename|runs| 19:51:41 INFO - PROCESS | 32654 | |0;dojo.html;2617.842929424234;2673.2381271337667;2678.785697144229;2684.718104599017;2689.166358428886;4811.446683631379;4812;4829.565339119478;4879.6828206166665;4932.975335123319;4806.927896081553;4889.413270407556;4906.1168989581865;4937.901241975158;4946.480619534951;4434.667399945001;4456.19788438081;4541.137183935041;4554.453465584134;4575.970406658508;4257.808398622054;4563.9731060511285;4589.5869371756535;4645.535446455345;4657.720536767788;4401.5378385269405;4456.799444024994;4462.598366147063;4472.6421886249345;4534.886627834314;4411.867643970686;4421.049474363027;4492.52828453011;4532.9320060199125;4559.45286565611;4497.03313787534;4501.549845015505;4505.7296562206375;4518.706284091523;4567.2920697291975;4834.250691142878;4890.926636100461;4898.485659005789;4912.36139301892;4944.90110197794;5230.790768369261;5237.502437268454;5249.002689488985;5279.9968006078725;5281.207818827168;5154.845354639329;5274.525292723673;5304.230886521433;5309.150535914274;5324.307839980777;4872.269159626085;4900.117978763821;4954.504549545017;4977.900441991213;4990.151674215428;5476.397596264408;5483.4516548344845;5485.067538518461;5494.532964698045;5538.6122971391615;5068;5139.152039913372;5183.585313174937;5200.791968321225;5230.163173892159;5186.040582492175;5186.092433824066;5209.218617207373;5213.3222681051975;5269.235960785742;5195.506426889439;5206.97396513015;5258.97370513145;5269.815556455505;5291.232771248147;5038.269450929594;5179.48205179479;5239.790408383622;5272.340957380327;5311.017461769585;4485.484169320504;4500.4149460569915;4504.684672072924;4524.140413321458;4541.091781643684;3867.845286188577;3877.8061096945603;3879;3890.183061557105;3922.4704664870446;4519.81920723174;4577.5193604671695;4605.102005108972;4631.282151266559;4631.58315751584;5352.143657014859;5357.383900851374;5364.356277246756;5381.13901775714;5392.299001129828;4606.332081848113;4634.698744581591;4641.118187544355;4643.907121857544;4697.8355757548325;4641.071785642817;4687.9765601171775;4730.314104454835;4742.19382704941;4823.204171311694;4946.950530494793;4948.035133149074;4951.207806750903;4980.854403487146;5018.924716129334;5320.973395133155;5322.574194064543;5329.227262047059;5332.360116785855;5335.733213339395;4898.314236007033;4951.900961980668;4956.653034287565;4956.925646115239;4968.329275547755;5258.421573626822;5289.3652761668845;5290.68255904647;5293.708846013506;5312.282841816305;5293.258943747801;5334.799670074202;5350.625456218183;5351.438098999549;5362.678239305654;4993.500649935123;5078.771455284447;5123.897522049613;5149.794008239778;5157.07172708916;5074.755820824486;5102.872428189325;5106.285120083266;5119.590432765295;5119.590432765444;5080.974595127001;5106.66806657566;5112.079825631422;5131.025105230144;5175;5064.696118232918;5190.688558686491;5223.059849227176;5229.529342359206;5246.737663116905;5105.693658380509;5147.742612869416;5147.9227811583605;5150.99555586672;5191.896162076813 19:51:41 INFO - PROCESS | 32654 | |1;ext.html;548.7411233053582;576.3890276307114;582.5048708597692;597.554821657865;601.6510423954107;34354.484682729744;38196.99999999996;38222.617773822254;38360;38366.23267534647;38073;38441;38509.422358664575;38542.8072859636;38738.22523549527;7656.846863062749;7794.14264430915;7800.687972481094;7824.100228473713;7832.255935686101;7805.765827025199;7875.291223789858;7899.644515996794;7903.960480197591;7911.920880791205;7911.367090632764;7913.169117242693;7915.960420197891;7940.325072368855;7969;7856.489328193649;7906.248906353887;7909.209079092102;7911.248431399008;7912.20877912207;7732.1108072571815;7778.455508114434;7778.64996075178;7802.102758182768;7809.3752499799875;37463.06342341436;37561.81219093914;37682.81158594217;37758.24483510342;37779.24441511182;3125.46867032605;3189.61724593048;3202.247471844138;3280.4751239801517;3773.962260377416;29309.70690293091;29447.705522944925;29646.258843528867;29820.10539683813;30487;3463.2554000889677;3470.410030294856;3492.1269682579355;3530;3565.108722819295;267335;267703;268515;268666;271018.6449067762;31231.531527027113;51569.2264616031;52324.73837630863;52345.7382713084;52389.47610523922;32634;34181.65818341785;34333.82833085819;34335;34346.48480272798;12586.18189817659;12754.55359062447;12760;12771.680707982376;12845.357732113356;10379.169666426667;10454.581816727246;10455.16358691303;10486.73783155412;10499.475026248658;7820.139784623687;7880.64537095832;7888.368930485547;7979.561124138112;8005.439619226599;3113.081640915935;3149.937001259962;3185;3201.199700074981;3202.295494991098;842.9367797415218;922.5986695787354;958.9616415343447;972.2659392158874;1000.5797565022708;27551.724482755315;28159.43681126366;28183.71816281852;28267.71732282692;28603.284917876805;959.1463597398321;1008.1078245752415;1025.9538320775582;1047.4134484688598;1061.1298735037349;14499.855001450062;14923.70152596942;14935.402583896523;14938.103713777207;15201.315940782692;393080;394094;398067;399829;401876;32990.50514242288;33168;33199.83400083033;33273.833630832174;33483;1110.134095405585;1110.2228440091806;1120.843081968525;1156.6356597671706;1170.3731812780243;26273.4745305089;27317.180484585493;27380;27423;27776.305592360353;42547.57452425436;42636.360454592585;42965;42974.570254297054;43254.351184732885;326172;330381;332679;333018;333306;24989.625155622318;25033;25265.87367063153;25431.491370172862;25505.74494255108;38782.80608596939;40673.79663101784;41257.38113928233;41564.79217603893;42556.78721606372;35751.64248357587;35760.46359304665;35767.64232357643;35870.64129358673;36105;35425.64574354327;35765.64234357623;35797.46303805497;36061.27877442489;36358;31962.20094497656;34978.32727563671;36171.27657446889;36288.4556731644;36997.81501092477;31580.526292105176;32313.192170194994;32781.83609081939;32872.34255314928;32993.835030824695;24782.752172478045;24804.87597562073;25027;25173;25347.746522534537 19:51:41 INFO - PROCESS | 32654 | |2;jquery.html;374.4794735317907;377.66576579726944;379.50095624254106;389.851856294608;393.0939185178163;15767.763483547742;16111.677766444678;17069.57326066849;17116.31534738609;17147.39984100557;15613.375464981416;16376.508704738848;16413.671726565462;16432;17215.139243037862;3441.4149594568858;4621.676482646208;4817.4219093708625;4820.156472617278;4822.300766388871;5252.212168174766;5547.77808887646;5560.165975103747;5635.21107045012;5639;5581.079121944895;5626.746796394172;5653.23681303025;5660.122680984454;5671.8582035449035;5502.174673798922;5576.749046292926;5586.497215250647;5606.55147588192;5608.495235428831;5363.436839131913;5383.973080134574;5398.4871437213405;5407.621466497347;5409.161579955114;19372.225110995543;19795.208191672315;20129.698054529195;20316;20330.898345508176;1905.3617038292189;1909.1981367825547;1936.0958562156766;2094.832413406924;2268.6823844661762;9003.909960900439;9103.135202155785;9343.486108264044;9354.111359420844;9429.76425589359;1714.2800023989955;1717.1242666240182;1787.642471505691;1788.1059470264868;1850.4826042645036;48852.75573622145;70049;72502.2749772506;73394.63302683452;79192.20807791906;15738.68522629541;16253.59366015859;16835.24241409115;17207.655846882994;17321;29649.25876853096;29650.851745741133;29685.406291874042;30242.54636180459;30536.847315763724;7871.724489642949;8423.789405264917;8467.110953349933;8615.22462978335;8648.524331161847;6821.420179284717;6851.862962740817;6941.68762405693;6966.651667416609;7026.473014523931;3592.946105808415;8528.232459078712;8682.392232543662;8773.254273386707;8890.86663700045;1852.0739630184908;1853.6385404845926;1873.7657792775904;1920.5198700324918;1942.8251457368622;827.420805436185;849.592195746033;855.8587833007608;904.263025634106;926.2913870888775;16795.41216057432;16825.831741682672;17086.82913170877;17515;17687.292508299783;850.6342272822745;866.5277423804042;869.3479890082439;888.9244414224734;910.0035461170008;9187.26501879848;9332.95333523328;9688.75778105553;9690.176335011603;9694.22446204302;314807;317197;403546;406185;406922;81638.59180704059;82058.17941820624;84902;85013;85598;908.9000209976897;922.1055576091314;944.1832814615445;946.31392240625;972.0425380999851;15716.214189290718;15744.527664170093;15781.684366312838;15897.966632168873;16385.344586216896;35859;36389.45415818818;36566.063581417235;36575.34246575321;37664.62335376721;49491.25763113628;50740.746296268284;51520.48479515157;51786.460301987565;51965.480345197575;7468.738594149178;7565.319121279112;7578.3558397534625;7618.200088990576;7738.535687858746;8934;10658.946705266424;10880.67357979262;11245.269057511563;11514.94242528782;8644.351673624378;9070.455772653662;9221.17009469151;9381.577828997848;9683.951580242054;9382.10869967352;9414.62341506332;9763.755906102404;9859;9898.653547125816;9331.113544213289;9380.437173769596;9514.23886089125;9672.516374181121;9838.36050656705;7556.65995030214;7567.281108294703;7591.62041897914;7690.384769218337;7754.806129846799;7686.385089192963;8928.464292142493;9137.269018478639;9263.16631503168;9359.15767580921 19:51:41 INFO - PROCESS | 32654 | |3;mootools.html;1378.9586312410631;1410.083445760256;1483.6735918098022;1664.2427695398594;1702.8807983441156;7119.928800711991;7857.528548287107;7915.762527124189;8426.241638252555;8438.11399803021;8117.472364296316;8168;8232.506049637026;8255.133211012848;8263.173682631734;2245.360072379372;2296.552172326397;2297.5290065536524;2309.688192094071;2315.1202543033623;2223.499712564676;2226.487907781211;2235.508188198602;2240.630296001166;2251.4146321956246;2152.547964927367;2158.1583182558816;2161.4056134563043;2162.7512836023902;2232.0625337358347;2192.561487702466;2222.977770222293;2232.174095584636;2242.3048854854883;2245.2935768815737;2188.6388745856916;2195.5828392605513;2205.746339171;2225.3880182949656;2232.754397016327;8297.95851020747;8297.95851020747;8361.16388361165;8369.246767790928;8374.874376884352;4726.338312636233;4847.757612119415;4850.587700045465;4858.174110401205;4862.027594481118;2920.415916816645;2939.617849679549;2979.1956171833485;3032.3177285110896;3049.070033639739;989.9554520046615;1010.6816352848829;1025.3335332034162;1031.3347890610514;1038.5638032026568;11131.777364452666;11275.718107047307;11278.605248816335;11322.886771132265;11334.886651133465;4338.414314067623;4417.514073451917;4518.887027824265;4561.703489273186;4566.292224705176;9603.183729383081;9611.471369074769;9623.182029527428;9625.663101791544;9657;4909.165441874889;4913.852584422473;4916.532929371704;4926.211806111005;4931.852044438672;3933.2920074386884;4187.413762073312;4253.191893540217;4258.382534532476;4353.978230108829;3735.477033215352;3761.4169803680475;3842.1355195080882;3885.106425522146;3902.9462045247624;1233.2292317301687;1233.8149277608431;1237.6039667306375;1247.3638444393243;1249.9812502812465;695.3081683724625;825.9132791056973;830.5764060329154;835.3609488741118;835.7534527314457;5106.234064890222;5182.144946083854;5396.271503347077;5423.349198096174;5445.482679145475;400.71348985475527;408.3099561740649;409.26741133371524;415.40182137721587;418.16575931017815;3691.53855768029;3697.482352470656;3700.8519659213866;3774.358359078908;3788.659020688096;9730.464824434725;10160.390376577428;10241.795164096826;10270.589176433008;10297.794044119075;9747.951260243653;9992.200623950066;10045.497725113715;10056.446895420822;10069.899301006895;7580.431467639949;7623.7712868612925;7677.769666910001;7680.34717049046;7709.691612335556;5125.641205115755;5172.71550064735;5204.895902082013;5310.575153987749;5323.228131920927;9267.53662316895;9383.249340052917;9405.05949405054;9418.199453046567;9428.010058943986;8909.020007799007;9222.907770922206;9223.538823058954;9490.762730931781;9541.379810312308;6177;6852.349026842442;7054.4003759681;7081.291870812877;7187.7843664690145;7791.727289544839;7892.36861051103;7953.32396746283;8004.279614834692;8004.439689221698;6832.965835170792;6955.8608827822145;7065.894011589728;7129.643517824192;7132.037174981311;6997.195322537973;7022.6488675565;7083.724929512531;7112.537685050455;7232.276772322725;5923.4076592340425;6149.2313460817395;6161.784337548164;6275.748970041147;6293.779717710041;4437.534058923767;4566.88582785433;4581.404417425713;4671.019085991979;4688.413948256468;4512.255477846119;4637.466691330405;4689.6717229793585;4709.152352576432;4732.337472753748 19:51:41 INFO - PROCESS | 32654 | |4;prototype.html;309.7104207565926;315.3834254033365;315.430647680936;322.2234415059705;323.81380706094;5160.116557456529;5219.5041471060285;5220.32135822343;5228.163493840986;5240.86897827554;5077.339945807049;5093.134167191577;5134.691918484894;5165.251038599401;5174.637775355717;3826.48342473766;3920.84316627336;4033.5764744701823;4040.939385909214;4055.087605288816;4034.5561988181275;4038.3336749436453;4048.251073551388;4052.452918855961;4060.2691515527194;3918.8628398006076;3994.600539945997;4013.6789056875527;4019.557848636662;4025.0742329264285;3731.8134093295225;3925.528936527606;3931.312020396419;4033.35466325388;4045.292073887058;3417.2823707021557;3422.093145316493;3432.48512723091;3434.295969326307;3440.896773096811;4938.530839570235;4943.1102401567705;4946.233333833262;4946.554810067075;5036.496350364971;4234.30134027885;4475.351074094271;4487.955120448786;4493.168763778712;4520.028193938319;5328.6269961102735;5334.5732341412595;5342.946570534323;5360.16917377807;5373.731313434313;3743.1390780120723;3745.606711295302;3746.4754934309217;3759.3797023491093;3783;5328.147496400557;5627.6060675752715;5643.407442218549;5670.546356291528;5677.318721753375;3855.8072096395067;3869.6517313441364;3872.244912242086;3875.903102422462;3889.2999260132883;3930.8427662893164;3944.447777311179;3945.822437990297;3953.486046813896;3954.62431069048;4484.775761211927;4499.370088187657;4528.207563676344;4535.820686621502;4559.316102584638;5065.898682026339;5321.813736519203;5330.626856120034;5337.893242135136;5372.489613486712;1354.3296068446182;1366.8223130992908;1381.9585412437643;1383.5157694806737;1383.661003054238;856.9314454843598;864.3344624638993;879.4082710294388;882.4705176893813;903.3044555692212;4625.149940024017;4689.835855745033;4692.5307469253485;4703.129920964632;4718.504557021532;5490.670559766427;5495.9832431000395;5507.256520369699;5507.284053073075;5542.002439560837;4536.183486972377;4650;4685.2035154023215;4686.882827929329;4705.12955103307;2924.8683809228637;2943.543750718642;2943.955840662392;2948.3513627002453;2948.6756456789735;5150.330457040635;5150.742462876841;5165.948340516622;5166.870828229325;5171.9482805171465;5497.230387745719;5519.47080128107;5610.747516361774;5629.4652008059165;5671.659700417906;5113.74431278442;5130.948690513047;5132.769025393866;5135.6918584885025;5181.248718935809;5473.945260547343;5496.6701997880255;5501.679596896796;5502.779888804403;5503.2020357048805;5141.640085194001;5318.7340632967425;5360.597955153457;5369.3556773187465;5389.919151212656;5118.948810511847;5129.333186685707;5140.100482415488;5149.716765577929;5163.690178589297;3845.5577608574254;3869.9419508707956;3883.5339759229073;3888.4361767544115;3901.1612503311926;5343.7060961647485;5429.67421954684;5436.211749296251;5438.70087145195;5487.917681234864;5236;5273.683578985273;5290.497402746733;5308.893822123613;5324.1747529133045;4965.950340496549;5217.582593392595;5263;5279.656822306538;5302.443243459536;5177.430482646982;5202.765875535686;5224.895502090013;5242.842714718412;5246.763895624782;5133.6919784813035;5209.426963034139;5358.678479291255;5384.196294241473;5471.261379713687;5298.629095963245;5317.2555842181355;5327.6270661054905;5332.33345831771;5348.117560602613 19:51:41 INFO - PROCESS | 32654 | |5;yui.html;653.274864899961;716.7491378017694;728.9781306560803;749.9325060744532;783.8040489877529;11562.47968841402;12553;12560.43478043488;12610.747785044294;12624.116311858174;12217.38913054348;12250.509979600805;12358.073144514152;12414.689632759162;12426.937865310683;611.9020956646938;763.427429427929;763.8854171874208;766.2796970847413;790.8260182759784;774.5623722596742;775.5695588948131;776.216021817965;776.4797585617649;778.6573907480719;833.2958649940821;835.3859912963967;835.9665613375488;837.4431003382743;839.5046922315832;821.5522540215596;823.5511646152861;824.2211110500549;824.9587520623945;826.0129145670926;605.4823126227101;606.2149516376303;606.6329870428416;606.9453749162552;607.4866737606716;11958.461869215906;12020.879791202064;12061.09541784361;12062.276263424223;12086.093542984223;13454.461821527128;13639.727205455934;13968.511102111377;13972.93013534936;14008.789868151986;10872.402017889013;10902.563897444094;10934;10987.780244395068;11029.61396351132;3393.1347506385714;3429.228423604694;3430.0567343980356;3448;3531.0289670340603;57753;57943;58331.41668583302;59954.002299885266;60505.6974715128;10736.463176841127;10829.241953063367;10855.728606784893;10907.400092994803;10907.821577280742;17609.20758565842;17621.823781762276;17638.91180544089;17794.199261033285;17810.821891780917;6816.352446517573;6969.686364113627;7197.46019048563;7251.3836323912;7301.488895777245;3604.1710406606626;3617.3127105849803;3655.853765849336;3719.702423806089;3774.490443790108;3024.077656314801;3144.4654408750566;3159.794613350125;3160.5891234139876;3166.825824579624;565.3018522125172;588.5556404914263;596.1832289763053;597.3399393670019;608.3764141754737;396.1186360348202;467.67496589869717;479.441450709919;483.3571350104353;490.43844797706424;7043;7426.925730742623;7565.356944659766;7576.8484630308185;7665.348445382205;525.8869343091254;529.7324850950246;553.1122548309985;556.9832905012856;558.3829867995887;3376.307856889332;3409.2499650076943;3456.9308613827584;3525.11872031992;3598.442241452579;53534.464655353724;53565.732171338896;53672.463275367525;55188.44811551833;69232.65383673151;81406.18593814105;83251.5837420809;84089.57955210184;85362.57318713366;85823.57088214518;44480.21918136995;44794.32808507875;45929.54070459319;47301.76349118301;71853.64073179601;6942.271061538466;6966.616836074065;7049.577025378494;7082.893756593552;7230.313120253568;40601.39097913475;40762.59237407588;40888.59111408848;41934;42094;35396;56466.153007704095;56648.433515665965;56845.43154568401;57501.137482938626;8835.64657413722;9026.819463610822;9057.909420905706;9308.720738377859;9389.85915211286;10261.179105671677;10275.640352587623;10285.485725713834;10285.691429257135;10295.433751143759;9263.397879137834;9337.906620933703;9474.052594740471;9478.146966773023;9532.142107210384;9809.313348065567;9890.357126786736;10084.445355505517;10299.588016479256;10456.738581535523;8939.865902011605;9242.815143696955;9429.62281508732;9459.952700236454;9560.521973901416;8115;8151.358312077509;8312;8330.833383332421;8582.227599515823;8096.757097287091;8236.176382361717;8323.375746818892;8347.20735719652;8362.163783621589 19:51:41 INFO - PROCESS | 32654 | __end_tp_report 19:51:41 INFO - PROCESS | 32654 | __start_cc_report 19:51:41 INFO - PROCESS | 32654 | _x_x_mozilla_cycle_collect,395 19:51:41 INFO - PROCESS | 32654 | __end_cc_report 19:51:41 INFO - PROCESS | 32654 | __startTimestamp1467082301760__endTimestamp 19:51:41 INFO - PROCESS | 32654 | 19:51:41 INFO - PROCESS | 32654 | ------- Summary: start ------- 19:51:41 INFO - PROCESS | 32654 | Number of tests: 6 19:51:41 INFO - PROCESS | 32654 | 19:51:41 INFO - PROCESS | 32654 | [#0] dojo.html Cycles:165 Average:4875.76 Median:4980.85 stddev:530.38 (10.6%) stddev-sans-first:501.56 19:51:41 INFO - PROCESS | 32654 | Values: 2617.8 2673.2 2678.8 2684.7 2689.2 4811.4 4812.0 4829.6 4879.7 4933.0 4806.9 4889.4 4906.1 4937.9 4946.5 4434.7 4456.2 4541.1 4554.5 4576.0 4257.8 4564.0 4589.6 4645.5 4657.7 4401.5 4456.8 4462.6 4472.6 4534.9 4411.9 4421.0 4492.5 4532.9 4559.5 4497.0 4501.5 4505.7 4518.7 4567.3 4834.3 4890.9 4898.5 4912.4 4944.9 5230.8 5237.5 5249.0 5280.0 5281.2 5154.8 5274.5 5304.2 5309.2 5324.3 4872.3 4900.1 4954.5 4977.9 4990.2 5476.4 5483.5 5485.1 5494.5 5538.6 5068.0 5139.2 5183.6 5200.8 5230.2 5186.0 5186.1 5209.2 5213.3 5269.2 5195.5 5207.0 5259.0 5269.8 5291.2 5038.3 5179.5 5239.8 5272.3 5311.0 4485.5 4500.4 4504.7 4524.1 4541.1 3867.8 3877.8 3879.0 3890.2 3922.5 4519.8 4577.5 4605.1 4631.3 4631.6 5352.1 5357.4 5364.4 5381.1 5392.3 4606.3 4634.7 4641.1 4643.9 4697.8 4641.1 4688.0 4730.3 4742.2 4823.2 4947.0 4948.0 4951.2 4980.9 5018.9 5321.0 5322.6 5329.2 5332.4 5335.7 4898.3 4951.9 4956.7 4956.9 4968.3 5258.4 5289.4 5290.7 5293.7 5312.3 5293.3 5334.8 5350.6 5351.4 5362.7 4993.5 5078.8 5123.9 5149.8 5157.1 5074.8 5102.9 5106.3 5119.6 5119.6 5081.0 5106.7 5112.1 5131.0 5175.0 5064.7 5190.7 5223.1 5229.5 5246.7 5105.7 5147.7 5147.9 5151.0 5191.9 19:51:41 INFO - PROCESS | 32654 | 19:51:41 INFO - PROCESS | 32654 | [#1] ext.html Cycles:180 Average:46767.53 Median:19254.16 stddev:88897.81 (461.7%) stddev-sans-first:89079.46 19:51:41 INFO - PROCESS | 32654 | Values: 548.7 576.4 582.5 597.6 601.7 34354.5 38197.0 38222.6 38360.0 38366.2 38073.0 38441.0 38509.4 38542.8 38738.2 7656.8 7794.1 7800.7 7824.1 7832.3 7805.8 7875.3 7899.6 7904.0 7911.9 7911.4 7913.2 7916.0 7940.3 7969.0 7856.5 7906.2 7909.2 7911.2 7912.2 7732.1 7778.5 7778.6 7802.1 7809.4 37463.1 37561.8 37682.8 37758.2 37779.2 3125.5 3189.6 3202.2 3280.5 3774.0 29309.7 29447.7 29646.3 29820.1 30487.0 3463.3 3470.4 3492.1 3530.0 3565.1 267335.0 267703.0 268515.0 268666.0 271018.6 31231.5 51569.2 52324.7 52345.7 52389.5 32634.0 34181.7 34333.8 34335.0 34346.5 12586.2 12754.6 12760.0 12771.7 12845.4 10379.2 10454.6 10455.2 10486.7 10499.5 7820.1 7880.6 7888.4 7979.6 8005.4 3113.1 3149.9 3185.0 3201.2 3202.3 842.9 922.6 959.0 972.3 1000.6 27551.7 28159.4 28183.7 28267.7 28603.3 959.1 1008.1 1026.0 1047.4 1061.1 14499.9 14923.7 14935.4 14938.1 15201.3 393080.0 394094.0 398067.0 399829.0 401876.0 32990.5 33168.0 33199.8 33273.8 33483.0 1110.1 1110.2 1120.8 1156.6 1170.4 26273.5 27317.2 27380.0 27423.0 27776.3 42547.6 42636.4 42965.0 42974.6 43254.4 326172.0 330381.0 332679.0 333018.0 333306.0 24989.6 25033.0 25265.9 25431.5 25505.7 38782.8 40673.8 41257.4 41564.8 42556.8 35751.6 35760.5 35767.6 35870.6 36105.0 35425.6 35765.6 35797.5 36061.3 36358.0 31962.2 34978.3 36171.3 36288.5 36997.8 31580.5 32313.2 32781.8 32872.3 32993.8 24782.8 24804.9 25027.0 25173.0 25347.7 19:51:41 INFO - PROCESS | 32654 | 19:51:41 INFO - PROCESS | 32654 | [#2] jquery.html Cycles:180 Average:24532.62 Median:5578.91 stddev:61759.96 (1107.0%) stddev-sans-first:61906.58 19:51:41 INFO - PROCESS | 32654 | Values: 374.5 377.7 379.5 389.9 393.1 15767.8 16111.7 17069.6 17116.3 17147.4 15613.4 16376.5 16413.7 16432.0 17215.1 3441.4 4621.7 4817.4 4820.2 4822.3 5252.2 5547.8 5560.2 5635.2 5639.0 5581.1 5626.7 5653.2 5660.1 5671.9 5502.2 5576.7 5586.5 5606.6 5608.5 5363.4 5384.0 5398.5 5407.6 5409.2 19372.2 19795.2 20129.7 20316.0 20330.9 1905.4 1909.2 1936.1 2094.8 2268.7 9003.9 9103.1 9343.5 9354.1 9429.8 1714.3 1717.1 1787.6 1788.1 1850.5 48852.8 70049.0 72502.3 73394.6 79192.2 15738.7 16253.6 16835.2 17207.7 17321.0 29649.3 29650.9 29685.4 30242.5 30536.8 7871.7 8423.8 8467.1 8615.2 8648.5 6821.4 6851.9 6941.7 6966.7 7026.5 3592.9 8528.2 8682.4 8773.3 8890.9 1852.1 1853.6 1873.8 1920.5 1942.8 827.4 849.6 855.9 904.3 926.3 16795.4 16825.8 17086.8 17515.0 17687.3 850.6 866.5 869.3 888.9 910.0 9187.3 9333.0 9688.8 9690.2 9694.2 314807.0 317197.0 403546.0 406185.0 406922.0 81638.6 82058.2 84902.0 85013.0 85598.0 908.9 922.1 944.2 946.3 972.0 15716.2 15744.5 15781.7 15898.0 16385.3 35859.0 36389.5 36566.1 36575.3 37664.6 49491.3 50740.7 51520.5 51786.5 51965.5 7468.7 7565.3 7578.4 7618.2 7738.5 8934.0 10658.9 10880.7 11245.3 11514.9 8644.4 9070.5 9221.2 9381.6 9684.0 9382.1 9414.6 9763.8 9859.0 9898.7 9331.1 9380.4 9514.2 9672.5 9838.4 7556.7 7567.3 7591.6 7690.4 7754.8 7686.4 8928.5 9137.3 9263.2 9359.2 19:51:41 INFO - PROCESS | 32654 | 19:51:41 INFO - PROCESS | 32654 | [#3] mootools.html Cycles:180 Average:5327.53 Median:4729.34 stddev:3049.19 (64.5%) stddev-sans-first:3043.31 19:51:41 INFO - PROCESS | 32654 | Values: 1379.0 1410.1 1483.7 1664.2 1702.9 7119.9 7857.5 7915.8 8426.2 8438.1 8117.5 8168.0 8232.5 8255.1 8263.2 2245.4 2296.6 2297.5 2309.7 2315.1 2223.5 2226.5 2235.5 2240.6 2251.4 2152.5 2158.2 2161.4 2162.8 2232.1 2192.6 2223.0 2232.2 2242.3 2245.3 2188.6 2195.6 2205.7 2225.4 2232.8 8298.0 8298.0 8361.2 8369.2 8374.9 4726.3 4847.8 4850.6 4858.2 4862.0 2920.4 2939.6 2979.2 3032.3 3049.1 990.0 1010.7 1025.3 1031.3 1038.6 11131.8 11275.7 11278.6 11322.9 11334.9 4338.4 4417.5 4518.9 4561.7 4566.3 9603.2 9611.5 9623.2 9625.7 9657.0 4909.2 4913.9 4916.5 4926.2 4931.9 3933.3 4187.4 4253.2 4258.4 4354.0 3735.5 3761.4 3842.1 3885.1 3902.9 1233.2 1233.8 1237.6 1247.4 1250.0 695.3 825.9 830.6 835.4 835.8 5106.2 5182.1 5396.3 5423.3 5445.5 400.7 408.3 409.3 415.4 418.2 3691.5 3697.5 3700.9 3774.4 3788.7 9730.5 10160.4 10241.8 10270.6 10297.8 9748.0 9992.2 10045.5 10056.4 10069.9 7580.4 7623.8 7677.8 7680.3 7709.7 5125.6 5172.7 5204.9 5310.6 5323.2 9267.5 9383.2 9405.1 9418.2 9428.0 8909.0 9222.9 9223.5 9490.8 9541.4 6177.0 6852.3 7054.4 7081.3 7187.8 7791.7 7892.4 7953.3 8004.3 8004.4 6833.0 6955.9 7065.9 7129.6 7132.0 6997.2 7022.6 7083.7 7112.5 7232.3 5923.4 6149.2 6161.8 6275.7 6293.8 4437.5 4566.9 4581.4 4671.0 4688.4 4512.3 4637.5 4689.7 4709.2 4732.3 19:51:41 INFO - PROCESS | 32654 | 19:51:41 INFO - PROCESS | 32654 | [#4] prototype.html Cycles:180 Average:4424.81 Median:5124.14 stddev:1286.23 (25.1%) stddev-sans-first:1252.20 19:51:41 INFO - PROCESS | 32654 | Values: 309.7 315.4 315.4 322.2 323.8 5160.1 5219.5 5220.3 5228.2 5240.9 5077.3 5093.1 5134.7 5165.3 5174.6 3826.5 3920.8 4033.6 4040.9 4055.1 4034.6 4038.3 4048.3 4052.5 4060.3 3918.9 3994.6 4013.7 4019.6 4025.1 3731.8 3925.5 3931.3 4033.4 4045.3 3417.3 3422.1 3432.5 3434.3 3440.9 4938.5 4943.1 4946.2 4946.6 5036.5 4234.3 4475.4 4488.0 4493.2 4520.0 5328.6 5334.6 5342.9 5360.2 5373.7 3743.1 3745.6 3746.5 3759.4 3783.0 5328.1 5627.6 5643.4 5670.5 5677.3 3855.8 3869.7 3872.2 3875.9 3889.3 3930.8 3944.4 3945.8 3953.5 3954.6 4484.8 4499.4 4528.2 4535.8 4559.3 5065.9 5321.8 5330.6 5337.9 5372.5 1354.3 1366.8 1382.0 1383.5 1383.7 856.9 864.3 879.4 882.5 903.3 4625.1 4689.8 4692.5 4703.1 4718.5 5490.7 5496.0 5507.3 5507.3 5542.0 4536.2 4650.0 4685.2 4686.9 4705.1 2924.9 2943.5 2944.0 2948.4 2948.7 5150.3 5150.7 5165.9 5166.9 5171.9 5497.2 5519.5 5610.7 5629.5 5671.7 5113.7 5130.9 5132.8 5135.7 5181.2 5473.9 5496.7 5501.7 5502.8 5503.2 5141.6 5318.7 5360.6 5369.4 5389.9 5118.9 5129.3 5140.1 5149.7 5163.7 3845.6 3869.9 3883.5 3888.4 3901.2 5343.7 5429.7 5436.2 5438.7 5487.9 5236.0 5273.7 5290.5 5308.9 5324.2 4966.0 5217.6 5263.0 5279.7 5302.4 5177.4 5202.8 5224.9 5242.8 5246.8 5133.7 5209.4 5358.7 5384.2 5471.3 5298.6 5317.3 5327.6 5332.3 5348.1 19:51:41 INFO - PROCESS | 32654 | 19:51:41 INFO - PROCESS | 32654 | [#5] yui.html Cycles:180 Average:15026.40 Median:57173.28 stddev:20422.60 (35.7%) stddev-sans-first:20451.38 19:51:41 INFO - PROCESS | 32654 | Values: 653.3 716.7 729.0 749.9 783.8 11562.5 12553.0 12560.4 12610.7 12624.1 12217.4 12250.5 12358.1 12414.7 12426.9 611.9 763.4 763.9 766.3 790.8 774.6 775.6 776.2 776.5 778.7 833.3 835.4 836.0 837.4 839.5 821.6 823.6 824.2 825.0 826.0 605.5 606.2 606.6 606.9 607.5 11958.5 12020.9 12061.1 12062.3 12086.1 13454.5 13639.7 13968.5 13972.9 14008.8 10872.4 10902.6 10934.0 10987.8 11029.6 3393.1 3429.2 3430.1 3448.0 3531.0 57753.0 57943.0 58331.4 59954.0 60505.7 10736.5 10829.2 10855.7 10907.4 10907.8 17609.2 17621.8 17638.9 17794.2 17810.8 6816.4 6969.7 7197.5 7251.4 7301.5 3604.2 3617.3 3655.9 3719.7 3774.5 3024.1 3144.5 3159.8 3160.6 3166.8 565.3 588.6 596.2 597.3 608.4 396.1 467.7 479.4 483.4 490.4 7043.0 7426.9 7565.4 7576.8 7665.3 525.9 529.7 553.1 557.0 558.4 3376.3 3409.2 3456.9 3525.1 3598.4 53534.5 53565.7 53672.5 55188.4 69232.7 81406.2 83251.6 84089.6 85362.6 85823.6 44480.2 44794.3 45929.5 47301.8 71853.6 6942.3 6966.6 7049.6 7082.9 7230.3 40601.4 40762.6 40888.6 41934.0 42094.0 35396.0 56466.2 56648.4 56845.4 57501.1 8835.6 9026.8 9057.9 9308.7 9389.9 10261.2 10275.6 10285.5 10285.7 10295.4 9263.4 9337.9 9474.1 9478.1 9532.1 9809.3 9890.4 10084.4 10299.6 10456.7 8939.9 9242.8 9429.6 9460.0 9560.5 8115.0 8151.4 8312.0 8330.8 8582.2 8096.8 8236.2 8323.4 8347.2 8362.2 19:51:41 INFO - PROCESS | 32654 | -------- Summary: end -------- 19:51:41 INFO - PROCESS | 32654 | 19:51:42 INFO - TEST-INFO | 32654: exit 0 19:51:42 INFO - TEST-OK | dromaeo_css | took 1116123ms 19:51:42 INFO - TEST-START | kraken 19:51:42 INFO - operating with platform_type : linux_ 19:51:42 INFO - Initialising browser for kraken test... 19:51:42 INFO - TEST-INFO | started process 424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptgZjHw/profile http://localhost:41604/getInfo.html) 19:51:47 INFO - PROCESS | 424 | __metrics Screen width/height:1600/1200 19:51:47 INFO - PROCESS | 424 | colorDepth:24 19:51:47 INFO - PROCESS | 424 | Browser inner width/height: 1024/697 19:51:47 INFO - PROCESS | 424 | __metrics 19:51:47 ERROR - PROCESS | 424 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:51:48 INFO - TEST-INFO | 424: exit 0 19:51:48 INFO - Browser initialized. 19:51:48 INFO - Running cycle 1/1 for kraken test... 19:51:48 INFO - TEST-INFO | started process 544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptgZjHw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:01 INFO - PROCESS | 544 | RSS: Main: 186241024 19:52:01 INFO - PROCESS | 544 | 19:52:03 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41604/tests/kraken/driver.html?testName=audio-beat-detection) 19:52:04 INFO - PROCESS | 544 | RSS: Main: 190631936 19:52:04 INFO - PROCESS | 544 | 19:52:07 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41604/tests/kraken/driver.html?testName=audio-dft) 19:52:08 INFO - PROCESS | 544 | RSS: Main: 190631936 19:52:08 INFO - PROCESS | 544 | 19:52:11 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41604/tests/kraken/driver.html?testName=audio-fft) 19:52:11 INFO - PROCESS | 544 | RSS: Main: 186204160 19:52:11 INFO - PROCESS | 544 | 19:52:13 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41604/tests/kraken/driver.html?testName=audio-oscillator) 19:52:14 INFO - PROCESS | 544 | RSS: Main: 186875904 19:52:14 INFO - PROCESS | 544 | 19:52:16 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41604/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:52:17 INFO - PROCESS | 544 | RSS: Main: 186925056 19:52:17 INFO - PROCESS | 544 | 19:52:20 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41604/tests/kraken/driver.html?testName=imaging-darkroom) 19:52:21 INFO - PROCESS | 544 | RSS: Main: 187604992 19:52:21 INFO - PROCESS | 544 | 19:52:24 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41604/tests/kraken/driver.html?testName=imaging-desaturate) 19:52:25 INFO - PROCESS | 544 | RSS: Main: 184467456 19:52:25 INFO - PROCESS | 544 | 19:52:28 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41604/tests/kraken/driver.html?testName=json-parse-financial) 19:52:28 INFO - PROCESS | 544 | RSS: Main: 185970688 19:52:28 INFO - PROCESS | 544 | 19:52:30 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41604/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:52:31 INFO - PROCESS | 544 | RSS: Main: 186318848 19:52:31 INFO - PROCESS | 544 | 19:52:33 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:52:33 INFO - PROCESS | 544 | RSS: Main: 186929152 19:52:33 INFO - PROCESS | 544 | 19:52:36 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:52:36 INFO - PROCESS | 544 | RSS: Main: 186912768 19:52:36 INFO - PROCESS | 544 | 19:52:39 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:52:40 INFO - PROCESS | 544 | RSS: Main: 187154432 19:52:40 INFO - PROCESS | 544 | 19:52:43 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:52:43 INFO - PROCESS | 544 | RSS: Main: 186679296 19:52:43 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | Cycle 1(1): loaded http://localhost:41604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41604/tests/kraken/driver.html?testName=ai-astar) 19:52:45 INFO - PROCESS | 544 | RSS: Main: 187740160 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | __start_tp_report 19:52:45 INFO - PROCESS | 544 | _x_x_mozilla_page_load 19:52:45 INFO - PROCESS | 544 | _x_x_mozilla_page_load_details 19:52:45 INFO - PROCESS | 544 | |i|pagename|runs| 19:52:45 INFO - PROCESS | 544 | |0;ai-astar;104;116;108;112;115;115;116;113;114;114 19:52:45 INFO - PROCESS | 544 | |1;audio-beat-detection;168;139;159;178;131;168;161;134;184;136 19:52:45 INFO - PROCESS | 544 | |2;audio-dft;164;166;179;164;162;162;162;165;163;164 19:52:45 INFO - PROCESS | 544 | |3;audio-fft;75;77;77;180;76;76;78;76;156;77 19:52:45 INFO - PROCESS | 544 | |4;audio-oscillator;86;85;146;87;87;88;134;86;86;142 19:52:45 INFO - PROCESS | 544 | |5;imaging-gaussian-blur;118;118;117;118;117;117;118;119;118;119 19:52:45 INFO - PROCESS | 544 | |6;imaging-darkroom;148;149;148;155;151;151;149;149;149;149 19:52:45 INFO - PROCESS | 544 | |7;imaging-desaturate;95;95;95;96;96;97;96;95;96;96 19:52:45 INFO - PROCESS | 544 | |8;json-parse-financial;65;63;62;64;63;64;63;63;63;62 19:52:45 INFO - PROCESS | 544 | |9;json-stringify-tinderbox;69;64;65;65;66;64;63;64;65;66 19:52:45 INFO - PROCESS | 544 | |10;stanford-crypto-aes;84;82;82;84;83;85;88;90;83;83 19:52:45 INFO - PROCESS | 544 | |11;stanford-crypto-ccm;135;131;142;139;137;135;141;136;135;134 19:52:45 INFO - PROCESS | 544 | |12;stanford-crypto-pbkdf2;168;166;167;167;171;167;171;168;164;162 19:52:45 INFO - PROCESS | 544 | |13;stanford-crypto-sha256-iterative;70;68;67;67;70;67;67;70;66;66 19:52:45 INFO - PROCESS | 544 | __end_tp_report 19:52:45 INFO - PROCESS | 544 | __start_cc_report 19:52:45 INFO - PROCESS | 544 | _x_x_mozilla_cycle_collect,997 19:52:45 INFO - PROCESS | 544 | __end_cc_report 19:52:45 INFO - PROCESS | 544 | __startTimestamp1467082365699__endTimestamp 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | ------- Summary: start ------- 19:52:45 INFO - PROCESS | 544 | Number of tests: 14 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.50 stddev:3.86 (3.4%) stddev-sans-first:2.50 19:52:45 INFO - PROCESS | 544 | Values: 104.0 116.0 108.0 112.0 115.0 115.0 116.0 113.0 114.0 114.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:164.50 stddev:19.40 (11.8%) stddev-sans-first:20.07 19:52:45 INFO - PROCESS | 544 | Values: 168.0 139.0 159.0 178.0 131.0 168.0 161.0 134.0 184.0 136.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:5.07 (3.1%) stddev-sans-first:5.36 19:52:45 INFO - PROCESS | 544 | Values: 164.0 166.0 179.0 164.0 162.0 162.0 162.0 165.0 163.0 164.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.50 stddev:39.00 (51.0%) stddev-sans-first:40.70 19:52:45 INFO - PROCESS | 544 | Values: 75.0 77.0 77.0 180.0 76.0 76.0 78.0 76.0 156.0 77.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:86.00 stddev:26.37 (30.7%) stddev-sans-first:27.27 19:52:45 INFO - PROCESS | 544 | Values: 86.0 85.0 146.0 87.0 87.0 88.0 134.0 86.0 86.0 142.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 19:52:45 INFO - PROCESS | 544 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 118.0 119.0 118.0 119.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:149.00 stddev:2.10 (1.4%) stddev-sans-first:2.12 19:52:45 INFO - PROCESS | 544 | Values: 148.0 149.0 148.0 155.0 151.0 151.0 149.0 149.0 149.0 149.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 19:52:45 INFO - PROCESS | 544 | Values: 95.0 95.0 95.0 96.0 96.0 97.0 96.0 95.0 96.0 96.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.71 19:52:45 INFO - PROCESS | 544 | Values: 65.0 63.0 62.0 64.0 63.0 64.0 63.0 63.0 63.0 62.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:1.66 (2.6%) stddev-sans-first:1.00 19:52:45 INFO - PROCESS | 544 | Values: 69.0 64.0 65.0 65.0 66.0 64.0 63.0 64.0 65.0 66.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.63 (3.1%) stddev-sans-first:2.79 19:52:45 INFO - PROCESS | 544 | Values: 84.0 82.0 82.0 84.0 83.0 85.0 88.0 90.0 83.0 83.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:136.50 stddev:3.34 (2.4%) stddev-sans-first:3.50 19:52:45 INFO - PROCESS | 544 | Values: 135.0 131.0 142.0 139.0 137.0 135.0 141.0 136.0 135.0 134.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.50 stddev:2.77 (1.7%) stddev-sans-first:2.92 19:52:45 INFO - PROCESS | 544 | Values: 168.0 166.0 167.0 167.0 171.0 167.0 171.0 168.0 164.0 162.0 19:52:45 INFO - PROCESS | 544 | 19:52:45 INFO - PROCESS | 544 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:1.62 (2.4%) stddev-sans-first:1.51 19:52:45 INFO - PROCESS | 544 | Values: 70.0 68.0 67.0 67.0 70.0 67.0 67.0 70.0 66.0 66.0 19:52:45 INFO - PROCESS | 544 | -------- Summary: end -------- 19:52:45 INFO - PROCESS | 544 | 19:52:46 INFO - TEST-INFO | 544: exit 0 19:52:46 INFO - TEST-OK | kraken | took 64137ms 19:52:46 INFO - SUITE-END | took 1180s 19:52:46 INFO - Completed test suite (00:19:40) 19:52:46 INFO - javascript benchmark 19:52:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6403.215072975862, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.842929424234, 2673.2381271337667, 2678.785697144229, 2684.718104599017, 2689.166358428886, 4811.446683631379, 4812.0, 4829.565339119478, 4879.6828206166665, 4932.975335123319, 4806.927896081553, 4889.413270407556, 4906.1168989581865, 4937.901241975158, 4946.480619534951, 4434.667399945001, 4456.19788438081, 4541.137183935041, 4554.453465584134, 4575.970406658508, 4257.808398622054, 4563.9731060511285, 4589.5869371756535, 4645.535446455345, 4657.720536767788, 4401.5378385269405, 4456.799444024994, 4462.598366147063, 4472.6421886249345, 4534.886627834314, 4411.867643970686, 4421.049474363027, 4492.52828453011, 4532.9320060199125, 4559.45286565611, 4497.03313787534, 4501.549845015505, 4505.7296562206375, 4518.706284091523, 4567.2920697291975, 4834.250691142878, 4890.926636100461, 4898.485659005789, 4912.36139301892, 4944.90110197794, 5230.790768369261, 5237.502437268454, 5249.002689488985, 5279.9968006078725, 5281.207818827168, 5154.845354639329, 5274.525292723673, 5304.230886521433, 5309.150535914274, 5324.307839980777, 4872.269159626085, 4900.117978763821, 4954.504549545017, 4977.900441991213, 4990.151674215428, 5476.397596264408, 5483.4516548344845, 5485.067538518461, 5494.532964698045, 5538.6122971391615, 5068.0, 5139.152039913372, 5183.585313174937, 5200.791968321225, 5230.163173892159, 5186.040582492175, 5186.092433824066, 5209.218617207373, 5213.3222681051975, 5269.235960785742, 5195.506426889439, 5206.97396513015, 5258.97370513145, 5269.815556455505, 5291.232771248147, 5038.269450929594, 5179.48205179479, 5239.790408383622, 5272.340957380327, 5311.017461769585, 4485.484169320504, 4500.4149460569915, 4504.684672072924, 4524.140413321458, 4541.091781643684, 3867.845286188577, 3877.8061096945603, 3879.0, 3890.183061557105, 3922.4704664870446, 4519.81920723174, 4577.5193604671695, 4605.102005108972, 4631.282151266559, 4631.58315751584, 5352.143657014859, 5357.383900851374, 5364.356277246756, 5381.13901775714, 5392.299001129828, 4606.332081848113, 4634.698744581591, 4641.118187544355, 4643.907121857544, 4697.8355757548325, 4641.071785642817, 4687.9765601171775, 4730.314104454835, 4742.19382704941, 4823.204171311694, 4946.950530494793, 4948.035133149074, 4951.207806750903, 4980.854403487146, 5018.924716129334, 5320.973395133155, 5322.574194064543, 5329.227262047059, 5332.360116785855, 5335.733213339395, 4898.314236007033, 4951.900961980668, 4956.653034287565, 4956.925646115239, 4968.329275547755, 5258.421573626822, 5289.3652761668845, 5290.68255904647, 5293.708846013506, 5312.282841816305, 5293.258943747801, 5334.799670074202, 5350.625456218183, 5351.438098999549, 5362.678239305654, 4993.500649935123, 5078.771455284447, 5123.897522049613, 5149.794008239778, 5157.07172708916, 5074.755820824486, 5102.872428189325, 5106.285120083266, 5119.590432765295, 5119.590432765444, 5080.974595127001, 5106.66806657566, 5112.079825631422, 5131.025105230144, 5175.0, 5064.696118232918, 5190.688558686491, 5223.059849227176, 5229.529342359206, 5246.737663116905, 5105.693658380509, 5147.742612869416, 5147.9227811583605, 5150.99555586672, 5191.896162076813], "value": 4840.186692649219, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.7411233053582, 576.3890276307114, 582.5048708597692, 597.554821657865, 601.6510423954107, 34354.484682729744, 38196.99999999996, 38222.617773822254, 38360.0, 38366.23267534647, 38073.0, 38441.0, 38509.422358664575, 38542.8072859636, 38738.22523549527, 7656.846863062749, 7794.14264430915, 7800.687972481094, 7824.100228473713, 7832.255935686101, 7805.765827025199, 7875.291223789858, 7899.644515996794, 7903.960480197591, 7911.920880791205, 7911.367090632764, 7913.169117242693, 7915.960420197891, 7940.325072368855, 7969.0, 7856.489328193649, 7906.248906353887, 7909.209079092102, 7911.248431399008, 7912.20877912207, 7732.1108072571815, 7778.455508114434, 7778.64996075178, 7802.102758182768, 7809.3752499799875, 37463.06342341436, 37561.81219093914, 37682.81158594217, 37758.24483510342, 37779.24441511182, 3125.46867032605, 3189.61724593048, 3202.247471844138, 3280.4751239801517, 3773.962260377416, 29309.70690293091, 29447.705522944925, 29646.258843528867, 29820.10539683813, 30487.0, 3463.2554000889677, 3470.410030294856, 3492.1269682579355, 3530.0, 3565.108722819295, 267335.0, 267703.0, 268515.0, 268666.0, 271018.6449067762, 31231.531527027113, 51569.2264616031, 52324.73837630863, 52345.7382713084, 52389.47610523922, 32634.0, 34181.65818341785, 34333.82833085819, 34335.0, 34346.48480272798, 12586.18189817659, 12754.55359062447, 12760.0, 12771.680707982376, 12845.357732113356, 10379.169666426667, 10454.581816727246, 10455.16358691303, 10486.73783155412, 10499.475026248658, 7820.139784623687, 7880.64537095832, 7888.368930485547, 7979.561124138112, 8005.439619226599, 3113.081640915935, 3149.937001259962, 3185.0, 3201.199700074981, 3202.295494991098, 842.9367797415218, 922.5986695787354, 958.9616415343447, 972.2659392158874, 1000.5797565022708, 27551.724482755315, 28159.43681126366, 28183.71816281852, 28267.71732282692, 28603.284917876805, 959.1463597398321, 1008.1078245752415, 1025.9538320775582, 1047.4134484688598, 1061.1298735037349, 14499.855001450062, 14923.70152596942, 14935.402583896523, 14938.103713777207, 15201.315940782692, 393080.0, 394094.0, 398067.0, 399829.0, 401876.0, 32990.50514242288, 33168.0, 33199.83400083033, 33273.833630832174, 33483.0, 1110.134095405585, 1110.2228440091806, 1120.843081968525, 1156.6356597671706, 1170.3731812780243, 26273.4745305089, 27317.180484585493, 27380.0, 27423.0, 27776.305592360353, 42547.57452425436, 42636.360454592585, 42965.0, 42974.570254297054, 43254.351184732885, 326172.0, 330381.0, 332679.0, 333018.0, 333306.0, 24989.625155622318, 25033.0, 25265.87367063153, 25431.491370172862, 25505.74494255108, 38782.80608596939, 40673.79663101784, 41257.38113928233, 41564.79217603893, 42556.78721606372, 35751.64248357587, 35760.46359304665, 35767.64232357643, 35870.64129358673, 36105.0, 35425.64574354327, 35765.64234357623, 35797.46303805497, 36061.27877442489, 36358.0, 31962.20094497656, 34978.32727563671, 36171.27657446889, 36288.4556731644, 36997.81501092477, 31580.526292105176, 32313.192170194994, 32781.83609081939, 32872.34255314928, 32993.835030824695, 24782.752172478045, 24804.87597562073, 25027.0, 25173.0, 25347.746522534537], "value": 16290.01341121278, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.4794735317907, 377.66576579726944, 379.50095624254106, 389.851856294608, 393.0939185178163, 15767.763483547742, 16111.677766444678, 17069.57326066849, 17116.31534738609, 17147.39984100557, 15613.375464981416, 16376.508704738848, 16413.671726565462, 16432.0, 17215.139243037862, 3441.4149594568858, 4621.676482646208, 4817.4219093708625, 4820.156472617278, 4822.300766388871, 5252.212168174766, 5547.77808887646, 5560.165975103747, 5635.21107045012, 5639.0, 5581.079121944895, 5626.746796394172, 5653.23681303025, 5660.122680984454, 5671.8582035449035, 5502.174673798922, 5576.749046292926, 5586.497215250647, 5606.55147588192, 5608.495235428831, 5363.436839131913, 5383.973080134574, 5398.4871437213405, 5407.621466497347, 5409.161579955114, 19372.225110995543, 19795.208191672315, 20129.698054529195, 20316.0, 20330.898345508176, 1905.3617038292189, 1909.1981367825547, 1936.0958562156766, 2094.832413406924, 2268.6823844661762, 9003.909960900439, 9103.135202155785, 9343.486108264044, 9354.111359420844, 9429.76425589359, 1714.2800023989955, 1717.1242666240182, 1787.642471505691, 1788.1059470264868, 1850.4826042645036, 48852.75573622145, 70049.0, 72502.2749772506, 73394.63302683452, 79192.20807791906, 15738.68522629541, 16253.59366015859, 16835.24241409115, 17207.655846882994, 17321.0, 29649.25876853096, 29650.851745741133, 29685.406291874042, 30242.54636180459, 30536.847315763724, 7871.724489642949, 8423.789405264917, 8467.110953349933, 8615.22462978335, 8648.524331161847, 6821.420179284717, 6851.862962740817, 6941.68762405693, 6966.651667416609, 7026.473014523931, 3592.946105808415, 8528.232459078712, 8682.392232543662, 8773.254273386707, 8890.86663700045, 1852.0739630184908, 1853.6385404845926, 1873.7657792775904, 1920.5198700324918, 1942.8251457368622, 827.420805436185, 849.592195746033, 855.8587833007608, 904.263025634106, 926.2913870888775, 16795.41216057432, 16825.831741682672, 17086.82913170877, 17515.0, 17687.292508299783, 850.6342272822745, 866.5277423804042, 869.3479890082439, 888.9244414224734, 910.0035461170008, 9187.26501879848, 9332.95333523328, 9688.75778105553, 9690.176335011603, 9694.22446204302, 314807.0, 317197.0, 403546.0, 406185.0, 406922.0, 81638.59180704059, 82058.17941820624, 84902.0, 85013.0, 85598.0, 908.9000209976897, 922.1055576091314, 944.1832814615445, 946.31392240625, 972.0425380999851, 15716.214189290718, 15744.527664170093, 15781.684366312838, 15897.966632168873, 16385.344586216896, 35859.0, 36389.45415818818, 36566.063581417235, 36575.34246575321, 37664.62335376721, 49491.25763113628, 50740.746296268284, 51520.48479515157, 51786.460301987565, 51965.480345197575, 7468.738594149178, 7565.319121279112, 7578.3558397534625, 7618.200088990576, 7738.535687858746, 8934.0, 10658.946705266424, 10880.67357979262, 11245.269057511563, 11514.94242528782, 8644.351673624378, 9070.455772653662, 9221.17009469151, 9381.577828997848, 9683.951580242054, 9382.10869967352, 9414.62341506332, 9763.755906102404, 9859.0, 9898.653547125816, 9331.113544213289, 9380.437173769596, 9514.23886089125, 9672.516374181121, 9838.36050656705, 7556.65995030214, 7567.281108294703, 7591.62041897914, 7690.384769218337, 7754.806129846799, 7686.385089192963, 8928.464292142493, 9137.269018478639, 9263.16631503168, 9359.15767580921], "value": 8595.606877109645, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.9586312410631, 1410.083445760256, 1483.6735918098022, 1664.2427695398594, 1702.8807983441156, 7119.928800711991, 7857.528548287107, 7915.762527124189, 8426.241638252555, 8438.11399803021, 8117.472364296316, 8168.0, 8232.506049637026, 8255.133211012848, 8263.173682631734, 2245.360072379372, 2296.552172326397, 2297.5290065536524, 2309.688192094071, 2315.1202543033623, 2223.499712564676, 2226.487907781211, 2235.508188198602, 2240.630296001166, 2251.4146321956246, 2152.547964927367, 2158.1583182558816, 2161.4056134563043, 2162.7512836023902, 2232.0625337358347, 2192.561487702466, 2222.977770222293, 2232.174095584636, 2242.3048854854883, 2245.2935768815737, 2188.6388745856916, 2195.5828392605513, 2205.746339171, 2225.3880182949656, 2232.754397016327, 8297.95851020747, 8297.95851020747, 8361.16388361165, 8369.246767790928, 8374.874376884352, 4726.338312636233, 4847.757612119415, 4850.587700045465, 4858.174110401205, 4862.027594481118, 2920.415916816645, 2939.617849679549, 2979.1956171833485, 3032.3177285110896, 3049.070033639739, 989.9554520046615, 1010.6816352848829, 1025.3335332034162, 1031.3347890610514, 1038.5638032026568, 11131.777364452666, 11275.718107047307, 11278.605248816335, 11322.886771132265, 11334.886651133465, 4338.414314067623, 4417.514073451917, 4518.887027824265, 4561.703489273186, 4566.292224705176, 9603.183729383081, 9611.471369074769, 9623.182029527428, 9625.663101791544, 9657.0, 4909.165441874889, 4913.852584422473, 4916.532929371704, 4926.211806111005, 4931.852044438672, 3933.2920074386884, 4187.413762073312, 4253.191893540217, 4258.382534532476, 4353.978230108829, 3735.477033215352, 3761.4169803680475, 3842.1355195080882, 3885.106425522146, 3902.9462045247624, 1233.2292317301687, 1233.8149277608431, 1237.6039667306375, 1247.3638444393243, 1249.9812502812465, 695.3081683724625, 825.9132791056973, 830.5764060329154, 835.3609488741118, 835.7534527314457, 5106.234064890222, 5182.144946083854, 5396.271503347077, 5423.349198096174, 5445.482679145475, 400.71348985475527, 408.3099561740649, 409.26741133371524, 415.40182137721587, 418.16575931017815, 3691.53855768029, 3697.482352470656, 3700.8519659213866, 3774.358359078908, 3788.659020688096, 9730.464824434725, 10160.390376577428, 10241.795164096826, 10270.589176433008, 10297.794044119075, 9747.951260243653, 9992.200623950066, 10045.497725113715, 10056.446895420822, 10069.899301006895, 7580.431467639949, 7623.7712868612925, 7677.769666910001, 7680.34717049046, 7709.691612335556, 5125.641205115755, 5172.71550064735, 5204.895902082013, 5310.575153987749, 5323.228131920927, 9267.53662316895, 9383.249340052917, 9405.05949405054, 9418.199453046567, 9428.010058943986, 8909.020007799007, 9222.907770922206, 9223.538823058954, 9490.762730931781, 9541.379810312308, 6177.0, 6852.349026842442, 7054.4003759681, 7081.291870812877, 7187.7843664690145, 7791.727289544839, 7892.36861051103, 7953.32396746283, 8004.279614834692, 8004.439689221698, 6832.965835170792, 6955.8608827822145, 7065.894011589728, 7129.643517824192, 7132.037174981311, 6997.195322537973, 7022.6488675565, 7083.724929512531, 7112.537685050455, 7232.276772322725, 5923.4076592340425, 6149.2313460817395, 6161.784337548164, 6275.748970041147, 6293.779717710041, 4437.534058923767, 4566.88582785433, 4581.404417425713, 4671.019085991979, 4688.413948256468, 4512.255477846119, 4637.466691330405, 4689.6717229793585, 4709.152352576432, 4732.337472753748], "value": 4195.680849517212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.7104207565926, 315.3834254033365, 315.430647680936, 322.2234415059705, 323.81380706094, 5160.116557456529, 5219.5041471060285, 5220.32135822343, 5228.163493840986, 5240.86897827554, 5077.339945807049, 5093.134167191577, 5134.691918484894, 5165.251038599401, 5174.637775355717, 3826.48342473766, 3920.84316627336, 4033.5764744701823, 4040.939385909214, 4055.087605288816, 4034.5561988181275, 4038.3336749436453, 4048.251073551388, 4052.452918855961, 4060.2691515527194, 3918.8628398006076, 3994.600539945997, 4013.6789056875527, 4019.557848636662, 4025.0742329264285, 3731.8134093295225, 3925.528936527606, 3931.312020396419, 4033.35466325388, 4045.292073887058, 3417.2823707021557, 3422.093145316493, 3432.48512723091, 3434.295969326307, 3440.896773096811, 4938.530839570235, 4943.1102401567705, 4946.233333833262, 4946.554810067075, 5036.496350364971, 4234.30134027885, 4475.351074094271, 4487.955120448786, 4493.168763778712, 4520.028193938319, 5328.6269961102735, 5334.5732341412595, 5342.946570534323, 5360.16917377807, 5373.731313434313, 3743.1390780120723, 3745.606711295302, 3746.4754934309217, 3759.3797023491093, 3783.0, 5328.147496400557, 5627.6060675752715, 5643.407442218549, 5670.546356291528, 5677.318721753375, 3855.8072096395067, 3869.6517313441364, 3872.244912242086, 3875.903102422462, 3889.2999260132883, 3930.8427662893164, 3944.447777311179, 3945.822437990297, 3953.486046813896, 3954.62431069048, 4484.775761211927, 4499.370088187657, 4528.207563676344, 4535.820686621502, 4559.316102584638, 5065.898682026339, 5321.813736519203, 5330.626856120034, 5337.893242135136, 5372.489613486712, 1354.3296068446182, 1366.8223130992908, 1381.9585412437643, 1383.5157694806737, 1383.661003054238, 856.9314454843598, 864.3344624638993, 879.4082710294388, 882.4705176893813, 903.3044555692212, 4625.149940024017, 4689.835855745033, 4692.5307469253485, 4703.129920964632, 4718.504557021532, 5490.670559766427, 5495.9832431000395, 5507.256520369699, 5507.284053073075, 5542.002439560837, 4536.183486972377, 4650.0, 4685.2035154023215, 4686.882827929329, 4705.12955103307, 2924.8683809228637, 2943.543750718642, 2943.955840662392, 2948.3513627002453, 2948.6756456789735, 5150.330457040635, 5150.742462876841, 5165.948340516622, 5166.870828229325, 5171.9482805171465, 5497.230387745719, 5519.47080128107, 5610.747516361774, 5629.4652008059165, 5671.659700417906, 5113.74431278442, 5130.948690513047, 5132.769025393866, 5135.6918584885025, 5181.248718935809, 5473.945260547343, 5496.6701997880255, 5501.679596896796, 5502.779888804403, 5503.2020357048805, 5141.640085194001, 5318.7340632967425, 5360.597955153457, 5369.3556773187465, 5389.919151212656, 5118.948810511847, 5129.333186685707, 5140.100482415488, 5149.716765577929, 5163.690178589297, 3845.5577608574254, 3869.9419508707956, 3883.5339759229073, 3888.4361767544115, 3901.1612503311926, 5343.7060961647485, 5429.67421954684, 5436.211749296251, 5438.70087145195, 5487.917681234864, 5236.0, 5273.683578985273, 5290.497402746733, 5308.893822123613, 5324.1747529133045, 4965.950340496549, 5217.582593392595, 5263.0, 5279.656822306538, 5302.443243459536, 5177.430482646982, 5202.765875535686, 5224.895502090013, 5242.842714718412, 5246.763895624782, 5133.6919784813035, 5209.426963034139, 5358.678479291255, 5384.196294241473, 5471.261379713687, 5298.629095963245, 5317.2555842181355, 5327.6270661054905, 5332.33345831771, 5348.117560602613], "value": 4014.961582232176, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.274864899961, 716.7491378017694, 728.9781306560803, 749.9325060744532, 783.8040489877529, 11562.47968841402, 12553.0, 12560.43478043488, 12610.747785044294, 12624.116311858174, 12217.38913054348, 12250.509979600805, 12358.073144514152, 12414.689632759162, 12426.937865310683, 611.9020956646938, 763.427429427929, 763.8854171874208, 766.2796970847413, 790.8260182759784, 774.5623722596742, 775.5695588948131, 776.216021817965, 776.4797585617649, 778.6573907480719, 833.2958649940821, 835.3859912963967, 835.9665613375488, 837.4431003382743, 839.5046922315832, 821.5522540215596, 823.5511646152861, 824.2211110500549, 824.9587520623945, 826.0129145670926, 605.4823126227101, 606.2149516376303, 606.6329870428416, 606.9453749162552, 607.4866737606716, 11958.461869215906, 12020.879791202064, 12061.09541784361, 12062.276263424223, 12086.093542984223, 13454.461821527128, 13639.727205455934, 13968.511102111377, 13972.93013534936, 14008.789868151986, 10872.402017889013, 10902.563897444094, 10934.0, 10987.780244395068, 11029.61396351132, 3393.1347506385714, 3429.228423604694, 3430.0567343980356, 3448.0, 3531.0289670340603, 57753.0, 57943.0, 58331.41668583302, 59954.002299885266, 60505.6974715128, 10736.463176841127, 10829.241953063367, 10855.728606784893, 10907.400092994803, 10907.821577280742, 17609.20758565842, 17621.823781762276, 17638.91180544089, 17794.199261033285, 17810.821891780917, 6816.352446517573, 6969.686364113627, 7197.46019048563, 7251.3836323912, 7301.488895777245, 3604.1710406606626, 3617.3127105849803, 3655.853765849336, 3719.702423806089, 3774.490443790108, 3024.077656314801, 3144.4654408750566, 3159.794613350125, 3160.5891234139876, 3166.825824579624, 565.3018522125172, 588.5556404914263, 596.1832289763053, 597.3399393670019, 608.3764141754737, 396.1186360348202, 467.67496589869717, 479.441450709919, 483.3571350104353, 490.43844797706424, 7043.0, 7426.925730742623, 7565.356944659766, 7576.8484630308185, 7665.348445382205, 525.8869343091254, 529.7324850950246, 553.1122548309985, 556.9832905012856, 558.3829867995887, 3376.307856889332, 3409.2499650076943, 3456.9308613827584, 3525.11872031992, 3598.442241452579, 53534.464655353724, 53565.732171338896, 53672.463275367525, 55188.44811551833, 69232.65383673151, 81406.18593814105, 83251.5837420809, 84089.57955210184, 85362.57318713366, 85823.57088214518, 44480.21918136995, 44794.32808507875, 45929.54070459319, 47301.76349118301, 71853.64073179601, 6942.271061538466, 6966.616836074065, 7049.577025378494, 7082.893756593552, 7230.313120253568, 40601.39097913475, 40762.59237407588, 40888.59111408848, 41934.0, 42094.0, 35396.0, 56466.153007704095, 56648.433515665965, 56845.43154568401, 57501.137482938626, 8835.64657413722, 9026.819463610822, 9057.909420905706, 9308.720738377859, 9389.85915211286, 10261.179105671677, 10275.640352587623, 10285.485725713834, 10285.691429257135, 10295.433751143759, 9263.397879137834, 9337.906620933703, 9474.052594740471, 9478.146966773023, 9532.142107210384, 9809.313348065567, 9890.357126786736, 10084.445355505517, 10299.588016479256, 10456.738581535523, 8939.865902011605, 9242.815143696955, 9429.62281508732, 9459.952700236454, 9560.521973901416, 8115.0, 8151.358312077509, 8312.0, 8330.833383332421, 8582.227599515823, 8096.757097287091, 8236.176382361717, 8323.375746818892, 8347.20735719652, 8362.163783621589], "value": 6036.719863598502, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 108.0, 112.0, 115.0, 115.0, 116.0, 113.0, 114.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 139.0, 159.0, 178.0, 131.0, 168.0, 161.0, 134.0, 184.0, 136.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 179.0, 164.0, 162.0, 162.0, 162.0, 165.0, 163.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 180.0, 76.0, 76.0, 78.0, 76.0, 156.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 146.0, 87.0, 87.0, 88.0, 134.0, 86.0, 86.0, 142.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 119.0, 118.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 155.0, 151.0, 151.0, 149.0, 149.0, 149.0, 149.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 62.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 65.0, 65.0, 66.0, 64.0, 63.0, 64.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 82.0, 84.0, 83.0, 85.0, 88.0, 90.0, 83.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 142.0, 139.0, 137.0, 135.0, 141.0, 136.0, 135.0, 134.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 167.0, 167.0, 171.0, 167.0, 171.0, 168.0, 164.0, 162.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 67.0, 67.0, 70.0, 67.0, 67.0, 70.0, 66.0, 66.0], "value": 67.8, "unit": "score"}]}]} 19:52:46 INFO - Return code: 0 19:52:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:52:47 ERROR - # TBPL SUCCESS # 19:52:47 INFO - Running post-action listener: _resource_record_post_action 19:52:47 INFO - ##### 19:52:47 INFO - ##### Finished run-tests step (success) 19:52:47 INFO - ##### 19:52:47 INFO - Running post-run listener: _resource_record_post_run 19:52:47 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 548143104; Read time: 304; Write time: 429844 19:52:47 INFO - TinderboxPrint: CPU usage
13.4% 19:52:47 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 304 19:52:47 INFO - TinderboxPrint: I/O write bytes / time
548,143,104 / 429,844 19:52:47 INFO - TinderboxPrint: CPU idle
8,271.0 (86.6%) 19:52:47 INFO - TinderboxPrint: CPU user
1,230.2 (12.9%) 19:52:47 INFO - TinderboxPrint: Swap in / out
0 / 0 19:52:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246517760; Read time: 0; Write time: 267792 19:52:47 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 12288; Write bytes: 301625344; Read time: 304; Write time: 162052 19:52:47 INFO - Running post-run listener: _upload_blobber_files 19:52:47 INFO - Blob upload gear active. 19:52:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:52:47 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 19:52:47 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'] 19:52:47 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 19:52:48 INFO - (blobuploader) - INFO - Open directory for files ... 19:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:52:48 INFO - (blobuploader) - INFO - Done attempting. 19:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:52:49 INFO - (blobuploader) - INFO - Done attempting. 19:52:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:52:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:52:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:52:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:52:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:52:54 INFO - (blobuploader) - INFO - Done attempting. 19:52:54 INFO - (blobuploader) - INFO - Iteration through files over. 19:52:54 INFO - Return code: 0 19:52:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:52:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:52:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c2413e96194dbcd0c67d276e3cd20f870ce5abb5a88cd6b61cd864fdb3934eaa84ba1e36c218bb887900d52571d7232df3b6a917d7508156ece423381625d4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae67ac6413a9e31ec40cfe9d0883869dae479fec28b9c0d1ca5ad3fc1e8447aac610763f0b6bfea51f85cecabfd0b45b46fbcb6d828386ddef18fbc2bb76865e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4be78d97c49356a9fdd3effe5852614a0a65cb98d917fef78876d248d59d3dfa561cf13bd548f6df70fc3a70c02cc71c2d49c6a73befdc4a2dfa5695d267b459"} 19:52:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:52:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:52:54 INFO - Contents: 19:52:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5c2413e96194dbcd0c67d276e3cd20f870ce5abb5a88cd6b61cd864fdb3934eaa84ba1e36c218bb887900d52571d7232df3b6a917d7508156ece423381625d4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae67ac6413a9e31ec40cfe9d0883869dae479fec28b9c0d1ca5ad3fc1e8447aac610763f0b6bfea51f85cecabfd0b45b46fbcb6d828386ddef18fbc2bb76865e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4be78d97c49356a9fdd3effe5852614a0a65cb98d917fef78876d248d59d3dfa561cf13bd548f6df70fc3a70c02cc71c2d49c6a73befdc4a2dfa5695d267b459"} 19:52:54 INFO - Running post-run listener: copy_logs_to_upload_dir 19:52:54 INFO - Copying logs to upload dir... 19:52:54 INFO - mkdir: /builds/slave/test/build/upload/logs 19:52:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.291074 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-27 19:52:54.579646) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 19:52:54.583728) ========= 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=523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765 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/5c2413e96194dbcd0c67d276e3cd20f870ce5abb5a88cd6b61cd864fdb3934eaa84ba1e36c218bb887900d52571d7232df3b6a917d7508156ece423381625d4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae67ac6413a9e31ec40cfe9d0883869dae479fec28b9c0d1ca5ad3fc1e8447aac610763f0b6bfea51f85cecabfd0b45b46fbcb6d828386ddef18fbc2bb76865e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4be78d97c49356a9fdd3effe5852614a0a65cb98d917fef78876d248d59d3dfa561cf13bd548f6df70fc3a70c02cc71c2d49c6a73befdc4a2dfa5695d267b459"} build_url:https://queue.taskcluster.net/v1/task/IvPY60H9Q7iFVD5qmRP5JA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/IvPY60H9Q7iFVD5qmRP5JA/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/5c2413e96194dbcd0c67d276e3cd20f870ce5abb5a88cd6b61cd864fdb3934eaa84ba1e36c218bb887900d52571d7232df3b6a917d7508156ece423381625d4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae67ac6413a9e31ec40cfe9d0883869dae479fec28b9c0d1ca5ad3fc1e8447aac610763f0b6bfea51f85cecabfd0b45b46fbcb6d828386ddef18fbc2bb76865e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4be78d97c49356a9fdd3effe5852614a0a65cb98d917fef78876d248d59d3dfa561cf13bd548f6df70fc3a70c02cc71c2d49c6a73befdc4a2dfa5695d267b459"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 19:52:54.609897) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:52:54.610482) ========= 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=523ca41ca1e0623de333ad52000001bf-1467081132.915544-1592709765 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:52:54.693543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 19:52:54.693853) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 19:52:54.694143) ========= ========= Total master_lag: 0.17 =========