builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1466893585.5 results: success (0) buildid: 20160625144323 builduid: 2acc665ab6fb4a9eaa038736efb257e4 revision: afb7cb42a98a66de401af5bcf7de03733f2784cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:25.497952) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:25.498376) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:25.498707) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:25.549022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:25.549341) ========= 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=ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-25 15:26:25-- 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% 42.7M=0s 2016-06-25 15:26:25 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178292 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:25.764902) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:25.765236) ========= 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=ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.076108 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:25.855210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-25 15:26:25.855658) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev afb7cb42a98a66de401af5bcf7de03733f2784cd --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 afb7cb42a98a66de401af5bcf7de03733f2784cd --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=ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-25 15:26:25,918 truncating revision to first 12 chars 2016-06-25 15:26:25,918 Setting DEBUG logging. 2016-06-25 15:26:25,918 attempt 1/10 2016-06-25 15:26:25,918 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/afb7cb42a98a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-25 15:26:27,325 unpacking tar archive at: fx-team-afb7cb42a98a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.761797 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-25 15:26:27.635407) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:27.635830) ========= script_repo_revision: afb7cb42a98a66de401af5bcf7de03733f2784cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:27.636471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:27.636801) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 15:26:27.647190) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-25 15:26:27.647639) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:26:27 INFO - MultiFileLogger online at 20160625 15:26:27 in /builds/slave/test 15:26:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:26:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:26:27 INFO - {'append_to_log': False, 15:26:27 INFO - 'base_work_dir': '/builds/slave/test', 15:26:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:26:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:26:27 INFO - 'branch': 'Fx-Team-Non-PGO', 15:26:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:26:27 INFO - 'config_files': ('talos/linux_config.py',), 15:26:27 INFO - 'default_actions': ('clobber', 15:26:27 INFO - 'read-buildbot-config', 15:26:27 INFO - 'download-and-extract', 15:26:27 INFO - 'populate-webroot', 15:26:27 INFO - 'create-virtualenv', 15:26:27 INFO - 'install', 15:26:27 INFO - 'run-tests'), 15:26:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:26:27 INFO - 'download_minidump_stackwalk': True, 15:26:27 INFO - 'download_symbols': 'ondemand', 15:26:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:26:27 INFO - 'tooltool.py': '/tools/tooltool.py', 15:26:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:26:27 INFO - '/tools/misc-python/virtualenv.py')}, 15:26:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:26:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:26:27 INFO - 'installer_path': 'installer.exe', 15:26:27 INFO - 'log_level': 'info', 15:26:27 INFO - 'log_name': 'talos', 15:26:27 INFO - 'log_to_console': True, 15:26:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:26:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:26:27 INFO - 'opt_config_files': (), 15:26:27 INFO - 'pip_index': False, 15:26:27 INFO - 'sps_profile': False, 15:26:27 INFO - 'sps_profile_interval': 0, 15:26:27 INFO - 'suite': 'dromaeojs-e10s', 15:26:27 INFO - 'system_bits': '32', 15:26:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:26:27 INFO - 'title': 'talos-linux64-ix-035', 15:26:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:26:27 INFO - 'use_talos_json': True, 15:26:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:26:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:26:27 INFO - 'work_dir': 'build'} 15:26:27 INFO - ##### 15:26:27 INFO - ##### Running clobber step. 15:26:27 INFO - ##### 15:26:27 INFO - Running pre-action listener: _resource_record_pre_action 15:26:27 INFO - Running main action method: clobber 15:26:27 INFO - rmtree: /builds/slave/test/build 15:26:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:26:28 INFO - Running post-action listener: _resource_record_post_action 15:26:28 INFO - ##### 15:26:28 INFO - ##### Finished clobber step (success) 15:26:28 INFO - ##### 15:26:28 INFO - ##### 15:26:28 INFO - ##### Running read-buildbot-config step. 15:26:28 INFO - ##### 15:26:28 INFO - Running pre-action listener: _resource_record_pre_action 15:26:28 INFO - Running main action method: read_buildbot_config 15:26:28 INFO - Using buildbot properties: 15:26:28 INFO - { 15:26:28 INFO - "project": "", 15:26:28 INFO - "product": "firefox", 15:26:28 INFO - "script_repo_revision": "production", 15:26:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:26:28 INFO - "repository": "", 15:26:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:26:28 INFO - "buildid": "20160625144323", 15:26:28 INFO - "pgo_build": "False", 15:26:28 INFO - "basedir": "/builds/slave/test", 15:26:28 INFO - "buildnumber": 1386, 15:26:28 INFO - "slavename": "talos-linux64-ix-035", 15:26:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:26:28 INFO - "platform": "ubuntu64_hw", 15:26:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:26:28 INFO - "branch": "fx-team", 15:26:28 INFO - "repo_path": "integration/fx-team", 15:26:28 INFO - "revision": "afb7cb42a98a66de401af5bcf7de03733f2784cd", 15:26:28 INFO - "stage_platform": "linux64", 15:26:28 INFO - "builduid": "2acc665ab6fb4a9eaa038736efb257e4", 15:26:28 INFO - "slavebuilddir": "test" 15:26:28 INFO - } 15:26:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:26:28 INFO - Running post-action listener: _resource_record_post_action 15:26:28 INFO - ##### 15:26:28 INFO - ##### Finished read-buildbot-config step (success) 15:26:28 INFO - ##### 15:26:28 INFO - ##### 15:26:28 INFO - ##### Running download-and-extract step. 15:26:28 INFO - ##### 15:26:28 INFO - Running pre-action listener: _resource_record_pre_action 15:26:28 INFO - Running main action method: download_and_extract 15:26:28 INFO - mkdir: /builds/slave/test/build/tests 15:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:28 INFO - https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:26:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:26:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:26:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:29 INFO - Downloaded 1361 bytes. 15:26:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:26:29 INFO - Using the following test package requirements: 15:26:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:26:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:26:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:26:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:29 INFO - u'jsshell-linux-x86_64.zip'], 15:26:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:26:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:26:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:26:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:26:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:26:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:26:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:26: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')]} 15:26:29 INFO - https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:26:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:36 INFO - Downloaded 22713106 bytes. 15:26:36 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'] 15:26:36 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 15:26:37 INFO - Return code: 0 15:26:37 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 15:26:37 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')]} 15:26:37 INFO - https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:26:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:38 INFO - Downloaded 22713106 bytes. 15:26:38 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'] 15:26:38 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 15:26:40 INFO - Return code: 0 15:26:40 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')]} 15:26:40 INFO - https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:26:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:41 INFO - Downloaded 14405188 bytes. 15:26:41 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'] 15:26:41 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 15:26:41 INFO - Return code: 0 15:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:41 INFO - https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:26:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vens87spTlKWbAsul_A8xQ/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 15:26:43 INFO - Downloaded 56272542 bytes. 15:26:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:43 INFO - mkdir: /builds/slave/test/properties 15:26:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:26:43 INFO - Writing to file /builds/slave/test/properties/build_url 15:26:43 INFO - Contents: 15:26:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:44 INFO - Running post-action listener: _resource_record_post_action 15:26:44 INFO - Running post-action listener: set_extra_try_arguments 15:26:44 INFO - ##### 15:26:44 INFO - ##### Finished download-and-extract step (success) 15:26:44 INFO - ##### 15:26:44 INFO - ##### 15:26:44 INFO - ##### Running populate-webroot step. 15:26:44 INFO - ##### 15:26:44 INFO - Running pre-action listener: _resource_record_pre_action 15:26:44 INFO - Running main action method: populate_webroot 15:26:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:26:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:26:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:26:44 INFO - '--tppagecycles', 15:26:44 INFO - '7'], 15:26:44 INFO - 'tests': ['tsvgm']}}, 15:26:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:26:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:26:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:26:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:26:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:26:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:26:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:44 INFO - 'talos_options': ['--disable-e10s'], 15:26:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:44 INFO - 'talos_options': ['--disable-e10s'], 15:26:44 INFO - 'tests': ['damp', 'tps']}, 15:26:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:44 INFO - 'tests': ['damp', 'tps']}, 15:26:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:26:44 INFO - 'tests': ['dromaeo_dom']}, 15:26:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:26:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:26:44 INFO - 'tests': ['basic_compositor_video']}, 15:26:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:26:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:26:44 INFO - 'tests': ['a11yr', 15:26:44 INFO - 'ts_paint', 15:26:44 INFO - 'tpaint', 15:26:44 INFO - 'sessionrestore', 15:26:44 INFO - 'sessionrestore_no_auto_restore', 15:26:44 INFO - 'tabpaint']}, 15:26:44 INFO - 'other-e10s': {'tests': ['a11yr', 15:26:44 INFO - 'ts_paint', 15:26:44 INFO - 'tpaint', 15:26:44 INFO - 'sessionrestore', 15:26:44 INFO - 'sessionrestore_no_auto_restore', 15:26:44 INFO - 'tabpaint']}, 15:26:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:26:44 INFO - 'ts_paint', 15:26:44 INFO - 'tpaint', 15:26:44 INFO - 'sessionrestore', 15:26:44 INFO - 'sessionrestore_no_auto_restore', 15:26:44 INFO - 'tabpaint']}, 15:26:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:26:44 INFO - 'ts_paint', 15:26:44 INFO - 'tpaint', 15:26:44 INFO - 'sessionrestore', 15:26:44 INFO - 'sessionrestore_no_auto_restore', 15:26:44 INFO - 'tabpaint']}, 15:26:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:26:44 INFO - 'tests': ['a11yr', 15:26:44 INFO - 'ts_paint', 15:26:44 INFO - 'tpaint', 15:26:44 INFO - 'sessionrestore', 15:26:44 INFO - 'sessionrestore_no_auto_restore', 15:26:44 INFO - 'tabpaint']}, 15:26:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:26:44 INFO - 'tests': ['a11yr', 15:26:44 INFO - 'ts_paint', 15:26:44 INFO - 'tpaint', 15:26:44 INFO - 'sessionrestore', 15:26:44 INFO - 'sessionrestore_no_auto_restore', 15:26:44 INFO - 'tabpaint']}, 15:26:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:26:44 INFO - 'tests': ['tsvgx', 15:26:44 INFO - 'tsvgr_opacity', 15:26:44 INFO - 'tart', 15:26:44 INFO - 'tscrollx', 15:26:44 INFO - 'cart']}, 15:26:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:26:44 INFO - 'tsvgr_opacity', 15:26:44 INFO - 'tart', 15:26:44 INFO - 'tscrollx', 15:26:44 INFO - 'cart']}, 15:26:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:44 INFO - 'talos_options': ['--disable-e10s'], 15:26:44 INFO - 'tests': ['tp5o']}, 15:26:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:44 INFO - 'tests': ['tp5o']}, 15:26:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:44 INFO - 'talos_options': ['--disable-e10s', 15:26:44 INFO - '--xperf_path', 15:26:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:44 INFO - 'tests': ['tp5n']}, 15:26:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:44 INFO - 'talos_options': ['--xperf_path', 15:26:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:44 INFO - 'tests': ['tp5n']}}, 15:26:44 INFO - 'talos.zip': {'path': '', 15:26:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:26:44 INFO - Running post-action listener: _resource_record_post_action 15:26:44 INFO - ##### 15:26:44 INFO - ##### Finished populate-webroot step (success) 15:26:44 INFO - ##### 15:26:44 INFO - ##### 15:26:44 INFO - ##### Running create-virtualenv step. 15:26:44 INFO - ##### 15:26:44 INFO - Running pre-action listener: _resource_record_pre_action 15:26:44 INFO - Running main action method: create_virtualenv 15:26:44 INFO - Creating virtualenv /builds/slave/test/build/venv 15:26:44 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 15:26:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:26:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:26:44 INFO - Using real prefix '/usr' 15:26:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:26:45 INFO - Installing distribute.............................................................................................................................................................................................done. 15:26:47 INFO - Installing pip.................done. 15:26:47 INFO - Return code: 0 15:26:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2185ae9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bba2c0>, '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 0x1bbb1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb650>, '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': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', '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 15:26: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', 'pip>=1.5'] in /builds/slave/test/build 15:26: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 pip>=1.5 15:26:47 INFO - Using env: {'DISPLAY': ':0', 15:26:47 INFO - 'HOME': '/home/cltbld', 15:26:47 INFO - 'LANG': 'en_US.UTF-8', 15:26:47 INFO - 'LANGUAGE': 'en_US:en', 15:26:47 INFO - 'LOGNAME': 'cltbld', 15:26:47 INFO - 'MAIL': '/var/mail/cltbld', 15:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:47 INFO - 'MOZ_NO_REMOTE': '1', 15:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:47 INFO - 'NO_EM_RESTART': '1', 15:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:47 INFO - 'PWD': '/builds/slave/test', 15:26:47 INFO - 'SHELL': '/bin/bash', 15:26:47 INFO - 'SHLVL': '1', 15:26:47 INFO - 'TERM': 'linux', 15:26:47 INFO - 'TMOUT': '86400', 15:26:47 INFO - 'USER': 'cltbld', 15:26:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', 15:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:47 INFO - '_': '/tools/buildbot/bin/python'} 15:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:47 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 15:26:47 INFO - Cleaning up... 15:26:47 INFO - Return code: 0 15:26:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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', '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 0x7f2185ae9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bba2c0>, '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 0x1bbb1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb650>, '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': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', '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 15:26: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:26: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 psutil>=3.1.1 15:26:47 INFO - Using env: {'DISPLAY': ':0', 15:26:47 INFO - 'HOME': '/home/cltbld', 15:26:47 INFO - 'LANG': 'en_US.UTF-8', 15:26:47 INFO - 'LANGUAGE': 'en_US:en', 15:26:47 INFO - 'LOGNAME': 'cltbld', 15:26:47 INFO - 'MAIL': '/var/mail/cltbld', 15:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:47 INFO - 'MOZ_NO_REMOTE': '1', 15:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:47 INFO - 'NO_EM_RESTART': '1', 15:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:47 INFO - 'PWD': '/builds/slave/test', 15:26:47 INFO - 'SHELL': '/bin/bash', 15:26:47 INFO - 'SHLVL': '1', 15:26:47 INFO - 'TERM': 'linux', 15:26:47 INFO - 'TMOUT': '86400', 15:26:47 INFO - 'USER': 'cltbld', 15:26:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', 15:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:47 INFO - '_': '/tools/buildbot/bin/python'} 15:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:47 INFO - Downloading/unpacking psutil>=3.1.1 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:26:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:49 INFO - Installing collected packages: psutil 15:26:49 INFO - Running setup.py install for psutil 15:26:49 INFO - building 'psutil._psutil_linux' extension 15:26:49 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 15:26:50 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 15:26:51 INFO - building 'psutil._psutil_posix' extension 15:26:51 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 15:26:51 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 15:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:51 INFO - Successfully installed psutil 15:26:51 INFO - Cleaning up... 15:26:51 INFO - Return code: 0 15:26:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:26:51 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')]} 15:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:51 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')]} 15:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:51 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 0x7f2185ae9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bba2c0>, '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 0x1bbb1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb650>, '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': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', '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 15:26:51 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 15:26:51 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 15:26:51 INFO - Using env: {'DISPLAY': ':0', 15:26:51 INFO - 'HOME': '/home/cltbld', 15:26:51 INFO - 'LANG': 'en_US.UTF-8', 15:26:51 INFO - 'LANGUAGE': 'en_US:en', 15:26:51 INFO - 'LOGNAME': 'cltbld', 15:26:51 INFO - 'MAIL': '/var/mail/cltbld', 15:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:51 INFO - 'MOZ_NO_REMOTE': '1', 15:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:51 INFO - 'NO_EM_RESTART': '1', 15:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:51 INFO - 'PWD': '/builds/slave/test', 15:26:51 INFO - 'SHELL': '/bin/bash', 15:26:51 INFO - 'SHLVL': '1', 15:26:51 INFO - 'TERM': 'linux', 15:26:51 INFO - 'TMOUT': '86400', 15:26:51 INFO - 'USER': 'cltbld', 15:26:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', 15:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:51 INFO - '_': '/tools/buildbot/bin/python'} 15:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:26:51 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 15:26:51 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 15:26:51 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 15:26:51 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 15:26:51 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 15:26:51 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 15:26:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:26:53 INFO - Installing collected packages: mozsystemmonitor 15:26:53 INFO - Running setup.py install for mozsystemmonitor 15:26:53 INFO - Successfully installed mozsystemmonitor 15:26:53 INFO - Cleaning up... 15:26:53 INFO - Return code: 0 15:26:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:53 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 0x7f2185ae9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bba2c0>, '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 0x1bbb1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb650>, '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': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', '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 15:26:53 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 15:26:53 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 15:26:53 INFO - Using env: {'DISPLAY': ':0', 15:26:53 INFO - 'HOME': '/home/cltbld', 15:26:53 INFO - 'LANG': 'en_US.UTF-8', 15:26:53 INFO - 'LANGUAGE': 'en_US:en', 15:26:53 INFO - 'LOGNAME': 'cltbld', 15:26:53 INFO - 'MAIL': '/var/mail/cltbld', 15:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:53 INFO - 'MOZ_NO_REMOTE': '1', 15:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:53 INFO - 'NO_EM_RESTART': '1', 15:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:53 INFO - 'PWD': '/builds/slave/test', 15:26:53 INFO - 'SHELL': '/bin/bash', 15:26:53 INFO - 'SHLVL': '1', 15:26:53 INFO - 'TERM': 'linux', 15:26:53 INFO - 'TMOUT': '86400', 15:26:53 INFO - 'USER': 'cltbld', 15:26:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', 15:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:53 INFO - '_': '/tools/buildbot/bin/python'} 15:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:53 INFO - Downloading/unpacking jsonschema==2.5.1 15:26:53 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 15:26:53 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 15:26:53 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 15:26:53 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 15:26:53 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 15:26:53 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 15:26:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:26:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:26:56 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 15:26:56 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 15:26:56 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 15:26:56 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 15:26:56 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 15:26:56 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 15:26:57 INFO - Downloading functools32-3.2.3-2.tar.gz 15:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:26:57 INFO - warning: no files found matching '*.txt' 15:26:57 INFO - no previously-included directories found matching 'build' 15:26:57 INFO - no previously-included directories found matching 'dist' 15:26:57 INFO - no previously-included directories found matching '.git*' 15:26:57 INFO - Installing collected packages: jsonschema, functools32 15:26:57 INFO - Running setup.py install for functools32 15:26:57 INFO - warning: no files found matching '*.txt' 15:26:57 INFO - no previously-included directories found matching 'build' 15:26:57 INFO - no previously-included directories found matching 'dist' 15:26:57 INFO - no previously-included directories found matching '.git*' 15:26:57 INFO - Successfully installed jsonschema functools32 15:26:57 INFO - Cleaning up... 15:26:57 INFO - Return code: 0 15:26:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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', '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 0x7f2185ae9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bba2c0>, '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 0x1bbb1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb650>, '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': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', '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 15:26: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:26: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 blobuploader==1.2.4 15:26:57 INFO - Using env: {'DISPLAY': ':0', 15:26:57 INFO - 'HOME': '/home/cltbld', 15:26:57 INFO - 'LANG': 'en_US.UTF-8', 15:26:57 INFO - 'LANGUAGE': 'en_US:en', 15:26:57 INFO - 'LOGNAME': 'cltbld', 15:26:57 INFO - 'MAIL': '/var/mail/cltbld', 15:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:57 INFO - 'MOZ_NO_REMOTE': '1', 15:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:57 INFO - 'NO_EM_RESTART': '1', 15:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:57 INFO - 'PWD': '/builds/slave/test', 15:26:57 INFO - 'SHELL': '/bin/bash', 15:26:57 INFO - 'SHLVL': '1', 15:26:57 INFO - 'TERM': 'linux', 15:26:57 INFO - 'TMOUT': '86400', 15:26:57 INFO - 'USER': 'cltbld', 15:26:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', 15:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:57 INFO - '_': '/tools/buildbot/bin/python'} 15:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:57 INFO - Downloading/unpacking blobuploader==1.2.4 15:26:57 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 15:26:57 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 15:26:57 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 15:26:57 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 15:26:57 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 15:26:57 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 15:26:59 INFO - Downloading blobuploader-1.2.4.tar.gz 15:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:26:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:26:59 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 15:26:59 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 15:26:59 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 15:26:59 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 15:26:59 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 15:26:59 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 15:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:26:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:26:59 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 15:26:59 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 15:26:59 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 15:26:59 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 15:26:59 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 15:26:59 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 15:27:00 INFO - Downloading docopt-0.6.1.tar.gz 15:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:27:00 INFO - Installing collected packages: blobuploader, requests, docopt 15:27:00 INFO - Running setup.py install for blobuploader 15:27:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:27:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:27:00 INFO - Running setup.py install for requests 15:27:00 INFO - Running setup.py install for docopt 15:27:00 INFO - Successfully installed blobuploader requests docopt 15:27:00 INFO - Cleaning up... 15:27:00 INFO - Return code: 0 15:27:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:00 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')]} 15:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:00 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')]} 15:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:00 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 0x7f2185ae9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bba2c0>, '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 0x1bbb1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb650>, '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': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', '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 15:27:00 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 15:27:00 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 15:27:00 INFO - Using env: {'DISPLAY': ':0', 15:27:00 INFO - 'HOME': '/home/cltbld', 15:27:00 INFO - 'LANG': 'en_US.UTF-8', 15:27:00 INFO - 'LANGUAGE': 'en_US:en', 15:27:00 INFO - 'LOGNAME': 'cltbld', 15:27:00 INFO - 'MAIL': '/var/mail/cltbld', 15:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:00 INFO - 'MOZ_NO_REMOTE': '1', 15:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:00 INFO - 'NO_EM_RESTART': '1', 15:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:00 INFO - 'PWD': '/builds/slave/test', 15:27:00 INFO - 'SHELL': '/bin/bash', 15:27:00 INFO - 'SHLVL': '1', 15:27:00 INFO - 'TERM': 'linux', 15:27:00 INFO - 'TMOUT': '86400', 15:27:00 INFO - 'USER': 'cltbld', 15:27:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', 15:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:00 INFO - '_': '/tools/buildbot/bin/python'} 15:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:00 INFO - Running setup.py (path:/tmp/pip-rZd4nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:01 INFO - Running setup.py (path:/tmp/pip-B7dD93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:01 INFO - Running setup.py (path:/tmp/pip-ooYjjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:01 INFO - Running setup.py (path:/tmp/pip-RaECyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:01 INFO - Running setup.py (path:/tmp/pip-RmGEIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:01 INFO - Running setup.py (path:/tmp/pip-K2aRtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:01 INFO - Running setup.py (path:/tmp/pip-JYMvly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:01 INFO - Running setup.py (path:/tmp/pip-1ijIS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:01 INFO - Running setup.py (path:/tmp/pip-c4glMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:01 INFO - Running setup.py (path:/tmp/pip-o8SlMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:01 INFO - Running setup.py (path:/tmp/pip-Nf5h5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:01 INFO - Running setup.py (path:/tmp/pip-RuVWks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:01 INFO - Running setup.py (path:/tmp/pip-f2Pe57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:01 INFO - Running setup.py (path:/tmp/pip-g4INPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:01 INFO - Running setup.py (path:/tmp/pip-FM3sd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:02 INFO - Running setup.py (path:/tmp/pip-Ooqoaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:02 INFO - Running setup.py (path:/tmp/pip-kxMSo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:27:02 INFO - Running setup.py install for manifestparser 15:27:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozcrash 15:27:02 INFO - Running setup.py install for mozdebug 15:27:02 INFO - Running setup.py install for mozdevice 15:27:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozfile 15:27:02 INFO - Running setup.py install for mozhttpd 15:27:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozinfo 15:27:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozInstall 15:27:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Running setup.py install for mozleak 15:27:03 INFO - Running setup.py install for mozlog 15:27:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Running setup.py install for moznetwork 15:27:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Running setup.py install for mozprocess 15:27:03 INFO - Running setup.py install for mozprofile 15:27:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Running setup.py install for mozrunner 15:27:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Running setup.py install for mozscreenshot 15:27:03 INFO - Running setup.py install for moztest 15:27:03 INFO - Running setup.py install for mozversion 15:27:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:27:03 INFO - Cleaning up... 15:27:04 INFO - Return code: 0 15:27:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:04 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')]} 15:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:04 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')]} 15:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:04 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 0x7f2185ae9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bba2c0>, '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 0x1bbb1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb650>, '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': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', '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 15:27:04 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 15:27:04 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 15:27:04 INFO - Using env: {'DISPLAY': ':0', 15:27:04 INFO - 'HOME': '/home/cltbld', 15:27:04 INFO - 'LANG': 'en_US.UTF-8', 15:27:04 INFO - 'LANGUAGE': 'en_US:en', 15:27:04 INFO - 'LOGNAME': 'cltbld', 15:27:04 INFO - 'MAIL': '/var/mail/cltbld', 15:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:04 INFO - 'MOZ_NO_REMOTE': '1', 15:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:04 INFO - 'NO_EM_RESTART': '1', 15:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:04 INFO - 'PWD': '/builds/slave/test', 15:27:04 INFO - 'SHELL': '/bin/bash', 15:27:04 INFO - 'SHLVL': '1', 15:27:04 INFO - 'TERM': 'linux', 15:27:04 INFO - 'TMOUT': '86400', 15:27:04 INFO - 'USER': 'cltbld', 15:27:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', 15:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:04 INFO - '_': '/tools/buildbot/bin/python'} 15:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:04 INFO - Running setup.py (path:/tmp/pip-fp3tDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:04 INFO - Running setup.py (path:/tmp/pip-eQF4zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:04 INFO - Running setup.py (path:/tmp/pip-Bmvs80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:04 INFO - Running setup.py (path:/tmp/pip-7aRT1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:04 INFO - Running setup.py (path:/tmp/pip-n1a6gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:04 INFO - Running setup.py (path:/tmp/pip-L_Xwkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:04 INFO - Running setup.py (path:/tmp/pip-HAM8I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:04 INFO - Running setup.py (path:/tmp/pip-muhBas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:04 INFO - Running setup.py (path:/tmp/pip-hyjZx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:04 INFO - Running setup.py (path:/tmp/pip-Mk1Vr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:04 INFO - Running setup.py (path:/tmp/pip-3HXMXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:05 INFO - Running setup.py (path:/tmp/pip-WvCrTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:05 INFO - Running setup.py (path:/tmp/pip-0NKSRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:05 INFO - Running setup.py (path:/tmp/pip-QuQ3OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:05 INFO - Running setup.py (path:/tmp/pip-NS34g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:05 INFO - Running setup.py (path:/tmp/pip-rTdwtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:05 INFO - Running setup.py (path:/tmp/pip-uXP56g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:07 INFO - Downloading blessings-1.6.tar.gz 15:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:27:07 INFO - Installing collected packages: blessings 15:27:07 INFO - Running setup.py install for blessings 15:27:07 INFO - Successfully installed blessings 15:27:07 INFO - Cleaning up... 15:27:07 INFO - Return code: 0 15:27:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:07 INFO - Reading from file tmpfile_stdout 15:27:07 INFO - Current package versions: 15:27:07 INFO - argparse == 1.2.1 15:27:07 INFO - blessings == 1.6 15:27:07 INFO - blobuploader == 1.2.4 15:27:07 INFO - docopt == 0.6.1 15:27:07 INFO - functools32 == 3.2.3-2 15:27:07 INFO - jsonschema == 2.5.1 15:27:07 INFO - manifestparser == 1.1 15:27:07 INFO - mozInstall == 1.12 15:27:07 INFO - mozcrash == 0.17 15:27:07 INFO - mozdebug == 0.1 15:27:07 INFO - mozdevice == 0.48 15:27:07 INFO - mozfile == 1.2 15:27:07 INFO - mozhttpd == 0.7 15:27:07 INFO - mozinfo == 0.9 15:27:07 INFO - mozleak == 0.1 15:27:07 INFO - mozlog == 3.2 15:27:07 INFO - moznetwork == 0.27 15:27:07 INFO - mozprocess == 0.22 15:27:07 INFO - mozprofile == 0.28 15:27:07 INFO - mozrunner == 6.11 15:27:07 INFO - mozscreenshot == 0.1 15:27:07 INFO - mozsystemmonitor == 0.3 15:27:07 INFO - moztest == 0.7 15:27:07 INFO - mozversion == 1.4 15:27:07 INFO - psutil == 3.1.1 15:27:07 INFO - requests == 1.2.3 15:27:07 INFO - wsgiref == 0.1.2 15:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:07 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 0x7f2185ae9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bba2c0>, '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 0x1bbb1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb650>, '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': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', '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 15:27:07 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 15:27:07 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 15:27:07 INFO - Using env: {'DISPLAY': ':0', 15:27:07 INFO - 'HOME': '/home/cltbld', 15:27:07 INFO - 'LANG': 'en_US.UTF-8', 15:27:07 INFO - 'LANGUAGE': 'en_US:en', 15:27:07 INFO - 'LOGNAME': 'cltbld', 15:27:07 INFO - 'MAIL': '/var/mail/cltbld', 15:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:07 INFO - 'MOZ_NO_REMOTE': '1', 15:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:07 INFO - 'NO_EM_RESTART': '1', 15:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:07 INFO - 'PWD': '/builds/slave/test', 15:27:07 INFO - 'SHELL': '/bin/bash', 15:27:07 INFO - 'SHLVL': '1', 15:27:07 INFO - 'TERM': 'linux', 15:27:07 INFO - 'TMOUT': '86400', 15:27:07 INFO - 'USER': 'cltbld', 15:27:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', 15:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:07 INFO - '_': '/tools/buildbot/bin/python'} 15:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:08 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)) 15:27:08 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)) 15:27:08 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)) 15:27:08 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)) 15:27:08 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)) 15:27:08 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)) 15:27:08 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)) 15:27:08 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)) 15:27:08 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)) 15:27:08 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)) 15:27:08 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)) 15:27:08 INFO - Cleaning up... 15:27:08 INFO - Return code: 0 15:27:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2185ae9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bba2c0>, '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 0x1bbb1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb650>, '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': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', '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 15:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:27:08 INFO - Using env: {'DISPLAY': ':0', 15:27:08 INFO - 'HOME': '/home/cltbld', 15:27:08 INFO - 'LANG': 'en_US.UTF-8', 15:27:08 INFO - 'LANGUAGE': 'en_US:en', 15:27:08 INFO - 'LOGNAME': 'cltbld', 15:27:08 INFO - 'MAIL': '/var/mail/cltbld', 15:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:08 INFO - 'MOZ_NO_REMOTE': '1', 15:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:08 INFO - 'NO_EM_RESTART': '1', 15:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:08 INFO - 'PWD': '/builds/slave/test', 15:27:08 INFO - 'SHELL': '/bin/bash', 15:27:08 INFO - 'SHLVL': '1', 15:27:08 INFO - 'TERM': 'linux', 15:27:08 INFO - 'TMOUT': '86400', 15:27:08 INFO - 'USER': 'cltbld', 15:27:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', 15:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:08 INFO - '_': '/tools/buildbot/bin/python'} 15:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:27:08 INFO - Cleaning up... 15:27:08 INFO - Return code: 0 15:27:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2185ae9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bba2c0>, '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 0x1bbb1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb650>, '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': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', '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 15:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:27:08 INFO - Using env: {'DISPLAY': ':0', 15:27:08 INFO - 'HOME': '/home/cltbld', 15:27:08 INFO - 'LANG': 'en_US.UTF-8', 15:27:08 INFO - 'LANGUAGE': 'en_US:en', 15:27:08 INFO - 'LOGNAME': 'cltbld', 15:27:08 INFO - 'MAIL': '/var/mail/cltbld', 15:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:08 INFO - 'MOZ_NO_REMOTE': '1', 15:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:08 INFO - 'NO_EM_RESTART': '1', 15:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:08 INFO - 'PWD': '/builds/slave/test', 15:27:08 INFO - 'SHELL': '/bin/bash', 15:27:08 INFO - 'SHLVL': '1', 15:27:08 INFO - 'TERM': 'linux', 15:27:08 INFO - 'TMOUT': '86400', 15:27:08 INFO - 'USER': 'cltbld', 15:27:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', 15:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:08 INFO - '_': '/tools/buildbot/bin/python'} 15:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:08 INFO - Downloading/unpacking flake8 15:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:27:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:27:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:11 INFO - no previously-included directories found matching 'docs/_build' 15:27:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:27:11 INFO - Running setup.py install for pep8 15:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:11 INFO - no previously-included directories found matching 'docs/_build' 15:27:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:27:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:27:11 INFO - Cleaning up... 15:27:11 INFO - Return code: 0 15:27:11 INFO - Running post-action listener: _resource_record_post_action 15:27:11 INFO - Running post-action listener: _start_resource_monitoring 15:27:11 INFO - Starting resource monitoring. 15:27:11 INFO - ##### 15:27:11 INFO - ##### Finished create-virtualenv step (success) 15:27:11 INFO - ##### 15:27:11 INFO - ##### 15:27:11 INFO - ##### Running install step. 15:27:11 INFO - ##### 15:27:11 INFO - Running pre-action listener: _resource_record_pre_action 15:27:11 INFO - Running main action method: install 15:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:11 INFO - Reading from file tmpfile_stdout 15:27:11 INFO - Detecting whether we're running mozinstall >=1.0... 15:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:27:11 INFO - Reading from file tmpfile_stdout 15:27:11 INFO - Output received: 15:27:11 INFO - Usage: mozinstall [options] installer 15:27:11 INFO - Options: 15:27:11 INFO - -h, --help show this help message and exit 15:27:11 INFO - -d DEST, --destination=DEST 15:27:11 INFO - Directory to install application into. [default: 15:27:11 INFO - "/builds/slave/test"] 15:27:11 INFO - --app=APP Application being installed. [default: firefox] 15:27:11 INFO - mkdir: /builds/slave/test/build/application 15:27:11 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'] 15:27:11 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 15:27:27 INFO - Reading from file tmpfile_stdout 15:27:27 INFO - Output received: 15:27:27 INFO - /builds/slave/test/build/application/firefox/firefox 15:27:27 INFO - Running post-action listener: _resource_record_post_action 15:27:27 INFO - ##### 15:27:27 INFO - ##### Finished install step (success) 15:27:27 INFO - ##### 15:27:27 INFO - ##### 15:27:27 INFO - ##### Running run-tests step. 15:27:27 INFO - ##### 15:27:27 INFO - Running pre-action listener: _resource_record_pre_action 15:27:27 INFO - Running main action method: run_tests 15:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:27:27 INFO - Python 2.7.3 15:27:27 INFO - Return code: 0 15:27:27 INFO - grabbing minidump binary from tooltool 15:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:27 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 0x1bba2c0>, '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 0x1bbb1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:27:27 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 15:27:27 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 15:27:27 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 15:27:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:27:27 INFO - Return code: 0 15:27:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:27:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:27:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:27:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:27:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:27:28 INFO - Return code: 0 15:27:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:27:28 INFO - Using env: {'DISPLAY': ':0', 15:27:28 INFO - 'HOME': '/home/cltbld', 15:27:28 INFO - 'LANG': 'en_US.UTF-8', 15:27:28 INFO - 'LANGUAGE': 'en_US:en', 15:27:28 INFO - 'LOGNAME': 'cltbld', 15:27:28 INFO - 'MAIL': '/var/mail/cltbld', 15:27:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:27:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:28 INFO - 'MOZ_NO_REMOTE': '1', 15:27:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:28 INFO - 'NO_EM_RESTART': '1', 15:27:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:28 INFO - 'PWD': '/builds/slave/test', 15:27:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:27:28 INFO - 'SHELL': '/bin/bash', 15:27:28 INFO - 'SHLVL': '1', 15:27:28 INFO - 'TERM': 'linux', 15:27:28 INFO - 'TMOUT': '86400', 15:27:28 INFO - 'USER': 'cltbld', 15:27:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167', 15:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:28 INFO - '_': '/tools/buildbot/bin/python'} 15:27:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:27:29 INFO - mozversion application_buildid: 20160625144323 15:27:29 INFO - mozversion application_changeset: afb7cb42a98a66de401af5bcf7de03733f2784cd 15:27:29 INFO - mozversion application_display_name: Nightly 15:27:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:27:29 INFO - mozversion application_name: Firefox 15:27:29 INFO - mozversion application_remotingname: firefox 15:27:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:27:29 INFO - mozversion application_vendor: Mozilla 15:27:29 INFO - mozversion application_version: 50.0a1 15:27:29 INFO - mozversion platform_buildid: 20160625144323 15:27:29 INFO - mozversion platform_changeset: afb7cb42a98a66de401af5bcf7de03733f2784cd 15:27:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:27:29 INFO - mozversion platform_version: 50.0a1 15:27:29 INFO - using testdate: 1466893649 15:27:29 INFO - actual date: 1466893649 15:27:29 INFO - starting webserver on 'localhost:58651' 15:27:29 INFO - SUITE-START | Running 2 tests 15:27:29 INFO - TEST-START | dromaeo_css 15:27:29 INFO - operating with platform_type : linux_ 15:27:29 INFO - Initialising browser for dromaeo_css test... 15:27:29 INFO - TEST-INFO | started process 3329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC9Iphy/profile http://localhost:58651/getInfo.html) 15:27:34 INFO - PROCESS | 3329 | __metrics Screen width/height:1600/1200 15:27:34 INFO - PROCESS | 3329 | colorDepth:24 15:27:34 INFO - PROCESS | 3329 | Browser inner width/height: 1024/697 15:27:34 INFO - PROCESS | 3329 | __metrics 15:27:35 ERROR - PROCESS | 3329 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:27:36 INFO - TEST-INFO | 3329: exit 0 15:27:36 INFO - Browser initialized. 15:27:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:27:36 INFO - TEST-INFO | started process 3447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC9Iphy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:48 INFO - PROCESS | 3447 | RSS: Main: 186060800 15:27:48 INFO - PROCESS | 3447 | 15:28:38 INFO - PROCESS | 3447 | 1466893718257 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] 15:30:50 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58651/tests/dromaeo/cssquery-ext.html) 15:30:51 INFO - PROCESS | 3447 | RSS: Main: 188944384 15:30:51 INFO - PROCESS | 3447 | 15:33:53 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-ext.html (next: http://localhost:58651/tests/dromaeo/cssquery-jquery.html) 15:33:54 INFO - PROCESS | 3447 | RSS: Main: 187469824 15:33:54 INFO - PROCESS | 3447 | 15:36:56 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58651/tests/dromaeo/cssquery-mootools.html) 15:36:57 INFO - PROCESS | 3447 | RSS: Main: 189366272 15:36:57 INFO - PROCESS | 3447 | 15:39:58 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58651/tests/dromaeo/cssquery-prototype.html) 15:39:59 INFO - PROCESS | 3447 | RSS: Main: 186769408 15:39:59 INFO - PROCESS | 3447 | 15:43:02 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58651/tests/dromaeo/cssquery-yui.html) 15:43:02 INFO - PROCESS | 3447 | RSS: Main: 188690432 15:43:02 INFO - PROCESS | 3447 | 15:46:05 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:58651/tests/dromaeo/cssquery-yui.html (next: http://localhost:58651/tests/dromaeo/cssquery-dojo.html) 15:46:05 INFO - PROCESS | 3447 | RSS: Main: 189480960 15:46:05 INFO - PROCESS | 3447 | 15:46:05 INFO - PROCESS | 3447 | __start_tp_report 15:46:05 INFO - PROCESS | 3447 | _x_x_mozilla_page_load 15:46:05 INFO - PROCESS | 3447 | _x_x_mozilla_page_load_details 15:46:05 INFO - PROCESS | 3447 | |i|pagename|runs| 15:46:05 INFO - PROCESS | 3447 | |0;dojo.html;2638.9472210555787;2673.4653069386122;2683.5840444731075;2689.825161364511;2696.3393968477726;4809.8316558920405;4840.588549973252;4849.781759820812;4941.752912354385;4981.576565991886;4787.186178349681;4883.413990321157;4914.336564563783;4935.087008903355;4948.5051494850495;4470.128324976639;4487.865364039068;4529.449902747996;4601.884952876171;4676.298555216711;4283.143371325732;4550.408446901898;4571.725696458207;4577.862664120065;4618.099470603233;4418.624416924566;4448.088141930896;4460.442444694413;4512.751798651073;4555.111753208109;4459.331100334944;4469.888252793674;4526.818927242906;4578.748168850712;4591.265397536412;4485.1254005468945;4548.863534093983;4549.27211646135;4570.748608826513;4603.470600880908;4836.733979631119;4887.975560122212;4915.3364295819965;4925.2858335541505;4928.926066109011;5221.477852214786;5268.236105764643;5270.947290527122;5285.841424757264;5306.124489459235;5084.8220312288895;5258.2638430619745;5311.442298558673;5316.043112239795;5333.626646134772;4906.411230652309;4931.013797240566;4956.207006878882;4956.306117143603;5008.6744361616375;5435.537979271806;5444.8094316698725;5447.536959358499;5450.809221677222;5505.311836020497;5099.4390617032095;5111;5172.5344718975475;5211.322528071327;5220.295260139908;5125.051865404912;5134;5178.585713142939;5207.114790485551;5209.348831396075;5122.846314610493;5148.17629179337;5190.870228244324;5214.32213812202;5222.686638801684;4991.301217829507;5145.9742701287005;5177.145770947752;5189.299444574934;5251.606129540223;4391.758453285036;4421.182081314967;4429.958959644481;4467.486239082482;4470.150671372494;3838.9424158637644;3844.9038774030314;3846.5961074086817;3874.535055793323;3901.6878649707955;4517.593416592523;4618.1918164321105;4648.3259927310355;4657.836975705834;4672.976635116871;5373.086575282211;5391.946080539223;5392.784288628411;5402.37872644643;5426.321709786277;4637.791299391535;4675.2052151134385;4680.625549955996;4683.648726345537;4726.149293127201;4654.930176047362;4693.718376897397;4725.3384526166365;4765;4849.515048495193;4984.252362145562;4999.625028122978;5011.473795251446;5017.648764586444;5052.115879721034;5359.758810853443;5375.3280839895015;5396.055690254111;5396.3524377075;5430.40265570779;4848.927266090941;4903.8528844134735;4924.655274130777;4935.309056731989;5015.1975683890405;5175.301334319819;5175.430702622633;5184.585233181412;5186.377634683862;5192.948070519246;5258.868528286824;5259.47405259471;5262.868428289324;5263.631545791758;5314.468553144655;4974.452810190804;5083.38999320084;5109.3613298337705;5133.614978876674;5153.3558305211845;5105;5140.794368225229;5143.228515722672;5144.6655967362;5179.792808287626;4898.828541001048;5037.647364684583;5051.570616497639;5065.240213967934;5076.441591424867;5114.309568208244;5172.250023746611;5174.172132458789;5183.196604526304;5187.403448603459;5067.366579177603;5080.974595127149;5084.542391184811;5085.160948443466;5096.617753668415 15:46:05 INFO - PROCESS | 3447 | |1;ext.html;583.8160979291523;590.9054551271796;602.5721737566328;608.6895683201568;608.8934436473618;32534.67465325346;33095.33809323815;36076.45885311716;36190.09524761879;36215;36866.078348041316;37586.43620345697;37869;37883.43174852379;37909.999999999935;7559.168491465948;7755.185705500898;7770.883436748425;7791.649375778075;7796.493227940194;7666.501677390979;7710.57591832449;7766;7768.378529717609;7789.337906277973;7758.069031716202;7801.492902961318;7808.3362914152085;7810.218978102201;7811.648475818602;7707.344875685545;7743.651535680908;7744.303012728825;7748.380129589619;7752.263534964198;7601.315881570686;7654.464187506876;7660.425468089916;7669.769906902802;7691.153973062958;35725.28549429023;36041.45937810935;36159.4576081359;36201;36284.63715362865;2330.4057465346395;2887.4658188235244;3135.984320078408;3230.321632457163;3547.3614749345106;27569.724302757117;27714.307142321402;27725.86137069322;27917.302067448272;28073.85963070192;3334.916627084318;3419.5212670226188;3420.0765793235937;3451.948220776665;3475.4960530723156;218402;220661;221737;222152;222176;30789.538156927665;32056.67943320537;32062.519062214087;32126.83936580302;32215.838920805247;31991.360172796412;33927;34069.14827129292;34100.658993410245;34137;13339.333033348294;13365.665858353424;13389.66525836862;13403.463861445627;13467.730645387233;10750.301230420155;10803.567857285621;10860.728481788019;10899.29154604964;10899.782004359868;7801.921980780233;7828.373730101578;7838.882416763753;7872.33085187754;7872.72445464406;3047.7104675055834;3115.2679120406688;3133.4516459619476;3149.6692847251165;3167.6990685885266;900.7432881628704;904.263025634106;927.7726956895604;929.4284015330524;975.5171190260867;28363.149105526867;28460.146195614165;28886.422271554453;29277.56083658747;29307.560386594218;938.1134827587864;988.4514094677523;1021.667957913681;1063.3194755356578;1072.3565860483648;14656.78014829757;14675.48635797742;14863.331150098054;15072;15300.693986120437;387866;390520;390905;392575;393141;48792.26811597829;49033.509664903606;49261;49381;49506.504934950906;1165.9825102623468;1189.7263629365295;1208.7219939413808;1228.1341654133994;1228.8095345221504;26569.468610628064;27603.30991725223;27846.379970604503;28113;28564.42871142524;40935.59064409318;41181.58818411898;41433.37849932314;41451.58548414477;41570.58429415667;324583;325289;325691;326547;326696;22354.32937011892;22927.426814329774;25008.874955625106;25341.366465838502;25376.238712838644;42325.78837105795;42354.576454235066;42795.57204427916;43296.78351608222;44686;36626;37228.62771372252;37764.62235377611;37973.62026379811;38355.424668629435;36454.81772591226;36473.817630911675;36537.81731091328;37107.628923710414;37604;36202;36259.818700906326;36600.81699591485;37465.81267093647;37705.62294377021;31194.376112478076;34002.31995360128;34044.31911361808;34282;34284.82857585796;25662.871685641454;25666.230013099637;26286.86856565705;27564.448711026067;28011.159665210078 15:46:05 INFO - PROCESS | 3447 | |2;jquery.html;375.352516908333;378.30958500736153;380.2414183703512;380.68403225322976;392.3154096102302;16168.191590420476;16655.58361040973;17485.388011419618;17501.212445439953;18109.275628974858;10563.683089507327;10904.073153781937;10926.125909927207;10928.562857485691;10942.23404361695;4545.909081818353;4787.066522028206;5152.6650767699975;5488.53347465466;5535.667859928397;5508.91736623951;5535.501804837564;5562.3047119110115;5566.888662226753;5584.050711379055;5356.303680521527;5548.001359755242;5578.665280083188;5592.804251851186;5599.63602365847;5575.972120139394;5582.804601838937;5619.072852979253;5646.322441307028;5658.91511627326;5361.81233656824;5650;5652.0391533439415;5653.9151912721345;5671.659700417947;11868;12426.068044896669;12432.12975091744;18627;19864.70202946957;1864.925402983879;1865.020864046373;1875.6154988227381;1929.3440230321617;2374.27584586701;8988.280937524982;9045.954770226173;9058.728238152866;9442.905570944271;9618.75953101171;1558.6259297768568;1692.3907393338388;1757.2707326459504;1803.332766876251;1860.283790740561;53414.73292633512;60336.09495857565;60370;61394;69434;9479.672845801593;9500.857487137699;9702.466364349888;9811.411315321104;9900.405975641484;14124.788128178085;14232.501862434765;14315.28423578817;14338.426462941574;14341.56975290743;6833.3166683332265;6911.308869113049;6975.197852246955;7018.473614478935;7258.927410725931;6441.742330306735;6864.347886950832;6880.311968803079;6951.200611929693;6966.825829354307;4464.776761161994;4472.9105417892115;4539.046800171935;4541.341505481687;4544.659150563721;1855.2857149997349;1885.915133818954;1906.7235250888543;1914.607505461377;1933.1494142577221;793.9483933544417;852.9061803201643;853.3642436384933;890.8351954888367;923.5336155241695;16628.25172867224;17121.315147394213;17330.82669173292;17344.826551734575;17363.392281270095;865.9177378149066;893.3523195683208;903.8327909336793;949.7103383468109;958.9712308630752;9411.811763764823;9532.380395274286;9719.125278724949;9796.118349348593;9877.40735555869;378433;382882;387556;388228;389071;48634.75682621564;59858;76398;79283;82799.5860020696;792.6987744656993;893.5353616119581;904.3759805733891;920.8572671235969;927.2859897878595;15718.528444146694;15806.130662813195;15912.44306449315;15929.761053584438;16062.196890155212;35209.47185792266;37148.44277335896;37702.811485942395;38010;38339.2332153361;50678;50878.236826448374;50888;52195.47804521906;53208.467915320354;7697.961510192413;7853.921460785319;7870.409719270963;8013.15861834499;8136.837263254583;10001.749956251151;11838.171328007302;12083.57707480234;12182.451789669663;12266.815997759863;9612.375195612263;10326.638567650096;10382.428966406618;10614.257002009785;10705;10650.467476626292;10734.73163170927;10742.462876856282;10876.891231087904;10901;10547.789044219226;10735.302205356627;10747.193960452842;10840.566377344818;10859.239853210516;7806.4925779824125;8025.59872006409;8108.918910810817;8202.83594328122;8218.137095604876;8005.599720014093;9505.859296884419;10404.791904161722;10854.565817367533;10868.293560918515 15:46:05 INFO - PROCESS | 3447 | |3;mootools.html;1351;1399.1814788348815;1432.6561625209947;1539.199616199577;1573.90556566606;6698.631575263358;7377.225391333913;7397.149327827301;7997.88003179952;7999.040115186179;7620.847583048336;7791.805204869867;7866.410019248565;7867.1739467355965;7875.251851074153;2164.653655415134;2191.4302281406867;2194.967075493869;2199.197292988056;2201.4056204824687;2111.5565731196466;2139.422355963889;2153.849230553862;2158.686990386393;2158.7085743424673;2123.851330406872;2128.57428514297;2151.236311109557;2158.4495953531828;2193.1556350804894;2123.140128248062;2126.915273210658;2132.402927180392;2135.519508110678;2149.3229632665816;2068.8241499472565;2070.554830711389;2099;2099.3177217404404;2114.3551216878845;7896.802579935547;7943.324817390471;7953.0853951795125;7958.283754462068;7981.760547183594;4474.485434175079;4597.448306203277;4607;4611.815527378901;4621.976890115528;2794.273488892882;2833.4474777418413;2891.7975741698087;2911.243076800026;2937;863.6459051788736;893.6559424621568;895.1317222294364;914.8216097860919;918.0727465260069;10648.57405703771;10659.520321585547;10669.253152279343;10679.519421626046;10703.839442408447;4118.979405102956;4158.792060396968;4290.4636920384955;4295.398644189816;4351.6518678505645;9187.95406022979;9202.447853128833;9233.769155771159;9234.122758337948;9236.769080773034;4606.516315786861;4636.5131661175765;4666.066786642685;4683.812647494062;4723.173444647173;3695.168587067942;4081.0409553754844;4227.42929704486;4252.362145678111;4268.338407546835;3578.7673801202836;3581.8925432237074;3618.131648404364;3668.834902429397;3775.6601905828607;1146.1633007904277;1164.2257898497405;1169.7543515861594;1185.8991985681314;1187.6080893305189;703.3704834173386;856.6593281514535;861.440063958432;861.7113267055481;871.7166920750782;5205.29728486657;5210.8957820844125;5228.660137091153;5326.36083669962;5328.440513746078;406.60153050011155;410.41106012871626;419.09057345560205;419.5280309651642;424.1241835609518;3635.94546081809;3663.505426767352;3680.1719613087375;3729.1050147964293;3767.1147280389637;9240.399374040666;9463.668771593098;9648.662296819577;9691.418514889128;9719;9391.671291504901;9494.24046076326;9531.428114313163;9568.712938611852;9658.082482164184;7355.8161045974275;7427.18300986891;7436.73971410998;7459.291367320096;7482.8877566836545;5068.847934561969;5106.846794596168;5138.871528211825;5276.498732620395;5329.040772660803;8844.55777211124;8959;8995.685151019945;9018.639254429749;9024.774380640536;8737.563121843756;9143.222826059859;9188.908110918805;9192.816143677222;9241.861372079558;6073.787417440369;6538.967305163444;6727.192736871607;6747.089142965833;6780.254172040973;7520.962395187989;7565.962170189114;7567.508111972704;7588.734394296173;7628.54228746277;6357.8728425432155;6502.796982558053;6533.444657204191;6568.7372505099265;6662.6335551545135;6347.333529979471;6461.321561236003;6473.676316184266;6537.901931470937;6555.082288479712;6139.1098290746695;6183.5671502994355;6194.256689197145;6200.3179650237535;6208.627482351073;4700.92948605778;4720.952790472052;4756;4772.069446457907;4867.123917694849;4499.460064792246;4748.691335063209;4811.013742182914;4870.366852309319;4875.878103047452 15:46:05 INFO - PROCESS | 3447 | |4;prototype.html;285.47472650323414;285.9961535012107;287.9049913528536;299.1578705942771;306.4973443552573;5213.139831927732;5234.816781412651;5250.684958902469;5275.36695596529;5276.445973172815;5100.183970564701;5129.974005198957;5132.974335128329;5141.82003629873;5168.61235407345;3797.221569578244;3951.940720889189;4008.2183974125055;4049.412835138903;4055.776932268724;4008.9599104009026;4030.637242648161;4043.150938302945;4049.919001619966;4078.775667338295;4040.676745860339;4044.2407552714517;4057.756534607918;4057.898552536181;4072.429859819628;3733.290674771785;3979.2240513099955;3984.1234928315725;4053.9189216215805;4073.429719839225;3417.726581873444;3442.7417943654077;3478.843452044639;3492.3364560733635;3502.684758371733;4981.1532039553;4996.625253105995;5013.724245166514;5022.321986531844;5029.497050294978;4265.893352666177;4501.774911254424;4518.68958002179;4546.249868771649;4567.862964111082;5361.946380536184;5373.81191658294;5386.865328366783;5402.297701298845;5407.540359069484;3774.8112594370173;3780.1683629601443;3781.6953151162807;3787.1478917243676;3806.2958352704836;5325.600579956519;5574.386817450078;5592.412796656333;5605.747741351608;5625.437456254342;3848.7883166425554;3856.82644281008;3868.6324799144036;3876.8255428505786;3902.282995481979;3934.8426062957733;3940.5074365704286;3945.447637330776;3966.36538153894;3971.3447281198855;4492.640588752892;4518.480374756879;4539.682222244477;4542.545745425431;4551.180787458223;5094.337736094284;5292.814751483679;5372.194170874322;5372.5970552207955;5417.995341723508;1321.7620828251006;1340.1757918879819;1341.6176389729076;1360.177092858826;1360.9183448993092;839.3201506779528;854.8160797295666;877.6752601537472;880.7445840706251;885.1767855893952;4746.833860814855;4754.904901902012;4755.785989630475;4776.331313616097;4777.8327758528285;5475.4524547545725;5476.342838859283;5496.395396506381;5520.309961254843;5524.309461317335;4610.2854057621125;4704.741239231875;4721.551452612065;4721.875156179733;4762.690425122356;2943.3818898031227;2947.7199666031693;2948.3366242595675;2954.320506283567;2955.4089182163652;5102.489751024942;5104.285400043997;5119.513646203604;5143.537081662668;5152.042223954873;5467.671939683552;5593.188987596775;5633.408492108351;5649.898269837425;5677.233573467529;5026.974865125578;5112.846614601568;5126.53861152498;5183.626339020163;5194.844154675366;5443.60481388188;5444.237806707143;5446.891062178814;5456.59075569326;5458.426865179258;5066.82266120684;5285.603579731613;5333.573314134782;5338.733063346895;5344.579469139831;5075.974620126875;5112.9744351278005;5139.691618502902;5157.277981082577;5165.690058596496;3761.981190094032;3781.77092444951;3789.2800367930004;3792.9431058534697;3793.577408471823;5265.894493936415;5367.785288588413;5375;5388.676679399248;5392.541633961;5260.947390526198;5293.8088929990445;5296.285001524899;5302.814401495929;5303.867403314794;5000.374953130859;5269.631125821155;5275.577953763613;5291.365036195682;5314.2365969694765;5121.411037730709;5145.562627176732;5170.353705786777;5172.741362931763;5237.397699264633;5067.77195026232;5301.920471193012;5445.727713614383;5463.344398672185;5465.918011229755;5272.103742363731;5273.419923808301;5312.282841816305;5328.786848526171;5357.910414938256 15:46:05 INFO - PROCESS | 3447 | |5;yui.html;650.5283669339726;706.6678661029316;725.6371814092954;729.3800269770692;764.1635032739259;12468.750624987495;12783.424745886447;12807.679808004805;12816.423260953256;12834.294113823737;13810.309484525758;14393.424263029467;14421.711565768705;14891.329890154942;14977.700445991073;802.9317508011826;804.8511025460308;809.6356639512213;810.0603300171801;811.3428123220181;633.5153607490273;768.1243382543904;798.5727635714894;801.6272433318505;802.0936341933607;837.539353355655;839.7564706235185;841.8442588121187;850.2560259772699;851.5614458553819;829.266099501939;836.1220718245878;837.9622916968751;845.0535400351615;845.3364109174299;610.2920612089954;613.208960441035;613.7698363113832;614.5759425996048;615.5291202230297;13833.654158646114;13918.02573819833;13918.443262269497;13937.303134843318;13956.09285396446;12938.87061129386;13044.28256445895;13150.342482875818;13166.144200627024;13188.472461101544;9852.261080418997;9987.101160895554;10092.243081768896;10095.747606309827;10195.388276703421;3336.2660214752714;3346.2303670155757;3394.1684287349512;3398.9490157647656;3474.3572439098593;60450.697746511425;60640.09039864405;60726.999999999556;60802.391976080115;60997.390026099616;10544.156467482582;10569.21478875001;10594.629187978384;10608.363498190134;10736.409497477558;18909.527261818566;18964.43106706801;19174;19235.90382048081;19519.804801952083;6912.619805910623;6948.583085014915;6966.3730264276455;7006.859862802716;7049.647517624098;3719.1074142206216;3719.5350581177354;3736.2855582584198;3740.6446387593137;3782.451544526028;2853.543433050702;2986.2385091801884;2987.4025194961096;2991.0578167877047;2997.7601791857037;484.3461327208241;485.9368282123301;489.5838537243386;493.40791050739256;503.4788993391822;461.42552522109514;491.82786024891004;567.2795549651919;598.8322770597352;605.9121427393003;7891.131975482693;7900.486468379652;7936.523808571389;8165.428420010661;8348.499090054616;473.2404490792298;504.91668874635275;545.5035917315224;554.3569459427046;572.4104172702123;4265.296226122717;4337.696361254745;4397.758123303249;4466.240739074366;4510.436195475566;105363;107223;107800;108667;112681;88799.55600221957;90552.5472372634;91541;91814.54092729493;92162.53918730498;81268.59365703134;81869;82405.17594824095;84330.5783471091;84346.99999999878;8711.782205444915;8811.162939520735;8930.19628233462;8970.955145224232;9386.389884657476;36741.63258367382;39762.40356394598;40232.396514051725;41921.58078419177;42050.15899681928;60802;61485.385146149754;61710.382896170464;64000.35999639944;64524;11449.484773185393;11504.769904602028;11524.193306468467;11564.826527602261;11588.362640054878;12045;12057.457414416547;12185.939070304592;12373.195742276723;12810.807837882625;11733.823992639946;11740.530378784753;11809.763804724029;12088.516459341528;12246;10680.145588352758;10863.67408977732;11257.605983790529;11370.54517819278;11392.886071139514;10897.945510272715;11205.60780372683;11316.321020738782;11499.54001839917;11528;9482.24142068619;9589.952050239704;9797.755056123653;9915.256355773201;9928.404295742279;9930.652427165014;10177.389356638329;10615.256932014685;10936.726581835517;11066.557337706723 15:46:05 INFO - PROCESS | 3447 | __end_tp_report 15:46:05 INFO - PROCESS | 3447 | __start_cc_report 15:46:05 INFO - PROCESS | 3447 | _x_x_mozilla_cycle_collect,401 15:46:05 INFO - PROCESS | 3447 | __end_cc_report 15:46:05 INFO - PROCESS | 3447 | __startTimestamp1466894765881__endTimestamp 15:46:05 INFO - PROCESS | 3447 | 15:46:05 INFO - PROCESS | 3447 | ------- Summary: start ------- 15:46:05 INFO - PROCESS | 3447 | Number of tests: 6 15:46:05 INFO - PROCESS | 3447 | 15:46:05 INFO - PROCESS | 3447 | [#0] dojo.html Cycles:165 Average:4867.18 Median:4999.63 stddev:522.14 (10.4%) stddev-sans-first:493.62 15:46:05 INFO - PROCESS | 3447 | Values: 2638.9 2673.5 2683.6 2689.8 2696.3 4809.8 4840.6 4849.8 4941.8 4981.6 4787.2 4883.4 4914.3 4935.1 4948.5 4470.1 4487.9 4529.4 4601.9 4676.3 4283.1 4550.4 4571.7 4577.9 4618.1 4418.6 4448.1 4460.4 4512.8 4555.1 4459.3 4469.9 4526.8 4578.7 4591.3 4485.1 4548.9 4549.3 4570.7 4603.5 4836.7 4888.0 4915.3 4925.3 4928.9 5221.5 5268.2 5270.9 5285.8 5306.1 5084.8 5258.3 5311.4 5316.0 5333.6 4906.4 4931.0 4956.2 4956.3 5008.7 5435.5 5444.8 5447.5 5450.8 5505.3 5099.4 5111.0 5172.5 5211.3 5220.3 5125.1 5134.0 5178.6 5207.1 5209.3 5122.8 5148.2 5190.9 5214.3 5222.7 4991.3 5146.0 5177.1 5189.3 5251.6 4391.8 4421.2 4430.0 4467.5 4470.2 3838.9 3844.9 3846.6 3874.5 3901.7 4517.6 4618.2 4648.3 4657.8 4673.0 5373.1 5391.9 5392.8 5402.4 5426.3 4637.8 4675.2 4680.6 4683.6 4726.1 4654.9 4693.7 4725.3 4765.0 4849.5 4984.3 4999.6 5011.5 5017.6 5052.1 5359.8 5375.3 5396.1 5396.4 5430.4 4848.9 4903.9 4924.7 4935.3 5015.2 5175.3 5175.4 5184.6 5186.4 5192.9 5258.9 5259.5 5262.9 5263.6 5314.5 4974.5 5083.4 5109.4 5133.6 5153.4 5105.0 5140.8 5143.2 5144.7 5179.8 4898.8 5037.6 5051.6 5065.2 5076.4 5114.3 5172.3 5174.2 5183.2 5187.4 5067.4 5081.0 5084.5 5085.2 5096.6 15:46:05 INFO - PROCESS | 3447 | 15:46:05 INFO - PROCESS | 3447 | [#1] ext.html Cycles:180 Average:45123.93 Median:35883.37 stddev:84639.96 (235.9%) stddev-sans-first:84811.33 15:46:05 INFO - PROCESS | 3447 | Values: 583.8 590.9 602.6 608.7 608.9 32534.7 33095.3 36076.5 36190.1 36215.0 36866.1 37586.4 37869.0 37883.4 37910.0 7559.2 7755.2 7770.9 7791.6 7796.5 7666.5 7710.6 7766.0 7768.4 7789.3 7758.1 7801.5 7808.3 7810.2 7811.6 7707.3 7743.7 7744.3 7748.4 7752.3 7601.3 7654.5 7660.4 7669.8 7691.2 35725.3 36041.5 36159.5 36201.0 36284.6 2330.4 2887.5 3136.0 3230.3 3547.4 27569.7 27714.3 27725.9 27917.3 28073.9 3334.9 3419.5 3420.1 3451.9 3475.5 218402.0 220661.0 221737.0 222152.0 222176.0 30789.5 32056.7 32062.5 32126.8 32215.8 31991.4 33927.0 34069.1 34100.7 34137.0 13339.3 13365.7 13389.7 13403.5 13467.7 10750.3 10803.6 10860.7 10899.3 10899.8 7801.9 7828.4 7838.9 7872.3 7872.7 3047.7 3115.3 3133.5 3149.7 3167.7 900.7 904.3 927.8 929.4 975.5 28363.1 28460.1 28886.4 29277.6 29307.6 938.1 988.5 1021.7 1063.3 1072.4 14656.8 14675.5 14863.3 15072.0 15300.7 387866.0 390520.0 390905.0 392575.0 393141.0 48792.3 49033.5 49261.0 49381.0 49506.5 1166.0 1189.7 1208.7 1228.1 1228.8 26569.5 27603.3 27846.4 28113.0 28564.4 40935.6 41181.6 41433.4 41451.6 41570.6 324583.0 325289.0 325691.0 326547.0 326696.0 22354.3 22927.4 25008.9 25341.4 25376.2 42325.8 42354.6 42795.6 43296.8 44686.0 36626.0 37228.6 37764.6 37973.6 38355.4 36454.8 36473.8 36537.8 37107.6 37604.0 36202.0 36259.8 36600.8 37465.8 37705.6 31194.4 34002.3 34044.3 34282.0 34284.8 25662.9 25666.2 26286.9 27564.4 28011.2 15:46:05 INFO - PROCESS | 3447 | 15:46:05 INFO - PROCESS | 3447 | [#2] jquery.html Cycles:180 Average:23535.67 Median:50778.12 stddev:63404.38 (124.9%) stddev-sans-first:63558.39 15:46:05 INFO - PROCESS | 3447 | Values: 375.4 378.3 380.2 380.7 392.3 16168.2 16655.6 17485.4 17501.2 18109.3 10563.7 10904.1 10926.1 10928.6 10942.2 4545.9 4787.1 5152.7 5488.5 5535.7 5508.9 5535.5 5562.3 5566.9 5584.1 5356.3 5548.0 5578.7 5592.8 5599.6 5576.0 5582.8 5619.1 5646.3 5658.9 5361.8 5650.0 5652.0 5653.9 5671.7 11868.0 12426.1 12432.1 18627.0 19864.7 1864.9 1865.0 1875.6 1929.3 2374.3 8988.3 9046.0 9058.7 9442.9 9618.8 1558.6 1692.4 1757.3 1803.3 1860.3 53414.7 60336.1 60370.0 61394.0 69434.0 9479.7 9500.9 9702.5 9811.4 9900.4 14124.8 14232.5 14315.3 14338.4 14341.6 6833.3 6911.3 6975.2 7018.5 7258.9 6441.7 6864.3 6880.3 6951.2 6966.8 4464.8 4472.9 4539.0 4541.3 4544.7 1855.3 1885.9 1906.7 1914.6 1933.1 793.9 852.9 853.4 890.8 923.5 16628.3 17121.3 17330.8 17344.8 17363.4 865.9 893.4 903.8 949.7 959.0 9411.8 9532.4 9719.1 9796.1 9877.4 378433.0 382882.0 387556.0 388228.0 389071.0 48634.8 59858.0 76398.0 79283.0 82799.6 792.7 893.5 904.4 920.9 927.3 15718.5 15806.1 15912.4 15929.8 16062.2 35209.5 37148.4 37702.8 38010.0 38339.2 50678.0 50878.2 50888.0 52195.5 53208.5 7698.0 7853.9 7870.4 8013.2 8136.8 10001.7 11838.2 12083.6 12182.5 12266.8 9612.4 10326.6 10382.4 10614.3 10705.0 10650.5 10734.7 10742.5 10876.9 10901.0 10547.8 10735.3 10747.2 10840.6 10859.2 7806.5 8025.6 8108.9 8202.8 8218.1 8005.6 9505.9 10404.8 10854.6 10868.3 15:46:05 INFO - PROCESS | 3447 | 15:46:05 INFO - PROCESS | 3447 | [#3] mootools.html Cycles:180 Average:5119.77 Median:5087.85 stddev:2898.16 (57.0%) stddev-sans-first:2892.45 15:46:05 INFO - PROCESS | 3447 | Values: 1351.0 1399.2 1432.7 1539.2 1573.9 6698.6 7377.2 7397.1 7997.9 7999.0 7620.8 7791.8 7866.4 7867.2 7875.3 2164.7 2191.4 2195.0 2199.2 2201.4 2111.6 2139.4 2153.8 2158.7 2158.7 2123.9 2128.6 2151.2 2158.4 2193.2 2123.1 2126.9 2132.4 2135.5 2149.3 2068.8 2070.6 2099.0 2099.3 2114.4 7896.8 7943.3 7953.1 7958.3 7981.8 4474.5 4597.4 4607.0 4611.8 4622.0 2794.3 2833.4 2891.8 2911.2 2937.0 863.6 893.7 895.1 914.8 918.1 10648.6 10659.5 10669.3 10679.5 10703.8 4119.0 4158.8 4290.5 4295.4 4351.7 9188.0 9202.4 9233.8 9234.1 9236.8 4606.5 4636.5 4666.1 4683.8 4723.2 3695.2 4081.0 4227.4 4252.4 4268.3 3578.8 3581.9 3618.1 3668.8 3775.7 1146.2 1164.2 1169.8 1185.9 1187.6 703.4 856.7 861.4 861.7 871.7 5205.3 5210.9 5228.7 5326.4 5328.4 406.6 410.4 419.1 419.5 424.1 3635.9 3663.5 3680.2 3729.1 3767.1 9240.4 9463.7 9648.7 9691.4 9719.0 9391.7 9494.2 9531.4 9568.7 9658.1 7355.8 7427.2 7436.7 7459.3 7482.9 5068.8 5106.8 5138.9 5276.5 5329.0 8844.6 8959.0 8995.7 9018.6 9024.8 8737.6 9143.2 9188.9 9192.8 9241.9 6073.8 6539.0 6727.2 6747.1 6780.3 7521.0 7566.0 7567.5 7588.7 7628.5 6357.9 6502.8 6533.4 6568.7 6662.6 6347.3 6461.3 6473.7 6537.9 6555.1 6139.1 6183.6 6194.3 6200.3 6208.6 4700.9 4721.0 4756.0 4772.1 4867.1 4499.5 4748.7 4811.0 4870.4 4875.9 15:46:05 INFO - PROCESS | 3447 | 15:46:05 INFO - PROCESS | 3447 | [#4] prototype.html Cycles:180 Average:4427.12 Median:5097.26 stddev:1288.56 (25.3%) stddev-sans-first:1254.11 15:46:05 INFO - PROCESS | 3447 | Values: 285.5 286.0 287.9 299.2 306.5 5213.1 5234.8 5250.7 5275.4 5276.4 5100.2 5130.0 5133.0 5141.8 5168.6 3797.2 3951.9 4008.2 4049.4 4055.8 4009.0 4030.6 4043.2 4049.9 4078.8 4040.7 4044.2 4057.8 4057.9 4072.4 3733.3 3979.2 3984.1 4053.9 4073.4 3417.7 3442.7 3478.8 3492.3 3502.7 4981.2 4996.6 5013.7 5022.3 5029.5 4265.9 4501.8 4518.7 4546.2 4567.9 5361.9 5373.8 5386.9 5402.3 5407.5 3774.8 3780.2 3781.7 3787.1 3806.3 5325.6 5574.4 5592.4 5605.7 5625.4 3848.8 3856.8 3868.6 3876.8 3902.3 3934.8 3940.5 3945.4 3966.4 3971.3 4492.6 4518.5 4539.7 4542.5 4551.2 5094.3 5292.8 5372.2 5372.6 5418.0 1321.8 1340.2 1341.6 1360.2 1360.9 839.3 854.8 877.7 880.7 885.2 4746.8 4754.9 4755.8 4776.3 4777.8 5475.5 5476.3 5496.4 5520.3 5524.3 4610.3 4704.7 4721.6 4721.9 4762.7 2943.4 2947.7 2948.3 2954.3 2955.4 5102.5 5104.3 5119.5 5143.5 5152.0 5467.7 5593.2 5633.4 5649.9 5677.2 5027.0 5112.8 5126.5 5183.6 5194.8 5443.6 5444.2 5446.9 5456.6 5458.4 5066.8 5285.6 5333.6 5338.7 5344.6 5076.0 5113.0 5139.7 5157.3 5165.7 3762.0 3781.8 3789.3 3792.9 3793.6 5265.9 5367.8 5375.0 5388.7 5392.5 5260.9 5293.8 5296.3 5302.8 5303.9 5000.4 5269.6 5275.6 5291.4 5314.2 5121.4 5145.6 5170.4 5172.7 5237.4 5067.8 5301.9 5445.7 5463.3 5465.9 5272.1 5273.4 5312.3 5328.8 5357.9 15:46:05 INFO - PROCESS | 3447 | 15:46:05 INFO - PROCESS | 3447 | [#5] yui.html Cycles:180 Average:18407.20 Median:4488.34 stddev:27132.64 (604.5%) stddev-sans-first:27176.00 15:46:05 INFO - PROCESS | 3447 | Values: 650.5 706.7 725.6 729.4 764.2 12468.8 12783.4 12807.7 12816.4 12834.3 13810.3 14393.4 14421.7 14891.3 14977.7 802.9 804.9 809.6 810.1 811.3 633.5 768.1 798.6 801.6 802.1 837.5 839.8 841.8 850.3 851.6 829.3 836.1 838.0 845.1 845.3 610.3 613.2 613.8 614.6 615.5 13833.7 13918.0 13918.4 13937.3 13956.1 12938.9 13044.3 13150.3 13166.1 13188.5 9852.3 9987.1 10092.2 10095.7 10195.4 3336.3 3346.2 3394.2 3398.9 3474.4 60450.7 60640.1 60727.0 60802.4 60997.4 10544.2 10569.2 10594.6 10608.4 10736.4 18909.5 18964.4 19174.0 19235.9 19519.8 6912.6 6948.6 6966.4 7006.9 7049.6 3719.1 3719.5 3736.3 3740.6 3782.5 2853.5 2986.2 2987.4 2991.1 2997.8 484.3 485.9 489.6 493.4 503.5 461.4 491.8 567.3 598.8 605.9 7891.1 7900.5 7936.5 8165.4 8348.5 473.2 504.9 545.5 554.4 572.4 4265.3 4337.7 4397.8 4466.2 4510.4 105363.0 107223.0 107800.0 108667.0 112681.0 88799.6 90552.5 91541.0 91814.5 92162.5 81268.6 81869.0 82405.2 84330.6 84347.0 8711.8 8811.2 8930.2 8971.0 9386.4 36741.6 39762.4 40232.4 41921.6 42050.2 60802.0 61485.4 61710.4 64000.4 64524.0 11449.5 11504.8 11524.2 11564.8 11588.4 12045.0 12057.5 12185.9 12373.2 12810.8 11733.8 11740.5 11809.8 12088.5 12246.0 10680.1 10863.7 11257.6 11370.5 11392.9 10897.9 11205.6 11316.3 11499.5 11528.0 9482.2 9590.0 9797.8 9915.3 9928.4 9930.7 10177.4 10615.3 10936.7 11066.6 15:46:05 INFO - PROCESS | 3447 | -------- Summary: end -------- 15:46:05 INFO - PROCESS | 3447 | 15:46:06 INFO - TEST-INFO | 3447: exit 0 15:46:06 INFO - TEST-OK | dromaeo_css | took 1117530ms 15:46:06 INFO - TEST-START | kraken 15:46:06 INFO - operating with platform_type : linux_ 15:46:06 INFO - Initialising browser for kraken test... 15:46:06 INFO - TEST-INFO | started process 3680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYd0D2D/profile http://localhost:58651/getInfo.html) 15:46:11 INFO - PROCESS | 3680 | __metrics Screen width/height:1600/1200 15:46:11 INFO - PROCESS | 3680 | colorDepth:24 15:46:11 INFO - PROCESS | 3680 | Browser inner width/height: 1024/697 15:46:11 INFO - PROCESS | 3680 | __metrics 15:46:12 ERROR - PROCESS | 3680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:46:13 INFO - TEST-INFO | 3680: exit 0 15:46:13 INFO - Browser initialized. 15:46:13 INFO - Running cycle 1/1 for kraken test... 15:46:13 INFO - TEST-INFO | started process 3800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYd0D2D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:25 INFO - PROCESS | 3800 | RSS: Main: 185888768 15:46:25 INFO - PROCESS | 3800 | 15:46:28 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58651/tests/kraken/driver.html?testName=audio-beat-detection) 15:46:29 INFO - PROCESS | 3800 | RSS: Main: 190226432 15:46:29 INFO - PROCESS | 3800 | 15:46:31 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58651/tests/kraken/driver.html?testName=audio-dft) 15:46:32 INFO - PROCESS | 3800 | RSS: Main: 189771776 15:46:32 INFO - PROCESS | 3800 | 15:46:35 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58651/tests/kraken/driver.html?testName=audio-fft) 15:46:36 INFO - PROCESS | 3800 | RSS: Main: 185733120 15:46:36 INFO - PROCESS | 3800 | 15:46:38 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58651/tests/kraken/driver.html?testName=audio-oscillator) 15:46:38 INFO - PROCESS | 3800 | RSS: Main: 186531840 15:46:38 INFO - PROCESS | 3800 | 15:46:41 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:46:41 INFO - PROCESS | 3800 | RSS: Main: 187052032 15:46:41 INFO - PROCESS | 3800 | 15:46:44 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58651/tests/kraken/driver.html?testName=imaging-darkroom) 15:46:45 INFO - PROCESS | 3800 | RSS: Main: 186769408 15:46:45 INFO - PROCESS | 3800 | 15:46:49 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58651/tests/kraken/driver.html?testName=imaging-desaturate) 15:46:49 INFO - PROCESS | 3800 | RSS: Main: 184266752 15:46:49 INFO - PROCESS | 3800 | 15:46:52 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58651/tests/kraken/driver.html?testName=json-parse-financial) 15:46:53 INFO - PROCESS | 3800 | RSS: Main: 185921536 15:46:53 INFO - PROCESS | 3800 | 15:46:54 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:46:55 INFO - PROCESS | 3800 | RSS: Main: 186241024 15:46:55 INFO - PROCESS | 3800 | 15:46:57 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:46:58 INFO - PROCESS | 3800 | RSS: Main: 186437632 15:46:58 INFO - PROCESS | 3800 | 15:47:00 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:47:01 INFO - PROCESS | 3800 | RSS: Main: 186580992 15:47:01 INFO - PROCESS | 3800 | 15:47:04 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:47:05 INFO - PROCESS | 3800 | RSS: Main: 185090048 15:47:05 INFO - PROCESS | 3800 | 15:47:07 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:47:08 INFO - PROCESS | 3800 | RSS: Main: 186544128 15:47:08 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | Cycle 1(1): loaded http://localhost:58651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58651/tests/kraken/driver.html?testName=ai-astar) 15:47:10 INFO - PROCESS | 3800 | RSS: Main: 186650624 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | __start_tp_report 15:47:10 INFO - PROCESS | 3800 | _x_x_mozilla_page_load 15:47:10 INFO - PROCESS | 3800 | _x_x_mozilla_page_load_details 15:47:10 INFO - PROCESS | 3800 | |i|pagename|runs| 15:47:10 INFO - PROCESS | 3800 | |0;ai-astar;105;114;106;113;114;114;115;112;112;113 15:47:10 INFO - PROCESS | 3800 | |1;audio-beat-detection;163;131;171;180;131;156;159;134;198;138 15:47:10 INFO - PROCESS | 3800 | |2;audio-dft;162;168;169;163;161;161;163;161;162;164 15:47:10 INFO - PROCESS | 3800 | |3;audio-fft;75;75;76;151;75;76;79;77;161;78 15:47:10 INFO - PROCESS | 3800 | |4;audio-oscillator;87;87;139;86;88;86;132;86;89;133 15:47:10 INFO - PROCESS | 3800 | |5;imaging-gaussian-blur;117;121;118;118;118;118;118;117;118;118 15:47:10 INFO - PROCESS | 3800 | |6;imaging-darkroom;147;147;151;149;146;148;148;147;148;147 15:47:10 INFO - PROCESS | 3800 | |7;imaging-desaturate;96;96;96;96;96;99;97;96;97;96 15:47:10 INFO - PROCESS | 3800 | |8;json-parse-financial;64;67;65;64;65;64;64;68;65;64 15:47:10 INFO - PROCESS | 3800 | |9;json-stringify-tinderbox;65;64;64;64;66;65;65;68;65;65 15:47:10 INFO - PROCESS | 3800 | |10;stanford-crypto-aes;85;89;83;84;85;83;83;82;98;83 15:47:10 INFO - PROCESS | 3800 | |11;stanford-crypto-ccm;140;130;130;129;130;150;136;139;139;142 15:47:10 INFO - PROCESS | 3800 | |12;stanford-crypto-pbkdf2;169;166;173;170;168;174;172;176;170;168 15:47:10 INFO - PROCESS | 3800 | |13;stanford-crypto-sha256-iterative;66;69;67;67;68;65;66;67;71;67 15:47:10 INFO - PROCESS | 3800 | __end_tp_report 15:47:10 INFO - PROCESS | 3800 | __start_cc_report 15:47:10 INFO - PROCESS | 3800 | _x_x_mozilla_cycle_collect,952 15:47:10 INFO - PROCESS | 3800 | __end_cc_report 15:47:10 INFO - PROCESS | 3800 | __startTimestamp1466894830573__endTimestamp 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | ------- Summary: start ------- 15:47:10 INFO - PROCESS | 3800 | Number of tests: 14 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.50 stddev:3.46 (3.0%) stddev-sans-first:2.65 15:47:10 INFO - PROCESS | 3800 | Values: 105.0 114.0 106.0 113.0 114.0 114.0 115.0 112.0 112.0 113.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:161.00 stddev:22.81 (14.2%) stddev-sans-first:24.05 15:47:10 INFO - PROCESS | 3800 | Values: 163.0 131.0 171.0 180.0 131.0 156.0 159.0 134.0 198.0 138.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.88 (1.8%) stddev-sans-first:3.00 15:47:10 INFO - PROCESS | 3800 | Values: 162.0 168.0 169.0 163.0 161.0 161.0 163.0 161.0 162.0 164.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#3] audio-fft Cycles:10 Average:92.30 Median:76.00 stddev:33.68 (44.3%) stddev-sans-first:35.14 15:47:10 INFO - PROCESS | 3800 | Values: 75.0 75.0 76.0 151.0 75.0 76.0 79.0 77.0 161.0 78.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:86.50 stddev:23.11 (26.7%) stddev-sans-first:23.93 15:47:10 INFO - PROCESS | 3800 | Values: 87.0 87.0 139.0 86.0 88.0 86.0 132.0 86.0 89.0 133.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.10 (0.9%) stddev-sans-first:1.09 15:47:10 INFO - PROCESS | 3800 | Values: 117.0 121.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 15:47:10 INFO - PROCESS | 3800 | Values: 147.0 147.0 151.0 149.0 146.0 148.0 148.0 147.0 148.0 147.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 15:47:10 INFO - PROCESS | 3800 | Values: 96.0 96.0 96.0 96.0 96.0 99.0 97.0 96.0 97.0 96.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.41 (2.2%) stddev-sans-first:1.45 15:47:10 INFO - PROCESS | 3800 | Values: 64.0 67.0 65.0 64.0 65.0 64.0 64.0 68.0 65.0 64.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 15:47:10 INFO - PROCESS | 3800 | Values: 65.0 64.0 64.0 64.0 66.0 65.0 65.0 68.0 65.0 65.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.50 stddev:4.81 (5.7%) stddev-sans-first:5.10 15:47:10 INFO - PROCESS | 3800 | Values: 85.0 89.0 83.0 84.0 85.0 83.0 83.0 82.0 98.0 83.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:139.00 stddev:6.84 (4.9%) stddev-sans-first:7.13 15:47:10 INFO - PROCESS | 3800 | Values: 140.0 130.0 130.0 129.0 130.0 150.0 136.0 139.0 139.0 142.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:171.00 stddev:3.10 (1.8%) stddev-sans-first:3.23 15:47:10 INFO - PROCESS | 3800 | Values: 169.0 166.0 173.0 170.0 168.0 174.0 172.0 176.0 170.0 168.0 15:47:10 INFO - PROCESS | 3800 | 15:47:10 INFO - PROCESS | 3800 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.70 (2.5%) stddev-sans-first:1.74 15:47:10 INFO - PROCESS | 3800 | Values: 66.0 69.0 67.0 67.0 68.0 65.0 66.0 67.0 71.0 67.0 15:47:10 INFO - PROCESS | 3800 | -------- Summary: end -------- 15:47:10 INFO - PROCESS | 3800 | 15:47:11 INFO - TEST-INFO | 3800: exit 0 15:47:11 INFO - TEST-OK | kraken | took 64899ms 15:47:11 INFO - SUITE-END | took 1182s 15:47:11 INFO - Completed test suite (00:19:42) 15:47:11 INFO - javascript benchmark 15:47:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6390.656551158198, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2638.9472210555787, 2673.4653069386122, 2683.5840444731075, 2689.825161364511, 2696.3393968477726, 4809.8316558920405, 4840.588549973252, 4849.781759820812, 4941.752912354385, 4981.576565991886, 4787.186178349681, 4883.413990321157, 4914.336564563783, 4935.087008903355, 4948.5051494850495, 4470.128324976639, 4487.865364039068, 4529.449902747996, 4601.884952876171, 4676.298555216711, 4283.143371325732, 4550.408446901898, 4571.725696458207, 4577.862664120065, 4618.099470603233, 4418.624416924566, 4448.088141930896, 4460.442444694413, 4512.751798651073, 4555.111753208109, 4459.331100334944, 4469.888252793674, 4526.818927242906, 4578.748168850712, 4591.265397536412, 4485.1254005468945, 4548.863534093983, 4549.27211646135, 4570.748608826513, 4603.470600880908, 4836.733979631119, 4887.975560122212, 4915.3364295819965, 4925.2858335541505, 4928.926066109011, 5221.477852214786, 5268.236105764643, 5270.947290527122, 5285.841424757264, 5306.124489459235, 5084.8220312288895, 5258.2638430619745, 5311.442298558673, 5316.043112239795, 5333.626646134772, 4906.411230652309, 4931.013797240566, 4956.207006878882, 4956.306117143603, 5008.6744361616375, 5435.537979271806, 5444.8094316698725, 5447.536959358499, 5450.809221677222, 5505.311836020497, 5099.4390617032095, 5111.0, 5172.5344718975475, 5211.322528071327, 5220.295260139908, 5125.051865404912, 5134.0, 5178.585713142939, 5207.114790485551, 5209.348831396075, 5122.846314610493, 5148.17629179337, 5190.870228244324, 5214.32213812202, 5222.686638801684, 4991.301217829507, 5145.9742701287005, 5177.145770947752, 5189.299444574934, 5251.606129540223, 4391.758453285036, 4421.182081314967, 4429.958959644481, 4467.486239082482, 4470.150671372494, 3838.9424158637644, 3844.9038774030314, 3846.5961074086817, 3874.535055793323, 3901.6878649707955, 4517.593416592523, 4618.1918164321105, 4648.3259927310355, 4657.836975705834, 4672.976635116871, 5373.086575282211, 5391.946080539223, 5392.784288628411, 5402.37872644643, 5426.321709786277, 4637.791299391535, 4675.2052151134385, 4680.625549955996, 4683.648726345537, 4726.149293127201, 4654.930176047362, 4693.718376897397, 4725.3384526166365, 4765.0, 4849.515048495193, 4984.252362145562, 4999.625028122978, 5011.473795251446, 5017.648764586444, 5052.115879721034, 5359.758810853443, 5375.3280839895015, 5396.055690254111, 5396.3524377075, 5430.40265570779, 4848.927266090941, 4903.8528844134735, 4924.655274130777, 4935.309056731989, 5015.1975683890405, 5175.301334319819, 5175.430702622633, 5184.585233181412, 5186.377634683862, 5192.948070519246, 5258.868528286824, 5259.47405259471, 5262.868428289324, 5263.631545791758, 5314.468553144655, 4974.452810190804, 5083.38999320084, 5109.3613298337705, 5133.614978876674, 5153.3558305211845, 5105.0, 5140.794368225229, 5143.228515722672, 5144.6655967362, 5179.792808287626, 4898.828541001048, 5037.647364684583, 5051.570616497639, 5065.240213967934, 5076.441591424867, 5114.309568208244, 5172.250023746611, 5174.172132458789, 5183.196604526304, 5187.403448603459, 5067.366579177603, 5080.974595127149, 5084.542391184811, 5085.160948443466, 5096.617753668415], "value": 4832.571904171732, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.8160979291523, 590.9054551271796, 602.5721737566328, 608.6895683201568, 608.8934436473618, 32534.67465325346, 33095.33809323815, 36076.45885311716, 36190.09524761879, 36215.0, 36866.078348041316, 37586.43620345697, 37869.0, 37883.43174852379, 37909.999999999935, 7559.168491465948, 7755.185705500898, 7770.883436748425, 7791.649375778075, 7796.493227940194, 7666.501677390979, 7710.57591832449, 7766.0, 7768.378529717609, 7789.337906277973, 7758.069031716202, 7801.492902961318, 7808.3362914152085, 7810.218978102201, 7811.648475818602, 7707.344875685545, 7743.651535680908, 7744.303012728825, 7748.380129589619, 7752.263534964198, 7601.315881570686, 7654.464187506876, 7660.425468089916, 7669.769906902802, 7691.153973062958, 35725.28549429023, 36041.45937810935, 36159.4576081359, 36201.0, 36284.63715362865, 2330.4057465346395, 2887.4658188235244, 3135.984320078408, 3230.321632457163, 3547.3614749345106, 27569.724302757117, 27714.307142321402, 27725.86137069322, 27917.302067448272, 28073.85963070192, 3334.916627084318, 3419.5212670226188, 3420.0765793235937, 3451.948220776665, 3475.4960530723156, 218402.0, 220661.0, 221737.0, 222152.0, 222176.0, 30789.538156927665, 32056.67943320537, 32062.519062214087, 32126.83936580302, 32215.838920805247, 31991.360172796412, 33927.0, 34069.14827129292, 34100.658993410245, 34137.0, 13339.333033348294, 13365.665858353424, 13389.66525836862, 13403.463861445627, 13467.730645387233, 10750.301230420155, 10803.567857285621, 10860.728481788019, 10899.29154604964, 10899.782004359868, 7801.921980780233, 7828.373730101578, 7838.882416763753, 7872.33085187754, 7872.72445464406, 3047.7104675055834, 3115.2679120406688, 3133.4516459619476, 3149.6692847251165, 3167.6990685885266, 900.7432881628704, 904.263025634106, 927.7726956895604, 929.4284015330524, 975.5171190260867, 28363.149105526867, 28460.146195614165, 28886.422271554453, 29277.56083658747, 29307.560386594218, 938.1134827587864, 988.4514094677523, 1021.667957913681, 1063.3194755356578, 1072.3565860483648, 14656.78014829757, 14675.48635797742, 14863.331150098054, 15072.0, 15300.693986120437, 387866.0, 390520.0, 390905.0, 392575.0, 393141.0, 48792.26811597829, 49033.509664903606, 49261.0, 49381.0, 49506.504934950906, 1165.9825102623468, 1189.7263629365295, 1208.7219939413808, 1228.1341654133994, 1228.8095345221504, 26569.468610628064, 27603.30991725223, 27846.379970604503, 28113.0, 28564.42871142524, 40935.59064409318, 41181.58818411898, 41433.37849932314, 41451.58548414477, 41570.58429415667, 324583.0, 325289.0, 325691.0, 326547.0, 326696.0, 22354.32937011892, 22927.426814329774, 25008.874955625106, 25341.366465838502, 25376.238712838644, 42325.78837105795, 42354.576454235066, 42795.57204427916, 43296.78351608222, 44686.0, 36626.0, 37228.62771372252, 37764.62235377611, 37973.62026379811, 38355.424668629435, 36454.81772591226, 36473.817630911675, 36537.81731091328, 37107.628923710414, 37604.0, 36202.0, 36259.818700906326, 36600.81699591485, 37465.81267093647, 37705.62294377021, 31194.376112478076, 34002.31995360128, 34044.31911361808, 34282.0, 34284.82857585796, 25662.871685641454, 25666.230013099637, 26286.86856565705, 27564.448711026067, 28011.159665210078], "value": 16159.245722821213, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.352516908333, 378.30958500736153, 380.2414183703512, 380.68403225322976, 392.3154096102302, 16168.191590420476, 16655.58361040973, 17485.388011419618, 17501.212445439953, 18109.275628974858, 10563.683089507327, 10904.073153781937, 10926.125909927207, 10928.562857485691, 10942.23404361695, 4545.909081818353, 4787.066522028206, 5152.6650767699975, 5488.53347465466, 5535.667859928397, 5508.91736623951, 5535.501804837564, 5562.3047119110115, 5566.888662226753, 5584.050711379055, 5356.303680521527, 5548.001359755242, 5578.665280083188, 5592.804251851186, 5599.63602365847, 5575.972120139394, 5582.804601838937, 5619.072852979253, 5646.322441307028, 5658.91511627326, 5361.81233656824, 5650.0, 5652.0391533439415, 5653.9151912721345, 5671.659700417947, 11868.0, 12426.068044896669, 12432.12975091744, 18627.0, 19864.70202946957, 1864.925402983879, 1865.020864046373, 1875.6154988227381, 1929.3440230321617, 2374.27584586701, 8988.280937524982, 9045.954770226173, 9058.728238152866, 9442.905570944271, 9618.75953101171, 1558.6259297768568, 1692.3907393338388, 1757.2707326459504, 1803.332766876251, 1860.283790740561, 53414.73292633512, 60336.09495857565, 60370.0, 61394.0, 69434.0, 9479.672845801593, 9500.857487137699, 9702.466364349888, 9811.411315321104, 9900.405975641484, 14124.788128178085, 14232.501862434765, 14315.28423578817, 14338.426462941574, 14341.56975290743, 6833.3166683332265, 6911.308869113049, 6975.197852246955, 7018.473614478935, 7258.927410725931, 6441.742330306735, 6864.347886950832, 6880.311968803079, 6951.200611929693, 6966.825829354307, 4464.776761161994, 4472.9105417892115, 4539.046800171935, 4541.341505481687, 4544.659150563721, 1855.2857149997349, 1885.915133818954, 1906.7235250888543, 1914.607505461377, 1933.1494142577221, 793.9483933544417, 852.9061803201643, 853.3642436384933, 890.8351954888367, 923.5336155241695, 16628.25172867224, 17121.315147394213, 17330.82669173292, 17344.826551734575, 17363.392281270095, 865.9177378149066, 893.3523195683208, 903.8327909336793, 949.7103383468109, 958.9712308630752, 9411.811763764823, 9532.380395274286, 9719.125278724949, 9796.118349348593, 9877.40735555869, 378433.0, 382882.0, 387556.0, 388228.0, 389071.0, 48634.75682621564, 59858.0, 76398.0, 79283.0, 82799.5860020696, 792.6987744656993, 893.5353616119581, 904.3759805733891, 920.8572671235969, 927.2859897878595, 15718.528444146694, 15806.130662813195, 15912.44306449315, 15929.761053584438, 16062.196890155212, 35209.47185792266, 37148.44277335896, 37702.811485942395, 38010.0, 38339.2332153361, 50678.0, 50878.236826448374, 50888.0, 52195.47804521906, 53208.467915320354, 7697.961510192413, 7853.921460785319, 7870.409719270963, 8013.15861834499, 8136.837263254583, 10001.749956251151, 11838.171328007302, 12083.57707480234, 12182.451789669663, 12266.815997759863, 9612.375195612263, 10326.638567650096, 10382.428966406618, 10614.257002009785, 10705.0, 10650.467476626292, 10734.73163170927, 10742.462876856282, 10876.891231087904, 10901.0, 10547.789044219226, 10735.302205356627, 10747.193960452842, 10840.566377344818, 10859.239853210516, 7806.4925779824125, 8025.59872006409, 8108.918910810817, 8202.83594328122, 8218.137095604876, 8005.599720014093, 9505.859296884419, 10404.791904161722, 10854.565817367533, 10868.293560918515], "value": 8091.070740979607, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.0, 1399.1814788348815, 1432.6561625209947, 1539.199616199577, 1573.90556566606, 6698.631575263358, 7377.225391333913, 7397.149327827301, 7997.88003179952, 7999.040115186179, 7620.847583048336, 7791.805204869867, 7866.410019248565, 7867.1739467355965, 7875.251851074153, 2164.653655415134, 2191.4302281406867, 2194.967075493869, 2199.197292988056, 2201.4056204824687, 2111.5565731196466, 2139.422355963889, 2153.849230553862, 2158.686990386393, 2158.7085743424673, 2123.851330406872, 2128.57428514297, 2151.236311109557, 2158.4495953531828, 2193.1556350804894, 2123.140128248062, 2126.915273210658, 2132.402927180392, 2135.519508110678, 2149.3229632665816, 2068.8241499472565, 2070.554830711389, 2099.0, 2099.3177217404404, 2114.3551216878845, 7896.802579935547, 7943.324817390471, 7953.0853951795125, 7958.283754462068, 7981.760547183594, 4474.485434175079, 4597.448306203277, 4607.0, 4611.815527378901, 4621.976890115528, 2794.273488892882, 2833.4474777418413, 2891.7975741698087, 2911.243076800026, 2937.0, 863.6459051788736, 893.6559424621568, 895.1317222294364, 914.8216097860919, 918.0727465260069, 10648.57405703771, 10659.520321585547, 10669.253152279343, 10679.519421626046, 10703.839442408447, 4118.979405102956, 4158.792060396968, 4290.4636920384955, 4295.398644189816, 4351.6518678505645, 9187.95406022979, 9202.447853128833, 9233.769155771159, 9234.122758337948, 9236.769080773034, 4606.516315786861, 4636.5131661175765, 4666.066786642685, 4683.812647494062, 4723.173444647173, 3695.168587067942, 4081.0409553754844, 4227.42929704486, 4252.362145678111, 4268.338407546835, 3578.7673801202836, 3581.8925432237074, 3618.131648404364, 3668.834902429397, 3775.6601905828607, 1146.1633007904277, 1164.2257898497405, 1169.7543515861594, 1185.8991985681314, 1187.6080893305189, 703.3704834173386, 856.6593281514535, 861.440063958432, 861.7113267055481, 871.7166920750782, 5205.29728486657, 5210.8957820844125, 5228.660137091153, 5326.36083669962, 5328.440513746078, 406.60153050011155, 410.41106012871626, 419.09057345560205, 419.5280309651642, 424.1241835609518, 3635.94546081809, 3663.505426767352, 3680.1719613087375, 3729.1050147964293, 3767.1147280389637, 9240.399374040666, 9463.668771593098, 9648.662296819577, 9691.418514889128, 9719.0, 9391.671291504901, 9494.24046076326, 9531.428114313163, 9568.712938611852, 9658.082482164184, 7355.8161045974275, 7427.18300986891, 7436.73971410998, 7459.291367320096, 7482.8877566836545, 5068.847934561969, 5106.846794596168, 5138.871528211825, 5276.498732620395, 5329.040772660803, 8844.55777211124, 8959.0, 8995.685151019945, 9018.639254429749, 9024.774380640536, 8737.563121843756, 9143.222826059859, 9188.908110918805, 9192.816143677222, 9241.861372079558, 6073.787417440369, 6538.967305163444, 6727.192736871607, 6747.089142965833, 6780.254172040973, 7520.962395187989, 7565.962170189114, 7567.508111972704, 7588.734394296173, 7628.54228746277, 6357.8728425432155, 6502.796982558053, 6533.444657204191, 6568.7372505099265, 6662.6335551545135, 6347.333529979471, 6461.321561236003, 6473.676316184266, 6537.901931470937, 6555.082288479712, 6139.1098290746695, 6183.5671502994355, 6194.256689197145, 6200.3179650237535, 6208.627482351073, 4700.92948605778, 4720.952790472052, 4756.0, 4772.069446457907, 4867.123917694849, 4499.460064792246, 4748.691335063209, 4811.013742182914, 4870.366852309319, 4875.878103047452], "value": 4044.2011242705216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.47472650323414, 285.9961535012107, 287.9049913528536, 299.1578705942771, 306.4973443552573, 5213.139831927732, 5234.816781412651, 5250.684958902469, 5275.36695596529, 5276.445973172815, 5100.183970564701, 5129.974005198957, 5132.974335128329, 5141.82003629873, 5168.61235407345, 3797.221569578244, 3951.940720889189, 4008.2183974125055, 4049.412835138903, 4055.776932268724, 4008.9599104009026, 4030.637242648161, 4043.150938302945, 4049.919001619966, 4078.775667338295, 4040.676745860339, 4044.2407552714517, 4057.756534607918, 4057.898552536181, 4072.429859819628, 3733.290674771785, 3979.2240513099955, 3984.1234928315725, 4053.9189216215805, 4073.429719839225, 3417.726581873444, 3442.7417943654077, 3478.843452044639, 3492.3364560733635, 3502.684758371733, 4981.1532039553, 4996.625253105995, 5013.724245166514, 5022.321986531844, 5029.497050294978, 4265.893352666177, 4501.774911254424, 4518.68958002179, 4546.249868771649, 4567.862964111082, 5361.946380536184, 5373.81191658294, 5386.865328366783, 5402.297701298845, 5407.540359069484, 3774.8112594370173, 3780.1683629601443, 3781.6953151162807, 3787.1478917243676, 3806.2958352704836, 5325.600579956519, 5574.386817450078, 5592.412796656333, 5605.747741351608, 5625.437456254342, 3848.7883166425554, 3856.82644281008, 3868.6324799144036, 3876.8255428505786, 3902.282995481979, 3934.8426062957733, 3940.5074365704286, 3945.447637330776, 3966.36538153894, 3971.3447281198855, 4492.640588752892, 4518.480374756879, 4539.682222244477, 4542.545745425431, 4551.180787458223, 5094.337736094284, 5292.814751483679, 5372.194170874322, 5372.5970552207955, 5417.995341723508, 1321.7620828251006, 1340.1757918879819, 1341.6176389729076, 1360.177092858826, 1360.9183448993092, 839.3201506779528, 854.8160797295666, 877.6752601537472, 880.7445840706251, 885.1767855893952, 4746.833860814855, 4754.904901902012, 4755.785989630475, 4776.331313616097, 4777.8327758528285, 5475.4524547545725, 5476.342838859283, 5496.395396506381, 5520.309961254843, 5524.309461317335, 4610.2854057621125, 4704.741239231875, 4721.551452612065, 4721.875156179733, 4762.690425122356, 2943.3818898031227, 2947.7199666031693, 2948.3366242595675, 2954.320506283567, 2955.4089182163652, 5102.489751024942, 5104.285400043997, 5119.513646203604, 5143.537081662668, 5152.042223954873, 5467.671939683552, 5593.188987596775, 5633.408492108351, 5649.898269837425, 5677.233573467529, 5026.974865125578, 5112.846614601568, 5126.53861152498, 5183.626339020163, 5194.844154675366, 5443.60481388188, 5444.237806707143, 5446.891062178814, 5456.59075569326, 5458.426865179258, 5066.82266120684, 5285.603579731613, 5333.573314134782, 5338.733063346895, 5344.579469139831, 5075.974620126875, 5112.9744351278005, 5139.691618502902, 5157.277981082577, 5165.690058596496, 3761.981190094032, 3781.77092444951, 3789.2800367930004, 3792.9431058534697, 3793.577408471823, 5265.894493936415, 5367.785288588413, 5375.0, 5388.676679399248, 5392.541633961, 5260.947390526198, 5293.8088929990445, 5296.285001524899, 5302.814401495929, 5303.867403314794, 5000.374953130859, 5269.631125821155, 5275.577953763613, 5291.365036195682, 5314.2365969694765, 5121.411037730709, 5145.562627176732, 5170.353705786777, 5172.741362931763, 5237.397699264633, 5067.77195026232, 5301.920471193012, 5445.727713614383, 5463.344398672185, 5465.918011229755, 5272.103742363731, 5273.419923808301, 5312.282841816305, 5328.786848526171, 5357.910414938256], "value": 4006.836701336338, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.5283669339726, 706.6678661029316, 725.6371814092954, 729.3800269770692, 764.1635032739259, 12468.750624987495, 12783.424745886447, 12807.679808004805, 12816.423260953256, 12834.294113823737, 13810.309484525758, 14393.424263029467, 14421.711565768705, 14891.329890154942, 14977.700445991073, 802.9317508011826, 804.8511025460308, 809.6356639512213, 810.0603300171801, 811.3428123220181, 633.5153607490273, 768.1243382543904, 798.5727635714894, 801.6272433318505, 802.0936341933607, 837.539353355655, 839.7564706235185, 841.8442588121187, 850.2560259772699, 851.5614458553819, 829.266099501939, 836.1220718245878, 837.9622916968751, 845.0535400351615, 845.3364109174299, 610.2920612089954, 613.208960441035, 613.7698363113832, 614.5759425996048, 615.5291202230297, 13833.654158646114, 13918.02573819833, 13918.443262269497, 13937.303134843318, 13956.09285396446, 12938.87061129386, 13044.28256445895, 13150.342482875818, 13166.144200627024, 13188.472461101544, 9852.261080418997, 9987.101160895554, 10092.243081768896, 10095.747606309827, 10195.388276703421, 3336.2660214752714, 3346.2303670155757, 3394.1684287349512, 3398.9490157647656, 3474.3572439098593, 60450.697746511425, 60640.09039864405, 60726.999999999556, 60802.391976080115, 60997.390026099616, 10544.156467482582, 10569.21478875001, 10594.629187978384, 10608.363498190134, 10736.409497477558, 18909.527261818566, 18964.43106706801, 19174.0, 19235.90382048081, 19519.804801952083, 6912.619805910623, 6948.583085014915, 6966.3730264276455, 7006.859862802716, 7049.647517624098, 3719.1074142206216, 3719.5350581177354, 3736.2855582584198, 3740.6446387593137, 3782.451544526028, 2853.543433050702, 2986.2385091801884, 2987.4025194961096, 2991.0578167877047, 2997.7601791857037, 484.3461327208241, 485.9368282123301, 489.5838537243386, 493.40791050739256, 503.4788993391822, 461.42552522109514, 491.82786024891004, 567.2795549651919, 598.8322770597352, 605.9121427393003, 7891.131975482693, 7900.486468379652, 7936.523808571389, 8165.428420010661, 8348.499090054616, 473.2404490792298, 504.91668874635275, 545.5035917315224, 554.3569459427046, 572.4104172702123, 4265.296226122717, 4337.696361254745, 4397.758123303249, 4466.240739074366, 4510.436195475566, 105363.0, 107223.0, 107800.0, 108667.0, 112681.0, 88799.55600221957, 90552.5472372634, 91541.0, 91814.54092729493, 92162.53918730498, 81268.59365703134, 81869.0, 82405.17594824095, 84330.5783471091, 84346.99999999878, 8711.782205444915, 8811.162939520735, 8930.19628233462, 8970.955145224232, 9386.389884657476, 36741.63258367382, 39762.40356394598, 40232.396514051725, 41921.58078419177, 42050.15899681928, 60802.0, 61485.385146149754, 61710.382896170464, 64000.35999639944, 64524.0, 11449.484773185393, 11504.769904602028, 11524.193306468467, 11564.826527602261, 11588.362640054878, 12045.0, 12057.457414416547, 12185.939070304592, 12373.195742276723, 12810.807837882625, 11733.823992639946, 11740.530378784753, 11809.763804724029, 12088.516459341528, 12246.0, 10680.145588352758, 10863.67408977732, 11257.605983790529, 11370.54517819278, 11392.886071139514, 10897.945510272715, 11205.60780372683, 11316.321020738782, 11499.54001839917, 11528.0, 9482.24142068619, 9589.952050239704, 9797.755056123653, 9915.256355773201, 9928.404295742279, 9930.652427165014, 10177.389356638329, 10615.256932014685, 10936.726581835517, 11066.557337706723], "value": 6652.568492317335, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 106.0, 113.0, 114.0, 114.0, 115.0, 112.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 171.0, 180.0, 131.0, 156.0, 159.0, 134.0, 198.0, 138.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 169.0, 163.0, 161.0, 161.0, 163.0, 161.0, 162.0, 164.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 151.0, 75.0, 76.0, 79.0, 77.0, 161.0, 78.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 139.0, 86.0, 88.0, 86.0, 132.0, 86.0, 89.0, 133.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 151.0, 149.0, 146.0, 148.0, 148.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 99.0, 97.0, 96.0, 97.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 65.0, 64.0, 65.0, 64.0, 64.0, 68.0, 65.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 66.0, 65.0, 65.0, 68.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 83.0, 84.0, 85.0, 83.0, 83.0, 82.0, 98.0, 83.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 130.0, 130.0, 129.0, 130.0, 150.0, 136.0, 139.0, 139.0, 142.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 173.0, 170.0, 168.0, 174.0, 172.0, 176.0, 170.0, 168.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 67.0, 68.0, 65.0, 66.0, 67.0, 71.0, 67.0], "value": 67.3, "unit": "score"}]}]} 15:47:11 INFO - Return code: 0 15:47:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:47:11 ERROR - # TBPL SUCCESS # 15:47:11 INFO - Running post-action listener: _resource_record_post_action 15:47:11 INFO - ##### 15:47:11 INFO - ##### Finished run-tests step (success) 15:47:11 INFO - ##### 15:47:11 INFO - Running post-run listener: _resource_record_post_run 15:47:11 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7798784; Write bytes: 423477248; Read time: 1872; Write time: 330796 15:47:11 INFO - TinderboxPrint: CPU usage
13.4% 15:47:11 INFO - TinderboxPrint: I/O read bytes / time
7,798,784 / 1,872 15:47:11 INFO - TinderboxPrint: I/O write bytes / time
423,477,248 / 330,796 15:47:11 INFO - TinderboxPrint: CPU idle
8,285.4 (86.5%) 15:47:11 INFO - TinderboxPrint: CPU user
1,230.9 (12.9%) 15:47:11 INFO - TinderboxPrint: Swap in / out
0 / 0 15:47:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 77180928; Read time: 96; Write time: 53676 15:47:11 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 6033408; Write bytes: 323284992; Read time: 1720; Write time: 249184 15:47:12 INFO - Running post-run listener: _upload_blobber_files 15:47:12 INFO - Blob upload gear active. 15:47:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:47:12 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 15:47:12 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'] 15:47:12 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 15:47:12 INFO - (blobuploader) - INFO - Open directory for files ... 15:47:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:47:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:47:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:13 INFO - (blobuploader) - INFO - Done attempting. 15:47:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:47:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:47:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:17 INFO - (blobuploader) - INFO - Done attempting. 15:47:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:47:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:47:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:18 INFO - (blobuploader) - INFO - Done attempting. 15:47:18 INFO - (blobuploader) - INFO - Iteration through files over. 15:47:18 INFO - Return code: 0 15:47:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:47:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:47:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2bd7965105e784af86160de60dfe101c5a75412fc79a50951b15e0c312b1cf88334d99e154e3f1a5fa7e5b1eb158e90daa55ef1ab78f267fbdd387fec40ef9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa46677c7a1086a8b7b4d0f5cd1d516e1566c4c94ca4a0da27cb47058f947bd16720a9347f463dd9629b0338c0e977a09894fe101e099b4b2780ae9d0c8c7419", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc88433b9445db62ee3778d2f3ac7fd3de145e0a4ffaf0a7a06769de3e7635e09c0b0ea05a19313835e0d768e5f234bd3b15b0c0573c742bd3f36f6814aa4e44"} 15:47:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:47:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:47:18 INFO - Contents: 15:47:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2bd7965105e784af86160de60dfe101c5a75412fc79a50951b15e0c312b1cf88334d99e154e3f1a5fa7e5b1eb158e90daa55ef1ab78f267fbdd387fec40ef9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa46677c7a1086a8b7b4d0f5cd1d516e1566c4c94ca4a0da27cb47058f947bd16720a9347f463dd9629b0338c0e977a09894fe101e099b4b2780ae9d0c8c7419", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc88433b9445db62ee3778d2f3ac7fd3de145e0a4ffaf0a7a06769de3e7635e09c0b0ea05a19313835e0d768e5f234bd3b15b0c0573c742bd3f36f6814aa4e44"} 15:47:18 INFO - Running post-run listener: copy_logs_to_upload_dir 15:47:18 INFO - Copying logs to upload dir... 15:47:18 INFO - mkdir: /builds/slave/test/build/upload/logs 15:47:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.816535 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-25 15:47:18.482808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 15:47:18.485971) ========= 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=ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2bd7965105e784af86160de60dfe101c5a75412fc79a50951b15e0c312b1cf88334d99e154e3f1a5fa7e5b1eb158e90daa55ef1ab78f267fbdd387fec40ef9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa46677c7a1086a8b7b4d0f5cd1d516e1566c4c94ca4a0da27cb47058f947bd16720a9347f463dd9629b0338c0e977a09894fe101e099b4b2780ae9d0c8c7419", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc88433b9445db62ee3778d2f3ac7fd3de145e0a4ffaf0a7a06769de3e7635e09c0b0ea05a19313835e0d768e5f234bd3b15b0c0573c742bd3f36f6814aa4e44"} build_url:https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/Vens87spTlKWbAsul_A8xQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2bd7965105e784af86160de60dfe101c5a75412fc79a50951b15e0c312b1cf88334d99e154e3f1a5fa7e5b1eb158e90daa55ef1ab78f267fbdd387fec40ef9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa46677c7a1086a8b7b4d0f5cd1d516e1566c4c94ca4a0da27cb47058f947bd16720a9347f463dd9629b0338c0e977a09894fe101e099b4b2780ae9d0c8c7419", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc88433b9445db62ee3778d2f3ac7fd3de145e0a4ffaf0a7a06769de3e7635e09c0b0ea05a19313835e0d768e5f234bd3b15b0c0573c742bd3f36f6814aa4e44"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 15:47:18.515056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:47:18.515784) ========= 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=ed14279e38b05397cf4aa391000001a4-1466893337.810896-56313167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004326 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 15:47:18.599152) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 15:47:18.599613) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 15:47:18.600201) ========= ========= Total master_lag: 0.18 =========