builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1465560758.97 results: success (0) buildid: 20160610023030 builduid: 7960a9e2ffba41f0adfd78a3aa8ac46b revision: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:38.973877) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:38.982996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:38.983328) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:39.032021) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:39.032322) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 05:12:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.0M=0s 2016-06-10 05:12:39 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137979 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:39.186161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:39.186707) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019585 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:39.236864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-10 05:12:39.237169) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9c0dce75ed0c21e0b05ba72c348da23b27e80888 --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 9c0dce75ed0c21e0b05ba72c348da23b27e80888 --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=74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 05:12:39,648 truncating revision to first 12 chars 2016-06-10 05:12:39,648 Setting DEBUG logging. 2016-06-10 05:12:39,648 attempt 1/10 2016-06-10 05:12:39,648 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9c0dce75ed0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 05:12:40,869 unpacking tar archive at: fx-team-9c0dce75ed0c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.007166 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-10 05:12:41.257442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:41.257767) ========= script_repo_revision: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:41.258154) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:41.258505) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:12:41.270173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-10 05:12:41.270865) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:12:41 INFO - MultiFileLogger online at 20160610 05:12:41 in /builds/slave/test 05:12:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:12:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:12:41 INFO - {'append_to_log': False, 05:12:41 INFO - 'base_work_dir': '/builds/slave/test', 05:12:41 INFO - 'blob_upload_branch': 'Fx-Team', 05:12:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:12:41 INFO - 'branch': 'Fx-Team', 05:12:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:12:41 INFO - 'config_files': ('talos/linux_config.py',), 05:12:41 INFO - 'default_actions': ('clobber', 05:12:41 INFO - 'read-buildbot-config', 05:12:41 INFO - 'download-and-extract', 05:12:41 INFO - 'populate-webroot', 05:12:41 INFO - 'create-virtualenv', 05:12:41 INFO - 'install', 05:12:41 INFO - 'run-tests'), 05:12:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:12:41 INFO - 'download_minidump_stackwalk': True, 05:12:41 INFO - 'download_symbols': 'ondemand', 05:12:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:12:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:12:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:12:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:12:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:12:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:12:41 INFO - 'installer_path': 'installer.exe', 05:12:41 INFO - 'log_level': 'info', 05:12:41 INFO - 'log_name': 'talos', 05:12:41 INFO - 'log_to_console': True, 05:12:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:12:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:12:41 INFO - 'opt_config_files': (), 05:12:41 INFO - 'pip_index': False, 05:12:41 INFO - 'sps_profile': False, 05:12:41 INFO - 'sps_profile_interval': 0, 05:12:41 INFO - 'suite': 'dromaeojs-e10s', 05:12:41 INFO - 'system_bits': '32', 05:12:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:12:41 INFO - 'title': 'talos-linux64-ix-042', 05:12:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:12:41 INFO - 'use_talos_json': True, 05:12:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:12:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:12:41 INFO - 'work_dir': 'build'} 05:12:41 INFO - ##### 05:12:41 INFO - ##### Running clobber step. 05:12:41 INFO - ##### 05:12:41 INFO - Running pre-action listener: _resource_record_pre_action 05:12:41 INFO - Running main action method: clobber 05:12:41 INFO - rmtree: /builds/slave/test/build 05:12:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:12:42 INFO - Running post-action listener: _resource_record_post_action 05:12:42 INFO - ##### 05:12:42 INFO - ##### Finished clobber step (success) 05:12:42 INFO - ##### 05:12:42 INFO - ##### 05:12:42 INFO - ##### Running read-buildbot-config step. 05:12:42 INFO - ##### 05:12:42 INFO - Running pre-action listener: _resource_record_pre_action 05:12:42 INFO - Running main action method: read_buildbot_config 05:12:42 INFO - Using buildbot properties: 05:12:42 INFO - { 05:12:42 INFO - "project": "", 05:12:42 INFO - "product": "firefox", 05:12:42 INFO - "script_repo_revision": "production", 05:12:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:12:42 INFO - "repository": "", 05:12:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:12:42 INFO - "buildid": "20160610023030", 05:12:42 INFO - "pgo_build": "True", 05:12:42 INFO - "basedir": "/builds/slave/test", 05:12:42 INFO - "buildnumber": 825, 05:12:42 INFO - "slavename": "talos-linux64-ix-042", 05:12:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:12:42 INFO - "platform": "ubuntu64_hw", 05:12:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:12:42 INFO - "branch": "fx-team", 05:12:42 INFO - "repo_path": "integration/fx-team", 05:12:42 INFO - "revision": "9c0dce75ed0c21e0b05ba72c348da23b27e80888", 05:12:42 INFO - "stage_platform": "linux64-pgo", 05:12:42 INFO - "builduid": "7960a9e2ffba41f0adfd78a3aa8ac46b", 05:12:42 INFO - "slavebuilddir": "test" 05:12:42 INFO - } 05:12:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:12:42 INFO - Running post-action listener: _resource_record_post_action 05:12:42 INFO - ##### 05:12:42 INFO - ##### Finished read-buildbot-config step (success) 05:12:42 INFO - ##### 05:12:42 INFO - ##### 05:12:42 INFO - ##### Running download-and-extract step. 05:12:42 INFO - ##### 05:12:42 INFO - Running pre-action listener: _resource_record_pre_action 05:12:42 INFO - Running main action method: download_and_extract 05:12:42 INFO - mkdir: /builds/slave/test/build/tests 05:12:42 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')]} 05:12:42 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:12:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:12:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:12:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:12:45 INFO - Downloaded 1361 bytes. 05:12:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:12:45 INFO - Using the following test package requirements: 05:12:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:12:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:12:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:45 INFO - u'jsshell-linux-x86_64.zip'], 05:12:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:12:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:12:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:12:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:12:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:12:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:12:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:12:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:12: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')]} 05:12:45 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:12:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:12:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:12:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:12:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:12:50 INFO - Downloaded 24452446 bytes. 05:12:50 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'] 05:12:50 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 05:12:52 INFO - Return code: 0 05:12:52 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 05:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:52 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:12:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:12:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:12:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:12:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:12:54 INFO - Downloaded 24452446 bytes. 05:12:54 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'] 05:12:54 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 05:12:55 INFO - Return code: 0 05:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:55 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:12:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:12:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:12:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:12:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:12:59 INFO - Downloaded 10833377 bytes. 05:12:59 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'] 05:12:59 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 05:12:59 INFO - Return code: 0 05:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:59 INFO - https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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 05:13:04 INFO - Downloaded 59292349 bytes. 05:13:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:13:04 INFO - mkdir: /builds/slave/test/properties 05:13:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:13:04 INFO - Writing to file /builds/slave/test/properties/build_url 05:13:04 INFO - Contents: 05:13:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:13:04 INFO - Running post-action listener: _resource_record_post_action 05:13:04 INFO - Running post-action listener: set_extra_try_arguments 05:13:04 INFO - ##### 05:13:04 INFO - ##### Finished download-and-extract step (success) 05:13:04 INFO - ##### 05:13:04 INFO - ##### 05:13:04 INFO - ##### Running populate-webroot step. 05:13:04 INFO - ##### 05:13:04 INFO - Running pre-action listener: _resource_record_pre_action 05:13:04 INFO - Running main action method: populate_webroot 05:13:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:13:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:13:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:13:04 INFO - '--tppagecycles', 05:13:04 INFO - '7'], 05:13:04 INFO - 'tests': ['tsvgm']}}, 05:13:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:13:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:13:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:13:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:13:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:13:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:13:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:04 INFO - 'talos_options': ['--disable-e10s'], 05:13:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:04 INFO - 'talos_options': ['--disable-e10s'], 05:13:04 INFO - 'tests': ['damp', 'tps']}, 05:13:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:04 INFO - 'tests': ['damp', 'tps']}, 05:13:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:13:04 INFO - 'tests': ['dromaeo_dom']}, 05:13:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:13:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:13:04 INFO - 'tests': ['a11yr', 05:13:04 INFO - 'ts_paint', 05:13:04 INFO - 'tpaint', 05:13:04 INFO - 'sessionrestore', 05:13:04 INFO - 'sessionrestore_no_auto_restore', 05:13:04 INFO - 'tabpaint']}, 05:13:04 INFO - 'other-e10s': {'tests': ['a11yr', 05:13:04 INFO - 'ts_paint', 05:13:04 INFO - 'tpaint', 05:13:04 INFO - 'sessionrestore', 05:13:04 INFO - 'sessionrestore_no_auto_restore', 05:13:04 INFO - 'tabpaint']}, 05:13:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:13:04 INFO - 'ts_paint', 05:13:04 INFO - 'tpaint', 05:13:04 INFO - 'sessionrestore', 05:13:04 INFO - 'sessionrestore_no_auto_restore', 05:13:04 INFO - 'tabpaint']}, 05:13:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:13:04 INFO - 'ts_paint', 05:13:04 INFO - 'tpaint', 05:13:04 INFO - 'sessionrestore', 05:13:04 INFO - 'sessionrestore_no_auto_restore', 05:13:04 INFO - 'tabpaint']}, 05:13:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:13:04 INFO - 'tests': ['a11yr', 05:13:04 INFO - 'ts_paint', 05:13:04 INFO - 'tpaint', 05:13:04 INFO - 'sessionrestore', 05:13:04 INFO - 'sessionrestore_no_auto_restore', 05:13:04 INFO - 'tabpaint']}, 05:13:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:13:04 INFO - 'tests': ['a11yr', 05:13:04 INFO - 'ts_paint', 05:13:04 INFO - 'tpaint', 05:13:04 INFO - 'sessionrestore', 05:13:04 INFO - 'sessionrestore_no_auto_restore', 05:13:04 INFO - 'tabpaint']}, 05:13:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:13:04 INFO - 'tests': ['tsvgx', 05:13:04 INFO - 'tsvgr_opacity', 05:13:04 INFO - 'tart', 05:13:04 INFO - 'tscrollx', 05:13:04 INFO - 'cart']}, 05:13:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:13:04 INFO - 'tsvgr_opacity', 05:13:04 INFO - 'tart', 05:13:04 INFO - 'tscrollx', 05:13:04 INFO - 'cart']}, 05:13:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:04 INFO - 'talos_options': ['--disable-e10s'], 05:13:04 INFO - 'tests': ['tp5o']}, 05:13:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:04 INFO - 'tests': ['tp5o']}, 05:13:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:04 INFO - 'talos_options': ['--disable-e10s', 05:13:04 INFO - '--xperf_path', 05:13:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:04 INFO - 'tests': ['tp5n']}, 05:13:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:04 INFO - 'talos_options': ['--xperf_path', 05:13:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:04 INFO - 'tests': ['tp5n']}}, 05:13:04 INFO - 'talos.zip': {'path': '', 05:13:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:13:04 INFO - Running post-action listener: _resource_record_post_action 05:13:04 INFO - ##### 05:13:04 INFO - ##### Finished populate-webroot step (success) 05:13:04 INFO - ##### 05:13:04 INFO - ##### 05:13:04 INFO - ##### Running create-virtualenv step. 05:13:04 INFO - ##### 05:13:04 INFO - Running pre-action listener: _resource_record_pre_action 05:13:04 INFO - Running main action method: create_virtualenv 05:13:04 INFO - Creating virtualenv /builds/slave/test/build/venv 05:13:04 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 05:13:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:13:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:13:04 INFO - Using real prefix '/usr' 05:13:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:13:05 INFO - Installing distribute.............................................................................................................................................................................................done. 05:13:07 INFO - Installing pip.................done. 05:13:07 INFO - Return code: 0 05:13:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:07 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 0x7fb438f63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e110>, '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 0x26ba230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ba6c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', '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 05:13:07 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 05:13:07 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 05:13:07 INFO - Using env: {'DISPLAY': ':0', 05:13:07 INFO - 'HOME': '/home/cltbld', 05:13:07 INFO - 'LANG': 'en_US.UTF-8', 05:13:07 INFO - 'LANGUAGE': 'en_US:en', 05:13:07 INFO - 'LOGNAME': 'cltbld', 05:13:07 INFO - 'MAIL': '/var/mail/cltbld', 05:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:07 INFO - 'MOZ_NO_REMOTE': '1', 05:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:07 INFO - 'NO_EM_RESTART': '1', 05:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:07 INFO - 'PWD': '/builds/slave/test', 05:13:07 INFO - 'SHELL': '/bin/bash', 05:13:07 INFO - 'SHLVL': '1', 05:13:07 INFO - 'TERM': 'linux', 05:13:07 INFO - 'TMOUT': '86400', 05:13:07 INFO - 'USER': 'cltbld', 05:13:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', 05:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:07 INFO - '_': '/tools/buildbot/bin/python'} 05:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:07 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 05:13:07 INFO - Cleaning up... 05:13:07 INFO - Return code: 0 05:13:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:07 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 0x7fb438f63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e110>, '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 0x26ba230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ba6c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', '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 05:13:07 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 05:13:07 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 05:13:07 INFO - Using env: {'DISPLAY': ':0', 05:13:07 INFO - 'HOME': '/home/cltbld', 05:13:07 INFO - 'LANG': 'en_US.UTF-8', 05:13:07 INFO - 'LANGUAGE': 'en_US:en', 05:13:07 INFO - 'LOGNAME': 'cltbld', 05:13:07 INFO - 'MAIL': '/var/mail/cltbld', 05:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:07 INFO - 'MOZ_NO_REMOTE': '1', 05:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:07 INFO - 'NO_EM_RESTART': '1', 05:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:07 INFO - 'PWD': '/builds/slave/test', 05:13:07 INFO - 'SHELL': '/bin/bash', 05:13:07 INFO - 'SHLVL': '1', 05:13:07 INFO - 'TERM': 'linux', 05:13:07 INFO - 'TMOUT': '86400', 05:13:07 INFO - 'USER': 'cltbld', 05:13:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', 05:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:07 INFO - '_': '/tools/buildbot/bin/python'} 05:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:07 INFO - Downloading/unpacking psutil>=3.1.1 05:13:07 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 05:13:07 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 05:13:07 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 05:13:07 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 05:13:07 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 05:13:07 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 05:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:13:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:09 INFO - Installing collected packages: psutil 05:13:09 INFO - Running setup.py install for psutil 05:13:09 INFO - building 'psutil._psutil_linux' extension 05:13:09 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 05:13:10 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 05:13:10 INFO - building 'psutil._psutil_posix' extension 05:13:10 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 05:13:10 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 05:13:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:10 INFO - Successfully installed psutil 05:13:10 INFO - Cleaning up... 05:13:10 INFO - Return code: 0 05:13:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:13:10 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')]} 05:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:10 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')]} 05:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:10 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 0x7fb438f63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e110>, '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 0x26ba230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ba6c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', '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 05:13:10 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 05:13:10 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 05:13:10 INFO - Using env: {'DISPLAY': ':0', 05:13:10 INFO - 'HOME': '/home/cltbld', 05:13:10 INFO - 'LANG': 'en_US.UTF-8', 05:13:10 INFO - 'LANGUAGE': 'en_US:en', 05:13:10 INFO - 'LOGNAME': 'cltbld', 05:13:10 INFO - 'MAIL': '/var/mail/cltbld', 05:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:10 INFO - 'MOZ_NO_REMOTE': '1', 05:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:10 INFO - 'NO_EM_RESTART': '1', 05:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:10 INFO - 'PWD': '/builds/slave/test', 05:13:10 INFO - 'SHELL': '/bin/bash', 05:13:10 INFO - 'SHLVL': '1', 05:13:10 INFO - 'TERM': 'linux', 05:13:10 INFO - 'TMOUT': '86400', 05:13:10 INFO - 'USER': 'cltbld', 05:13:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', 05:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:10 INFO - '_': '/tools/buildbot/bin/python'} 05:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:13:10 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 05:13:10 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 05:13:10 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 05:13:10 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 05:13:10 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 05:13:10 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 05:13:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:13:12 INFO - Installing collected packages: mozsystemmonitor 05:13:12 INFO - Running setup.py install for mozsystemmonitor 05:13:12 INFO - Successfully installed mozsystemmonitor 05:13:12 INFO - Cleaning up... 05:13:12 INFO - Return code: 0 05:13:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb438f63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e110>, '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 0x26ba230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ba6c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', '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 05:13:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:13:12 INFO - Using env: {'DISPLAY': ':0', 05:13:12 INFO - 'HOME': '/home/cltbld', 05:13:12 INFO - 'LANG': 'en_US.UTF-8', 05:13:12 INFO - 'LANGUAGE': 'en_US:en', 05:13:12 INFO - 'LOGNAME': 'cltbld', 05:13:12 INFO - 'MAIL': '/var/mail/cltbld', 05:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:12 INFO - 'MOZ_NO_REMOTE': '1', 05:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:12 INFO - 'NO_EM_RESTART': '1', 05:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:12 INFO - 'PWD': '/builds/slave/test', 05:13:12 INFO - 'SHELL': '/bin/bash', 05:13:12 INFO - 'SHLVL': '1', 05:13:12 INFO - 'TERM': 'linux', 05:13:12 INFO - 'TMOUT': '86400', 05:13:12 INFO - 'USER': 'cltbld', 05:13:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', 05:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:12 INFO - '_': '/tools/buildbot/bin/python'} 05:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:12 INFO - Downloading/unpacking jsonschema==2.5.1 05:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:13:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:13:14 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 05:13:14 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 05:13:14 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 05:13:14 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 05:13:14 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 05:13:14 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 05:13:14 INFO - Downloading functools32-3.2.3-2.tar.gz 05:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:13:15 INFO - warning: no files found matching '*.txt' 05:13:15 INFO - no previously-included directories found matching 'build' 05:13:15 INFO - no previously-included directories found matching 'dist' 05:13:15 INFO - no previously-included directories found matching '.git*' 05:13:15 INFO - Installing collected packages: jsonschema, functools32 05:13:15 INFO - Running setup.py install for functools32 05:13:15 INFO - warning: no files found matching '*.txt' 05:13:15 INFO - no previously-included directories found matching 'build' 05:13:15 INFO - no previously-included directories found matching 'dist' 05:13:15 INFO - no previously-included directories found matching '.git*' 05:13:15 INFO - Successfully installed jsonschema functools32 05:13:15 INFO - Cleaning up... 05:13:15 INFO - Return code: 0 05:13:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb438f63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e110>, '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 0x26ba230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ba6c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', '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 05:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:13:15 INFO - Using env: {'DISPLAY': ':0', 05:13:15 INFO - 'HOME': '/home/cltbld', 05:13:15 INFO - 'LANG': 'en_US.UTF-8', 05:13:15 INFO - 'LANGUAGE': 'en_US:en', 05:13:15 INFO - 'LOGNAME': 'cltbld', 05:13:15 INFO - 'MAIL': '/var/mail/cltbld', 05:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:15 INFO - 'MOZ_NO_REMOTE': '1', 05:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:15 INFO - 'NO_EM_RESTART': '1', 05:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:15 INFO - 'PWD': '/builds/slave/test', 05:13:15 INFO - 'SHELL': '/bin/bash', 05:13:15 INFO - 'SHLVL': '1', 05:13:15 INFO - 'TERM': 'linux', 05:13:15 INFO - 'TMOUT': '86400', 05:13:15 INFO - 'USER': 'cltbld', 05:13:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', 05:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:15 INFO - '_': '/tools/buildbot/bin/python'} 05:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:15 INFO - Downloading/unpacking blobuploader==1.2.4 05:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:17 INFO - Downloading blobuploader-1.2.4.tar.gz 05:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:13:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:13:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:18 INFO - Downloading docopt-0.6.1.tar.gz 05:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:13:18 INFO - Installing collected packages: blobuploader, requests, docopt 05:13:18 INFO - Running setup.py install for blobuploader 05:13:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:13:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:13:18 INFO - Running setup.py install for requests 05:13:18 INFO - Running setup.py install for docopt 05:13:18 INFO - Successfully installed blobuploader requests docopt 05:13:18 INFO - Cleaning up... 05:13:18 INFO - Return code: 0 05:13:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:18 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 0x7fb438f63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e110>, '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 0x26ba230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ba6c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', '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 05:13:18 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 05:13:18 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 05:13:18 INFO - Using env: {'DISPLAY': ':0', 05:13:18 INFO - 'HOME': '/home/cltbld', 05:13:18 INFO - 'LANG': 'en_US.UTF-8', 05:13:18 INFO - 'LANGUAGE': 'en_US:en', 05:13:18 INFO - 'LOGNAME': 'cltbld', 05:13:18 INFO - 'MAIL': '/var/mail/cltbld', 05:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:18 INFO - 'MOZ_NO_REMOTE': '1', 05:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:18 INFO - 'NO_EM_RESTART': '1', 05:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:18 INFO - 'PWD': '/builds/slave/test', 05:13:18 INFO - 'SHELL': '/bin/bash', 05:13:18 INFO - 'SHLVL': '1', 05:13:18 INFO - 'TERM': 'linux', 05:13:18 INFO - 'TMOUT': '86400', 05:13:18 INFO - 'USER': 'cltbld', 05:13:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', 05:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:18 INFO - '_': '/tools/buildbot/bin/python'} 05:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:19 INFO - Running setup.py (path:/tmp/pip-WGiSE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:19 INFO - Running setup.py (path:/tmp/pip-xcBzia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:19 INFO - Running setup.py (path:/tmp/pip-wXfebJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:19 INFO - Running setup.py (path:/tmp/pip-Uw7tex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:19 INFO - Running setup.py (path:/tmp/pip-Pb_buX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:19 INFO - Running setup.py (path:/tmp/pip-DIZkCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:19 INFO - Running setup.py (path:/tmp/pip-xK3M8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:19 INFO - Running setup.py (path:/tmp/pip-gTQs1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:19 INFO - Running setup.py (path:/tmp/pip-4jiHLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:19 INFO - Running setup.py (path:/tmp/pip-4JoxCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:19 INFO - Running setup.py (path:/tmp/pip-dJG_cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:19 INFO - Running setup.py (path:/tmp/pip-X1TH6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:19 INFO - Running setup.py (path:/tmp/pip-LY6mHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:20 INFO - Running setup.py (path:/tmp/pip-v_vzGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:20 INFO - Running setup.py (path:/tmp/pip-9TJc8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:20 INFO - Running setup.py (path:/tmp/pip-vQnf3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:20 INFO - Running setup.py (path:/tmp/pip-quc5Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:13:20 INFO - Running setup.py install for manifestparser 05:13:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:13:20 INFO - Running setup.py install for mozcrash 05:13:20 INFO - Running setup.py install for mozdebug 05:13:20 INFO - Running setup.py install for mozdevice 05:13:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:13:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:13:20 INFO - Running setup.py install for mozfile 05:13:20 INFO - Running setup.py install for mozhttpd 05:13:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:13:20 INFO - Running setup.py install for mozinfo 05:13:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Running setup.py install for mozInstall 05:13:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Running setup.py install for mozleak 05:13:21 INFO - Running setup.py install for mozlog 05:13:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Running setup.py install for moznetwork 05:13:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Running setup.py install for mozprocess 05:13:21 INFO - Running setup.py install for mozprofile 05:13:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Running setup.py install for mozrunner 05:13:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Running setup.py install for mozscreenshot 05:13:21 INFO - Running setup.py install for moztest 05:13:22 INFO - Running setup.py install for mozversion 05:13:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:13:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:13:22 INFO - Cleaning up... 05:13:22 INFO - Return code: 0 05:13:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:22 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 0x7fb438f63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e110>, '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 0x26ba230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ba6c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', '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 05:13:22 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 05:13:22 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 05:13:22 INFO - Using env: {'DISPLAY': ':0', 05:13:22 INFO - 'HOME': '/home/cltbld', 05:13:22 INFO - 'LANG': 'en_US.UTF-8', 05:13:22 INFO - 'LANGUAGE': 'en_US:en', 05:13:22 INFO - 'LOGNAME': 'cltbld', 05:13:22 INFO - 'MAIL': '/var/mail/cltbld', 05:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:22 INFO - 'MOZ_NO_REMOTE': '1', 05:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:22 INFO - 'NO_EM_RESTART': '1', 05:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:22 INFO - 'PWD': '/builds/slave/test', 05:13:22 INFO - 'SHELL': '/bin/bash', 05:13:22 INFO - 'SHLVL': '1', 05:13:22 INFO - 'TERM': 'linux', 05:13:22 INFO - 'TMOUT': '86400', 05:13:22 INFO - 'USER': 'cltbld', 05:13:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', 05:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:22 INFO - '_': '/tools/buildbot/bin/python'} 05:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:22 INFO - Running setup.py (path:/tmp/pip-0ADpgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:22 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)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:22 INFO - Running setup.py (path:/tmp/pip-w84fpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:22 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)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:22 INFO - Running setup.py (path:/tmp/pip-BlX8gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:22 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)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:22 INFO - Running setup.py (path:/tmp/pip-QHtfgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:22 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)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:22 INFO - Running setup.py (path:/tmp/pip-ZrQuOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:22 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)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:22 INFO - Running setup.py (path:/tmp/pip-M4uoGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:22 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)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:22 INFO - Running setup.py (path:/tmp/pip-KBBKKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:22 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)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:22 INFO - Running setup.py (path:/tmp/pip-7xZBau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:22 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)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:22 INFO - Running setup.py (path:/tmp/pip-uE8Udv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:22 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)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:23 INFO - Running setup.py (path:/tmp/pip-ys5RIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:23 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)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:23 INFO - Running setup.py (path:/tmp/pip-PTRHdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:23 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)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:23 INFO - Running setup.py (path:/tmp/pip-lJ8BZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:23 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)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:23 INFO - Running setup.py (path:/tmp/pip-mmSXz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:23 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)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:23 INFO - Running setup.py (path:/tmp/pip-9fpfFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:23 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)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:23 INFO - Running setup.py (path:/tmp/pip-3mC5uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:23 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)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:23 INFO - Running setup.py (path:/tmp/pip-o9dach-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:23 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)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:23 INFO - Running setup.py (path:/tmp/pip-I0YVyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:23 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)) 05:13:23 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)) 05:13:23 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)) 05:13:23 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)) 05:13:23 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)) 05:13:23 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)) 05:13:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:13:23 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 05:13:23 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 05:13:23 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 05:13:23 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 05:13:23 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 05:13:23 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 05:13:25 INFO - Downloading blessings-1.6.tar.gz 05:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:13:25 INFO - Installing collected packages: blessings 05:13:25 INFO - Running setup.py install for blessings 05:13:25 INFO - Successfully installed blessings 05:13:25 INFO - Cleaning up... 05:13:25 INFO - Return code: 0 05:13:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:13:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:25 INFO - Reading from file tmpfile_stdout 05:13:25 INFO - Current package versions: 05:13:25 INFO - argparse == 1.2.1 05:13:25 INFO - blessings == 1.6 05:13:25 INFO - blobuploader == 1.2.4 05:13:25 INFO - docopt == 0.6.1 05:13:25 INFO - functools32 == 3.2.3-2 05:13:25 INFO - jsonschema == 2.5.1 05:13:25 INFO - manifestparser == 1.1 05:13:25 INFO - mozInstall == 1.12 05:13:25 INFO - mozcrash == 0.17 05:13:25 INFO - mozdebug == 0.1 05:13:25 INFO - mozdevice == 0.48 05:13:25 INFO - mozfile == 1.2 05:13:25 INFO - mozhttpd == 0.7 05:13:25 INFO - mozinfo == 0.9 05:13:25 INFO - mozleak == 0.1 05:13:25 INFO - mozlog == 3.2 05:13:25 INFO - moznetwork == 0.27 05:13:25 INFO - mozprocess == 0.22 05:13:25 INFO - mozprofile == 0.28 05:13:25 INFO - mozrunner == 6.11 05:13:25 INFO - mozscreenshot == 0.1 05:13:25 INFO - mozsystemmonitor == 0.3 05:13:25 INFO - moztest == 0.7 05:13:25 INFO - mozversion == 1.4 05:13:25 INFO - psutil == 3.1.1 05:13:25 INFO - requests == 1.2.3 05:13:25 INFO - wsgiref == 0.1.2 05:13:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:25 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')]} 05:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:25 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')]} 05:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:25 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 0x7fb438f63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e110>, '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 0x26ba230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ba6c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', '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 05:13:25 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 05:13:25 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 05:13:25 INFO - Using env: {'DISPLAY': ':0', 05:13:25 INFO - 'HOME': '/home/cltbld', 05:13:25 INFO - 'LANG': 'en_US.UTF-8', 05:13:25 INFO - 'LANGUAGE': 'en_US:en', 05:13:25 INFO - 'LOGNAME': 'cltbld', 05:13:25 INFO - 'MAIL': '/var/mail/cltbld', 05:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:25 INFO - 'MOZ_NO_REMOTE': '1', 05:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:25 INFO - 'NO_EM_RESTART': '1', 05:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:25 INFO - 'PWD': '/builds/slave/test', 05:13:25 INFO - 'SHELL': '/bin/bash', 05:13:25 INFO - 'SHLVL': '1', 05:13:25 INFO - 'TERM': 'linux', 05:13:25 INFO - 'TMOUT': '86400', 05:13:25 INFO - 'USER': 'cltbld', 05:13:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', 05:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:25 INFO - '_': '/tools/buildbot/bin/python'} 05:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:26 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)) 05:13:26 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)) 05:13:26 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)) 05:13:26 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)) 05:13:26 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)) 05:13:26 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)) 05:13:26 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)) 05:13:26 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)) 05:13:26 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)) 05:13:26 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)) 05:13:26 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)) 05:13:26 INFO - Cleaning up... 05:13:26 INFO - Return code: 0 05:13:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb438f63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e110>, '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 0x26ba230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ba6c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', '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 05:13: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', 'jsonschema'] in /builds/slave/test/build 05:13: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 jsonschema 05:13:26 INFO - Using env: {'DISPLAY': ':0', 05:13:26 INFO - 'HOME': '/home/cltbld', 05:13:26 INFO - 'LANG': 'en_US.UTF-8', 05:13:26 INFO - 'LANGUAGE': 'en_US:en', 05:13:26 INFO - 'LOGNAME': 'cltbld', 05:13:26 INFO - 'MAIL': '/var/mail/cltbld', 05:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:26 INFO - 'MOZ_NO_REMOTE': '1', 05:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:26 INFO - 'NO_EM_RESTART': '1', 05:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:26 INFO - 'PWD': '/builds/slave/test', 05:13:26 INFO - 'SHELL': '/bin/bash', 05:13:26 INFO - 'SHLVL': '1', 05:13:26 INFO - 'TERM': 'linux', 05:13:26 INFO - 'TMOUT': '86400', 05:13:26 INFO - 'USER': 'cltbld', 05:13:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', 05:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:26 INFO - '_': '/tools/buildbot/bin/python'} 05:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:13:26 INFO - Cleaning up... 05:13:26 INFO - Return code: 0 05:13:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb438f63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274e110>, '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 0x26ba230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ba6c0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', '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 05:13: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', 'flake8'] in /builds/slave/test/build 05:13: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 flake8 05:13:26 INFO - Using env: {'DISPLAY': ':0', 05:13:26 INFO - 'HOME': '/home/cltbld', 05:13:26 INFO - 'LANG': 'en_US.UTF-8', 05:13:26 INFO - 'LANGUAGE': 'en_US:en', 05:13:26 INFO - 'LOGNAME': 'cltbld', 05:13:26 INFO - 'MAIL': '/var/mail/cltbld', 05:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:26 INFO - 'MOZ_NO_REMOTE': '1', 05:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:26 INFO - 'NO_EM_RESTART': '1', 05:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:26 INFO - 'PWD': '/builds/slave/test', 05:13:26 INFO - 'SHELL': '/bin/bash', 05:13:26 INFO - 'SHLVL': '1', 05:13:26 INFO - 'TERM': 'linux', 05:13:26 INFO - 'TMOUT': '86400', 05:13:26 INFO - 'USER': 'cltbld', 05:13:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', 05:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:26 INFO - '_': '/tools/buildbot/bin/python'} 05:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:26 INFO - Downloading/unpacking flake8 05:13:26 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 05:13:26 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 05:13:26 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 05:13:26 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 05:13:26 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 05:13:26 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 05:13:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:13:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:13:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:13:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:29 INFO - no previously-included directories found matching 'docs/_build' 05:13:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:13:29 INFO - Running setup.py install for pep8 05:13:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:29 INFO - no previously-included directories found matching 'docs/_build' 05:13:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:13:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:13:29 INFO - Cleaning up... 05:13:29 INFO - Return code: 0 05:13:29 INFO - Running post-action listener: _resource_record_post_action 05:13:29 INFO - Running post-action listener: _start_resource_monitoring 05:13:29 INFO - Starting resource monitoring. 05:13:29 INFO - ##### 05:13:29 INFO - ##### Finished create-virtualenv step (success) 05:13:29 INFO - ##### 05:13:29 INFO - ##### 05:13:29 INFO - ##### Running install step. 05:13:29 INFO - ##### 05:13:29 INFO - Running pre-action listener: _resource_record_pre_action 05:13:29 INFO - Running main action method: install 05:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:29 INFO - Reading from file tmpfile_stdout 05:13:29 INFO - Detecting whether we're running mozinstall >=1.0... 05:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:13:29 INFO - Reading from file tmpfile_stdout 05:13:29 INFO - Output received: 05:13:29 INFO - Usage: mozinstall [options] installer 05:13:29 INFO - Options: 05:13:29 INFO - -h, --help show this help message and exit 05:13:29 INFO - -d DEST, --destination=DEST 05:13:29 INFO - Directory to install application into. [default: 05:13:29 INFO - "/builds/slave/test"] 05:13:29 INFO - --app=APP Application being installed. [default: firefox] 05:13:29 INFO - mkdir: /builds/slave/test/build/application 05:13:29 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'] 05:13:29 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 05:13:46 INFO - Reading from file tmpfile_stdout 05:13:46 INFO - Output received: 05:13:46 INFO - /builds/slave/test/build/application/firefox/firefox 05:13:46 INFO - Running post-action listener: _resource_record_post_action 05:13:46 INFO - ##### 05:13:46 INFO - ##### Finished install step (success) 05:13:46 INFO - ##### 05:13:46 INFO - ##### 05:13:46 INFO - ##### Running run-tests step. 05:13:46 INFO - ##### 05:13:46 INFO - Running pre-action listener: _resource_record_pre_action 05:13:46 INFO - Running main action method: run_tests 05:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:13:46 INFO - Python 2.7.3 05:13:46 INFO - Return code: 0 05:13:46 INFO - grabbing minidump binary from tooltool 05:13:46 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')]} 05:13:46 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 0x274e110>, '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 0x26ba230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ba6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:13:46 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 05:13:46 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 05:13:46 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 05:13:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:13:46 INFO - Return code: 0 05:13:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:13:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:13:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:13:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:13:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:13:47 INFO - Return code: 0 05:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 05:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 05:13:47 INFO - Using env: {'DISPLAY': ':0', 05:13:47 INFO - 'HOME': '/home/cltbld', 05:13:47 INFO - 'LANG': 'en_US.UTF-8', 05:13:47 INFO - 'LANGUAGE': 'en_US:en', 05:13:47 INFO - 'LOGNAME': 'cltbld', 05:13:47 INFO - 'MAIL': '/var/mail/cltbld', 05:13:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:13:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:47 INFO - 'MOZ_NO_REMOTE': '1', 05:13:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:47 INFO - 'NO_EM_RESTART': '1', 05:13:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:47 INFO - 'PWD': '/builds/slave/test', 05:13:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:13:47 INFO - 'SHELL': '/bin/bash', 05:13:47 INFO - 'SHLVL': '1', 05:13:47 INFO - 'TERM': 'linux', 05:13:47 INFO - 'TMOUT': '86400', 05:13:47 INFO - 'USER': 'cltbld', 05:13:47 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950', 05:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:47 INFO - '_': '/tools/buildbot/bin/python'} 05:13:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 05:13:47 INFO - mozversion application_buildid: 20160610023030 05:13:47 INFO - mozversion application_changeset: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 05:13:47 INFO - mozversion application_display_name: Nightly 05:13:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:13:47 INFO - mozversion application_name: Firefox 05:13:47 INFO - mozversion application_remotingname: firefox 05:13:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:13:47 INFO - mozversion application_vendor: Mozilla 05:13:47 INFO - mozversion application_version: 50.0a1 05:13:47 INFO - mozversion platform_buildid: 20160610023030 05:13:47 INFO - mozversion platform_changeset: 9c0dce75ed0c21e0b05ba72c348da23b27e80888 05:13:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:13:47 INFO - mozversion platform_version: 50.0a1 05:13:47 INFO - using testdate: 1465560827 05:13:47 INFO - actual date: 1465560827 05:13:47 INFO - starting webserver on 'localhost:42126' 05:13:47 INFO - SUITE-START | Running 2 tests 05:13:47 INFO - TEST-START | dromaeo_css 05:13:47 INFO - operating with platform_type : linux_ 05:13:47 INFO - Initialising browser for dromaeo_css test... 05:13:47 INFO - TEST-INFO | started process 27601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvts5kA/profile http://localhost:42126/getInfo.html) 05:13:52 INFO - PROCESS | 27601 | __metrics Screen width/height:1600/1200 05:13:52 INFO - PROCESS | 27601 | colorDepth:24 05:13:52 INFO - PROCESS | 27601 | Browser inner width/height: 1024/697 05:13:52 INFO - PROCESS | 27601 | __metrics 05:13:53 ERROR - PROCESS | 27601 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:13:54 INFO - TEST-INFO | 27601: exit 0 05:13:54 INFO - Browser initialized. 05:13:54 INFO - Running cycle 1/1 for dromaeo_css test... 05:13:54 INFO - TEST-INFO | started process 27720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvts5kA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:06 INFO - PROCESS | 27720 | RSS: Main: 184303616 05:14:06 INFO - PROCESS | 27720 | 05:14:55 INFO - PROCESS | 27720 | 1465560895765 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] 05:17:04 INFO - PROCESS | 27720 | Cycle 1(1): loaded http://localhost:42126/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42126/tests/dromaeo/cssquery-ext.html) 05:17:05 INFO - PROCESS | 27720 | RSS: Main: 187617280 05:17:05 INFO - PROCESS | 27720 | 05:20:07 INFO - PROCESS | 27720 | Cycle 1(1): loaded http://localhost:42126/tests/dromaeo/cssquery-ext.html (next: http://localhost:42126/tests/dromaeo/cssquery-jquery.html) 05:20:08 INFO - PROCESS | 27720 | RSS: Main: 186970112 05:20:08 INFO - PROCESS | 27720 | 05:23:09 INFO - PROCESS | 27720 | Cycle 1(1): loaded http://localhost:42126/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42126/tests/dromaeo/cssquery-mootools.html) 05:23:10 INFO - PROCESS | 27720 | RSS: Main: 188407808 05:23:10 INFO - PROCESS | 27720 | 05:26:12 INFO - PROCESS | 27720 | Cycle 1(1): loaded http://localhost:42126/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42126/tests/dromaeo/cssquery-prototype.html) 05:26:12 INFO - PROCESS | 27720 | RSS: Main: 185745408 05:26:12 INFO - PROCESS | 27720 | 05:29:15 INFO - PROCESS | 27720 | Cycle 1(1): loaded http://localhost:42126/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42126/tests/dromaeo/cssquery-yui.html) 05:29:15 INFO - PROCESS | 27720 | RSS: Main: 188112896 05:29:15 INFO - PROCESS | 27720 | 05:32:18 INFO - PROCESS | 27720 | Cycle 1(1): loaded http://localhost:42126/tests/dromaeo/cssquery-yui.html (next: http://localhost:42126/tests/dromaeo/cssquery-dojo.html) 05:32:18 INFO - PROCESS | 27720 | RSS: Main: 189231104 05:32:18 INFO - PROCESS | 27720 | 05:32:18 INFO - PROCESS | 27720 | __start_tp_report 05:32:18 INFO - PROCESS | 27720 | _x_x_mozilla_page_load 05:32:18 INFO - PROCESS | 27720 | _x_x_mozilla_page_load_details 05:32:18 INFO - PROCESS | 27720 | |i|pagename|runs| 05:32:18 INFO - PROCESS | 27720 | |0;dojo.html;3081.7072378124076;3117.906462806115;3146.8269245191505;3155.132338606882;3162.3359094590137;5369.38252101008;5382.89234215316;5425.0506161421745;5438.809641662542;5497.038018346793;5305.336832895888;5422.40353561109;5499.7250137493165;5521.282233309664;5574.442555744424;4975.776090075946;5010.624203184758;5038.773255203525;5146.511081447256;5163.690178589278;5010.874728131807;5182.170852663575;5229.973850130763;5233.084210263189;5234.214867769827;4862.197737373329;4905.117078925792;5001.424836143854;5030.044291584605;5063.569596584276;4917.975410122926;4931.137051016058;4968.7515624219;5002.274670172841;5035.068512325195;4925.408950925876;4933.925991110136;4938.456769755324;4962.503749625044;4980.377452818398;5278.2346559749;5380.515753582157;5392.541633961118;5404.729763511848;5428.538574221196;5810.041343178371;5819.447152520504;5821.563382746269;5821.767129314822;5836.066229403317;5886.941130588725;5895.4399332063385;5903.3801450847905;5904.114382842565;5918.437748413894;5321.787128514855;5401.540869026137;5423.728813559306;5479.6164268501225;5501.312335958005;5994.831007953408;5997.280326360865;6001.4298641628975;6012.428819262163;6013;5539.224508568804;5799.014167591519;5803.419658034247;5806.187133801272;5816.389279125716;5783.768649253982;5825.563082768809;5843.766249350064;5876.206712093898;5881.3530511643685;5680.176374425685;5710.114932185518;5839.941600584025;5862.355140934494;5863.648181109147;5773.061030351685;5808.448197421239;5820.097884827858;5826.796062137805;5858.8242352729485;4372.672049596293;4377.715448495837;4408.9559104408545;4418.1163767246035;4419.779011049434;3918.5101862267215;3958.129211573449;3966.5438474575217;3992.201559688074;4003.3994900764537;5360.91958620621;5496.5053145217125;5523.337199536001;5546.805861794898;5557.5553955683445;5815.621984570989;5845.503132233723;5858.765649374062;5895.646261224255;5904.793332233351;5557.472040156179;5592.7762889484775;5593.161025846156;5604.103343465026;5631.859203519863;4767.261074533453;4837.879053023703;4911.656184067081;4927.876803079952;4928.088303663762;5978.342382337939;6061.727222275008;6103.969480152571;6121.234845644294;6124.969375153096;5919.91120133207;5926.1999630049395;5940.198073260054;5941.970290148522;5949.137375080676;5823.301203855395;5975.581709280309;6003.8198854034445;6048.848778780566;6056.03103503455;5784.305883294031;5790;5791.478766910998;5805.361410244954;5825.912611310749;5795.942040579709;5855;5855.268091488564;5876.294844618673;5903.2916050072545;5408;5638.718064096696;5666.291713535808;5674.177244299471;5678.0915053591225;5548.833534993957;5595.608307418442;5601.579881508985;5679.148127780866;5710.457506536873;5451.836444906659;5529.419410961952;5555.30558680165;5564.805231817029;5570.637908535932;5628.8874222514505;5692.743826527733;5749.396313387201;5759.683217423082;5767.711614419346;5459.989901868167;5583.050881350261;5598.608097433141;5620.859478512906;5641.182028605911 05:32:18 INFO - PROCESS | 27720 | |1;ext.html;575.585578383564;609.615941956567;625.3996163682864;637.0794202377565;664.8204984654141;37288.62711372886;42747.14505709888;42764.35853462197;42977.78511107448;43139.13721725564;41883.371749423706;42308.153836923244;42519.78740106295;42633.360499592534;42775.3583696244;8737.432066915662;8860.424072435304;8880.733577992638;8881.777955551099;8917.95541022294;8715.128487151298;8770.56147192641;8838.911610883906;8841.204291613754;8847.911520884772;8840.071792461795;8927.598258078402;8940.687075952343;8943.150400711922;8954.641814327419;8707.43401678892;8820.823583528325;8846.513441760733;8861.291096712248;8904.910950890473;8896.154865287788;8927.61621948599;8978.820423591556;9000.234980026706;9004.099590041009;41405.585944140475;41647.167056659004;41734.37398439026;41851.58148418507;42016.57983420157;3510.912227194315;3686.8525258989607;4196.622303992655;4319.287317592593;4383.473983122046;31850.522242166386;32557.348853023042;32848.17879553006;32939.341213175605;33381.83309083463;3912.5500567434824;4072.9389059164137;4328.394024836525;4440.844570440019;4527.411436513232;374909;375224;376485;376892.1155394233;376995;33868.661313386554;34662;34733;60586;60732;37158.628413715516;37302.25395492075;37342.879713608636;37349.43975840365;37394.62605373966;15087.170205638795;15333.156676382907;15439.073655580702;15459.845401546065;15475.071495710294;12688.23870567769;12735.426905789262;12868.034897382546;12868.356582170854;12911.612651620466;8341.374396920255;8386.538740369338;8427.073021967579;8465.280451161598;8545.786355341166;3174.9841250793597;3187.4103290891258;3239.72462340699;3269.2971011232225;3270.787398819069;968.2689569375218;1013.7653431396822;1017.2777328097134;1077.73595469109;1136.5944775579583;33335.83332083324;33336;33709;33789.83105084508;34169.65830341714;1111.6831702964616;1142.257532603814;1165.3008195082882;1235.6849003504049;1268.0869773762877;17332.82667173337;17538.912305438647;17582.472525824247;17644.294228230727;17679.73480397795;540924;549733;557834;558470.2841343766;558945;58797.70601146967;58816.11775823366;59281;59428.70285648544;59649;1318.1102755640097;1363.986360136406;1369.9726005479833;1372.499037851177;1373.3957058893855;31041.8447907759;31860.8406957973;32054.358912821146;32090;33077;52991.735041324544;53078.2038269434;53112.203316949504;53492.732536338626;53639.463605363446;467680;480440;483291;484927;486748;28213.576796348483;28243.858780706785;28461.857690711415;28507.572386414635;28691.28271793222;49391.25913111235;49500.75249623729;49723.75138124286;49794.75102624464;50909.74545127251;41860;41972.580274196866;42392.788036059625;42420.39807207203;42706.35940460833;40765.388519172826;41658.37512437255;41711.1657766849;41779.58220417757;41786.1642767149;40516.594834051284;41037;42080;42095.7895210522;42296.788516057226;35614.287714246086;37294.44058339181;37325.44011839879;37367.439488408236;38033.42949855699;28205.280744024334;28285.292867678472;28495.28761780972;28897.56653650155;30364.392712145192 05:32:18 INFO - PROCESS | 27720 | |2;jquery.html;387.79253099591716;390.69135383047376;391.2097562922894;396.46675221826644;403.75976294105016;17849.107544622766;18985.52536186596;19405.12676929538;19457.47052883125;20056.298029568967;18534.165962531686;19141.712874306897;19274.614507709837;19331.130099145535;19480.123394447248;5478.835634930949;5484.341878974528;5599.832005039855;5692.658440493563;5701.629394089371;5577.470140336682;5641.041023026095;5645.096784514479;5653.547716182696;5682.034054210794;5445.863853403677;5614.747336369873;5635.746391412396;5637.210790489335;5645.350784659755;5550.69471179085;5588.441155884399;5589.804356847531;5591.329040515164;5612.102063669793;4872.537108974641;5025.698458092526;5036.19420892659;5057.4689657585795;5063.443021267658;22363.10547578095;22439.32682019542;23063.192788252498;23104.65343019856;23172.76827231723;2232.0625337358347;2309.8845057747044;2346.0733010460945;2577.2139497453268;2850.315924178203;9508.334416590773;14212.50256241037;14745.852541474555;14904.62738431537;15130.470433534774;1937.4381429385462;1958.177565422526;1963.813437723414;2002.119067610247;2003.6393449179143;77300.22699773042;81344;82715;82786;83783.16216837875;10592.841107383396;10648.787024259627;10649.307794993301;10786;10951.288166269167;14986.775198372034;15002.324895379734;15021.69956600862;15035.924820376047;15049.54851354461;7610.820322849967;7701.345385642171;7749.7675069748;7793.06483222017;7974.52152870818;7289.562626242442;7467.1039475263315;7478.5138965967035;7512.549247045085;7711.305982461606;4426.75652839097;4580.8167673293365;4593.862184134415;4595.126925884071;4701.3653156824075;1879.4079864842531;1883.6797744383487;1891.8202770736757;1905.104600837604;1918.788933217373;887.1527691055027;953;969.6751588217885;1030.4899074957943;1054.4516851237313;19056.809431905782;19436.2225510978;19529.414117576212;19840.702389464168;19939.501512462306;1035.9585616575403;1036.6060896859296;1037.2065369991963;1061.9522121504551;1082.5345101606385;10480.63317783874;10927.344359338465;10961.342319460859;11042.944785276022;11052.171087168334;532450;540472;541514;544286.0785186125;545167;77173.61413192897;89645;92926;93191.53404232935;97941.51029244809;1009.4649835587151;1021.4841505040056;1030.6959446963165;1069.1607088435542;1071.507106730897;17450.91274543619;17688.55778605545;18015;18257.634847302714;18532.166052527937;42936.78531607322;43295;43725.781371094214;43969.34045989249;45662.31506527471;61052;61892.38107618866;62314;62343;63222.05166922408;7405.407567394488;8611.492988727074;8747.956260218658;8875.511846848485;8917.955410222907;11472.483738231633;13519.932400337935;13552.254625995665;13787.379567919668;13954;11797.587084452003;11947.880521194676;12013;12189.695257618276;12230.449629766505;12037.939810300892;12142.210756300812;12287.631371058882;12447.751044979232;12469.5012199511;7033.507654464139;9941.30410871261;12389.75220495603;12400.81398779001;12560.183588066746;7820.217978202134;7854.921450785419;7860.803479913048;7867.645955932111;8087.3125784308995;10499.229018647167;12482.188657737219;12584.748305033665;12606.369681515704;12817.615471535868 05:32:18 INFO - PROCESS | 27720 | |3;mootools.html;1468.441992043024;1495.48405799999;1597.1136019509174;1707.3426730708682;1726.4734256051916;7801.6489257983385;8406.369522285837;8426.199511046449;9023.278137748981;9024.458532488046;8478.957605211981;8681.652733890636;8741.606627701753;8770.254528365096;8788;2300.8159347252263;2338.0998315648512;2343.3321503371544;2347.108098922407;2347.3896786835376;2200.185931205456;2223.755386907439;2237.7538470768204;2242.506648537319;2254.5265494246228;2226.421130506064;2246.0229800036955;2257.1761307122947;2271.5797577448225;2274.80664143548;2209.6133176694016;2214.1586197245106;2233.452804062999;2243.876586787726;2244.4837687332006;2204.4048107011017;2214.3578362275084;2229.342344008521;2230.39779259599;2234.2626933112033;8787.472751634858;8841.955790221007;8843.69047083349;8845.469271843709;8871.866921996176;5237.580993520509;5387.67673939561;5426.294581704353;5430.484104010113;5431.945680543223;3177.189816596776;3265.118418027143;3444.207832198583;3449.6550344965303;3459.896203113911;1082.0748260237463;1086.4296244471636;1107.1530279336314;1109.3732041396586;1115.6876074699098;12315.93842030793;12341.444634991447;12393.814092788525;12404.689882752913;12425.254484730945;4630.606398456169;4664.673472856935;4735.455422626442;4756.8097276108565;4772.737499437495;10272.178225741924;10318.587256509805;10340.844887326695;10457.68626941193;10459.84310235347;5302.1781623848365;5416.133418652997;5424.457554244623;5428.728563571805;5437.510624043855;4392.846250381222;4747.95252047482;4923.310736496894;4923.433805112458;5007.499250075036;3936.9606303937167;3953.6441720245316;3994.8202330894596;3998.660113890294;4074.633283004544;1169.2750494693175;1178.263585259213;1179.204037274836;1192.6183621241294;1205.2949024820402;852.2798235491;956.4930586789013;996.342414006752;996.8903420623726;999.8050380175941;6000.21997140369;6010.158577799111;6013.1581578579035;6116.694165291718;6133.539984501181;411.3151602581728;420.268732405612;420.743346558599;423.9067405170857;424.3083773449258;4097.549269580344;4210.536840947493;4242.830286788556;4264.850730224489;4289.292266775947;10747.247692661438;10862.837057444145;11084.501197446134;11521.539138434537;11570;11297.943510282395;11418.486168122288;11418.828717569244;11529.250598711225;11560.30638161713;8363.665453381918;8484.109168537214;8583;8607.569621519024;8616.741497755078;5914.201582786269;5925.614835035709;5936.257967754031;5952.940470595238;6059.3637668045985;10338.948305258426;10558.260921735406;10606.946965265124;10708.678739637824;10741.46292685347;10660.573577056832;10781.568737250422;10835.241533092609;10858.565657373932;10868.61959831402;7254.854902901807;7261.854762904818;7503.287187717158;7815.062192536932;7960.920390796018;8693.91306086931;8704.26013788835;8707.172818582478;8782.956085219534;8788.824223515367;7726.690932362867;7859.09620393662;7956.6419511120985;8002.479838810459;8016.278534931884;7680.884786728092;7749.225077492206;7852.13626501073;7857.607119643881;7867.365059467785;6773.796786096425;6845.794626161223;6983.2318444972025;6993.0908981832035;6999.965000174967;5301.390340110936;5325.09473389517;5351.1973204019705;5445.455454454681;5474.72626368672;5215.634905556574;5266.131088370376;5268.5258326749245;5288.894222115459;5346.679199248058 05:32:18 INFO - PROCESS | 27720 | |4;prototype.html;328.48263984224855;329.93566254580355;333.54637692737873;340.3261542146551;340.36861621691776;5554.888902221953;5675.2622159119255;5681.687507187098;5687.63030403024;5715.2855893013375;5593.608447408683;5613.691246981414;5614.147331380645;5621.4940655341015;5626.352969408519;4205.810738516767;4265.829366825324;4343.522212556616;4370.2133615949115;4371.65026797857;4342.218400687875;4345.78271086446;4361.953131248493;4379.642310883621;4411.580899814512;4363.258246098155;4364.454443194601;4403.647708183337;4405.140997505488;4411.3382992551215;4298.312270036779;4300.118475712471;4304.268274393361;4308.3537469379535;4314.913701725979;3821.8280177392085;3829.215010922782;3849.538055433338;3864.091938394475;3864.632859878307;5447.665321996096;5493.917591236134;5495.763453223033;5503.752331145068;5506.697131657757;4748.881277968044;4931.778069986859;4948.257761335828;4963.205887058053;5024.924626130611;5772.769089236425;5833.854153646151;5846.889091072725;5865.736041878083;5867.677277749722;4175.331946888483;4179.414881916534;4240.766757828318;4264.424302719124;4267.701260911737;5838.182654428383;6170.444659980623;6170.791188581912;6174.475169610589;6245.594036387621;4179.7460761771345;4194.161167766398;4199.580041995837;4205.3271476563605;4210.789460527023;4237.453329534697;4281.207976524353;4313.180495705806;4320.135972805451;4327.935080973788;4800.95199048012;4935.654504184673;4946.194638956827;4960.677555958851;5012.273220383024;5796.710164491843;5841.269841269841;5863.2670916135485;5939.851503712355;5974.790882319098;1455.7961885336063;1462.4223431744615;1488.873445757101;1495.327102803721;1501.9173945433106;947.990520094804;963.330485312701;994.597188138805;1008.6822650864954;1009;5507.5593952483705;5577.860553486114;5626;5727.140928860621;5739.512141467939;5965.463108320185;5987.520998320124;6020.307664618537;6065.302490213594;6096.9575192310185;5410.404855465896;5571.498565129158;5606.55147588192;5637.844241930395;5688.601797874109;3176.745860331168;3213.1806389371027;3252.902412927616;3264.281857991238;3266.673332666762;5990.843296413288;6187.938120618826;6200.472959798468;6214.627122372672;6285.937140628535;6069.180660610849;6142.969285153635;6174.086033329682;6181.783637572753;6242.375762423721;5877.5591830612875;6162.322144564095;6191.721372538246;6198.256209254918;6214.689265536705;5946.1972633693895;5970.940290597038;5984.354302566829;5991.670458124845;6013.9699301503215;5899.46904778572;5904.173415721716;5904.9704751475965;5914.67469289176;5952.196453478725;5989.2812862456785;6153.29237137717;6168.1056246844855;6184.969075154595;6194.876102477835;4205.264078786261;4228.112096459778;4230.534641189528;4231.217224813419;4231.809568569361;5876.44173803488;5983.192269043623;6061.424164704346;6083.847903802263;6091.786787462417;5806.44838740319;5894.498967587803;5916.881662366814;5921.3190483094995;5942.58401911862;5592.315688469476;5914;5943;5944.64332140073;5963.956307646231;5741.885162296647;5742.741576628978;5764.423557644202;5827.970860145672;5853.946289667901;5903.645781253139;5917.940820591739;5947.405259474018;5959.582829201914;5966.403359663999;5577.633479797476;5796.82609521715;5830.591858569859;5848.853778655568;5849.303701926394 05:32:18 INFO - PROCESS | 27720 | |5;yui.html;724.5435375713303;763.9770806875796;783.5964478293678;784.1022029775907;796.6375299238844;14845.851541484582;14986.850131498682;14988.700225995473;15025.849741502581;15222.847771522282;13511.256880871548;14069.929650351734;14152.716945661106;14372.353244104015;14434.133951962864;791.4183075439533;791.8257983243706;796.0884786918974;797.1789057270992;799.9640016199285;775.1550809617515;803.5138741061661;810.0320117459638;810.6392655268407;811.1158836867813;856.648774002659;862.9525376104311;864.0797550608581;864.5547543015321;865.5888452984814;857.6440777077537;857.8670306102564;861.4960248254779;862.2886118951858;862.3144600042981;617.8455386153462;618.3816183816184;618.4619381138393;624.4629618528107;625.9029850373199;15741;15754.291056902466;15764.132972686497;15794.447194348257;15825.129617871013;13714.382852771649;13754.31228438574;14590.781138282935;14593.34329955144;14691.926540367229;12283.324417157053;12314.384280785926;12463.439145238486;12531.93734031333;13070.477180912752;3849.2301539691894;3853.190829925719;3964.524257089168;4020.798960052015;4024.03423178438;74252.62873685651;74892;76252.23747762507;76474.61762691151;77287;10188.286819922534;10283.971602839656;10466.267361284788;10546.525406356732;10698.197635177392;20854;21102;21147.25984590532;21326.466838329165;21556.353309400743;8415.116412776693;8424.241818236389;8466.238038576557;8485.575721213914;8513.659453621909;4795;4828.37231159947;4836.951630483721;4863.537963893425;4895.814078962436;3556.270964452281;3677.79772112531;3680.7239457040296;3684.8157592120288;3708.2027364116307;589.8083122985047;596.8627215740318;607.9209702738616;611.7063809371526;611.8195132435942;647.252423450915;674.956127851688;684.8116767888771;685.2154283345542;702.5257950883235;9268.72193834186;9732.464714440774;9777.120059194707;9809.166220871306;9961.750956226007;597.2027343496394;686.2279935073043;714.6176795414428;751.8158051277472;756.3230908337008;4436.0240747035605;4497.617702495325;4528.343390208467;4532.4334458192725;4572.611328037087;84943.15056849476;107897.46051269694;110230;112360.43819780849;113282.6623253403;62693.37306626967;65270;65397;81164;92947.07052929384;85229;85959;87493.56253218693;87785.56107219424;88906;9529.904700952902;9598.376105553116;9821.803563928539;9852.556634951588;9900.108990190918;48104.759476202395;49702;50257;50697.23954140617;54603.453965459834;66970.66514667396;76316.23683763092;76683.23316766761;77129.61435193013;77583;12712.173708708904;12757;12805.935970320088;12829.42267597979;13019.869801301866;14566.635834104232;14692.338844751797;15044.849551504345;15086.54740357791;15277.465288714842;13608.93195534016;13654.180749155083;13734.313284335944;13799.586012419644;14310.069845460011;13441.596752097452;13667.589972300846;13877.514286999907;13934.30328483592;14516.927415362856;13621.863781362455;13624.591262262147;13720.588382348546;13779.793303100261;13852.099613525088;9573.9042609573;9698.951505242429;9755.463449510346;9854.704358869245;10077.798444031225;10397.72755637425;10517.9474102629;10564.418956957441;10606.204534660086;10612.734681632712 05:32:18 INFO - PROCESS | 27720 | __end_tp_report 05:32:18 INFO - PROCESS | 27720 | __start_cc_report 05:32:18 INFO - PROCESS | 27720 | _x_x_mozilla_cycle_collect,349 05:32:18 INFO - PROCESS | 27720 | __end_cc_report 05:32:18 INFO - PROCESS | 27720 | __startTimestamp1465561938947__endTimestamp 05:32:18 INFO - PROCESS | 27720 | 05:32:18 INFO - PROCESS | 27720 | ------- Summary: start ------- 05:32:18 INFO - PROCESS | 27720 | Number of tests: 6 05:32:18 INFO - PROCESS | 27720 | 05:32:18 INFO - PROCESS | 27720 | [#0] dojo.html Cycles:165 Average:5418.65 Median:5593.16 stddev:622.45 (11.1%) stddev-sans-first:596.75 05:32:18 INFO - PROCESS | 27720 | Values: 3081.7 3117.9 3146.8 3155.1 3162.3 5369.4 5382.9 5425.1 5438.8 5497.0 5305.3 5422.4 5499.7 5521.3 5574.4 4975.8 5010.6 5038.8 5146.5 5163.7 5010.9 5182.2 5230.0 5233.1 5234.2 4862.2 4905.1 5001.4 5030.0 5063.6 4918.0 4931.1 4968.8 5002.3 5035.1 4925.4 4933.9 4938.5 4962.5 4980.4 5278.2 5380.5 5392.5 5404.7 5428.5 5810.0 5819.4 5821.6 5821.8 5836.1 5886.9 5895.4 5903.4 5904.1 5918.4 5321.8 5401.5 5423.7 5479.6 5501.3 5994.8 5997.3 6001.4 6012.4 6013.0 5539.2 5799.0 5803.4 5806.2 5816.4 5783.8 5825.6 5843.8 5876.2 5881.4 5680.2 5710.1 5839.9 5862.4 5863.6 5773.1 5808.4 5820.1 5826.8 5858.8 4372.7 4377.7 4409.0 4418.1 4419.8 3918.5 3958.1 3966.5 3992.2 4003.4 5360.9 5496.5 5523.3 5546.8 5557.6 5815.6 5845.5 5858.8 5895.6 5904.8 5557.5 5592.8 5593.2 5604.1 5631.9 4767.3 4837.9 4911.7 4927.9 4928.1 5978.3 6061.7 6104.0 6121.2 6125.0 5919.9 5926.2 5940.2 5942.0 5949.1 5823.3 5975.6 6003.8 6048.8 6056.0 5784.3 5790.0 5791.5 5805.4 5825.9 5795.9 5855.0 5855.3 5876.3 5903.3 5408.0 5638.7 5666.3 5674.2 5678.1 5548.8 5595.6 5601.6 5679.1 5710.5 5451.8 5529.4 5555.3 5564.8 5570.6 5628.9 5692.7 5749.4 5759.7 5767.7 5460.0 5583.1 5598.6 5620.9 5641.2 05:32:18 INFO - PROCESS | 27720 | 05:32:18 INFO - PROCESS | 27720 | [#1] ext.html Cycles:180 Average:61468.18 Median:41782.87 stddev:126506.80 (302.8%) stddev-sans-first:126779.07 05:32:18 INFO - PROCESS | 27720 | Values: 575.6 609.6 625.4 637.1 664.8 37288.6 42747.1 42764.4 42977.8 43139.1 41883.4 42308.2 42519.8 42633.4 42775.4 8737.4 8860.4 8880.7 8881.8 8918.0 8715.1 8770.6 8838.9 8841.2 8847.9 8840.1 8927.6 8940.7 8943.2 8954.6 8707.4 8820.8 8846.5 8861.3 8904.9 8896.2 8927.6 8978.8 9000.2 9004.1 41405.6 41647.2 41734.4 41851.6 42016.6 3510.9 3686.9 4196.6 4319.3 4383.5 31850.5 32557.3 32848.2 32939.3 33381.8 3912.6 4072.9 4328.4 4440.8 4527.4 374909.0 375224.0 376485.0 376892.1 376995.0 33868.7 34662.0 34733.0 60586.0 60732.0 37158.6 37302.3 37342.9 37349.4 37394.6 15087.2 15333.2 15439.1 15459.8 15475.1 12688.2 12735.4 12868.0 12868.4 12911.6 8341.4 8386.5 8427.1 8465.3 8545.8 3175.0 3187.4 3239.7 3269.3 3270.8 968.3 1013.8 1017.3 1077.7 1136.6 33335.8 33336.0 33709.0 33789.8 34169.7 1111.7 1142.3 1165.3 1235.7 1268.1 17332.8 17538.9 17582.5 17644.3 17679.7 540924.0 549733.0 557834.0 558470.3 558945.0 58797.7 58816.1 59281.0 59428.7 59649.0 1318.1 1364.0 1370.0 1372.5 1373.4 31041.8 31860.8 32054.4 32090.0 33077.0 52991.7 53078.2 53112.2 53492.7 53639.5 467680.0 480440.0 483291.0 484927.0 486748.0 28213.6 28243.9 28461.9 28507.6 28691.3 49391.3 49500.8 49723.8 49794.8 50909.7 41860.0 41972.6 42392.8 42420.4 42706.4 40765.4 41658.4 41711.2 41779.6 41786.2 40516.6 41037.0 42080.0 42095.8 42296.8 35614.3 37294.4 37325.4 37367.4 38033.4 28205.3 28285.3 28495.3 28897.6 30364.4 05:32:18 INFO - PROCESS | 27720 | 05:32:18 INFO - PROCESS | 27720 | [#2] jquery.html Cycles:180 Average:30603.94 Median:12759.42 stddev:88938.23 (697.0%) stddev-sans-first:89158.79 05:32:18 INFO - PROCESS | 27720 | Values: 387.8 390.7 391.2 396.5 403.8 17849.1 18985.5 19405.1 19457.5 20056.3 18534.2 19141.7 19274.6 19331.1 19480.1 5478.8 5484.3 5599.8 5692.7 5701.6 5577.5 5641.0 5645.1 5653.5 5682.0 5445.9 5614.7 5635.7 5637.2 5645.4 5550.7 5588.4 5589.8 5591.3 5612.1 4872.5 5025.7 5036.2 5057.5 5063.4 22363.1 22439.3 23063.2 23104.7 23172.8 2232.1 2309.9 2346.1 2577.2 2850.3 9508.3 14212.5 14745.9 14904.6 15130.5 1937.4 1958.2 1963.8 2002.1 2003.6 77300.2 81344.0 82715.0 82786.0 83783.2 10592.8 10648.8 10649.3 10786.0 10951.3 14986.8 15002.3 15021.7 15035.9 15049.5 7610.8 7701.3 7749.8 7793.1 7974.5 7289.6 7467.1 7478.5 7512.5 7711.3 4426.8 4580.8 4593.9 4595.1 4701.4 1879.4 1883.7 1891.8 1905.1 1918.8 887.2 953.0 969.7 1030.5 1054.5 19056.8 19436.2 19529.4 19840.7 19939.5 1036.0 1036.6 1037.2 1062.0 1082.5 10480.6 10927.3 10961.3 11042.9 11052.2 532450.0 540472.0 541514.0 544286.1 545167.0 77173.6 89645.0 92926.0 93191.5 97941.5 1009.5 1021.5 1030.7 1069.2 1071.5 17450.9 17688.6 18015.0 18257.6 18532.2 42936.8 43295.0 43725.8 43969.3 45662.3 61052.0 61892.4 62314.0 62343.0 63222.1 7405.4 8611.5 8748.0 8875.5 8918.0 11472.5 13519.9 13552.3 13787.4 13954.0 11797.6 11947.9 12013.0 12189.7 12230.4 12037.9 12142.2 12287.6 12447.8 12469.5 7033.5 9941.3 12389.8 12400.8 12560.2 7820.2 7854.9 7860.8 7867.6 8087.3 10499.2 12482.2 12584.7 12606.4 12817.6 05:32:18 INFO - PROCESS | 27720 | 05:32:18 INFO - PROCESS | 27720 | [#3] mootools.html Cycles:180 Average:5870.57 Median:4511.73 stddev:3417.36 (75.7%) stddev-sans-first:3410.94 05:32:18 INFO - PROCESS | 27720 | Values: 1468.4 1495.5 1597.1 1707.3 1726.5 7801.6 8406.4 8426.2 9023.3 9024.5 8479.0 8681.7 8741.6 8770.3 8788.0 2300.8 2338.1 2343.3 2347.1 2347.4 2200.2 2223.8 2237.8 2242.5 2254.5 2226.4 2246.0 2257.2 2271.6 2274.8 2209.6 2214.2 2233.5 2243.9 2244.5 2204.4 2214.4 2229.3 2230.4 2234.3 8787.5 8842.0 8843.7 8845.5 8871.9 5237.6 5387.7 5426.3 5430.5 5431.9 3177.2 3265.1 3444.2 3449.7 3459.9 1082.1 1086.4 1107.2 1109.4 1115.7 12315.9 12341.4 12393.8 12404.7 12425.3 4630.6 4664.7 4735.5 4756.8 4772.7 10272.2 10318.6 10340.8 10457.7 10459.8 5302.2 5416.1 5424.5 5428.7 5437.5 4392.8 4748.0 4923.3 4923.4 5007.5 3937.0 3953.6 3994.8 3998.7 4074.6 1169.3 1178.3 1179.2 1192.6 1205.3 852.3 956.5 996.3 996.9 999.8 6000.2 6010.2 6013.2 6116.7 6133.5 411.3 420.3 420.7 423.9 424.3 4097.5 4210.5 4242.8 4264.9 4289.3 10747.2 10862.8 11084.5 11521.5 11570.0 11297.9 11418.5 11418.8 11529.3 11560.3 8363.7 8484.1 8583.0 8607.6 8616.7 5914.2 5925.6 5936.3 5952.9 6059.4 10338.9 10558.3 10606.9 10708.7 10741.5 10660.6 10781.6 10835.2 10858.6 10868.6 7254.9 7261.9 7503.3 7815.1 7960.9 8693.9 8704.3 8707.2 8783.0 8788.8 7726.7 7859.1 7956.6 8002.5 8016.3 7680.9 7749.2 7852.1 7857.6 7867.4 6773.8 6845.8 6983.2 6993.1 7000.0 5301.4 5325.1 5351.2 5445.5 5474.7 5215.6 5266.1 5268.5 5288.9 5346.7 05:32:18 INFO - PROCESS | 27720 | 05:32:18 INFO - PROCESS | 27720 | [#4] prototype.html Cycles:180 Average:4936.16 Median:5632.10 stddev:1459.02 (25.9%) stddev-sans-first:1421.53 05:32:18 INFO - PROCESS | 27720 | Values: 328.5 329.9 333.5 340.3 340.4 5554.9 5675.3 5681.7 5687.6 5715.3 5593.6 5613.7 5614.1 5621.5 5626.4 4205.8 4265.8 4343.5 4370.2 4371.7 4342.2 4345.8 4362.0 4379.6 4411.6 4363.3 4364.5 4403.6 4405.1 4411.3 4298.3 4300.1 4304.3 4308.4 4314.9 3821.8 3829.2 3849.5 3864.1 3864.6 5447.7 5493.9 5495.8 5503.8 5506.7 4748.9 4931.8 4948.3 4963.2 5024.9 5772.8 5833.9 5846.9 5865.7 5867.7 4175.3 4179.4 4240.8 4264.4 4267.7 5838.2 6170.4 6170.8 6174.5 6245.6 4179.7 4194.2 4199.6 4205.3 4210.8 4237.5 4281.2 4313.2 4320.1 4327.9 4801.0 4935.7 4946.2 4960.7 5012.3 5796.7 5841.3 5863.3 5939.9 5974.8 1455.8 1462.4 1488.9 1495.3 1501.9 948.0 963.3 994.6 1008.7 1009.0 5507.6 5577.9 5626.0 5727.1 5739.5 5965.5 5987.5 6020.3 6065.3 6097.0 5410.4 5571.5 5606.6 5637.8 5688.6 3176.7 3213.2 3252.9 3264.3 3266.7 5990.8 6187.9 6200.5 6214.6 6285.9 6069.2 6143.0 6174.1 6181.8 6242.4 5877.6 6162.3 6191.7 6198.3 6214.7 5946.2 5970.9 5984.4 5991.7 6014.0 5899.5 5904.2 5905.0 5914.7 5952.2 5989.3 6153.3 6168.1 6185.0 6194.9 4205.3 4228.1 4230.5 4231.2 4231.8 5876.4 5983.2 6061.4 6083.8 6091.8 5806.4 5894.5 5916.9 5921.3 5942.6 5592.3 5914.0 5943.0 5944.6 5964.0 5741.9 5742.7 5764.4 5828.0 5853.9 5903.6 5917.9 5947.4 5959.6 5966.4 5577.6 5796.8 5830.6 5848.9 5849.3 05:32:18 INFO - PROCESS | 27720 | 05:32:18 INFO - PROCESS | 27720 | [#5] yui.html Cycles:180 Average:19782.61 Median:27298.91 stddev:27655.57 (101.3%) stddev-sans-first:27696.13 05:32:18 INFO - PROCESS | 27720 | Values: 724.5 764.0 783.6 784.1 796.6 14845.9 14986.9 14988.7 15025.8 15222.8 13511.3 14069.9 14152.7 14372.4 14434.1 791.4 791.8 796.1 797.2 800.0 775.2 803.5 810.0 810.6 811.1 856.6 863.0 864.1 864.6 865.6 857.6 857.9 861.5 862.3 862.3 617.8 618.4 618.5 624.5 625.9 15741.0 15754.3 15764.1 15794.4 15825.1 13714.4 13754.3 14590.8 14593.3 14691.9 12283.3 12314.4 12463.4 12531.9 13070.5 3849.2 3853.2 3964.5 4020.8 4024.0 74252.6 74892.0 76252.2 76474.6 77287.0 10188.3 10284.0 10466.3 10546.5 10698.2 20854.0 21102.0 21147.3 21326.5 21556.4 8415.1 8424.2 8466.2 8485.6 8513.7 4795.0 4828.4 4837.0 4863.5 4895.8 3556.3 3677.8 3680.7 3684.8 3708.2 589.8 596.9 607.9 611.7 611.8 647.3 675.0 684.8 685.2 702.5 9268.7 9732.5 9777.1 9809.2 9961.8 597.2 686.2 714.6 751.8 756.3 4436.0 4497.6 4528.3 4532.4 4572.6 84943.2 107897.5 110230.0 112360.4 113282.7 62693.4 65270.0 65397.0 81164.0 92947.1 85229.0 85959.0 87493.6 87785.6 88906.0 9529.9 9598.4 9821.8 9852.6 9900.1 48104.8 49702.0 50257.0 50697.2 54603.5 66970.7 76316.2 76683.2 77129.6 77583.0 12712.2 12757.0 12805.9 12829.4 13019.9 14566.6 14692.3 15044.8 15086.5 15277.5 13608.9 13654.2 13734.3 13799.6 14310.1 13441.6 13667.6 13877.5 13934.3 14516.9 13621.9 13624.6 13720.6 13779.8 13852.1 9573.9 9699.0 9755.5 9854.7 10077.8 10397.7 10517.9 10564.4 10606.2 10612.7 05:32:18 INFO - PROCESS | 27720 | -------- Summary: end -------- 05:32:18 INFO - PROCESS | 27720 | 05:32:19 INFO - TEST-INFO | 27720: exit 0 05:32:19 INFO - TEST-OK | dromaeo_css | took 1111946ms 05:32:19 INFO - TEST-START | kraken 05:32:19 INFO - operating with platform_type : linux_ 05:32:19 INFO - Initialising browser for kraken test... 05:32:19 INFO - TEST-INFO | started process 27961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkjcxu/profile http://localhost:42126/getInfo.html) 05:32:24 INFO - PROCESS | 27961 | __metrics Screen width/height:1600/1200 05:32:24 INFO - PROCESS | 27961 | colorDepth:24 05:32:24 INFO - PROCESS | 27961 | Browser inner width/height: 1024/697 05:32:24 INFO - PROCESS | 27961 | __metrics 05:32:25 ERROR - PROCESS | 27961 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:32:26 INFO - TEST-INFO | 27961: exit 0 05:32:26 INFO - Browser initialized. 05:32:26 INFO - Running cycle 1/1 for kraken test... 05:32:26 INFO - TEST-INFO | started process 28080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkjcxu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:38 INFO - PROCESS | 28080 | RSS: Main: 184872960 05:32:38 INFO - PROCESS | 28080 | 05:32:40 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42126/tests/kraken/driver.html?testName=audio-beat-detection) 05:32:41 INFO - PROCESS | 28080 | RSS: Main: 190021632 05:32:41 INFO - PROCESS | 28080 | 05:32:44 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42126/tests/kraken/driver.html?testName=audio-dft) 05:32:44 INFO - PROCESS | 28080 | RSS: Main: 189431808 05:32:44 INFO - PROCESS | 28080 | 05:32:47 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42126/tests/kraken/driver.html?testName=audio-fft) 05:32:48 INFO - PROCESS | 28080 | RSS: Main: 184897536 05:32:48 INFO - PROCESS | 28080 | 05:32:50 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42126/tests/kraken/driver.html?testName=audio-oscillator) 05:32:51 INFO - PROCESS | 28080 | RSS: Main: 185450496 05:32:51 INFO - PROCESS | 28080 | 05:32:53 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42126/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:32:54 INFO - PROCESS | 28080 | RSS: Main: 185561088 05:32:54 INFO - PROCESS | 28080 | 05:32:57 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42126/tests/kraken/driver.html?testName=imaging-darkroom) 05:32:57 INFO - PROCESS | 28080 | RSS: Main: 186220544 05:32:57 INFO - PROCESS | 28080 | 05:33:01 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42126/tests/kraken/driver.html?testName=imaging-desaturate) 05:33:01 INFO - PROCESS | 28080 | RSS: Main: 186429440 05:33:01 INFO - PROCESS | 28080 | 05:33:04 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42126/tests/kraken/driver.html?testName=json-parse-financial) 05:33:05 INFO - PROCESS | 28080 | RSS: Main: 185856000 05:33:05 INFO - PROCESS | 28080 | 05:33:06 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42126/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:33:07 INFO - PROCESS | 28080 | RSS: Main: 186191872 05:33:07 INFO - PROCESS | 28080 | 05:33:09 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42126/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:33:09 INFO - PROCESS | 28080 | RSS: Main: 185831424 05:33:09 INFO - PROCESS | 28080 | 05:33:12 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42126/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:33:12 INFO - PROCESS | 28080 | RSS: Main: 186261504 05:33:12 INFO - PROCESS | 28080 | 05:33:15 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:33:15 INFO - PROCESS | 28080 | RSS: Main: 186925056 05:33:15 INFO - PROCESS | 28080 | 05:33:18 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:33:19 INFO - PROCESS | 28080 | RSS: Main: 186679296 05:33:19 INFO - PROCESS | 28080 | 05:33:20 INFO - PROCESS | 28080 | Cycle 1(1): loaded http://localhost:42126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42126/tests/kraken/driver.html?testName=ai-astar) 05:33:21 INFO - PROCESS | 28080 | RSS: Main: 187244544 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | __start_tp_report 05:33:21 INFO - PROCESS | 28080 | _x_x_mozilla_page_load 05:33:21 INFO - PROCESS | 28080 | _x_x_mozilla_page_load_details 05:33:21 INFO - PROCESS | 28080 | |i|pagename|runs| 05:33:21 INFO - PROCESS | 28080 | |0;ai-astar;111;105;111;111;112;112;109;110;111;112 05:33:21 INFO - PROCESS | 28080 | |1;audio-beat-detection;150;136;158;174;139;164;167;129;178;127 05:33:21 INFO - PROCESS | 28080 | |2;audio-dft;161;163;163;161;164;173;162;163;162;163 05:33:21 INFO - PROCESS | 28080 | |3;audio-fft;75;75;75;149;76;76;75;74;167;75 05:33:21 INFO - PROCESS | 28080 | |4;audio-oscillator;84;89;138;87;87;87;144;86;86;149 05:33:21 INFO - PROCESS | 28080 | |5;imaging-gaussian-blur;118;119;120;118;118;117;118;117;117;118 05:33:21 INFO - PROCESS | 28080 | |6;imaging-darkroom;147;147;148;150;148;148;147;148;147;147 05:33:21 INFO - PROCESS | 28080 | |7;imaging-desaturate;97;95;95;95;95;95;96;96;96;96 05:33:21 INFO - PROCESS | 28080 | |8;json-parse-financial;56;58;61;55;59;63;60;56;55;61 05:33:21 INFO - PROCESS | 28080 | |9;json-stringify-tinderbox;61;62;62;61;62;62;61;61;61;61 05:33:21 INFO - PROCESS | 28080 | |10;stanford-crypto-aes;79;81;80;79;82;81;88;82;117;85 05:33:21 INFO - PROCESS | 28080 | |11;stanford-crypto-ccm;133;124;123;119;123;121;123;130;144;125 05:33:21 INFO - PROCESS | 28080 | |12;stanford-crypto-pbkdf2;159;165;162;158;158;160;159;160;160;160 05:33:21 INFO - PROCESS | 28080 | |13;stanford-crypto-sha256-iterative;65;69;62;64;65;65;63;63;68;62 05:33:21 INFO - PROCESS | 28080 | __end_tp_report 05:33:21 INFO - PROCESS | 28080 | __start_cc_report 05:33:21 INFO - PROCESS | 28080 | _x_x_mozilla_cycle_collect,868 05:33:21 INFO - PROCESS | 28080 | __end_cc_report 05:33:21 INFO - PROCESS | 28080 | __startTimestamp1465562001185__endTimestamp 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | ------- Summary: start ------- 05:33:21 INFO - PROCESS | 28080 | Number of tests: 14 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 05:33:21 INFO - PROCESS | 28080 | Values: 111.0 105.0 111.0 111.0 112.0 112.0 109.0 110.0 111.0 112.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:161.00 stddev:18.70 (11.6%) stddev-sans-first:19.82 05:33:21 INFO - PROCESS | 28080 | Values: 150.0 136.0 158.0 174.0 139.0 164.0 167.0 129.0 178.0 127.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:3.47 (2.1%) stddev-sans-first:3.56 05:33:21 INFO - PROCESS | 28080 | Values: 161.0 163.0 163.0 161.0 164.0 173.0 162.0 163.0 162.0 163.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#3] audio-fft Cycles:10 Average:91.70 Median:75.00 stddev:35.20 (46.9%) stddev-sans-first:36.82 05:33:21 INFO - PROCESS | 28080 | Values: 75.0 75.0 75.0 149.0 76.0 76.0 75.0 74.0 167.0 75.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:86.50 stddev:27.73 (32.1%) stddev-sans-first:28.48 05:33:21 INFO - PROCESS | 28080 | Values: 84.0 89.0 138.0 87.0 87.0 87.0 144.0 86.0 86.0 149.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 05:33:21 INFO - PROCESS | 28080 | Values: 118.0 119.0 120.0 118.0 118.0 117.0 118.0 117.0 117.0 118.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 05:33:21 INFO - PROCESS | 28080 | Values: 147.0 147.0 148.0 150.0 148.0 148.0 147.0 148.0 147.0 147.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 05:33:21 INFO - PROCESS | 28080 | Values: 97.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.50 stddev:2.84 (4.8%) stddev-sans-first:2.87 05:33:21 INFO - PROCESS | 28080 | Values: 56.0 58.0 61.0 55.0 59.0 63.0 60.0 56.0 55.0 61.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:33:21 INFO - PROCESS | 28080 | Values: 61.0 62.0 62.0 61.0 62.0 62.0 61.0 61.0 61.0 61.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:81.50 stddev:11.44 (14.0%) stddev-sans-first:11.90 05:33:21 INFO - PROCESS | 28080 | Values: 79.0 81.0 80.0 79.0 82.0 81.0 88.0 82.0 117.0 85.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:124.50 stddev:7.40 (5.9%) stddev-sans-first:7.46 05:33:21 INFO - PROCESS | 28080 | Values: 133.0 124.0 123.0 119.0 123.0 121.0 123.0 130.0 144.0 125.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:160.00 stddev:2.08 (1.3%) stddev-sans-first:2.17 05:33:21 INFO - PROCESS | 28080 | Values: 159.0 165.0 162.0 158.0 158.0 160.0 159.0 160.0 160.0 160.0 05:33:21 INFO - PROCESS | 28080 | 05:33:21 INFO - PROCESS | 28080 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:2.37 (3.6%) stddev-sans-first:2.51 05:33:21 INFO - PROCESS | 28080 | Values: 65.0 69.0 62.0 64.0 65.0 65.0 63.0 63.0 68.0 62.0 05:33:21 INFO - PROCESS | 28080 | -------- Summary: end -------- 05:33:21 INFO - PROCESS | 28080 | 05:33:22 INFO - TEST-INFO | 28080: exit 0 05:33:22 INFO - TEST-OK | kraken | took 62462ms 05:33:22 INFO - SUITE-END | took 1174s 05:33:22 INFO - Completed test suite (00:19:34) 05:33:22 INFO - javascript benchmark 05:33:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7245.467146345715, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.7072378124076, 3117.906462806115, 3146.8269245191505, 3155.132338606882, 3162.3359094590137, 5369.38252101008, 5382.89234215316, 5425.0506161421745, 5438.809641662542, 5497.038018346793, 5305.336832895888, 5422.40353561109, 5499.7250137493165, 5521.282233309664, 5574.442555744424, 4975.776090075946, 5010.624203184758, 5038.773255203525, 5146.511081447256, 5163.690178589278, 5010.874728131807, 5182.170852663575, 5229.973850130763, 5233.084210263189, 5234.214867769827, 4862.197737373329, 4905.117078925792, 5001.424836143854, 5030.044291584605, 5063.569596584276, 4917.975410122926, 4931.137051016058, 4968.7515624219, 5002.274670172841, 5035.068512325195, 4925.408950925876, 4933.925991110136, 4938.456769755324, 4962.503749625044, 4980.377452818398, 5278.2346559749, 5380.515753582157, 5392.541633961118, 5404.729763511848, 5428.538574221196, 5810.041343178371, 5819.447152520504, 5821.563382746269, 5821.767129314822, 5836.066229403317, 5886.941130588725, 5895.4399332063385, 5903.3801450847905, 5904.114382842565, 5918.437748413894, 5321.787128514855, 5401.540869026137, 5423.728813559306, 5479.6164268501225, 5501.312335958005, 5994.831007953408, 5997.280326360865, 6001.4298641628975, 6012.428819262163, 6013.0, 5539.224508568804, 5799.014167591519, 5803.419658034247, 5806.187133801272, 5816.389279125716, 5783.768649253982, 5825.563082768809, 5843.766249350064, 5876.206712093898, 5881.3530511643685, 5680.176374425685, 5710.114932185518, 5839.941600584025, 5862.355140934494, 5863.648181109147, 5773.061030351685, 5808.448197421239, 5820.097884827858, 5826.796062137805, 5858.8242352729485, 4372.672049596293, 4377.715448495837, 4408.9559104408545, 4418.1163767246035, 4419.779011049434, 3918.5101862267215, 3958.129211573449, 3966.5438474575217, 3992.201559688074, 4003.3994900764537, 5360.91958620621, 5496.5053145217125, 5523.337199536001, 5546.805861794898, 5557.5553955683445, 5815.621984570989, 5845.503132233723, 5858.765649374062, 5895.646261224255, 5904.793332233351, 5557.472040156179, 5592.7762889484775, 5593.161025846156, 5604.103343465026, 5631.859203519863, 4767.261074533453, 4837.879053023703, 4911.656184067081, 4927.876803079952, 4928.088303663762, 5978.342382337939, 6061.727222275008, 6103.969480152571, 6121.234845644294, 6124.969375153096, 5919.91120133207, 5926.1999630049395, 5940.198073260054, 5941.970290148522, 5949.137375080676, 5823.301203855395, 5975.581709280309, 6003.8198854034445, 6048.848778780566, 6056.03103503455, 5784.305883294031, 5790.0, 5791.478766910998, 5805.361410244954, 5825.912611310749, 5795.942040579709, 5855.0, 5855.268091488564, 5876.294844618673, 5903.2916050072545, 5408.0, 5638.718064096696, 5666.291713535808, 5674.177244299471, 5678.0915053591225, 5548.833534993957, 5595.608307418442, 5601.579881508985, 5679.148127780866, 5710.457506536873, 5451.836444906659, 5529.419410961952, 5555.30558680165, 5564.805231817029, 5570.637908535932, 5628.8874222514505, 5692.743826527733, 5749.396313387201, 5759.683217423082, 5767.711614419346, 5459.989901868167, 5583.050881350261, 5598.608097433141, 5620.859478512906, 5641.182028605911], "value": 5376.055666703432, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.585578383564, 609.615941956567, 625.3996163682864, 637.0794202377565, 664.8204984654141, 37288.62711372886, 42747.14505709888, 42764.35853462197, 42977.78511107448, 43139.13721725564, 41883.371749423706, 42308.153836923244, 42519.78740106295, 42633.360499592534, 42775.3583696244, 8737.432066915662, 8860.424072435304, 8880.733577992638, 8881.777955551099, 8917.95541022294, 8715.128487151298, 8770.56147192641, 8838.911610883906, 8841.204291613754, 8847.911520884772, 8840.071792461795, 8927.598258078402, 8940.687075952343, 8943.150400711922, 8954.641814327419, 8707.43401678892, 8820.823583528325, 8846.513441760733, 8861.291096712248, 8904.910950890473, 8896.154865287788, 8927.61621948599, 8978.820423591556, 9000.234980026706, 9004.099590041009, 41405.585944140475, 41647.167056659004, 41734.37398439026, 41851.58148418507, 42016.57983420157, 3510.912227194315, 3686.8525258989607, 4196.622303992655, 4319.287317592593, 4383.473983122046, 31850.522242166386, 32557.348853023042, 32848.17879553006, 32939.341213175605, 33381.83309083463, 3912.5500567434824, 4072.9389059164137, 4328.394024836525, 4440.844570440019, 4527.411436513232, 374909.0, 375224.0, 376485.0, 376892.1155394233, 376995.0, 33868.661313386554, 34662.0, 34733.0, 60586.0, 60732.0, 37158.628413715516, 37302.25395492075, 37342.879713608636, 37349.43975840365, 37394.62605373966, 15087.170205638795, 15333.156676382907, 15439.073655580702, 15459.845401546065, 15475.071495710294, 12688.23870567769, 12735.426905789262, 12868.034897382546, 12868.356582170854, 12911.612651620466, 8341.374396920255, 8386.538740369338, 8427.073021967579, 8465.280451161598, 8545.786355341166, 3174.9841250793597, 3187.4103290891258, 3239.72462340699, 3269.2971011232225, 3270.787398819069, 968.2689569375218, 1013.7653431396822, 1017.2777328097134, 1077.73595469109, 1136.5944775579583, 33335.83332083324, 33336.0, 33709.0, 33789.83105084508, 34169.65830341714, 1111.6831702964616, 1142.257532603814, 1165.3008195082882, 1235.6849003504049, 1268.0869773762877, 17332.82667173337, 17538.912305438647, 17582.472525824247, 17644.294228230727, 17679.73480397795, 540924.0, 549733.0, 557834.0, 558470.2841343766, 558945.0, 58797.70601146967, 58816.11775823366, 59281.0, 59428.70285648544, 59649.0, 1318.1102755640097, 1363.986360136406, 1369.9726005479833, 1372.499037851177, 1373.3957058893855, 31041.8447907759, 31860.8406957973, 32054.358912821146, 32090.0, 33077.0, 52991.735041324544, 53078.2038269434, 53112.203316949504, 53492.732536338626, 53639.463605363446, 467680.0, 480440.0, 483291.0, 484927.0, 486748.0, 28213.576796348483, 28243.858780706785, 28461.857690711415, 28507.572386414635, 28691.28271793222, 49391.25913111235, 49500.75249623729, 49723.75138124286, 49794.75102624464, 50909.74545127251, 41860.0, 41972.580274196866, 42392.788036059625, 42420.39807207203, 42706.35940460833, 40765.388519172826, 41658.37512437255, 41711.1657766849, 41779.58220417757, 41786.1642767149, 40516.594834051284, 41037.0, 42080.0, 42095.7895210522, 42296.788516057226, 35614.287714246086, 37294.44058339181, 37325.44011839879, 37367.439488408236, 38033.42949855699, 28205.280744024334, 28285.292867678472, 28495.28761780972, 28897.56653650155, 30364.392712145192], "value": 19143.485135661525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.79253099591716, 390.69135383047376, 391.2097562922894, 396.46675221826644, 403.75976294105016, 17849.107544622766, 18985.52536186596, 19405.12676929538, 19457.47052883125, 20056.298029568967, 18534.165962531686, 19141.712874306897, 19274.614507709837, 19331.130099145535, 19480.123394447248, 5478.835634930949, 5484.341878974528, 5599.832005039855, 5692.658440493563, 5701.629394089371, 5577.470140336682, 5641.041023026095, 5645.096784514479, 5653.547716182696, 5682.034054210794, 5445.863853403677, 5614.747336369873, 5635.746391412396, 5637.210790489335, 5645.350784659755, 5550.69471179085, 5588.441155884399, 5589.804356847531, 5591.329040515164, 5612.102063669793, 4872.537108974641, 5025.698458092526, 5036.19420892659, 5057.4689657585795, 5063.443021267658, 22363.10547578095, 22439.32682019542, 23063.192788252498, 23104.65343019856, 23172.76827231723, 2232.0625337358347, 2309.8845057747044, 2346.0733010460945, 2577.2139497453268, 2850.315924178203, 9508.334416590773, 14212.50256241037, 14745.852541474555, 14904.62738431537, 15130.470433534774, 1937.4381429385462, 1958.177565422526, 1963.813437723414, 2002.119067610247, 2003.6393449179143, 77300.22699773042, 81344.0, 82715.0, 82786.0, 83783.16216837875, 10592.841107383396, 10648.787024259627, 10649.307794993301, 10786.0, 10951.288166269167, 14986.775198372034, 15002.324895379734, 15021.69956600862, 15035.924820376047, 15049.54851354461, 7610.820322849967, 7701.345385642171, 7749.7675069748, 7793.06483222017, 7974.52152870818, 7289.562626242442, 7467.1039475263315, 7478.5138965967035, 7512.549247045085, 7711.305982461606, 4426.75652839097, 4580.8167673293365, 4593.862184134415, 4595.126925884071, 4701.3653156824075, 1879.4079864842531, 1883.6797744383487, 1891.8202770736757, 1905.104600837604, 1918.788933217373, 887.1527691055027, 953.0, 969.6751588217885, 1030.4899074957943, 1054.4516851237313, 19056.809431905782, 19436.2225510978, 19529.414117576212, 19840.702389464168, 19939.501512462306, 1035.9585616575403, 1036.6060896859296, 1037.2065369991963, 1061.9522121504551, 1082.5345101606385, 10480.63317783874, 10927.344359338465, 10961.342319460859, 11042.944785276022, 11052.171087168334, 532450.0, 540472.0, 541514.0, 544286.0785186125, 545167.0, 77173.61413192897, 89645.0, 92926.0, 93191.53404232935, 97941.51029244809, 1009.4649835587151, 1021.4841505040056, 1030.6959446963165, 1069.1607088435542, 1071.507106730897, 17450.91274543619, 17688.55778605545, 18015.0, 18257.634847302714, 18532.166052527937, 42936.78531607322, 43295.0, 43725.781371094214, 43969.34045989249, 45662.31506527471, 61052.0, 61892.38107618866, 62314.0, 62343.0, 63222.05166922408, 7405.407567394488, 8611.492988727074, 8747.956260218658, 8875.511846848485, 8917.955410222907, 11472.483738231633, 13519.932400337935, 13552.254625995665, 13787.379567919668, 13954.0, 11797.587084452003, 11947.880521194676, 12013.0, 12189.695257618276, 12230.449629766505, 12037.939810300892, 12142.210756300812, 12287.631371058882, 12447.751044979232, 12469.5012199511, 7033.507654464139, 9941.30410871261, 12389.75220495603, 12400.81398779001, 12560.183588066746, 7820.217978202134, 7854.921450785419, 7860.803479913048, 7867.645955932111, 8087.3125784308995, 10499.229018647167, 12482.188657737219, 12584.748305033665, 12606.369681515704, 12817.615471535868], "value": 9284.45405656711, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.441992043024, 1495.48405799999, 1597.1136019509174, 1707.3426730708682, 1726.4734256051916, 7801.6489257983385, 8406.369522285837, 8426.199511046449, 9023.278137748981, 9024.458532488046, 8478.957605211981, 8681.652733890636, 8741.606627701753, 8770.254528365096, 8788.0, 2300.8159347252263, 2338.0998315648512, 2343.3321503371544, 2347.108098922407, 2347.3896786835376, 2200.185931205456, 2223.755386907439, 2237.7538470768204, 2242.506648537319, 2254.5265494246228, 2226.421130506064, 2246.0229800036955, 2257.1761307122947, 2271.5797577448225, 2274.80664143548, 2209.6133176694016, 2214.1586197245106, 2233.452804062999, 2243.876586787726, 2244.4837687332006, 2204.4048107011017, 2214.3578362275084, 2229.342344008521, 2230.39779259599, 2234.2626933112033, 8787.472751634858, 8841.955790221007, 8843.69047083349, 8845.469271843709, 8871.866921996176, 5237.580993520509, 5387.67673939561, 5426.294581704353, 5430.484104010113, 5431.945680543223, 3177.189816596776, 3265.118418027143, 3444.207832198583, 3449.6550344965303, 3459.896203113911, 1082.0748260237463, 1086.4296244471636, 1107.1530279336314, 1109.3732041396586, 1115.6876074699098, 12315.93842030793, 12341.444634991447, 12393.814092788525, 12404.689882752913, 12425.254484730945, 4630.606398456169, 4664.673472856935, 4735.455422626442, 4756.8097276108565, 4772.737499437495, 10272.178225741924, 10318.587256509805, 10340.844887326695, 10457.68626941193, 10459.84310235347, 5302.1781623848365, 5416.133418652997, 5424.457554244623, 5428.728563571805, 5437.510624043855, 4392.846250381222, 4747.95252047482, 4923.310736496894, 4923.433805112458, 5007.499250075036, 3936.9606303937167, 3953.6441720245316, 3994.8202330894596, 3998.660113890294, 4074.633283004544, 1169.2750494693175, 1178.263585259213, 1179.204037274836, 1192.6183621241294, 1205.2949024820402, 852.2798235491, 956.4930586789013, 996.342414006752, 996.8903420623726, 999.8050380175941, 6000.21997140369, 6010.158577799111, 6013.1581578579035, 6116.694165291718, 6133.539984501181, 411.3151602581728, 420.268732405612, 420.743346558599, 423.9067405170857, 424.3083773449258, 4097.549269580344, 4210.536840947493, 4242.830286788556, 4264.850730224489, 4289.292266775947, 10747.247692661438, 10862.837057444145, 11084.501197446134, 11521.539138434537, 11570.0, 11297.943510282395, 11418.486168122288, 11418.828717569244, 11529.250598711225, 11560.30638161713, 8363.665453381918, 8484.109168537214, 8583.0, 8607.569621519024, 8616.741497755078, 5914.201582786269, 5925.614835035709, 5936.257967754031, 5952.940470595238, 6059.3637668045985, 10338.948305258426, 10558.260921735406, 10606.946965265124, 10708.678739637824, 10741.46292685347, 10660.573577056832, 10781.568737250422, 10835.241533092609, 10858.565657373932, 10868.61959831402, 7254.854902901807, 7261.854762904818, 7503.287187717158, 7815.062192536932, 7960.920390796018, 8693.91306086931, 8704.26013788835, 8707.172818582478, 8782.956085219534, 8788.824223515367, 7726.690932362867, 7859.09620393662, 7956.6419511120985, 8002.479838810459, 8016.278534931884, 7680.884786728092, 7749.225077492206, 7852.13626501073, 7857.607119643881, 7867.365059467785, 6773.796786096425, 6845.794626161223, 6983.2318444972025, 6993.0908981832035, 6999.965000174967, 5301.390340110936, 5325.09473389517, 5351.1973204019705, 5445.455454454681, 5474.72626368672, 5215.634905556574, 5266.131088370376, 5268.5258326749245, 5288.894222115459, 5346.679199248058], "value": 4566.127147405401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.48263984224855, 329.93566254580355, 333.54637692737873, 340.3261542146551, 340.36861621691776, 5554.888902221953, 5675.2622159119255, 5681.687507187098, 5687.63030403024, 5715.2855893013375, 5593.608447408683, 5613.691246981414, 5614.147331380645, 5621.4940655341015, 5626.352969408519, 4205.810738516767, 4265.829366825324, 4343.522212556616, 4370.2133615949115, 4371.65026797857, 4342.218400687875, 4345.78271086446, 4361.953131248493, 4379.642310883621, 4411.580899814512, 4363.258246098155, 4364.454443194601, 4403.647708183337, 4405.140997505488, 4411.3382992551215, 4298.312270036779, 4300.118475712471, 4304.268274393361, 4308.3537469379535, 4314.913701725979, 3821.8280177392085, 3829.215010922782, 3849.538055433338, 3864.091938394475, 3864.632859878307, 5447.665321996096, 5493.917591236134, 5495.763453223033, 5503.752331145068, 5506.697131657757, 4748.881277968044, 4931.778069986859, 4948.257761335828, 4963.205887058053, 5024.924626130611, 5772.769089236425, 5833.854153646151, 5846.889091072725, 5865.736041878083, 5867.677277749722, 4175.331946888483, 4179.414881916534, 4240.766757828318, 4264.424302719124, 4267.701260911737, 5838.182654428383, 6170.444659980623, 6170.791188581912, 6174.475169610589, 6245.594036387621, 4179.7460761771345, 4194.161167766398, 4199.580041995837, 4205.3271476563605, 4210.789460527023, 4237.453329534697, 4281.207976524353, 4313.180495705806, 4320.135972805451, 4327.935080973788, 4800.95199048012, 4935.654504184673, 4946.194638956827, 4960.677555958851, 5012.273220383024, 5796.710164491843, 5841.269841269841, 5863.2670916135485, 5939.851503712355, 5974.790882319098, 1455.7961885336063, 1462.4223431744615, 1488.873445757101, 1495.327102803721, 1501.9173945433106, 947.990520094804, 963.330485312701, 994.597188138805, 1008.6822650864954, 1009.0, 5507.5593952483705, 5577.860553486114, 5626.0, 5727.140928860621, 5739.512141467939, 5965.463108320185, 5987.520998320124, 6020.307664618537, 6065.302490213594, 6096.9575192310185, 5410.404855465896, 5571.498565129158, 5606.55147588192, 5637.844241930395, 5688.601797874109, 3176.745860331168, 3213.1806389371027, 3252.902412927616, 3264.281857991238, 3266.673332666762, 5990.843296413288, 6187.938120618826, 6200.472959798468, 6214.627122372672, 6285.937140628535, 6069.180660610849, 6142.969285153635, 6174.086033329682, 6181.783637572753, 6242.375762423721, 5877.5591830612875, 6162.322144564095, 6191.721372538246, 6198.256209254918, 6214.689265536705, 5946.1972633693895, 5970.940290597038, 5984.354302566829, 5991.670458124845, 6013.9699301503215, 5899.46904778572, 5904.173415721716, 5904.9704751475965, 5914.67469289176, 5952.196453478725, 5989.2812862456785, 6153.29237137717, 6168.1056246844855, 6184.969075154595, 6194.876102477835, 4205.264078786261, 4228.112096459778, 4230.534641189528, 4231.217224813419, 4231.809568569361, 5876.44173803488, 5983.192269043623, 6061.424164704346, 6083.847903802263, 6091.786787462417, 5806.44838740319, 5894.498967587803, 5916.881662366814, 5921.3190483094995, 5942.58401911862, 5592.315688469476, 5914.0, 5943.0, 5944.64332140073, 5963.956307646231, 5741.885162296647, 5742.741576628978, 5764.423557644202, 5827.970860145672, 5853.946289667901, 5903.645781253139, 5917.940820591739, 5947.405259474018, 5959.582829201914, 5966.403359663999, 5577.633479797476, 5796.82609521715, 5830.591858569859, 5848.853778655568, 5849.303701926394], "value": 4464.759433851757, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.5435375713303, 763.9770806875796, 783.5964478293678, 784.1022029775907, 796.6375299238844, 14845.851541484582, 14986.850131498682, 14988.700225995473, 15025.849741502581, 15222.847771522282, 13511.256880871548, 14069.929650351734, 14152.716945661106, 14372.353244104015, 14434.133951962864, 791.4183075439533, 791.8257983243706, 796.0884786918974, 797.1789057270992, 799.9640016199285, 775.1550809617515, 803.5138741061661, 810.0320117459638, 810.6392655268407, 811.1158836867813, 856.648774002659, 862.9525376104311, 864.0797550608581, 864.5547543015321, 865.5888452984814, 857.6440777077537, 857.8670306102564, 861.4960248254779, 862.2886118951858, 862.3144600042981, 617.8455386153462, 618.3816183816184, 618.4619381138393, 624.4629618528107, 625.9029850373199, 15741.0, 15754.291056902466, 15764.132972686497, 15794.447194348257, 15825.129617871013, 13714.382852771649, 13754.31228438574, 14590.781138282935, 14593.34329955144, 14691.926540367229, 12283.324417157053, 12314.384280785926, 12463.439145238486, 12531.93734031333, 13070.477180912752, 3849.2301539691894, 3853.190829925719, 3964.524257089168, 4020.798960052015, 4024.03423178438, 74252.62873685651, 74892.0, 76252.23747762507, 76474.61762691151, 77287.0, 10188.286819922534, 10283.971602839656, 10466.267361284788, 10546.525406356732, 10698.197635177392, 20854.0, 21102.0, 21147.25984590532, 21326.466838329165, 21556.353309400743, 8415.116412776693, 8424.241818236389, 8466.238038576557, 8485.575721213914, 8513.659453621909, 4795.0, 4828.37231159947, 4836.951630483721, 4863.537963893425, 4895.814078962436, 3556.270964452281, 3677.79772112531, 3680.7239457040296, 3684.8157592120288, 3708.2027364116307, 589.8083122985047, 596.8627215740318, 607.9209702738616, 611.7063809371526, 611.8195132435942, 647.252423450915, 674.956127851688, 684.8116767888771, 685.2154283345542, 702.5257950883235, 9268.72193834186, 9732.464714440774, 9777.120059194707, 9809.166220871306, 9961.750956226007, 597.2027343496394, 686.2279935073043, 714.6176795414428, 751.8158051277472, 756.3230908337008, 4436.0240747035605, 4497.617702495325, 4528.343390208467, 4532.4334458192725, 4572.611328037087, 84943.15056849476, 107897.46051269694, 110230.0, 112360.43819780849, 113282.6623253403, 62693.37306626967, 65270.0, 65397.0, 81164.0, 92947.07052929384, 85229.0, 85959.0, 87493.56253218693, 87785.56107219424, 88906.0, 9529.904700952902, 9598.376105553116, 9821.803563928539, 9852.556634951588, 9900.108990190918, 48104.759476202395, 49702.0, 50257.0, 50697.23954140617, 54603.453965459834, 66970.66514667396, 76316.23683763092, 76683.23316766761, 77129.61435193013, 77583.0, 12712.173708708904, 12757.0, 12805.935970320088, 12829.42267597979, 13019.869801301866, 14566.635834104232, 14692.338844751797, 15044.849551504345, 15086.54740357791, 15277.465288714842, 13608.93195534016, 13654.180749155083, 13734.313284335944, 13799.586012419644, 14310.069845460011, 13441.596752097452, 13667.589972300846, 13877.514286999907, 13934.30328483592, 14516.927415362856, 13621.863781362455, 13624.591262262147, 13720.588382348546, 13779.793303100261, 13852.099613525088, 9573.9042609573, 9698.951505242429, 9755.463449510346, 9854.704358869245, 10077.798444031225, 10397.72755637425, 10517.9474102629, 10564.418956957441, 10606.204534660086, 10612.734681632712], "value": 7426.2521723762875, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 111.0, 112.0, 112.0, 109.0, 110.0, 111.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 136.0, 158.0, 174.0, 139.0, 164.0, 167.0, 129.0, 178.0, 127.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 161.0, 164.0, 173.0, 162.0, 163.0, 162.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 149.0, 76.0, 76.0, 75.0, 74.0, 167.0, 75.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 138.0, 87.0, 87.0, 87.0, 144.0, 86.0, 86.0, 149.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 120.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 150.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 61.0, 55.0, 59.0, 63.0, 60.0, 56.0, 55.0, 61.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 80.0, 79.0, 82.0, 81.0, 88.0, 82.0, 117.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 124.0, 123.0, 119.0, 123.0, 121.0, 123.0, 130.0, 144.0, 125.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 165.0, 162.0, 158.0, 158.0, 160.0, 159.0, 160.0, 160.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 62.0, 64.0, 65.0, 65.0, 63.0, 63.0, 68.0, 62.0], "value": 64.6, "unit": "score"}]}]} 05:33:22 INFO - Return code: 0 05:33:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:33:22 ERROR - # TBPL SUCCESS # 05:33:22 INFO - Running post-action listener: _resource_record_post_action 05:33:22 INFO - ##### 05:33:22 INFO - ##### Finished run-tests step (success) 05:33:22 INFO - ##### 05:33:22 INFO - Running post-run listener: _resource_record_post_run 05:33:22 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530223104; Read time: 12; Write time: 459000 05:33:22 INFO - TinderboxPrint: CPU usage
13.4% 05:33:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:33:22 INFO - TinderboxPrint: I/O write bytes / time
530,223,104 / 459,000 05:33:22 INFO - TinderboxPrint: CPU idle
8,228.7 (86.5%) 05:33:22 INFO - TinderboxPrint: CPU user
1,222.6 (12.9%) 05:33:22 INFO - TinderboxPrint: Swap in / out
0 / 0 05:33:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 130412544; Read time: 0; Write time: 150384 05:33:22 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293257216; Read time: 12; Write time: 215968 05:33:23 INFO - Running post-run listener: _upload_blobber_files 05:33:23 INFO - Blob upload gear active. 05:33:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:33:23 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 05:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:33:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:33:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:33:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:33:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:24 INFO - (blobuploader) - INFO - Done attempting. 05:33:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:33:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:33:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:25 INFO - (blobuploader) - INFO - Done attempting. 05:33:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:33:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:33:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:29 INFO - (blobuploader) - INFO - Done attempting. 05:33:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:33:29 INFO - Return code: 0 05:33:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:33:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:33:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f23477669164643d8a1ea1f1e5641f6d8ab2d1802f7894973648388a6218439008dec08c185b8ca3ce663a3423ad2bdc263965f2a1130cd7989965979e2de4d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e72bf4d1b815aa33e8dc8e047da2acdea7fe723cd0a4b664b37204e3b8e4a806ec71ec79e8f5740e36bfa6d207daa5cc22bbb90e22bd93abc554e2becbe08d5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6f2080e71522bd240d00f120c4261ba9dd2ba767f1ee5c5702c5301653d5a625803a0b6056f80d38844d67a70955f96b094d39d9d1c401a0711a7147c5fd081"} 05:33:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:33:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:33:29 INFO - Contents: 05:33:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f23477669164643d8a1ea1f1e5641f6d8ab2d1802f7894973648388a6218439008dec08c185b8ca3ce663a3423ad2bdc263965f2a1130cd7989965979e2de4d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e72bf4d1b815aa33e8dc8e047da2acdea7fe723cd0a4b664b37204e3b8e4a806ec71ec79e8f5740e36bfa6d207daa5cc22bbb90e22bd93abc554e2becbe08d5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6f2080e71522bd240d00f120c4261ba9dd2ba767f1ee5c5702c5301653d5a625803a0b6056f80d38844d67a70955f96b094d39d9d1c401a0711a7147c5fd081"} 05:33:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:33:29 INFO - Copying logs to upload dir... 05:33:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:33:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.507367 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-10 05:33:28.788436) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 05:33:28.791911) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950 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/sha512/f23477669164643d8a1ea1f1e5641f6d8ab2d1802f7894973648388a6218439008dec08c185b8ca3ce663a3423ad2bdc263965f2a1130cd7989965979e2de4d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e72bf4d1b815aa33e8dc8e047da2acdea7fe723cd0a4b664b37204e3b8e4a806ec71ec79e8f5740e36bfa6d207daa5cc22bbb90e22bd93abc554e2becbe08d5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6f2080e71522bd240d00f120c4261ba9dd2ba767f1ee5c5702c5301653d5a625803a0b6056f80d38844d67a70955f96b094d39d9d1c401a0711a7147c5fd081"} build_url:https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/ZCTRnY_PT0q65SMm5WmuOQ/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/sha512/f23477669164643d8a1ea1f1e5641f6d8ab2d1802f7894973648388a6218439008dec08c185b8ca3ce663a3423ad2bdc263965f2a1130cd7989965979e2de4d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e72bf4d1b815aa33e8dc8e047da2acdea7fe723cd0a4b664b37204e3b8e4a806ec71ec79e8f5740e36bfa6d207daa5cc22bbb90e22bd93abc554e2becbe08d5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6f2080e71522bd240d00f120c4261ba9dd2ba767f1ee5c5702c5301653d5a625803a0b6056f80d38844d67a70955f96b094d39d9d1c401a0711a7147c5fd081"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 05:33:28.817544) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:33:28.817868) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465556185.427027-2018645950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:33:28.900993) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 05:33:28.901304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 05:33:28.901602) ========= ========= Total master_lag: 0.16 =========