builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1465425396.83 results: success (0) buildid: 20160608145529 builduid: dcf16cfcd46041888d19d14cabc22f2a revision: d03332bc9097bbf3bcf15dce7fb0fde5d10b7eae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:36.833049) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:36.833513) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:36.833787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:36.848107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:36.848453) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 15:36:36-- 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% 114M=0s 2016-06-08 15:36:37 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116175 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:36.979845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:36.980153) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018069 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:37.029869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:37.030303) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d03332bc9097bbf3bcf15dce7fb0fde5d10b7eae --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 d03332bc9097bbf3bcf15dce7fb0fde5d10b7eae --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=e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 15:36:37,138 truncating revision to first 12 chars 2016-06-08 15:36:37,138 Setting DEBUG logging. 2016-06-08 15:36:37,138 attempt 1/10 2016-06-08 15:36:37,138 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d03332bc9097?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 15:36:37,420 unpacking tar archive at: fx-team-d03332bc9097/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638757 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:37.682476) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:37.682825) ========= script_repo_revision: d03332bc9097bbf3bcf15dce7fb0fde5d10b7eae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:37.683240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:37.683544) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 15:36:37.691981) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-08 15:36:37.692282) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:36:37 INFO - MultiFileLogger online at 20160608 15:36:37 in /builds/slave/test 15:36:37 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:36:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:36:37 INFO - {'append_to_log': False, 15:36:37 INFO - 'base_work_dir': '/builds/slave/test', 15:36:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:36:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:36:37 INFO - 'branch': 'Fx-Team-Non-PGO', 15:36:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:36:37 INFO - 'config_files': ('talos/linux_config.py',), 15:36:37 INFO - 'default_actions': ('clobber', 15:36:37 INFO - 'read-buildbot-config', 15:36:37 INFO - 'download-and-extract', 15:36:37 INFO - 'populate-webroot', 15:36:37 INFO - 'create-virtualenv', 15:36:37 INFO - 'install', 15:36:37 INFO - 'run-tests'), 15:36:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:36:37 INFO - 'download_minidump_stackwalk': True, 15:36:37 INFO - 'download_symbols': 'ondemand', 15:36:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:36:37 INFO - 'tooltool.py': '/tools/tooltool.py', 15:36:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:36:37 INFO - '/tools/misc-python/virtualenv.py')}, 15:36:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:36:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:36:37 INFO - 'installer_path': 'installer.exe', 15:36:37 INFO - 'log_level': 'info', 15:36:37 INFO - 'log_name': 'talos', 15:36:37 INFO - 'log_to_console': True, 15:36:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:36:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:36:37 INFO - 'opt_config_files': (), 15:36:37 INFO - 'pip_index': False, 15:36:37 INFO - 'sps_profile': False, 15:36:37 INFO - 'sps_profile_interval': 0, 15:36:37 INFO - 'suite': 'dromaeojs-e10s', 15:36:37 INFO - 'system_bits': '32', 15:36:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:36:37 INFO - 'title': 'talos-linux64-ix-067', 15:36:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:36:37 INFO - 'use_talos_json': True, 15:36:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:36:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:36:37 INFO - 'work_dir': 'build'} 15:36:37 INFO - ##### 15:36:37 INFO - ##### Running clobber step. 15:36:37 INFO - ##### 15:36:37 INFO - Running pre-action listener: _resource_record_pre_action 15:36:37 INFO - Running main action method: clobber 15:36:37 INFO - rmtree: /builds/slave/test/build 15:36:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:36:38 INFO - Running post-action listener: _resource_record_post_action 15:36:38 INFO - ##### 15:36:38 INFO - ##### Finished clobber step (success) 15:36:38 INFO - ##### 15:36:38 INFO - ##### 15:36:38 INFO - ##### Running read-buildbot-config step. 15:36:38 INFO - ##### 15:36:38 INFO - Running pre-action listener: _resource_record_pre_action 15:36:38 INFO - Running main action method: read_buildbot_config 15:36:38 INFO - Using buildbot properties: 15:36:38 INFO - { 15:36:38 INFO - "project": "", 15:36:38 INFO - "product": "firefox", 15:36:38 INFO - "script_repo_revision": "production", 15:36:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:36:38 INFO - "repository": "", 15:36:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:36:38 INFO - "buildid": "20160608145529", 15:36:38 INFO - "pgo_build": "False", 15:36:38 INFO - "basedir": "/builds/slave/test", 15:36:38 INFO - "buildnumber": 1573, 15:36:38 INFO - "slavename": "talos-linux64-ix-067", 15:36:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:36:38 INFO - "platform": "ubuntu64_hw", 15:36:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:36:38 INFO - "branch": "fx-team", 15:36:38 INFO - "repo_path": "integration/fx-team", 15:36:38 INFO - "revision": "d03332bc9097bbf3bcf15dce7fb0fde5d10b7eae", 15:36:38 INFO - "stage_platform": "linux64", 15:36:38 INFO - "builduid": "dcf16cfcd46041888d19d14cabc22f2a", 15:36:38 INFO - "slavebuilddir": "test" 15:36:38 INFO - } 15:36:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:36:38 INFO - Running post-action listener: _resource_record_post_action 15:36:38 INFO - ##### 15:36:38 INFO - ##### Finished read-buildbot-config step (success) 15:36:38 INFO - ##### 15:36:38 INFO - ##### 15:36:38 INFO - ##### Running download-and-extract step. 15:36:38 INFO - ##### 15:36:38 INFO - Running pre-action listener: _resource_record_pre_action 15:36:38 INFO - Running main action method: download_and_extract 15:36:38 INFO - mkdir: /builds/slave/test/build/tests 15:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:38 INFO - https://queue.taskcluster.net/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:36:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:36:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:36:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/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:36:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/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:36:39 INFO - Downloaded 1361 bytes. 15:36:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:36:39 INFO - Using the following test package requirements: 15:36:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:36:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:36:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:36:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:39 INFO - u'jsshell-linux-x86_64.zip'], 15:36:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:36:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:36:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:36:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:36:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:36:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:36:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:36:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:39 INFO - https://queue.taskcluster.net/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/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:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/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:36:40 INFO - Downloaded 22878228 bytes. 15:36:40 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:36:40 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:36:41 INFO - Return code: 0 15:36:41 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:36: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:36:41 INFO - https://queue.taskcluster.net/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:36:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:36:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:36:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/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:36:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/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:36:42 INFO - Downloaded 22878228 bytes. 15:36:42 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:36:42 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:36:44 INFO - Return code: 0 15:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:44 INFO - https://queue.taskcluster.net/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/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:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/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:36:45 INFO - Downloaded 10833369 bytes. 15:36:45 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:36:45 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:36:45 INFO - Return code: 0 15:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:45 INFO - https://queue.taskcluster.net/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:36:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:36:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:36:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/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:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R4fN73UhRSCNQC_oJuVpAQ/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:36:46 INFO - Downloaded 55337442 bytes. 15:36:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:36:46 INFO - mkdir: /builds/slave/test/properties 15:36:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:36:46 INFO - Writing to file /builds/slave/test/properties/build_url 15:36:46 INFO - Contents: 15:36:46 INFO - build_url:https://queue.taskcluster.net/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:36:47 INFO - Running post-action listener: _resource_record_post_action 15:36:47 INFO - Running post-action listener: set_extra_try_arguments 15:36:47 INFO - ##### 15:36:47 INFO - ##### Finished download-and-extract step (success) 15:36:47 INFO - ##### 15:36:47 INFO - ##### 15:36:47 INFO - ##### Running populate-webroot step. 15:36:47 INFO - ##### 15:36:47 INFO - Running pre-action listener: _resource_record_pre_action 15:36:47 INFO - Running main action method: populate_webroot 15:36:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:36:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:36:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:36:47 INFO - '--tppagecycles', 15:36:47 INFO - '7'], 15:36:47 INFO - 'tests': ['tsvgm']}}, 15:36:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:36:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:36:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:36:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:36:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:36:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:36:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'talos_options': ['--disable-e10s'], 15:36:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:36:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:36:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'talos_options': ['--disable-e10s'], 15:36:47 INFO - 'tests': ['damp', 'tps']}, 15:36:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'tests': ['damp', 'tps']}, 15:36:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:36:47 INFO - 'tests': ['dromaeo_dom']}, 15:36:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:36:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:36:47 INFO - 'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore', 15:36:47 INFO - 'tabpaint']}, 15:36:47 INFO - 'other-e10s': {'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore', 15:36:47 INFO - 'tabpaint']}, 15:36:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore', 15:36:47 INFO - 'tabpaint']}, 15:36:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore', 15:36:47 INFO - 'tabpaint']}, 15:36:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:36:47 INFO - 'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore', 15:36:47 INFO - 'tabpaint']}, 15:36:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:36:47 INFO - 'tests': ['a11yr', 15:36:47 INFO - 'ts_paint', 15:36:47 INFO - 'tpaint', 15:36:47 INFO - 'sessionrestore', 15:36:47 INFO - 'sessionrestore_no_auto_restore', 15:36:47 INFO - 'tabpaint']}, 15:36:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:36:47 INFO - 'tests': ['tsvgx', 15:36:47 INFO - 'tsvgr_opacity', 15:36:47 INFO - 'tart', 15:36:47 INFO - 'tscrollx', 15:36:47 INFO - 'cart']}, 15:36:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:36:47 INFO - 'tsvgr_opacity', 15:36:47 INFO - 'tart', 15:36:47 INFO - 'tscrollx', 15:36:47 INFO - 'cart']}, 15:36:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'talos_options': ['--disable-e10s'], 15:36:47 INFO - 'tests': ['tp5o']}, 15:36:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'tests': ['tp5o']}, 15:36:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'talos_options': ['--disable-e10s', 15:36:47 INFO - '--xperf_path', 15:36:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:36:47 INFO - 'tests': ['tp5n']}, 15:36:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:36:47 INFO - 'talos_options': ['--xperf_path', 15:36:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:36:47 INFO - 'tests': ['tp5n']}}, 15:36:47 INFO - 'talos.zip': {'path': '', 15:36:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:36:47 INFO - Running post-action listener: _resource_record_post_action 15:36:47 INFO - ##### 15:36:47 INFO - ##### Finished populate-webroot step (success) 15:36:47 INFO - ##### 15:36:47 INFO - ##### 15:36:47 INFO - ##### Running create-virtualenv step. 15:36:47 INFO - ##### 15:36:47 INFO - Running pre-action listener: _resource_record_pre_action 15:36:47 INFO - Running main action method: create_virtualenv 15:36:47 INFO - Creating virtualenv /builds/slave/test/build/venv 15:36:47 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:36:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:36:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:36:47 INFO - Using real prefix '/usr' 15:36:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:36:48 INFO - Installing distribute.............................................................................................................................................................................................done. 15:36:50 INFO - Installing pip.................done. 15:36:50 INFO - Return code: 0 15:36:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:50 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 0x7f372781af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1374350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14031c0>, '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 0x14040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1404550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', '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:36:50 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:36:50 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:36:50 INFO - Using env: {'DISPLAY': ':0', 15:36:50 INFO - 'HOME': '/home/cltbld', 15:36:50 INFO - 'LANG': 'en_US.UTF-8', 15:36:50 INFO - 'LANGUAGE': 'en_US:en', 15:36:50 INFO - 'LOGNAME': 'cltbld', 15:36:50 INFO - 'MAIL': '/var/mail/cltbld', 15:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:50 INFO - 'MOZ_NO_REMOTE': '1', 15:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:50 INFO - 'NO_EM_RESTART': '1', 15:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:50 INFO - 'PWD': '/builds/slave/test', 15:36:50 INFO - 'SHELL': '/bin/bash', 15:36:50 INFO - 'SHLVL': '1', 15:36:50 INFO - 'TERM': 'linux', 15:36:50 INFO - 'TMOUT': '86400', 15:36:50 INFO - 'USER': 'cltbld', 15:36:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', 15:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:50 INFO - '_': '/tools/buildbot/bin/python'} 15:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:50 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:36:50 INFO - Cleaning up... 15:36:50 INFO - Return code: 0 15:36:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:50 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 0x7f372781af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1374350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14031c0>, '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 0x14040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1404550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', '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:36:50 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:36:50 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:36:50 INFO - Using env: {'DISPLAY': ':0', 15:36:50 INFO - 'HOME': '/home/cltbld', 15:36:50 INFO - 'LANG': 'en_US.UTF-8', 15:36:50 INFO - 'LANGUAGE': 'en_US:en', 15:36:50 INFO - 'LOGNAME': 'cltbld', 15:36:50 INFO - 'MAIL': '/var/mail/cltbld', 15:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:50 INFO - 'MOZ_NO_REMOTE': '1', 15:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:50 INFO - 'NO_EM_RESTART': '1', 15:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:50 INFO - 'PWD': '/builds/slave/test', 15:36:50 INFO - 'SHELL': '/bin/bash', 15:36:50 INFO - 'SHLVL': '1', 15:36:50 INFO - 'TERM': 'linux', 15:36:50 INFO - 'TMOUT': '86400', 15:36:50 INFO - 'USER': 'cltbld', 15:36:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', 15:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:50 INFO - '_': '/tools/buildbot/bin/python'} 15:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:50 INFO - Downloading/unpacking psutil>=3.1.1 15:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:36:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:36:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:36:52 INFO - Installing collected packages: psutil 15:36:52 INFO - Running setup.py install for psutil 15:36:52 INFO - building 'psutil._psutil_linux' extension 15:36:52 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:36:52 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:36:53 INFO - building 'psutil._psutil_posix' extension 15:36:53 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:36:53 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:36:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:36:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:36:54 INFO - Successfully installed psutil 15:36:54 INFO - Cleaning up... 15:36:54 INFO - Return code: 0 15:36:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:36:54 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:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:54 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:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:54 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 0x7f372781af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1374350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14031c0>, '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 0x14040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1404550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', '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:36:54 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:36:54 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:36:54 INFO - Using env: {'DISPLAY': ':0', 15:36:54 INFO - 'HOME': '/home/cltbld', 15:36:54 INFO - 'LANG': 'en_US.UTF-8', 15:36:54 INFO - 'LANGUAGE': 'en_US:en', 15:36:54 INFO - 'LOGNAME': 'cltbld', 15:36:54 INFO - 'MAIL': '/var/mail/cltbld', 15:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:54 INFO - 'MOZ_NO_REMOTE': '1', 15:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:54 INFO - 'NO_EM_RESTART': '1', 15:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:54 INFO - 'PWD': '/builds/slave/test', 15:36:54 INFO - 'SHELL': '/bin/bash', 15:36:54 INFO - 'SHLVL': '1', 15:36:54 INFO - 'TERM': 'linux', 15:36:54 INFO - 'TMOUT': '86400', 15:36:54 INFO - 'USER': 'cltbld', 15:36:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', 15:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:54 INFO - '_': '/tools/buildbot/bin/python'} 15:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:36:54 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:36:54 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:36:54 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:36:54 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:36:54 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:36:54 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:36:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:36:56 INFO - Installing collected packages: mozsystemmonitor 15:36:56 INFO - Running setup.py install for mozsystemmonitor 15:36:56 INFO - Successfully installed mozsystemmonitor 15:36:56 INFO - Cleaning up... 15:36:56 INFO - Return code: 0 15:36:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:36:56 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:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:56 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:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:56 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 0x7f372781af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1374350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14031c0>, '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 0x14040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1404550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', '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:36:56 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:36:56 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:36:56 INFO - Using env: {'DISPLAY': ':0', 15:36:56 INFO - 'HOME': '/home/cltbld', 15:36:56 INFO - 'LANG': 'en_US.UTF-8', 15:36:56 INFO - 'LANGUAGE': 'en_US:en', 15:36:56 INFO - 'LOGNAME': 'cltbld', 15:36:56 INFO - 'MAIL': '/var/mail/cltbld', 15:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:56 INFO - 'MOZ_NO_REMOTE': '1', 15:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:56 INFO - 'NO_EM_RESTART': '1', 15:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:56 INFO - 'PWD': '/builds/slave/test', 15:36:56 INFO - 'SHELL': '/bin/bash', 15:36:56 INFO - 'SHLVL': '1', 15:36:56 INFO - 'TERM': 'linux', 15:36:56 INFO - 'TMOUT': '86400', 15:36:56 INFO - 'USER': 'cltbld', 15:36:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', 15:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:56 INFO - '_': '/tools/buildbot/bin/python'} 15:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:56 INFO - Downloading/unpacking jsonschema==2.5.1 15:36: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:36: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:36: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:36: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:36: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:36: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:36:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:36:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:58 INFO - Downloading functools32-3.2.3-2.tar.gz 15:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:36:58 INFO - warning: no files found matching '*.txt' 15:36:58 INFO - no previously-included directories found matching 'build' 15:36:58 INFO - no previously-included directories found matching 'dist' 15:36:58 INFO - no previously-included directories found matching '.git*' 15:36:58 INFO - Installing collected packages: jsonschema, functools32 15:36:58 INFO - Running setup.py install for functools32 15:36:58 INFO - warning: no files found matching '*.txt' 15:36:58 INFO - no previously-included directories found matching 'build' 15:36:58 INFO - no previously-included directories found matching 'dist' 15:36:58 INFO - no previously-included directories found matching '.git*' 15:36:58 INFO - Successfully installed jsonschema functools32 15:36:58 INFO - Cleaning up... 15:36:59 INFO - Return code: 0 15:36:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:36:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f372781af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1374350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14031c0>, '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 0x14040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1404550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', '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:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:36:59 INFO - Using env: {'DISPLAY': ':0', 15:36:59 INFO - 'HOME': '/home/cltbld', 15:36:59 INFO - 'LANG': 'en_US.UTF-8', 15:36:59 INFO - 'LANGUAGE': 'en_US:en', 15:36:59 INFO - 'LOGNAME': 'cltbld', 15:36:59 INFO - 'MAIL': '/var/mail/cltbld', 15:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:59 INFO - 'MOZ_NO_REMOTE': '1', 15:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:59 INFO - 'NO_EM_RESTART': '1', 15:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:59 INFO - 'PWD': '/builds/slave/test', 15:36:59 INFO - 'SHELL': '/bin/bash', 15:36:59 INFO - 'SHLVL': '1', 15:36:59 INFO - 'TERM': 'linux', 15:36:59 INFO - 'TMOUT': '86400', 15:36:59 INFO - 'USER': 'cltbld', 15:36:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', 15:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:59 INFO - '_': '/tools/buildbot/bin/python'} 15:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:59 INFO - Downloading/unpacking blobuploader==1.2.4 15:36: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:36: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:36: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:36: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:36: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:36: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:37:01 INFO - Downloading blobuploader-1.2.4.tar.gz 15:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:37:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:37:01 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:37:01 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:37:01 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:37:01 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:37:01 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:37:01 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:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:37:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:37:01 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:37:01 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:37:01 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:37:01 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:37:01 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:37:01 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:37:01 INFO - Downloading docopt-0.6.1.tar.gz 15:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:37:01 INFO - Installing collected packages: blobuploader, requests, docopt 15:37:01 INFO - Running setup.py install for blobuploader 15:37:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:37:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:37:02 INFO - Running setup.py install for requests 15:37:02 INFO - Running setup.py install for docopt 15:37:02 INFO - Successfully installed blobuploader requests docopt 15:37:02 INFO - Cleaning up... 15:37:02 INFO - Return code: 0 15:37:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:02 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 0x7f372781af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1374350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14031c0>, '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 0x14040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1404550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', '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:37:02 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:37:02 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:37:02 INFO - Using env: {'DISPLAY': ':0', 15:37:02 INFO - 'HOME': '/home/cltbld', 15:37:02 INFO - 'LANG': 'en_US.UTF-8', 15:37:02 INFO - 'LANGUAGE': 'en_US:en', 15:37:02 INFO - 'LOGNAME': 'cltbld', 15:37:02 INFO - 'MAIL': '/var/mail/cltbld', 15:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:02 INFO - 'MOZ_NO_REMOTE': '1', 15:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:02 INFO - 'NO_EM_RESTART': '1', 15:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:02 INFO - 'PWD': '/builds/slave/test', 15:37:02 INFO - 'SHELL': '/bin/bash', 15:37:02 INFO - 'SHLVL': '1', 15:37:02 INFO - 'TERM': 'linux', 15:37:02 INFO - 'TMOUT': '86400', 15:37:02 INFO - 'USER': 'cltbld', 15:37:02 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', 15:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:02 INFO - '_': '/tools/buildbot/bin/python'} 15:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:37:02 INFO - Running setup.py (path:/tmp/pip-M2pC1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:37:02 INFO - Running setup.py (path:/tmp/pip-sfSEH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:37:02 INFO - Running setup.py (path:/tmp/pip-9IPnk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:37:02 INFO - Running setup.py (path:/tmp/pip-k7NzdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:37:03 INFO - Running setup.py (path:/tmp/pip-fcFOiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:37:03 INFO - Running setup.py (path:/tmp/pip-MsmWZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:37:03 INFO - Running setup.py (path:/tmp/pip-DFMjTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:37:03 INFO - Running setup.py (path:/tmp/pip-ZUoT98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:37:03 INFO - Running setup.py (path:/tmp/pip-summlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:37:03 INFO - Running setup.py (path:/tmp/pip-AV98iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:37:03 INFO - Running setup.py (path:/tmp/pip-izeQRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:37:03 INFO - Running setup.py (path:/tmp/pip-xCTLTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:37:03 INFO - Running setup.py (path:/tmp/pip-Ev1esu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:37:03 INFO - Running setup.py (path:/tmp/pip-NfAHnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:03 INFO - Running setup.py (path:/tmp/pip-hdBP5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:37:03 INFO - Running setup.py (path:/tmp/pip-c9K4mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:37:03 INFO - Running setup.py (path:/tmp/pip-hAeW9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:37:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:37:03 INFO - Running setup.py install for manifestparser 15:37:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:37:04 INFO - Running setup.py install for mozcrash 15:37:04 INFO - Running setup.py install for mozdebug 15:37:04 INFO - Running setup.py install for mozdevice 15:37:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:37:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:37:04 INFO - Running setup.py install for mozfile 15:37:04 INFO - Running setup.py install for mozhttpd 15:37:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:37:04 INFO - Running setup.py install for mozinfo 15:37:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:37:04 INFO - Running setup.py install for mozInstall 15:37:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:37:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:37:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:37:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:37:04 INFO - Running setup.py install for mozleak 15:37:04 INFO - Running setup.py install for mozlog 15:37:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:37:05 INFO - Running setup.py install for moznetwork 15:37:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:37:05 INFO - Running setup.py install for mozprocess 15:37:05 INFO - Running setup.py install for mozprofile 15:37:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:37:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:37:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:37:05 INFO - Running setup.py install for mozrunner 15:37:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:37:05 INFO - Running setup.py install for mozscreenshot 15:37:05 INFO - Running setup.py install for moztest 15:37:05 INFO - Running setup.py install for mozversion 15:37:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:37:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:37:05 INFO - Cleaning up... 15:37:05 INFO - Return code: 0 15:37:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:05 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 0x7f372781af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1374350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14031c0>, '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 0x14040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1404550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', '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:37:05 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:37:05 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:37:05 INFO - Using env: {'DISPLAY': ':0', 15:37:05 INFO - 'HOME': '/home/cltbld', 15:37:05 INFO - 'LANG': 'en_US.UTF-8', 15:37:05 INFO - 'LANGUAGE': 'en_US:en', 15:37:05 INFO - 'LOGNAME': 'cltbld', 15:37:05 INFO - 'MAIL': '/var/mail/cltbld', 15:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:05 INFO - 'MOZ_NO_REMOTE': '1', 15:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:05 INFO - 'NO_EM_RESTART': '1', 15:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:05 INFO - 'PWD': '/builds/slave/test', 15:37:05 INFO - 'SHELL': '/bin/bash', 15:37:05 INFO - 'SHLVL': '1', 15:37:05 INFO - 'TERM': 'linux', 15:37:05 INFO - 'TMOUT': '86400', 15:37:05 INFO - 'USER': 'cltbld', 15:37:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', 15:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:05 INFO - '_': '/tools/buildbot/bin/python'} 15:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:37:05 INFO - Running setup.py (path:/tmp/pip-DsiLu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:37:06 INFO - Running setup.py (path:/tmp/pip-okWgEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:37:06 INFO - Running setup.py (path:/tmp/pip-p824kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:37:06 INFO - Running setup.py (path:/tmp/pip-Eg9umH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:37:06 INFO - Running setup.py (path:/tmp/pip-WlerfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:37:06 INFO - Running setup.py (path:/tmp/pip-zD51OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:37:06 INFO - Running setup.py (path:/tmp/pip-7YhdOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:37:06 INFO - Running setup.py (path:/tmp/pip-Onh57S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:37:06 INFO - Running setup.py (path:/tmp/pip-MwM4mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:37:06 INFO - Running setup.py (path:/tmp/pip-l6HPuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:37:06 INFO - Running setup.py (path:/tmp/pip-g0pNDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:37:06 INFO - Running setup.py (path:/tmp/pip-y49uvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:37:06 INFO - Running setup.py (path:/tmp/pip-8vzgIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:37:06 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:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:37:06 INFO - Running setup.py (path:/tmp/pip-YERc6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:07 INFO - Running setup.py (path:/tmp/pip-iMODkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:37:07 INFO - Running setup.py (path:/tmp/pip-c5A8kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:37:07 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:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:37:07 INFO - Running setup.py (path:/tmp/pip-GQqxO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:37:07 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:37:07 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:37:07 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:37:07 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:37:07 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:37:07 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:37:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:09 INFO - Downloading blessings-1.6.tar.gz 15:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:37:09 INFO - Installing collected packages: blessings 15:37:09 INFO - Running setup.py install for blessings 15:37:09 INFO - Successfully installed blessings 15:37:09 INFO - Cleaning up... 15:37:09 INFO - Return code: 0 15:37:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:37:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:37:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:37:09 INFO - Reading from file tmpfile_stdout 15:37:09 INFO - Current package versions: 15:37:09 INFO - argparse == 1.2.1 15:37:09 INFO - blessings == 1.6 15:37:09 INFO - blobuploader == 1.2.4 15:37:09 INFO - docopt == 0.6.1 15:37:09 INFO - functools32 == 3.2.3-2 15:37:09 INFO - jsonschema == 2.5.1 15:37:09 INFO - manifestparser == 1.1 15:37:09 INFO - mozInstall == 1.12 15:37:09 INFO - mozcrash == 0.17 15:37:09 INFO - mozdebug == 0.1 15:37:09 INFO - mozdevice == 0.48 15:37:09 INFO - mozfile == 1.2 15:37:09 INFO - mozhttpd == 0.7 15:37:09 INFO - mozinfo == 0.9 15:37:09 INFO - mozleak == 0.1 15:37:09 INFO - mozlog == 3.2 15:37:09 INFO - moznetwork == 0.27 15:37:09 INFO - mozprocess == 0.22 15:37:09 INFO - mozprofile == 0.28 15:37:09 INFO - mozrunner == 6.11 15:37:09 INFO - mozscreenshot == 0.1 15:37:09 INFO - mozsystemmonitor == 0.3 15:37:09 INFO - moztest == 0.7 15:37:09 INFO - mozversion == 1.4 15:37:09 INFO - psutil == 3.1.1 15:37:09 INFO - requests == 1.2.3 15:37:09 INFO - wsgiref == 0.1.2 15:37:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:37:09 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:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:09 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:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:09 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 0x7f372781af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1374350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14031c0>, '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 0x14040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1404550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', '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:37:09 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:37:09 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:37:09 INFO - Using env: {'DISPLAY': ':0', 15:37:09 INFO - 'HOME': '/home/cltbld', 15:37:09 INFO - 'LANG': 'en_US.UTF-8', 15:37:09 INFO - 'LANGUAGE': 'en_US:en', 15:37:09 INFO - 'LOGNAME': 'cltbld', 15:37:09 INFO - 'MAIL': '/var/mail/cltbld', 15:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:09 INFO - 'MOZ_NO_REMOTE': '1', 15:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:09 INFO - 'NO_EM_RESTART': '1', 15:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:09 INFO - 'PWD': '/builds/slave/test', 15:37:09 INFO - 'SHELL': '/bin/bash', 15:37:09 INFO - 'SHLVL': '1', 15:37:09 INFO - 'TERM': 'linux', 15:37:09 INFO - 'TMOUT': '86400', 15:37:09 INFO - 'USER': 'cltbld', 15:37:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', 15:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:09 INFO - '_': '/tools/buildbot/bin/python'} 15:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:09 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:37:09 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:37:09 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:37:09 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:37:09 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:37:09 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:37:09 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:37:09 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:37:09 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:37:09 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:37:09 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:37:09 INFO - Cleaning up... 15:37:09 INFO - Return code: 0 15:37:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:37:09 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:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:09 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:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:09 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 0x7f372781af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1374350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14031c0>, '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 0x14040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1404550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', '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:37:09 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:37:09 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:37:09 INFO - Using env: {'DISPLAY': ':0', 15:37:09 INFO - 'HOME': '/home/cltbld', 15:37:09 INFO - 'LANG': 'en_US.UTF-8', 15:37:09 INFO - 'LANGUAGE': 'en_US:en', 15:37:09 INFO - 'LOGNAME': 'cltbld', 15:37:09 INFO - 'MAIL': '/var/mail/cltbld', 15:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:09 INFO - 'MOZ_NO_REMOTE': '1', 15:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:09 INFO - 'NO_EM_RESTART': '1', 15:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:09 INFO - 'PWD': '/builds/slave/test', 15:37:09 INFO - 'SHELL': '/bin/bash', 15:37:09 INFO - 'SHLVL': '1', 15:37:09 INFO - 'TERM': 'linux', 15:37:09 INFO - 'TMOUT': '86400', 15:37:09 INFO - 'USER': 'cltbld', 15:37:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', 15:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:09 INFO - '_': '/tools/buildbot/bin/python'} 15:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:37:10 INFO - Cleaning up... 15:37:10 INFO - Return code: 0 15:37:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:37:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f372781af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1374350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14031c0>, '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 0x14040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1404550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', '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:37:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:37:10 INFO - Using env: {'DISPLAY': ':0', 15:37:10 INFO - 'HOME': '/home/cltbld', 15:37:10 INFO - 'LANG': 'en_US.UTF-8', 15:37:10 INFO - 'LANGUAGE': 'en_US:en', 15:37:10 INFO - 'LOGNAME': 'cltbld', 15:37:10 INFO - 'MAIL': '/var/mail/cltbld', 15:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:10 INFO - 'MOZ_NO_REMOTE': '1', 15:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:10 INFO - 'NO_EM_RESTART': '1', 15:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:10 INFO - 'PWD': '/builds/slave/test', 15:37:10 INFO - 'SHELL': '/bin/bash', 15:37:10 INFO - 'SHLVL': '1', 15:37:10 INFO - 'TERM': 'linux', 15:37:10 INFO - 'TMOUT': '86400', 15:37:10 INFO - 'USER': 'cltbld', 15:37:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', 15:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:10 INFO - '_': '/tools/buildbot/bin/python'} 15:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:37:10 INFO - Downloading/unpacking flake8 15:37: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:37: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:37: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:37: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:37: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:37: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:37:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:37:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:37:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:37:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:37:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:37:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:37:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:37:12 INFO - no previously-included directories found matching 'docs/_build' 15:37:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:37:12 INFO - Running setup.py install for pep8 15:37:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:37:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:37:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:37:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:37:12 INFO - no previously-included directories found matching 'docs/_build' 15:37:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:37:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:37:13 INFO - Cleaning up... 15:37:13 INFO - Return code: 0 15:37:13 INFO - Running post-action listener: _resource_record_post_action 15:37:13 INFO - Running post-action listener: _start_resource_monitoring 15:37:13 INFO - Starting resource monitoring. 15:37:13 INFO - ##### 15:37:13 INFO - ##### Finished create-virtualenv step (success) 15:37:13 INFO - ##### 15:37:13 INFO - ##### 15:37:13 INFO - ##### Running install step. 15:37:13 INFO - ##### 15:37:13 INFO - Running pre-action listener: _resource_record_pre_action 15:37:13 INFO - Running main action method: install 15:37:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:37:13 INFO - Reading from file tmpfile_stdout 15:37:13 INFO - Detecting whether we're running mozinstall >=1.0... 15:37:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:37:13 INFO - Reading from file tmpfile_stdout 15:37:13 INFO - Output received: 15:37:13 INFO - Usage: mozinstall [options] installer 15:37:13 INFO - Options: 15:37:13 INFO - -h, --help show this help message and exit 15:37:13 INFO - -d DEST, --destination=DEST 15:37:13 INFO - Directory to install application into. [default: 15:37:13 INFO - "/builds/slave/test"] 15:37:13 INFO - --app=APP Application being installed. [default: firefox] 15:37:13 INFO - mkdir: /builds/slave/test/build/application 15:37:13 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:37:13 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:37:29 INFO - Reading from file tmpfile_stdout 15:37:29 INFO - Output received: 15:37:29 INFO - /builds/slave/test/build/application/firefox/firefox 15:37:29 INFO - Running post-action listener: _resource_record_post_action 15:37:29 INFO - ##### 15:37:29 INFO - ##### Finished install step (success) 15:37:29 INFO - ##### 15:37:29 INFO - ##### 15:37:29 INFO - ##### Running run-tests step. 15:37:29 INFO - ##### 15:37:29 INFO - Running pre-action listener: _resource_record_pre_action 15:37:29 INFO - Running main action method: run_tests 15:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:37:29 INFO - Python 2.7.3 15:37:29 INFO - Return code: 0 15:37:29 INFO - grabbing minidump binary from tooltool 15:37: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:37:29 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 0x14031c0>, '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 0x14040c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1404550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:37:29 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:37:29 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:37:29 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:37:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:37:29 INFO - Return code: 0 15:37:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:37:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:37:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:37:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:37:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:37:30 INFO - Return code: 0 15:37:30 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/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:37:30 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/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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:37:30 INFO - Using env: {'DISPLAY': ':0', 15:37:30 INFO - 'HOME': '/home/cltbld', 15:37:30 INFO - 'LANG': 'en_US.UTF-8', 15:37:30 INFO - 'LANGUAGE': 'en_US:en', 15:37:30 INFO - 'LOGNAME': 'cltbld', 15:37:30 INFO - 'MAIL': '/var/mail/cltbld', 15:37:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:37:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:37:30 INFO - 'MOZ_NO_REMOTE': '1', 15:37:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:37:30 INFO - 'NO_EM_RESTART': '1', 15:37:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:37:30 INFO - 'PWD': '/builds/slave/test', 15:37:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:37:30 INFO - 'SHELL': '/bin/bash', 15:37:30 INFO - 'SHLVL': '1', 15:37:30 INFO - 'TERM': 'linux', 15:37:30 INFO - 'TMOUT': '86400', 15:37:30 INFO - 'USER': 'cltbld', 15:37:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766', 15:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:37:30 INFO - '_': '/tools/buildbot/bin/python'} 15:37:30 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/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:37:30 INFO - mozversion application_buildid: 20160608145529 15:37:30 INFO - mozversion application_changeset: d03332bc9097bbf3bcf15dce7fb0fde5d10b7eae 15:37:30 INFO - mozversion application_display_name: Nightly 15:37:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:37:30 INFO - mozversion application_name: Firefox 15:37:30 INFO - mozversion application_remotingname: firefox 15:37:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:37:30 INFO - mozversion application_vendor: Mozilla 15:37:30 INFO - mozversion application_version: 50.0a1 15:37:30 INFO - mozversion platform_buildid: 20160608145529 15:37:30 INFO - mozversion platform_changeset: d03332bc9097bbf3bcf15dce7fb0fde5d10b7eae 15:37:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:37:30 INFO - mozversion platform_version: 50.0a1 15:37:30 INFO - using testdate: 1465425450 15:37:30 INFO - actual date: 1465425450 15:37:30 INFO - starting webserver on 'localhost:45545' 15:37:30 INFO - SUITE-START | Running 2 tests 15:37:30 INFO - TEST-START | dromaeo_css 15:37:30 INFO - operating with platform_type : linux_ 15:37:30 INFO - Initialising browser for dromaeo_css test... 15:37:30 INFO - TEST-INFO | started process 5379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQTctUK/profile http://localhost:45545/getInfo.html) 15:37:34 INFO - PROCESS | 5379 | __metrics Screen width/height:1600/1200 15:37:34 INFO - PROCESS | 5379 | colorDepth:24 15:37:34 INFO - PROCESS | 5379 | Browser inner width/height: 1024/697 15:37:34 INFO - PROCESS | 5379 | __metrics 15:37:35 ERROR - PROCESS | 5379 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:37:36 INFO - TEST-INFO | 5379: exit 0 15:37:36 INFO - Browser initialized. 15:37:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:37:36 INFO - TEST-INFO | started process 5501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQTctUK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:48 INFO - PROCESS | 5501 | RSS: Main: 168058880 15:37:48 INFO - PROCESS | 5501 | 15:38:37 INFO - PROCESS | 5501 | 1465425517896 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:40:50 INFO - PROCESS | 5501 | Cycle 1(1): loaded http://localhost:45545/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45545/tests/dromaeo/cssquery-ext.html) 15:40:52 INFO - PROCESS | 5501 | RSS: Main: 168501248 15:40:52 INFO - PROCESS | 5501 | 15:43:54 INFO - PROCESS | 5501 | Cycle 1(1): loaded http://localhost:45545/tests/dromaeo/cssquery-ext.html (next: http://localhost:45545/tests/dromaeo/cssquery-jquery.html) 15:43:54 INFO - PROCESS | 5501 | RSS: Main: 170733568 15:43:54 INFO - PROCESS | 5501 | 15:46:56 INFO - PROCESS | 5501 | Cycle 1(1): loaded http://localhost:45545/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45545/tests/dromaeo/cssquery-mootools.html) 15:46:57 INFO - PROCESS | 5501 | RSS: Main: 171335680 15:46:57 INFO - PROCESS | 5501 | 15:49:59 INFO - PROCESS | 5501 | Cycle 1(1): loaded http://localhost:45545/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45545/tests/dromaeo/cssquery-prototype.html) 15:50:00 INFO - PROCESS | 5501 | RSS: Main: 169668608 15:50:00 INFO - PROCESS | 5501 | 15:53:02 INFO - PROCESS | 5501 | Cycle 1(1): loaded http://localhost:45545/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45545/tests/dromaeo/cssquery-yui.html) 15:53:03 INFO - PROCESS | 5501 | RSS: Main: 171581440 15:53:03 INFO - PROCESS | 5501 | 15:56:05 INFO - PROCESS | 5501 | Cycle 1(1): loaded http://localhost:45545/tests/dromaeo/cssquery-yui.html (next: http://localhost:45545/tests/dromaeo/cssquery-dojo.html) 15:56:06 INFO - PROCESS | 5501 | RSS: Main: 172863488 15:56:06 INFO - PROCESS | 5501 | 15:56:06 INFO - PROCESS | 5501 | __start_tp_report 15:56:06 INFO - PROCESS | 5501 | _x_x_mozilla_page_load 15:56:06 INFO - PROCESS | 5501 | _x_x_mozilla_page_load_details 15:56:06 INFO - PROCESS | 5501 | |i|pagename|runs| 15:56:06 INFO - PROCESS | 5501 | |0;dojo.html;2652.907148249811;2709.769669578085;2734.330089128163;2736.0423851651913;2737.8357298562073;4777.904441911164;4789.64077694173;4803.663743537953;4864.416270047599;4966.2550617407405;4656;4756.500567440412;4759.738214398207;4767.356406885069;4779.283107533872;4344.370066340387;4371.125774845028;4440.933385999213;4481.641468682514;4484.66365022623;4172.791360431981;4535.659825513083;4563.110193512266;4578.473475550321;4585.9541404586025;4318.330658747899;4326.134773045372;4342.044750154961;4435.68950173488;4490.955090449086;4299.935500967488;4325.567443255681;4338.175746608134;4342.978285108586;4374.9781251093855;4341.804618792162;4370.016746232104;4381.715188512769;4390.034192477649;4417.403650507173;4678.181318269323;4734.905301893943;4737.407824021997;4748.5251474852585;4750.026244619879;5160.483951604847;5161.329027226474;5177.896442071175;5193.480651934777;5232.136697444917;4988.625853061035;5152.407473140599;5193.428722840522;5225.190095535198;5231.346081739783;4768.141734487756;4777.546133117348;4816.4220293564995;4827;4875.9512404875495;5239.502247286502;5256.710880901587;5273.31446911899;5284.894302114013;5319.4414586467865;4942.456329803718;5054.115529782347;5056.696598204119;5057.418396884405;5057.620678449131;4989.17678583037;5088.77100530477;5097.260897169889;5110.310108135429;5112.054269960069;5056.393232812086;5059.898802024012;5128.1282182029145;5137.717425541631;5143.27994080829;4956.306117143603;5111;5142.742862856917;5169.508896654812;5177.637565370464;4195.7692326922315;4217;4264.91470170601;4265.232258193555;4266.829326826892;3712.5916149223563;3712.6658600726064;3722.516072910504;3764.153065560227;3766.2844059628583;4480.910381792346;4516.548345165523;4520.683552151318;4530.61489773373;4567.246404343313;5064.772085256172;5127.717975511383;5139.7687104080405;5156.432792392834;5182.766775495112;4532.637389008872;4548.88627784308;4559.566841150086;4594.989102397467;4603.815847366068;4584.4498660161;4599.67802253839;4606.355110284563;4609.377734005933;4611.308303754397;4752.120857641347;4885.169521181337;4920.434150072788;4922.409310882717;4963.156263435152;5260.263563101245;5262.079136151082;5278.656887302313;5284.9471505284455;5329.57363410934;4951.97524012392;4988.600911927109;4992.350994370709;5000.224965130411;5045.823396181116;4964.05682920244;5067.062593420229;5162.251473536241;5166.199239117943;5186.066508028591;5197.740112994411;5227.895442091213;5231.189165679326;5234.738263086907;5247.16045432729;5092.745362731923;5093.643444958817;5094.6688465249645;5098.847034588968;5139.074966506065;4873.951260487492;4929.827456039022;4934.950650493449;4985.675931064469;5008.824691135793;4855.514448555116;4880.365552478155;4920.92618610714;4929.211326187793;4973.154563724248;4866.90266194667;5023.372078490189;5027.446980832178;5033.6476446648385;5091.0581542414775;4810.855674329776;4882.536159064884;4903.754812259444;4943.060818444484;4947.332110165082 15:56:06 INFO - PROCESS | 5501 | |1;ext.html;546.2789118363761;582.0715958046916;595.7557401465399;611.9938800611992;619.8109576579147;35588.822055889716;39058.023549411315;39096.80451597742;39210.41184382237;39344.409833852515;40685.59314406855;41729.79135104328;41789.164216715726;41865.53470628529;41878.16243675132;7619.657115429819;7830.882536761953;7842.333401660866;7844;7853.371730261594;7774.41691873109;7857.253560911704;7861.882071768928;7874.094479134887;7907.486013409139;7740.496867703581;7893.723719669812;7898.210178982114;7898.328642065402;7907.565083920382;7852.254035866612;7859.6463159157975;7885.487443316195;7910.050793904711;7916.287534121957;7610.771676849703;7687.807804804868;7696.076470823481;7706.499077559996;7708.421868359896;37883;38203.61796382028;38454.03864903372;38514.80742596297;38609.61390386088;2417.891194896234;2804.733550312717;2892.4070565534016;2913.752331051863;2941.102963596102;26976.59535106975;27371.726282737116;27517.31206719828;27681.584776228374;27803.721962780317;3300.86796528141;3307;3344.1305260632166;3358.395488812013;3388.3053973935284;220689;220737;221113;221340;223427;32724.83637581797;33407;33858.32283354319;33874.49188262178;33930.83034584811;33501;35187.4721879172;35330.64669353325;35357.64642353595;35456.11359716028;13513.66215844592;13672.179669219879;13716.519921802888;13796.862031379758;13830.170189788645;10794.78410431787;10932.453377331261;10957.83563246552;10965.451727413756;10978.780424391467;7960.6417711201975;7996.520208787491;8052.436329456882;8106.7162649308175;8137.226963438464;3095.3654500827274;3133.185371803302;3151.7163455289133;3158.5262210668584;3178.8410579470933;792.4888446951684;821.4414198345182;896.3591032411726;910.8041771019263;1030.0523518363125;28834.27914302159;28944.276393090342;29050.41899162047;29409.55885661717;29518.445313003354;918.4168053286211;944.1266828183902;947.190152419685;1040.8862517106622;1049.4752623688155;14034.298285085704;14519.346629401702;14786.482473113389;14861.331240094221;15056.924715376354;392087;392656;392803;394606;396273.20497372345;51525.48474515282;52090.21864671957;52410.73794631002;52536.211956820676;52552;1215.866254711981;1229.59423390281;1251.4931452761646;1252.2423933520272;1272.3828942962655;26923.326916827235;27730.722692772815;27773.58339624867;27887.581686274316;28127.43745125127;42759.7862010688;43041.569584303754;43580.56419435765;43587.34618980781;43606.345904812086;326770;330098;330425;331856;332007;25718;26018.219453416426;26394.73605263923;26546.601800972614;26735.33161670896;44711;45007.324890126016;45201.54798451973;45203.7739811312;45311.09377812359;36972.44541331828;38408;38449.4232586517;38881.41677874778;38939.22121557609;37273.440898386005;37552;37593.43609845909;37902.24195516019;38232.2353552933;36967;37197.6280237205;37373;37924;38128.61871381251;32840.835795820865;33390.165245869044;33480.1629959253;34262.657373425944;34352.656473434945;25712.742872571034;25751.484970300862;26225.344366390993;26556.601650974866;26574.20277391604 15:56:06 INFO - PROCESS | 5501 | |2;jquery.html;369.90937220381005;370.2650239275039;374.9362608356579;377.97380112993216;389.17300735936135;16038.198090095493;16259.674806503863;16316.918415407921;16695.081770502617;16805.32778688851;16376.263068161932;16470.341186352533;17177.398791042317;17335.39326123586;17372.13139343034;4931.235658472942;5113.667611605252;5115.104856650071;5156.149235376159;5161.561267292284;3600.711943044563;5107.106256405133;5642.774289028454;5917.5561832862495;5989.460948514633;6028.487578555806;6033.879322413549;6045.153678485016;6056.364081771417;6061.151438798572;5820.301563812349;6059.757609695607;6063.363346848583;6065.909011364833;6068.302145253286;5097.7960881564695;5280.577553795725;5292.682439053669;5296.841094767163;5300.761465734013;19078.80921190798;19187.424377268704;19262.4221273362;19264;19473.415797526097;1844.7140693192578;1958.0308145846411;2022.9797702023086;2029.9289524866706;2042.234162189179;13118.803217951738;13570.050096493249;13577.660558486019;13701.314934253247;13770;1797.5595978985102;1817.9363722269657;1897.4023182697406;1902.781180164285;1945.542797442614;68884.6555767218;70855.64572177158;73122;73364;73410.63294683545;9785.706428807147;10011.399316041061;10013.198944084455;10082.445465499468;10169.23730720199;13827.723445531234;13944.581662549937;13950.372233249529;13956.302184890716;13967.650808729863;7077.646117694095;7161.104861892263;7167.677454514455;7279.818004549928;7301.160366557808;6672.366125218096;6718.193816742022;6733.494987875831;6863.6568171591225;6898.034275201476;4223.936640950388;4237.894052648709;4339.674524410681;4351.4995775485595;4419.867403977886;1542.691461707663;1711.7603535505039;1805.7652505174244;1818.3544841581313;1847.9353222637144;779.5400713578903;875.7635438431588;912.0286894457381;923.1460898668705;941.4633658814547;16145.67708645844;16183.19084045793;17250.223739931484;17403.825961740222;18041.7293740594;830.1532436914314;872.1627237851733;885.3404213860715;917.9173874351341;918.42598376015;9336.719898403058;9624.807503850025;9694.127528522467;9731.221502279801;9961.651342203133;376655;377932;380838;384495;384595;80709;81347;82198.06811591324;82705.58647206846;83054;976.3702411944256;984.242133557157;986.2997271936862;994.9901199576815;1010.9646162384281;14474.565763027125;15009;16319.265633046303;16395.344186232418;16828.495145145665;37849.24301514009;39250.60749392584;39376.606233937295;39755;40160.397594036694;46241.60704733045;47873.76063119662;48024.7598762004;54251.18623220576;55473.72263138658;7329.52358096722;7805.18045605226;7861.646225919733;7888.408369372435;7944.20557944224;10490.842637360598;11897.405129743305;12001.339926304137;12316.568920087753;12388.876111239133;9940.304178707422;10200.28597998133;10304.742381440225;10376.066154046172;10454.215933805148;10261.897381026392;10386.896131038895;10437.530311135864;10510.632127875793;10637.680869573926;10226.13077888358;10352.275340726379;10406.375617462976;10506.947465262625;10623.628173014216;7658.425618078778;7750.922490775246;7806.765797026098;7936.6428510716005;8047.83904321922;9181.908180918106;10332;10447.94776026115;10454.790904182026;10566.524506397383 15:56:06 INFO - PROCESS | 5501 | |3;mootools.html;1390.9652258693534;1408.5985494134175;1514.1672080355802;1706.7781188445501;1727.3436094284177;6669;7644.197359277279;7671.194524574923;8153.633086511107;8193.87709184362;7715.112762032368;7948.443608947376;7997.520148791076;8007.479513831597;8017.03795544534;2205.977940220593;2243.304575581567;2251.5609456156058;2252.650839119931;2253.11002154149;2204.1403852497538;2234.5642599693065;2244.8091912187483;2263.54729054189;2264.3546589222074;2188.72640919885;2213.57941991022;2229.721284839395;2238.0935721033006;2245.146844199202;2146.4311957331242;2157.5577006713665;2157.7842215778373;2158.665406861939;2161.567686462698;2175.9564808703894;2176.564687062578;2177.3467959612053;2185.366243789299;2186.9234576789895;7894.64474098667;7967.521948683039;8016.398770092266;8049.436539442241;8049.718259860877;4469.664775141878;4610.216263235225;4615.076984603093;4626.1210370029585;4636.165490211761;2895.102518219359;2926.1221633510077;2930.721581449759;2931.92670183245;2936.8237905725723;888.3026823943238;906.3655441191192;924.7503174142944;938.0525669074284;945.6737425588161;10703.304285221435;10741.892581074168;10744.78510429795;10808.51361688726;10848.02367786903;4185.183889141588;4284.8500302489265;4332.501762297313;4355.978220108879;4388.495323037828;9236.5843537041;9257.028012058772;9268.212201962773;9269.72190834276;9288.953555232181;4563.201439748031;4619.284010978304;4629.213033784265;4630.513796051433;4637.304404339308;3675.4486826976167;4103.261412945699;4219.725717828393;4233.322668373045;4249.87250382489;3624.9818750906074;3690.833912473945;3724.1806802503406;3782.394816829294;3943.2507823514015;1108.9778204435866;1117.536222467667;1137.5961533655598;1146.690393593725;1148.024179447463;663.5952069237761;674.254948282151;825.0347093900151;826.89663792026;848.1857416879865;5209.426963034139;5313.415524292324;5320.494553017457;5340.546053585411;5546.500814926676;398.3586425854372;420.2393667461904;421.1787015320138;892.9585673151564;969.7963427680126;3636.4908912752235;3718.535183102112;3758.7180961428003;3768.171002379472;3804.9619503804606;9369.578368973413;9520.381175223589;9596.424214547149;9620.13418792298;9661.32370734056;9471.242300615933;9553.570089345996;9587.520623968774;9604.375715578464;9611.183049440737;7087.61018144007;7211.242819503981;7250.963745181346;7268.890966635505;7506.812329691692;5371.892562148813;5466.91799622998;5473.757837675833;5567.164925261243;5632.662040277596;9136.04071572502;9147.954260228656;9206.263498919936;9237.445753254826;9301.86047209306;9095.772605684911;9124.49815260167;9124.950630677557;9185.219256363283;9264.907350926675;5579.832605021694;5942.821715348547;6038.12447195163;6174.8147555573405;6180.289266734383;7370.852582948418;7387.704491820482;7398.075240594926;7432.442566807619;7443.144038435649;6772.762953296611;6943.513954023372;6982.581045137308;7032.402245809163;7084.574925504487;6675.299093595297;6679.432248258758;6681.1314529110905;6757.459403247827;6771.762988295583;6176.28972668131;6218.626882387071;6244.562880598314;6277.811665650038;6317.30509643948;4526.547345265579;4655.0457156283555;4660.4174478190225;4771.332013518179;4808.0383923214795;4449.243628583214;4628.236341003697;4646.535346465326;4728.3380326753595;4737.857864264078 15:56:06 INFO - PROCESS | 5501 | |4;prototype.html;285.72713059028615;297.66661339299986;303.4204669082053;304.6070568966034;305.91587313488793;4812.903741925168;4955.554000139987;5027.648064635472;5046.54581087702;5048.697078175307;4753.263244197146;4893.947801222736;4913.950860491394;4928.457869634337;4936.308916751648;3868.6324799144036;3882.9611703882883;3897.4153876918404;3899.2201559688174;3906.628870257321;3742.176721121349;3928.0769019280588;3938.6849052075763;3959.7426167299177;3968.325384684596;3863.5750067492554;3865.246276975991;3895.2014836958356;3904.1606054698236;3917.8050694538156;3880.72834901557;3894.279558281727;3896.8246428910766;3903.1217975955465;3952.822123004443;3354.3626710924846;3470.6182319944787;3476.5132881396626;3501.859925602973;3515.736319776027;4703.2239680452685;4769.4515130760055;4770.7082113341685;4787.40157480315;4790.209615413452;4474.865754027384;4489.46126464823;4495.842645507391;4514.8194072237075;4527.501974782771;4926.876828079291;5187.250757098744;5201.297824793643;5217.869553261161;5253.238280449352;3717.516722826015;3747.5502939647417;3748.3253014457387;3756.6806821420214;3760.9623903761158;5471.71414717541;5522.751476183581;5526.972365138189;5533.612647114704;5547.308071038332;3651.1784848409425;3924.2740093082302;3926.980365098156;3929.351656976567;3944.875710422516;3862.995621138468;3910.8631197907935;3911.5110611173604;3925.450436938831;3940.4286378474962;4469;4470.9105817883465;4487.439070116236;4491.955080449219;4516.803047192497;5205.6356055075785;5220.895582088337;5234.476552344811;5272.762725677354;5293.894122117536;1252.480220708414;1354.106289848695;1355.532341342255;1355.9017196071213;1364.7884577890443;874.7900503879023;885.5306687455659;885.9335549833788;889.0709208876739;899.7030979776789;4108.979455102705;4182.91634167315;4229.238737027365;4232.978835105805;4257.659387249013;4788.377510923558;4805.471398146201;4823.638227132979;4832.318063474805;4863.319135321058;4148.62662360389;4263.552327005682;4267.039916018933;4268.253055715238;4304.634106101016;2454.9746459171256;2563.2054063240457;2575.1115865026536;2586.4439145583788;2595.9870200648875;4542.613877820356;4562.58936695699;4573.428321459817;4579.198640237945;4586.403767510203;4878.878028049327;4896.828610998669;4937.061958227925;4962.702237865739;4985.326980857611;4346.760928148982;4542.159700455426;4552.97392660263;4569.81720731167;4589.196890544208;4721.669483136285;4770.308305295782;4790.976045119752;4796.496367881462;4820.325154478446;4676.69601475903;4692.694974826625;4715.457722361835;4719.884875981836;4733.881652958704;4349.434203686734;4546.590806827401;4553.203189441768;4586.334981427608;4602.654800890014;3578.801101630983;3589.451489442525;3593.64063593649;3602.441621548664;3603.4414665726854;4762.571368576845;4771.377731571282;4778.331033655221;4811.687240329367;5137.845864623918;5010.398752149619;5198.8960220794615;5207.27098206259;5254.921176182437;5262.763175657028;5196.480351964773;5204.375474943031;5259.39516955555;5287.7620507078045;5316.813911513079;5075.086484432837;5114.309568208244;5155.226715992631;5214.478552144755;5234.581233501387;5145.61407894402;5290.418054014132;5291.8677033072945;5295.894082118259;5319.2287118368395;5095.617828662791;5115.18157094863;5146.845594632167;5165.845024649267;5195.428502864757 15:56:06 INFO - PROCESS | 5501 | |5;yui.html;633.8478765096376;675.3415419965535;717.1107826295395;739.5119221313934;742.5655991245121;12339.383030848467;12447.066470014739;12454.128211025232;12531.185472944275;12545.059120565948;11529.135314851399;11608.883911160907;11677.182597218198;11693.532258709663;12118.394080295971;621.304139363913;785.0853755374982;785.7681983814788;794.0233512779284;801.7915342011061;810.0522388805083;811.0915774332726;811.6225954930956;811.7970507373157;813.8209593889335;832.0348395860773;833.7748807821885;834.3367023216557;835.2315869400167;838.4633834345993;828.7720876758909;829.4276948905236;831.4969443486664;831.5966756123275;832.9458585191943;604.030530997751;604.1179877379031;604.3744724210464;604.6976511744128;607.532200205839;12745.936270318682;12755.744885102245;12767.744645107046;12768.361581920866;12779.424925878358;13255.801162982563;13536.86463135366;13732.313384330744;13793.517226897111;14021.64945876351;10240.487975601265;10359.119474844647;10379.221558383077;10384.065434110891;10709.357438553712;3287.3918325109694;3310.1890036940863;3333;3343.548620936191;3418.5555877735983;55582.72208638972;55617;56462.43537564654;57695.13457298144;58236.70881645607;10233;10305.793884122275;10434.843477347846;10468.162546996222;10685.893141068645;18704.906475467535;18975.43073707791;19028.238870445304;19042.714359284622;19187.232510699414;6422.710978006001;6493.123428337114;6563.540552161398;6623.3376662333385;6748.662566871735;3663.249033948034;3711;3744.063984003999;3755.1738617504107;3755.8309876055096;2841.801073924805;2925.9268518287213;2943.808652437585;2955.9556606650917;2963.4517614241436;498.53636118410225;500.56951022120944;507.81210951948015;508.3112382721433;517.9689218646894;495.3313027412964;508.10826998617927;508.52961011064616;533.4638688118416;542.2435702195415;7491.850162996819;7519.473636845369;7541.283578060075;7597.810054748565;7673.846523069507;451.86218203448266;527.9076161671692;530.2205757536416;535.1891883796052;540.9810656627078;3674.632536746304;3681.5398075240596;3691.53855768029;3705.2033812729856;3761.5110035695184;88575;92199;92476.53761731148;92532.53733731288;93298.53350733338;78680;80503.19496805074;81236.59381703053;81464;81641;71216.28783712097;72423.63788181025;72832.63583682048;73405;74281.62859185778;6516.120323756232;6645.667716614246;6675.332466753286;6769.695363708744;6887.793366199022;31015;34018.3196336067;35018.29963400667;41025.384619230135;43197.784011081;57229;58458;61705.38294617176;63939.68030159819;64501.677491612245;9010.14403631654;9151.908480915106;9161.770955725893;9162.816743665222;9271.119243671841;9533.856992144985;9567.952160239432;9729.513524323615;10054.748631283985;10320.071193592312;8489.95755021221;8720.607572659372;8724;8736.432131911406;8862.778430539289;8984.32617553673;9047.547622618975;9159.038300978302;9265.53672316395;9407.52962351866;8647.146441674107;8716.128387161232;8781.604827782638;8844.823103537765;9056.547172641473;7703.383729301754;7740.574268415291;8110.148434414302;8175.877361839696;8231.506109633441;7683.731069412544;7748.302652761278;7870.921290787019;8087.514749115072;8096.757097287091 15:56:06 INFO - PROCESS | 5501 | __end_tp_report 15:56:06 INFO - PROCESS | 5501 | __start_cc_report 15:56:06 INFO - PROCESS | 5501 | _x_x_mozilla_cycle_collect,383 15:56:06 INFO - PROCESS | 5501 | __end_cc_report 15:56:06 INFO - PROCESS | 5501 | __startTimestamp1465426566128__endTimestamp 15:56:06 INFO - PROCESS | 5501 | 15:56:06 INFO - PROCESS | 5501 | ------- Summary: start ------- 15:56:06 INFO - PROCESS | 5501 | Number of tests: 6 15:56:06 INFO - PROCESS | 5501 | 15:56:06 INFO - PROCESS | 5501 | [#0] dojo.html Cycles:165 Average:4756.90 Median:4903.75 stddev:508.71 (10.4%) stddev-sans-first:482.75 15:56:06 INFO - PROCESS | 5501 | Values: 2652.9 2709.8 2734.3 2736.0 2737.8 4777.9 4789.6 4803.7 4864.4 4966.3 4656.0 4756.5 4759.7 4767.4 4779.3 4344.4 4371.1 4440.9 4481.6 4484.7 4172.8 4535.7 4563.1 4578.5 4586.0 4318.3 4326.1 4342.0 4435.7 4491.0 4299.9 4325.6 4338.2 4343.0 4375.0 4341.8 4370.0 4381.7 4390.0 4417.4 4678.2 4734.9 4737.4 4748.5 4750.0 5160.5 5161.3 5177.9 5193.5 5232.1 4988.6 5152.4 5193.4 5225.2 5231.3 4768.1 4777.5 4816.4 4827.0 4876.0 5239.5 5256.7 5273.3 5284.9 5319.4 4942.5 5054.1 5056.7 5057.4 5057.6 4989.2 5088.8 5097.3 5110.3 5112.1 5056.4 5059.9 5128.1 5137.7 5143.3 4956.3 5111.0 5142.7 5169.5 5177.6 4195.8 4217.0 4264.9 4265.2 4266.8 3712.6 3712.7 3722.5 3764.2 3766.3 4480.9 4516.5 4520.7 4530.6 4567.2 5064.8 5127.7 5139.8 5156.4 5182.8 4532.6 4548.9 4559.6 4595.0 4603.8 4584.4 4599.7 4606.4 4609.4 4611.3 4752.1 4885.2 4920.4 4922.4 4963.2 5260.3 5262.1 5278.7 5284.9 5329.6 4952.0 4988.6 4992.4 5000.2 5045.8 4964.1 5067.1 5162.3 5166.2 5186.1 5197.7 5227.9 5231.2 5234.7 5247.2 5092.7 5093.6 5094.7 5098.8 5139.1 4874.0 4929.8 4935.0 4985.7 5008.8 4855.5 4880.4 4920.9 4929.2 4973.2 4866.9 5023.4 5027.4 5033.6 5091.1 4810.9 4882.5 4903.8 4943.1 4947.3 15:56:06 INFO - PROCESS | 5501 | 15:56:06 INFO - PROCESS | 5501 | [#1] ext.html Cycles:180 Average:46008.22 Median:37085.04 stddev:85329.07 (230.1%) stddev-sans-first:85500.17 15:56:06 INFO - PROCESS | 5501 | Values: 546.3 582.1 595.8 612.0 619.8 35588.8 39058.0 39096.8 39210.4 39344.4 40685.6 41729.8 41789.2 41865.5 41878.2 7619.7 7830.9 7842.3 7844.0 7853.4 7774.4 7857.3 7861.9 7874.1 7907.5 7740.5 7893.7 7898.2 7898.3 7907.6 7852.3 7859.6 7885.5 7910.1 7916.3 7610.8 7687.8 7696.1 7706.5 7708.4 37883.0 38203.6 38454.0 38514.8 38609.6 2417.9 2804.7 2892.4 2913.8 2941.1 26976.6 27371.7 27517.3 27681.6 27803.7 3300.9 3307.0 3344.1 3358.4 3388.3 220689.0 220737.0 221113.0 221340.0 223427.0 32724.8 33407.0 33858.3 33874.5 33930.8 33501.0 35187.5 35330.6 35357.6 35456.1 13513.7 13672.2 13716.5 13796.9 13830.2 10794.8 10932.5 10957.8 10965.5 10978.8 7960.6 7996.5 8052.4 8106.7 8137.2 3095.4 3133.2 3151.7 3158.5 3178.8 792.5 821.4 896.4 910.8 1030.1 28834.3 28944.3 29050.4 29409.6 29518.4 918.4 944.1 947.2 1040.9 1049.5 14034.3 14519.3 14786.5 14861.3 15056.9 392087.0 392656.0 392803.0 394606.0 396273.2 51525.5 52090.2 52410.7 52536.2 52552.0 1215.9 1229.6 1251.5 1252.2 1272.4 26923.3 27730.7 27773.6 27887.6 28127.4 42759.8 43041.6 43580.6 43587.3 43606.3 326770.0 330098.0 330425.0 331856.0 332007.0 25718.0 26018.2 26394.7 26546.6 26735.3 44711.0 45007.3 45201.5 45203.8 45311.1 36972.4 38408.0 38449.4 38881.4 38939.2 37273.4 37552.0 37593.4 37902.2 38232.2 36967.0 37197.6 37373.0 37924.0 38128.6 32840.8 33390.2 33480.2 34262.7 34352.7 25712.7 25751.5 26225.3 26556.6 26574.2 15:56:06 INFO - PROCESS | 5501 | 15:56:06 INFO - PROCESS | 5501 | [#2] jquery.html Cycles:180 Average:24458.58 Median:39313.61 stddev:63106.65 (160.5%) stddev-sans-first:63257.76 15:56:06 INFO - PROCESS | 5501 | Values: 369.9 370.3 374.9 378.0 389.2 16038.2 16259.7 16316.9 16695.1 16805.3 16376.3 16470.3 17177.4 17335.4 17372.1 4931.2 5113.7 5115.1 5156.1 5161.6 3600.7 5107.1 5642.8 5917.6 5989.5 6028.5 6033.9 6045.2 6056.4 6061.2 5820.3 6059.8 6063.4 6065.9 6068.3 5097.8 5280.6 5292.7 5296.8 5300.8 19078.8 19187.4 19262.4 19264.0 19473.4 1844.7 1958.0 2023.0 2029.9 2042.2 13118.8 13570.1 13577.7 13701.3 13770.0 1797.6 1817.9 1897.4 1902.8 1945.5 68884.7 70855.6 73122.0 73364.0 73410.6 9785.7 10011.4 10013.2 10082.4 10169.2 13827.7 13944.6 13950.4 13956.3 13967.7 7077.6 7161.1 7167.7 7279.8 7301.2 6672.4 6718.2 6733.5 6863.7 6898.0 4223.9 4237.9 4339.7 4351.5 4419.9 1542.7 1711.8 1805.8 1818.4 1847.9 779.5 875.8 912.0 923.1 941.5 16145.7 16183.2 17250.2 17403.8 18041.7 830.2 872.2 885.3 917.9 918.4 9336.7 9624.8 9694.1 9731.2 9961.7 376655.0 377932.0 380838.0 384495.0 384595.0 80709.0 81347.0 82198.1 82705.6 83054.0 976.4 984.2 986.3 995.0 1011.0 14474.6 15009.0 16319.3 16395.3 16828.5 37849.2 39250.6 39376.6 39755.0 40160.4 46241.6 47873.8 48024.8 54251.2 55473.7 7329.5 7805.2 7861.6 7888.4 7944.2 10490.8 11897.4 12001.3 12316.6 12388.9 9940.3 10200.3 10304.7 10376.1 10454.2 10261.9 10386.9 10437.5 10510.6 10637.7 10226.1 10352.3 10406.4 10506.9 10623.6 7658.4 7750.9 7806.8 7936.6 8047.8 9181.9 10332.0 10447.9 10454.8 10566.5 15:56:06 INFO - PROCESS | 5501 | 15:56:06 INFO - PROCESS | 5501 | [#3] mootools.html Cycles:180 Average:5164.63 Median:5330.52 stddev:2903.80 (54.5%) stddev-sans-first:2898.10 15:56:06 INFO - PROCESS | 5501 | Values: 1391.0 1408.6 1514.2 1706.8 1727.3 6669.0 7644.2 7671.2 8153.6 8193.9 7715.1 7948.4 7997.5 8007.5 8017.0 2206.0 2243.3 2251.6 2252.7 2253.1 2204.1 2234.6 2244.8 2263.5 2264.4 2188.7 2213.6 2229.7 2238.1 2245.1 2146.4 2157.6 2157.8 2158.7 2161.6 2176.0 2176.6 2177.3 2185.4 2186.9 7894.6 7967.5 8016.4 8049.4 8049.7 4469.7 4610.2 4615.1 4626.1 4636.2 2895.1 2926.1 2930.7 2931.9 2936.8 888.3 906.4 924.8 938.1 945.7 10703.3 10741.9 10744.8 10808.5 10848.0 4185.2 4284.9 4332.5 4356.0 4388.5 9236.6 9257.0 9268.2 9269.7 9289.0 4563.2 4619.3 4629.2 4630.5 4637.3 3675.4 4103.3 4219.7 4233.3 4249.9 3625.0 3690.8 3724.2 3782.4 3943.3 1109.0 1117.5 1137.6 1146.7 1148.0 663.6 674.3 825.0 826.9 848.2 5209.4 5313.4 5320.5 5340.5 5546.5 398.4 420.2 421.2 893.0 969.8 3636.5 3718.5 3758.7 3768.2 3805.0 9369.6 9520.4 9596.4 9620.1 9661.3 9471.2 9553.6 9587.5 9604.4 9611.2 7087.6 7211.2 7251.0 7268.9 7506.8 5371.9 5466.9 5473.8 5567.2 5632.7 9136.0 9148.0 9206.3 9237.4 9301.9 9095.8 9124.5 9125.0 9185.2 9264.9 5579.8 5942.8 6038.1 6174.8 6180.3 7370.9 7387.7 7398.1 7432.4 7443.1 6772.8 6943.5 6982.6 7032.4 7084.6 6675.3 6679.4 6681.1 6757.5 6771.8 6176.3 6218.6 6244.6 6277.8 6317.3 4526.5 4655.0 4660.4 4771.3 4808.0 4449.2 4628.2 4646.5 4728.3 4737.9 15:56:06 INFO - PROCESS | 5501 | 15:56:06 INFO - PROCESS | 5501 | [#4] prototype.html Cycles:180 Average:4193.73 Median:4582.77 stddev:1199.79 (26.2%) stddev-sans-first:1166.75 15:56:06 INFO - PROCESS | 5501 | Values: 285.7 297.7 303.4 304.6 305.9 4812.9 4955.6 5027.6 5046.5 5048.7 4753.3 4893.9 4914.0 4928.5 4936.3 3868.6 3883.0 3897.4 3899.2 3906.6 3742.2 3928.1 3938.7 3959.7 3968.3 3863.6 3865.2 3895.2 3904.2 3917.8 3880.7 3894.3 3896.8 3903.1 3952.8 3354.4 3470.6 3476.5 3501.9 3515.7 4703.2 4769.5 4770.7 4787.4 4790.2 4474.9 4489.5 4495.8 4514.8 4527.5 4926.9 5187.3 5201.3 5217.9 5253.2 3717.5 3747.6 3748.3 3756.7 3761.0 5471.7 5522.8 5527.0 5533.6 5547.3 3651.2 3924.3 3927.0 3929.4 3944.9 3863.0 3910.9 3911.5 3925.5 3940.4 4469.0 4470.9 4487.4 4492.0 4516.8 5205.6 5220.9 5234.5 5272.8 5293.9 1252.5 1354.1 1355.5 1355.9 1364.8 874.8 885.5 885.9 889.1 899.7 4109.0 4182.9 4229.2 4233.0 4257.7 4788.4 4805.5 4823.6 4832.3 4863.3 4148.6 4263.6 4267.0 4268.3 4304.6 2455.0 2563.2 2575.1 2586.4 2596.0 4542.6 4562.6 4573.4 4579.2 4586.4 4878.9 4896.8 4937.1 4962.7 4985.3 4346.8 4542.2 4553.0 4569.8 4589.2 4721.7 4770.3 4791.0 4796.5 4820.3 4676.7 4692.7 4715.5 4719.9 4733.9 4349.4 4546.6 4553.2 4586.3 4602.7 3578.8 3589.5 3593.6 3602.4 3603.4 4762.6 4771.4 4778.3 4811.7 5137.8 5010.4 5198.9 5207.3 5254.9 5262.8 5196.5 5204.4 5259.4 5287.8 5316.8 5075.1 5114.3 5155.2 5214.5 5234.6 5145.6 5290.4 5291.9 5295.9 5319.2 5095.6 5115.2 5146.8 5165.8 5195.4 15:56:06 INFO - PROCESS | 5501 | 15:56:06 INFO - PROCESS | 5501 | [#5] yui.html Cycles:180 Average:16464.54 Median:627.58 stddev:24105.72 (3841.1%) stddev-sans-first:24144.03 15:56:06 INFO - PROCESS | 5501 | Values: 633.8 675.3 717.1 739.5 742.6 12339.4 12447.1 12454.1 12531.2 12545.1 11529.1 11608.9 11677.2 11693.5 12118.4 621.3 785.1 785.8 794.0 801.8 810.1 811.1 811.6 811.8 813.8 832.0 833.8 834.3 835.2 838.5 828.8 829.4 831.5 831.6 832.9 604.0 604.1 604.4 604.7 607.5 12745.9 12755.7 12767.7 12768.4 12779.4 13255.8 13536.9 13732.3 13793.5 14021.6 10240.5 10359.1 10379.2 10384.1 10709.4 3287.4 3310.2 3333.0 3343.5 3418.6 55582.7 55617.0 56462.4 57695.1 58236.7 10233.0 10305.8 10434.8 10468.2 10685.9 18704.9 18975.4 19028.2 19042.7 19187.2 6422.7 6493.1 6563.5 6623.3 6748.7 3663.2 3711.0 3744.1 3755.2 3755.8 2841.8 2925.9 2943.8 2956.0 2963.5 498.5 500.6 507.8 508.3 518.0 495.3 508.1 508.5 533.5 542.2 7491.9 7519.5 7541.3 7597.8 7673.8 451.9 527.9 530.2 535.2 541.0 3674.6 3681.5 3691.5 3705.2 3761.5 88575.0 92199.0 92476.5 92532.5 93298.5 78680.0 80503.2 81236.6 81464.0 81641.0 71216.3 72423.6 72832.6 73405.0 74281.6 6516.1 6645.7 6675.3 6769.7 6887.8 31015.0 34018.3 35018.3 41025.4 43197.8 57229.0 58458.0 61705.4 63939.7 64501.7 9010.1 9151.9 9161.8 9162.8 9271.1 9533.9 9568.0 9729.5 10054.7 10320.1 8490.0 8720.6 8724.0 8736.4 8862.8 8984.3 9047.5 9159.0 9265.5 9407.5 8647.1 8716.1 8781.6 8844.8 9056.5 7703.4 7740.6 8110.1 8175.9 8231.5 7683.7 7748.3 7870.9 8087.5 8096.8 15:56:06 INFO - PROCESS | 5501 | -------- Summary: end -------- 15:56:06 INFO - PROCESS | 5501 | 15:56:06 INFO - TEST-INFO | 5501: exit 0 15:56:06 INFO - TEST-OK | dromaeo_css | took 1116309ms 15:56:06 INFO - TEST-START | kraken 15:56:06 INFO - operating with platform_type : linux_ 15:56:06 INFO - Initialising browser for kraken test... 15:56:06 INFO - TEST-INFO | started process 5735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJseZKt/profile http://localhost:45545/getInfo.html) 15:56:11 INFO - PROCESS | 5735 | __metrics Screen width/height:1600/1200 15:56:11 INFO - PROCESS | 5735 | colorDepth:24 15:56:11 INFO - PROCESS | 5735 | Browser inner width/height: 1024/697 15:56:11 INFO - PROCESS | 5735 | __metrics 15:56:11 ERROR - PROCESS | 5735 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:56:12 INFO - TEST-INFO | 5735: exit 0 15:56:12 INFO - Browser initialized. 15:56:12 INFO - Running cycle 1/1 for kraken test... 15:56:12 INFO - TEST-INFO | started process 5853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJseZKt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:56:24 INFO - PROCESS | 5853 | RSS: Main: 168751104 15:56:24 INFO - PROCESS | 5853 | 15:56:27 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45545/tests/kraken/driver.html?testName=audio-beat-detection) 15:56:28 INFO - PROCESS | 5853 | RSS: Main: 172646400 15:56:28 INFO - PROCESS | 5853 | 15:56:31 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45545/tests/kraken/driver.html?testName=audio-dft) 15:56:31 INFO - PROCESS | 5853 | RSS: Main: 172388352 15:56:31 INFO - PROCESS | 5853 | 15:56:34 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45545/tests/kraken/driver.html?testName=audio-fft) 15:56:35 INFO - PROCESS | 5853 | RSS: Main: 168337408 15:56:35 INFO - PROCESS | 5853 | 15:56:37 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45545/tests/kraken/driver.html?testName=audio-oscillator) 15:56:38 INFO - PROCESS | 5853 | RSS: Main: 168730624 15:56:38 INFO - PROCESS | 5853 | 15:56:40 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45545/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:56:40 INFO - PROCESS | 5853 | RSS: Main: 168681472 15:56:40 INFO - PROCESS | 5853 | 15:56:44 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45545/tests/kraken/driver.html?testName=imaging-darkroom) 15:56:44 INFO - PROCESS | 5853 | RSS: Main: 169349120 15:56:44 INFO - PROCESS | 5853 | 15:56:48 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45545/tests/kraken/driver.html?testName=imaging-desaturate) 15:56:49 INFO - PROCESS | 5853 | RSS: Main: 166445056 15:56:49 INFO - PROCESS | 5853 | 15:56:51 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45545/tests/kraken/driver.html?testName=json-parse-financial) 15:56:52 INFO - PROCESS | 5853 | RSS: Main: 167755776 15:56:52 INFO - PROCESS | 5853 | 15:56:54 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45545/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:56:54 INFO - PROCESS | 5853 | RSS: Main: 168247296 15:56:54 INFO - PROCESS | 5853 | 15:56:56 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45545/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:56:57 INFO - PROCESS | 5853 | RSS: Main: 168460288 15:56:57 INFO - PROCESS | 5853 | 15:56:59 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45545/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:57:00 INFO - PROCESS | 5853 | RSS: Main: 168689664 15:57:00 INFO - PROCESS | 5853 | 15:57:03 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45545/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:57:03 INFO - PROCESS | 5853 | RSS: Main: 169164800 15:57:03 INFO - PROCESS | 5853 | 15:57:06 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45545/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:57:07 INFO - PROCESS | 5853 | RSS: Main: 168837120 15:57:07 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | Cycle 1(1): loaded http://localhost:45545/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45545/tests/kraken/driver.html?testName=ai-astar) 15:57:09 INFO - PROCESS | 5853 | RSS: Main: 170016768 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | __start_tp_report 15:57:09 INFO - PROCESS | 5853 | _x_x_mozilla_page_load 15:57:09 INFO - PROCESS | 5853 | _x_x_mozilla_page_load_details 15:57:09 INFO - PROCESS | 5853 | |i|pagename|runs| 15:57:09 INFO - PROCESS | 5853 | |0;ai-astar;114;108;113;114;116;114;114;113;114;113 15:57:09 INFO - PROCESS | 5853 | |1;audio-beat-detection;154;133;158;179;132;155;157;131;192;132 15:57:09 INFO - PROCESS | 5853 | |2;audio-dft;162;166;166;174;165;166;161;162;161;162 15:57:09 INFO - PROCESS | 5853 | |3;audio-fft;75;75;75;165;77;79;75;76;154;78 15:57:09 INFO - PROCESS | 5853 | |4;audio-oscillator;87;88;139;86;86;86;130;87;90;136 15:57:09 INFO - PROCESS | 5853 | |5;imaging-gaussian-blur;117;118;118;118;118;118;118;118;118;118 15:57:09 INFO - PROCESS | 5853 | |6;imaging-darkroom;147;148;147;148;149;148;146;147;146;148 15:57:09 INFO - PROCESS | 5853 | |7;imaging-desaturate;96;96;97;95;95;96;96;96;98;96 15:57:09 INFO - PROCESS | 5853 | |8;json-parse-financial;66;65;65;65;63;64;64;63;62;63 15:57:09 INFO - PROCESS | 5853 | |9;json-stringify-tinderbox;65;65;64;65;66;66;65;65;65;66 15:57:09 INFO - PROCESS | 5853 | |10;stanford-crypto-aes;86;83;91;83;88;92;88;86;110;87 15:57:09 INFO - PROCESS | 5853 | |11;stanford-crypto-ccm;134;137;136;144;141;134;135;137;163;149 15:57:09 INFO - PROCESS | 5853 | |12;stanford-crypto-pbkdf2;172;171;173;171;172;171;177;171;177;169 15:57:09 INFO - PROCESS | 5853 | |13;stanford-crypto-sha256-iterative;67;70;68;71;67;69;67;67;68;67 15:57:09 INFO - PROCESS | 5853 | __end_tp_report 15:57:09 INFO - PROCESS | 5853 | __start_cc_report 15:57:09 INFO - PROCESS | 5853 | _x_x_mozilla_cycle_collect,976 15:57:09 INFO - PROCESS | 5853 | __end_cc_report 15:57:09 INFO - PROCESS | 5853 | __startTimestamp1465426629474__endTimestamp 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | ------- Summary: start ------- 15:57:09 INFO - PROCESS | 5853 | Number of tests: 14 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.06 (1.8%) stddev-sans-first:2.17 15:57:09 INFO - PROCESS | 5853 | Values: 114.0 108.0 113.0 114.0 116.0 114.0 114.0 113.0 114.0 113.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:156.00 stddev:21.09 (13.5%) stddev-sans-first:22.36 15:57:09 INFO - PROCESS | 5853 | Values: 154.0 133.0 158.0 179.0 132.0 155.0 157.0 131.0 192.0 132.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.50 stddev:3.95 (2.4%) stddev-sans-first:4.09 15:57:09 INFO - PROCESS | 5853 | Values: 162.0 166.0 166.0 174.0 165.0 166.0 161.0 162.0 161.0 162.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:35.22 (46.7%) stddev-sans-first:36.76 15:57:09 INFO - PROCESS | 5853 | Values: 75.0 75.0 75.0 165.0 77.0 79.0 75.0 76.0 154.0 78.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:86.50 stddev:23.25 (26.9%) stddev-sans-first:24.06 15:57:09 INFO - PROCESS | 5853 | Values: 87.0 88.0 139.0 86.0 86.0 86.0 130.0 87.0 90.0 136.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 15:57:09 INFO - PROCESS | 5853 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 15:57:09 INFO - PROCESS | 5853 | Values: 147.0 148.0 147.0 148.0 149.0 148.0 146.0 147.0 146.0 148.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 15:57:09 INFO - PROCESS | 5853 | Values: 96.0 96.0 97.0 95.0 95.0 96.0 96.0 96.0 98.0 96.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.50 stddev:1.25 (1.9%) stddev-sans-first:1.09 15:57:09 INFO - PROCESS | 5853 | Values: 66.0 65.0 65.0 65.0 63.0 64.0 64.0 63.0 62.0 63.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 15:57:09 INFO - PROCESS | 5853 | Values: 65.0 65.0 64.0 65.0 66.0 66.0 65.0 65.0 65.0 66.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:87.50 stddev:7.81 (8.9%) stddev-sans-first:8.18 15:57:09 INFO - PROCESS | 5853 | Values: 86.0 83.0 91.0 83.0 88.0 92.0 88.0 86.0 110.0 87.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:139.00 stddev:9.12 (6.6%) stddev-sans-first:9.31 15:57:09 INFO - PROCESS | 5853 | Values: 134.0 137.0 136.0 144.0 141.0 134.0 135.0 137.0 163.0 149.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:172.00 stddev:2.63 (1.5%) stddev-sans-first:2.79 15:57:09 INFO - PROCESS | 5853 | Values: 172.0 171.0 173.0 171.0 172.0 171.0 177.0 171.0 177.0 169.0 15:57:09 INFO - PROCESS | 5853 | 15:57:09 INFO - PROCESS | 5853 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.45 (2.1%) stddev-sans-first:1.48 15:57:09 INFO - PROCESS | 5853 | Values: 67.0 70.0 68.0 71.0 67.0 69.0 67.0 67.0 68.0 67.0 15:57:09 INFO - PROCESS | 5853 | -------- Summary: end -------- 15:57:09 INFO - PROCESS | 5853 | 15:57:10 INFO - TEST-INFO | 5853: exit 0 15:57:10 INFO - TEST-OK | kraken | took 63647ms 15:57:10 INFO - SUITE-END | took 1179s 15:57:10 INFO - Completed test suite (00:19:40) 15:57:10 INFO - javascript benchmark 15:57:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6297.221264901889, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2652.907148249811, 2709.769669578085, 2734.330089128163, 2736.0423851651913, 2737.8357298562073, 4777.904441911164, 4789.64077694173, 4803.663743537953, 4864.416270047599, 4966.2550617407405, 4656.0, 4756.500567440412, 4759.738214398207, 4767.356406885069, 4779.283107533872, 4344.370066340387, 4371.125774845028, 4440.933385999213, 4481.641468682514, 4484.66365022623, 4172.791360431981, 4535.659825513083, 4563.110193512266, 4578.473475550321, 4585.9541404586025, 4318.330658747899, 4326.134773045372, 4342.044750154961, 4435.68950173488, 4490.955090449086, 4299.935500967488, 4325.567443255681, 4338.175746608134, 4342.978285108586, 4374.9781251093855, 4341.804618792162, 4370.016746232104, 4381.715188512769, 4390.034192477649, 4417.403650507173, 4678.181318269323, 4734.905301893943, 4737.407824021997, 4748.5251474852585, 4750.026244619879, 5160.483951604847, 5161.329027226474, 5177.896442071175, 5193.480651934777, 5232.136697444917, 4988.625853061035, 5152.407473140599, 5193.428722840522, 5225.190095535198, 5231.346081739783, 4768.141734487756, 4777.546133117348, 4816.4220293564995, 4827.0, 4875.9512404875495, 5239.502247286502, 5256.710880901587, 5273.31446911899, 5284.894302114013, 5319.4414586467865, 4942.456329803718, 5054.115529782347, 5056.696598204119, 5057.418396884405, 5057.620678449131, 4989.17678583037, 5088.77100530477, 5097.260897169889, 5110.310108135429, 5112.054269960069, 5056.393232812086, 5059.898802024012, 5128.1282182029145, 5137.717425541631, 5143.27994080829, 4956.306117143603, 5111.0, 5142.742862856917, 5169.508896654812, 5177.637565370464, 4195.7692326922315, 4217.0, 4264.91470170601, 4265.232258193555, 4266.829326826892, 3712.5916149223563, 3712.6658600726064, 3722.516072910504, 3764.153065560227, 3766.2844059628583, 4480.910381792346, 4516.548345165523, 4520.683552151318, 4530.61489773373, 4567.246404343313, 5064.772085256172, 5127.717975511383, 5139.7687104080405, 5156.432792392834, 5182.766775495112, 4532.637389008872, 4548.88627784308, 4559.566841150086, 4594.989102397467, 4603.815847366068, 4584.4498660161, 4599.67802253839, 4606.355110284563, 4609.377734005933, 4611.308303754397, 4752.120857641347, 4885.169521181337, 4920.434150072788, 4922.409310882717, 4963.156263435152, 5260.263563101245, 5262.079136151082, 5278.656887302313, 5284.9471505284455, 5329.57363410934, 4951.97524012392, 4988.600911927109, 4992.350994370709, 5000.224965130411, 5045.823396181116, 4964.05682920244, 5067.062593420229, 5162.251473536241, 5166.199239117943, 5186.066508028591, 5197.740112994411, 5227.895442091213, 5231.189165679326, 5234.738263086907, 5247.16045432729, 5092.745362731923, 5093.643444958817, 5094.6688465249645, 5098.847034588968, 5139.074966506065, 4873.951260487492, 4929.827456039022, 4934.950650493449, 4985.675931064469, 5008.824691135793, 4855.514448555116, 4880.365552478155, 4920.92618610714, 4929.211326187793, 4973.154563724248, 4866.90266194667, 5023.372078490189, 5027.446980832178, 5033.6476446648385, 5091.0581542414775, 4810.855674329776, 4882.536159064884, 4903.754812259444, 4943.060818444484, 4947.332110165082], "value": 4724.2072711850715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.2789118363761, 582.0715958046916, 595.7557401465399, 611.9938800611992, 619.8109576579147, 35588.822055889716, 39058.023549411315, 39096.80451597742, 39210.41184382237, 39344.409833852515, 40685.59314406855, 41729.79135104328, 41789.164216715726, 41865.53470628529, 41878.16243675132, 7619.657115429819, 7830.882536761953, 7842.333401660866, 7844.0, 7853.371730261594, 7774.41691873109, 7857.253560911704, 7861.882071768928, 7874.094479134887, 7907.486013409139, 7740.496867703581, 7893.723719669812, 7898.210178982114, 7898.328642065402, 7907.565083920382, 7852.254035866612, 7859.6463159157975, 7885.487443316195, 7910.050793904711, 7916.287534121957, 7610.771676849703, 7687.807804804868, 7696.076470823481, 7706.499077559996, 7708.421868359896, 37883.0, 38203.61796382028, 38454.03864903372, 38514.80742596297, 38609.61390386088, 2417.891194896234, 2804.733550312717, 2892.4070565534016, 2913.752331051863, 2941.102963596102, 26976.59535106975, 27371.726282737116, 27517.31206719828, 27681.584776228374, 27803.721962780317, 3300.86796528141, 3307.0, 3344.1305260632166, 3358.395488812013, 3388.3053973935284, 220689.0, 220737.0, 221113.0, 221340.0, 223427.0, 32724.83637581797, 33407.0, 33858.32283354319, 33874.49188262178, 33930.83034584811, 33501.0, 35187.4721879172, 35330.64669353325, 35357.64642353595, 35456.11359716028, 13513.66215844592, 13672.179669219879, 13716.519921802888, 13796.862031379758, 13830.170189788645, 10794.78410431787, 10932.453377331261, 10957.83563246552, 10965.451727413756, 10978.780424391467, 7960.6417711201975, 7996.520208787491, 8052.436329456882, 8106.7162649308175, 8137.226963438464, 3095.3654500827274, 3133.185371803302, 3151.7163455289133, 3158.5262210668584, 3178.8410579470933, 792.4888446951684, 821.4414198345182, 896.3591032411726, 910.8041771019263, 1030.0523518363125, 28834.27914302159, 28944.276393090342, 29050.41899162047, 29409.55885661717, 29518.445313003354, 918.4168053286211, 944.1266828183902, 947.190152419685, 1040.8862517106622, 1049.4752623688155, 14034.298285085704, 14519.346629401702, 14786.482473113389, 14861.331240094221, 15056.924715376354, 392087.0, 392656.0, 392803.0, 394606.0, 396273.20497372345, 51525.48474515282, 52090.21864671957, 52410.73794631002, 52536.211956820676, 52552.0, 1215.866254711981, 1229.59423390281, 1251.4931452761646, 1252.2423933520272, 1272.3828942962655, 26923.326916827235, 27730.722692772815, 27773.58339624867, 27887.581686274316, 28127.43745125127, 42759.7862010688, 43041.569584303754, 43580.56419435765, 43587.34618980781, 43606.345904812086, 326770.0, 330098.0, 330425.0, 331856.0, 332007.0, 25718.0, 26018.219453416426, 26394.73605263923, 26546.601800972614, 26735.33161670896, 44711.0, 45007.324890126016, 45201.54798451973, 45203.7739811312, 45311.09377812359, 36972.44541331828, 38408.0, 38449.4232586517, 38881.41677874778, 38939.22121557609, 37273.440898386005, 37552.0, 37593.43609845909, 37902.24195516019, 38232.2353552933, 36967.0, 37197.6280237205, 37373.0, 37924.0, 38128.61871381251, 32840.835795820865, 33390.165245869044, 33480.1629959253, 34262.657373425944, 34352.656473434945, 25712.742872571034, 25751.484970300862, 26225.344366390993, 26556.601650974866, 26574.20277391604], "value": 16425.49212765065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.90937220381005, 370.2650239275039, 374.9362608356579, 377.97380112993216, 389.17300735936135, 16038.198090095493, 16259.674806503863, 16316.918415407921, 16695.081770502617, 16805.32778688851, 16376.263068161932, 16470.341186352533, 17177.398791042317, 17335.39326123586, 17372.13139343034, 4931.235658472942, 5113.667611605252, 5115.104856650071, 5156.149235376159, 5161.561267292284, 3600.711943044563, 5107.106256405133, 5642.774289028454, 5917.5561832862495, 5989.460948514633, 6028.487578555806, 6033.879322413549, 6045.153678485016, 6056.364081771417, 6061.151438798572, 5820.301563812349, 6059.757609695607, 6063.363346848583, 6065.909011364833, 6068.302145253286, 5097.7960881564695, 5280.577553795725, 5292.682439053669, 5296.841094767163, 5300.761465734013, 19078.80921190798, 19187.424377268704, 19262.4221273362, 19264.0, 19473.415797526097, 1844.7140693192578, 1958.0308145846411, 2022.9797702023086, 2029.9289524866706, 2042.234162189179, 13118.803217951738, 13570.050096493249, 13577.660558486019, 13701.314934253247, 13770.0, 1797.5595978985102, 1817.9363722269657, 1897.4023182697406, 1902.781180164285, 1945.542797442614, 68884.6555767218, 70855.64572177158, 73122.0, 73364.0, 73410.63294683545, 9785.706428807147, 10011.399316041061, 10013.198944084455, 10082.445465499468, 10169.23730720199, 13827.723445531234, 13944.581662549937, 13950.372233249529, 13956.302184890716, 13967.650808729863, 7077.646117694095, 7161.104861892263, 7167.677454514455, 7279.818004549928, 7301.160366557808, 6672.366125218096, 6718.193816742022, 6733.494987875831, 6863.6568171591225, 6898.034275201476, 4223.936640950388, 4237.894052648709, 4339.674524410681, 4351.4995775485595, 4419.867403977886, 1542.691461707663, 1711.7603535505039, 1805.7652505174244, 1818.3544841581313, 1847.9353222637144, 779.5400713578903, 875.7635438431588, 912.0286894457381, 923.1460898668705, 941.4633658814547, 16145.67708645844, 16183.19084045793, 17250.223739931484, 17403.825961740222, 18041.7293740594, 830.1532436914314, 872.1627237851733, 885.3404213860715, 917.9173874351341, 918.42598376015, 9336.719898403058, 9624.807503850025, 9694.127528522467, 9731.221502279801, 9961.651342203133, 376655.0, 377932.0, 380838.0, 384495.0, 384595.0, 80709.0, 81347.0, 82198.06811591324, 82705.58647206846, 83054.0, 976.3702411944256, 984.242133557157, 986.2997271936862, 994.9901199576815, 1010.9646162384281, 14474.565763027125, 15009.0, 16319.265633046303, 16395.344186232418, 16828.495145145665, 37849.24301514009, 39250.60749392584, 39376.606233937295, 39755.0, 40160.397594036694, 46241.60704733045, 47873.76063119662, 48024.7598762004, 54251.18623220576, 55473.72263138658, 7329.52358096722, 7805.18045605226, 7861.646225919733, 7888.408369372435, 7944.20557944224, 10490.842637360598, 11897.405129743305, 12001.339926304137, 12316.568920087753, 12388.876111239133, 9940.304178707422, 10200.28597998133, 10304.742381440225, 10376.066154046172, 10454.215933805148, 10261.897381026392, 10386.896131038895, 10437.530311135864, 10510.632127875793, 10637.680869573926, 10226.13077888358, 10352.275340726379, 10406.375617462976, 10506.947465262625, 10623.628173014216, 7658.425618078778, 7750.922490775246, 7806.765797026098, 7936.6428510716005, 8047.83904321922, 9181.908180918106, 10332.0, 10447.94776026115, 10454.790904182026, 10566.524506397383], "value": 8410.08918264422, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.9652258693534, 1408.5985494134175, 1514.1672080355802, 1706.7781188445501, 1727.3436094284177, 6669.0, 7644.197359277279, 7671.194524574923, 8153.633086511107, 8193.87709184362, 7715.112762032368, 7948.443608947376, 7997.520148791076, 8007.479513831597, 8017.03795544534, 2205.977940220593, 2243.304575581567, 2251.5609456156058, 2252.650839119931, 2253.11002154149, 2204.1403852497538, 2234.5642599693065, 2244.8091912187483, 2263.54729054189, 2264.3546589222074, 2188.72640919885, 2213.57941991022, 2229.721284839395, 2238.0935721033006, 2245.146844199202, 2146.4311957331242, 2157.5577006713665, 2157.7842215778373, 2158.665406861939, 2161.567686462698, 2175.9564808703894, 2176.564687062578, 2177.3467959612053, 2185.366243789299, 2186.9234576789895, 7894.64474098667, 7967.521948683039, 8016.398770092266, 8049.436539442241, 8049.718259860877, 4469.664775141878, 4610.216263235225, 4615.076984603093, 4626.1210370029585, 4636.165490211761, 2895.102518219359, 2926.1221633510077, 2930.721581449759, 2931.92670183245, 2936.8237905725723, 888.3026823943238, 906.3655441191192, 924.7503174142944, 938.0525669074284, 945.6737425588161, 10703.304285221435, 10741.892581074168, 10744.78510429795, 10808.51361688726, 10848.02367786903, 4185.183889141588, 4284.8500302489265, 4332.501762297313, 4355.978220108879, 4388.495323037828, 9236.5843537041, 9257.028012058772, 9268.212201962773, 9269.72190834276, 9288.953555232181, 4563.201439748031, 4619.284010978304, 4629.213033784265, 4630.513796051433, 4637.304404339308, 3675.4486826976167, 4103.261412945699, 4219.725717828393, 4233.322668373045, 4249.87250382489, 3624.9818750906074, 3690.833912473945, 3724.1806802503406, 3782.394816829294, 3943.2507823514015, 1108.9778204435866, 1117.536222467667, 1137.5961533655598, 1146.690393593725, 1148.024179447463, 663.5952069237761, 674.254948282151, 825.0347093900151, 826.89663792026, 848.1857416879865, 5209.426963034139, 5313.415524292324, 5320.494553017457, 5340.546053585411, 5546.500814926676, 398.3586425854372, 420.2393667461904, 421.1787015320138, 892.9585673151564, 969.7963427680126, 3636.4908912752235, 3718.535183102112, 3758.7180961428003, 3768.171002379472, 3804.9619503804606, 9369.578368973413, 9520.381175223589, 9596.424214547149, 9620.13418792298, 9661.32370734056, 9471.242300615933, 9553.570089345996, 9587.520623968774, 9604.375715578464, 9611.183049440737, 7087.61018144007, 7211.242819503981, 7250.963745181346, 7268.890966635505, 7506.812329691692, 5371.892562148813, 5466.91799622998, 5473.757837675833, 5567.164925261243, 5632.662040277596, 9136.04071572502, 9147.954260228656, 9206.263498919936, 9237.445753254826, 9301.86047209306, 9095.772605684911, 9124.49815260167, 9124.950630677557, 9185.219256363283, 9264.907350926675, 5579.832605021694, 5942.821715348547, 6038.12447195163, 6174.8147555573405, 6180.289266734383, 7370.852582948418, 7387.704491820482, 7398.075240594926, 7432.442566807619, 7443.144038435649, 6772.762953296611, 6943.513954023372, 6982.581045137308, 7032.402245809163, 7084.574925504487, 6675.299093595297, 6679.432248258758, 6681.1314529110905, 6757.459403247827, 6771.762988295583, 6176.28972668131, 6218.626882387071, 6244.562880598314, 6277.811665650038, 6317.30509643948, 4526.547345265579, 4655.0457156283555, 4660.4174478190225, 4771.332013518179, 4808.0383923214795, 4449.243628583214, 4628.236341003697, 4646.535346465326, 4728.3380326753595, 4737.857864264078], "value": 4122.423387010034, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.72713059028615, 297.66661339299986, 303.4204669082053, 304.6070568966034, 305.91587313488793, 4812.903741925168, 4955.554000139987, 5027.648064635472, 5046.54581087702, 5048.697078175307, 4753.263244197146, 4893.947801222736, 4913.950860491394, 4928.457869634337, 4936.308916751648, 3868.6324799144036, 3882.9611703882883, 3897.4153876918404, 3899.2201559688174, 3906.628870257321, 3742.176721121349, 3928.0769019280588, 3938.6849052075763, 3959.7426167299177, 3968.325384684596, 3863.5750067492554, 3865.246276975991, 3895.2014836958356, 3904.1606054698236, 3917.8050694538156, 3880.72834901557, 3894.279558281727, 3896.8246428910766, 3903.1217975955465, 3952.822123004443, 3354.3626710924846, 3470.6182319944787, 3476.5132881396626, 3501.859925602973, 3515.736319776027, 4703.2239680452685, 4769.4515130760055, 4770.7082113341685, 4787.40157480315, 4790.209615413452, 4474.865754027384, 4489.46126464823, 4495.842645507391, 4514.8194072237075, 4527.501974782771, 4926.876828079291, 5187.250757098744, 5201.297824793643, 5217.869553261161, 5253.238280449352, 3717.516722826015, 3747.5502939647417, 3748.3253014457387, 3756.6806821420214, 3760.9623903761158, 5471.71414717541, 5522.751476183581, 5526.972365138189, 5533.612647114704, 5547.308071038332, 3651.1784848409425, 3924.2740093082302, 3926.980365098156, 3929.351656976567, 3944.875710422516, 3862.995621138468, 3910.8631197907935, 3911.5110611173604, 3925.450436938831, 3940.4286378474962, 4469.0, 4470.9105817883465, 4487.439070116236, 4491.955080449219, 4516.803047192497, 5205.6356055075785, 5220.895582088337, 5234.476552344811, 5272.762725677354, 5293.894122117536, 1252.480220708414, 1354.106289848695, 1355.532341342255, 1355.9017196071213, 1364.7884577890443, 874.7900503879023, 885.5306687455659, 885.9335549833788, 889.0709208876739, 899.7030979776789, 4108.979455102705, 4182.91634167315, 4229.238737027365, 4232.978835105805, 4257.659387249013, 4788.377510923558, 4805.471398146201, 4823.638227132979, 4832.318063474805, 4863.319135321058, 4148.62662360389, 4263.552327005682, 4267.039916018933, 4268.253055715238, 4304.634106101016, 2454.9746459171256, 2563.2054063240457, 2575.1115865026536, 2586.4439145583788, 2595.9870200648875, 4542.613877820356, 4562.58936695699, 4573.428321459817, 4579.198640237945, 4586.403767510203, 4878.878028049327, 4896.828610998669, 4937.061958227925, 4962.702237865739, 4985.326980857611, 4346.760928148982, 4542.159700455426, 4552.97392660263, 4569.81720731167, 4589.196890544208, 4721.669483136285, 4770.308305295782, 4790.976045119752, 4796.496367881462, 4820.325154478446, 4676.69601475903, 4692.694974826625, 4715.457722361835, 4719.884875981836, 4733.881652958704, 4349.434203686734, 4546.590806827401, 4553.203189441768, 4586.334981427608, 4602.654800890014, 3578.801101630983, 3589.451489442525, 3593.64063593649, 3602.441621548664, 3603.4414665726854, 4762.571368576845, 4771.377731571282, 4778.331033655221, 4811.687240329367, 5137.845864623918, 5010.398752149619, 5198.8960220794615, 5207.27098206259, 5254.921176182437, 5262.763175657028, 5196.480351964773, 5204.375474943031, 5259.39516955555, 5287.7620507078045, 5316.813911513079, 5075.086484432837, 5114.309568208244, 5155.226715992631, 5214.478552144755, 5234.581233501387, 5145.61407894402, 5290.418054014132, 5291.8677033072945, 5295.894082118259, 5319.2287118368395, 5095.617828662791, 5115.18157094863, 5146.845594632167, 5165.845024649267, 5195.428502864757], "value": 3814.867319139988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.8478765096376, 675.3415419965535, 717.1107826295395, 739.5119221313934, 742.5655991245121, 12339.383030848467, 12447.066470014739, 12454.128211025232, 12531.185472944275, 12545.059120565948, 11529.135314851399, 11608.883911160907, 11677.182597218198, 11693.532258709663, 12118.394080295971, 621.304139363913, 785.0853755374982, 785.7681983814788, 794.0233512779284, 801.7915342011061, 810.0522388805083, 811.0915774332726, 811.6225954930956, 811.7970507373157, 813.8209593889335, 832.0348395860773, 833.7748807821885, 834.3367023216557, 835.2315869400167, 838.4633834345993, 828.7720876758909, 829.4276948905236, 831.4969443486664, 831.5966756123275, 832.9458585191943, 604.030530997751, 604.1179877379031, 604.3744724210464, 604.6976511744128, 607.532200205839, 12745.936270318682, 12755.744885102245, 12767.744645107046, 12768.361581920866, 12779.424925878358, 13255.801162982563, 13536.86463135366, 13732.313384330744, 13793.517226897111, 14021.64945876351, 10240.487975601265, 10359.119474844647, 10379.221558383077, 10384.065434110891, 10709.357438553712, 3287.3918325109694, 3310.1890036940863, 3333.0, 3343.548620936191, 3418.5555877735983, 55582.72208638972, 55617.0, 56462.43537564654, 57695.13457298144, 58236.70881645607, 10233.0, 10305.793884122275, 10434.843477347846, 10468.162546996222, 10685.893141068645, 18704.906475467535, 18975.43073707791, 19028.238870445304, 19042.714359284622, 19187.232510699414, 6422.710978006001, 6493.123428337114, 6563.540552161398, 6623.3376662333385, 6748.662566871735, 3663.249033948034, 3711.0, 3744.063984003999, 3755.1738617504107, 3755.8309876055096, 2841.801073924805, 2925.9268518287213, 2943.808652437585, 2955.9556606650917, 2963.4517614241436, 498.53636118410225, 500.56951022120944, 507.81210951948015, 508.3112382721433, 517.9689218646894, 495.3313027412964, 508.10826998617927, 508.52961011064616, 533.4638688118416, 542.2435702195415, 7491.850162996819, 7519.473636845369, 7541.283578060075, 7597.810054748565, 7673.846523069507, 451.86218203448266, 527.9076161671692, 530.2205757536416, 535.1891883796052, 540.9810656627078, 3674.632536746304, 3681.5398075240596, 3691.53855768029, 3705.2033812729856, 3761.5110035695184, 88575.0, 92199.0, 92476.53761731148, 92532.53733731288, 93298.53350733338, 78680.0, 80503.19496805074, 81236.59381703053, 81464.0, 81641.0, 71216.28783712097, 72423.63788181025, 72832.63583682048, 73405.0, 74281.62859185778, 6516.120323756232, 6645.667716614246, 6675.332466753286, 6769.695363708744, 6887.793366199022, 31015.0, 34018.3196336067, 35018.29963400667, 41025.384619230135, 43197.784011081, 57229.0, 58458.0, 61705.38294617176, 63939.68030159819, 64501.677491612245, 9010.14403631654, 9151.908480915106, 9161.770955725893, 9162.816743665222, 9271.119243671841, 9533.856992144985, 9567.952160239432, 9729.513524323615, 10054.748631283985, 10320.071193592312, 8489.95755021221, 8720.607572659372, 8724.0, 8736.432131911406, 8862.778430539289, 8984.32617553673, 9047.547622618975, 9159.038300978302, 9265.53672316395, 9407.52962351866, 8647.146441674107, 8716.128387161232, 8781.604827782638, 8844.823103537765, 9056.547172641473, 7703.383729301754, 7740.574268415291, 8110.148434414302, 8175.877361839696, 8231.506109633441, 7683.731069412544, 7748.302652761278, 7870.921290787019, 8087.514749115072, 8096.757097287091], "value": 6075.2880947611875, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 114.0, 116.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 158.0, 179.0, 132.0, 155.0, 157.0, 131.0, 192.0, 132.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 166.0, 174.0, 165.0, 166.0, 161.0, 162.0, 161.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 165.0, 77.0, 79.0, 75.0, 76.0, 154.0, 78.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 139.0, 86.0, 86.0, 86.0, 130.0, 87.0, 90.0, 136.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 149.0, 148.0, 146.0, 147.0, 146.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 98.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 63.0, 64.0, 64.0, 63.0, 62.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 91.0, 83.0, 88.0, 92.0, 88.0, 86.0, 110.0, 87.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 137.0, 136.0, 144.0, 141.0, 134.0, 135.0, 137.0, 163.0, 149.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 173.0, 171.0, 172.0, 171.0, 177.0, 171.0, 177.0, 169.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 71.0, 67.0, 69.0, 67.0, 67.0, 68.0, 67.0], "value": 68.1, "unit": "score"}]}]} 15:57:10 INFO - Return code: 0 15:57:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:57:10 ERROR - # TBPL SUCCESS # 15:57:10 INFO - Running post-action listener: _resource_record_post_action 15:57:10 INFO - ##### 15:57:10 INFO - ##### Finished run-tests step (success) 15:57:10 INFO - ##### 15:57:10 INFO - Running post-run listener: _resource_record_post_run 15:57:10 INFO - Total resource usage - Wall time: 1197s; CPU: 14.0%; Read bytes: 507904; Write bytes: 298647552; Read time: 304; Write time: 174388 15:57:10 INFO - TinderboxPrint: CPU usage
13.5% 15:57:10 INFO - TinderboxPrint: I/O read bytes / time
507,904 / 304 15:57:10 INFO - TinderboxPrint: I/O write bytes / time
298,647,552 / 174,388 15:57:10 INFO - TinderboxPrint: CPU idle
8,260.0 (86.5%) 15:57:10 INFO - TinderboxPrint: CPU user
1,240.5 (13.0%) 15:57:10 INFO - TinderboxPrint: Swap in / out
0 / 0 15:57:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 17289216; Read time: 0; Write time: 7688 15:57:10 INFO - run-tests - Wall time: 1181s; CPU: 14.0%; Read bytes: 507904; Write bytes: 281358336; Read time: 304; Write time: 166700 15:57:11 INFO - Running post-run listener: _upload_blobber_files 15:57:11 INFO - Blob upload gear active. 15:57:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:57:11 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:57:11 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:57:11 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:57:11 INFO - (blobuploader) - INFO - Open directory for files ... 15:57:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:57:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:57:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:12 INFO - (blobuploader) - INFO - Done attempting. 15:57:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:57:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:57:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:16 INFO - (blobuploader) - INFO - Done attempting. 15:57:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:57:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:57:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:57:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:57:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:57:17 INFO - (blobuploader) - INFO - Done attempting. 15:57:17 INFO - (blobuploader) - INFO - Iteration through files over. 15:57:17 INFO - Return code: 0 15:57:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:57:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:57:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40f264cd05ac354cb4c249c369cadcd40943166760bf5f0cc8eb8a294d8ef78506608842969708a39953ed4a4f206d4c48045004f1d178467137ac4f5723e3b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d99fa06587760381e750deaed61672f2915cc0b78b7a1829937532f095878b628b7784f309febc316a36af60caad038c187f199dc34335c1cb586ef56e5f1a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23760649d4a65d34f3ce5ecae7bcbe6731fec1f2369b5f540f19d01ed554bc3e8da92de0fffc9dca097fb7e82584f19ec4c54d4849a91a70dbddff7c7dd6d410"} 15:57:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:57:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:57:17 INFO - Contents: 15:57:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40f264cd05ac354cb4c249c369cadcd40943166760bf5f0cc8eb8a294d8ef78506608842969708a39953ed4a4f206d4c48045004f1d178467137ac4f5723e3b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d99fa06587760381e750deaed61672f2915cc0b78b7a1829937532f095878b628b7784f309febc316a36af60caad038c187f199dc34335c1cb586ef56e5f1a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23760649d4a65d34f3ce5ecae7bcbe6731fec1f2369b5f540f19d01ed554bc3e8da92de0fffc9dca097fb7e82584f19ec4c54d4849a91a70dbddff7c7dd6d410"} 15:57:17 INFO - Running post-run listener: copy_logs_to_upload_dir 15:57:17 INFO - Copying logs to upload dir... 15:57:17 INFO - mkdir: /builds/slave/test/build/upload/logs 15:57:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.706480 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-08 15:57:17.396503) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 15:57:17.399930) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766 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/40f264cd05ac354cb4c249c369cadcd40943166760bf5f0cc8eb8a294d8ef78506608842969708a39953ed4a4f206d4c48045004f1d178467137ac4f5723e3b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d99fa06587760381e750deaed61672f2915cc0b78b7a1829937532f095878b628b7784f309febc316a36af60caad038c187f199dc34335c1cb586ef56e5f1a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23760649d4a65d34f3ce5ecae7bcbe6731fec1f2369b5f540f19d01ed554bc3e8da92de0fffc9dca097fb7e82584f19ec4c54d4849a91a70dbddff7c7dd6d410"} build_url:https://queue.taskcluster.net/v1/task/R4fN73UhRSCNQC_oJuVpAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/R4fN73UhRSCNQC_oJuVpAQ/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/40f264cd05ac354cb4c249c369cadcd40943166760bf5f0cc8eb8a294d8ef78506608842969708a39953ed4a4f206d4c48045004f1d178467137ac4f5723e3b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5d99fa06587760381e750deaed61672f2915cc0b78b7a1829937532f095878b628b7784f309febc316a36af60caad038c187f199dc34335c1cb586ef56e5f1a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/23760649d4a65d34f3ce5ecae7bcbe6731fec1f2369b5f540f19d01ed554bc3e8da92de0fffc9dca097fb7e82584f19ec4c54d4849a91a70dbddff7c7dd6d410"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 15:57:17.425363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 15:57:17.425710) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1465425396.269058-870581766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 15:57:17.508499) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 15:57:17.508823) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 15:57:17.509125) ========= ========= Total master_lag: 0.15 =========