builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1465547665.75 results: success (0) buildid: 20160610005628 builduid: e99992b985f5470f94dab2304bcefdb3 revision: 6e0788aa97c74aa11b75654bfc82d4ecb34f502a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:25.746558) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:25.746988) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:25.747308) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:25.813602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:25.813903) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 01:34:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.9M=0s 2016-06-10 01:34:26 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094043 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:25.958404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:25.958750) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018460 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:26.012946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:26.013299) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6e0788aa97c74aa11b75654bfc82d4ecb34f502a --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 6e0788aa97c74aa11b75654bfc82d4ecb34f502a --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=337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 01:34:26,366 truncating revision to first 12 chars 2016-06-10 01:34:26,366 Setting DEBUG logging. 2016-06-10 01:34:26,366 attempt 1/10 2016-06-10 01:34:26,366 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6e0788aa97c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 01:34:26,681 unpacking tar archive at: fx-team-6e0788aa97c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661654 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:26.691713) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:26.692021) ========= script_repo_revision: 6e0788aa97c74aa11b75654bfc82d4ecb34f502a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:26.692443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:26.692799) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 01:34:26.706227) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-10 01:34:26.706545) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:34:27 INFO - MultiFileLogger online at 20160610 01:34:27 in /builds/slave/test 01:34:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:34:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:34:27 INFO - {'append_to_log': False, 01:34:27 INFO - 'base_work_dir': '/builds/slave/test', 01:34:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:34:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:34:27 INFO - 'branch': 'Fx-Team-Non-PGO', 01:34:27 INFO - 'buildbot_json_path': 'buildprops.json', 01:34:27 INFO - 'config_files': ('talos/linux_config.py',), 01:34:27 INFO - 'default_actions': ('clobber', 01:34:27 INFO - 'read-buildbot-config', 01:34:27 INFO - 'download-and-extract', 01:34:27 INFO - 'populate-webroot', 01:34:27 INFO - 'create-virtualenv', 01:34:27 INFO - 'install', 01:34:27 INFO - 'run-tests'), 01:34:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:34:27 INFO - 'download_minidump_stackwalk': True, 01:34:27 INFO - 'download_symbols': 'ondemand', 01:34:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:34:27 INFO - 'tooltool.py': '/tools/tooltool.py', 01:34:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:34:27 INFO - '/tools/misc-python/virtualenv.py')}, 01:34:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:34:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:34:27 INFO - 'installer_path': 'installer.exe', 01:34:27 INFO - 'log_level': 'info', 01:34:27 INFO - 'log_name': 'talos', 01:34:27 INFO - 'log_to_console': True, 01:34:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:34:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:34:27 INFO - 'opt_config_files': (), 01:34:27 INFO - 'pip_index': False, 01:34:27 INFO - 'sps_profile': False, 01:34:27 INFO - 'sps_profile_interval': 0, 01:34:27 INFO - 'suite': 'dromaeojs-e10s', 01:34:27 INFO - 'system_bits': '32', 01:34:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:34:27 INFO - 'title': 'talos-linux64-ix-060', 01:34:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:34:27 INFO - 'use_talos_json': True, 01:34:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:34:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:34:27 INFO - 'work_dir': 'build'} 01:34:27 INFO - ##### 01:34:27 INFO - ##### Running clobber step. 01:34:27 INFO - ##### 01:34:27 INFO - Running pre-action listener: _resource_record_pre_action 01:34:27 INFO - Running main action method: clobber 01:34:27 INFO - rmtree: /builds/slave/test/build 01:34:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:34:28 INFO - Running post-action listener: _resource_record_post_action 01:34:28 INFO - ##### 01:34:28 INFO - ##### Finished clobber step (success) 01:34:28 INFO - ##### 01:34:28 INFO - ##### 01:34:28 INFO - ##### Running read-buildbot-config step. 01:34:28 INFO - ##### 01:34:28 INFO - Running pre-action listener: _resource_record_pre_action 01:34:28 INFO - Running main action method: read_buildbot_config 01:34:28 INFO - Using buildbot properties: 01:34:28 INFO - { 01:34:28 INFO - "project": "", 01:34:28 INFO - "product": "firefox", 01:34:28 INFO - "script_repo_revision": "production", 01:34:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:34:28 INFO - "repository": "", 01:34:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:34:28 INFO - "buildid": "20160610005628", 01:34:28 INFO - "pgo_build": "False", 01:34:28 INFO - "basedir": "/builds/slave/test", 01:34:28 INFO - "buildnumber": 1359, 01:34:28 INFO - "slavename": "talos-linux64-ix-060", 01:34:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:34:28 INFO - "platform": "ubuntu64_hw", 01:34:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:34:28 INFO - "branch": "fx-team", 01:34:28 INFO - "repo_path": "integration/fx-team", 01:34:28 INFO - "revision": "6e0788aa97c74aa11b75654bfc82d4ecb34f502a", 01:34:28 INFO - "stage_platform": "linux64", 01:34:28 INFO - "builduid": "e99992b985f5470f94dab2304bcefdb3", 01:34:28 INFO - "slavebuilddir": "test" 01:34:28 INFO - } 01:34:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:34:28 INFO - Running post-action listener: _resource_record_post_action 01:34:28 INFO - ##### 01:34:28 INFO - ##### Finished read-buildbot-config step (success) 01:34:28 INFO - ##### 01:34:28 INFO - ##### 01:34:28 INFO - ##### Running download-and-extract step. 01:34:28 INFO - ##### 01:34:28 INFO - Running pre-action listener: _resource_record_pre_action 01:34:28 INFO - Running main action method: download_and_extract 01:34:28 INFO - mkdir: /builds/slave/test/build/tests 01:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:34:28 INFO - https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:34:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:34:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:34:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/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 01:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/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 01:34:39 INFO - Downloaded 1361 bytes. 01:34:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:34:39 INFO - Using the following test package requirements: 01:34:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:34:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:34:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:34:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:34:39 INFO - u'jsshell-linux-x86_64.zip'], 01:34:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:34:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:34:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:34:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:34:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:34:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:34:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:34:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:34:39 INFO - https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:34:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:34:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:34:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/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 01:34:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/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 01:34:49 INFO - Downloaded 22879604 bytes. 01:34:49 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'] 01:34:49 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 01:34:50 INFO - Return code: 0 01:34:50 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 01:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:34:50 INFO - https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:34:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:34:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:34:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/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 01:34:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/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 01:34:52 INFO - Downloaded 22879604 bytes. 01:34:52 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'] 01:34:52 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 01:34:53 INFO - Return code: 0 01:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:34:53 INFO - https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:34:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:34:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:34:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/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 01:34:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/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 01:34:54 INFO - Downloaded 10833377 bytes. 01:34:54 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'] 01:34:54 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 01:34:55 INFO - Return code: 0 01:34: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')]} 01:34:55 INFO - https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:34:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:34:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:34:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/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 01:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/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 01:34:56 INFO - Downloaded 55378059 bytes. 01:34:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:34:56 INFO - mkdir: /builds/slave/test/properties 01:34:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:34:56 INFO - Writing to file /builds/slave/test/properties/build_url 01:34:56 INFO - Contents: 01:34:56 INFO - build_url:https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:34:57 INFO - Running post-action listener: _resource_record_post_action 01:34:57 INFO - Running post-action listener: set_extra_try_arguments 01:34:57 INFO - ##### 01:34:57 INFO - ##### Finished download-and-extract step (success) 01:34:57 INFO - ##### 01:34:57 INFO - ##### 01:34:57 INFO - ##### Running populate-webroot step. 01:34:57 INFO - ##### 01:34:57 INFO - Running pre-action listener: _resource_record_pre_action 01:34:57 INFO - Running main action method: populate_webroot 01:34:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:34:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:34:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:34:57 INFO - '--tppagecycles', 01:34:57 INFO - '7'], 01:34:57 INFO - 'tests': ['tsvgm']}}, 01:34:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:34:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:34:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:34:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:34:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:34:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:34:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:57 INFO - 'talos_options': ['--disable-e10s'], 01:34:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:57 INFO - 'talos_options': ['--disable-e10s'], 01:34:57 INFO - 'tests': ['damp', 'tps']}, 01:34:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:57 INFO - 'tests': ['damp', 'tps']}, 01:34:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:34:57 INFO - 'tests': ['dromaeo_dom']}, 01:34:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:34:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:34:57 INFO - 'tests': ['a11yr', 01:34:57 INFO - 'ts_paint', 01:34:57 INFO - 'tpaint', 01:34:57 INFO - 'sessionrestore', 01:34:57 INFO - 'sessionrestore_no_auto_restore', 01:34:57 INFO - 'tabpaint']}, 01:34:57 INFO - 'other-e10s': {'tests': ['a11yr', 01:34:57 INFO - 'ts_paint', 01:34:57 INFO - 'tpaint', 01:34:57 INFO - 'sessionrestore', 01:34:57 INFO - 'sessionrestore_no_auto_restore', 01:34:57 INFO - 'tabpaint']}, 01:34:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:34:57 INFO - 'ts_paint', 01:34:57 INFO - 'tpaint', 01:34:57 INFO - 'sessionrestore', 01:34:57 INFO - 'sessionrestore_no_auto_restore', 01:34:57 INFO - 'tabpaint']}, 01:34:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:34:57 INFO - 'ts_paint', 01:34:57 INFO - 'tpaint', 01:34:57 INFO - 'sessionrestore', 01:34:57 INFO - 'sessionrestore_no_auto_restore', 01:34:57 INFO - 'tabpaint']}, 01:34:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:34:57 INFO - 'tests': ['a11yr', 01:34:57 INFO - 'ts_paint', 01:34:57 INFO - 'tpaint', 01:34:57 INFO - 'sessionrestore', 01:34:57 INFO - 'sessionrestore_no_auto_restore', 01:34:57 INFO - 'tabpaint']}, 01:34:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:34:57 INFO - 'tests': ['a11yr', 01:34:57 INFO - 'ts_paint', 01:34:57 INFO - 'tpaint', 01:34:57 INFO - 'sessionrestore', 01:34:57 INFO - 'sessionrestore_no_auto_restore', 01:34:57 INFO - 'tabpaint']}, 01:34:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:34:57 INFO - 'tests': ['tsvgx', 01:34:57 INFO - 'tsvgr_opacity', 01:34:57 INFO - 'tart', 01:34:57 INFO - 'tscrollx', 01:34:57 INFO - 'cart']}, 01:34:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:34:57 INFO - 'tsvgr_opacity', 01:34:57 INFO - 'tart', 01:34:57 INFO - 'tscrollx', 01:34:57 INFO - 'cart']}, 01:34:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:57 INFO - 'talos_options': ['--disable-e10s'], 01:34:57 INFO - 'tests': ['tp5o']}, 01:34:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:57 INFO - 'tests': ['tp5o']}, 01:34:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:57 INFO - 'talos_options': ['--disable-e10s', 01:34:57 INFO - '--xperf_path', 01:34:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:57 INFO - 'tests': ['tp5n']}, 01:34:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:57 INFO - 'talos_options': ['--xperf_path', 01:34:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:57 INFO - 'tests': ['tp5n']}}, 01:34:57 INFO - 'talos.zip': {'path': '', 01:34:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:34:57 INFO - Running post-action listener: _resource_record_post_action 01:34:57 INFO - ##### 01:34:57 INFO - ##### Finished populate-webroot step (success) 01:34:57 INFO - ##### 01:34:57 INFO - ##### 01:34:57 INFO - ##### Running create-virtualenv step. 01:34:57 INFO - ##### 01:34:57 INFO - Running pre-action listener: _resource_record_pre_action 01:34:57 INFO - Running main action method: create_virtualenv 01:34:57 INFO - Creating virtualenv /builds/slave/test/build/venv 01:34:57 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 01:34:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:34:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:34:57 INFO - Using real prefix '/usr' 01:34:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:34:57 INFO - Installing distribute.............................................................................................................................................................................................done. 01:34:59 INFO - Installing pip.................done. 01:34:59 INFO - Return code: 0 01:34:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:59 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 0x7fe97646cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2138350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71c0>, '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 0x21c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c8550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', '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 01:34:59 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 01:34:59 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 01:34:59 INFO - Using env: {'DISPLAY': ':0', 01:34:59 INFO - 'HOME': '/home/cltbld', 01:34:59 INFO - 'LANG': 'en_US.UTF-8', 01:34:59 INFO - 'LANGUAGE': 'en_US:en', 01:34:59 INFO - 'LOGNAME': 'cltbld', 01:34:59 INFO - 'MAIL': '/var/mail/cltbld', 01:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:59 INFO - 'MOZ_NO_REMOTE': '1', 01:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:59 INFO - 'NO_EM_RESTART': '1', 01:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:59 INFO - 'PWD': '/builds/slave/test', 01:34:59 INFO - 'SHELL': '/bin/bash', 01:34:59 INFO - 'SHLVL': '1', 01:34:59 INFO - 'TERM': 'linux', 01:34:59 INFO - 'TMOUT': '86400', 01:34:59 INFO - 'USER': 'cltbld', 01:34:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', 01:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:59 INFO - '_': '/tools/buildbot/bin/python'} 01:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:59 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 01:34:59 INFO - Cleaning up... 01:34:59 INFO - Return code: 0 01:34:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:59 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 0x7fe97646cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2138350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71c0>, '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 0x21c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c8550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', '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 01:34:59 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 01:34:59 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 01:34:59 INFO - Using env: {'DISPLAY': ':0', 01:34:59 INFO - 'HOME': '/home/cltbld', 01:34:59 INFO - 'LANG': 'en_US.UTF-8', 01:34:59 INFO - 'LANGUAGE': 'en_US:en', 01:34:59 INFO - 'LOGNAME': 'cltbld', 01:34:59 INFO - 'MAIL': '/var/mail/cltbld', 01:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:59 INFO - 'MOZ_NO_REMOTE': '1', 01:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:59 INFO - 'NO_EM_RESTART': '1', 01:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:59 INFO - 'PWD': '/builds/slave/test', 01:34:59 INFO - 'SHELL': '/bin/bash', 01:34:59 INFO - 'SHLVL': '1', 01:34:59 INFO - 'TERM': 'linux', 01:34:59 INFO - 'TMOUT': '86400', 01:34:59 INFO - 'USER': 'cltbld', 01:34:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', 01:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:59 INFO - '_': '/tools/buildbot/bin/python'} 01:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:00 INFO - Downloading/unpacking psutil>=3.1.1 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:35:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:35:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:35:02 INFO - Installing collected packages: psutil 01:35:02 INFO - Running setup.py install for psutil 01:35:02 INFO - building 'psutil._psutil_linux' extension 01:35:02 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 01:35:02 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 01:35:02 INFO - building 'psutil._psutil_posix' extension 01:35:02 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 01:35:02 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 01:35:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:35:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:35:02 INFO - Successfully installed psutil 01:35:02 INFO - Cleaning up... 01:35:02 INFO - Return code: 0 01:35:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:02 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 0x7fe97646cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2138350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71c0>, '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 0x21c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c8550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', '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 01:35:02 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 01:35:02 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 01:35:02 INFO - Using env: {'DISPLAY': ':0', 01:35:02 INFO - 'HOME': '/home/cltbld', 01:35:02 INFO - 'LANG': 'en_US.UTF-8', 01:35:02 INFO - 'LANGUAGE': 'en_US:en', 01:35:02 INFO - 'LOGNAME': 'cltbld', 01:35:02 INFO - 'MAIL': '/var/mail/cltbld', 01:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:02 INFO - 'MOZ_NO_REMOTE': '1', 01:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:02 INFO - 'NO_EM_RESTART': '1', 01:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:02 INFO - 'PWD': '/builds/slave/test', 01:35:02 INFO - 'SHELL': '/bin/bash', 01:35:02 INFO - 'SHLVL': '1', 01:35:02 INFO - 'TERM': 'linux', 01:35:02 INFO - 'TMOUT': '86400', 01:35:02 INFO - 'USER': 'cltbld', 01:35:02 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', 01:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:02 INFO - '_': '/tools/buildbot/bin/python'} 01:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:35:02 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 01:35:02 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 01:35:02 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 01:35:02 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 01:35:02 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 01:35:02 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 01:35:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:35:05 INFO - Installing collected packages: mozsystemmonitor 01:35:05 INFO - Running setup.py install for mozsystemmonitor 01:35:05 INFO - Successfully installed mozsystemmonitor 01:35:05 INFO - Cleaning up... 01:35:05 INFO - Return code: 0 01:35:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:05 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 0x7fe97646cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2138350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71c0>, '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 0x21c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c8550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', '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 01:35:05 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 01:35:05 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 01:35:05 INFO - Using env: {'DISPLAY': ':0', 01:35:05 INFO - 'HOME': '/home/cltbld', 01:35:05 INFO - 'LANG': 'en_US.UTF-8', 01:35:05 INFO - 'LANGUAGE': 'en_US:en', 01:35:05 INFO - 'LOGNAME': 'cltbld', 01:35:05 INFO - 'MAIL': '/var/mail/cltbld', 01:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:05 INFO - 'MOZ_NO_REMOTE': '1', 01:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:05 INFO - 'NO_EM_RESTART': '1', 01:35:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:05 INFO - 'PWD': '/builds/slave/test', 01:35:05 INFO - 'SHELL': '/bin/bash', 01:35:05 INFO - 'SHLVL': '1', 01:35:05 INFO - 'TERM': 'linux', 01:35:05 INFO - 'TMOUT': '86400', 01:35:05 INFO - 'USER': 'cltbld', 01:35:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', 01:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:05 INFO - '_': '/tools/buildbot/bin/python'} 01:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:05 INFO - Downloading/unpacking jsonschema==2.5.1 01:35:05 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 01:35:05 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 01:35:05 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 01:35:05 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 01:35:05 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 01:35:05 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 01:35:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:35:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35:07 INFO - Downloading functools32-3.2.3-2.tar.gz 01:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:35:07 INFO - warning: no files found matching '*.txt' 01:35:07 INFO - no previously-included directories found matching 'build' 01:35:07 INFO - no previously-included directories found matching 'dist' 01:35:07 INFO - no previously-included directories found matching '.git*' 01:35:07 INFO - Installing collected packages: jsonschema, functools32 01:35:07 INFO - Running setup.py install for functools32 01:35:07 INFO - warning: no files found matching '*.txt' 01:35:07 INFO - no previously-included directories found matching 'build' 01:35:07 INFO - no previously-included directories found matching 'dist' 01:35:07 INFO - no previously-included directories found matching '.git*' 01:35:07 INFO - Successfully installed jsonschema functools32 01:35:07 INFO - Cleaning up... 01:35:08 INFO - Return code: 0 01:35:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:08 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 0x7fe97646cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2138350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71c0>, '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 0x21c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c8550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', '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 01:35:08 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 01:35:08 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 01:35:08 INFO - Using env: {'DISPLAY': ':0', 01:35:08 INFO - 'HOME': '/home/cltbld', 01:35:08 INFO - 'LANG': 'en_US.UTF-8', 01:35:08 INFO - 'LANGUAGE': 'en_US:en', 01:35:08 INFO - 'LOGNAME': 'cltbld', 01:35:08 INFO - 'MAIL': '/var/mail/cltbld', 01:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:08 INFO - 'MOZ_NO_REMOTE': '1', 01:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:08 INFO - 'NO_EM_RESTART': '1', 01:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:08 INFO - 'PWD': '/builds/slave/test', 01:35:08 INFO - 'SHELL': '/bin/bash', 01:35:08 INFO - 'SHLVL': '1', 01:35:08 INFO - 'TERM': 'linux', 01:35:08 INFO - 'TMOUT': '86400', 01:35:08 INFO - 'USER': 'cltbld', 01:35:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', 01:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:08 INFO - '_': '/tools/buildbot/bin/python'} 01:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:08 INFO - Downloading/unpacking blobuploader==1.2.4 01:35:08 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 01:35:08 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 01:35:08 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 01:35:08 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 01:35:08 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 01:35:08 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 01:35:10 INFO - Downloading blobuploader-1.2.4.tar.gz 01:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:35:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:35:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35:10 INFO - Downloading docopt-0.6.1.tar.gz 01:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:35:10 INFO - Installing collected packages: blobuploader, requests, docopt 01:35:10 INFO - Running setup.py install for blobuploader 01:35:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:35:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:35:10 INFO - Running setup.py install for requests 01:35:11 INFO - Running setup.py install for docopt 01:35:11 INFO - Successfully installed blobuploader requests docopt 01:35:11 INFO - Cleaning up... 01:35:11 INFO - Return code: 0 01:35:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35:11 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')]} 01:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:11 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')]} 01:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:11 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 0x7fe97646cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2138350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71c0>, '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 0x21c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c8550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', '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 01:35:11 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 01:35:11 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 01:35:11 INFO - Using env: {'DISPLAY': ':0', 01:35:11 INFO - 'HOME': '/home/cltbld', 01:35:11 INFO - 'LANG': 'en_US.UTF-8', 01:35:11 INFO - 'LANGUAGE': 'en_US:en', 01:35:11 INFO - 'LOGNAME': 'cltbld', 01:35:11 INFO - 'MAIL': '/var/mail/cltbld', 01:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:11 INFO - 'MOZ_NO_REMOTE': '1', 01:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:11 INFO - 'NO_EM_RESTART': '1', 01:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:11 INFO - 'PWD': '/builds/slave/test', 01:35:11 INFO - 'SHELL': '/bin/bash', 01:35:11 INFO - 'SHLVL': '1', 01:35:11 INFO - 'TERM': 'linux', 01:35:11 INFO - 'TMOUT': '86400', 01:35:11 INFO - 'USER': 'cltbld', 01:35:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', 01:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:11 INFO - '_': '/tools/buildbot/bin/python'} 01:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:35:11 INFO - Running setup.py (path:/tmp/pip-GgttGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:35:11 INFO - Running setup.py (path:/tmp/pip-HErxl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:35:11 INFO - Running setup.py (path:/tmp/pip-1o6vDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:35:11 INFO - Running setup.py (path:/tmp/pip-bI_bng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:35:12 INFO - Running setup.py (path:/tmp/pip-8lmOzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:35:12 INFO - Running setup.py (path:/tmp/pip-FI74WH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:35:12 INFO - Running setup.py (path:/tmp/pip-fMiCsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:35:12 INFO - Running setup.py (path:/tmp/pip-soRB0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:35:12 INFO - Running setup.py (path:/tmp/pip-YISDqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:35:12 INFO - Running setup.py (path:/tmp/pip-KtQXf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:35:12 INFO - Running setup.py (path:/tmp/pip-4F5wnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:35:12 INFO - Running setup.py (path:/tmp/pip-1DiKBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:35:12 INFO - Running setup.py (path:/tmp/pip-4aZpcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:35:12 INFO - Running setup.py (path:/tmp/pip-lmETQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:12 INFO - Running setup.py (path:/tmp/pip-oCCUyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:35:12 INFO - Running setup.py (path:/tmp/pip-vdki9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:35:12 INFO - Running setup.py (path:/tmp/pip-DmFtXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:35:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:35:12 INFO - Running setup.py install for manifestparser 01:35:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:35:13 INFO - Running setup.py install for mozcrash 01:35:13 INFO - Running setup.py install for mozdebug 01:35:13 INFO - Running setup.py install for mozdevice 01:35:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:35:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:35:13 INFO - Running setup.py install for mozfile 01:35:13 INFO - Running setup.py install for mozhttpd 01:35:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:35:13 INFO - Running setup.py install for mozinfo 01:35:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:35:13 INFO - Running setup.py install for mozInstall 01:35:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:35:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:35:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:35:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:35:13 INFO - Running setup.py install for mozleak 01:35:13 INFO - Running setup.py install for mozlog 01:35:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:35:13 INFO - Running setup.py install for moznetwork 01:35:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:35:14 INFO - Running setup.py install for mozprocess 01:35:14 INFO - Running setup.py install for mozprofile 01:35:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:35:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:35:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:35:14 INFO - Running setup.py install for mozrunner 01:35:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:35:14 INFO - Running setup.py install for mozscreenshot 01:35:14 INFO - Running setup.py install for moztest 01:35:14 INFO - Running setup.py install for mozversion 01:35:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:35:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:35:14 INFO - Cleaning up... 01:35:14 INFO - Return code: 0 01:35:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:14 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 0x7fe97646cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2138350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71c0>, '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 0x21c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c8550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', '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 01:35:14 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 01:35:14 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 01:35:14 INFO - Using env: {'DISPLAY': ':0', 01:35:14 INFO - 'HOME': '/home/cltbld', 01:35:14 INFO - 'LANG': 'en_US.UTF-8', 01:35:14 INFO - 'LANGUAGE': 'en_US:en', 01:35:14 INFO - 'LOGNAME': 'cltbld', 01:35:14 INFO - 'MAIL': '/var/mail/cltbld', 01:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:14 INFO - 'MOZ_NO_REMOTE': '1', 01:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:14 INFO - 'NO_EM_RESTART': '1', 01:35:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:14 INFO - 'PWD': '/builds/slave/test', 01:35:14 INFO - 'SHELL': '/bin/bash', 01:35:14 INFO - 'SHLVL': '1', 01:35:14 INFO - 'TERM': 'linux', 01:35:14 INFO - 'TMOUT': '86400', 01:35:14 INFO - 'USER': 'cltbld', 01:35:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', 01:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:14 INFO - '_': '/tools/buildbot/bin/python'} 01:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:35:14 INFO - Running setup.py (path:/tmp/pip-bF4LeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:35:15 INFO - Running setup.py (path:/tmp/pip-nMVvng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:35:15 INFO - Running setup.py (path:/tmp/pip-hRFm1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:35:15 INFO - Running setup.py (path:/tmp/pip-_hB5aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:35:15 INFO - Running setup.py (path:/tmp/pip-rZyla0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:35:15 INFO - Running setup.py (path:/tmp/pip-EoOBW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:35:15 INFO - Running setup.py (path:/tmp/pip-R8Nde8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:35:15 INFO - Running setup.py (path:/tmp/pip-PqP3Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:35:15 INFO - Running setup.py (path:/tmp/pip-jyR5zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:35:15 INFO - Running setup.py (path:/tmp/pip-R0d98B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:35:15 INFO - Running setup.py (path:/tmp/pip-JNd2mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:35:15 INFO - Running setup.py (path:/tmp/pip-0OeMps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:35:15 INFO - Running setup.py (path:/tmp/pip-Vq9deQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:35:15 INFO - Running setup.py (path:/tmp/pip-zNHFJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:35:15 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)) 01:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:15 INFO - Running setup.py (path:/tmp/pip-7mzlQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:16 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)) 01:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:35:16 INFO - Running setup.py (path:/tmp/pip-pMlhuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:35:16 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)) 01:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:35:16 INFO - Running setup.py (path:/tmp/pip-0Nso0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:35:16 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)) 01:35:16 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)) 01:35:16 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)) 01:35:16 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)) 01:35:16 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)) 01:35:16 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)) 01:35:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:35:16 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 01:35:16 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 01:35:16 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 01:35:16 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 01:35:16 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 01:35:16 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 01:35:18 INFO - Downloading blessings-1.6.tar.gz 01:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:35:18 INFO - Installing collected packages: blessings 01:35:18 INFO - Running setup.py install for blessings 01:35:18 INFO - Successfully installed blessings 01:35:18 INFO - Cleaning up... 01:35:18 INFO - Return code: 0 01:35:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:35:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:35:18 INFO - Reading from file tmpfile_stdout 01:35:18 INFO - Current package versions: 01:35:18 INFO - argparse == 1.2.1 01:35:18 INFO - blessings == 1.6 01:35:18 INFO - blobuploader == 1.2.4 01:35:18 INFO - docopt == 0.6.1 01:35:18 INFO - functools32 == 3.2.3-2 01:35:18 INFO - jsonschema == 2.5.1 01:35:18 INFO - manifestparser == 1.1 01:35:18 INFO - mozInstall == 1.12 01:35:18 INFO - mozcrash == 0.17 01:35:18 INFO - mozdebug == 0.1 01:35:18 INFO - mozdevice == 0.48 01:35:18 INFO - mozfile == 1.2 01:35:18 INFO - mozhttpd == 0.7 01:35:18 INFO - mozinfo == 0.9 01:35:18 INFO - mozleak == 0.1 01:35:18 INFO - mozlog == 3.2 01:35:18 INFO - moznetwork == 0.27 01:35:18 INFO - mozprocess == 0.22 01:35:18 INFO - mozprofile == 0.28 01:35:18 INFO - mozrunner == 6.11 01:35:18 INFO - mozscreenshot == 0.1 01:35:18 INFO - mozsystemmonitor == 0.3 01:35:18 INFO - moztest == 0.7 01:35:18 INFO - mozversion == 1.4 01:35:18 INFO - psutil == 3.1.1 01:35:18 INFO - requests == 1.2.3 01:35:18 INFO - wsgiref == 0.1.2 01:35:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35: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')]} 01:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35: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')]} 01:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:18 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 0x7fe97646cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2138350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71c0>, '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 0x21c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c8550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', '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 01:35:18 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 01:35:18 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 01:35:18 INFO - Using env: {'DISPLAY': ':0', 01:35:18 INFO - 'HOME': '/home/cltbld', 01:35:18 INFO - 'LANG': 'en_US.UTF-8', 01:35:18 INFO - 'LANGUAGE': 'en_US:en', 01:35:18 INFO - 'LOGNAME': 'cltbld', 01:35:18 INFO - 'MAIL': '/var/mail/cltbld', 01:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:18 INFO - 'MOZ_NO_REMOTE': '1', 01:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:18 INFO - 'NO_EM_RESTART': '1', 01:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:18 INFO - 'PWD': '/builds/slave/test', 01:35:18 INFO - 'SHELL': '/bin/bash', 01:35:18 INFO - 'SHLVL': '1', 01:35:18 INFO - 'TERM': 'linux', 01:35:18 INFO - 'TMOUT': '86400', 01:35:18 INFO - 'USER': 'cltbld', 01:35:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', 01:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:18 INFO - '_': '/tools/buildbot/bin/python'} 01:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:18 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)) 01:35:18 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)) 01:35:18 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)) 01:35:18 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)) 01:35:18 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)) 01:35:18 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)) 01:35:18 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)) 01:35:18 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)) 01:35:18 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)) 01:35:18 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)) 01:35:18 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)) 01:35:18 INFO - Cleaning up... 01:35:18 INFO - Return code: 0 01:35:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:35: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')]} 01:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35: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')]} 01:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:18 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 0x7fe97646cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2138350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71c0>, '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 0x21c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c8550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', '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 01:35:18 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 01:35:18 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 01:35:18 INFO - Using env: {'DISPLAY': ':0', 01:35:18 INFO - 'HOME': '/home/cltbld', 01:35:18 INFO - 'LANG': 'en_US.UTF-8', 01:35:18 INFO - 'LANGUAGE': 'en_US:en', 01:35:18 INFO - 'LOGNAME': 'cltbld', 01:35:18 INFO - 'MAIL': '/var/mail/cltbld', 01:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:18 INFO - 'MOZ_NO_REMOTE': '1', 01:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:18 INFO - 'NO_EM_RESTART': '1', 01:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:18 INFO - 'PWD': '/builds/slave/test', 01:35:18 INFO - 'SHELL': '/bin/bash', 01:35:18 INFO - 'SHLVL': '1', 01:35:18 INFO - 'TERM': 'linux', 01:35:18 INFO - 'TMOUT': '86400', 01:35:18 INFO - 'USER': 'cltbld', 01:35:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', 01:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:18 INFO - '_': '/tools/buildbot/bin/python'} 01:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:35:18 INFO - Cleaning up... 01:35:18 INFO - Return code: 0 01:35:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:35: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')]} 01:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35: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')]} 01:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:18 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 0x7fe97646cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2138350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c71c0>, '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 0x21c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c8550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', '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 01:35:18 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 01:35:18 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 01:35:18 INFO - Using env: {'DISPLAY': ':0', 01:35:18 INFO - 'HOME': '/home/cltbld', 01:35:18 INFO - 'LANG': 'en_US.UTF-8', 01:35:18 INFO - 'LANGUAGE': 'en_US:en', 01:35:18 INFO - 'LOGNAME': 'cltbld', 01:35:18 INFO - 'MAIL': '/var/mail/cltbld', 01:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:18 INFO - 'MOZ_NO_REMOTE': '1', 01:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:18 INFO - 'NO_EM_RESTART': '1', 01:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:18 INFO - 'PWD': '/builds/slave/test', 01:35:18 INFO - 'SHELL': '/bin/bash', 01:35:18 INFO - 'SHLVL': '1', 01:35:18 INFO - 'TERM': 'linux', 01:35:18 INFO - 'TMOUT': '86400', 01:35:18 INFO - 'USER': 'cltbld', 01:35:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', 01:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:18 INFO - '_': '/tools/buildbot/bin/python'} 01:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:19 INFO - Downloading/unpacking flake8 01:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:35:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:35:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 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 01:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:35:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:35:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:35:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:35:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:35:21 INFO - no previously-included directories found matching 'docs/_build' 01:35:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:35:21 INFO - Running setup.py install for pep8 01:35:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:35:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:35:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:35:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:35:21 INFO - no previously-included directories found matching 'docs/_build' 01:35:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:35:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:35:21 INFO - Cleaning up... 01:35:22 INFO - Return code: 0 01:35:22 INFO - Running post-action listener: _resource_record_post_action 01:35:22 INFO - Running post-action listener: _start_resource_monitoring 01:35:22 INFO - Starting resource monitoring. 01:35:22 INFO - ##### 01:35:22 INFO - ##### Finished create-virtualenv step (success) 01:35:22 INFO - ##### 01:35:22 INFO - ##### 01:35:22 INFO - ##### Running install step. 01:35:22 INFO - ##### 01:35:22 INFO - Running pre-action listener: _resource_record_pre_action 01:35:22 INFO - Running main action method: install 01:35:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:35:22 INFO - Reading from file tmpfile_stdout 01:35:22 INFO - Detecting whether we're running mozinstall >=1.0... 01:35:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:35:22 INFO - Reading from file tmpfile_stdout 01:35:22 INFO - Output received: 01:35:22 INFO - Usage: mozinstall [options] installer 01:35:22 INFO - Options: 01:35:22 INFO - -h, --help show this help message and exit 01:35:22 INFO - -d DEST, --destination=DEST 01:35:22 INFO - Directory to install application into. [default: 01:35:22 INFO - "/builds/slave/test"] 01:35:22 INFO - --app=APP Application being installed. [default: firefox] 01:35:22 INFO - mkdir: /builds/slave/test/build/application 01:35:22 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'] 01:35:22 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 01:35:38 INFO - Reading from file tmpfile_stdout 01:35:38 INFO - Output received: 01:35:38 INFO - /builds/slave/test/build/application/firefox/firefox 01:35:38 INFO - Running post-action listener: _resource_record_post_action 01:35:38 INFO - ##### 01:35:38 INFO - ##### Finished install step (success) 01:35:38 INFO - ##### 01:35:38 INFO - ##### 01:35:38 INFO - ##### Running run-tests step. 01:35:38 INFO - ##### 01:35:38 INFO - Running pre-action listener: _resource_record_pre_action 01:35:38 INFO - Running main action method: run_tests 01:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:35:38 INFO - Python 2.7.3 01:35:38 INFO - Return code: 0 01:35:38 INFO - grabbing minidump binary from tooltool 01:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:35:38 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 0x21c71c0>, '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 0x21c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c8550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:35:38 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 01:35:38 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 01:35:38 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 01:35:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:35:38 INFO - Return code: 0 01:35:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:35:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:35:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:35:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:35:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:35:39 INFO - Return code: 0 01:35:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 01:35:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 01:35:39 INFO - Using env: {'DISPLAY': ':0', 01:35:39 INFO - 'HOME': '/home/cltbld', 01:35:39 INFO - 'LANG': 'en_US.UTF-8', 01:35:39 INFO - 'LANGUAGE': 'en_US:en', 01:35:39 INFO - 'LOGNAME': 'cltbld', 01:35:39 INFO - 'MAIL': '/var/mail/cltbld', 01:35:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:35:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:39 INFO - 'MOZ_NO_REMOTE': '1', 01:35:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:39 INFO - 'NO_EM_RESTART': '1', 01:35:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:39 INFO - 'PWD': '/builds/slave/test', 01:35:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:35:39 INFO - 'SHELL': '/bin/bash', 01:35:39 INFO - 'SHLVL': '1', 01:35:39 INFO - 'TERM': 'linux', 01:35:39 INFO - 'TMOUT': '86400', 01:35:39 INFO - 'USER': 'cltbld', 01:35:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169', 01:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:39 INFO - '_': '/tools/buildbot/bin/python'} 01:35:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 01:35:39 INFO - mozversion application_buildid: 20160610005628 01:35:39 INFO - mozversion application_changeset: 6e0788aa97c74aa11b75654bfc82d4ecb34f502a 01:35:39 INFO - mozversion application_display_name: Nightly 01:35:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:35:39 INFO - mozversion application_name: Firefox 01:35:39 INFO - mozversion application_remotingname: firefox 01:35:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:35:39 INFO - mozversion application_vendor: Mozilla 01:35:39 INFO - mozversion application_version: 50.0a1 01:35:39 INFO - mozversion platform_buildid: 20160610005628 01:35:39 INFO - mozversion platform_changeset: 6e0788aa97c74aa11b75654bfc82d4ecb34f502a 01:35:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:35:39 INFO - mozversion platform_version: 50.0a1 01:35:39 INFO - using testdate: 1465547739 01:35:39 INFO - actual date: 1465547739 01:35:39 INFO - starting webserver on 'localhost:42405' 01:35:39 INFO - SUITE-START | Running 2 tests 01:35:39 INFO - TEST-START | dromaeo_css 01:35:39 INFO - operating with platform_type : linux_ 01:35:39 INFO - Initialising browser for dromaeo_css test... 01:35:39 INFO - TEST-INFO | started process 30172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7M6rrS/profile http://localhost:42405/getInfo.html) 01:35:44 INFO - PROCESS | 30172 | __metrics Screen width/height:1600/1200 01:35:44 INFO - PROCESS | 30172 | colorDepth:24 01:35:44 INFO - PROCESS | 30172 | Browser inner width/height: 1024/697 01:35:44 INFO - PROCESS | 30172 | __metrics 01:35:45 ERROR - PROCESS | 30172 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 01:35:46 INFO - TEST-INFO | 30172: exit 0 01:35:46 INFO - Browser initialized. 01:35:46 INFO - Running cycle 1/1 for dromaeo_css test... 01:35:46 INFO - TEST-INFO | started process 30293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7M6rrS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:35:58 INFO - PROCESS | 30293 | RSS: Main: 184885248 01:35:58 INFO - PROCESS | 30293 | 01:36:47 INFO - PROCESS | 30293 | 1465547807979 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] 01:38:59 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:42405/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42405/tests/dromaeo/cssquery-ext.html) 01:39:00 INFO - PROCESS | 30293 | RSS: Main: 187781120 01:39:00 INFO - PROCESS | 30293 | 01:42:02 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:42405/tests/dromaeo/cssquery-ext.html (next: http://localhost:42405/tests/dromaeo/cssquery-jquery.html) 01:42:03 INFO - PROCESS | 30293 | RSS: Main: 187310080 01:42:03 INFO - PROCESS | 30293 | 01:45:05 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:42405/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42405/tests/dromaeo/cssquery-mootools.html) 01:45:06 INFO - PROCESS | 30293 | RSS: Main: 188628992 01:45:06 INFO - PROCESS | 30293 | 01:48:07 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:42405/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42405/tests/dromaeo/cssquery-prototype.html) 01:48:08 INFO - PROCESS | 30293 | RSS: Main: 185552896 01:48:08 INFO - PROCESS | 30293 | 01:51:11 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:42405/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42405/tests/dromaeo/cssquery-yui.html) 01:51:11 INFO - PROCESS | 30293 | RSS: Main: 188276736 01:51:11 INFO - PROCESS | 30293 | 01:54:14 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:42405/tests/dromaeo/cssquery-yui.html (next: http://localhost:42405/tests/dromaeo/cssquery-dojo.html) 01:54:14 INFO - PROCESS | 30293 | RSS: Main: 188878848 01:54:14 INFO - PROCESS | 30293 | 01:54:14 INFO - PROCESS | 30293 | __start_tp_report 01:54:14 INFO - PROCESS | 30293 | _x_x_mozilla_page_load 01:54:14 INFO - PROCESS | 30293 | _x_x_mozilla_page_load_details 01:54:14 INFO - PROCESS | 30293 | |i|pagename|runs| 01:54:14 INFO - PROCESS | 30293 | |0;dojo.html;2604.1536500637294;2665.3869609989715;2676.3041609181605;2682;2692.0577797770784;4799.904001919959;4804.687695299807;4863.221884498481;4865.732384718839;4868.51314868513;4646.024334889668;4844.854654360366;4896.2410826321975;4941.2094064949615;4941.60467162627;4405.317175837742;4429.77851107445;4520.457545094577;4554.225781617117;4568.063546972862;4235.131797981407;4554.066416384633;4558.293464513005;4641.791119399618;4656;4342.565743425664;4403.977980110111;4415.227335216357;4452.309891966718;4545.000099978016;4445.911081778347;4468.084042771224;4505.3917721107555;4560.840370587013;4561.156186105581;4510.684252102355;4527.660425468071;4535.886602834922;4542.364069030338;4564.726116433025;4798.5441383068555;4888.046830867982;4904.239842824368;4915.5084491550915;4919.680220785674;5226;5245.685258884441;5249.291345668324;5256.395514515842;5282.286891269668;5035.118854200537;5220.269162317279;5299.152135658314;5300.522952934216;5307.124324486455;4886.902261954777;4909.926351104737;4933.753312334369;4935.555799978019;4990.600751939836;5401.837944861661;5413.296271484682;5421.484958928895;5429.647072940246;5468.179773033997;4900.387451568554;5077.466865979093;5104;5179.61152913533;5185.2999845021195;5007.349044624249;5242.842714718565;5261.368635763656;5275;5323.680579165262;5163.14808056674;5213.061648903234;5215.530602245816;5226.294450249167;5227.555657769132;4889.633277504201;5152.381714194245;5195.246689230116;5198.168293073166;5201.245819356172;4441;4461.732296062247;4466.531014243523;4504.301833215857;4504.504504504502;3876.554196267465;3884.7474914131058;3889.8249578769023;3900.0444891001885;3936.566977632458;4314.288142456459;4446.288593824973;4481.887952801206;4508;4571.131485017836;5191.9480805192225;5239.345081864767;5243.292155559027;5243.68537887728;5288.65623734456;4488.375912681225;4500.144972455223;4502.4371953505815;4535.659825513099;4547.3406356078185;4545.772711364419;4657.347971284023;4675.18184317743;4679.859604211879;4708.317293992421;4855.635827312965;4870.464248932685;4904.705717656952;4916.287138364917;4957.727324997016;5262.079136151235;5276.472352764693;5276.894462110659;5281.128613778684;5283.286756287852;4748.145333839942;4834.6374021947795;4857.1742803724155;4870.196417591058;4900.411950565955;5071.594272458121;5112.872178195426;5118.027574760784;5127.102757017582;5173.508516690908;5011.298418221379;5188.870278243074;5191.065608190562;5191.558717509054;5204.479552044765;4851.708897466164;4957.157283261926;4991.800327986985;5008.84973450797;5024.07054694868;5048.3941926969;5100.719460429712;5101.540861322499;5117.257997590403;5124.180131178993;4972.801087956441;5028.723420211923;5036.345275114211;5041.546260836396;5087.949120508748;4919.926201107058;5065.088284108896;5105.872353191051;5122.948770512247;5124.5131712487255;4979.502049794992;5012.949870501248;5014.674046186986;5022.196448568212;5050.393952725696 01:54:14 INFO - PROCESS | 30293 | |1;ext.html;549.1049589169655;570.6433479075578;571.1489880078678;578.6961845031358;586.5600799400448;37477.437838432445;38263.808680956594;38296.61703382965;38383.42424863629;38514.422283665765;38591.614083859226;38606.22787544248;39023.60976390235;39093.41359879604;39277;7481.7007319707145;7612.771616851475;7616.276453736914;7617.619119044026;7658.2724641159;7616.885746713804;7714.228577142297;7742.419318551103;7766.37868970481;7778.766637000899;7785.3771698264;7823.882641760378;7824;7830.256125668053;7832.060152781674;7682.846343073164;7698.769036928901;7718.189590093071;7731.806704832368;7786.883196752054;7609.391248700091;7700.422468314843;7710.653020614086;7734.071911370615;7747.147813740484;37034.44448333277;37136.25727485462;37313.25373492542;37322.44016339757;37723.811380943196;2953.4831404504125;3012.2469382654335;3042.7717921156;3110.144710204689;3193.1538142392283;29104.854475727698;29820.70179298201;30141.69858301411;30187.547186792217;30763.077107686804;3441.913952151191;3444.793312401264;3475.8088305143206;3509.6314886937016;3581.2658405026905;244834;245511;247545.9999999982;247848;248125;31790.841045794623;49391.50608493941;49476.752616236685;49859;50101.24848127281;32311.51532727011;33314.3337133256;33635.495467568006;33782.83108584442;34022.48966265508;12894.484220631257;13086.934565327112;13112.885404740513;13126.081174317897;13228.074034817662;10419.895801042045;10553.155747540179;10591.417472039111;10593.311434756715;10618.840717389245;7758.728444504415;7832.960835195901;7856.410769192219;7962.442629016029;7966.522008679498;3105.503119500914;3108.114187456564;3123.453395655751;3155.8422078896424;3211.6627754085953;889.58634235081;899.3120262998812;944.9716508504756;955.3694561589317;992.2211064314479;27787.72212277892;28880.27799304992;28928.276793080342;29481.705182947895;29530.704692953226;943.6649989253854;959.510649568725;990.757264470195;996.5913975270105;1076.1713480619878;14388.424463021362;14639.853601463848;14744.926275368554;14823.925880370529;14914.552563423114;385286;387353;388613;389829;390408;48411.75794121007;49415.50584494109;49429.50570494321;49527;49655.50344496581;1199.220506670671;1211.5173070377389;1220.2983284611207;1223.3516236394726;1235.3329202230875;25746.742532574433;26906.327341815828;27433.725662743116;27626.861865690542;27747.722522775322;41509.58490415178;42732.35901461543;42777.78611106925;42820.571794281655;42969;276721;280351;327088;327729;329193;25225.990960362113;25265.621015684414;25548;25605.487890242464;25679.10123145681;41441.79279103585;41882.790586046875;42177;42982.140357193304;43366.34950475682;36278;36705.44941825821;36751.89744307568;36966.630333697394;37444;34813;34883.12792180216;34985;35317.646823532465;35643.82178089093;35034.64965350314;35722.46416303705;35827.641723582434;36002.09994750152;36129.27741445209;31293.687063129077;32208.677913220567;32373.217866727933;32855.83572082124;33018.834905825315;25184.748152518972;25198.24405267845;25326.74673253244;25461.236162915142;25572.488550229264 01:54:14 INFO - PROCESS | 30293 | |2;jquery.html;341.60203363082013;346.11394829237156;351.89619062376613;364.40238009664137;365.26763838503797;15719.921400392996;16159.192040397977;17176.570585735364;17257.223424945878;17264.395746148886;16355.427560035401;16592.17039148041;17016.574585635335;17102.059386733723;17179;4440.644748420134;4758.191107511731;4763.14263432582;4781.139394908915;4791.401074865642;4718.834840780573;4727.007328461027;4729.2433210686295;4758.428988521382;4775.044991001796;4723.6929599575915;5037.29477873098;5101.54086132248;5141.691498510101;5156.896862062757;5070.2394640803805;5092.821751238707;5107.591392688594;5122.974385128051;5125.3080834087295;4424.601785839258;4615.284630882219;4620.953790462086;4644.9535504644855;4672.462666793328;11649.70875728105;11707.12196585251;11878.643640690792;11888.524459021628;11891.762164756656;1878.4646375782836;1890.3005887821594;1901.2014953719472;1945.863789534733;1960.7843137255034;9011.098890111001;9055.139761722627;9066.95466522663;9332.113449222314;9463.38487998278;1554.8028018425748;1736.2100244388898;1741.8693597980202;1794.6500432415685;1804.3684710351404;43951.560484395064;59500.70249648724;60180.39819601835;68867;72133.27866721318;9838.409695418297;9910.851337229948;9917.801643967081;9920.652777152909;10140.847887281696;13717.628237176203;13805.654858628615;13808.930955345159;13826.30868456573;13856.099353541988;7225.783226503213;7295.161056478573;7335.963320183471;7457.32884040439;7498.887516687254;6917.584944903322;6948.583085014915;6994;7121;7203.495755297184;4228.492580890313;4253.893652658709;4263.957360426418;4323.351497275371;4329.675274354436;1800.2798880447663;1803.422904670493;1810.5383127302716;1839.3838064248628;1874.6157037807218;830.7964548685611;860.1054902901038;881.3345923827469;901.5221932375852;971.771633666102;16575.171241437878;16699.248533816008;17466.405012601314;17502;17530.737038944426;878.8242351529719;912.4525284829182;916.2578311567652;945.3996712087736;946.2099147212155;9558.518429643416;9583.568739406743;9710.75723106914;9855.11303982645;9877.209823214125;391346;395846;396185;397216;397763;63508;71836.64081679558;73542;74725;75098;901.8106197698426;901.8421776189141;927.1655510041018;929.3680297397699;948.393028461785;15814.209289535707;15903.920480397986;15914.7612785806;15932.123733194321;16157.838421616103;27216.72783272142;32944.505832412055;34616.65383346134;34692.653073468944;34820.30359392849;45341;46735.29897051479;51012.48987510077;52931.17926980452;53030;7159.785206443815;7907.881381779162;7959.602019899097;8007.719729809429;8075.475094118863;8453.323734101134;11693.415329233334;12195.390230488618;12211.206271592318;12400.441980110736;10035.849462257926;10044.447555384524;10057.19542436618;10254.897451025394;10294;10149.64476243328;10213.489325533545;10245.180385568987;10270.33242839213;10554.577816887238;10411.271211015157;10445.164386849186;10690.73273168177;10720.142388608736;10845.457727113771;7915.643796029308;7933.246341597539;7962.402819788655;7983.1617680142745;8030.196980302157;9503.287253456157;9808.950955245178;9919;10652.62715804943;10654.094401975919 01:54:14 INFO - PROCESS | 30293 | |3;mootools.html;1353.5262658069678;1399.5521433141396;1450.9347079381428;1663.3845477173447;1673.3306677329074;6392.137061496696;7341.926580734191;7419;7926.603669816508;7946.64240109195;7531.397488200944;7762.767116986485;7813.413993950462;7833.177516360772;7845.882311765328;2154.493693981913;2176.934691959236;2178.455386153462;2185.0495034659893;2188.1903695632636;2173.630482817917;2183.279517759144;2189.2665956904457;2189.879556624385;2194.7037149984785;2179.204590324528;2180.2587120379067;2184.213683074092;2186.311311936735;2202.768709285526;2068.389825001628;2075.916963321465;2082.83337333013;2085.9061342239634;2089.9477513062143;2126.25581046634;2149.12960251097;2157.924472643466;2158.0504577985635;2159.1255541505557;7811.4922530035365;7853.136155022943;7892.960535197287;7901.8814717778705;7915.089764677078;4434.2905135178535;4455.732656040648;4511.526289739563;4512.684112112153;4638.652101092432;2679;2740.6848212455625;2791.1766029021487;2810.5222112240967;2816.6338376010985;867.7396780965685;880.7533890510667;889.6263569300844;939.0890835889177;939.3565407695681;10466;10468.68593942183;10504.2647014709;10514.421706806123;10515.474226288656;4090.570490098556;4127;4196.160767846443;4210.115875666083;4210.431591735138;8839.60221790021;8887.289016878634;8901;8960.641574337084;8992.640294388151;4616.676832621752;4619.122366750306;4673.649476289292;4711.081339138904;4722.5513576210205;3506.368853606324;4015.9598404015587;4121.793910304533;4289.935650965238;4328;3444.362792883325;3483.216276337854;3603.0632035670915;3613.457981302826;3621.293847699726;1178.4814681540095;1182.798924182891;1192.8866757658009;1197.9221350612183;1205.3491114798087;654.7282877605741;787.6258777080841;793.3732351442411;820.0774129104757;830.3357314148657;4889.731064791471;4956.975215123974;4976.328195693535;5022.146235140035;5026.798928042837;409.2326887086712;414.5419311660632;423.47970784881807;424.1453471255423;855.8074433252468;3349.4975753636663;3459.290845376692;3488;3491.284286721216;3523.6300188480354;8838.955805220932;9073.45559266446;9107.861517310335;9121.863172052424;9157.542122893961;8924.643014279356;8950.462972221687;8981.101889810967;9042.819143617091;9047.276217902552;6754.763583274562;7100.254473280334;7110.680019399139;7135.571865688075;7314.853702926018;5246.895062098813;5255.605829562722;5319.920201197063;5358.678479291255;5437.864053398696;8682.479051256945;8795.780105497413;8858;8883.333749968908;8911.331650126396;8252.958735206286;8543.444676096035;8635.050144484227;8814.691485797966;8969.7757556059;5618.185363122406;6218.844528886633;6253.6560489173535;6425.839354016187;6490.026496025634;7167.749128780676;7184.46116541251;7225.313595208447;7240.601766902871;7255.419566434778;6489.772857949949;6652.600843949379;6726.697298621476;6739.865202696017;6754.324567543206;6663.966680166568;6694.765683201064;6718.294579069127;6750.729970801113;6789.015592739124;6027.879442411215;6031.849203769941;6051.546134039877;6077.149199112217;6092.573519853568;4003.259397011562;4147.502299724052;4184.539700632989;4231.11146659205;4281.700280980302;4131.380292956081;4156.397322388298;4167.437395951629;4262.744235345889;4310.978445107754 01:54:14 INFO - PROCESS | 30293 | |4;prototype.html;287.64906813687304;295.9792814502985;297.9433907557564;303.6720342030607;305.13189974522504;5137.332146820912;5147.536721695046;5148.172398798429;5152.613553983452;5172.198309262061;5033.949660503394;5043.293938848564;5065.645404821664;5076.6700164489375;5115.974420127904;3654.561452625682;3810.1998580298173;3908.1206728486004;3909.7849618270984;3917.2557214129365;3924.7645141291473;3964.464797252377;3987.700922430815;4000.6997725739106;4007.899802504946;3940.581390699346;3985.083430810915;3992.1816027714394;3997.5402828674637;4001.1797581495725;3837.4052021936645;3961.900952476211;3991.1419044905197;4000.5599384067873;4003.719739618228;3481.669241422061;3489.7906125632544;3496.915956053606;3497.6852083312624;3501.6148223695373;4941.48114447985;4980.9252861207115;4997.850494386312;5018.2974383586325;5028.874278143039;4368.907773056736;4489.595936365743;4493.595576398107;4501.3022981437925;4520.909581808345;5296.285001524783;5309.256704061435;5336.38631557372;5377.489138531833;5381.300430943991;3790.924181516382;3795.1840354323676;3801.7148713846295;3810.3522401191863;3820.083180036799;5423.776251736808;5570.972145139289;5597.132444471114;5607.2897766181295;5610.803621873256;3793.943090853639;3811.9809400952818;3815.236952609489;3824.980875095662;3834.5206849143856;3860.9961410033593;3863.9034024149623;3894.2406230784727;3895.14306852492;3901.7073719471155;4432.069265454226;4483.30508771141;4485.394471746273;4488.1248156609145;4500.392447019676;5183.3261675981885;5212.947870521322;5297;5302.3637163540625;5317.574594032468;1350.5818890165287;1353.6006877970826;1364.6042647632273;1372.540199033315;1373.7458570164551;832.3008672714949;833.4665813879122;860.4622111180512;870.5081628879663;870.9433886797337;4519.276915693539;4651.930221046687;4661.673682842168;4686.461056978491;4695.976520117378;5509.5041446270025;5521.420250873681;5527.55779537636;5529.474699903502;5543.417941116125;4450.777461126931;4633.4903160652975;4664.183767840682;4676.462206846256;4683.320918466871;2947.955780663292;2967.7774166937565;2980.538016607386;2987.6564195117403;2996.715312045352;5173.741312934413;5203.791848326025;5209.661372010883;5218.634695571273;5239.685618862881;5391.81128660495;5571.609987300931;5603.814512340109;5623.634463759842;5628.662280263197;5088.643794934319;5115.283860259567;5134.948650513522;5150.974245128826;5178.275041494269;5486.451354864482;5518.144687573433;5530.585206109477;5561.165825126263;5571.526420254162;5135.38375394955;5423.159410291411;5459.890802184013;5494.642848214853;5509.834704958857;5222.529972302359;5259.921101183409;5278;5290.497402746733;5301.867453313544;3818.1790914953417;3832.2143960487474;3832.693384529175;3848.7690738555775;3849.3263678856647;5356.437574054668;5470.671759694431;5505.944940550543;5509.41057702879;5536.667799932017;5323.680579165262;5330.333708286465;5344.679319240858;5375.973120134374;5377.327834020747;5145.305383773292;5342.1452567589;5378.892422151614;5397.1919406999095;5420.7289635518855;5234.607404444606;5287.814926477555;5288.524032837063;5309.601779866448;5319.973400132974;5189.92215116766;5252.763625636932;5407.296701539002;5429.6199266051;5459.3894801034585;5307.41618421981;5316.3354580677415;5327.760250788646;5329.09405401075;5335.493128152819 01:54:14 INFO - PROCESS | 30293 | |5;yui.html;521.0880958322934;538.7144813248974;545.6551340284057;572.084664536741;579.8666306749445;11133.1093512519;11786.528538858436;11866.7626647467;11879.999999999989;11897.107716921233;11896;14027.859721402783;14755.77866332006;14781.92609036956;14784.704305913876;616.4729156571134;774.4617490843851;783.2363445640511;783.2832957843566;784.8037990502374;751.2862780358654;775.7633921653921;777.4752042371405;778.3811869563682;780.7657702689199;820.4257020085934;821.3183058061794;821.6836517940606;822.5969275055239;825.9380546459009;803.7227156630953;813.8413009463158;813.8738495533142;814.2590242879011;818.8157664525464;593.1162567773986;593.9613925094854;596.2368168744015;597.208698474523;597.3548567547039;11821.822672659917;11839.704007399798;11853.644390668294;11871.703207419798;11911.463984120735;11446.484908179153;12174;12648.68378290541;12887.548935787203;12939.218068115306;9731;9813.803723925554;10034.498275086216;10144.391336519833;10150.187984961185;3189.202699325169;3281.7210537104374;3338.61605915318;3340.064781861083;3350.3466823969334;49847;51786.96426071457;51962;56317.155242671804;56817.147742783476;8970.461772293684;9104.908950910538;9274.44353338802;9275.489848058287;9390.62437502506;17298.394556190473;18426.170822313026;18490.63018739618;18542.721859172125;18570.721439178422;6689.732410703615;6780.423663988616;6808.93191068083;6908.792736217922;7093;3435.3129374125274;3467.6358982306497;3498.8775392861126;3498.9825050874583;3534.593521744981;2718.6465759451144;2804.7615952643846;2812.9015484458355;2817.661880574344;2820.4923113839295;469.3438117068002;472.433080303637;473.3349643750536;489.99550920612603;494.07114624506414;419.5238404411015;532.5267750892457;533.823838133415;551.1209620655048;557.946995035471;6750.696218670171;6873.4157596603845;6906.689198986058;7024.5434046786795;7044.241454371913;416.3338658147001;461.2300125430884;463.09696092619527;467.22440748357565;471.4931448692669;3202;3241.7730758846656;3242.2866969266724;3269.1336795749144;3328.1014126185796;85361;88234;89243.55378223068;90907.54546227226;94237.5288123555;79995.60002200068;80163.59918200372;80695.59652201702;81244;82036;71455.28544714487;71698;72263.27736722566;72332;73379;6331.2085989251345;6368.140301059298;6377.840553986188;6399.520035997226;6541.411272985454;41657;42658.14683706371;43788;44211.55788442203;44981.1003779916;58788;62488;62547.374526254156;62615.6869215651;62965;8953.731388058368;9059.547022648972;9079.137481939206;9182.449053056838;9224.077592240723;9622.470764107762;9669.081437263449;9682.612695492384;10058.29591928558;10297;8442.620082096444;8452.32381409498;8468;8563.785905352415;8658.39391242607;8610.569471526524;8860.42407243553;8888.822223555622;8979.775505612151;9012.63949442015;8164.346852251924;8353.791155221168;8404.243618074403;8479.533625650649;8654.82690346177;7662.310392064741;7686.769396918102;7709;7725.961370193338;7784.805379865548;7602;7630.313271805564;7687.654055567625;7719;7792.88310675329 01:54:14 INFO - PROCESS | 30293 | __end_tp_report 01:54:14 INFO - PROCESS | 30293 | __start_cc_report 01:54:14 INFO - PROCESS | 30293 | _x_x_mozilla_cycle_collect,394 01:54:14 INFO - PROCESS | 30293 | __end_cc_report 01:54:14 INFO - PROCESS | 30293 | __startTimestamp1465548854539__endTimestamp 01:54:14 INFO - PROCESS | 30293 | 01:54:14 INFO - PROCESS | 30293 | ------- Summary: start ------- 01:54:14 INFO - PROCESS | 30293 | Number of tests: 6 01:54:14 INFO - PROCESS | 30293 | 01:54:14 INFO - PROCESS | 30293 | [#0] dojo.html Cycles:165 Average:4817.01 Median:4919.93 stddev:511.60 (10.4%) stddev-sans-first:482.82 01:54:14 INFO - PROCESS | 30293 | Values: 2604.2 2665.4 2676.3 2682.0 2692.1 4799.9 4804.7 4863.2 4865.7 4868.5 4646.0 4844.9 4896.2 4941.2 4941.6 4405.3 4429.8 4520.5 4554.2 4568.1 4235.1 4554.1 4558.3 4641.8 4656.0 4342.6 4404.0 4415.2 4452.3 4545.0 4445.9 4468.1 4505.4 4560.8 4561.2 4510.7 4527.7 4535.9 4542.4 4564.7 4798.5 4888.0 4904.2 4915.5 4919.7 5226.0 5245.7 5249.3 5256.4 5282.3 5035.1 5220.3 5299.2 5300.5 5307.1 4886.9 4909.9 4933.8 4935.6 4990.6 5401.8 5413.3 5421.5 5429.6 5468.2 4900.4 5077.5 5104.0 5179.6 5185.3 5007.3 5242.8 5261.4 5275.0 5323.7 5163.1 5213.1 5215.5 5226.3 5227.6 4889.6 5152.4 5195.2 5198.2 5201.2 4441.0 4461.7 4466.5 4504.3 4504.5 3876.6 3884.7 3889.8 3900.0 3936.6 4314.3 4446.3 4481.9 4508.0 4571.1 5191.9 5239.3 5243.3 5243.7 5288.7 4488.4 4500.1 4502.4 4535.7 4547.3 4545.8 4657.3 4675.2 4679.9 4708.3 4855.6 4870.5 4904.7 4916.3 4957.7 5262.1 5276.5 5276.9 5281.1 5283.3 4748.1 4834.6 4857.2 4870.2 4900.4 5071.6 5112.9 5118.0 5127.1 5173.5 5011.3 5188.9 5191.1 5191.6 5204.5 4851.7 4957.2 4991.8 5008.8 5024.1 5048.4 5100.7 5101.5 5117.3 5124.2 4972.8 5028.7 5036.3 5041.5 5087.9 4919.9 5065.1 5105.9 5122.9 5124.5 4979.5 5012.9 5014.7 5022.2 5050.4 01:54:14 INFO - PROCESS | 30293 | 01:54:14 INFO - PROCESS | 30293 | [#1] ext.html Cycles:180 Average:45737.15 Median:36065.69 stddev:84434.53 (234.1%) stddev-sans-first:84603.23 01:54:14 INFO - PROCESS | 30293 | Values: 549.1 570.6 571.1 578.7 586.6 37477.4 38263.8 38296.6 38383.4 38514.4 38591.6 38606.2 39023.6 39093.4 39277.0 7481.7 7612.8 7616.3 7617.6 7658.3 7616.9 7714.2 7742.4 7766.4 7778.8 7785.4 7823.9 7824.0 7830.3 7832.1 7682.8 7698.8 7718.2 7731.8 7786.9 7609.4 7700.4 7710.7 7734.1 7747.1 37034.4 37136.3 37313.3 37322.4 37723.8 2953.5 3012.2 3042.8 3110.1 3193.2 29104.9 29820.7 30141.7 30187.5 30763.1 3441.9 3444.8 3475.8 3509.6 3581.3 244834.0 245511.0 247546.0 247848.0 248125.0 31790.8 49391.5 49476.8 49859.0 50101.2 32311.5 33314.3 33635.5 33782.8 34022.5 12894.5 13086.9 13112.9 13126.1 13228.1 10419.9 10553.2 10591.4 10593.3 10618.8 7758.7 7833.0 7856.4 7962.4 7966.5 3105.5 3108.1 3123.5 3155.8 3211.7 889.6 899.3 945.0 955.4 992.2 27787.7 28880.3 28928.3 29481.7 29530.7 943.7 959.5 990.8 996.6 1076.2 14388.4 14639.9 14744.9 14823.9 14914.6 385286.0 387353.0 388613.0 389829.0 390408.0 48411.8 49415.5 49429.5 49527.0 49655.5 1199.2 1211.5 1220.3 1223.4 1235.3 25746.7 26906.3 27433.7 27626.9 27747.7 41509.6 42732.4 42777.8 42820.6 42969.0 276721.0 280351.0 327088.0 327729.0 329193.0 25226.0 25265.6 25548.0 25605.5 25679.1 41441.8 41882.8 42177.0 42982.1 43366.3 36278.0 36705.4 36751.9 36966.6 37444.0 34813.0 34883.1 34985.0 35317.6 35643.8 35034.6 35722.5 35827.6 36002.1 36129.3 31293.7 32208.7 32373.2 32855.8 33018.8 25184.7 25198.2 25326.7 25461.2 25572.5 01:54:14 INFO - PROCESS | 30293 | 01:54:14 INFO - PROCESS | 30293 | [#2] jquery.html Cycles:180 Average:23663.05 Median:24978.14 stddev:65075.80 (260.5%) stddev-sans-first:65234.80 01:54:14 INFO - PROCESS | 30293 | Values: 341.6 346.1 351.9 364.4 365.3 15719.9 16159.2 17176.6 17257.2 17264.4 16355.4 16592.2 17016.6 17102.1 17179.0 4440.6 4758.2 4763.1 4781.1 4791.4 4718.8 4727.0 4729.2 4758.4 4775.0 4723.7 5037.3 5101.5 5141.7 5156.9 5070.2 5092.8 5107.6 5123.0 5125.3 4424.6 4615.3 4621.0 4645.0 4672.5 11649.7 11707.1 11878.6 11888.5 11891.8 1878.5 1890.3 1901.2 1945.9 1960.8 9011.1 9055.1 9067.0 9332.1 9463.4 1554.8 1736.2 1741.9 1794.7 1804.4 43951.6 59500.7 60180.4 68867.0 72133.3 9838.4 9910.9 9917.8 9920.7 10140.8 13717.6 13805.7 13808.9 13826.3 13856.1 7225.8 7295.2 7336.0 7457.3 7498.9 6917.6 6948.6 6994.0 7121.0 7203.5 4228.5 4253.9 4264.0 4323.4 4329.7 1800.3 1803.4 1810.5 1839.4 1874.6 830.8 860.1 881.3 901.5 971.8 16575.2 16699.2 17466.4 17502.0 17530.7 878.8 912.5 916.3 945.4 946.2 9558.5 9583.6 9710.8 9855.1 9877.2 391346.0 395846.0 396185.0 397216.0 397763.0 63508.0 71836.6 73542.0 74725.0 75098.0 901.8 901.8 927.2 929.4 948.4 15814.2 15903.9 15914.8 15932.1 16157.8 27216.7 32944.5 34616.7 34692.7 34820.3 45341.0 46735.3 51012.5 52931.2 53030.0 7159.8 7907.9 7959.6 8007.7 8075.5 8453.3 11693.4 12195.4 12211.2 12400.4 10035.8 10044.4 10057.2 10254.9 10294.0 10149.6 10213.5 10245.2 10270.3 10554.6 10411.3 10445.2 10690.7 10720.1 10845.5 7915.6 7933.2 7962.4 7983.2 8030.2 9503.3 9809.0 9919.0 10652.6 10654.1 01:54:14 INFO - PROCESS | 30293 | 01:54:14 INFO - PROCESS | 30293 | [#3] mootools.html Cycles:180 Average:4984.40 Median:4966.65 stddev:2799.44 (56.4%) stddev-sans-first:2794.00 01:54:14 INFO - PROCESS | 30293 | Values: 1353.5 1399.6 1450.9 1663.4 1673.3 6392.1 7341.9 7419.0 7926.6 7946.6 7531.4 7762.8 7813.4 7833.2 7845.9 2154.5 2176.9 2178.5 2185.0 2188.2 2173.6 2183.3 2189.3 2189.9 2194.7 2179.2 2180.3 2184.2 2186.3 2202.8 2068.4 2075.9 2082.8 2085.9 2089.9 2126.3 2149.1 2157.9 2158.1 2159.1 7811.5 7853.1 7893.0 7901.9 7915.1 4434.3 4455.7 4511.5 4512.7 4638.7 2679.0 2740.7 2791.2 2810.5 2816.6 867.7 880.8 889.6 939.1 939.4 10466.0 10468.7 10504.3 10514.4 10515.5 4090.6 4127.0 4196.2 4210.1 4210.4 8839.6 8887.3 8901.0 8960.6 8992.6 4616.7 4619.1 4673.6 4711.1 4722.6 3506.4 4016.0 4121.8 4289.9 4328.0 3444.4 3483.2 3603.1 3613.5 3621.3 1178.5 1182.8 1192.9 1197.9 1205.3 654.7 787.6 793.4 820.1 830.3 4889.7 4957.0 4976.3 5022.1 5026.8 409.2 414.5 423.5 424.1 855.8 3349.5 3459.3 3488.0 3491.3 3523.6 8839.0 9073.5 9107.9 9121.9 9157.5 8924.6 8950.5 8981.1 9042.8 9047.3 6754.8 7100.3 7110.7 7135.6 7314.9 5246.9 5255.6 5319.9 5358.7 5437.9 8682.5 8795.8 8858.0 8883.3 8911.3 8253.0 8543.4 8635.1 8814.7 8969.8 5618.2 6218.8 6253.7 6425.8 6490.0 7167.7 7184.5 7225.3 7240.6 7255.4 6489.8 6652.6 6726.7 6739.9 6754.3 6664.0 6694.8 6718.3 6750.7 6789.0 6027.9 6031.8 6051.5 6077.1 6092.6 4003.3 4147.5 4184.5 4231.1 4281.7 4131.4 4156.4 4167.4 4262.7 4311.0 01:54:14 INFO - PROCESS | 30293 | 01:54:14 INFO - PROCESS | 30293 | [#4] prototype.html Cycles:180 Average:4428.92 Median:5115.63 stddev:1299.91 (25.4%) stddev-sans-first:1265.85 01:54:14 INFO - PROCESS | 30293 | Values: 287.6 296.0 297.9 303.7 305.1 5137.3 5147.5 5148.2 5152.6 5172.2 5033.9 5043.3 5065.6 5076.7 5116.0 3654.6 3810.2 3908.1 3909.8 3917.3 3924.8 3964.5 3987.7 4000.7 4007.9 3940.6 3985.1 3992.2 3997.5 4001.2 3837.4 3961.9 3991.1 4000.6 4003.7 3481.7 3489.8 3496.9 3497.7 3501.6 4941.5 4980.9 4997.9 5018.3 5028.9 4368.9 4489.6 4493.6 4501.3 4520.9 5296.3 5309.3 5336.4 5377.5 5381.3 3790.9 3795.2 3801.7 3810.4 3820.1 5423.8 5571.0 5597.1 5607.3 5610.8 3793.9 3812.0 3815.2 3825.0 3834.5 3861.0 3863.9 3894.2 3895.1 3901.7 4432.1 4483.3 4485.4 4488.1 4500.4 5183.3 5212.9 5297.0 5302.4 5317.6 1350.6 1353.6 1364.6 1372.5 1373.7 832.3 833.5 860.5 870.5 870.9 4519.3 4651.9 4661.7 4686.5 4696.0 5509.5 5521.4 5527.6 5529.5 5543.4 4450.8 4633.5 4664.2 4676.5 4683.3 2948.0 2967.8 2980.5 2987.7 2996.7 5173.7 5203.8 5209.7 5218.6 5239.7 5391.8 5571.6 5603.8 5623.6 5628.7 5088.6 5115.3 5134.9 5151.0 5178.3 5486.5 5518.1 5530.6 5561.2 5571.5 5135.4 5423.2 5459.9 5494.6 5509.8 5222.5 5259.9 5278.0 5290.5 5301.9 3818.2 3832.2 3832.7 3848.8 3849.3 5356.4 5470.7 5505.9 5509.4 5536.7 5323.7 5330.3 5344.7 5376.0 5377.3 5145.3 5342.1 5378.9 5397.2 5420.7 5234.6 5287.8 5288.5 5309.6 5320.0 5189.9 5252.8 5407.3 5429.6 5459.4 5307.4 5316.3 5327.8 5329.1 5335.5 01:54:14 INFO - PROCESS | 30293 | 01:54:14 INFO - PROCESS | 30293 | [#5] yui.html Cycles:180 Average:16326.69 Median:34648.10 stddev:23997.73 (69.3%) stddev-sans-first:24035.70 01:54:14 INFO - PROCESS | 30293 | Values: 521.1 538.7 545.7 572.1 579.9 11133.1 11786.5 11866.8 11880.0 11897.1 11896.0 14027.9 14755.8 14781.9 14784.7 616.5 774.5 783.2 783.3 784.8 751.3 775.8 777.5 778.4 780.8 820.4 821.3 821.7 822.6 825.9 803.7 813.8 813.9 814.3 818.8 593.1 594.0 596.2 597.2 597.4 11821.8 11839.7 11853.6 11871.7 11911.5 11446.5 12174.0 12648.7 12887.5 12939.2 9731.0 9813.8 10034.5 10144.4 10150.2 3189.2 3281.7 3338.6 3340.1 3350.3 49847.0 51787.0 51962.0 56317.2 56817.1 8970.5 9104.9 9274.4 9275.5 9390.6 17298.4 18426.2 18490.6 18542.7 18570.7 6689.7 6780.4 6808.9 6908.8 7093.0 3435.3 3467.6 3498.9 3499.0 3534.6 2718.6 2804.8 2812.9 2817.7 2820.5 469.3 472.4 473.3 490.0 494.1 419.5 532.5 533.8 551.1 557.9 6750.7 6873.4 6906.7 7024.5 7044.2 416.3 461.2 463.1 467.2 471.5 3202.0 3241.8 3242.3 3269.1 3328.1 85361.0 88234.0 89243.6 90907.5 94237.5 79995.6 80163.6 80695.6 81244.0 82036.0 71455.3 71698.0 72263.3 72332.0 73379.0 6331.2 6368.1 6377.8 6399.5 6541.4 41657.0 42658.1 43788.0 44211.6 44981.1 58788.0 62488.0 62547.4 62615.7 62965.0 8953.7 9059.5 9079.1 9182.4 9224.1 9622.5 9669.1 9682.6 10058.3 10297.0 8442.6 8452.3 8468.0 8563.8 8658.4 8610.6 8860.4 8888.8 8979.8 9012.6 8164.3 8353.8 8404.2 8479.5 8654.8 7662.3 7686.8 7709.0 7726.0 7784.8 7602.0 7630.3 7687.7 7719.0 7792.9 01:54:14 INFO - PROCESS | 30293 | -------- Summary: end -------- 01:54:14 INFO - PROCESS | 30293 | 01:54:15 INFO - TEST-INFO | 30293: exit 0 01:54:15 INFO - TEST-OK | dromaeo_css | took 1115842ms 01:54:15 INFO - TEST-START | kraken 01:54:15 INFO - operating with platform_type : linux_ 01:54:15 INFO - Initialising browser for kraken test... 01:54:15 INFO - TEST-INFO | started process 30524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7xZMxd/profile http://localhost:42405/getInfo.html) 01:54:20 INFO - PROCESS | 30524 | __metrics Screen width/height:1600/1200 01:54:20 INFO - PROCESS | 30524 | colorDepth:24 01:54:20 INFO - PROCESS | 30524 | Browser inner width/height: 1024/697 01:54:20 INFO - PROCESS | 30524 | __metrics 01:54:20 ERROR - PROCESS | 30524 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 01:54:21 INFO - TEST-INFO | 30524: exit 0 01:54:21 INFO - Browser initialized. 01:54:21 INFO - Running cycle 1/1 for kraken test... 01:54:21 INFO - TEST-INFO | started process 30644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7xZMxd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:34 INFO - PROCESS | 30644 | RSS: Main: 185851904 01:54:34 INFO - PROCESS | 30644 | 01:54:36 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42405/tests/kraken/driver.html?testName=audio-beat-detection) 01:54:37 INFO - PROCESS | 30644 | RSS: Main: 189321216 01:54:37 INFO - PROCESS | 30644 | 01:54:40 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42405/tests/kraken/driver.html?testName=audio-dft) 01:54:41 INFO - PROCESS | 30644 | RSS: Main: 189911040 01:54:41 INFO - PROCESS | 30644 | 01:54:44 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42405/tests/kraken/driver.html?testName=audio-fft) 01:54:44 INFO - PROCESS | 30644 | RSS: Main: 185274368 01:54:44 INFO - PROCESS | 30644 | 01:54:46 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42405/tests/kraken/driver.html?testName=audio-oscillator) 01:54:47 INFO - PROCESS | 30644 | RSS: Main: 185683968 01:54:47 INFO - PROCESS | 30644 | 01:54:49 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42405/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:54:50 INFO - PROCESS | 30644 | RSS: Main: 186081280 01:54:50 INFO - PROCESS | 30644 | 01:54:53 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42405/tests/kraken/driver.html?testName=imaging-darkroom) 01:54:54 INFO - PROCESS | 30644 | RSS: Main: 186499072 01:54:54 INFO - PROCESS | 30644 | 01:54:57 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42405/tests/kraken/driver.html?testName=imaging-desaturate) 01:54:58 INFO - PROCESS | 30644 | RSS: Main: 183406592 01:54:58 INFO - PROCESS | 30644 | 01:55:01 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42405/tests/kraken/driver.html?testName=json-parse-financial) 01:55:02 INFO - PROCESS | 30644 | RSS: Main: 185171968 01:55:02 INFO - PROCESS | 30644 | 01:55:03 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42405/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:55:04 INFO - PROCESS | 30644 | RSS: Main: 185573376 01:55:04 INFO - PROCESS | 30644 | 01:55:06 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42405/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:55:07 INFO - PROCESS | 30644 | RSS: Main: 185532416 01:55:07 INFO - PROCESS | 30644 | 01:55:09 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42405/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:55:10 INFO - PROCESS | 30644 | RSS: Main: 185679872 01:55:10 INFO - PROCESS | 30644 | 01:55:12 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:55:13 INFO - PROCESS | 30644 | RSS: Main: 185462784 01:55:13 INFO - PROCESS | 30644 | 01:55:16 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:55:16 INFO - PROCESS | 30644 | RSS: Main: 185311232 01:55:16 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | Cycle 1(1): loaded http://localhost:42405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42405/tests/kraken/driver.html?testName=ai-astar) 01:55:18 INFO - PROCESS | 30644 | RSS: Main: 186376192 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | __start_tp_report 01:55:18 INFO - PROCESS | 30644 | _x_x_mozilla_page_load 01:55:18 INFO - PROCESS | 30644 | _x_x_mozilla_page_load_details 01:55:18 INFO - PROCESS | 30644 | |i|pagename|runs| 01:55:18 INFO - PROCESS | 30644 | |0;ai-astar;114;109;115;116;113;116;115;126;114;114 01:55:18 INFO - PROCESS | 30644 | |1;audio-beat-detection;160;138;160;174;132;156;157;138;188;132 01:55:18 INFO - PROCESS | 30644 | |2;audio-dft;164;169;177;163;163;163;167;165;165;163 01:55:18 INFO - PROCESS | 30644 | |3;audio-fft;75;77;78;165;77;75;79;77;163;78 01:55:18 INFO - PROCESS | 30644 | |4;audio-oscillator;87;86;153;88;87;88;139;87;87;136 01:55:18 INFO - PROCESS | 30644 | |5;imaging-gaussian-blur;119;118;118;119;119;119;118;118;119;119 01:55:18 INFO - PROCESS | 30644 | |6;imaging-darkroom;149;150;149;150;150;150;149;151;149;148 01:55:18 INFO - PROCESS | 30644 | |7;imaging-desaturate;100;95;95;96;100;97;96;96;96;95 01:55:18 INFO - PROCESS | 30644 | |8;json-parse-financial;64;64;68;65;65;64;67;64;64;65 01:55:18 INFO - PROCESS | 30644 | |9;json-stringify-tinderbox;65;65;65;66;66;65;65;65;65;66 01:55:18 INFO - PROCESS | 30644 | |10;stanford-crypto-aes;85;89;83;86;90;88;85;85;113;85 01:55:18 INFO - PROCESS | 30644 | |11;stanford-crypto-ccm;138;134;136;135;134;132;143;141;141;133 01:55:18 INFO - PROCESS | 30644 | |12;stanford-crypto-pbkdf2;172;174;172;176;177;175;168;170;169;170 01:55:18 INFO - PROCESS | 30644 | |13;stanford-crypto-sha256-iterative;69;68;68;68;69;68;67;68;69;69 01:55:18 INFO - PROCESS | 30644 | __end_tp_report 01:55:18 INFO - PROCESS | 30644 | __start_cc_report 01:55:18 INFO - PROCESS | 30644 | _x_x_mozilla_cycle_collect,1031 01:55:18 INFO - PROCESS | 30644 | __end_cc_report 01:55:18 INFO - PROCESS | 30644 | __startTimestamp1465548918967__endTimestamp 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | ------- Summary: start ------- 01:55:18 INFO - PROCESS | 30644 | Number of tests: 14 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:4.29 (3.7%) stddev-sans-first:4.53 01:55:18 INFO - PROCESS | 30644 | Values: 114.0 109.0 115.0 116.0 113.0 116.0 115.0 126.0 114.0 114.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:158.50 stddev:18.61 (11.7%) stddev-sans-first:19.59 01:55:18 INFO - PROCESS | 30644 | Values: 160.0 138.0 160.0 174.0 132.0 156.0 157.0 138.0 188.0 132.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.00 stddev:4.38 (2.7%) stddev-sans-first:4.59 01:55:18 INFO - PROCESS | 30644 | Values: 164.0 169.0 177.0 163.0 163.0 163.0 167.0 165.0 165.0 163.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#3] audio-fft Cycles:10 Average:94.40 Median:77.00 stddev:36.71 (47.7%) stddev-sans-first:38.26 01:55:18 INFO - PROCESS | 30644 | Values: 75.0 77.0 78.0 165.0 77.0 75.0 79.0 77.0 163.0 78.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:87.00 stddev:27.17 (31.2%) stddev-sans-first:28.12 01:55:18 INFO - PROCESS | 30644 | Values: 87.0 86.0 153.0 88.0 87.0 88.0 139.0 87.0 87.0 136.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:55:18 INFO - PROCESS | 30644 | Values: 119.0 118.0 118.0 119.0 119.0 119.0 118.0 118.0 119.0 119.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:150.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 01:55:18 INFO - PROCESS | 30644 | Values: 149.0 150.0 149.0 150.0 150.0 150.0 149.0 151.0 149.0 148.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.90 (2.0%) stddev-sans-first:1.56 01:55:18 INFO - PROCESS | 30644 | Values: 100.0 95.0 95.0 96.0 100.0 97.0 96.0 96.0 96.0 95.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.41 (2.2%) stddev-sans-first:1.45 01:55:18 INFO - PROCESS | 30644 | Values: 64.0 64.0 68.0 65.0 65.0 64.0 67.0 64.0 64.0 65.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 01:55:18 INFO - PROCESS | 30644 | Values: 65.0 65.0 65.0 66.0 66.0 65.0 65.0 65.0 65.0 66.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:85.50 stddev:8.74 (10.2%) stddev-sans-first:9.15 01:55:18 INFO - PROCESS | 30644 | Values: 85.0 89.0 83.0 86.0 90.0 88.0 85.0 85.0 113.0 85.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:137.00 stddev:3.83 (2.8%) stddev-sans-first:4.03 01:55:18 INFO - PROCESS | 30644 | Values: 138.0 134.0 136.0 135.0 134.0 132.0 143.0 141.0 141.0 133.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:3.09 (1.8%) stddev-sans-first:3.28 01:55:18 INFO - PROCESS | 30644 | Values: 172.0 174.0 172.0 176.0 177.0 175.0 168.0 170.0 169.0 170.0 01:55:18 INFO - PROCESS | 30644 | 01:55:18 INFO - PROCESS | 30644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 01:55:18 INFO - PROCESS | 30644 | Values: 69.0 68.0 68.0 68.0 69.0 68.0 67.0 68.0 69.0 69.0 01:55:18 INFO - PROCESS | 30644 | -------- Summary: end -------- 01:55:18 INFO - PROCESS | 30644 | 01:55:20 INFO - TEST-INFO | 30644: exit 0 01:55:20 INFO - TEST-OK | kraken | took 64938ms 01:55:20 INFO - SUITE-END | took 1180s 01:55:20 INFO - Completed test suite (00:19:41) 01:55:20 INFO - javascript benchmark 01:55:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6222.445523596059, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.1536500637294, 2665.3869609989715, 2676.3041609181605, 2682.0, 2692.0577797770784, 4799.904001919959, 4804.687695299807, 4863.221884498481, 4865.732384718839, 4868.51314868513, 4646.024334889668, 4844.854654360366, 4896.2410826321975, 4941.2094064949615, 4941.60467162627, 4405.317175837742, 4429.77851107445, 4520.457545094577, 4554.225781617117, 4568.063546972862, 4235.131797981407, 4554.066416384633, 4558.293464513005, 4641.791119399618, 4656.0, 4342.565743425664, 4403.977980110111, 4415.227335216357, 4452.309891966718, 4545.000099978016, 4445.911081778347, 4468.084042771224, 4505.3917721107555, 4560.840370587013, 4561.156186105581, 4510.684252102355, 4527.660425468071, 4535.886602834922, 4542.364069030338, 4564.726116433025, 4798.5441383068555, 4888.046830867982, 4904.239842824368, 4915.5084491550915, 4919.680220785674, 5226.0, 5245.685258884441, 5249.291345668324, 5256.395514515842, 5282.286891269668, 5035.118854200537, 5220.269162317279, 5299.152135658314, 5300.522952934216, 5307.124324486455, 4886.902261954777, 4909.926351104737, 4933.753312334369, 4935.555799978019, 4990.600751939836, 5401.837944861661, 5413.296271484682, 5421.484958928895, 5429.647072940246, 5468.179773033997, 4900.387451568554, 5077.466865979093, 5104.0, 5179.61152913533, 5185.2999845021195, 5007.349044624249, 5242.842714718565, 5261.368635763656, 5275.0, 5323.680579165262, 5163.14808056674, 5213.061648903234, 5215.530602245816, 5226.294450249167, 5227.555657769132, 4889.633277504201, 5152.381714194245, 5195.246689230116, 5198.168293073166, 5201.245819356172, 4441.0, 4461.732296062247, 4466.531014243523, 4504.301833215857, 4504.504504504502, 3876.554196267465, 3884.7474914131058, 3889.8249578769023, 3900.0444891001885, 3936.566977632458, 4314.288142456459, 4446.288593824973, 4481.887952801206, 4508.0, 4571.131485017836, 5191.9480805192225, 5239.345081864767, 5243.292155559027, 5243.68537887728, 5288.65623734456, 4488.375912681225, 4500.144972455223, 4502.4371953505815, 4535.659825513099, 4547.3406356078185, 4545.772711364419, 4657.347971284023, 4675.18184317743, 4679.859604211879, 4708.317293992421, 4855.635827312965, 4870.464248932685, 4904.705717656952, 4916.287138364917, 4957.727324997016, 5262.079136151235, 5276.472352764693, 5276.894462110659, 5281.128613778684, 5283.286756287852, 4748.145333839942, 4834.6374021947795, 4857.1742803724155, 4870.196417591058, 4900.411950565955, 5071.594272458121, 5112.872178195426, 5118.027574760784, 5127.102757017582, 5173.508516690908, 5011.298418221379, 5188.870278243074, 5191.065608190562, 5191.558717509054, 5204.479552044765, 4851.708897466164, 4957.157283261926, 4991.800327986985, 5008.84973450797, 5024.07054694868, 5048.3941926969, 5100.719460429712, 5101.540861322499, 5117.257997590403, 5124.180131178993, 4972.801087956441, 5028.723420211923, 5036.345275114211, 5041.546260836396, 5087.949120508748, 4919.926201107058, 5065.088284108896, 5105.872353191051, 5122.948770512247, 5124.5131712487255, 4979.502049794992, 5012.949870501248, 5014.674046186986, 5022.196448568212, 5050.393952725696], "value": 4783.749494996379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.1049589169655, 570.6433479075578, 571.1489880078678, 578.6961845031358, 586.5600799400448, 37477.437838432445, 38263.808680956594, 38296.61703382965, 38383.42424863629, 38514.422283665765, 38591.614083859226, 38606.22787544248, 39023.60976390235, 39093.41359879604, 39277.0, 7481.7007319707145, 7612.771616851475, 7616.276453736914, 7617.619119044026, 7658.2724641159, 7616.885746713804, 7714.228577142297, 7742.419318551103, 7766.37868970481, 7778.766637000899, 7785.3771698264, 7823.882641760378, 7824.0, 7830.256125668053, 7832.060152781674, 7682.846343073164, 7698.769036928901, 7718.189590093071, 7731.806704832368, 7786.883196752054, 7609.391248700091, 7700.422468314843, 7710.653020614086, 7734.071911370615, 7747.147813740484, 37034.44448333277, 37136.25727485462, 37313.25373492542, 37322.44016339757, 37723.811380943196, 2953.4831404504125, 3012.2469382654335, 3042.7717921156, 3110.144710204689, 3193.1538142392283, 29104.854475727698, 29820.70179298201, 30141.69858301411, 30187.547186792217, 30763.077107686804, 3441.913952151191, 3444.793312401264, 3475.8088305143206, 3509.6314886937016, 3581.2658405026905, 244834.0, 245511.0, 247545.9999999982, 247848.0, 248125.0, 31790.841045794623, 49391.50608493941, 49476.752616236685, 49859.0, 50101.24848127281, 32311.51532727011, 33314.3337133256, 33635.495467568006, 33782.83108584442, 34022.48966265508, 12894.484220631257, 13086.934565327112, 13112.885404740513, 13126.081174317897, 13228.074034817662, 10419.895801042045, 10553.155747540179, 10591.417472039111, 10593.311434756715, 10618.840717389245, 7758.728444504415, 7832.960835195901, 7856.410769192219, 7962.442629016029, 7966.522008679498, 3105.503119500914, 3108.114187456564, 3123.453395655751, 3155.8422078896424, 3211.6627754085953, 889.58634235081, 899.3120262998812, 944.9716508504756, 955.3694561589317, 992.2211064314479, 27787.72212277892, 28880.27799304992, 28928.276793080342, 29481.705182947895, 29530.704692953226, 943.6649989253854, 959.510649568725, 990.757264470195, 996.5913975270105, 1076.1713480619878, 14388.424463021362, 14639.853601463848, 14744.926275368554, 14823.925880370529, 14914.552563423114, 385286.0, 387353.0, 388613.0, 389829.0, 390408.0, 48411.75794121007, 49415.50584494109, 49429.50570494321, 49527.0, 49655.50344496581, 1199.220506670671, 1211.5173070377389, 1220.2983284611207, 1223.3516236394726, 1235.3329202230875, 25746.742532574433, 26906.327341815828, 27433.725662743116, 27626.861865690542, 27747.722522775322, 41509.58490415178, 42732.35901461543, 42777.78611106925, 42820.571794281655, 42969.0, 276721.0, 280351.0, 327088.0, 327729.0, 329193.0, 25225.990960362113, 25265.621015684414, 25548.0, 25605.487890242464, 25679.10123145681, 41441.79279103585, 41882.790586046875, 42177.0, 42982.140357193304, 43366.34950475682, 36278.0, 36705.44941825821, 36751.89744307568, 36966.630333697394, 37444.0, 34813.0, 34883.12792180216, 34985.0, 35317.646823532465, 35643.82178089093, 35034.64965350314, 35722.46416303705, 35827.641723582434, 36002.09994750152, 36129.27741445209, 31293.687063129077, 32208.677913220567, 32373.217866727933, 32855.83572082124, 33018.834905825315, 25184.748152518972, 25198.24405267845, 25326.74673253244, 25461.236162915142, 25572.488550229264], "value": 16349.36405351496, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.60203363082013, 346.11394829237156, 351.89619062376613, 364.40238009664137, 365.26763838503797, 15719.921400392996, 16159.192040397977, 17176.570585735364, 17257.223424945878, 17264.395746148886, 16355.427560035401, 16592.17039148041, 17016.574585635335, 17102.059386733723, 17179.0, 4440.644748420134, 4758.191107511731, 4763.14263432582, 4781.139394908915, 4791.401074865642, 4718.834840780573, 4727.007328461027, 4729.2433210686295, 4758.428988521382, 4775.044991001796, 4723.6929599575915, 5037.29477873098, 5101.54086132248, 5141.691498510101, 5156.896862062757, 5070.2394640803805, 5092.821751238707, 5107.591392688594, 5122.974385128051, 5125.3080834087295, 4424.601785839258, 4615.284630882219, 4620.953790462086, 4644.9535504644855, 4672.462666793328, 11649.70875728105, 11707.12196585251, 11878.643640690792, 11888.524459021628, 11891.762164756656, 1878.4646375782836, 1890.3005887821594, 1901.2014953719472, 1945.863789534733, 1960.7843137255034, 9011.098890111001, 9055.139761722627, 9066.95466522663, 9332.113449222314, 9463.38487998278, 1554.8028018425748, 1736.2100244388898, 1741.8693597980202, 1794.6500432415685, 1804.3684710351404, 43951.560484395064, 59500.70249648724, 60180.39819601835, 68867.0, 72133.27866721318, 9838.409695418297, 9910.851337229948, 9917.801643967081, 9920.652777152909, 10140.847887281696, 13717.628237176203, 13805.654858628615, 13808.930955345159, 13826.30868456573, 13856.099353541988, 7225.783226503213, 7295.161056478573, 7335.963320183471, 7457.32884040439, 7498.887516687254, 6917.584944903322, 6948.583085014915, 6994.0, 7121.0, 7203.495755297184, 4228.492580890313, 4253.893652658709, 4263.957360426418, 4323.351497275371, 4329.675274354436, 1800.2798880447663, 1803.422904670493, 1810.5383127302716, 1839.3838064248628, 1874.6157037807218, 830.7964548685611, 860.1054902901038, 881.3345923827469, 901.5221932375852, 971.771633666102, 16575.171241437878, 16699.248533816008, 17466.405012601314, 17502.0, 17530.737038944426, 878.8242351529719, 912.4525284829182, 916.2578311567652, 945.3996712087736, 946.2099147212155, 9558.518429643416, 9583.568739406743, 9710.75723106914, 9855.11303982645, 9877.209823214125, 391346.0, 395846.0, 396185.0, 397216.0, 397763.0, 63508.0, 71836.64081679558, 73542.0, 74725.0, 75098.0, 901.8106197698426, 901.8421776189141, 927.1655510041018, 929.3680297397699, 948.393028461785, 15814.209289535707, 15903.920480397986, 15914.7612785806, 15932.123733194321, 16157.838421616103, 27216.72783272142, 32944.505832412055, 34616.65383346134, 34692.653073468944, 34820.30359392849, 45341.0, 46735.29897051479, 51012.48987510077, 52931.17926980452, 53030.0, 7159.785206443815, 7907.881381779162, 7959.602019899097, 8007.719729809429, 8075.475094118863, 8453.323734101134, 11693.415329233334, 12195.390230488618, 12211.206271592318, 12400.441980110736, 10035.849462257926, 10044.447555384524, 10057.19542436618, 10254.897451025394, 10294.0, 10149.64476243328, 10213.489325533545, 10245.180385568987, 10270.33242839213, 10554.577816887238, 10411.271211015157, 10445.164386849186, 10690.73273168177, 10720.142388608736, 10845.457727113771, 7915.643796029308, 7933.246341597539, 7962.402819788655, 7983.1617680142745, 8030.196980302157, 9503.287253456157, 9808.950955245178, 9919.0, 10652.62715804943, 10654.094401975919], "value": 7930.630682272016, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.5262658069678, 1399.5521433141396, 1450.9347079381428, 1663.3845477173447, 1673.3306677329074, 6392.137061496696, 7341.926580734191, 7419.0, 7926.603669816508, 7946.64240109195, 7531.397488200944, 7762.767116986485, 7813.413993950462, 7833.177516360772, 7845.882311765328, 2154.493693981913, 2176.934691959236, 2178.455386153462, 2185.0495034659893, 2188.1903695632636, 2173.630482817917, 2183.279517759144, 2189.2665956904457, 2189.879556624385, 2194.7037149984785, 2179.204590324528, 2180.2587120379067, 2184.213683074092, 2186.311311936735, 2202.768709285526, 2068.389825001628, 2075.916963321465, 2082.83337333013, 2085.9061342239634, 2089.9477513062143, 2126.25581046634, 2149.12960251097, 2157.924472643466, 2158.0504577985635, 2159.1255541505557, 7811.4922530035365, 7853.136155022943, 7892.960535197287, 7901.8814717778705, 7915.089764677078, 4434.2905135178535, 4455.732656040648, 4511.526289739563, 4512.684112112153, 4638.652101092432, 2679.0, 2740.6848212455625, 2791.1766029021487, 2810.5222112240967, 2816.6338376010985, 867.7396780965685, 880.7533890510667, 889.6263569300844, 939.0890835889177, 939.3565407695681, 10466.0, 10468.68593942183, 10504.2647014709, 10514.421706806123, 10515.474226288656, 4090.570490098556, 4127.0, 4196.160767846443, 4210.115875666083, 4210.431591735138, 8839.60221790021, 8887.289016878634, 8901.0, 8960.641574337084, 8992.640294388151, 4616.676832621752, 4619.122366750306, 4673.649476289292, 4711.081339138904, 4722.5513576210205, 3506.368853606324, 4015.9598404015587, 4121.793910304533, 4289.935650965238, 4328.0, 3444.362792883325, 3483.216276337854, 3603.0632035670915, 3613.457981302826, 3621.293847699726, 1178.4814681540095, 1182.798924182891, 1192.8866757658009, 1197.9221350612183, 1205.3491114798087, 654.7282877605741, 787.6258777080841, 793.3732351442411, 820.0774129104757, 830.3357314148657, 4889.731064791471, 4956.975215123974, 4976.328195693535, 5022.146235140035, 5026.798928042837, 409.2326887086712, 414.5419311660632, 423.47970784881807, 424.1453471255423, 855.8074433252468, 3349.4975753636663, 3459.290845376692, 3488.0, 3491.284286721216, 3523.6300188480354, 8838.955805220932, 9073.45559266446, 9107.861517310335, 9121.863172052424, 9157.542122893961, 8924.643014279356, 8950.462972221687, 8981.101889810967, 9042.819143617091, 9047.276217902552, 6754.763583274562, 7100.254473280334, 7110.680019399139, 7135.571865688075, 7314.853702926018, 5246.895062098813, 5255.605829562722, 5319.920201197063, 5358.678479291255, 5437.864053398696, 8682.479051256945, 8795.780105497413, 8858.0, 8883.333749968908, 8911.331650126396, 8252.958735206286, 8543.444676096035, 8635.050144484227, 8814.691485797966, 8969.7757556059, 5618.185363122406, 6218.844528886633, 6253.6560489173535, 6425.839354016187, 6490.026496025634, 7167.749128780676, 7184.46116541251, 7225.313595208447, 7240.601766902871, 7255.419566434778, 6489.772857949949, 6652.600843949379, 6726.697298621476, 6739.865202696017, 6754.324567543206, 6663.966680166568, 6694.765683201064, 6718.294579069127, 6750.729970801113, 6789.015592739124, 6027.879442411215, 6031.849203769941, 6051.546134039877, 6077.149199112217, 6092.573519853568, 4003.259397011562, 4147.502299724052, 4184.539700632989, 4231.11146659205, 4281.700280980302, 4131.380292956081, 4156.397322388298, 4167.437395951629, 4262.744235345889, 4310.978445107754], "value": 3975.7195435774647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.64906813687304, 295.9792814502985, 297.9433907557564, 303.6720342030607, 305.13189974522504, 5137.332146820912, 5147.536721695046, 5148.172398798429, 5152.613553983452, 5172.198309262061, 5033.949660503394, 5043.293938848564, 5065.645404821664, 5076.6700164489375, 5115.974420127904, 3654.561452625682, 3810.1998580298173, 3908.1206728486004, 3909.7849618270984, 3917.2557214129365, 3924.7645141291473, 3964.464797252377, 3987.700922430815, 4000.6997725739106, 4007.899802504946, 3940.581390699346, 3985.083430810915, 3992.1816027714394, 3997.5402828674637, 4001.1797581495725, 3837.4052021936645, 3961.900952476211, 3991.1419044905197, 4000.5599384067873, 4003.719739618228, 3481.669241422061, 3489.7906125632544, 3496.915956053606, 3497.6852083312624, 3501.6148223695373, 4941.48114447985, 4980.9252861207115, 4997.850494386312, 5018.2974383586325, 5028.874278143039, 4368.907773056736, 4489.595936365743, 4493.595576398107, 4501.3022981437925, 4520.909581808345, 5296.285001524783, 5309.256704061435, 5336.38631557372, 5377.489138531833, 5381.300430943991, 3790.924181516382, 3795.1840354323676, 3801.7148713846295, 3810.3522401191863, 3820.083180036799, 5423.776251736808, 5570.972145139289, 5597.132444471114, 5607.2897766181295, 5610.803621873256, 3793.943090853639, 3811.9809400952818, 3815.236952609489, 3824.980875095662, 3834.5206849143856, 3860.9961410033593, 3863.9034024149623, 3894.2406230784727, 3895.14306852492, 3901.7073719471155, 4432.069265454226, 4483.30508771141, 4485.394471746273, 4488.1248156609145, 4500.392447019676, 5183.3261675981885, 5212.947870521322, 5297.0, 5302.3637163540625, 5317.574594032468, 1350.5818890165287, 1353.6006877970826, 1364.6042647632273, 1372.540199033315, 1373.7458570164551, 832.3008672714949, 833.4665813879122, 860.4622111180512, 870.5081628879663, 870.9433886797337, 4519.276915693539, 4651.930221046687, 4661.673682842168, 4686.461056978491, 4695.976520117378, 5509.5041446270025, 5521.420250873681, 5527.55779537636, 5529.474699903502, 5543.417941116125, 4450.777461126931, 4633.4903160652975, 4664.183767840682, 4676.462206846256, 4683.320918466871, 2947.955780663292, 2967.7774166937565, 2980.538016607386, 2987.6564195117403, 2996.715312045352, 5173.741312934413, 5203.791848326025, 5209.661372010883, 5218.634695571273, 5239.685618862881, 5391.81128660495, 5571.609987300931, 5603.814512340109, 5623.634463759842, 5628.662280263197, 5088.643794934319, 5115.283860259567, 5134.948650513522, 5150.974245128826, 5178.275041494269, 5486.451354864482, 5518.144687573433, 5530.585206109477, 5561.165825126263, 5571.526420254162, 5135.38375394955, 5423.159410291411, 5459.890802184013, 5494.642848214853, 5509.834704958857, 5222.529972302359, 5259.921101183409, 5278.0, 5290.497402746733, 5301.867453313544, 3818.1790914953417, 3832.2143960487474, 3832.693384529175, 3848.7690738555775, 3849.3263678856647, 5356.437574054668, 5470.671759694431, 5505.944940550543, 5509.41057702879, 5536.667799932017, 5323.680579165262, 5330.333708286465, 5344.679319240858, 5375.973120134374, 5377.327834020747, 5145.305383773292, 5342.1452567589, 5378.892422151614, 5397.1919406999095, 5420.7289635518855, 5234.607404444606, 5287.814926477555, 5288.524032837063, 5309.601779866448, 5319.973400132974, 5189.92215116766, 5252.763625636932, 5407.296701539002, 5429.6199266051, 5459.3894801034585, 5307.41618421981, 5316.3354580677415, 5327.760250788646, 5329.09405401075, 5335.493128152819], "value": 4007.134024353064, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.0880958322934, 538.7144813248974, 545.6551340284057, 572.084664536741, 579.8666306749445, 11133.1093512519, 11786.528538858436, 11866.7626647467, 11879.999999999989, 11897.107716921233, 11896.0, 14027.859721402783, 14755.77866332006, 14781.92609036956, 14784.704305913876, 616.4729156571134, 774.4617490843851, 783.2363445640511, 783.2832957843566, 784.8037990502374, 751.2862780358654, 775.7633921653921, 777.4752042371405, 778.3811869563682, 780.7657702689199, 820.4257020085934, 821.3183058061794, 821.6836517940606, 822.5969275055239, 825.9380546459009, 803.7227156630953, 813.8413009463158, 813.8738495533142, 814.2590242879011, 818.8157664525464, 593.1162567773986, 593.9613925094854, 596.2368168744015, 597.208698474523, 597.3548567547039, 11821.822672659917, 11839.704007399798, 11853.644390668294, 11871.703207419798, 11911.463984120735, 11446.484908179153, 12174.0, 12648.68378290541, 12887.548935787203, 12939.218068115306, 9731.0, 9813.803723925554, 10034.498275086216, 10144.391336519833, 10150.187984961185, 3189.202699325169, 3281.7210537104374, 3338.61605915318, 3340.064781861083, 3350.3466823969334, 49847.0, 51786.96426071457, 51962.0, 56317.155242671804, 56817.147742783476, 8970.461772293684, 9104.908950910538, 9274.44353338802, 9275.489848058287, 9390.62437502506, 17298.394556190473, 18426.170822313026, 18490.63018739618, 18542.721859172125, 18570.721439178422, 6689.732410703615, 6780.423663988616, 6808.93191068083, 6908.792736217922, 7093.0, 3435.3129374125274, 3467.6358982306497, 3498.8775392861126, 3498.9825050874583, 3534.593521744981, 2718.6465759451144, 2804.7615952643846, 2812.9015484458355, 2817.661880574344, 2820.4923113839295, 469.3438117068002, 472.433080303637, 473.3349643750536, 489.99550920612603, 494.07114624506414, 419.5238404411015, 532.5267750892457, 533.823838133415, 551.1209620655048, 557.946995035471, 6750.696218670171, 6873.4157596603845, 6906.689198986058, 7024.5434046786795, 7044.241454371913, 416.3338658147001, 461.2300125430884, 463.09696092619527, 467.22440748357565, 471.4931448692669, 3202.0, 3241.7730758846656, 3242.2866969266724, 3269.1336795749144, 3328.1014126185796, 85361.0, 88234.0, 89243.55378223068, 90907.54546227226, 94237.5288123555, 79995.60002200068, 80163.59918200372, 80695.59652201702, 81244.0, 82036.0, 71455.28544714487, 71698.0, 72263.27736722566, 72332.0, 73379.0, 6331.2085989251345, 6368.140301059298, 6377.840553986188, 6399.520035997226, 6541.411272985454, 41657.0, 42658.14683706371, 43788.0, 44211.55788442203, 44981.1003779916, 58788.0, 62488.0, 62547.374526254156, 62615.6869215651, 62965.0, 8953.731388058368, 9059.547022648972, 9079.137481939206, 9182.449053056838, 9224.077592240723, 9622.470764107762, 9669.081437263449, 9682.612695492384, 10058.29591928558, 10297.0, 8442.620082096444, 8452.32381409498, 8468.0, 8563.785905352415, 8658.39391242607, 8610.569471526524, 8860.42407243553, 8888.822223555622, 8979.775505612151, 9012.63949442015, 8164.346852251924, 8353.791155221168, 8404.243618074403, 8479.533625650649, 8654.82690346177, 7662.310392064741, 7686.769396918102, 7709.0, 7725.961370193338, 7784.805379865548, 7602.0, 7630.313271805564, 7687.654055567625, 7719.0, 7792.88310675329], "value": 5873.474716416716, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 115.0, 116.0, 113.0, 116.0, 115.0, 126.0, 114.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 138.0, 160.0, 174.0, 132.0, 156.0, 157.0, 138.0, 188.0, 132.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 177.0, 163.0, 163.0, 163.0, 167.0, 165.0, 165.0, 163.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 165.0, 77.0, 75.0, 79.0, 77.0, 163.0, 78.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 153.0, 88.0, 87.0, 88.0, 139.0, 87.0, 87.0, 136.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 119.0, 119.0, 119.0, 118.0, 118.0, 119.0, 119.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 150.0, 150.0, 150.0, 149.0, 151.0, 149.0, 148.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 95.0, 96.0, 100.0, 97.0, 96.0, 96.0, 96.0, 95.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 68.0, 65.0, 65.0, 64.0, 67.0, 64.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 83.0, 86.0, 90.0, 88.0, 85.0, 85.0, 113.0, 85.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 134.0, 136.0, 135.0, 134.0, 132.0, 143.0, 141.0, 141.0, 133.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 172.0, 176.0, 177.0, 175.0, 168.0, 170.0, 169.0, 170.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 67.0, 68.0, 69.0, 69.0], "value": 68.3, "unit": "score"}]}]} 01:55:20 INFO - Return code: 0 01:55:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:55:20 ERROR - # TBPL SUCCESS # 01:55:20 INFO - Running post-action listener: _resource_record_post_action 01:55:20 INFO - ##### 01:55:20 INFO - ##### Finished run-tests step (success) 01:55:20 INFO - ##### 01:55:20 INFO - Running post-run listener: _resource_record_post_run 01:55:20 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 535937024; Read time: 204; Write time: 439780 01:55:20 INFO - TinderboxPrint: CPU usage
13.4% 01:55:20 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 204 01:55:20 INFO - TinderboxPrint: I/O write bytes / time
535,937,024 / 439,780 01:55:20 INFO - TinderboxPrint: CPU idle
8,272.1 (86.6%) 01:55:20 INFO - TinderboxPrint: CPU user
1,229.6 (12.9%) 01:55:20 INFO - TinderboxPrint: Swap in / out
0 / 0 01:55:20 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237899776; Read time: 0; Write time: 254356 01:55:20 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 298037248; Read time: 204; Write time: 185424 01:55:21 INFO - Running post-run listener: _upload_blobber_files 01:55:21 INFO - Blob upload gear active. 01:55:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:55:21 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 01:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:55:21 INFO - (blobuploader) - INFO - Open directory for files ... 01:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:55:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:22 INFO - (blobuploader) - INFO - Done attempting. 01:55:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:55:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:55:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:26 INFO - (blobuploader) - INFO - Done attempting. 01:55:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:55:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:55:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:27 INFO - (blobuploader) - INFO - Done attempting. 01:55:27 INFO - (blobuploader) - INFO - Iteration through files over. 01:55:27 INFO - Return code: 0 01:55:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:55:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:55:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317038593fb72be30717c2c83d31e21ad47b14e5c202176dd9e4e8fbf454ce00e09098b425c97c2732fd6b6b487a695da439dbe8fbccc6501314a8554ebd18e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09be28fa91473291867658d34a6925db79f038e8bd72a18505df7467ce313ae0f45046041841dbfbedcaaeca4ab5a9c91d09964067a90147e04dc5ec91ad9d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67ffbd33cb1c3d3954d8e0da3a77ff80f46c3b871898be67d1d8694675b9b8204f2693d6a2dddda23625fe4a90457c46f387dc722240a537592ef8a1b08e4795"} 01:55:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:55:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:55:27 INFO - Contents: 01:55:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317038593fb72be30717c2c83d31e21ad47b14e5c202176dd9e4e8fbf454ce00e09098b425c97c2732fd6b6b487a695da439dbe8fbccc6501314a8554ebd18e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09be28fa91473291867658d34a6925db79f038e8bd72a18505df7467ce313ae0f45046041841dbfbedcaaeca4ab5a9c91d09964067a90147e04dc5ec91ad9d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67ffbd33cb1c3d3954d8e0da3a77ff80f46c3b871898be67d1d8694675b9b8204f2693d6a2dddda23625fe4a90457c46f387dc722240a537592ef8a1b08e4795"} 01:55:27 INFO - Running post-run listener: copy_logs_to_upload_dir 01:55:27 INFO - Copying logs to upload dir... 01:55:27 INFO - mkdir: /builds/slave/test/build/upload/logs 01:55:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.474468 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-10 01:55:27.204860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 01:55:27.207977) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317038593fb72be30717c2c83d31e21ad47b14e5c202176dd9e4e8fbf454ce00e09098b425c97c2732fd6b6b487a695da439dbe8fbccc6501314a8554ebd18e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09be28fa91473291867658d34a6925db79f038e8bd72a18505df7467ce313ae0f45046041841dbfbedcaaeca4ab5a9c91d09964067a90147e04dc5ec91ad9d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67ffbd33cb1c3d3954d8e0da3a77ff80f46c3b871898be67d1d8694675b9b8204f2693d6a2dddda23625fe4a90457c46f387dc722240a537592ef8a1b08e4795"} build_url:https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/UX0ni36-Tb2bxvMv7Uy4Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/317038593fb72be30717c2c83d31e21ad47b14e5c202176dd9e4e8fbf454ce00e09098b425c97c2732fd6b6b487a695da439dbe8fbccc6501314a8554ebd18e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09be28fa91473291867658d34a6925db79f038e8bd72a18505df7467ce313ae0f45046041841dbfbedcaaeca4ab5a9c91d09964067a90147e04dc5ec91ad9d62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/67ffbd33cb1c3d3954d8e0da3a77ff80f46c3b871898be67d1d8694675b9b8204f2693d6a2dddda23625fe4a90457c46f387dc722240a537592ef8a1b08e4795"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 01:55:27.233333) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 01:55:27.233718) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465545577.858881-819011169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 01:55:27.317711) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 01:55:27.318119) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 01:55:27.318449) ========= ========= Total master_lag: 0.22 =========