builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1465553841.44 results: success (0) buildid: 20160610024929 builduid: d2c4356b9e1943cc98e2dc6983467cc0 revision: ce7f534b25804ed865a146882e1bc12670c69e87 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.444540) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.444999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.445631) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.510262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.510527) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 03:17:21-- 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% 46.3M=0s 2016-06-10 03:17:22 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187889 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.721431) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.721726) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021419 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.771237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:21.771656) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ce7f534b25804ed865a146882e1bc12670c69e87 --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 ce7f534b25804ed865a146882e1bc12670c69e87 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 03:17:22,250 truncating revision to first 12 chars 2016-06-10 03:17:22,251 Setting DEBUG logging. 2016-06-10 03:17:22,251 attempt 1/10 2016-06-10 03:17:22,251 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ce7f534b2580?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 03:17:22,586 unpacking tar archive at: fx-team-ce7f534b2580/testing/mozharness/ program finished with exit code 0 elapsedTime=0.691695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:22.478856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:22.479436) ========= script_repo_revision: ce7f534b25804ed865a146882e1bc12670c69e87 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:22.480065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:22.480891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 03:17:22.491494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-10 03:17:22.491820) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:17:23 INFO - MultiFileLogger online at 20160610 03:17:23 in /builds/slave/test 03:17:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 03:17:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:17:23 INFO - {'append_to_log': False, 03:17:23 INFO - 'base_work_dir': '/builds/slave/test', 03:17:23 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:17:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:17:23 INFO - 'branch': 'Fx-Team-Non-PGO', 03:17:23 INFO - 'buildbot_json_path': 'buildprops.json', 03:17:23 INFO - 'config_files': ('talos/linux_config.py',), 03:17:23 INFO - 'default_actions': ('clobber', 03:17:23 INFO - 'read-buildbot-config', 03:17:23 INFO - 'download-and-extract', 03:17:23 INFO - 'populate-webroot', 03:17:23 INFO - 'create-virtualenv', 03:17:23 INFO - 'install', 03:17:23 INFO - 'run-tests'), 03:17:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:17:23 INFO - 'download_minidump_stackwalk': True, 03:17:23 INFO - 'download_symbols': 'ondemand', 03:17:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:17:23 INFO - 'tooltool.py': '/tools/tooltool.py', 03:17:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:17:23 INFO - '/tools/misc-python/virtualenv.py')}, 03:17:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:17:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:17:23 INFO - 'installer_path': 'installer.exe', 03:17:23 INFO - 'log_level': 'info', 03:17:23 INFO - 'log_name': 'talos', 03:17:23 INFO - 'log_to_console': True, 03:17:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:17:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:17:23 INFO - 'opt_config_files': (), 03:17:23 INFO - 'pip_index': False, 03:17:23 INFO - 'sps_profile': False, 03:17:23 INFO - 'sps_profile_interval': 0, 03:17:23 INFO - 'suite': 'dromaeojs', 03:17:23 INFO - 'system_bits': '32', 03:17:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:17:23 INFO - 'title': 'talos-linux64-ix-041', 03:17:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:17:23 INFO - 'use_talos_json': True, 03:17:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:17:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:17:23 INFO - 'work_dir': 'build'} 03:17:23 INFO - ##### 03:17:23 INFO - ##### Running clobber step. 03:17:23 INFO - ##### 03:17:23 INFO - Running pre-action listener: _resource_record_pre_action 03:17:23 INFO - Running main action method: clobber 03:17:23 INFO - rmtree: /builds/slave/test/build 03:17:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:17:23 INFO - Running post-action listener: _resource_record_post_action 03:17:23 INFO - ##### 03:17:23 INFO - ##### Finished clobber step (success) 03:17:23 INFO - ##### 03:17:23 INFO - ##### 03:17:23 INFO - ##### Running read-buildbot-config step. 03:17:23 INFO - ##### 03:17:23 INFO - Running pre-action listener: _resource_record_pre_action 03:17:23 INFO - Running main action method: read_buildbot_config 03:17:23 INFO - Using buildbot properties: 03:17:23 INFO - { 03:17:23 INFO - "project": "", 03:17:23 INFO - "product": "firefox", 03:17:23 INFO - "script_repo_revision": "production", 03:17:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:17:23 INFO - "repository": "", 03:17:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:17:23 INFO - "buildid": "20160610024929", 03:17:23 INFO - "pgo_build": "False", 03:17:23 INFO - "basedir": "/builds/slave/test", 03:17:23 INFO - "buildnumber": 1762, 03:17:23 INFO - "slavename": "talos-linux64-ix-041", 03:17:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:17:23 INFO - "platform": "ubuntu64_hw", 03:17:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:17:23 INFO - "branch": "fx-team", 03:17:23 INFO - "repo_path": "integration/fx-team", 03:17:23 INFO - "revision": "ce7f534b25804ed865a146882e1bc12670c69e87", 03:17:23 INFO - "stage_platform": "linux64", 03:17:23 INFO - "builduid": "d2c4356b9e1943cc98e2dc6983467cc0", 03:17:23 INFO - "slavebuilddir": "test" 03:17:23 INFO - } 03:17:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:17:23 INFO - Running post-action listener: _resource_record_post_action 03:17:23 INFO - ##### 03:17:23 INFO - ##### Finished read-buildbot-config step (success) 03:17:23 INFO - ##### 03:17:23 INFO - ##### 03:17:23 INFO - ##### Running download-and-extract step. 03:17:23 INFO - ##### 03:17:23 INFO - Running pre-action listener: _resource_record_pre_action 03:17:23 INFO - Running main action method: download_and_extract 03:17:23 INFO - mkdir: /builds/slave/test/build/tests 03:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:23 INFO - https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:17:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:17:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:17:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:26 INFO - Downloaded 1361 bytes. 03:17:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:17:26 INFO - Using the following test package requirements: 03:17:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:17:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:17:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:17:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:26 INFO - u'jsshell-linux-x86_64.zip'], 03:17:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:17:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:17:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:17:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:17:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:17:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:17:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:26 INFO - https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:17:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:17:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:17:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:27 INFO - Downloaded 22879604 bytes. 03:17:27 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'] 03:17:27 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 03:17:29 INFO - Return code: 0 03:17:29 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 03:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:29 INFO - https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:17:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:17:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:17:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:30 INFO - Downloaded 22879604 bytes. 03:17:30 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'] 03:17:30 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 03:17:31 INFO - Return code: 0 03:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:31 INFO - https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:17:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:17:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:17:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:33 INFO - Downloaded 10833377 bytes. 03:17:33 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'] 03:17:33 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 03:17:33 INFO - Return code: 0 03:17:33 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')]} 03:17:33 INFO - https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:17:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:17:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:17:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjSics3XQ1CG3fnOU-MDcg/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 03:17:35 INFO - Downloaded 55379646 bytes. 03:17:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:17:35 INFO - mkdir: /builds/slave/test/properties 03:17:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:17:35 INFO - Writing to file /builds/slave/test/properties/build_url 03:17:35 INFO - Contents: 03:17:35 INFO - build_url:https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:17:36 INFO - Running post-action listener: _resource_record_post_action 03:17:36 INFO - Running post-action listener: set_extra_try_arguments 03:17:36 INFO - ##### 03:17:36 INFO - ##### Finished download-and-extract step (success) 03:17:36 INFO - ##### 03:17:36 INFO - ##### 03:17:36 INFO - ##### Running populate-webroot step. 03:17:36 INFO - ##### 03:17:36 INFO - Running pre-action listener: _resource_record_pre_action 03:17:36 INFO - Running main action method: populate_webroot 03:17:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:17:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:17:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:17:36 INFO - '--tppagecycles', 03:17:36 INFO - '7'], 03:17:36 INFO - 'tests': ['tsvgm']}}, 03:17:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:17:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:17:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:17:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:17:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:17:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:17:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:36 INFO - 'talos_options': ['--disable-e10s'], 03:17:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:36 INFO - 'talos_options': ['--disable-e10s'], 03:17:36 INFO - 'tests': ['damp', 'tps']}, 03:17:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:36 INFO - 'tests': ['damp', 'tps']}, 03:17:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:17:36 INFO - 'tests': ['dromaeo_dom']}, 03:17:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:17:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:17:36 INFO - 'tests': ['a11yr', 03:17:36 INFO - 'ts_paint', 03:17:36 INFO - 'tpaint', 03:17:36 INFO - 'sessionrestore', 03:17:36 INFO - 'sessionrestore_no_auto_restore', 03:17:36 INFO - 'tabpaint']}, 03:17:36 INFO - 'other-e10s': {'tests': ['a11yr', 03:17:36 INFO - 'ts_paint', 03:17:36 INFO - 'tpaint', 03:17:36 INFO - 'sessionrestore', 03:17:36 INFO - 'sessionrestore_no_auto_restore', 03:17:36 INFO - 'tabpaint']}, 03:17:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:17:36 INFO - 'ts_paint', 03:17:36 INFO - 'tpaint', 03:17:36 INFO - 'sessionrestore', 03:17:36 INFO - 'sessionrestore_no_auto_restore', 03:17:36 INFO - 'tabpaint']}, 03:17:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:17:36 INFO - 'ts_paint', 03:17:36 INFO - 'tpaint', 03:17:36 INFO - 'sessionrestore', 03:17:36 INFO - 'sessionrestore_no_auto_restore', 03:17:36 INFO - 'tabpaint']}, 03:17:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:17:36 INFO - 'tests': ['a11yr', 03:17:36 INFO - 'ts_paint', 03:17:36 INFO - 'tpaint', 03:17:36 INFO - 'sessionrestore', 03:17:36 INFO - 'sessionrestore_no_auto_restore', 03:17:36 INFO - 'tabpaint']}, 03:17:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:17:36 INFO - 'tests': ['a11yr', 03:17:36 INFO - 'ts_paint', 03:17:36 INFO - 'tpaint', 03:17:36 INFO - 'sessionrestore', 03:17:36 INFO - 'sessionrestore_no_auto_restore', 03:17:36 INFO - 'tabpaint']}, 03:17:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:17:36 INFO - 'tests': ['tsvgx', 03:17:36 INFO - 'tsvgr_opacity', 03:17:36 INFO - 'tart', 03:17:36 INFO - 'tscrollx', 03:17:36 INFO - 'cart']}, 03:17:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:17:36 INFO - 'tsvgr_opacity', 03:17:36 INFO - 'tart', 03:17:36 INFO - 'tscrollx', 03:17:36 INFO - 'cart']}, 03:17:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:36 INFO - 'talos_options': ['--disable-e10s'], 03:17:36 INFO - 'tests': ['tp5o']}, 03:17:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:36 INFO - 'tests': ['tp5o']}, 03:17:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:36 INFO - 'talos_options': ['--disable-e10s', 03:17:36 INFO - '--xperf_path', 03:17:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:36 INFO - 'tests': ['tp5n']}, 03:17:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:36 INFO - 'talos_options': ['--xperf_path', 03:17:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:36 INFO - 'tests': ['tp5n']}}, 03:17:36 INFO - 'talos.zip': {'path': '', 03:17:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:17:36 INFO - Running post-action listener: _resource_record_post_action 03:17:36 INFO - ##### 03:17:36 INFO - ##### Finished populate-webroot step (success) 03:17:36 INFO - ##### 03:17:36 INFO - ##### 03:17:36 INFO - ##### Running create-virtualenv step. 03:17:36 INFO - ##### 03:17:36 INFO - Running pre-action listener: _resource_record_pre_action 03:17:36 INFO - Running main action method: create_virtualenv 03:17:36 INFO - Creating virtualenv /builds/slave/test/build/venv 03:17:36 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 03:17:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:17:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:17:36 INFO - Using real prefix '/usr' 03:17:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:17:37 INFO - Installing distribute.............................................................................................................................................................................................done. 03:17:39 INFO - Installing pip.................done. 03:17:39 INFO - Return code: 0 03:17:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:17: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')]} 03:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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')]} 03:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:39 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 0x7f28ba410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe762e0>, '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 0xde2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde25d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', '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 03:17:39 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 03:17:39 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 03:17:39 INFO - Using env: {'DISPLAY': ':0', 03:17:39 INFO - 'HOME': '/home/cltbld', 03:17:39 INFO - 'LANG': 'en_US.UTF-8', 03:17:39 INFO - 'LANGUAGE': 'en_US:en', 03:17:39 INFO - 'LOGNAME': 'cltbld', 03:17:39 INFO - 'MAIL': '/var/mail/cltbld', 03:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:39 INFO - 'MOZ_NO_REMOTE': '1', 03:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:39 INFO - 'NO_EM_RESTART': '1', 03:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:39 INFO - 'PWD': '/builds/slave/test', 03:17:39 INFO - 'SHELL': '/bin/bash', 03:17:39 INFO - 'SHLVL': '1', 03:17:39 INFO - 'TERM': 'linux', 03:17:39 INFO - 'TMOUT': '86400', 03:17:39 INFO - 'USER': 'cltbld', 03:17:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', 03:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:39 INFO - '_': '/tools/buildbot/bin/python'} 03:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:39 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 03:17:39 INFO - Cleaning up... 03:17:39 INFO - Return code: 0 03:17:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:17: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')]} 03:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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')]} 03:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:39 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 0x7f28ba410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe762e0>, '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 0xde2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde25d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', '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 03:17:39 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 03:17:39 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 03:17:39 INFO - Using env: {'DISPLAY': ':0', 03:17:39 INFO - 'HOME': '/home/cltbld', 03:17:39 INFO - 'LANG': 'en_US.UTF-8', 03:17:39 INFO - 'LANGUAGE': 'en_US:en', 03:17:39 INFO - 'LOGNAME': 'cltbld', 03:17:39 INFO - 'MAIL': '/var/mail/cltbld', 03:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:39 INFO - 'MOZ_NO_REMOTE': '1', 03:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:39 INFO - 'NO_EM_RESTART': '1', 03:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:39 INFO - 'PWD': '/builds/slave/test', 03:17:39 INFO - 'SHELL': '/bin/bash', 03:17:39 INFO - 'SHLVL': '1', 03:17:39 INFO - 'TERM': 'linux', 03:17:39 INFO - 'TMOUT': '86400', 03:17:39 INFO - 'USER': 'cltbld', 03:17:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', 03:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:39 INFO - '_': '/tools/buildbot/bin/python'} 03:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:39 INFO - Downloading/unpacking psutil>=3.1.1 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:17:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:41 INFO - Installing collected packages: psutil 03:17:41 INFO - Running setup.py install for psutil 03:17:41 INFO - building 'psutil._psutil_linux' extension 03:17:41 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 03:17:41 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 03:17:41 INFO - building 'psutil._psutil_posix' extension 03:17:41 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 03:17:42 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 03:17:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:42 INFO - Successfully installed psutil 03:17:42 INFO - Cleaning up... 03:17:42 INFO - Return code: 0 03:17:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:42 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 0x7f28ba410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe762e0>, '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 0xde2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde25d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', '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 03:17:42 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 03:17:42 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 03:17:42 INFO - Using env: {'DISPLAY': ':0', 03:17:42 INFO - 'HOME': '/home/cltbld', 03:17:42 INFO - 'LANG': 'en_US.UTF-8', 03:17:42 INFO - 'LANGUAGE': 'en_US:en', 03:17:42 INFO - 'LOGNAME': 'cltbld', 03:17:42 INFO - 'MAIL': '/var/mail/cltbld', 03:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:42 INFO - 'MOZ_NO_REMOTE': '1', 03:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:42 INFO - 'NO_EM_RESTART': '1', 03:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:42 INFO - 'PWD': '/builds/slave/test', 03:17:42 INFO - 'SHELL': '/bin/bash', 03:17:42 INFO - 'SHLVL': '1', 03:17:42 INFO - 'TERM': 'linux', 03:17:42 INFO - 'TMOUT': '86400', 03:17:42 INFO - 'USER': 'cltbld', 03:17:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', 03:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:42 INFO - '_': '/tools/buildbot/bin/python'} 03:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:17:44 INFO - Installing collected packages: mozsystemmonitor 03:17:44 INFO - Running setup.py install for mozsystemmonitor 03:17:44 INFO - Successfully installed mozsystemmonitor 03:17:44 INFO - Cleaning up... 03:17:44 INFO - Return code: 0 03:17:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:17:44 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')]} 03:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:44 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')]} 03:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:44 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 0x7f28ba410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe762e0>, '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 0xde2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde25d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', '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 03:17:44 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 03:17:44 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 03:17:44 INFO - Using env: {'DISPLAY': ':0', 03:17:44 INFO - 'HOME': '/home/cltbld', 03:17:44 INFO - 'LANG': 'en_US.UTF-8', 03:17:44 INFO - 'LANGUAGE': 'en_US:en', 03:17:44 INFO - 'LOGNAME': 'cltbld', 03:17:44 INFO - 'MAIL': '/var/mail/cltbld', 03:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:44 INFO - 'MOZ_NO_REMOTE': '1', 03:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:44 INFO - 'NO_EM_RESTART': '1', 03:17:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:44 INFO - 'PWD': '/builds/slave/test', 03:17:44 INFO - 'SHELL': '/bin/bash', 03:17:44 INFO - 'SHLVL': '1', 03:17:44 INFO - 'TERM': 'linux', 03:17:44 INFO - 'TMOUT': '86400', 03:17:44 INFO - 'USER': 'cltbld', 03:17:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', 03:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:44 INFO - '_': '/tools/buildbot/bin/python'} 03:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:44 INFO - Downloading/unpacking jsonschema==2.5.1 03:17:44 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 03:17:44 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 03:17:44 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 03:17:44 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 03:17:44 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 03:17:44 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 03:17:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:17:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:17:46 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 03:17:46 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 03:17:46 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 03:17:46 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 03:17:46 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 03:17:46 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 03:17:46 INFO - Downloading functools32-3.2.3-2.tar.gz 03:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:17:46 INFO - warning: no files found matching '*.txt' 03:17:46 INFO - no previously-included directories found matching 'build' 03:17:46 INFO - no previously-included directories found matching 'dist' 03:17:46 INFO - no previously-included directories found matching '.git*' 03:17:46 INFO - Installing collected packages: jsonschema, functools32 03:17:46 INFO - Running setup.py install for functools32 03:17:47 INFO - warning: no files found matching '*.txt' 03:17:47 INFO - no previously-included directories found matching 'build' 03:17:47 INFO - no previously-included directories found matching 'dist' 03:17:47 INFO - no previously-included directories found matching '.git*' 03:17:47 INFO - Successfully installed jsonschema functools32 03:17:47 INFO - Cleaning up... 03:17:47 INFO - Return code: 0 03:17:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:17:47 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')]} 03:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:47 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')]} 03:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:47 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 0x7f28ba410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe762e0>, '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 0xde2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde25d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', '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 03:17:47 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 03:17:47 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 03:17:47 INFO - Using env: {'DISPLAY': ':0', 03:17:47 INFO - 'HOME': '/home/cltbld', 03:17:47 INFO - 'LANG': 'en_US.UTF-8', 03:17:47 INFO - 'LANGUAGE': 'en_US:en', 03:17:47 INFO - 'LOGNAME': 'cltbld', 03:17:47 INFO - 'MAIL': '/var/mail/cltbld', 03:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:47 INFO - 'MOZ_NO_REMOTE': '1', 03:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:47 INFO - 'NO_EM_RESTART': '1', 03:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:47 INFO - 'PWD': '/builds/slave/test', 03:17:47 INFO - 'SHELL': '/bin/bash', 03:17:47 INFO - 'SHLVL': '1', 03:17:47 INFO - 'TERM': 'linux', 03:17:47 INFO - 'TMOUT': '86400', 03:17:47 INFO - 'USER': 'cltbld', 03:17:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', 03:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:47 INFO - '_': '/tools/buildbot/bin/python'} 03:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:47 INFO - Downloading/unpacking blobuploader==1.2.4 03:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:49 INFO - Downloading blobuploader-1.2.4.tar.gz 03:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:17:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:17:49 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 03:17:49 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 03:17:49 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 03:17:49 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 03:17:49 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 03:17:49 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 03:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:17:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:17:49 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 03:17:49 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 03:17:49 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 03:17:49 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 03:17:49 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 03:17:49 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 03:17:49 INFO - Downloading docopt-0.6.1.tar.gz 03:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:17:49 INFO - Installing collected packages: blobuploader, requests, docopt 03:17:49 INFO - Running setup.py install for blobuploader 03:17:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:17:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:17:50 INFO - Running setup.py install for requests 03:17:50 INFO - Running setup.py install for docopt 03:17:50 INFO - Successfully installed blobuploader requests docopt 03:17:50 INFO - Cleaning up... 03:17:50 INFO - Return code: 0 03:17:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17: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')]} 03:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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')]} 03:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:50 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 0x7f28ba410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe762e0>, '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 0xde2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde25d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', '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 03:17:50 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 03:17:50 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 03:17:50 INFO - Using env: {'DISPLAY': ':0', 03:17:50 INFO - 'HOME': '/home/cltbld', 03:17:50 INFO - 'LANG': 'en_US.UTF-8', 03:17:50 INFO - 'LANGUAGE': 'en_US:en', 03:17:50 INFO - 'LOGNAME': 'cltbld', 03:17:50 INFO - 'MAIL': '/var/mail/cltbld', 03:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:50 INFO - 'MOZ_NO_REMOTE': '1', 03:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:50 INFO - 'NO_EM_RESTART': '1', 03:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:50 INFO - 'PWD': '/builds/slave/test', 03:17:50 INFO - 'SHELL': '/bin/bash', 03:17:50 INFO - 'SHLVL': '1', 03:17:50 INFO - 'TERM': 'linux', 03:17:50 INFO - 'TMOUT': '86400', 03:17:50 INFO - 'USER': 'cltbld', 03:17:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', 03:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:50 INFO - '_': '/tools/buildbot/bin/python'} 03:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:50 INFO - Running setup.py (path:/tmp/pip-g9PwFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:50 INFO - Running setup.py (path:/tmp/pip-mdYSIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:50 INFO - Running setup.py (path:/tmp/pip-WjeCkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:51 INFO - Running setup.py (path:/tmp/pip-j_mrjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:51 INFO - Running setup.py (path:/tmp/pip-SSkRJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:51 INFO - Running setup.py (path:/tmp/pip-6qNJTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:51 INFO - Running setup.py (path:/tmp/pip-_P2pJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:51 INFO - Running setup.py (path:/tmp/pip-QC_RT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:51 INFO - Running setup.py (path:/tmp/pip-i6EQIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:51 INFO - Running setup.py (path:/tmp/pip-48ZcM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:51 INFO - Running setup.py (path:/tmp/pip-xn8z2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:51 INFO - Running setup.py (path:/tmp/pip-vr6mmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:51 INFO - Running setup.py (path:/tmp/pip-FZzwBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:51 INFO - Running setup.py (path:/tmp/pip-XmB2ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:51 INFO - Running setup.py (path:/tmp/pip-YaTHU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:51 INFO - Running setup.py (path:/tmp/pip-TvC16J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:51 INFO - Running setup.py (path:/tmp/pip-1L3wEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:17:52 INFO - Running setup.py install for manifestparser 03:17:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Running setup.py install for mozcrash 03:17:52 INFO - Running setup.py install for mozdebug 03:17:52 INFO - Running setup.py install for mozdevice 03:17:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Running setup.py install for mozfile 03:17:52 INFO - Running setup.py install for mozhttpd 03:17:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Running setup.py install for mozinfo 03:17:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Running setup.py install for mozInstall 03:17:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:17:52 INFO - Running setup.py install for mozleak 03:17:52 INFO - Running setup.py install for mozlog 03:17:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:17:53 INFO - Running setup.py install for moznetwork 03:17:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:17:53 INFO - Running setup.py install for mozprocess 03:17:53 INFO - Running setup.py install for mozprofile 03:17:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:17:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:17:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:17:53 INFO - Running setup.py install for mozrunner 03:17:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:17:53 INFO - Running setup.py install for mozscreenshot 03:17:53 INFO - Running setup.py install for moztest 03:17:53 INFO - Running setup.py install for mozversion 03:17:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:17:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:17:53 INFO - Cleaning up... 03:17:53 INFO - Return code: 0 03:17:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17: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')]} 03:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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')]} 03:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:53 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 0x7f28ba410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe762e0>, '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 0xde2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde25d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', '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 03:17:53 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 03:17:53 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 03:17:53 INFO - Using env: {'DISPLAY': ':0', 03:17:53 INFO - 'HOME': '/home/cltbld', 03:17:53 INFO - 'LANG': 'en_US.UTF-8', 03:17:53 INFO - 'LANGUAGE': 'en_US:en', 03:17:53 INFO - 'LOGNAME': 'cltbld', 03:17:53 INFO - 'MAIL': '/var/mail/cltbld', 03:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:53 INFO - 'MOZ_NO_REMOTE': '1', 03:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:53 INFO - 'NO_EM_RESTART': '1', 03:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:53 INFO - 'PWD': '/builds/slave/test', 03:17:53 INFO - 'SHELL': '/bin/bash', 03:17:53 INFO - 'SHLVL': '1', 03:17:53 INFO - 'TERM': 'linux', 03:17:53 INFO - 'TMOUT': '86400', 03:17:53 INFO - 'USER': 'cltbld', 03:17:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', 03:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:53 INFO - '_': '/tools/buildbot/bin/python'} 03:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:54 INFO - Running setup.py (path:/tmp/pip-vO55EQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:54 INFO - Running setup.py (path:/tmp/pip-mUrtE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:54 INFO - Running setup.py (path:/tmp/pip-nOLbRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:54 INFO - Running setup.py (path:/tmp/pip-qGpsYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:54 INFO - Running setup.py (path:/tmp/pip-YUkuAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:54 INFO - Running setup.py (path:/tmp/pip-Y4T99L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:54 INFO - Running setup.py (path:/tmp/pip-DtvhVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:54 INFO - Running setup.py (path:/tmp/pip-MGr9V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:54 INFO - Running setup.py (path:/tmp/pip-9THHXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:54 INFO - Running setup.py (path:/tmp/pip-utgB16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:54 INFO - Running setup.py (path:/tmp/pip-bg1r5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:54 INFO - Running setup.py (path:/tmp/pip-ELXSo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:54 INFO - Running setup.py (path:/tmp/pip-Vvr8x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:54 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)) 03:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:55 INFO - Running setup.py (path:/tmp/pip-U5FGMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:55 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)) 03:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:55 INFO - Running setup.py (path:/tmp/pip-jVumB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:55 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)) 03:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:55 INFO - Running setup.py (path:/tmp/pip-Fjiuoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:55 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)) 03:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:55 INFO - Running setup.py (path:/tmp/pip-TeMmL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:55 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)) 03:17:55 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)) 03:17:55 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)) 03:17:55 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)) 03:17:55 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)) 03:17:55 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)) 03:17:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:17:55 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 03:17:55 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 03:17:55 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 03:17:55 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 03:17:55 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 03:17:55 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 03:17:57 INFO - Downloading blessings-1.6.tar.gz 03:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:17:57 INFO - Installing collected packages: blessings 03:17:57 INFO - Running setup.py install for blessings 03:17:57 INFO - Successfully installed blessings 03:17:57 INFO - Cleaning up... 03:17:57 INFO - Return code: 0 03:17:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:57 INFO - Reading from file tmpfile_stdout 03:17:57 INFO - Current package versions: 03:17:57 INFO - argparse == 1.2.1 03:17:57 INFO - blessings == 1.6 03:17:57 INFO - blobuploader == 1.2.4 03:17:57 INFO - docopt == 0.6.1 03:17:57 INFO - functools32 == 3.2.3-2 03:17:57 INFO - jsonschema == 2.5.1 03:17:57 INFO - manifestparser == 1.1 03:17:57 INFO - mozInstall == 1.12 03:17:57 INFO - mozcrash == 0.17 03:17:57 INFO - mozdebug == 0.1 03:17:57 INFO - mozdevice == 0.48 03:17:57 INFO - mozfile == 1.2 03:17:57 INFO - mozhttpd == 0.7 03:17:57 INFO - mozinfo == 0.9 03:17:57 INFO - mozleak == 0.1 03:17:57 INFO - mozlog == 3.2 03:17:57 INFO - moznetwork == 0.27 03:17:57 INFO - mozprocess == 0.22 03:17:57 INFO - mozprofile == 0.28 03:17:57 INFO - mozrunner == 6.11 03:17:57 INFO - mozscreenshot == 0.1 03:17:57 INFO - mozsystemmonitor == 0.3 03:17:57 INFO - moztest == 0.7 03:17:57 INFO - mozversion == 1.4 03:17:57 INFO - psutil == 3.1.1 03:17:57 INFO - requests == 1.2.3 03:17:57 INFO - wsgiref == 0.1.2 03:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:57 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')]} 03:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:57 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')]} 03:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:57 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 0x7f28ba410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe762e0>, '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 0xde2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde25d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', '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 03:17:57 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 03:17:57 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 03:17:57 INFO - Using env: {'DISPLAY': ':0', 03:17:57 INFO - 'HOME': '/home/cltbld', 03:17:57 INFO - 'LANG': 'en_US.UTF-8', 03:17:57 INFO - 'LANGUAGE': 'en_US:en', 03:17:57 INFO - 'LOGNAME': 'cltbld', 03:17:57 INFO - 'MAIL': '/var/mail/cltbld', 03:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:57 INFO - 'MOZ_NO_REMOTE': '1', 03:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:57 INFO - 'NO_EM_RESTART': '1', 03:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:57 INFO - 'PWD': '/builds/slave/test', 03:17:57 INFO - 'SHELL': '/bin/bash', 03:17:57 INFO - 'SHLVL': '1', 03:17:57 INFO - 'TERM': 'linux', 03:17:57 INFO - 'TMOUT': '86400', 03:17:57 INFO - 'USER': 'cltbld', 03:17:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', 03:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:57 INFO - '_': '/tools/buildbot/bin/python'} 03:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:57 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)) 03:17:57 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)) 03:17:57 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)) 03:17:57 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)) 03:17:57 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)) 03:17:57 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)) 03:17:57 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)) 03:17:57 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)) 03:17:57 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)) 03:17:57 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)) 03:17:57 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)) 03:17:57 INFO - Cleaning up... 03:17:57 INFO - Return code: 0 03:17:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:17:57 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')]} 03:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:57 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')]} 03:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:57 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 0x7f28ba410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe762e0>, '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 0xde2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde25d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', '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 03:17:57 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 03:17:57 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 03:17:57 INFO - Using env: {'DISPLAY': ':0', 03:17:57 INFO - 'HOME': '/home/cltbld', 03:17:57 INFO - 'LANG': 'en_US.UTF-8', 03:17:57 INFO - 'LANGUAGE': 'en_US:en', 03:17:57 INFO - 'LOGNAME': 'cltbld', 03:17:57 INFO - 'MAIL': '/var/mail/cltbld', 03:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:57 INFO - 'MOZ_NO_REMOTE': '1', 03:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:57 INFO - 'NO_EM_RESTART': '1', 03:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:57 INFO - 'PWD': '/builds/slave/test', 03:17:57 INFO - 'SHELL': '/bin/bash', 03:17:57 INFO - 'SHLVL': '1', 03:17:57 INFO - 'TERM': 'linux', 03:17:57 INFO - 'TMOUT': '86400', 03:17:57 INFO - 'USER': 'cltbld', 03:17:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', 03:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:57 INFO - '_': '/tools/buildbot/bin/python'} 03:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:17:58 INFO - Cleaning up... 03:17:58 INFO - Return code: 0 03:17:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:17:58 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')]} 03:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:58 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')]} 03:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:58 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 0x7f28ba410f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe762e0>, '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 0xde2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde25d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', '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 03:17:58 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 03:17:58 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 03:17:58 INFO - Using env: {'DISPLAY': ':0', 03:17:58 INFO - 'HOME': '/home/cltbld', 03:17:58 INFO - 'LANG': 'en_US.UTF-8', 03:17:58 INFO - 'LANGUAGE': 'en_US:en', 03:17:58 INFO - 'LOGNAME': 'cltbld', 03:17:58 INFO - 'MAIL': '/var/mail/cltbld', 03:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:58 INFO - 'MOZ_NO_REMOTE': '1', 03:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:58 INFO - 'NO_EM_RESTART': '1', 03:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:58 INFO - 'PWD': '/builds/slave/test', 03:17:58 INFO - 'SHELL': '/bin/bash', 03:17:58 INFO - 'SHLVL': '1', 03:17:58 INFO - 'TERM': 'linux', 03:17:58 INFO - 'TMOUT': '86400', 03:17:58 INFO - 'USER': 'cltbld', 03:17:58 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', 03:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:58 INFO - '_': '/tools/buildbot/bin/python'} 03:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:58 INFO - Downloading/unpacking flake8 03:17:58 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 03:17:58 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 03:17:58 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 03:17:58 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 03:17:58 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 03:17:58 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 03:18:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:18:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:18:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:18:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:18:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:18:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:18:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:18:00 INFO - no previously-included directories found matching 'docs/_build' 03:18:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:18:00 INFO - Running setup.py install for pep8 03:18:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:18:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:18:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:18:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:18:01 INFO - no previously-included directories found matching 'docs/_build' 03:18:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:18:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:18:01 INFO - Cleaning up... 03:18:01 INFO - Return code: 0 03:18:01 INFO - Running post-action listener: _resource_record_post_action 03:18:01 INFO - Running post-action listener: _start_resource_monitoring 03:18:01 INFO - Starting resource monitoring. 03:18:01 INFO - ##### 03:18:01 INFO - ##### Finished create-virtualenv step (success) 03:18:01 INFO - ##### 03:18:01 INFO - ##### 03:18:01 INFO - ##### Running install step. 03:18:01 INFO - ##### 03:18:01 INFO - Running pre-action listener: _resource_record_pre_action 03:18:01 INFO - Running main action method: install 03:18:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:01 INFO - Reading from file tmpfile_stdout 03:18:01 INFO - Detecting whether we're running mozinstall >=1.0... 03:18:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:18:01 INFO - Reading from file tmpfile_stdout 03:18:01 INFO - Output received: 03:18:01 INFO - Usage: mozinstall [options] installer 03:18:01 INFO - Options: 03:18:01 INFO - -h, --help show this help message and exit 03:18:01 INFO - -d DEST, --destination=DEST 03:18:01 INFO - Directory to install application into. [default: 03:18:01 INFO - "/builds/slave/test"] 03:18:01 INFO - --app=APP Application being installed. [default: firefox] 03:18:01 INFO - mkdir: /builds/slave/test/build/application 03:18:01 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'] 03:18:01 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 03:18:17 INFO - Reading from file tmpfile_stdout 03:18:17 INFO - Output received: 03:18:17 INFO - /builds/slave/test/build/application/firefox/firefox 03:18:17 INFO - Running post-action listener: _resource_record_post_action 03:18:17 INFO - ##### 03:18:17 INFO - ##### Finished install step (success) 03:18:17 INFO - ##### 03:18:17 INFO - ##### 03:18:17 INFO - ##### Running run-tests step. 03:18:17 INFO - ##### 03:18:17 INFO - Running pre-action listener: _resource_record_pre_action 03:18:17 INFO - Running main action method: run_tests 03:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:18:17 INFO - Python 2.7.3 03:18:17 INFO - Return code: 0 03:18:17 INFO - grabbing minidump binary from tooltool 03:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:17 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 0xe762e0>, '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 0xde2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde25d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:18:17 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 03:18:17 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 03:18:17 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 03:18:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:18:17 INFO - Return code: 0 03:18:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:18:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:18:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:18:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:18:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:18:18 INFO - Return code: 0 03:18:18 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:18:18 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:18:18 INFO - Using env: {'DISPLAY': ':0', 03:18:18 INFO - 'HOME': '/home/cltbld', 03:18:18 INFO - 'LANG': 'en_US.UTF-8', 03:18:18 INFO - 'LANGUAGE': 'en_US:en', 03:18:18 INFO - 'LOGNAME': 'cltbld', 03:18:18 INFO - 'MAIL': '/var/mail/cltbld', 03:18:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:18:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:18 INFO - 'MOZ_NO_REMOTE': '1', 03:18:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:18 INFO - 'NO_EM_RESTART': '1', 03:18:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:18 INFO - 'PWD': '/builds/slave/test', 03:18:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:18:18 INFO - 'SHELL': '/bin/bash', 03:18:18 INFO - 'SHLVL': '1', 03:18:18 INFO - 'TERM': 'linux', 03:18:18 INFO - 'TMOUT': '86400', 03:18:18 INFO - 'USER': 'cltbld', 03:18:18 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587', 03:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:18 INFO - '_': '/tools/buildbot/bin/python'} 03:18:18 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:18:18 INFO - mozversion application_buildid: 20160610024929 03:18:18 INFO - mozversion application_changeset: ce7f534b25804ed865a146882e1bc12670c69e87 03:18:18 INFO - mozversion application_display_name: Nightly 03:18:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:18:18 INFO - mozversion application_name: Firefox 03:18:18 INFO - mozversion application_remotingname: firefox 03:18:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:18:18 INFO - mozversion application_vendor: Mozilla 03:18:18 INFO - mozversion application_version: 50.0a1 03:18:18 INFO - mozversion platform_buildid: 20160610024929 03:18:18 INFO - mozversion platform_changeset: ce7f534b25804ed865a146882e1bc12670c69e87 03:18:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:18:18 INFO - mozversion platform_version: 50.0a1 03:18:18 INFO - using testdate: 1465553898 03:18:18 INFO - actual date: 1465553898 03:18:18 INFO - starting webserver on 'localhost:57775' 03:18:18 INFO - SUITE-START | Running 2 tests 03:18:18 INFO - TEST-START | dromaeo_css 03:18:18 INFO - operating with platform_type : linux_ 03:18:18 INFO - Initialising browser for dromaeo_css test... 03:18:18 INFO - TEST-INFO | started process 16992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxhExHG/profile http://localhost:57775/getInfo.html) 03:18:23 INFO - PROCESS | 16992 | __metrics Screen width/height:1600/1200 03:18:23 INFO - PROCESS | 16992 | colorDepth:24 03:18:23 INFO - PROCESS | 16992 | Browser inner width/height: 1024/697 03:18:23 INFO - PROCESS | 16992 | __metrics 03:18:24 ERROR - PROCESS | 16992 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:18:24 INFO - PROCESS | 16992 | console.error: PushService: 03:18:24 INFO - PROCESS | 16992 | stateChangeProcessEnqueue: Error transitioning state 03:18:24 INFO - PROCESS | 16992 | UnknownError 03:18:25 INFO - TEST-INFO | 16992: exit 0 03:18:25 INFO - Browser initialized. 03:18:25 INFO - Running cycle 1/1 for dromaeo_css test... 03:18:25 INFO - TEST-INFO | started process 17075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxhExHG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:37 INFO - PROCESS | 17075 | RSS: Main: 175198208 03:18:37 INFO - PROCESS | 17075 | 03:19:29 INFO - PROCESS | 17075 | 1465553969208 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] 03:21:41 INFO - PROCESS | 17075 | Cycle 1(1): loaded http://localhost:57775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57775/tests/dromaeo/cssquery-ext.html) 03:21:42 INFO - PROCESS | 17075 | RSS: Main: 283492352 03:21:42 INFO - PROCESS | 17075 | 03:24:45 INFO - PROCESS | 17075 | Cycle 1(1): loaded http://localhost:57775/tests/dromaeo/cssquery-ext.html (next: http://localhost:57775/tests/dromaeo/cssquery-jquery.html) 03:24:45 INFO - PROCESS | 17075 | RSS: Main: 252284928 03:24:45 INFO - PROCESS | 17075 | 03:27:47 INFO - PROCESS | 17075 | Cycle 1(1): loaded http://localhost:57775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57775/tests/dromaeo/cssquery-mootools.html) 03:27:48 INFO - PROCESS | 17075 | RSS: Main: 252436480 03:27:48 INFO - PROCESS | 17075 | 03:30:50 INFO - PROCESS | 17075 | Cycle 1(1): loaded http://localhost:57775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57775/tests/dromaeo/cssquery-prototype.html) 03:30:51 INFO - PROCESS | 17075 | RSS: Main: 247533568 03:30:51 INFO - PROCESS | 17075 | 03:33:54 INFO - PROCESS | 17075 | Cycle 1(1): loaded http://localhost:57775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57775/tests/dromaeo/cssquery-yui.html) 03:33:55 INFO - PROCESS | 17075 | RSS: Main: 237211648 03:33:55 INFO - PROCESS | 17075 | 03:36:57 INFO - PROCESS | 17075 | Cycle 1(1): loaded http://localhost:57775/tests/dromaeo/cssquery-yui.html (next: http://localhost:57775/tests/dromaeo/cssquery-dojo.html) 03:36:58 INFO - PROCESS | 17075 | RSS: Main: 297345024 03:36:58 INFO - PROCESS | 17075 | 03:36:58 INFO - PROCESS | 17075 | __start_tp_report 03:36:58 INFO - PROCESS | 17075 | _x_x_mozilla_page_load 03:36:58 INFO - PROCESS | 17075 | _x_x_mozilla_page_load_details 03:36:58 INFO - PROCESS | 17075 | |i|pagename|runs| 03:36:58 INFO - PROCESS | 17075 | |0;dojo.html;2595;2602.1152808045263;2647.298465906535;2658.3354161459633;2662.2412612405456;4566.429196350457;4647.53524647536;4663.160631086403;4745.501722319154;4759.071980963713;4716.127516409458;4717.504662010482;4767.499412561683;4771.5944144747655;4822.3248745175615;4238.533761286256;4309.439772829535;4358.302671572549;4414.470263568376;4494.280915053592;4381.342798580206;4434.379186913835;4454.175977444183;4454.242778727624;4484.394606728099;4206.957930420687;4275.978620106879;4289.442372491588;4314.7411155330465;4336.9999999999845;4292.420523229386;4326.0266440051055;4332.025294308755;4333.046729719456;4352.847650332224;4338.43600331958;4367.323064924942;4368.257396242647;4370.694051416371;4419.049904270597;4727.810887564528;4776.952230477686;4780.450248221429;4784.306275590055;4789.521047895182;4881.633877459205;5051.6716413433005;5107.336046313955;5107.897842043139;5123.7438128093445;5158.613104017214;5174.611904107207;5176.0683077046115;5193.246979188034;5195.350581177353;4794;4794.496577859274;4794.712317260975;4806.591439727592;4838.322634831091;5006.74966251686;5222.947770522323;5256.92114618281;5302.337207849019;5361.27622770921;5049.040682270357;5135.820246291437;5137.691738495702;5141.074606570778;5142.280080788692;4950.678205916676;5180.48195180479;5182;5208.296879921238;5227.424983251839;4990.600751939909;5028.195488721787;5041.294218809369;5042.142835717937;5064.215046667772;5033.5469807716745;5039.118154322979;5039.4708555601865;5047.722375269322;5098.694078355311;4117.423560701504;4154.584541545822;4283.678724095706;4291.570842915684;4330.610245077958;3685.668289853926;3704.129529560551;3736.065983504124;3749.4938183345444;3767.2842159989514;4326.978365108154;4332.415123958225;4333.891652708708;4354.063876266555;4376.824927002948;4868.318435419044;5053.8736531587;5057.924131138036;5063.974680126576;5102.056119617882;4337.7397356158735;4373.234683930299;4389.034412429261;4401.889952751207;4436.844710435119;4583.770811459413;4606.930896036562;4607.9078418431445;4637.049404871993;4681.063787242565;4562.794674239601;4822.734749588806;4825.010872771144;4831.347768051268;4862.17343051682;4984.028114517634;5038.14351560243;5047.747612619428;5065.138926382598;5073.16292811682;4730.97634511839;4732.6687131900435;4746.0745154694505;4750.857474275777;4798.04039192156;4796.304535842213;4933.087378834927;4970.179920313252;4977.303177555073;5026.472220416804;5064.696118232918;5116.820911268088;5134.358205224347;5134.845954621367;5187.688738675692;4979.502049794992;4993.076280888047;4995.750212489288;4999.925001124913;5048.8990220194655;4689.343491911067;4852.975735121302;4854.126257273725;4974.552290293891;4994.725290109079;4849.95150048495;4876.975615121902;4879.194932836042;4915.95084049155;4926.901461970669;4964.627652925973;4965.875853103701;4975.203967365204;5008.6243531734535;5019.297298378157;4633.328167415773;4858.611311095033;4889.119958407521;4940.456549779593;4952.628552858478 03:36:58 INFO - PROCESS | 17075 | |1;ext.html;552.0530342040926;562.3167851060961;565.9688717120558;577.0536320434486;586.6216290492631;26550.86724566377;29112.85443572782;40156.397654035216;40955.18089638213;41004.179916401656;41265.793671031606;41630.791846040804;41765.582344176546;41778.373324400156;41795.373069403984;7846.333061689749;7934.603269836514;7995.720149794758;7997.920020799805;7998.760037198865;7547.54714717116;10073.798524029515;10314.278000539965;10315.43265120418;10661.680149595524;10485.633002844901;10620.840687389695;10639.255252132354;10639.627613033545;10639.840402393971;7612.8477430451085;10157.644482443078;10285;10372.688819335432;10375.84436233457;10006.849897251546;10408.271421000532;10411.479426028669;10411.947940260327;10419.583216671324;39380.21239575192;39718;39742.60257397418;39806.60193398087;39821;3041.726244637971;3080.614923134608;3212.180893872048;3235.4014507315987;3398.3543126805826;29651;29658.70341296581;29725.4466938711;29835.403291934257;29909.70090299091;3190.6171259448784;3206.070239630504;3212.357528494287;3248.058063161704;3267.460868956643;256631;257877;258807;260044;261190;29366.55950160749;29948.70051299459;52798;53335;53403.73298133485;32786.67213327884;32874.17814554607;32897.67102328994;32945.505817412755;32959;12631.621051368473;12706.237625742486;12706.9364653178;12710.237385756884;12741;10028.548715307828;10839.620613278497;10845.023947844575;11068.944655276671;11261.831072533918;7957.403194760416;7969.282764551218;8003.759887203393;8052.355811535063;8072.757817265491;3088.722015018659;3133.122725636825;3152.180433087414;3161.4941609342854;3161.668024857403;836.6695155413578;932.2728271947891;951.8334291499099;979.5249304087512;1007.7732510185297;27828.30429239285;28293.43413131767;28657.57013644797;28702.712972870006;28816.423671526452;943.8301105801022;955.4697143085515;966.5843687214565;980.2599037726613;1015.2334987084704;14801.851981480262;14891.776623350659;14959.775603365959;15110.244487775568;15310.540683779505;386248;388449;390381;390949;394369;50226.246606300934;50389.49610503848;50416.24375634368;50625.49374506208;50884.49115508872;1098.5441041967654;1187.857457105153;1204.482072708726;1229.827824104626;1235.6725467751232;27982.3004424891;28181.295467613472;28196.718032819408;29089.563656544746;29291;42521.36217956795;42572.36141457818;42928.57071429246;42971.14057718765;43012;291980;292389;292421;293197;294224;21781.23765668194;24466.388340290923;24859.378515537257;25086.121985730413;25169.24492265235;40778.59221407748;41079.58920410758;42079.57920420879;42192.36711449269;42804.78597606992;35658;35717.28565428625;36167;36553.45169822508;36624;35812.28375432529;36034.819825900704;36050.63949360473;36221;36260.81869590741;34956.47565286472;35532;35681.64318356783;36012.63987360093;36197.45703814392;31251.37497250088;32522.83738581292;32565.837170814943;32886.67113328932;32989.67010329866;24660.876695617124;25013.374665633506;25073.87463062673;25114.12100576471;25361.112361067273 03:36:58 INFO - PROCESS | 17075 | |2;jquery.html;356.4902189868488;361.55889814426405;362.4888906641636;370.1948262528999;380.7928865496376;15981;16706.24821883015;17229.396971106013;17242.741358879597;17249.74125388117;16114.516564503054;16274.511764647079;16589.91705041473;16623.168841557934;16803.32786688531;5023.472535383787;5165.431802501722;5242.397124330693;5245.921311180336;5258.605604579653;3102.1314032071054;3250.951235731466;5069.062223488648;5648.293963254593;5959.10613407988;5983.611065280743;5988.041913293874;6010.57925945184;6034.275886893579;6040.546958978072;5805.303363596353;5910.290765108193;5950.613210141327;6006.399360064002;6054.727537260812;2802.2574017885277;4872.4640289568115;5169.663971841818;5171.22431635254;5197.454267301917;20896.47758806027;20971.5805683887;21047.789522104737;21181.152753889826;21257.89371053135;1907.50404894727;1967.783543810194;1986.1261045140093;1987.6720341143694;2014.8891810950392;12423.75152496954;13215.273159976197;13358.332083395791;13407.865921340759;13882.722345553033;1697;1716.4764746752235;1730.4808557432846;1811.637672465499;1814.2561549764532;68197.31802681959;68425;69093.65453172702;69570.3042969574;71091;8492.919234787516;8976.775580610407;9245.861312080324;9786.608535658635;9873.062059104373;12734.172278801849;12798.424070916832;12828.935855320664;12895.871041289654;12976.221426714428;7084.574925504487;7194.856102877913;7247.927520724831;7378.926210737824;7442.106947166375;6931.09895713554;6971.721131154798;6982.441404687613;7094.006839042539;7114.750983715545;6027.336992930774;6037.335893051761;6038.852618002566;6059.848503787441;6091.451769340781;1534.7544392897082;1572.944946926875;1606.9276882540314;1623.0424049810667;1664.0063846767855;840.7477756672973;857.2627540315324;861.2248975921596;873.6199753107419;894.6332003878379;16979.74530382045;17109.828901711073;17464.65070698579;17816.46550603484;17911.193996270198;858.978525536854;869.1265278395173;897.9955100224457;943.5706753427174;949.2453499467939;10259.692209233735;10333.586656533655;10377.16982641402;10404.739881503023;10416.531256093342;388375;406006;407583;408032;412942;65484.67257663681;66577.33422665711;66589;67147.66426167935;67190.66404668044;921.635953798246;935.9017303183203;944.7826999790087;961.2310151878469;964.252704154272;15518.689626207639;15541.533753987398;15570;15702.528924132293;15995.520134395987;31193.688063119986;32401;33004.1748956278;33726.15684607806;33853.83073084619;43594.34608480939;43863.34204986864;44264.77867610641;44885.326720099874;44947.32579011252;7373.889391659022;7537.585432801248;7540.434467414856;7592.4305677075545;7658.8085297868;7122.649525656625;11107.500162492868;11687.824682629598;11937.641870743892;11972.700682483008;9309.581068851783;9793;10190.43952582615;10241.487925603838;10367.533460994122;10121.645742399276;10253.538590763583;10317.896821031994;10426.635067772591;10474.476276186313;10361.430121343097;10590.947045264724;10775.245732798629;10843;10899.182561307774;7781.883271751041;7810.218978102144;7856.175101614248;7932.36541076724;8147.511149331059;7909.0113735783025;9160;9943.502824858873;10511.632092876713;10686.198535109743 03:36:58 INFO - PROCESS | 17075 | |3;mootools.html;1260.6092111445457;1380.9240491772955;1410.1820943852567;1461.349699383774;1687.2913376381919;6617.50368722346;7475.7009719611215;7701.768946931587;7758.069031716188;7762.92237077629;7372.778816635496;7593.658285377158;7601.8479630407355;7772.7668169954995;7804.141544430108;1848.898310592917;2088.196044522862;2159.168720042783;2179.7384313882358;2195.4401627585025;2187.07049503961;2195.7145571075816;2199.483121466454;2201.7688142745023;2205.7794220577975;2113.9894300528476;2123.9893800530976;2190.726159230096;2194.429448343434;2197.692323074763;1806.3226290141197;2066.390414827614;2079.61527117483;2151.601953638582;2153.558520503293;2152.8277737781095;2164.8376371772024;2169.4684802223396;2172.3808714516445;2173.4892300309416;7753.263439973193;7801.726939557088;7831.686732530692;7831.921680783234;7854.1753115922575;4367.71609845359;4489.663275254336;4502.324651302298;4503.594676479132;4531.274996000624;2653.4560415114856;2834.5464725644006;2839.5456726923594;2846.245744877609;2851.329937464694;882.7175303902753;887.5650931043742;906.1980147569383;923.8568021956607;926.1803304075873;10075.697729068066;10178.33840800353;10195;10211.183105351554;10301.690949271533;4045.696572757055;4139.110091330378;4184;4196.412502249687;4209.410682504452;8771.605277762515;8799.560021999003;8799.780005499786;8810.647574096964;8865.157810008039;4576.153411618861;4580.381648477412;4580.473245576802;4598.586127248497;4605.769711514411;3585.6952159066773;3896.941545876814;4003.3394489908837;4036.4348991141264;4081.836726530965;3675.797831119314;3689.538807649044;3694.4458331250526;3795.070207799107;3804.600516945736;1136.0513970834445;1150.8216226484908;1167.4046236419488;1173.2901594535354;1176.923499972499;652.6573548886778;708.5323686366974;769.4844454215689;787.9448438609357;802.0015081223913;4690.507496712864;4773.737444440589;5045.41977672565;5086.720230387365;5089.949100509021;403.26806845575186;408.52202922580653;421.1913126796497;421.84391775042815;424.9213895429356;3094.133642580081;3168.82571458572;3173.286010647586;3212.213007813101;3282.097423208637;9274.536273186313;9634.13292803637;9663.951680241555;9690.903090969001;9701.17540009093;9677.322587418814;9684.08001239881;9685.17675997548;9698.75753106178;9717.659881904241;7263.782086537412;7394.371478424394;7407.777766667009;7419.109706835215;7436.219196984239;5054.1155297822;5063.620228482805;5143.5627971622835;5155.896882062413;5218.765155568084;8910.242629376316;9038.638454461749;9047.773805654911;9075.410098343587;9136.49749263797;8599.82800343977;8901.643934242558;8954.238889694188;9080.364374493722;9205.953970230374;5511.751971161227;6319.936800632118;6407.935920640734;6490.8052758417325;6553.639549824806;7396.445266605134;7420.257974202536;7469.253074692488;7483.32650061497;7513.474056816189;6595.1096601958125;6741.2921643226755;6847.281035491401;6937.583744975318;6965.825854353681;6610.70251838678;6648.83377915556;6652.667366631746;6799.932000680128;6879.277675844164;5856.707164641836;5861.853453663693;5889.204957330877;5903.498202652822;5906.468417842415;4177.686673499439;4240.893977650583;4248.660107191356;4254.149170165917;4290.742555446684;4062.187562487455;4138.379243113437;4205.453291072141;4296.6347860432215;4317.352397140454 03:36:58 INFO - PROCESS | 17075 | |4;prototype.html;284.2382415127459;295.2014799966092;298.5119329895621;299.3997035942934;299.5865705326649;4652.581267685908;4745.596624286935;4807.375041244638;4836.709797412158;4882.951170488299;4586.587207151356;4772.451168115659;4800.687955282913;4800.783964721587;4826;3749.850005999757;3783.7162212834146;3805.676517496016;3814.19901820618;3821.5605205401316;3527.171114788023;3633.7638053526566;3738.6448287412654;3794.4822071171475;3801.8214353550347;3738.289724952264;3754.6107940062216;3755.2864955658474;3758.2483503299313;3791.488149099878;3705.4997575327257;3714.4428335749853;3725.36668766309;3746.1383881707225;3778.2821263960036;3324.2852786650988;3331.433656278414;3331.583552055993;3333.5333053372306;3337.2491189482416;4631.397918270603;4651.7441540715245;4669.369635099252;4672.322513235596;4723.267893476516;4242.575742425764;4258.318669012974;4281.250781113293;4288.378185163134;4304.720193187432;5024.572911302544;5039.395272567279;5045.268436076748;5057.165567681328;5066.885285237242;3363.327334533103;3552.8223588820456;3559.501669766235;3647.1246900743895;3658.5243918290716;5250.18622113573;5250.317458730379;5261.684298942114;5266.394364648077;5289.814856480043;3600.6039335673054;3603.828755654423;3615.584207816082;3633.5821380541047;3659.4144936809985;3697.574778900407;3711.1278849470355;3713.1088538751046;3713.9071523211596;3718.4236443351324;4024.396340548941;4222.683298752606;4228.260054490452;4230.492340919048;4230.8519201827785;5050.520200580939;5053.36832895888;5063.215201643751;5070.467600901926;5071.315372424676;1189.2448295332354;1215.4685096777946;1262.6338361875137;1265.9303738294482;1267.3346493091017;794.6860989908954;799.9400044996648;811.1726039439739;813.7843471480063;820.122468958209;4040.9797951010055;4041.777702226406;4065.6137666921595;4071.7353372031316;4105.44576482177;4634.304854271886;4649.465311489222;4711.717296962193;4739.265413860857;4752.334673145762;3957.6240257175523;4001.3197756381487;4005.859794907164;4041.91916161681;4062.939055914164;2295.3023475814884;2466.334089795781;2473.6907886514186;2476.0343466048257;2500.7374225706403;4241.406203131564;4265.786710664516;4343.587359200871;4353.891152721208;4413.44831896013;4710.81156753726;4729.763511824395;4734.928976065362;4742.834000809955;4745.3593764842;4144.544100148981;4353.910123140973;4358.171947329997;4369.803358848796;4378.9418973081965;4559.38448309474;4576.771161441981;4603.238057165808;4639.164950308842;4662.906741865076;4543.568361005699;4549.636029117596;4574.425574425574;4583.220852455024;4604.1712491751805;4001.9785062277792;4345.152695224401;4441.955580444154;4453.933191002202;4455.287154055336;3246.9512957306133;3263.853126609261;3291.259466619991;3300.8019518828946;3301.240714635599;4617.445906491108;4624.653151013755;4638.281066434708;4668.883277918079;4991.176455884884;4854.8786280341865;5061.493850614909;5074.213496907985;5091.6181286402925;5110.3356563646485;5050.84847454577;5056.64603477753;5058.647728806123;5072.746362681777;5120.641555091257;4851.611871050378;4970.179920313252;4986;4996.925046124384;5032.521910418504;5073.974630126826;5106.285120083117;5117.518003768244;5144.639875208849;5148.253503242084;5018.146915024382;5018.795489082667;5062.670926389773;5072.340595722532;5085.720285384192 03:36:58 INFO - PROCESS | 17075 | |5;yui.html;498.80795893581006;535.7348112684222;589.4135335341334;590.8109404990404;616.9105479705443;10326.741831454208;11137.888621113787;11180.776384472305;11290.379029153393;11321.603743868965;12262.080343974216;13923.30383480827;14424.423023079064;14432.42270309189;15044.323005464754;613.2242712968099;753.6721526136121;779.7348901373532;785.8231897823001;786.1784435265162;784.6390660296271;786.4652036615099;789.7749141494675;790.4861839804116;791.8376732769768;822.8025273934243;823.7487566292278;823.9093699693029;824.68661908475;825.1336097098053;643.134983447265;784.4391260248949;801.7274126796859;815.514768712615;816.1185919207242;590.90250108732;591.5385998920849;591.5385998920849;591.9378465261171;593;11711.121665875093;11758.17692761507;11764.352960587164;11774.175807693466;11775.587854425139;10768.838467422916;11326.263792853439;11456.198066135374;11711.063114950783;11876.109291803063;10261.384316940932;10280.434576098312;10362.222833287458;10437.269391142623;10529.526171322308;3916.471276377681;3966.7619942803526;3986.123052928351;4196.685248606367;4330.112326972963;60062.39937600612;60468.697656511875;60707.08939365913;60921.6953915232;61388.38611613871;9604.807903841884;9634.807303853884;9672.75818104539;10070.546825392876;10078.748031299276;18110.456686299432;18125.546861328574;18137.09314534268;18144.45566633003;18165.54586135331;6506.3818937200895;6514;6569.507286953498;6689.632070236086;6739.359760822714;3476.6001909780193;3614.3855544557487;3617.7829330239742;3645.9635403645625;3760.7555508891833;2670.145553422886;2764.1154830454466;2768.7646550043473;2769.515334816399;2771.1547977866944;458.601017115112;468.9882752931204;471.3848427801752;472.6124577846202;485.36902027364283;422.7167797575632;510.8033407138279;533.757140501071;539.0970125040542;543.6194663735401;6982.47631427645;6983.476239282074;6991.510594258455;7164.391026762679;7185.748498802517;430.77814925313487;462.63220739512167;476.2522839142513;493.7852034364991;511.6955411530134;3254.625718042408;3290.9506357404657;3291.062047316503;3330.2506935939705;3382.340443613472;85059;86552.13447865567;89388.5530572343;89952;90107;76167;77651.61174194093;78445;78528.60735696285;81502;57065;65461.345386546476;67528.32471675318;67851;68721;7115.928840711734;7204.207537171012;7341.375983041501;7435.144958329862;7571.697132114654;37128.81435592805;42654.57345426506;42715;43583.56416435795;44858.77570612126;53337.46662533325;59508.40491595028;59936;60613;61446.7158461484;10168;10358.5338659762;11094.31905457956;11115.888841111486;11274.7745045097;10791.460426978463;11291.209615326849;11298.265612735146;11662.12534059966;12814.615561533168;10975.890241097486;11113.166512511432;11123.221374503708;11249.550017999189;11267;9836.21310295189;10142.188624910137;10191.235657325582;10942;10992.670219893416;10966.670999870017;11037;11619.0704743622;11644.592439264585;11689.473973671034;9132.315076369166;9168.35821492489;9295.860562091439;9363.85954210701;9390.624375024923;9269.582868770787;9419.736638573995;9535.809283814146;9627.147544884137;9633.373830700983 03:36:58 INFO - PROCESS | 17075 | __end_tp_report 03:36:58 INFO - PROCESS | 17075 | __start_cc_report 03:36:58 INFO - PROCESS | 17075 | _x_x_mozilla_cycle_collect,967 03:36:58 INFO - PROCESS | 17075 | __end_cc_report 03:36:58 INFO - PROCESS | 17075 | __startTimestamp1465555018177__endTimestamp 03:36:58 INFO - PROCESS | 17075 | 03:36:58 INFO - PROCESS | 17075 | ------- Summary: start ------- 03:36:58 INFO - PROCESS | 17075 | Number of tests: 6 03:36:58 INFO - PROCESS | 17075 | 03:36:58 INFO - PROCESS | 17075 | [#0] dojo.html Cycles:165 Average:4692.58 Median:4822.32 stddev:505.77 (10.5%) stddev-sans-first:479.81 03:36:58 INFO - PROCESS | 17075 | Values: 2595.0 2602.1 2647.3 2658.3 2662.2 4566.4 4647.5 4663.2 4745.5 4759.1 4716.1 4717.5 4767.5 4771.6 4822.3 4238.5 4309.4 4358.3 4414.5 4494.3 4381.3 4434.4 4454.2 4454.2 4484.4 4207.0 4276.0 4289.4 4314.7 4337.0 4292.4 4326.0 4332.0 4333.0 4352.8 4338.4 4367.3 4368.3 4370.7 4419.0 4727.8 4777.0 4780.5 4784.3 4789.5 4881.6 5051.7 5107.3 5107.9 5123.7 5158.6 5174.6 5176.1 5193.2 5195.4 4794.0 4794.5 4794.7 4806.6 4838.3 5006.7 5222.9 5256.9 5302.3 5361.3 5049.0 5135.8 5137.7 5141.1 5142.3 4950.7 5180.5 5182.0 5208.3 5227.4 4990.6 5028.2 5041.3 5042.1 5064.2 5033.5 5039.1 5039.5 5047.7 5098.7 4117.4 4154.6 4283.7 4291.6 4330.6 3685.7 3704.1 3736.1 3749.5 3767.3 4327.0 4332.4 4333.9 4354.1 4376.8 4868.3 5053.9 5057.9 5064.0 5102.1 4337.7 4373.2 4389.0 4401.9 4436.8 4583.8 4606.9 4607.9 4637.0 4681.1 4562.8 4822.7 4825.0 4831.3 4862.2 4984.0 5038.1 5047.7 5065.1 5073.2 4731.0 4732.7 4746.1 4750.9 4798.0 4796.3 4933.1 4970.2 4977.3 5026.5 5064.7 5116.8 5134.4 5134.8 5187.7 4979.5 4993.1 4995.8 4999.9 5048.9 4689.3 4853.0 4854.1 4974.6 4994.7 4850.0 4877.0 4879.2 4916.0 4926.9 4964.6 4965.9 4975.2 5008.6 5019.3 4633.3 4858.6 4889.1 4940.5 4952.6 03:36:58 INFO - PROCESS | 17075 | 03:36:58 INFO - PROCESS | 17075 | [#1] ext.html Cycles:180 Average:45975.23 Median:3223.88 stddev:83980.12 (2604.9%) stddev-sans-first:84146.45 03:36:58 INFO - PROCESS | 17075 | Values: 552.1 562.3 566.0 577.1 586.6 26550.9 29112.9 40156.4 40955.2 41004.2 41265.8 41630.8 41765.6 41778.4 41795.4 7846.3 7934.6 7995.7 7997.9 7998.8 7547.5 10073.8 10314.3 10315.4 10661.7 10485.6 10620.8 10639.3 10639.6 10639.8 7612.8 10157.6 10285.0 10372.7 10375.8 10006.8 10408.3 10411.5 10411.9 10419.6 39380.2 39718.0 39742.6 39806.6 39821.0 3041.7 3080.6 3212.2 3235.4 3398.4 29651.0 29658.7 29725.4 29835.4 29909.7 3190.6 3206.1 3212.4 3248.1 3267.5 256631.0 257877.0 258807.0 260044.0 261190.0 29366.6 29948.7 52798.0 53335.0 53403.7 32786.7 32874.2 32897.7 32945.5 32959.0 12631.6 12706.2 12706.9 12710.2 12741.0 10028.5 10839.6 10845.0 11068.9 11261.8 7957.4 7969.3 8003.8 8052.4 8072.8 3088.7 3133.1 3152.2 3161.5 3161.7 836.7 932.3 951.8 979.5 1007.8 27828.3 28293.4 28657.6 28702.7 28816.4 943.8 955.5 966.6 980.3 1015.2 14801.9 14891.8 14959.8 15110.2 15310.5 386248.0 388449.0 390381.0 390949.0 394369.0 50226.2 50389.5 50416.2 50625.5 50884.5 1098.5 1187.9 1204.5 1229.8 1235.7 27982.3 28181.3 28196.7 29089.6 29291.0 42521.4 42572.4 42928.6 42971.1 43012.0 291980.0 292389.0 292421.0 293197.0 294224.0 21781.2 24466.4 24859.4 25086.1 25169.2 40778.6 41079.6 42079.6 42192.4 42804.8 35658.0 35717.3 36167.0 36553.5 36624.0 35812.3 36034.8 36050.6 36221.0 36260.8 34956.5 35532.0 35681.6 36012.6 36197.5 31251.4 32522.8 32565.8 32886.7 32989.7 24660.9 25013.4 25073.9 25114.1 25361.1 03:36:58 INFO - PROCESS | 17075 | 03:36:58 INFO - PROCESS | 17075 | [#2] jquery.html Cycles:180 Average:24246.91 Median:410487.00 stddev:66414.49 (16.2%) stddev-sans-first:66576.57 03:36:58 INFO - PROCESS | 17075 | Values: 356.5 361.6 362.5 370.2 380.8 15981.0 16706.2 17229.4 17242.7 17249.7 16114.5 16274.5 16589.9 16623.2 16803.3 5023.5 5165.4 5242.4 5245.9 5258.6 3102.1 3251.0 5069.1 5648.3 5959.1 5983.6 5988.0 6010.6 6034.3 6040.5 5805.3 5910.3 5950.6 6006.4 6054.7 2802.3 4872.5 5169.7 5171.2 5197.5 20896.5 20971.6 21047.8 21181.2 21257.9 1907.5 1967.8 1986.1 1987.7 2014.9 12423.8 13215.3 13358.3 13407.9 13882.7 1697.0 1716.5 1730.5 1811.6 1814.3 68197.3 68425.0 69093.7 69570.3 71091.0 8492.9 8976.8 9245.9 9786.6 9873.1 12734.2 12798.4 12828.9 12895.9 12976.2 7084.6 7194.9 7247.9 7378.9 7442.1 6931.1 6971.7 6982.4 7094.0 7114.8 6027.3 6037.3 6038.9 6059.8 6091.5 1534.8 1572.9 1606.9 1623.0 1664.0 840.7 857.3 861.2 873.6 894.6 16979.7 17109.8 17464.7 17816.5 17911.2 859.0 869.1 898.0 943.6 949.2 10259.7 10333.6 10377.2 10404.7 10416.5 388375.0 406006.0 407583.0 408032.0 412942.0 65484.7 66577.3 66589.0 67147.7 67190.7 921.6 935.9 944.8 961.2 964.3 15518.7 15541.5 15570.0 15702.5 15995.5 31193.7 32401.0 33004.2 33726.2 33853.8 43594.3 43863.3 44264.8 44885.3 44947.3 7373.9 7537.6 7540.4 7592.4 7658.8 7122.6 11107.5 11687.8 11937.6 11972.7 9309.6 9793.0 10190.4 10241.5 10367.5 10121.6 10253.5 10317.9 10426.6 10474.5 10361.4 10590.9 10775.2 10843.0 10899.2 7781.9 7810.2 7856.2 7932.4 8147.5 7909.0 9160.0 9943.5 10511.6 10686.2 03:36:58 INFO - PROCESS | 17075 | 03:36:58 INFO - PROCESS | 17075 | [#3] mootools.html Cycles:180 Average:5011.63 Median:4732.12 stddev:2875.42 (60.8%) stddev-sans-first:2869.67 03:36:58 INFO - PROCESS | 17075 | Values: 1260.6 1380.9 1410.2 1461.3 1687.3 6617.5 7475.7 7701.8 7758.1 7762.9 7372.8 7593.7 7601.8 7772.8 7804.1 1848.9 2088.2 2159.2 2179.7 2195.4 2187.1 2195.7 2199.5 2201.8 2205.8 2114.0 2124.0 2190.7 2194.4 2197.7 1806.3 2066.4 2079.6 2151.6 2153.6 2152.8 2164.8 2169.5 2172.4 2173.5 7753.3 7801.7 7831.7 7831.9 7854.2 4367.7 4489.7 4502.3 4503.6 4531.3 2653.5 2834.5 2839.5 2846.2 2851.3 882.7 887.6 906.2 923.9 926.2 10075.7 10178.3 10195.0 10211.2 10301.7 4045.7 4139.1 4184.0 4196.4 4209.4 8771.6 8799.6 8799.8 8810.6 8865.2 4576.2 4580.4 4580.5 4598.6 4605.8 3585.7 3896.9 4003.3 4036.4 4081.8 3675.8 3689.5 3694.4 3795.1 3804.6 1136.1 1150.8 1167.4 1173.3 1176.9 652.7 708.5 769.5 787.9 802.0 4690.5 4773.7 5045.4 5086.7 5089.9 403.3 408.5 421.2 421.8 424.9 3094.1 3168.8 3173.3 3212.2 3282.1 9274.5 9634.1 9664.0 9690.9 9701.2 9677.3 9684.1 9685.2 9698.8 9717.7 7263.8 7394.4 7407.8 7419.1 7436.2 5054.1 5063.6 5143.6 5155.9 5218.8 8910.2 9038.6 9047.8 9075.4 9136.5 8599.8 8901.6 8954.2 9080.4 9206.0 5511.8 6319.9 6407.9 6490.8 6553.6 7396.4 7420.3 7469.3 7483.3 7513.5 6595.1 6741.3 6847.3 6937.6 6965.8 6610.7 6648.8 6652.7 6799.9 6879.3 5856.7 5861.9 5889.2 5903.5 5906.5 4177.7 4240.9 4248.7 4254.1 4290.7 4062.2 4138.4 4205.5 4296.6 4317.4 03:36:58 INFO - PROCESS | 17075 | 03:36:58 INFO - PROCESS | 17075 | [#4] prototype.html Cycles:180 Average:4026.41 Median:4396.20 stddev:1174.13 (26.7%) stddev-sans-first:1143.33 03:36:58 INFO - PROCESS | 17075 | Values: 284.2 295.2 298.5 299.4 299.6 4652.6 4745.6 4807.4 4836.7 4883.0 4586.6 4772.5 4800.7 4800.8 4826.0 3749.9 3783.7 3805.7 3814.2 3821.6 3527.2 3633.8 3738.6 3794.5 3801.8 3738.3 3754.6 3755.3 3758.2 3791.5 3705.5 3714.4 3725.4 3746.1 3778.3 3324.3 3331.4 3331.6 3333.5 3337.2 4631.4 4651.7 4669.4 4672.3 4723.3 4242.6 4258.3 4281.3 4288.4 4304.7 5024.6 5039.4 5045.3 5057.2 5066.9 3363.3 3552.8 3559.5 3647.1 3658.5 5250.2 5250.3 5261.7 5266.4 5289.8 3600.6 3603.8 3615.6 3633.6 3659.4 3697.6 3711.1 3713.1 3713.9 3718.4 4024.4 4222.7 4228.3 4230.5 4230.9 5050.5 5053.4 5063.2 5070.5 5071.3 1189.2 1215.5 1262.6 1265.9 1267.3 794.7 799.9 811.2 813.8 820.1 4041.0 4041.8 4065.6 4071.7 4105.4 4634.3 4649.5 4711.7 4739.3 4752.3 3957.6 4001.3 4005.9 4041.9 4062.9 2295.3 2466.3 2473.7 2476.0 2500.7 4241.4 4265.8 4343.6 4353.9 4413.4 4710.8 4729.8 4734.9 4742.8 4745.4 4144.5 4353.9 4358.2 4369.8 4378.9 4559.4 4576.8 4603.2 4639.2 4662.9 4543.6 4549.6 4574.4 4583.2 4604.2 4002.0 4345.2 4442.0 4453.9 4455.3 3247.0 3263.9 3291.3 3300.8 3301.2 4617.4 4624.7 4638.3 4668.9 4991.2 4854.9 5061.5 5074.2 5091.6 5110.3 5050.8 5056.6 5058.6 5072.7 5120.6 4851.6 4970.2 4986.0 4996.9 5032.5 5074.0 5106.3 5117.5 5144.6 5148.3 5018.1 5018.8 5062.7 5072.3 5085.7 03:36:58 INFO - PROCESS | 17075 | 03:36:58 INFO - PROCESS | 17075 | [#5] yui.html Cycles:180 Average:16528.90 Median:496.30 stddev:23317.19 (4698.2%) stddev-sans-first:23351.54 03:36:58 INFO - PROCESS | 17075 | Values: 498.8 535.7 589.4 590.8 616.9 10326.7 11137.9 11180.8 11290.4 11321.6 12262.1 13923.3 14424.4 14432.4 15044.3 613.2 753.7 779.7 785.8 786.2 784.6 786.5 789.8 790.5 791.8 822.8 823.7 823.9 824.7 825.1 643.1 784.4 801.7 815.5 816.1 590.9 591.5 591.5 591.9 593.0 11711.1 11758.2 11764.4 11774.2 11775.6 10768.8 11326.3 11456.2 11711.1 11876.1 10261.4 10280.4 10362.2 10437.3 10529.5 3916.5 3966.8 3986.1 4196.7 4330.1 60062.4 60468.7 60707.1 60921.7 61388.4 9604.8 9634.8 9672.8 10070.5 10078.7 18110.5 18125.5 18137.1 18144.5 18165.5 6506.4 6514.0 6569.5 6689.6 6739.4 3476.6 3614.4 3617.8 3646.0 3760.8 2670.1 2764.1 2768.8 2769.5 2771.2 458.6 469.0 471.4 472.6 485.4 422.7 510.8 533.8 539.1 543.6 6982.5 6983.5 6991.5 7164.4 7185.7 430.8 462.6 476.3 493.8 511.7 3254.6 3291.0 3291.1 3330.3 3382.3 85059.0 86552.1 89388.6 89952.0 90107.0 76167.0 77651.6 78445.0 78528.6 81502.0 57065.0 65461.3 67528.3 67851.0 68721.0 7115.9 7204.2 7341.4 7435.1 7571.7 37128.8 42654.6 42715.0 43583.6 44858.8 53337.5 59508.4 59936.0 60613.0 61446.7 10168.0 10358.5 11094.3 11115.9 11274.8 10791.5 11291.2 11298.3 11662.1 12814.6 10975.9 11113.2 11123.2 11249.6 11267.0 9836.2 10142.2 10191.2 10942.0 10992.7 10966.7 11037.0 11619.1 11644.6 11689.5 9132.3 9168.4 9295.9 9363.9 9390.6 9269.6 9419.7 9535.8 9627.1 9633.4 03:36:58 INFO - PROCESS | 17075 | -------- Summary: end -------- 03:36:58 INFO - PROCESS | 17075 | 03:36:58 INFO - TEST-INFO | 17075: exit 0 03:36:58 INFO - TEST-OK | dromaeo_css | took 1120348ms 03:36:58 INFO - TEST-START | kraken 03:36:58 INFO - operating with platform_type : linux_ 03:36:58 INFO - Initialising browser for kraken test... 03:36:59 INFO - TEST-INFO | started process 17254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8rR8EN/profile http://localhost:57775/getInfo.html) 03:37:03 INFO - PROCESS | 17254 | __metrics Screen width/height:1600/1200 03:37:03 INFO - PROCESS | 17254 | colorDepth:24 03:37:03 INFO - PROCESS | 17254 | Browser inner width/height: 1024/697 03:37:03 INFO - PROCESS | 17254 | __metrics 03:37:04 ERROR - PROCESS | 17254 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:37:05 INFO - PROCESS | 17254 | console.error: PushService: 03:37:05 INFO - PROCESS | 17254 | stateChangeProcessEnqueue: Error transitioning state 03:37:05 INFO - PROCESS | 17254 | UnknownError 03:37:05 INFO - TEST-INFO | 17254: exit 0 03:37:05 INFO - Browser initialized. 03:37:05 INFO - Running cycle 1/1 for kraken test... 03:37:05 INFO - TEST-INFO | started process 17336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8rR8EN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:18 INFO - PROCESS | 17336 | RSS: Main: 175337472 03:37:18 INFO - PROCESS | 17336 | 03:37:20 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57775/tests/kraken/driver.html?testName=audio-beat-detection) 03:37:21 INFO - PROCESS | 17336 | RSS: Main: 232341504 03:37:21 INFO - PROCESS | 17336 | 03:37:24 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57775/tests/kraken/driver.html?testName=audio-dft) 03:37:25 INFO - PROCESS | 17336 | RSS: Main: 220631040 03:37:25 INFO - PROCESS | 17336 | 03:37:28 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57775/tests/kraken/driver.html?testName=audio-fft) 03:37:29 INFO - PROCESS | 17336 | RSS: Main: 287911936 03:37:29 INFO - PROCESS | 17336 | 03:37:31 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57775/tests/kraken/driver.html?testName=audio-oscillator) 03:37:31 INFO - PROCESS | 17336 | RSS: Main: 197615616 03:37:31 INFO - PROCESS | 17336 | 03:37:34 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:37:34 INFO - PROCESS | 17336 | RSS: Main: 201736192 03:37:34 INFO - PROCESS | 17336 | 03:37:37 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57775/tests/kraken/driver.html?testName=imaging-darkroom) 03:37:38 INFO - PROCESS | 17336 | RSS: Main: 237674496 03:37:38 INFO - PROCESS | 17336 | 03:37:41 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57775/tests/kraken/driver.html?testName=imaging-desaturate) 03:37:42 INFO - PROCESS | 17336 | RSS: Main: 238768128 03:37:42 INFO - PROCESS | 17336 | 03:37:45 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57775/tests/kraken/driver.html?testName=json-parse-financial) 03:37:46 INFO - PROCESS | 17336 | RSS: Main: 238206976 03:37:46 INFO - PROCESS | 17336 | 03:37:47 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:37:48 INFO - PROCESS | 17336 | RSS: Main: 220221440 03:37:48 INFO - PROCESS | 17336 | 03:37:50 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57775/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:37:50 INFO - PROCESS | 17336 | RSS: Main: 225226752 03:37:50 INFO - PROCESS | 17336 | 03:37:53 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:37:53 INFO - PROCESS | 17336 | RSS: Main: 235298816 03:37:53 INFO - PROCESS | 17336 | 03:37:56 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:37:57 INFO - PROCESS | 17336 | RSS: Main: 241180672 03:37:57 INFO - PROCESS | 17336 | 03:37:59 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:00 INFO - PROCESS | 17336 | RSS: Main: 240386048 03:38:00 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | Cycle 1(1): loaded http://localhost:57775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57775/tests/kraken/driver.html?testName=ai-astar) 03:38:02 INFO - PROCESS | 17336 | RSS: Main: 283070464 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | __start_tp_report 03:38:02 INFO - PROCESS | 17336 | _x_x_mozilla_page_load 03:38:02 INFO - PROCESS | 17336 | _x_x_mozilla_page_load_details 03:38:02 INFO - PROCESS | 17336 | |i|pagename|runs| 03:38:02 INFO - PROCESS | 17336 | |0;ai-astar;114;110;114;114;113;113;115;115;111;113 03:38:02 INFO - PROCESS | 17336 | |1;audio-beat-detection;157;129;131;201;131;134;161;132;167;132 03:38:02 INFO - PROCESS | 17336 | |2;audio-dft;161;161;162;161;160;163;161;163;163;161 03:38:02 INFO - PROCESS | 17336 | |3;audio-fft;76;76;77;108;83;75;76;76;110;76 03:38:02 INFO - PROCESS | 17336 | |4;audio-oscillator;86;87;113;86;87;87;119;86;87;137 03:38:02 INFO - PROCESS | 17336 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 03:38:02 INFO - PROCESS | 17336 | |6;imaging-darkroom;147;145;146;145;145;146;146;145;146;147 03:38:02 INFO - PROCESS | 17336 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;95;94 03:38:02 INFO - PROCESS | 17336 | |8;json-parse-financial;63;65;62;63;63;63;67;62;62;63 03:38:02 INFO - PROCESS | 17336 | |9;json-stringify-tinderbox;64;66;65;65;65;65;65;66;64;65 03:38:02 INFO - PROCESS | 17336 | |10;stanford-crypto-aes;84;84;83;90;84;85;85;94;121;85 03:38:02 INFO - PROCESS | 17336 | |11;stanford-crypto-ccm;133;130;129;128;128;129;140;131;146;133 03:38:02 INFO - PROCESS | 17336 | |12;stanford-crypto-pbkdf2;171;168;167;167;168;163;173;168;167;167 03:38:02 INFO - PROCESS | 17336 | |13;stanford-crypto-sha256-iterative;72;67;70;67;67;66;67;69;70;67 03:38:02 INFO - PROCESS | 17336 | __end_tp_report 03:38:02 INFO - PROCESS | 17336 | __start_cc_report 03:38:02 INFO - PROCESS | 17336 | _x_x_mozilla_cycle_collect,1887 03:38:02 INFO - PROCESS | 17336 | __end_cc_report 03:38:02 INFO - PROCESS | 17336 | __startTimestamp1465555082629__endTimestamp 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | ------- Summary: start ------- 03:38:02 INFO - PROCESS | 17336 | Number of tests: 14 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:1.62 (1.4%) stddev-sans-first:1.69 03:38:02 INFO - PROCESS | 17336 | Values: 114.0 110.0 114.0 114.0 113.0 113.0 115.0 115.0 111.0 113.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:145.50 stddev:23.72 (16.3%) stddev-sans-first:24.91 03:38:02 INFO - PROCESS | 17336 | Values: 157.0 129.0 131.0 201.0 131.0 134.0 161.0 132.0 167.0 132.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 03:38:02 INFO - PROCESS | 17336 | Values: 161.0 161.0 162.0 161.0 160.0 163.0 161.0 163.0 163.0 161.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:13.74 (18.1%) stddev-sans-first:14.31 03:38:02 INFO - PROCESS | 17336 | Values: 76.0 76.0 77.0 108.0 83.0 75.0 76.0 76.0 110.0 76.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:86.50 stddev:18.56 (21.5%) stddev-sans-first:19.21 03:38:02 INFO - PROCESS | 17336 | Values: 86.0 87.0 113.0 86.0 87.0 87.0 119.0 86.0 87.0 137.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:38:02 INFO - PROCESS | 17336 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 03:38:02 INFO - PROCESS | 17336 | Values: 147.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 147.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:38:02 INFO - PROCESS | 17336 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.00 stddev:1.57 (2.5%) stddev-sans-first:1.66 03:38:02 INFO - PROCESS | 17336 | Values: 63.0 65.0 62.0 63.0 63.0 63.0 67.0 62.0 62.0 63.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 03:38:02 INFO - PROCESS | 17336 | Values: 64.0 66.0 65.0 65.0 65.0 65.0 65.0 66.0 64.0 65.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:85.00 stddev:11.58 (13.6%) stddev-sans-first:12.11 03:38:02 INFO - PROCESS | 17336 | Values: 84.0 84.0 83.0 90.0 84.0 85.0 85.0 94.0 121.0 85.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:132.00 stddev:5.89 (4.5%) stddev-sans-first:6.24 03:38:02 INFO - PROCESS | 17336 | Values: 133.0 130.0 129.0 128.0 128.0 129.0 140.0 131.0 146.0 133.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:2.64 (1.6%) stddev-sans-first:2.55 03:38:02 INFO - PROCESS | 17336 | Values: 171.0 168.0 167.0 167.0 168.0 163.0 173.0 168.0 167.0 167.0 03:38:02 INFO - PROCESS | 17336 | 03:38:02 INFO - PROCESS | 17336 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.93 (2.8%) stddev-sans-first:1.48 03:38:02 INFO - PROCESS | 17336 | Values: 72.0 67.0 70.0 67.0 67.0 66.0 67.0 69.0 70.0 67.0 03:38:02 INFO - PROCESS | 17336 | -------- Summary: end -------- 03:38:02 INFO - PROCESS | 17336 | 03:38:03 INFO - TEST-INFO | 17336: exit 0 03:38:03 INFO - TEST-OK | kraken | took 64939ms 03:38:03 INFO - SUITE-END | took 1185s 03:38:04 INFO - Completed test suite (00:19:45) 03:38:04 INFO - javascript benchmark 03:38:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2595.0, 2602.1152808045263, 2647.298465906535, 2658.3354161459633, 2662.2412612405456, 4566.429196350457, 4647.53524647536, 4663.160631086403, 4745.501722319154, 4759.071980963713, 4716.127516409458, 4717.504662010482, 4767.499412561683, 4771.5944144747655, 4822.3248745175615, 4238.533761286256, 4309.439772829535, 4358.302671572549, 4414.470263568376, 4494.280915053592, 4381.342798580206, 4434.379186913835, 4454.175977444183, 4454.242778727624, 4484.394606728099, 4206.957930420687, 4275.978620106879, 4289.442372491588, 4314.7411155330465, 4336.9999999999845, 4292.420523229386, 4326.0266440051055, 4332.025294308755, 4333.046729719456, 4352.847650332224, 4338.43600331958, 4367.323064924942, 4368.257396242647, 4370.694051416371, 4419.049904270597, 4727.810887564528, 4776.952230477686, 4780.450248221429, 4784.306275590055, 4789.521047895182, 4881.633877459205, 5051.6716413433005, 5107.336046313955, 5107.897842043139, 5123.7438128093445, 5158.613104017214, 5174.611904107207, 5176.0683077046115, 5193.246979188034, 5195.350581177353, 4794.0, 4794.496577859274, 4794.712317260975, 4806.591439727592, 4838.322634831091, 5006.74966251686, 5222.947770522323, 5256.92114618281, 5302.337207849019, 5361.27622770921, 5049.040682270357, 5135.820246291437, 5137.691738495702, 5141.074606570778, 5142.280080788692, 4950.678205916676, 5180.48195180479, 5182.0, 5208.296879921238, 5227.424983251839, 4990.600751939909, 5028.195488721787, 5041.294218809369, 5042.142835717937, 5064.215046667772, 5033.5469807716745, 5039.118154322979, 5039.4708555601865, 5047.722375269322, 5098.694078355311, 4117.423560701504, 4154.584541545822, 4283.678724095706, 4291.570842915684, 4330.610245077958, 3685.668289853926, 3704.129529560551, 3736.065983504124, 3749.4938183345444, 3767.2842159989514, 4326.978365108154, 4332.415123958225, 4333.891652708708, 4354.063876266555, 4376.824927002948, 4868.318435419044, 5053.8736531587, 5057.924131138036, 5063.974680126576, 5102.056119617882, 4337.7397356158735, 4373.234683930299, 4389.034412429261, 4401.889952751207, 4436.844710435119, 4583.770811459413, 4606.930896036562, 4607.9078418431445, 4637.049404871993, 4681.063787242565, 4562.794674239601, 4822.734749588806, 4825.010872771144, 4831.347768051268, 4862.17343051682, 4984.028114517634, 5038.14351560243, 5047.747612619428, 5065.138926382598, 5073.16292811682, 4730.97634511839, 4732.6687131900435, 4746.0745154694505, 4750.857474275777, 4798.04039192156, 4796.304535842213, 4933.087378834927, 4970.179920313252, 4977.303177555073, 5026.472220416804, 5064.696118232918, 5116.820911268088, 5134.358205224347, 5134.845954621367, 5187.688738675692, 4979.502049794992, 4993.076280888047, 4995.750212489288, 4999.925001124913, 5048.8990220194655, 4689.343491911067, 4852.975735121302, 4854.126257273725, 4974.552290293891, 4994.725290109079, 4849.95150048495, 4876.975615121902, 4879.194932836042, 4915.95084049155, 4926.901461970669, 4964.627652925973, 4965.875853103701, 4975.203967365204, 5008.6243531734535, 5019.297298378157, 4633.328167415773, 4858.611311095033, 4889.119958407521, 4940.456549779593, 4952.628552858478], "value": 4659.633018114395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.0530342040926, 562.3167851060961, 565.9688717120558, 577.0536320434486, 586.6216290492631, 26550.86724566377, 29112.85443572782, 40156.397654035216, 40955.18089638213, 41004.179916401656, 41265.793671031606, 41630.791846040804, 41765.582344176546, 41778.373324400156, 41795.373069403984, 7846.333061689749, 7934.603269836514, 7995.720149794758, 7997.920020799805, 7998.760037198865, 7547.54714717116, 10073.798524029515, 10314.278000539965, 10315.43265120418, 10661.680149595524, 10485.633002844901, 10620.840687389695, 10639.255252132354, 10639.627613033545, 10639.840402393971, 7612.8477430451085, 10157.644482443078, 10285.0, 10372.688819335432, 10375.84436233457, 10006.849897251546, 10408.271421000532, 10411.479426028669, 10411.947940260327, 10419.583216671324, 39380.21239575192, 39718.0, 39742.60257397418, 39806.60193398087, 39821.0, 3041.726244637971, 3080.614923134608, 3212.180893872048, 3235.4014507315987, 3398.3543126805826, 29651.0, 29658.70341296581, 29725.4466938711, 29835.403291934257, 29909.70090299091, 3190.6171259448784, 3206.070239630504, 3212.357528494287, 3248.058063161704, 3267.460868956643, 256631.0, 257877.0, 258807.0, 260044.0, 261190.0, 29366.55950160749, 29948.70051299459, 52798.0, 53335.0, 53403.73298133485, 32786.67213327884, 32874.17814554607, 32897.67102328994, 32945.505817412755, 32959.0, 12631.621051368473, 12706.237625742486, 12706.9364653178, 12710.237385756884, 12741.0, 10028.548715307828, 10839.620613278497, 10845.023947844575, 11068.944655276671, 11261.831072533918, 7957.403194760416, 7969.282764551218, 8003.759887203393, 8052.355811535063, 8072.757817265491, 3088.722015018659, 3133.122725636825, 3152.180433087414, 3161.4941609342854, 3161.668024857403, 836.6695155413578, 932.2728271947891, 951.8334291499099, 979.5249304087512, 1007.7732510185297, 27828.30429239285, 28293.43413131767, 28657.57013644797, 28702.712972870006, 28816.423671526452, 943.8301105801022, 955.4697143085515, 966.5843687214565, 980.2599037726613, 1015.2334987084704, 14801.851981480262, 14891.776623350659, 14959.775603365959, 15110.244487775568, 15310.540683779505, 386248.0, 388449.0, 390381.0, 390949.0, 394369.0, 50226.246606300934, 50389.49610503848, 50416.24375634368, 50625.49374506208, 50884.49115508872, 1098.5441041967654, 1187.857457105153, 1204.482072708726, 1229.827824104626, 1235.6725467751232, 27982.3004424891, 28181.295467613472, 28196.718032819408, 29089.563656544746, 29291.0, 42521.36217956795, 42572.36141457818, 42928.57071429246, 42971.14057718765, 43012.0, 291980.0, 292389.0, 292421.0, 293197.0, 294224.0, 21781.23765668194, 24466.388340290923, 24859.378515537257, 25086.121985730413, 25169.24492265235, 40778.59221407748, 41079.58920410758, 42079.57920420879, 42192.36711449269, 42804.78597606992, 35658.0, 35717.28565428625, 36167.0, 36553.45169822508, 36624.0, 35812.28375432529, 36034.819825900704, 36050.63949360473, 36221.0, 36260.81869590741, 34956.47565286472, 35532.0, 35681.64318356783, 36012.63987360093, 36197.45703814392, 31251.37497250088, 32522.83738581292, 32565.837170814943, 32886.67113328932, 32989.67010329866, 24660.876695617124, 25013.374665633506, 25073.87463062673, 25114.12100576471, 25361.112361067273], "value": 16833.932489116236, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.4902189868488, 361.55889814426405, 362.4888906641636, 370.1948262528999, 380.7928865496376, 15981.0, 16706.24821883015, 17229.396971106013, 17242.741358879597, 17249.74125388117, 16114.516564503054, 16274.511764647079, 16589.91705041473, 16623.168841557934, 16803.32786688531, 5023.472535383787, 5165.431802501722, 5242.397124330693, 5245.921311180336, 5258.605604579653, 3102.1314032071054, 3250.951235731466, 5069.062223488648, 5648.293963254593, 5959.10613407988, 5983.611065280743, 5988.041913293874, 6010.57925945184, 6034.275886893579, 6040.546958978072, 5805.303363596353, 5910.290765108193, 5950.613210141327, 6006.399360064002, 6054.727537260812, 2802.2574017885277, 4872.4640289568115, 5169.663971841818, 5171.22431635254, 5197.454267301917, 20896.47758806027, 20971.5805683887, 21047.789522104737, 21181.152753889826, 21257.89371053135, 1907.50404894727, 1967.783543810194, 1986.1261045140093, 1987.6720341143694, 2014.8891810950392, 12423.75152496954, 13215.273159976197, 13358.332083395791, 13407.865921340759, 13882.722345553033, 1697.0, 1716.4764746752235, 1730.4808557432846, 1811.637672465499, 1814.2561549764532, 68197.31802681959, 68425.0, 69093.65453172702, 69570.3042969574, 71091.0, 8492.919234787516, 8976.775580610407, 9245.861312080324, 9786.608535658635, 9873.062059104373, 12734.172278801849, 12798.424070916832, 12828.935855320664, 12895.871041289654, 12976.221426714428, 7084.574925504487, 7194.856102877913, 7247.927520724831, 7378.926210737824, 7442.106947166375, 6931.09895713554, 6971.721131154798, 6982.441404687613, 7094.006839042539, 7114.750983715545, 6027.336992930774, 6037.335893051761, 6038.852618002566, 6059.848503787441, 6091.451769340781, 1534.7544392897082, 1572.944946926875, 1606.9276882540314, 1623.0424049810667, 1664.0063846767855, 840.7477756672973, 857.2627540315324, 861.2248975921596, 873.6199753107419, 894.6332003878379, 16979.74530382045, 17109.828901711073, 17464.65070698579, 17816.46550603484, 17911.193996270198, 858.978525536854, 869.1265278395173, 897.9955100224457, 943.5706753427174, 949.2453499467939, 10259.692209233735, 10333.586656533655, 10377.16982641402, 10404.739881503023, 10416.531256093342, 388375.0, 406006.0, 407583.0, 408032.0, 412942.0, 65484.67257663681, 66577.33422665711, 66589.0, 67147.66426167935, 67190.66404668044, 921.635953798246, 935.9017303183203, 944.7826999790087, 961.2310151878469, 964.252704154272, 15518.689626207639, 15541.533753987398, 15570.0, 15702.528924132293, 15995.520134395987, 31193.688063119986, 32401.0, 33004.1748956278, 33726.15684607806, 33853.83073084619, 43594.34608480939, 43863.34204986864, 44264.77867610641, 44885.326720099874, 44947.32579011252, 7373.889391659022, 7537.585432801248, 7540.434467414856, 7592.4305677075545, 7658.8085297868, 7122.649525656625, 11107.500162492868, 11687.824682629598, 11937.641870743892, 11972.700682483008, 9309.581068851783, 9793.0, 10190.43952582615, 10241.487925603838, 10367.533460994122, 10121.645742399276, 10253.538590763583, 10317.896821031994, 10426.635067772591, 10474.476276186313, 10361.430121343097, 10590.947045264724, 10775.245732798629, 10843.0, 10899.182561307774, 7781.883271751041, 7810.218978102144, 7856.175101614248, 7932.36541076724, 8147.511149331059, 7909.0113735783025, 9160.0, 9943.502824858873, 10511.632092876713, 10686.198535109743], "value": 8229.217268887658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.6092111445457, 1380.9240491772955, 1410.1820943852567, 1461.349699383774, 1687.2913376381919, 6617.50368722346, 7475.7009719611215, 7701.768946931587, 7758.069031716188, 7762.92237077629, 7372.778816635496, 7593.658285377158, 7601.8479630407355, 7772.7668169954995, 7804.141544430108, 1848.898310592917, 2088.196044522862, 2159.168720042783, 2179.7384313882358, 2195.4401627585025, 2187.07049503961, 2195.7145571075816, 2199.483121466454, 2201.7688142745023, 2205.7794220577975, 2113.9894300528476, 2123.9893800530976, 2190.726159230096, 2194.429448343434, 2197.692323074763, 1806.3226290141197, 2066.390414827614, 2079.61527117483, 2151.601953638582, 2153.558520503293, 2152.8277737781095, 2164.8376371772024, 2169.4684802223396, 2172.3808714516445, 2173.4892300309416, 7753.263439973193, 7801.726939557088, 7831.686732530692, 7831.921680783234, 7854.1753115922575, 4367.71609845359, 4489.663275254336, 4502.324651302298, 4503.594676479132, 4531.274996000624, 2653.4560415114856, 2834.5464725644006, 2839.5456726923594, 2846.245744877609, 2851.329937464694, 882.7175303902753, 887.5650931043742, 906.1980147569383, 923.8568021956607, 926.1803304075873, 10075.697729068066, 10178.33840800353, 10195.0, 10211.183105351554, 10301.690949271533, 4045.696572757055, 4139.110091330378, 4184.0, 4196.412502249687, 4209.410682504452, 8771.605277762515, 8799.560021999003, 8799.780005499786, 8810.647574096964, 8865.157810008039, 4576.153411618861, 4580.381648477412, 4580.473245576802, 4598.586127248497, 4605.769711514411, 3585.6952159066773, 3896.941545876814, 4003.3394489908837, 4036.4348991141264, 4081.836726530965, 3675.797831119314, 3689.538807649044, 3694.4458331250526, 3795.070207799107, 3804.600516945736, 1136.0513970834445, 1150.8216226484908, 1167.4046236419488, 1173.2901594535354, 1176.923499972499, 652.6573548886778, 708.5323686366974, 769.4844454215689, 787.9448438609357, 802.0015081223913, 4690.507496712864, 4773.737444440589, 5045.41977672565, 5086.720230387365, 5089.949100509021, 403.26806845575186, 408.52202922580653, 421.1913126796497, 421.84391775042815, 424.9213895429356, 3094.133642580081, 3168.82571458572, 3173.286010647586, 3212.213007813101, 3282.097423208637, 9274.536273186313, 9634.13292803637, 9663.951680241555, 9690.903090969001, 9701.17540009093, 9677.322587418814, 9684.08001239881, 9685.17675997548, 9698.75753106178, 9717.659881904241, 7263.782086537412, 7394.371478424394, 7407.777766667009, 7419.109706835215, 7436.219196984239, 5054.1155297822, 5063.620228482805, 5143.5627971622835, 5155.896882062413, 5218.765155568084, 8910.242629376316, 9038.638454461749, 9047.773805654911, 9075.410098343587, 9136.49749263797, 8599.82800343977, 8901.643934242558, 8954.238889694188, 9080.364374493722, 9205.953970230374, 5511.751971161227, 6319.936800632118, 6407.935920640734, 6490.8052758417325, 6553.639549824806, 7396.445266605134, 7420.257974202536, 7469.253074692488, 7483.32650061497, 7513.474056816189, 6595.1096601958125, 6741.2921643226755, 6847.281035491401, 6937.583744975318, 6965.825854353681, 6610.70251838678, 6648.83377915556, 6652.667366631746, 6799.932000680128, 6879.277675844164, 5856.707164641836, 5861.853453663693, 5889.204957330877, 5903.498202652822, 5906.468417842415, 4177.686673499439, 4240.893977650583, 4248.660107191356, 4254.149170165917, 4290.742555446684, 4062.187562487455, 4138.379243113437, 4205.453291072141, 4296.6347860432215, 4317.352397140454], "value": 3947.319310765821, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.2382415127459, 295.2014799966092, 298.5119329895621, 299.3997035942934, 299.5865705326649, 4652.581267685908, 4745.596624286935, 4807.375041244638, 4836.709797412158, 4882.951170488299, 4586.587207151356, 4772.451168115659, 4800.687955282913, 4800.783964721587, 4826.0, 3749.850005999757, 3783.7162212834146, 3805.676517496016, 3814.19901820618, 3821.5605205401316, 3527.171114788023, 3633.7638053526566, 3738.6448287412654, 3794.4822071171475, 3801.8214353550347, 3738.289724952264, 3754.6107940062216, 3755.2864955658474, 3758.2483503299313, 3791.488149099878, 3705.4997575327257, 3714.4428335749853, 3725.36668766309, 3746.1383881707225, 3778.2821263960036, 3324.2852786650988, 3331.433656278414, 3331.583552055993, 3333.5333053372306, 3337.2491189482416, 4631.397918270603, 4651.7441540715245, 4669.369635099252, 4672.322513235596, 4723.267893476516, 4242.575742425764, 4258.318669012974, 4281.250781113293, 4288.378185163134, 4304.720193187432, 5024.572911302544, 5039.395272567279, 5045.268436076748, 5057.165567681328, 5066.885285237242, 3363.327334533103, 3552.8223588820456, 3559.501669766235, 3647.1246900743895, 3658.5243918290716, 5250.18622113573, 5250.317458730379, 5261.684298942114, 5266.394364648077, 5289.814856480043, 3600.6039335673054, 3603.828755654423, 3615.584207816082, 3633.5821380541047, 3659.4144936809985, 3697.574778900407, 3711.1278849470355, 3713.1088538751046, 3713.9071523211596, 3718.4236443351324, 4024.396340548941, 4222.683298752606, 4228.260054490452, 4230.492340919048, 4230.8519201827785, 5050.520200580939, 5053.36832895888, 5063.215201643751, 5070.467600901926, 5071.315372424676, 1189.2448295332354, 1215.4685096777946, 1262.6338361875137, 1265.9303738294482, 1267.3346493091017, 794.6860989908954, 799.9400044996648, 811.1726039439739, 813.7843471480063, 820.122468958209, 4040.9797951010055, 4041.777702226406, 4065.6137666921595, 4071.7353372031316, 4105.44576482177, 4634.304854271886, 4649.465311489222, 4711.717296962193, 4739.265413860857, 4752.334673145762, 3957.6240257175523, 4001.3197756381487, 4005.859794907164, 4041.91916161681, 4062.939055914164, 2295.3023475814884, 2466.334089795781, 2473.6907886514186, 2476.0343466048257, 2500.7374225706403, 4241.406203131564, 4265.786710664516, 4343.587359200871, 4353.891152721208, 4413.44831896013, 4710.81156753726, 4729.763511824395, 4734.928976065362, 4742.834000809955, 4745.3593764842, 4144.544100148981, 4353.910123140973, 4358.171947329997, 4369.803358848796, 4378.9418973081965, 4559.38448309474, 4576.771161441981, 4603.238057165808, 4639.164950308842, 4662.906741865076, 4543.568361005699, 4549.636029117596, 4574.425574425574, 4583.220852455024, 4604.1712491751805, 4001.9785062277792, 4345.152695224401, 4441.955580444154, 4453.933191002202, 4455.287154055336, 3246.9512957306133, 3263.853126609261, 3291.259466619991, 3300.8019518828946, 3301.240714635599, 4617.445906491108, 4624.653151013755, 4638.281066434708, 4668.883277918079, 4991.176455884884, 4854.8786280341865, 5061.493850614909, 5074.213496907985, 5091.6181286402925, 5110.3356563646485, 5050.84847454577, 5056.64603477753, 5058.647728806123, 5072.746362681777, 5120.641555091257, 4851.611871050378, 4970.179920313252, 4986.0, 4996.925046124384, 5032.521910418504, 5073.974630126826, 5106.285120083117, 5117.518003768244, 5144.639875208849, 5148.253503242084, 5018.146915024382, 5018.795489082667, 5062.670926389773, 5072.340595722532, 5085.720285384192], "value": 3654.625152463281, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.80795893581006, 535.7348112684222, 589.4135335341334, 590.8109404990404, 616.9105479705443, 10326.741831454208, 11137.888621113787, 11180.776384472305, 11290.379029153393, 11321.603743868965, 12262.080343974216, 13923.30383480827, 14424.423023079064, 14432.42270309189, 15044.323005464754, 613.2242712968099, 753.6721526136121, 779.7348901373532, 785.8231897823001, 786.1784435265162, 784.6390660296271, 786.4652036615099, 789.7749141494675, 790.4861839804116, 791.8376732769768, 822.8025273934243, 823.7487566292278, 823.9093699693029, 824.68661908475, 825.1336097098053, 643.134983447265, 784.4391260248949, 801.7274126796859, 815.514768712615, 816.1185919207242, 590.90250108732, 591.5385998920849, 591.5385998920849, 591.9378465261171, 593.0, 11711.121665875093, 11758.17692761507, 11764.352960587164, 11774.175807693466, 11775.587854425139, 10768.838467422916, 11326.263792853439, 11456.198066135374, 11711.063114950783, 11876.109291803063, 10261.384316940932, 10280.434576098312, 10362.222833287458, 10437.269391142623, 10529.526171322308, 3916.471276377681, 3966.7619942803526, 3986.123052928351, 4196.685248606367, 4330.112326972963, 60062.39937600612, 60468.697656511875, 60707.08939365913, 60921.6953915232, 61388.38611613871, 9604.807903841884, 9634.807303853884, 9672.75818104539, 10070.546825392876, 10078.748031299276, 18110.456686299432, 18125.546861328574, 18137.09314534268, 18144.45566633003, 18165.54586135331, 6506.3818937200895, 6514.0, 6569.507286953498, 6689.632070236086, 6739.359760822714, 3476.6001909780193, 3614.3855544557487, 3617.7829330239742, 3645.9635403645625, 3760.7555508891833, 2670.145553422886, 2764.1154830454466, 2768.7646550043473, 2769.515334816399, 2771.1547977866944, 458.601017115112, 468.9882752931204, 471.3848427801752, 472.6124577846202, 485.36902027364283, 422.7167797575632, 510.8033407138279, 533.757140501071, 539.0970125040542, 543.6194663735401, 6982.47631427645, 6983.476239282074, 6991.510594258455, 7164.391026762679, 7185.748498802517, 430.77814925313487, 462.63220739512167, 476.2522839142513, 493.7852034364991, 511.6955411530134, 3254.625718042408, 3290.9506357404657, 3291.062047316503, 3330.2506935939705, 3382.340443613472, 85059.0, 86552.13447865567, 89388.5530572343, 89952.0, 90107.0, 76167.0, 77651.61174194093, 78445.0, 78528.60735696285, 81502.0, 57065.0, 65461.345386546476, 67528.32471675318, 67851.0, 68721.0, 7115.928840711734, 7204.207537171012, 7341.375983041501, 7435.144958329862, 7571.697132114654, 37128.81435592805, 42654.57345426506, 42715.0, 43583.56416435795, 44858.77570612126, 53337.46662533325, 59508.40491595028, 59936.0, 60613.0, 61446.7158461484, 10168.0, 10358.5338659762, 11094.31905457956, 11115.888841111486, 11274.7745045097, 10791.460426978463, 11291.209615326849, 11298.265612735146, 11662.12534059966, 12814.615561533168, 10975.890241097486, 11113.166512511432, 11123.221374503708, 11249.550017999189, 11267.0, 9836.21310295189, 10142.188624910137, 10191.235657325582, 10942.0, 10992.670219893416, 10966.670999870017, 11037.0, 11619.0704743622, 11644.592439264585, 11689.473973671034, 9132.315076369166, 9168.35821492489, 9295.860562091439, 9363.85954210701, 9390.624375024923, 9269.582868770787, 9419.736638573995, 9535.809283814146, 9627.147544884137, 9633.373830700983], "value": 6152.063541756544, "unit": "score"}], "name": "dromaeo_css", "value": 6208.96022658475, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 114.0, 114.0, 113.0, 113.0, 115.0, 115.0, 111.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 131.0, 201.0, 131.0, 134.0, 161.0, 132.0, 167.0, 132.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 160.0, 163.0, 161.0, 163.0, 163.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 108.0, 83.0, 75.0, 76.0, 76.0, 110.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 113.0, 86.0, 87.0, 87.0, 119.0, 86.0, 87.0, 137.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 62.0, 63.0, 63.0, 63.0, 67.0, 62.0, 62.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 90.0, 84.0, 85.0, 85.0, 94.0, 121.0, 85.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 129.0, 128.0, 128.0, 129.0, 140.0, 131.0, 146.0, 133.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 167.0, 167.0, 168.0, 163.0, 173.0, 168.0, 167.0, 167.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 70.0, 67.0, 67.0, 66.0, 67.0, 69.0, 70.0, 67.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1547.1000000000001, "alertThreshold": 2.0}]} 03:38:04 INFO - Return code: 0 03:38:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:38:04 ERROR - # TBPL SUCCESS # 03:38:04 INFO - Running post-action listener: _resource_record_post_action 03:38:04 INFO - ##### 03:38:04 INFO - ##### Finished run-tests step (success) 03:38:04 INFO - ##### 03:38:04 INFO - Running post-run listener: _resource_record_post_run 03:38:04 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 533929984; Read time: 304; Write time: 650232 03:38:04 INFO - TinderboxPrint: CPU usage
13.3% 03:38:04 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 304 03:38:04 INFO - TinderboxPrint: I/O write bytes / time
533,929,984 / 650,232 03:38:04 INFO - TinderboxPrint: CPU idle
8,326.8 (86.7%) 03:38:04 INFO - TinderboxPrint: CPU user
1,223.8 (12.7%) 03:38:04 INFO - TinderboxPrint: Swap in / out
0 / 0 03:38:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 215826432; Read time: 0; Write time: 305552 03:38:04 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293740544; Read time: 304; Write time: 339548 03:38:05 INFO - Running post-run listener: _upload_blobber_files 03:38:05 INFO - Blob upload gear active. 03:38:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:05 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 03:38:05 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'] 03:38:05 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 03:38:05 INFO - (blobuploader) - INFO - Open directory for files ... 03:38:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:38:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:09 INFO - (blobuploader) - INFO - Done attempting. 03:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:10 INFO - (blobuploader) - INFO - Done attempting. 03:38:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:38:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:38:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:11 INFO - (blobuploader) - INFO - Done attempting. 03:38:11 INFO - (blobuploader) - INFO - Iteration through files over. 03:38:11 INFO - Return code: 0 03:38:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:38:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:38:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d724812d28844f7ec4a9772b35839e7971d6ba39efbdb9dd63801474ca3c3fb158354dd0f8b9198fd3ecf011585695f6fb6ea1317384f680b5c360562228fbff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d716737e84ffd9f5520ccfb1009f77de26df365de8b8e49fca8b63a7f63596dd6ff3a2424f739e1e8b2153ad2ffcc636b4e17f629eca6fde23c4db945ce6fb33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/201c467aa5fafc34820bfce4d273d044d6cce29d1d41ec5111bcf6c8aaad025ec50f9dc16e3cb32c78528a7ca2fa135c4db4a9396293eab241084566b11e3150"} 03:38:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:38:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:38:11 INFO - Contents: 03:38:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d724812d28844f7ec4a9772b35839e7971d6ba39efbdb9dd63801474ca3c3fb158354dd0f8b9198fd3ecf011585695f6fb6ea1317384f680b5c360562228fbff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d716737e84ffd9f5520ccfb1009f77de26df365de8b8e49fca8b63a7f63596dd6ff3a2424f739e1e8b2153ad2ffcc636b4e17f629eca6fde23c4db945ce6fb33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/201c467aa5fafc34820bfce4d273d044d6cce29d1d41ec5111bcf6c8aaad025ec50f9dc16e3cb32c78528a7ca2fa135c4db4a9396293eab241084566b11e3150"} 03:38:11 INFO - Running post-run listener: copy_logs_to_upload_dir 03:38:11 INFO - Copying logs to upload dir... 03:38:11 INFO - mkdir: /builds/slave/test/build/upload/logs 03:38:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.666591 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-10 03:38:11.193071) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 03:38:11.197046) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d724812d28844f7ec4a9772b35839e7971d6ba39efbdb9dd63801474ca3c3fb158354dd0f8b9198fd3ecf011585695f6fb6ea1317384f680b5c360562228fbff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d716737e84ffd9f5520ccfb1009f77de26df365de8b8e49fca8b63a7f63596dd6ff3a2424f739e1e8b2153ad2ffcc636b4e17f629eca6fde23c4db945ce6fb33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/201c467aa5fafc34820bfce4d273d044d6cce29d1d41ec5111bcf6c8aaad025ec50f9dc16e3cb32c78528a7ca2fa135c4db4a9396293eab241084566b11e3150"} build_url:https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011425 build_url: 'https://queue.taskcluster.net/v1/task/MjSics3XQ1CG3fnOU-MDcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d724812d28844f7ec4a9772b35839e7971d6ba39efbdb9dd63801474ca3c3fb158354dd0f8b9198fd3ecf011585695f6fb6ea1317384f680b5c360562228fbff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d716737e84ffd9f5520ccfb1009f77de26df365de8b8e49fca8b63a7f63596dd6ff3a2424f739e1e8b2153ad2ffcc636b4e17f629eca6fde23c4db945ce6fb33", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/201c467aa5fafc34820bfce4d273d044d6cce29d1d41ec5111bcf6c8aaad025ec50f9dc16e3cb32c78528a7ca2fa135c4db4a9396293eab241084566b11e3150"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 03:38:11.229312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:38:11.229920) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465552665.195613-1705427587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 03:38:11.313387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 03:38:11.313737) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 03:38:11.314057) ========= ========= Total master_lag: 0.20 =========