builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1466241604.71 results: success (0) buildid: 20160617233003 builduid: 1c2b73f4bc20486abc510eb2e476775b revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.705843) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.706394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.706739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.776865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.777121) ========= 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=00204705a9daa57ed339a427000001b9-1466238857.328536-734563074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 02:20:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 210M=0s 2016-06-18 02:20:05 (210 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133244 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.932118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.932458) ========= 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=00204705a9daa57ed339a427000001b9-1466238857.328536-734563074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014013 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:04.985008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-18 02:20:04.985334) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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=00204705a9daa57ed339a427000001b9-1466238857.328536-734563074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 02:20:05,185 truncating revision to first 12 chars 2016-06-18 02:20:05,185 Setting DEBUG logging. 2016-06-18 02:20:05,185 attempt 1/10 2016-06-18 02:20:05,185 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3ce53bd1e25b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 02:20:06,168 unpacking tar archive at: fx-team-3ce53bd1e25b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.333156 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-18 02:20:06.333280) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:06.333633) ========= script_repo_revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:06.334067) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:06.334354) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 02:20:06.345828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-18 02:20:06.346281) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1466238857.328536-734563074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:20:06 INFO - MultiFileLogger online at 20160618 02:20:06 in /builds/slave/test 02:20:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:20:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:06 INFO - {'append_to_log': False, 02:20:06 INFO - 'base_work_dir': '/builds/slave/test', 02:20:06 INFO - 'blob_upload_branch': 'Fx-Team', 02:20:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:06 INFO - 'branch': 'Fx-Team', 02:20:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:06 INFO - 'config_files': ('talos/linux_config.py',), 02:20:06 INFO - 'default_actions': ('clobber', 02:20:06 INFO - 'read-buildbot-config', 02:20:06 INFO - 'download-and-extract', 02:20:06 INFO - 'populate-webroot', 02:20:06 INFO - 'create-virtualenv', 02:20:06 INFO - 'install', 02:20:06 INFO - 'run-tests'), 02:20:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:06 INFO - 'download_minidump_stackwalk': True, 02:20:06 INFO - 'download_symbols': 'ondemand', 02:20:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:06 INFO - 'installer_path': 'installer.exe', 02:20:06 INFO - 'log_level': 'info', 02:20:06 INFO - 'log_name': 'talos', 02:20:06 INFO - 'log_to_console': True, 02:20:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:20:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:20:06 INFO - 'opt_config_files': (), 02:20:06 INFO - 'pip_index': False, 02:20:06 INFO - 'sps_profile': False, 02:20:06 INFO - 'sps_profile_interval': 0, 02:20:06 INFO - 'suite': 'dromaeojs-e10s', 02:20:06 INFO - 'system_bits': '32', 02:20:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:06 INFO - 'title': 'talos-linux64-ix-016', 02:20:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:06 INFO - 'use_talos_json': True, 02:20:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:06 INFO - 'work_dir': 'build'} 02:20:06 INFO - ##### 02:20:06 INFO - ##### Running clobber step. 02:20:06 INFO - ##### 02:20:06 INFO - Running pre-action listener: _resource_record_pre_action 02:20:06 INFO - Running main action method: clobber 02:20:06 INFO - rmtree: /builds/slave/test/build 02:20:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:07 INFO - Running post-action listener: _resource_record_post_action 02:20:07 INFO - ##### 02:20:07 INFO - ##### Finished clobber step (success) 02:20:07 INFO - ##### 02:20:07 INFO - ##### 02:20:07 INFO - ##### Running read-buildbot-config step. 02:20:07 INFO - ##### 02:20:07 INFO - Running pre-action listener: _resource_record_pre_action 02:20:07 INFO - Running main action method: read_buildbot_config 02:20:07 INFO - Using buildbot properties: 02:20:07 INFO - { 02:20:07 INFO - "project": "", 02:20:07 INFO - "product": "firefox", 02:20:07 INFO - "script_repo_revision": "production", 02:20:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:20:07 INFO - "repository": "", 02:20:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:20:07 INFO - "buildid": "20160617233003", 02:20:07 INFO - "pgo_build": "True", 02:20:07 INFO - "basedir": "/builds/slave/test", 02:20:07 INFO - "buildnumber": 563, 02:20:07 INFO - "slavename": "talos-linux64-ix-016", 02:20:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:20:07 INFO - "platform": "ubuntu64_hw", 02:20:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:20:07 INFO - "branch": "fx-team", 02:20:07 INFO - "repo_path": "integration/fx-team", 02:20:07 INFO - "revision": "3ce53bd1e25b93140484d3933c9339a829e0c1eb", 02:20:07 INFO - "stage_platform": "linux64-pgo", 02:20:07 INFO - "builduid": "1c2b73f4bc20486abc510eb2e476775b", 02:20:07 INFO - "slavebuilddir": "test" 02:20:07 INFO - } 02:20:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:20:07 INFO - Running post-action listener: _resource_record_post_action 02:20:07 INFO - ##### 02:20:07 INFO - ##### Finished read-buildbot-config step (success) 02:20:07 INFO - ##### 02:20:07 INFO - ##### 02:20:07 INFO - ##### Running download-and-extract step. 02:20:07 INFO - ##### 02:20:07 INFO - Running pre-action listener: _resource_record_pre_action 02:20:07 INFO - Running main action method: download_and_extract 02:20:07 INFO - mkdir: /builds/slave/test/build/tests 02:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:07 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:20:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:20:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:20:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:18 INFO - Downloaded 1361 bytes. 02:20:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:20:18 INFO - Using the following test package requirements: 02:20:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:18 INFO - u'jsshell-linux-x86_64.zip'], 02:20:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:18 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:27 INFO - Downloaded 24221020 bytes. 02:20:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:28 INFO - Return code: 0 02:20:28 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 02:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:28 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:20:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:31 INFO - Downloaded 24221020 bytes. 02:20:31 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'] 02:20:31 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 02:20:33 INFO - Return code: 0 02:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:33 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:20:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:34 INFO - Downloaded 14405384 bytes. 02:20:34 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'] 02:20:34 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 02:20:34 INFO - Return code: 0 02:20:34 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')]} 02:20:34 INFO - https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:20:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WPS14SmeSl2gvBQojfXlWg/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 02:20:36 INFO - Downloaded 60128862 bytes. 02:20:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:36 INFO - mkdir: /builds/slave/test/properties 02:20:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:20:36 INFO - Writing to file /builds/slave/test/properties/build_url 02:20:36 INFO - Contents: 02:20:36 INFO - build_url:https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:20:36 INFO - Running post-action listener: _resource_record_post_action 02:20:36 INFO - Running post-action listener: set_extra_try_arguments 02:20:36 INFO - ##### 02:20:36 INFO - ##### Finished download-and-extract step (success) 02:20:36 INFO - ##### 02:20:36 INFO - ##### 02:20:36 INFO - ##### Running populate-webroot step. 02:20:36 INFO - ##### 02:20:36 INFO - Running pre-action listener: _resource_record_pre_action 02:20:36 INFO - Running main action method: populate_webroot 02:20:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:20:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:20:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:20:36 INFO - '--tppagecycles', 02:20:36 INFO - '7'], 02:20:36 INFO - 'tests': ['tsvgm']}}, 02:20:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:20:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:20:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:20:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:20:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:20:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:20:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:36 INFO - 'talos_options': ['--disable-e10s'], 02:20:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:36 INFO - 'talos_options': ['--disable-e10s'], 02:20:36 INFO - 'tests': ['damp', 'tps']}, 02:20:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:36 INFO - 'tests': ['damp', 'tps']}, 02:20:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:20:36 INFO - 'tests': ['dromaeo_dom']}, 02:20:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:20:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:20:36 INFO - 'tests': ['basic_compositor_video']}, 02:20:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:20:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:20:36 INFO - 'tests': ['a11yr', 02:20:36 INFO - 'ts_paint', 02:20:36 INFO - 'tpaint', 02:20:36 INFO - 'sessionrestore', 02:20:36 INFO - 'sessionrestore_no_auto_restore', 02:20:36 INFO - 'tabpaint']}, 02:20:36 INFO - 'other-e10s': {'tests': ['a11yr', 02:20:36 INFO - 'ts_paint', 02:20:36 INFO - 'tpaint', 02:20:36 INFO - 'sessionrestore', 02:20:36 INFO - 'sessionrestore_no_auto_restore', 02:20:36 INFO - 'tabpaint']}, 02:20:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:20:36 INFO - 'ts_paint', 02:20:36 INFO - 'tpaint', 02:20:36 INFO - 'sessionrestore', 02:20:36 INFO - 'sessionrestore_no_auto_restore', 02:20:36 INFO - 'tabpaint']}, 02:20:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:20:36 INFO - 'ts_paint', 02:20:36 INFO - 'tpaint', 02:20:36 INFO - 'sessionrestore', 02:20:36 INFO - 'sessionrestore_no_auto_restore', 02:20:36 INFO - 'tabpaint']}, 02:20:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:20:36 INFO - 'tests': ['a11yr', 02:20:36 INFO - 'ts_paint', 02:20:36 INFO - 'tpaint', 02:20:36 INFO - 'sessionrestore', 02:20:36 INFO - 'sessionrestore_no_auto_restore', 02:20:36 INFO - 'tabpaint']}, 02:20:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:20:36 INFO - 'tests': ['a11yr', 02:20:36 INFO - 'ts_paint', 02:20:36 INFO - 'tpaint', 02:20:36 INFO - 'sessionrestore', 02:20:36 INFO - 'sessionrestore_no_auto_restore', 02:20:36 INFO - 'tabpaint']}, 02:20:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:20:36 INFO - 'tests': ['tsvgx', 02:20:36 INFO - 'tsvgr_opacity', 02:20:36 INFO - 'tart', 02:20:36 INFO - 'tscrollx', 02:20:36 INFO - 'cart']}, 02:20:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:20:36 INFO - 'tsvgr_opacity', 02:20:36 INFO - 'tart', 02:20:36 INFO - 'tscrollx', 02:20:36 INFO - 'cart']}, 02:20:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:36 INFO - 'talos_options': ['--disable-e10s'], 02:20:36 INFO - 'tests': ['tp5o']}, 02:20:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:36 INFO - 'tests': ['tp5o']}, 02:20:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:36 INFO - 'talos_options': ['--disable-e10s', 02:20:36 INFO - '--xperf_path', 02:20:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:36 INFO - 'tests': ['tp5n']}, 02:20:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:36 INFO - 'talos_options': ['--xperf_path', 02:20:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:36 INFO - 'tests': ['tp5n']}}, 02:20:36 INFO - 'talos.zip': {'path': '', 02:20:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:20:36 INFO - Running post-action listener: _resource_record_post_action 02:20:36 INFO - ##### 02:20:36 INFO - ##### Finished populate-webroot step (success) 02:20:36 INFO - ##### 02:20:36 INFO - ##### 02:20:36 INFO - ##### Running create-virtualenv step. 02:20:36 INFO - ##### 02:20:36 INFO - Running pre-action listener: _resource_record_pre_action 02:20:36 INFO - Running main action method: create_virtualenv 02:20:36 INFO - Creating virtualenv /builds/slave/test/build/venv 02:20:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:20:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:20:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:20:36 INFO - Using real prefix '/usr' 02:20:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:20:37 INFO - Installing distribute.............................................................................................................................................................................................done. 02:20:39 INFO - Installing pip.................done. 02:20:39 INFO - Return code: 0 02:20:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb956f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716110>, '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 0x2682230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26826c0>, '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': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', '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 02:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:20:39 INFO - Using env: {'DISPLAY': ':0', 02:20:39 INFO - 'HOME': '/home/cltbld', 02:20:39 INFO - 'LANG': 'en_US.UTF-8', 02:20:39 INFO - 'LANGUAGE': 'en_US:en', 02:20:39 INFO - 'LOGNAME': 'cltbld', 02:20:39 INFO - 'MAIL': '/var/mail/cltbld', 02:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:39 INFO - 'MOZ_NO_REMOTE': '1', 02:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:39 INFO - 'NO_EM_RESTART': '1', 02:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:39 INFO - 'PWD': '/builds/slave/test', 02:20:39 INFO - 'SHELL': '/bin/bash', 02:20:39 INFO - 'SHLVL': '1', 02:20:39 INFO - 'TERM': 'linux', 02:20:39 INFO - 'TMOUT': '86400', 02:20:39 INFO - 'USER': 'cltbld', 02:20:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', 02:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:39 INFO - '_': '/tools/buildbot/bin/python'} 02:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:20:39 INFO - Cleaning up... 02:20:39 INFO - Return code: 0 02:20:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb956f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716110>, '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 0x2682230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26826c0>, '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': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', '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 02:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:20:39 INFO - Using env: {'DISPLAY': ':0', 02:20:39 INFO - 'HOME': '/home/cltbld', 02:20:39 INFO - 'LANG': 'en_US.UTF-8', 02:20:39 INFO - 'LANGUAGE': 'en_US:en', 02:20:39 INFO - 'LOGNAME': 'cltbld', 02:20:39 INFO - 'MAIL': '/var/mail/cltbld', 02:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:39 INFO - 'MOZ_NO_REMOTE': '1', 02:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:39 INFO - 'NO_EM_RESTART': '1', 02:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:39 INFO - 'PWD': '/builds/slave/test', 02:20:39 INFO - 'SHELL': '/bin/bash', 02:20:39 INFO - 'SHLVL': '1', 02:20:39 INFO - 'TERM': 'linux', 02:20:39 INFO - 'TMOUT': '86400', 02:20:39 INFO - 'USER': 'cltbld', 02:20:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', 02:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:39 INFO - '_': '/tools/buildbot/bin/python'} 02:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:39 INFO - Downloading/unpacking psutil>=3.1.1 02:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:41 INFO - Installing collected packages: psutil 02:20:41 INFO - Running setup.py install for psutil 02:20:41 INFO - building 'psutil._psutil_linux' extension 02:20:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:20:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:20:42 INFO - building 'psutil._psutil_posix' extension 02:20:42 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 02:20:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:20:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:42 INFO - Successfully installed psutil 02:20:42 INFO - Cleaning up... 02:20:42 INFO - Return code: 0 02:20:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb956f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716110>, '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 0x2682230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26826c0>, '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': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', '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 02:20:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:20:42 INFO - Using env: {'DISPLAY': ':0', 02:20:42 INFO - 'HOME': '/home/cltbld', 02:20:42 INFO - 'LANG': 'en_US.UTF-8', 02:20:42 INFO - 'LANGUAGE': 'en_US:en', 02:20:42 INFO - 'LOGNAME': 'cltbld', 02:20:42 INFO - 'MAIL': '/var/mail/cltbld', 02:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:42 INFO - 'MOZ_NO_REMOTE': '1', 02:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:42 INFO - 'NO_EM_RESTART': '1', 02:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:42 INFO - 'PWD': '/builds/slave/test', 02:20:42 INFO - 'SHELL': '/bin/bash', 02:20:42 INFO - 'SHLVL': '1', 02:20:42 INFO - 'TERM': 'linux', 02:20:42 INFO - 'TMOUT': '86400', 02:20:42 INFO - 'USER': 'cltbld', 02:20:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', 02:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:42 INFO - '_': '/tools/buildbot/bin/python'} 02:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:20:44 INFO - Installing collected packages: mozsystemmonitor 02:20:44 INFO - Running setup.py install for mozsystemmonitor 02:20:44 INFO - Successfully installed mozsystemmonitor 02:20:44 INFO - Cleaning up... 02:20:44 INFO - Return code: 0 02:20:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb956f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716110>, '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 0x2682230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26826c0>, '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': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', '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 02:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:20:44 INFO - Using env: {'DISPLAY': ':0', 02:20:44 INFO - 'HOME': '/home/cltbld', 02:20:44 INFO - 'LANG': 'en_US.UTF-8', 02:20:44 INFO - 'LANGUAGE': 'en_US:en', 02:20:44 INFO - 'LOGNAME': 'cltbld', 02:20:44 INFO - 'MAIL': '/var/mail/cltbld', 02:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:44 INFO - 'MOZ_NO_REMOTE': '1', 02:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:44 INFO - 'NO_EM_RESTART': '1', 02:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:44 INFO - 'PWD': '/builds/slave/test', 02:20:44 INFO - 'SHELL': '/bin/bash', 02:20:44 INFO - 'SHLVL': '1', 02:20:44 INFO - 'TERM': 'linux', 02:20:44 INFO - 'TMOUT': '86400', 02:20:44 INFO - 'USER': 'cltbld', 02:20:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', 02:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:44 INFO - '_': '/tools/buildbot/bin/python'} 02:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:44 INFO - Downloading/unpacking jsonschema==2.5.1 02:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:20:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:46 INFO - Downloading functools32-3.2.3-2.tar.gz 02:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:20:47 INFO - warning: no files found matching '*.txt' 02:20:47 INFO - no previously-included directories found matching 'build' 02:20:47 INFO - no previously-included directories found matching 'dist' 02:20:47 INFO - no previously-included directories found matching '.git*' 02:20:47 INFO - Installing collected packages: jsonschema, functools32 02:20:47 INFO - Running setup.py install for functools32 02:20:47 INFO - warning: no files found matching '*.txt' 02:20:47 INFO - no previously-included directories found matching 'build' 02:20:47 INFO - no previously-included directories found matching 'dist' 02:20:47 INFO - no previously-included directories found matching '.git*' 02:20:47 INFO - Successfully installed jsonschema functools32 02:20:47 INFO - Cleaning up... 02:20:47 INFO - Return code: 0 02:20:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb956f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716110>, '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 0x2682230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26826c0>, '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': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', '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 02:20:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:20:47 INFO - Using env: {'DISPLAY': ':0', 02:20:47 INFO - 'HOME': '/home/cltbld', 02:20:47 INFO - 'LANG': 'en_US.UTF-8', 02:20:47 INFO - 'LANGUAGE': 'en_US:en', 02:20:47 INFO - 'LOGNAME': 'cltbld', 02:20:47 INFO - 'MAIL': '/var/mail/cltbld', 02:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:47 INFO - 'MOZ_NO_REMOTE': '1', 02:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:47 INFO - 'NO_EM_RESTART': '1', 02:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:47 INFO - 'PWD': '/builds/slave/test', 02:20:47 INFO - 'SHELL': '/bin/bash', 02:20:47 INFO - 'SHLVL': '1', 02:20:47 INFO - 'TERM': 'linux', 02:20:47 INFO - 'TMOUT': '86400', 02:20:47 INFO - 'USER': 'cltbld', 02:20:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', 02:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:47 INFO - '_': '/tools/buildbot/bin/python'} 02:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:47 INFO - Downloading/unpacking blobuploader==1.2.4 02:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:49 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:50 INFO - Downloading docopt-0.6.1.tar.gz 02:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:50 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:50 INFO - Running setup.py install for blobuploader 02:20:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:50 INFO - Running setup.py install for requests 02:20:50 INFO - Running setup.py install for docopt 02:20:50 INFO - Successfully installed blobuploader requests docopt 02:20:50 INFO - Cleaning up... 02:20:50 INFO - Return code: 0 02:20:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb956f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716110>, '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 0x2682230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26826c0>, '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': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', '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 02:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:50 INFO - Using env: {'DISPLAY': ':0', 02:20:50 INFO - 'HOME': '/home/cltbld', 02:20:50 INFO - 'LANG': 'en_US.UTF-8', 02:20:50 INFO - 'LANGUAGE': 'en_US:en', 02:20:50 INFO - 'LOGNAME': 'cltbld', 02:20:50 INFO - 'MAIL': '/var/mail/cltbld', 02:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:50 INFO - 'MOZ_NO_REMOTE': '1', 02:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:50 INFO - 'NO_EM_RESTART': '1', 02:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:50 INFO - 'PWD': '/builds/slave/test', 02:20:50 INFO - 'SHELL': '/bin/bash', 02:20:50 INFO - 'SHLVL': '1', 02:20:50 INFO - 'TERM': 'linux', 02:20:50 INFO - 'TMOUT': '86400', 02:20:50 INFO - 'USER': 'cltbld', 02:20:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', 02:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:50 INFO - '_': '/tools/buildbot/bin/python'} 02:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:50 INFO - Running setup.py (path:/tmp/pip-tOc41m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:51 INFO - Running setup.py (path:/tmp/pip-zcBu0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:51 INFO - Running setup.py (path:/tmp/pip-MHJWvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:51 INFO - Running setup.py (path:/tmp/pip-bJqdJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:51 INFO - Running setup.py (path:/tmp/pip-ZFab3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:51 INFO - Running setup.py (path:/tmp/pip-EdpOXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:51 INFO - Running setup.py (path:/tmp/pip-fIW15A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:51 INFO - Running setup.py (path:/tmp/pip-bCgdRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:51 INFO - Running setup.py (path:/tmp/pip-tWcOYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:51 INFO - Running setup.py (path:/tmp/pip-vNUVOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:51 INFO - Running setup.py (path:/tmp/pip-LFxHyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:51 INFO - Running setup.py (path:/tmp/pip-5ELq_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:51 INFO - Running setup.py (path:/tmp/pip-kHjKZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:51 INFO - Running setup.py (path:/tmp/pip-ePSzzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:51 INFO - Running setup.py (path:/tmp/pip-aF0BOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:52 INFO - Running setup.py (path:/tmp/pip-nhekYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:52 INFO - Running setup.py (path:/tmp/pip-KvjrKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:52 INFO - Running setup.py install for manifestparser 02:20:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:52 INFO - Running setup.py install for mozcrash 02:20:52 INFO - Running setup.py install for mozdebug 02:20:52 INFO - Running setup.py install for mozdevice 02:20:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:52 INFO - Running setup.py install for mozfile 02:20:52 INFO - Running setup.py install for mozhttpd 02:20:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:52 INFO - Running setup.py install for mozinfo 02:20:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:52 INFO - Running setup.py install for mozInstall 02:20:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:52 INFO - Running setup.py install for mozleak 02:20:53 INFO - Running setup.py install for mozlog 02:20:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Running setup.py install for moznetwork 02:20:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Running setup.py install for mozprocess 02:20:53 INFO - Running setup.py install for mozprofile 02:20:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Running setup.py install for mozrunner 02:20:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Running setup.py install for mozscreenshot 02:20:53 INFO - Running setup.py install for moztest 02:20:53 INFO - Running setup.py install for mozversion 02:20:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:53 INFO - Cleaning up... 02:20:53 INFO - Return code: 0 02:20:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb956f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716110>, '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 0x2682230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26826c0>, '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': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', '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 02:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:53 INFO - Using env: {'DISPLAY': ':0', 02:20:53 INFO - 'HOME': '/home/cltbld', 02:20:53 INFO - 'LANG': 'en_US.UTF-8', 02:20:53 INFO - 'LANGUAGE': 'en_US:en', 02:20:53 INFO - 'LOGNAME': 'cltbld', 02:20:53 INFO - 'MAIL': '/var/mail/cltbld', 02:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:53 INFO - 'MOZ_NO_REMOTE': '1', 02:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:53 INFO - 'NO_EM_RESTART': '1', 02:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:53 INFO - 'PWD': '/builds/slave/test', 02:20:53 INFO - 'SHELL': '/bin/bash', 02:20:53 INFO - 'SHLVL': '1', 02:20:53 INFO - 'TERM': 'linux', 02:20:53 INFO - 'TMOUT': '86400', 02:20:53 INFO - 'USER': 'cltbld', 02:20:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', 02:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:53 INFO - '_': '/tools/buildbot/bin/python'} 02:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:54 INFO - Running setup.py (path:/tmp/pip-oQCxEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:54 INFO - Running setup.py (path:/tmp/pip-mwebvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:54 INFO - Running setup.py (path:/tmp/pip-L3Um1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:54 INFO - Running setup.py (path:/tmp/pip-kDadJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:54 INFO - Running setup.py (path:/tmp/pip-lPDpZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:54 INFO - Running setup.py (path:/tmp/pip-UgVzdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:54 INFO - Running setup.py (path:/tmp/pip-EHzO9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:54 INFO - Running setup.py (path:/tmp/pip-dSnzNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:54 INFO - Running setup.py (path:/tmp/pip-2EKSbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:54 INFO - Running setup.py (path:/tmp/pip-e0HhfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:54 INFO - Running setup.py (path:/tmp/pip-hgB45n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:54 INFO - Running setup.py (path:/tmp/pip-IfhNNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:55 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)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:55 INFO - Running setup.py (path:/tmp/pip-bjVFiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:55 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)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:55 INFO - Running setup.py (path:/tmp/pip-D136KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:55 INFO - Running setup.py (path:/tmp/pip-J3Y7lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:55 INFO - Running setup.py (path:/tmp/pip-e37nPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:55 INFO - Running setup.py (path:/tmp/pip-DeBHsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:57 INFO - Downloading blessings-1.6.tar.gz 02:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:57 INFO - Installing collected packages: blessings 02:20:57 INFO - Running setup.py install for blessings 02:20:57 INFO - Successfully installed blessings 02:20:57 INFO - Cleaning up... 02:20:57 INFO - Return code: 0 02:20:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:57 INFO - Reading from file tmpfile_stdout 02:20:57 INFO - Current package versions: 02:20:57 INFO - argparse == 1.2.1 02:20:57 INFO - blessings == 1.6 02:20:57 INFO - blobuploader == 1.2.4 02:20:57 INFO - docopt == 0.6.1 02:20:57 INFO - functools32 == 3.2.3-2 02:20:57 INFO - jsonschema == 2.5.1 02:20:57 INFO - manifestparser == 1.1 02:20:57 INFO - mozInstall == 1.12 02:20:57 INFO - mozcrash == 0.17 02:20:57 INFO - mozdebug == 0.1 02:20:57 INFO - mozdevice == 0.48 02:20:57 INFO - mozfile == 1.2 02:20:57 INFO - mozhttpd == 0.7 02:20:57 INFO - mozinfo == 0.9 02:20:57 INFO - mozleak == 0.1 02:20:57 INFO - mozlog == 3.2 02:20:57 INFO - moznetwork == 0.27 02:20:57 INFO - mozprocess == 0.22 02:20:57 INFO - mozprofile == 0.28 02:20:57 INFO - mozrunner == 6.11 02:20:57 INFO - mozscreenshot == 0.1 02:20:57 INFO - mozsystemmonitor == 0.3 02:20:57 INFO - moztest == 0.7 02:20:57 INFO - mozversion == 1.4 02:20:57 INFO - psutil == 3.1.1 02:20:57 INFO - requests == 1.2.3 02:20:57 INFO - wsgiref == 0.1.2 02:20:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb956f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716110>, '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 0x2682230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26826c0>, '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': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', '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 02:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:57 INFO - Using env: {'DISPLAY': ':0', 02:20:57 INFO - 'HOME': '/home/cltbld', 02:20:57 INFO - 'LANG': 'en_US.UTF-8', 02:20:57 INFO - 'LANGUAGE': 'en_US:en', 02:20:57 INFO - 'LOGNAME': 'cltbld', 02:20:57 INFO - 'MAIL': '/var/mail/cltbld', 02:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:57 INFO - 'MOZ_NO_REMOTE': '1', 02:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:57 INFO - 'NO_EM_RESTART': '1', 02:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:57 INFO - 'PWD': '/builds/slave/test', 02:20:57 INFO - 'SHELL': '/bin/bash', 02:20:57 INFO - 'SHLVL': '1', 02:20:57 INFO - 'TERM': 'linux', 02:20:57 INFO - 'TMOUT': '86400', 02:20:57 INFO - 'USER': 'cltbld', 02:20:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', 02:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:57 INFO - '_': '/tools/buildbot/bin/python'} 02:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:20:57 INFO - Cleaning up... 02:20:57 INFO - Return code: 0 02:20:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb956f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716110>, '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 0x2682230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26826c0>, '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': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', '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 02:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:20:57 INFO - Using env: {'DISPLAY': ':0', 02:20:57 INFO - 'HOME': '/home/cltbld', 02:20:57 INFO - 'LANG': 'en_US.UTF-8', 02:20:57 INFO - 'LANGUAGE': 'en_US:en', 02:20:57 INFO - 'LOGNAME': 'cltbld', 02:20:57 INFO - 'MAIL': '/var/mail/cltbld', 02:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:57 INFO - 'MOZ_NO_REMOTE': '1', 02:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:57 INFO - 'NO_EM_RESTART': '1', 02:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:57 INFO - 'PWD': '/builds/slave/test', 02:20:57 INFO - 'SHELL': '/bin/bash', 02:20:57 INFO - 'SHLVL': '1', 02:20:57 INFO - 'TERM': 'linux', 02:20:57 INFO - 'TMOUT': '86400', 02:20:57 INFO - 'USER': 'cltbld', 02:20:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', 02:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:57 INFO - '_': '/tools/buildbot/bin/python'} 02:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:20:58 INFO - Cleaning up... 02:20:58 INFO - Return code: 0 02:20:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb956f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2716110>, '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 0x2682230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26826c0>, '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': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', '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 02:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:20:58 INFO - Using env: {'DISPLAY': ':0', 02:20:58 INFO - 'HOME': '/home/cltbld', 02:20:58 INFO - 'LANG': 'en_US.UTF-8', 02:20:58 INFO - 'LANGUAGE': 'en_US:en', 02:20:58 INFO - 'LOGNAME': 'cltbld', 02:20:58 INFO - 'MAIL': '/var/mail/cltbld', 02:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:58 INFO - 'MOZ_NO_REMOTE': '1', 02:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:58 INFO - 'NO_EM_RESTART': '1', 02:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:58 INFO - 'PWD': '/builds/slave/test', 02:20:58 INFO - 'SHELL': '/bin/bash', 02:20:58 INFO - 'SHLVL': '1', 02:20:58 INFO - 'TERM': 'linux', 02:20:58 INFO - 'TMOUT': '86400', 02:20:58 INFO - 'USER': 'cltbld', 02:20:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', 02:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:58 INFO - '_': '/tools/buildbot/bin/python'} 02:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:58 INFO - Downloading/unpacking flake8 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:21:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:21:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:21:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:21:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:21:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:21:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:21:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:21:00 INFO - no previously-included directories found matching 'docs/_build' 02:21:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:21:01 INFO - Running setup.py install for pep8 02:21:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:21:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:21:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:21:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:21:01 INFO - no previously-included directories found matching 'docs/_build' 02:21:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:21:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:21:01 INFO - Cleaning up... 02:21:01 INFO - Return code: 0 02:21:01 INFO - Running post-action listener: _resource_record_post_action 02:21:01 INFO - Running post-action listener: _start_resource_monitoring 02:21:01 INFO - Starting resource monitoring. 02:21:01 INFO - ##### 02:21:01 INFO - ##### Finished create-virtualenv step (success) 02:21:01 INFO - ##### 02:21:01 INFO - ##### 02:21:01 INFO - ##### Running install step. 02:21:01 INFO - ##### 02:21:01 INFO - Running pre-action listener: _resource_record_pre_action 02:21:01 INFO - Running main action method: install 02:21:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:01 INFO - Reading from file tmpfile_stdout 02:21:01 INFO - Detecting whether we're running mozinstall >=1.0... 02:21:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:21:01 INFO - Reading from file tmpfile_stdout 02:21:01 INFO - Output received: 02:21:01 INFO - Usage: mozinstall [options] installer 02:21:01 INFO - Options: 02:21:01 INFO - -h, --help show this help message and exit 02:21:01 INFO - -d DEST, --destination=DEST 02:21:01 INFO - Directory to install application into. [default: 02:21:01 INFO - "/builds/slave/test"] 02:21:01 INFO - --app=APP Application being installed. [default: firefox] 02:21:01 INFO - mkdir: /builds/slave/test/build/application 02:21:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:21:18 INFO - Reading from file tmpfile_stdout 02:21:18 INFO - Output received: 02:21:18 INFO - /builds/slave/test/build/application/firefox/firefox 02:21:18 INFO - Running post-action listener: _resource_record_post_action 02:21:18 INFO - ##### 02:21:18 INFO - ##### Finished install step (success) 02:21:18 INFO - ##### 02:21:18 INFO - ##### 02:21:18 INFO - ##### Running run-tests step. 02:21:18 INFO - ##### 02:21:18 INFO - Running pre-action listener: _resource_record_pre_action 02:21:18 INFO - Running main action method: run_tests 02:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:18 INFO - Python 2.7.3 02:21:18 INFO - Return code: 0 02:21:18 INFO - grabbing minidump binary from tooltool 02:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:18 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 0x2716110>, '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 0x2682230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26826c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:18 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 02:21:18 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 02:21:18 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 02:21:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:18 INFO - Return code: 0 02:21:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:21:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:21:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:21:19 INFO - Return code: 0 02:21:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 02:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 02:21:19 INFO - Using env: {'DISPLAY': ':0', 02:21:19 INFO - 'HOME': '/home/cltbld', 02:21:19 INFO - 'LANG': 'en_US.UTF-8', 02:21:19 INFO - 'LANGUAGE': 'en_US:en', 02:21:19 INFO - 'LOGNAME': 'cltbld', 02:21:19 INFO - 'MAIL': '/var/mail/cltbld', 02:21:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:19 INFO - 'MOZ_NO_REMOTE': '1', 02:21:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:19 INFO - 'NO_EM_RESTART': '1', 02:21:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:19 INFO - 'PWD': '/builds/slave/test', 02:21:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:19 INFO - 'SHELL': '/bin/bash', 02:21:19 INFO - 'SHLVL': '1', 02:21:19 INFO - 'TERM': 'linux', 02:21:19 INFO - 'TMOUT': '86400', 02:21:19 INFO - 'USER': 'cltbld', 02:21:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1466238857.328536-734563074', 02:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:19 INFO - '_': '/tools/buildbot/bin/python'} 02:21:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 02:21:19 INFO - mozversion application_buildid: 20160617233003 02:21:19 INFO - mozversion application_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 02:21:19 INFO - mozversion application_display_name: Nightly 02:21:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:19 INFO - mozversion application_name: Firefox 02:21:19 INFO - mozversion application_remotingname: firefox 02:21:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:21:19 INFO - mozversion application_vendor: Mozilla 02:21:19 INFO - mozversion application_version: 50.0a1 02:21:19 INFO - mozversion platform_buildid: 20160617233003 02:21:19 INFO - mozversion platform_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 02:21:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:21:19 INFO - mozversion platform_version: 50.0a1 02:21:19 INFO - using testdate: 1466241679 02:21:19 INFO - actual date: 1466241679 02:21:19 INFO - starting webserver on 'localhost:60408' 02:21:19 INFO - SUITE-START | Running 2 tests 02:21:19 INFO - TEST-START | dromaeo_css 02:21:19 INFO - operating with platform_type : linux_ 02:21:19 INFO - Initialising browser for dromaeo_css test... 02:21:19 INFO - TEST-INFO | started process 12428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkq6uKv/profile http://localhost:60408/getInfo.html) 02:21:24 INFO - PROCESS | 12428 | __metrics Screen width/height:1600/1200 02:21:24 INFO - PROCESS | 12428 | colorDepth:24 02:21:24 INFO - PROCESS | 12428 | Browser inner width/height: 1024/697 02:21:24 INFO - PROCESS | 12428 | __metrics 02:21:24 ERROR - PROCESS | 12428 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:21:25 INFO - TEST-INFO | 12428: exit 0 02:21:25 INFO - Browser initialized. 02:21:25 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:25 INFO - TEST-INFO | started process 12546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkq6uKv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:37 INFO - PROCESS | 12546 | RSS: Main: 184803328 02:21:37 INFO - PROCESS | 12546 | 02:22:27 INFO - PROCESS | 12546 | 1466241747266 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] 02:24:35 INFO - PROCESS | 12546 | Cycle 1(1): loaded http://localhost:60408/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60408/tests/dromaeo/cssquery-ext.html) 02:24:36 INFO - PROCESS | 12546 | RSS: Main: 189251584 02:24:36 INFO - PROCESS | 12546 | 02:27:38 INFO - PROCESS | 12546 | Cycle 1(1): loaded http://localhost:60408/tests/dromaeo/cssquery-ext.html (next: http://localhost:60408/tests/dromaeo/cssquery-jquery.html) 02:27:38 INFO - PROCESS | 12546 | RSS: Main: 187772928 02:27:38 INFO - PROCESS | 12546 | 02:30:40 INFO - PROCESS | 12546 | Cycle 1(1): loaded http://localhost:60408/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60408/tests/dromaeo/cssquery-mootools.html) 02:30:41 INFO - PROCESS | 12546 | RSS: Main: 188919808 02:30:41 INFO - PROCESS | 12546 | 02:33:43 INFO - PROCESS | 12546 | Cycle 1(1): loaded http://localhost:60408/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60408/tests/dromaeo/cssquery-prototype.html) 02:33:43 INFO - PROCESS | 12546 | RSS: Main: 186773504 02:33:43 INFO - PROCESS | 12546 | 02:36:46 INFO - PROCESS | 12546 | Cycle 1(1): loaded http://localhost:60408/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60408/tests/dromaeo/cssquery-yui.html) 02:36:46 INFO - PROCESS | 12546 | RSS: Main: 188682240 02:36:46 INFO - PROCESS | 12546 | 02:39:49 INFO - PROCESS | 12546 | Cycle 1(1): loaded http://localhost:60408/tests/dromaeo/cssquery-yui.html (next: http://localhost:60408/tests/dromaeo/cssquery-dojo.html) 02:39:49 INFO - PROCESS | 12546 | RSS: Main: 189460480 02:39:49 INFO - PROCESS | 12546 | 02:39:49 INFO - PROCESS | 12546 | __start_tp_report 02:39:49 INFO - PROCESS | 12546 | _x_x_mozilla_page_load 02:39:49 INFO - PROCESS | 12546 | _x_x_mozilla_page_load_details 02:39:49 INFO - PROCESS | 12546 | |i|pagename|runs| 02:39:49 INFO - PROCESS | 12546 | |0;dojo.html;3118.5945827042483;3136.168915237461;3172.5558421820942;3172.6668699786537;3176.698213669702;5451.291332126823;5520.5307548858345;5523.337199536057;5551.417101204366;5574.358948720898;5438.211459338394;5505.284313039309;5555.611107222486;5574.581906357029;5609;5093.847184584469;5111.821086261982;5157.948420515784;5191.844244672666;5193.195054766517;509.9839799271053;5108.693478391308;5162.070827251112;5172.948270517303;5193.246979188016;5101.387833459971;5106.4382917879;5111.284420181178;5115.795368185268;5119.129747942859;4984.476629953839;5112.693238405707;5120;5120.02719483297;5148.588112950955;5003.54968052877;5064.620153488466;5095.312132862054;5099.311592934943;5102.668326558799;5575.330960284792;5582.553395728332;5614.691191984439;5626.606137570372;5639.492445679867;5727.31272247333;5880.26496687914;5992.700364981733;6016.909746353808;6058.787942421994;5977.970110149465;6073.878522429527;6086;6096.390360963913;6110.114033465123;5593.664380137205;5600.4959553639965;5605.635633683797;5606.467385598362;5607.943920560824;5950.851228719317;6067.787627433018;6074.75700971965;6154.969225153935;6167.660778657217;5860.560457965669;5907.793227237026;5908.615939963888;5928.851778705567;5948.762049518057;6024.789132380346;6030.7286172121485;6030.939690603038;6034.034554471351;6036.943534881379;5734.942650573441;5774.3070831499645;5814.476697097281;5840.678762668009;5908.763649454059;5715.799947001835;5825.155352473952;5862.443067908542;5867.354590994987;5889.528837692974;4509.842155524607;4510.413646225969;4520.59314661682;4530.365748795171;4548.818047278138;3946.723729338919;3954.5452272988973;3976.58245884178;4000.439938408625;4011.659008984269;5652.321721393377;5688.345840228427;5690.886182276331;5691.573132015033;5692.37383887772;5878.735456904449;5945.10823376497;5950.702464876739;5956.255468066492;5958.851028724316;5511.834644960658;5646.350669672958;5691.544676425876;5709.714514274353;5719.628224165416;4820.662553621283;4835.178019736653;4838.806447742121;4861.100696371112;4868.050730107595;6016.548758843104;6223.875522489616;6243.25080990275;6248.812535623939;6251.12484252205;5888.9705551472825;5912.881742365214;5935.080062590306;6002.339742628395;6022.969885150546;6171.228596425447;6172.166757487682;6174.073888916699;6179.227596550431;6182.907256391068;5715.742791574306;5759.94240057594;5852.619579727304;5854.385289544536;5861.062230043172;5915.852103697442;5974.492168165754;5984.1323008164445;5993.220881285405;6041.486473649789;5731.512821410227;5758.942410576008;5798.768049277982;5808.30300363959;5818.44724751148;5651.15232715096;5729.914051289317;5731.656100633975;5738.598298119258;5742.368339482737;5560.304961879765;5672.659640421588;5683.545316374597;5699.914501282401;5821.912671310019;5775.624584402;5800.1299805029585;5826.912596311144;5852.239208902815;5870.618409803349;5634.549236061187;5640.182173584725;5697.059985102412;5716.28546431696;5742.712864356682 02:39:49 INFO - PROCESS | 12546 | |1;ext.html;592.8073376152748;619.8047615001275;627.4980015987209;644.7195469970561;654.3064351787103;39964.200715985666;41121.3831792523;41203.79398103009;44603.33095003577;45173;42351.36472952901;42778;42928.57071429285;42932.78533607328;42934.785326073325;8789.428687135332;8905.421147625384;8952;8989.056149104315;9021.097890210993;8762.518061506615;8824.117588241157;8860.158284962918;8864.512451815148;8903.24322432594;8893.021767605558;8974.326925480582;8991.550422478882;8999.41503802254;9006.504642244674;8875.644974201025;8914.286857051453;8947.686830960918;8962.238209752179;8996.550172491414;8815.382923195379;8856.645734170625;8902.688405905827;8917.464952102895;8952.104789520996;41045.794771025954;41334.1733165338;41390.1721965562;41446.1710765783;41622.167556649;3454.9654503455145;3460.688538031564;3542.2030043240065;3549.8402571884326;4029.37544680575;30092.8495357524;30230.395392092036;30407.23981900448;33532.49701254483;33564.664353356646;4219.22423287965;4274.706336786657;4314.395984562164;4343.305071188626;4345.652347812167;353886;354289;355433;355498;356376.2181189103;57521;57635.71182144062;57766;58073.41926580764;58340.708296458244;34204.65795342065;61055.38944610586;61244.38755612476;61366.69316653388;61727.38272617216;13468.39392227352;14036;14082.929585352007;14106.85893141076;14145.646358840906;9788.363756355957;9796.069373409515;9852.408855468695;9892.406455612543;9893.911669716326;18696.158672859754;18742.25030998745;18759.499240060763;18807.90596047011;18869.528261793566;6984.301569843076;7105.751298704624;7263.4915555910575;7305.525140865933;7317.780466586011;969.7914948286152;1086.413336798136;1096.5887792077972;1101.8347247912877;1120.7086157599083;31840.363192736015;31907.52138717921;32030;32280.838595806872;32349.51475727866;1064.43052966664;1092.7432053467428;1099.2689861242184;1151.1366475143643;1215.2283300104498;16297.429589964295;16648.25082871274;16668.902036173276;16700;16793.244304006348;555341;557316;560729;561327;565068;55564.72217638886;55681.16478252829;56190.15714764282;56199.438005620235;56400.43599564034;1331.5605850069453;1331.7203387288585;1333.5863984176804;1337.4516448256168;1354.1198221156328;29127.85436072891;30501.694983049885;30827.552105964383;30965.380692386476;31176;47489.28766068443;47821;48074.5192548084;48147.75926120487;48226.75886620545;421236.57526849903;427778;429272;431215;435081;27210.863945680147;27440.725592743816;27634.170974870787;27679.44641107207;27750.306242344104;46673.766631167986;46945.765271173426;47142.52857471519;48005.75997120132;48040.75979620079;40396.19207615773;40723.59276407198;40767.1846563073;40827;41780.3732944;39237.80381098076;39848.80075599603;40007.19985600213;40055.39916901307;40284;34427;38220.42669360017;38684.80657596694;38713.22573548457;39800;35082.82458587691;35965.82017089898;36689.81655091707;36821.26357472889;37201;27120.32199195036;27214;27498.862505687342;27611.447771044066;27832.721672783824 02:39:49 INFO - PROCESS | 12546 | |2;jquery.html;379.3191221756947;379.62986088563673;382.44927304681255;393.8778978516658;401.25166564357465;17580.824191758078;19190.232390704354;19306.806931930692;19856.60286794263;20024;18499.0750462477;18511.537211569685;18668.895788551883;18883.150258238376;19187.712184317246;5584.748686309115;5694.487496125348;5791.015527360338;5801.390853960336;5806.738696758634;5667.688277144755;5669.121286200625;5688.4311568843195;5698.715064246791;5703.942960570404;5404.756785944642;5550;5596.132599447072;5620.9437905620825;5754.625949313302;5787.797427090074;5789.04480760674;5799.507041901444;5863.149843272723;5868.03177475716;5679.488846003838;5796.739146738365;5813.302403711539;5839.503642190419;5842.386549412293;13417.530386436429;13882.722345553033;22770.886145569333;22780.430489237737;22846.31461056171;2053.9281125160546;2280.737715162761;2382.809375249993;2459.557279689655;2649.2582077018465;9869.703908882744;10144.239182061301;10613.57545698171;11735.765284694344;14239.928800355932;1912.3402426162952;1937.9438206177667;1941.980580194194;1966.567355181872;1977.5649357141406;65467.67266163686;69318.99999999949;71601.64199179022;78864.10582346872;81895.5905220476;10241.48792560369;10385.169186465064;10664.187088195025;10795.676129716121;10928.142215823329;14740.968132230855;14805.481808136663;14806.555803325917;14808.259587020606;14835.777463338058;7153.248908864494;7187.640617969185;7229.09636295463;7302.926970730331;7352.264773522605;6594.769183078569;6627.701753421107;6931.514793964374;7035.683394247271;7238.52949558277;4384.714993525475;4568.2690769477385;4590.563896429834;4608.308753686907;4721.961168542915;1889.263187356932;1923.3652894544766;1937.8159074887863;1943.504406376365;1999.5600967787063;806.2703253555542;908.1871724806261;931.4830269200523;941.3222479814523;959.5490119643756;18764.437066888015;18907.338243161423;19102.617947641247;19289.421317360502;19567.41297761041;939.492673956056;952.6713283917038;1024.800163968034;1027.0807627173638;1050.4537640426936;10459.424731639832;10822.458877056273;10839.512221950032;10850.348979061282;10894.346339219672;452098;454099;467379;469031;478900;60128.39871601228;62156.06765898515;79697.20302797014;97084;97430.51284743672;981.3179840011267;1001.1290177545582;1008.0725732326277;1040.0275742181084;1040.8542804007445;17420.216090275713;17428.651426971643;17932.731009034615;18155.546111346794;18177.636447270717;42313;43010.56989430191;43085.78457107695;43091.56908430876;45453.09093818171;58612.41387586069;59761.40238597558;60199.09701354571;60689.69655151696;60767.08849367175;8208.958955205186;8382;8467;8585.82828343442;8651.48091114535;12205.328706921204;12500.687482813002;12729.363531823186;13301.401436935168;13499.932500337436;11751.47118379692;11764.117691173025;11971.521139154336;12216.511339546318;12315.44580493862;11927.522899083939;11964.282143071443;12027.639170824888;12155.331456769962;12210.57262995791;11903.523859045541;12009;12075.818862716891;12167.391630418266;12476.750464990831;7346.77959661211;8418.284445822173;8488.363372746946;8581.914180858112;8667.393282470166;11479.713007174887;11550.537978480766;11592.188546801643;11882.16824822254;12153.45309461094 02:39:49 INFO - PROCESS | 12546 | |3;mootools.html;1439.712057588482;1465.033078168409;1582.200988500807;1713.1519897650664;1724.56023713953;8084.2724154826055;8243.381746369016;8712.520811355382;8739.388242822997;8846.867296990551;9167.633294668205;9207.217386522154;9211.263098952084;9263.212626926703;9296.488693121875;2359.4219416243;2392.820538459614;2403.51929614077;2407.711074671033;2414.2515820095737;2304.573653874039;2326.4416540030356;2356.8350215484925;2375.3467796355967;2383.7616238376195;2344.906203751848;2355.387599224197;2357.3635118518077;2374.430136767172;2376.9762302376926;2361.988190059056;2367.4318163640773;2372.0867466025534;2375.3111597636666;2382.60686986647;2320.9419764505856;2323.8489498182735;2338.018032426385;2339.7894189523026;2339.988300058506;9242.983271840092;9287.024862389419;9316.602509623543;9349.39228950123;9355.532223388804;5379.5696344292755;5470.425605311425;5502.284702988586;5509.5041446270025;5558.194061861048;3432.8798492052906;3441.346144232588;3553.218291975761;3567.126054116732;3601.8199090045655;1176.4882276209876;1195.940202989847;1198.2211562484367;1224.4428784902937;1225.2709637765515;13121.14712543672;13137.474501019948;13156.144850584777;13173.934130329382;13192.934035329858;4760.500147484534;4836.879078023007;4952.727599981963;4969.105560999054;4993.176125939252;10712.125378058809;10796.136309095253;10803.081738052197;10860.511276992554;10890.455477226107;5432.130859062531;5460.372057213392;5487.780488780484;5501.202325662756;5526.696031718294;4432.977835110803;4798.640101992364;4878.463369029475;4958.727270000112;4962.20604703253;3937.8031098444962;3979.6816254699556;4075.89810254746;4113;4132.566080561498;1289.8903593194684;1298.4935875008755;1308.6662900960193;1311.4819646239682;1317.038561849855;950.7100334398075;954.6038394066524;974.0794948773341;974.5030034682363;980.9215262778961;6093;6152.138700581832;6221.906671399933;6239.625622462667;6320.968395157995;476.04552871493127;476.49491538968806;485.5363128212619;485.8323878261994;488.2675986020969;4184.811683474251;4237.597428244373;4300.4839419269265;4306.5262821089655;4361.12777444506;11221.158413119048;11525.481353338952;11575.13186511015;11664.6500604982;11689.707757305965;11423.657290281304;11435;11475.77048459026;11479.770404591862;11483.081353491702;8138.755837324889;8462.746117616482;8489.193526614961;8669.08974557675;8694.565271736514;6110.969445152746;6272.435480806749;6290.968545157428;6319.715612797527;6370.574676019779;10405.115565177044;10633.468326583485;10692.14462842955;10784.406857622906;10886.836697449702;10581.894181058398;10704.411257380918;10814.56741730322;10833.458327083772;10866.96763807437;7617.428692847948;8014.639341229776;8067.354611631173;8326.83346333082;8372.07907130203;9224.631014759334;9234.261259099121;9260.722178334661;9263.305252105984;9316.767080823034;7988.760337189894;8269.09040005587;8269.131741167092;8290.87563686533;8334.79163020905;7828.491148075357;8080;8090.150534193825;8260.339172866035;8281.17188281167;6816.147981502312;6994.705979393829;7346.742863999734;7432.479726419098;7435.256474352522;5199.428062913152;5239.187925871496;5246.501582349671;5272.420033796356;5292.073887069824;5175.534201921845;5199.76601052946;5210.765515551885;5247.08176069194;5291.894162116659 02:39:49 INFO - PROCESS | 12546 | |4;prototype.html;329.5402912936452;331.06639277238185;337.46174851112477;339.4958486647328;343.95012723155156;5456.208849716789;5579.2746942897365;5592;5666.37669856316;5709.286339207599;5479.780808767645;5588.21764952907;5615.831525054245;5619.297587801525;5641.717914104289;4324.156789426071;4350.456192975878;4356.89107772305;4359.934600980988;4401.581849724287;4137.54487006429;4366.345048242757;4371.562843715619;4388.824447022115;4393.275109606911;4301.354796780477;4310.892227694317;4317;4326.30779075348;4334.956650433503;4340.110277393127;4340.848070317524;4341.327094300388;4343.218220720253;4349.630281426083;3760.3419401604883;3777.6411240932066;3804.144067584799;3810.8285127169343;3827.98558382029;5456.372517160537;5472.878059997691;5482.095454250044;5493.670379777226;5500.697461639608;4881.755152436106;4912;4944.480829512885;4947.406311242638;4960.70235785854;5718.199452076713;5759.078547432391;5879;5892.852678683024;5904.3762965184915;4106.630403263691;4134.235166494208;4134.689898257643;4158.480189976253;4171.10321280923;6083.17877086592;6108.175396321529;6136.9079463808075;6147.385261473817;6159.599626024339;4106.691998100095;4240.385144154142;4263.360495925636;4271.786410679453;4283.2932566126865;4276.2796367160145;4280.143971205771;4294.0767734937135;4301.247281725686;4308.771999980053;4867.0995865764235;4896.975515122402;4945.307656928033;4962.652614317035;4969.577585905238;5747.655140691572;5892.616979896293;5896.027155519291;5908.20239267702;5950.404959504015;1455.3378212913099;1471.5805995291291;1480.1341215388902;1485.376142020354;1486.8661820436212;916.3516907841282;923.7829110159107;926.813678491532;927.7680579855037;947.488356287597;5003.24951257307;5010.897602527438;5064.594832413398;5084.923726144111;5132;5336.759845806948;5408.810061786479;5418.214358918013;5461.399246082928;5465.836024919259;4900.26496025599;4949.970512090026;5063.594912406998;5160.8967820643375;5173.292813371579;2806.4106537627326;2828.618136551539;2879.8992035278666;2905.7965942384253;2936.588877557144;5486.91769623456;5517.337919449611;5535.474129957647;5547.694876781735;5574.554035677136;5435.347758269033;5685.260916080966;6273.368924079772;6299.401556852092;6302.558820882586;6308.337624549448;6332.398422149889;6338.58799178052;6362.586431881913;6362.713677884506;6022.909656355246;6127.264728232462;6140.631562106288;6164.229471316085;6202.56582039271;6057.121717350871;6080.635161890301;6086.786962456293;6089.147519347206;6104.4505994460715;5716.485516303553;6362.904556431565;6378.2346118466085;6378.330275321025;6390.64851433157;4229.915401691887;4262.211490874198;4268.637165840814;4281.571842815818;4281.60847724497;6076.240469941257;6122.295935967242;6129.387061293835;6130.846728831636;6179.907301390573;5757.65454072757;5869.207656966255;5902.350741418526;5916.308079823756;5946.286445626552;5820.854478638068;5822.650640961556;5896.498797602252;5926.459120628581;5939.46544810969;5756.352078044147;5784.884302314014;5787.55311172207;5798.855028624318;5814.5639077068545;5642.915356269741;5942.603488180188;5956.106584012433;5989.8203053908455;5998.25021872266;5794.82615521535;5796.449337313117;5811.970940145272;5818.6217895836635;5850.502707269759 02:39:49 INFO - PROCESS | 12546 | |5;yui.html;715.817466546031;759.5063208914205;761.9085709714835;768.0974854545909;779.170183754302;13726;14503.202323872183;14707.411703531872;14806.629834254149;14861.108333499997;13268.734625307488;13294.135881167742;13384.464621415133;13397.866021339783;13411.262380569065;638.6200210874522;755.6788364944904;763.1262204775529;763.4121726270769;770.0374531835206;742.5730205132044;768.827013921866;771.4484143837155;772.5982489105662;775.6393277126135;817.3461231015194;818.758466252457;823.6787652815377;827.3629305434841;827.8054657155564;816.5019338203691;816.5876232502578;818.0633175014575;819.1030821250721;819.2462934100641;597.7310210405292;598.3089531590975;598.6318414175295;599.0714392691311;599.8260504453704;13790.65523361914;13856.93071534646;13878.306084695725;13938.58184254474;13943.721125577533;13851.445942162301;14130;14171.362288697033;14178.787318190236;14265.215413152273;11536.307821530734;11572.826407603892;11717;11807.173497855154;11859.58491452795;3234.126785767853;3282.4091663500562;3366.0575038989123;3430.433978393587;3436.2096717754807;75240.24759752388;75698.62150689267;75975.62012189903;76219.61890190514;77945;10666.679999600025;10900.618478353379;10918.12654987615;11026.062784663232;11460.828087578693;17801.198946047458;20232.89883550573;20239.8988005062;20294.086766095563;20304.39086827368;7794.3764498839955;7957.7612671619945;8113.229243221885;8295.958520207481;8318.87872081652;4540.977295113504;4603;4719.4100737407825;4733.479317275097;4772.164871147535;3570.535830342039;3581.158427769472;3592.084018575247;3592.892213233607;3597.6941959933697;647.1910112359551;662.5097427903316;667.6027763480721;670.4502308107305;689.7344522358827;664.6909187227963;701.4143190435941;702.8734827730955;709.8118998465411;711.7900219435176;9092.181703646704;9114.817703646022;9170.174684278447;9287.257019438428;9461.101195386427;568.57502750768;589.6285340235625;679.9864002719918;686.1080595226186;710.7974227345285;4363.498197707241;4485.887852803641;4497.955020449754;4514.32285157229;4577.725336479755;109880.4505977465;110817;111633;113653;114728;57546.424535754944;92772.53613731888;93657;93825.5308723452;94244.52877735568;55183.72408138014;82619;84114.57942710248;86198;86300.56849715712;8382.207118547807;8472.576371181292;8522.147785221676;8525.573721314033;8687.174718401742;51154.74422627863;52252.47747522476;52783.736081319345;53040.73479632577;54408.45591544034;72504.63747681228;73200.26799731934;73630.84172540474;75443.62278188574;75495.62252188704;9720.562574684014;9995.450250236307;10003.2997690161;10079.647212347532;11884.881151188378;13149.474021039434;13858.237796921267;13862.168269903837;13878.167309961435;13913.58259252224;12336.3215023171;13006.739865202453;13202.075854690464;13510.189388636712;13673;12436.375975568606;12844.614661560168;13088.214707117604;13202.603921882359;13223.140495867738;12421.627351179479;12588.181768185039;12995.415206315549;13123.671908202372;13248.933755331162;9628.951855240679;10051.296409251283;10096.69709908704;10119.683958769425;10129.346883009572;10400.219983501116;10841.850698141963;10851.45742712877;10936.726581835517;10966.396848173426 02:39:49 INFO - PROCESS | 12546 | __end_tp_report 02:39:49 INFO - PROCESS | 12546 | __start_cc_report 02:39:49 INFO - PROCESS | 12546 | _x_x_mozilla_cycle_collect,341 02:39:49 INFO - PROCESS | 12546 | __end_cc_report 02:39:49 INFO - PROCESS | 12546 | __startTimestamp1466242789618__endTimestamp 02:39:49 INFO - PROCESS | 12546 | 02:39:49 INFO - PROCESS | 12546 | ------- Summary: start ------- 02:39:49 INFO - PROCESS | 12546 | Number of tests: 6 02:39:49 INFO - PROCESS | 12546 | 02:39:49 INFO - PROCESS | 12546 | [#0] dojo.html Cycles:165 Average:5491.01 Median:5715.74 stddev:751.65 (13.2%) stddev-sans-first:730.55 02:39:49 INFO - PROCESS | 12546 | Values: 3118.6 3136.2 3172.6 3172.7 3176.7 5451.3 5520.5 5523.3 5551.4 5574.4 5438.2 5505.3 5555.6 5574.6 5609.0 5093.8 5111.8 5157.9 5191.8 5193.2 510.0 5108.7 5162.1 5172.9 5193.2 5101.4 5106.4 5111.3 5115.8 5119.1 4984.5 5112.7 5120.0 5120.0 5148.6 5003.5 5064.6 5095.3 5099.3 5102.7 5575.3 5582.6 5614.7 5626.6 5639.5 5727.3 5880.3 5992.7 6016.9 6058.8 5978.0 6073.9 6086.0 6096.4 6110.1 5593.7 5600.5 5605.6 5606.5 5607.9 5950.9 6067.8 6074.8 6155.0 6167.7 5860.6 5907.8 5908.6 5928.9 5948.8 6024.8 6030.7 6030.9 6034.0 6036.9 5734.9 5774.3 5814.5 5840.7 5908.8 5715.8 5825.2 5862.4 5867.4 5889.5 4509.8 4510.4 4520.6 4530.4 4548.8 3946.7 3954.5 3976.6 4000.4 4011.7 5652.3 5688.3 5690.9 5691.6 5692.4 5878.7 5945.1 5950.7 5956.3 5958.9 5511.8 5646.4 5691.5 5709.7 5719.6 4820.7 4835.2 4838.8 4861.1 4868.1 6016.5 6223.9 6243.3 6248.8 6251.1 5889.0 5912.9 5935.1 6002.3 6023.0 6171.2 6172.2 6174.1 6179.2 6182.9 5715.7 5759.9 5852.6 5854.4 5861.1 5915.9 5974.5 5984.1 5993.2 6041.5 5731.5 5758.9 5798.8 5808.3 5818.4 5651.2 5729.9 5731.7 5738.6 5742.4 5560.3 5672.7 5683.5 5699.9 5821.9 5775.6 5800.1 5826.9 5852.2 5870.6 5634.5 5640.2 5697.1 5716.3 5742.7 02:39:49 INFO - PROCESS | 12546 | 02:39:49 INFO - PROCESS | 12546 | [#1] ext.html Cycles:180 Average:60082.42 Median:41534.17 stddev:121123.60 (291.6%) stddev-sans-first:121381.03 02:39:49 INFO - PROCESS | 12546 | Values: 592.8 619.8 627.5 644.7 654.3 39964.2 41121.4 41203.8 44603.3 45173.0 42351.4 42778.0 42928.6 42932.8 42934.8 8789.4 8905.4 8952.0 8989.1 9021.1 8762.5 8824.1 8860.2 8864.5 8903.2 8893.0 8974.3 8991.6 8999.4 9006.5 8875.6 8914.3 8947.7 8962.2 8996.6 8815.4 8856.6 8902.7 8917.5 8952.1 41045.8 41334.2 41390.2 41446.2 41622.2 3455.0 3460.7 3542.2 3549.8 4029.4 30092.8 30230.4 30407.2 33532.5 33564.7 4219.2 4274.7 4314.4 4343.3 4345.7 353886.0 354289.0 355433.0 355498.0 356376.2 57521.0 57635.7 57766.0 58073.4 58340.7 34204.7 61055.4 61244.4 61366.7 61727.4 13468.4 14036.0 14082.9 14106.9 14145.6 9788.4 9796.1 9852.4 9892.4 9893.9 18696.2 18742.3 18759.5 18807.9 18869.5 6984.3 7105.8 7263.5 7305.5 7317.8 969.8 1086.4 1096.6 1101.8 1120.7 31840.4 31907.5 32030.0 32280.8 32349.5 1064.4 1092.7 1099.3 1151.1 1215.2 16297.4 16648.3 16668.9 16700.0 16793.2 555341.0 557316.0 560729.0 561327.0 565068.0 55564.7 55681.2 56190.2 56199.4 56400.4 1331.6 1331.7 1333.6 1337.5 1354.1 29127.9 30501.7 30827.6 30965.4 31176.0 47489.3 47821.0 48074.5 48147.8 48226.8 421236.6 427778.0 429272.0 431215.0 435081.0 27210.9 27440.7 27634.2 27679.4 27750.3 46673.8 46945.8 47142.5 48005.8 48040.8 40396.2 40723.6 40767.2 40827.0 41780.4 39237.8 39848.8 40007.2 40055.4 40284.0 34427.0 38220.4 38684.8 38713.2 39800.0 35082.8 35965.8 36689.8 36821.3 37201.0 27120.3 27214.0 27498.9 27611.4 27832.7 02:39:49 INFO - PROCESS | 12546 | 02:39:49 INFO - PROCESS | 12546 | [#2] jquery.html Cycles:180 Average:27676.90 Median:1514.29 stddev:76427.42 (5047.1%) stddev-sans-first:76614.34 02:39:49 INFO - PROCESS | 12546 | Values: 379.3 379.6 382.4 393.9 401.3 17580.8 19190.2 19306.8 19856.6 20024.0 18499.1 18511.5 18668.9 18883.2 19187.7 5584.7 5694.5 5791.0 5801.4 5806.7 5667.7 5669.1 5688.4 5698.7 5703.9 5404.8 5550.0 5596.1 5620.9 5754.6 5787.8 5789.0 5799.5 5863.1 5868.0 5679.5 5796.7 5813.3 5839.5 5842.4 13417.5 13882.7 22770.9 22780.4 22846.3 2053.9 2280.7 2382.8 2459.6 2649.3 9869.7 10144.2 10613.6 11735.8 14239.9 1912.3 1937.9 1942.0 1966.6 1977.6 65467.7 69319.0 71601.6 78864.1 81895.6 10241.5 10385.2 10664.2 10795.7 10928.1 14741.0 14805.5 14806.6 14808.3 14835.8 7153.2 7187.6 7229.1 7302.9 7352.3 6594.8 6627.7 6931.5 7035.7 7238.5 4384.7 4568.3 4590.6 4608.3 4722.0 1889.3 1923.4 1937.8 1943.5 1999.6 806.3 908.2 931.5 941.3 959.5 18764.4 18907.3 19102.6 19289.4 19567.4 939.5 952.7 1024.8 1027.1 1050.5 10459.4 10822.5 10839.5 10850.3 10894.3 452098.0 454099.0 467379.0 469031.0 478900.0 60128.4 62156.1 79697.2 97084.0 97430.5 981.3 1001.1 1008.1 1040.0 1040.9 17420.2 17428.7 17932.7 18155.5 18177.6 42313.0 43010.6 43085.8 43091.6 45453.1 58612.4 59761.4 60199.1 60689.7 60767.1 8209.0 8382.0 8467.0 8585.8 8651.5 12205.3 12500.7 12729.4 13301.4 13499.9 11751.5 11764.1 11971.5 12216.5 12315.4 11927.5 11964.3 12027.6 12155.3 12210.6 11903.5 12009.0 12075.8 12167.4 12476.8 7346.8 8418.3 8488.4 8581.9 8667.4 11479.7 11550.5 11592.2 11882.2 12153.5 02:39:49 INFO - PROCESS | 12546 | 02:39:49 INFO - PROCESS | 12546 | [#3] mootools.html Cycles:180 Average:6046.40 Median:2661.21 stddev:3519.44 (132.2%) stddev-sans-first:3512.28 02:39:49 INFO - PROCESS | 12546 | Values: 1439.7 1465.0 1582.2 1713.2 1724.6 8084.3 8243.4 8712.5 8739.4 8846.9 9167.6 9207.2 9211.3 9263.2 9296.5 2359.4 2392.8 2403.5 2407.7 2414.3 2304.6 2326.4 2356.8 2375.3 2383.8 2344.9 2355.4 2357.4 2374.4 2377.0 2362.0 2367.4 2372.1 2375.3 2382.6 2320.9 2323.8 2338.0 2339.8 2340.0 9243.0 9287.0 9316.6 9349.4 9355.5 5379.6 5470.4 5502.3 5509.5 5558.2 3432.9 3441.3 3553.2 3567.1 3601.8 1176.5 1195.9 1198.2 1224.4 1225.3 13121.1 13137.5 13156.1 13173.9 13192.9 4760.5 4836.9 4952.7 4969.1 4993.2 10712.1 10796.1 10803.1 10860.5 10890.5 5432.1 5460.4 5487.8 5501.2 5526.7 4433.0 4798.6 4878.5 4958.7 4962.2 3937.8 3979.7 4075.9 4113.0 4132.6 1289.9 1298.5 1308.7 1311.5 1317.0 950.7 954.6 974.1 974.5 980.9 6093.0 6152.1 6221.9 6239.6 6321.0 476.0 476.5 485.5 485.8 488.3 4184.8 4237.6 4300.5 4306.5 4361.1 11221.2 11525.5 11575.1 11664.7 11689.7 11423.7 11435.0 11475.8 11479.8 11483.1 8138.8 8462.7 8489.2 8669.1 8694.6 6111.0 6272.4 6291.0 6319.7 6370.6 10405.1 10633.5 10692.1 10784.4 10886.8 10581.9 10704.4 10814.6 10833.5 10867.0 7617.4 8014.6 8067.4 8326.8 8372.1 9224.6 9234.3 9260.7 9263.3 9316.8 7988.8 8269.1 8269.1 8290.9 8334.8 7828.5 8080.0 8090.2 8260.3 8281.2 6816.1 6994.7 7346.7 7432.5 7435.3 5199.4 5239.2 5246.5 5272.4 5292.1 5175.5 5199.8 5210.8 5247.1 5291.9 02:39:49 INFO - PROCESS | 12546 | 02:39:49 INFO - PROCESS | 12546 | [#4] prototype.html Cycles:180 Average:4869.77 Median:5484.51 stddev:1460.93 (26.6%) stddev-sans-first:1424.73 02:39:49 INFO - PROCESS | 12546 | Values: 329.5 331.1 337.5 339.5 344.0 5456.2 5579.3 5592.0 5666.4 5709.3 5479.8 5588.2 5615.8 5619.3 5641.7 4324.2 4350.5 4356.9 4359.9 4401.6 4137.5 4366.3 4371.6 4388.8 4393.3 4301.4 4310.9 4317.0 4326.3 4335.0 4340.1 4340.8 4341.3 4343.2 4349.6 3760.3 3777.6 3804.1 3810.8 3828.0 5456.4 5472.9 5482.1 5493.7 5500.7 4881.8 4912.0 4944.5 4947.4 4960.7 5718.2 5759.1 5879.0 5892.9 5904.4 4106.6 4134.2 4134.7 4158.5 4171.1 6083.2 6108.2 6136.9 6147.4 6159.6 4106.7 4240.4 4263.4 4271.8 4283.3 4276.3 4280.1 4294.1 4301.2 4308.8 4867.1 4897.0 4945.3 4962.7 4969.6 5747.7 5892.6 5896.0 5908.2 5950.4 1455.3 1471.6 1480.1 1485.4 1486.9 916.4 923.8 926.8 927.8 947.5 5003.2 5010.9 5064.6 5084.9 5132.0 5336.8 5408.8 5418.2 5461.4 5465.8 4900.3 4950.0 5063.6 5160.9 5173.3 2806.4 2828.6 2879.9 2905.8 2936.6 5486.9 5517.3 5535.5 5547.7 5574.6 5435.3 5685.3 6273.4 6299.4 6302.6 6308.3 6332.4 6338.6 6362.6 6362.7 6022.9 6127.3 6140.6 6164.2 6202.6 6057.1 6080.6 6086.8 6089.1 6104.5 5716.5 6362.9 6378.2 6378.3 6390.6 4229.9 4262.2 4268.6 4281.6 4281.6 6076.2 6122.3 6129.4 6130.8 6179.9 5757.7 5869.2 5902.4 5916.3 5946.3 5820.9 5822.7 5896.5 5926.5 5939.5 5756.4 5784.9 5787.6 5798.9 5814.6 5642.9 5942.6 5956.1 5989.8 5998.3 5794.8 5796.4 5812.0 5818.6 5850.5 02:39:49 INFO - PROCESS | 12546 | 02:39:49 INFO - PROCESS | 12546 | [#5] yui.html Cycles:180 Average:19752.20 Median:4752.82 stddev:28654.91 (602.9%) stddev-sans-first:28699.64 02:39:49 INFO - PROCESS | 12546 | Values: 715.8 759.5 761.9 768.1 779.2 13726.0 14503.2 14707.4 14806.6 14861.1 13268.7 13294.1 13384.5 13397.9 13411.3 638.6 755.7 763.1 763.4 770.0 742.6 768.8 771.4 772.6 775.6 817.3 818.8 823.7 827.4 827.8 816.5 816.6 818.1 819.1 819.2 597.7 598.3 598.6 599.1 599.8 13790.7 13856.9 13878.3 13938.6 13943.7 13851.4 14130.0 14171.4 14178.8 14265.2 11536.3 11572.8 11717.0 11807.2 11859.6 3234.1 3282.4 3366.1 3430.4 3436.2 75240.2 75698.6 75975.6 76219.6 77945.0 10666.7 10900.6 10918.1 11026.1 11460.8 17801.2 20232.9 20239.9 20294.1 20304.4 7794.4 7957.8 8113.2 8296.0 8318.9 4541.0 4603.0 4719.4 4733.5 4772.2 3570.5 3581.2 3592.1 3592.9 3597.7 647.2 662.5 667.6 670.5 689.7 664.7 701.4 702.9 709.8 711.8 9092.2 9114.8 9170.2 9287.3 9461.1 568.6 589.6 680.0 686.1 710.8 4363.5 4485.9 4498.0 4514.3 4577.7 109880.5 110817.0 111633.0 113653.0 114728.0 57546.4 92772.5 93657.0 93825.5 94244.5 55183.7 82619.0 84114.6 86198.0 86300.6 8382.2 8472.6 8522.1 8525.6 8687.2 51154.7 52252.5 52783.7 53040.7 54408.5 72504.6 73200.3 73630.8 75443.6 75495.6 9720.6 9995.5 10003.3 10079.6 11884.9 13149.5 13858.2 13862.2 13878.2 13913.6 12336.3 13006.7 13202.1 13510.2 13673.0 12436.4 12844.6 13088.2 13202.6 13223.1 12421.6 12588.2 12995.4 13123.7 13248.9 9629.0 10051.3 10096.7 10119.7 10129.3 10400.2 10841.9 10851.5 10936.7 10966.4 02:39:49 INFO - PROCESS | 12546 | -------- Summary: end -------- 02:39:49 INFO - PROCESS | 12546 | 02:39:50 INFO - TEST-INFO | 12546: exit 0 02:39:50 INFO - TEST-OK | dromaeo_css | took 1110555ms 02:39:50 INFO - TEST-START | kraken 02:39:50 INFO - operating with platform_type : linux_ 02:39:50 INFO - Initialising browser for kraken test... 02:39:50 INFO - TEST-INFO | started process 12783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmAZs80/profile http://localhost:60408/getInfo.html) 02:39:54 INFO - PROCESS | 12783 | __metrics Screen width/height:1600/1200 02:39:54 INFO - PROCESS | 12783 | colorDepth:24 02:39:54 INFO - PROCESS | 12783 | Browser inner width/height: 1024/697 02:39:54 INFO - PROCESS | 12783 | __metrics 02:39:55 ERROR - PROCESS | 12783 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:39:56 INFO - TEST-INFO | 12783: exit 0 02:39:56 INFO - Browser initialized. 02:39:56 INFO - Running cycle 1/1 for kraken test... 02:39:56 INFO - TEST-INFO | started process 12903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmAZs80/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:08 INFO - PROCESS | 12903 | RSS: Main: 185462784 02:40:08 INFO - PROCESS | 12903 | 02:40:10 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60408/tests/kraken/driver.html?testName=audio-beat-detection) 02:40:11 INFO - PROCESS | 12903 | RSS: Main: 191258624 02:40:11 INFO - PROCESS | 12903 | 02:40:14 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60408/tests/kraken/driver.html?testName=audio-dft) 02:40:15 INFO - PROCESS | 12903 | RSS: Main: 190304256 02:40:15 INFO - PROCESS | 12903 | 02:40:17 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60408/tests/kraken/driver.html?testName=audio-fft) 02:40:18 INFO - PROCESS | 12903 | RSS: Main: 185470976 02:40:18 INFO - PROCESS | 12903 | 02:40:20 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60408/tests/kraken/driver.html?testName=audio-oscillator) 02:40:21 INFO - PROCESS | 12903 | RSS: Main: 186224640 02:40:21 INFO - PROCESS | 12903 | 02:40:23 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60408/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:24 INFO - PROCESS | 12903 | RSS: Main: 186585088 02:40:24 INFO - PROCESS | 12903 | 02:40:27 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60408/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:28 INFO - PROCESS | 12903 | RSS: Main: 186974208 02:40:28 INFO - PROCESS | 12903 | 02:40:31 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60408/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:32 INFO - PROCESS | 12903 | RSS: Main: 183877632 02:40:32 INFO - PROCESS | 12903 | 02:40:34 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60408/tests/kraken/driver.html?testName=json-parse-financial) 02:40:35 INFO - PROCESS | 12903 | RSS: Main: 185335808 02:40:35 INFO - PROCESS | 12903 | 02:40:37 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60408/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:37 INFO - PROCESS | 12903 | RSS: Main: 185741312 02:40:37 INFO - PROCESS | 12903 | 02:40:39 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60408/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:40 INFO - PROCESS | 12903 | RSS: Main: 186040320 02:40:40 INFO - PROCESS | 12903 | 02:40:42 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60408/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:43 INFO - PROCESS | 12903 | RSS: Main: 186494976 02:40:43 INFO - PROCESS | 12903 | 02:40:45 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60408/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:46 INFO - PROCESS | 12903 | RSS: Main: 186761216 02:40:46 INFO - PROCESS | 12903 | 02:40:49 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60408/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:40:49 INFO - PROCESS | 12903 | RSS: Main: 186568704 02:40:49 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | Cycle 1(1): loaded http://localhost:60408/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60408/tests/kraken/driver.html?testName=ai-astar) 02:40:51 INFO - PROCESS | 12903 | RSS: Main: 188100608 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | __start_tp_report 02:40:51 INFO - PROCESS | 12903 | _x_x_mozilla_page_load 02:40:51 INFO - PROCESS | 12903 | _x_x_mozilla_page_load_details 02:40:51 INFO - PROCESS | 12903 | |i|pagename|runs| 02:40:51 INFO - PROCESS | 12903 | |0;ai-astar;112;105;112;109;110;112;112;110;109;110 02:40:51 INFO - PROCESS | 12903 | |1;audio-beat-detection;156;129;151;180;126;157;166;128;198;126 02:40:51 INFO - PROCESS | 12903 | |2;audio-dft;164;165;163;163;176;172;164;164;161;162 02:40:51 INFO - PROCESS | 12903 | |3;audio-fft;76;76;76;158;76;76;75;75;164;74 02:40:51 INFO - PROCESS | 12903 | |4;audio-oscillator;87;86;139;86;87;88;149;85;85;139 02:40:51 INFO - PROCESS | 12903 | |5;imaging-gaussian-blur;119;118;118;118;121;117;118;118;117;118 02:40:51 INFO - PROCESS | 12903 | |6;imaging-darkroom;147;148;148;151;147;149;147;148;147;148 02:40:51 INFO - PROCESS | 12903 | |7;imaging-desaturate;96;96;96;95;96;95;96;95;96;95 02:40:51 INFO - PROCESS | 12903 | |8;json-parse-financial;55;55;55;55;57;58;57;56;56;56 02:40:51 INFO - PROCESS | 12903 | |9;json-stringify-tinderbox;61;62;61;62;62;63;60;61;62;62 02:40:51 INFO - PROCESS | 12903 | |10;stanford-crypto-aes;85;81;86;81;81;80;80;80;113;80 02:40:51 INFO - PROCESS | 12903 | |11;stanford-crypto-ccm;121;121;133;131;130;134;136;125;127;131 02:40:51 INFO - PROCESS | 12903 | |12;stanford-crypto-pbkdf2;166;164;156;159;171;159;169;157;157;167 02:40:51 INFO - PROCESS | 12903 | |13;stanford-crypto-sha256-iterative;62;64;68;63;62;63;61;62;61;61 02:40:51 INFO - PROCESS | 12903 | __end_tp_report 02:40:51 INFO - PROCESS | 12903 | __start_cc_report 02:40:51 INFO - PROCESS | 12903 | _x_x_mozilla_cycle_collect,888 02:40:51 INFO - PROCESS | 12903 | __end_cc_report 02:40:51 INFO - PROCESS | 12903 | __startTimestamp1466242851563__endTimestamp 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | ------- Summary: start ------- 02:40:51 INFO - PROCESS | 12903 | Number of tests: 14 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.18 (2.0%) stddev-sans-first:2.20 02:40:51 INFO - PROCESS | 12903 | Values: 112.0 105.0 112.0 109.0 110.0 112.0 112.0 110.0 109.0 110.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:156.50 stddev:24.93 (15.9%) stddev-sans-first:26.39 02:40:51 INFO - PROCESS | 12903 | Values: 156.0 129.0 151.0 180.0 126.0 157.0 166.0 128.0 198.0 126.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.00 stddev:4.77 (2.9%) stddev-sans-first:5.03 02:40:51 INFO - PROCESS | 12903 | Values: 164.0 165.0 163.0 163.0 176.0 172.0 164.0 164.0 161.0 162.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:36.08 (47.5%) stddev-sans-first:37.77 02:40:51 INFO - PROCESS | 12903 | Values: 76.0 76.0 76.0 158.0 76.0 76.0 75.0 75.0 164.0 74.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:86.00 stddev:27.23 (31.7%) stddev-sans-first:28.25 02:40:51 INFO - PROCESS | 12903 | Values: 87.0 86.0 139.0 86.0 87.0 88.0 149.0 85.0 85.0 139.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.14 (1.0%) stddev-sans-first:1.17 02:40:51 INFO - PROCESS | 12903 | Values: 119.0 118.0 118.0 118.0 121.0 117.0 118.0 118.0 117.0 118.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 02:40:51 INFO - PROCESS | 12903 | Values: 147.0 148.0 148.0 151.0 147.0 149.0 147.0 148.0 147.0 148.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:40:51 INFO - PROCESS | 12903 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.05 (1.9%) stddev-sans-first:1.05 02:40:51 INFO - PROCESS | 12903 | Values: 55.0 55.0 55.0 55.0 57.0 58.0 57.0 56.0 56.0 56.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.84 (1.4%) stddev-sans-first:0.87 02:40:51 INFO - PROCESS | 12903 | Values: 61.0 62.0 61.0 62.0 62.0 63.0 60.0 61.0 62.0 62.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:81.00 stddev:10.18 (12.6%) stddev-sans-first:10.79 02:40:51 INFO - PROCESS | 12903 | Values: 85.0 81.0 86.0 81.0 81.0 80.0 80.0 80.0 113.0 80.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:131.00 stddev:5.24 (4.0%) stddev-sans-first:4.71 02:40:51 INFO - PROCESS | 12903 | Values: 121.0 121.0 133.0 131.0 130.0 134.0 136.0 125.0 127.0 131.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:165.00 stddev:5.54 (3.4%) stddev-sans-first:5.73 02:40:51 INFO - PROCESS | 12903 | Values: 166.0 164.0 156.0 159.0 171.0 159.0 169.0 157.0 157.0 167.0 02:40:51 INFO - PROCESS | 12903 | 02:40:51 INFO - PROCESS | 12903 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:2.11 (3.4%) stddev-sans-first:2.22 02:40:51 INFO - PROCESS | 12903 | Values: 62.0 64.0 68.0 63.0 62.0 63.0 61.0 62.0 61.0 61.0 02:40:51 INFO - PROCESS | 12903 | -------- Summary: end -------- 02:40:51 INFO - PROCESS | 12903 | 02:40:52 INFO - TEST-INFO | 12903: exit 0 02:40:52 INFO - TEST-OK | kraken | took 62204ms 02:40:52 INFO - SUITE-END | took 1172s 02:40:52 INFO - Completed test suite (00:19:32) 02:40:52 INFO - javascript benchmark 02:40:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7241.3910356716015, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.5945827042483, 3136.168915237461, 3172.5558421820942, 3172.6668699786537, 3176.698213669702, 5451.291332126823, 5520.5307548858345, 5523.337199536057, 5551.417101204366, 5574.358948720898, 5438.211459338394, 5505.284313039309, 5555.611107222486, 5574.581906357029, 5609.0, 5093.847184584469, 5111.821086261982, 5157.948420515784, 5191.844244672666, 5193.195054766517, 509.9839799271053, 5108.693478391308, 5162.070827251112, 5172.948270517303, 5193.246979188016, 5101.387833459971, 5106.4382917879, 5111.284420181178, 5115.795368185268, 5119.129747942859, 4984.476629953839, 5112.693238405707, 5120.0, 5120.02719483297, 5148.588112950955, 5003.54968052877, 5064.620153488466, 5095.312132862054, 5099.311592934943, 5102.668326558799, 5575.330960284792, 5582.553395728332, 5614.691191984439, 5626.606137570372, 5639.492445679867, 5727.31272247333, 5880.26496687914, 5992.700364981733, 6016.909746353808, 6058.787942421994, 5977.970110149465, 6073.878522429527, 6086.0, 6096.390360963913, 6110.114033465123, 5593.664380137205, 5600.4959553639965, 5605.635633683797, 5606.467385598362, 5607.943920560824, 5950.851228719317, 6067.787627433018, 6074.75700971965, 6154.969225153935, 6167.660778657217, 5860.560457965669, 5907.793227237026, 5908.615939963888, 5928.851778705567, 5948.762049518057, 6024.789132380346, 6030.7286172121485, 6030.939690603038, 6034.034554471351, 6036.943534881379, 5734.942650573441, 5774.3070831499645, 5814.476697097281, 5840.678762668009, 5908.763649454059, 5715.799947001835, 5825.155352473952, 5862.443067908542, 5867.354590994987, 5889.528837692974, 4509.842155524607, 4510.413646225969, 4520.59314661682, 4530.365748795171, 4548.818047278138, 3946.723729338919, 3954.5452272988973, 3976.58245884178, 4000.439938408625, 4011.659008984269, 5652.321721393377, 5688.345840228427, 5690.886182276331, 5691.573132015033, 5692.37383887772, 5878.735456904449, 5945.10823376497, 5950.702464876739, 5956.255468066492, 5958.851028724316, 5511.834644960658, 5646.350669672958, 5691.544676425876, 5709.714514274353, 5719.628224165416, 4820.662553621283, 4835.178019736653, 4838.806447742121, 4861.100696371112, 4868.050730107595, 6016.548758843104, 6223.875522489616, 6243.25080990275, 6248.812535623939, 6251.12484252205, 5888.9705551472825, 5912.881742365214, 5935.080062590306, 6002.339742628395, 6022.969885150546, 6171.228596425447, 6172.166757487682, 6174.073888916699, 6179.227596550431, 6182.907256391068, 5715.742791574306, 5759.94240057594, 5852.619579727304, 5854.385289544536, 5861.062230043172, 5915.852103697442, 5974.492168165754, 5984.1323008164445, 5993.220881285405, 6041.486473649789, 5731.512821410227, 5758.942410576008, 5798.768049277982, 5808.30300363959, 5818.44724751148, 5651.15232715096, 5729.914051289317, 5731.656100633975, 5738.598298119258, 5742.368339482737, 5560.304961879765, 5672.659640421588, 5683.545316374597, 5699.914501282401, 5821.912671310019, 5775.624584402, 5800.1299805029585, 5826.912596311144, 5852.239208902815, 5870.618409803349, 5634.549236061187, 5640.182173584725, 5697.059985102412, 5716.28546431696, 5742.712864356682], "value": 5441.306452093463, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.8073376152748, 619.8047615001275, 627.4980015987209, 644.7195469970561, 654.3064351787103, 39964.200715985666, 41121.3831792523, 41203.79398103009, 44603.33095003577, 45173.0, 42351.36472952901, 42778.0, 42928.57071429285, 42932.78533607328, 42934.785326073325, 8789.428687135332, 8905.421147625384, 8952.0, 8989.056149104315, 9021.097890210993, 8762.518061506615, 8824.117588241157, 8860.158284962918, 8864.512451815148, 8903.24322432594, 8893.021767605558, 8974.326925480582, 8991.550422478882, 8999.41503802254, 9006.504642244674, 8875.644974201025, 8914.286857051453, 8947.686830960918, 8962.238209752179, 8996.550172491414, 8815.382923195379, 8856.645734170625, 8902.688405905827, 8917.464952102895, 8952.104789520996, 41045.794771025954, 41334.1733165338, 41390.1721965562, 41446.1710765783, 41622.167556649, 3454.9654503455145, 3460.688538031564, 3542.2030043240065, 3549.8402571884326, 4029.37544680575, 30092.8495357524, 30230.395392092036, 30407.23981900448, 33532.49701254483, 33564.664353356646, 4219.22423287965, 4274.706336786657, 4314.395984562164, 4343.305071188626, 4345.652347812167, 353886.0, 354289.0, 355433.0, 355498.0, 356376.2181189103, 57521.0, 57635.71182144062, 57766.0, 58073.41926580764, 58340.708296458244, 34204.65795342065, 61055.38944610586, 61244.38755612476, 61366.69316653388, 61727.38272617216, 13468.39392227352, 14036.0, 14082.929585352007, 14106.85893141076, 14145.646358840906, 9788.363756355957, 9796.069373409515, 9852.408855468695, 9892.406455612543, 9893.911669716326, 18696.158672859754, 18742.25030998745, 18759.499240060763, 18807.90596047011, 18869.528261793566, 6984.301569843076, 7105.751298704624, 7263.4915555910575, 7305.525140865933, 7317.780466586011, 969.7914948286152, 1086.413336798136, 1096.5887792077972, 1101.8347247912877, 1120.7086157599083, 31840.363192736015, 31907.52138717921, 32030.0, 32280.838595806872, 32349.51475727866, 1064.43052966664, 1092.7432053467428, 1099.2689861242184, 1151.1366475143643, 1215.2283300104498, 16297.429589964295, 16648.25082871274, 16668.902036173276, 16700.0, 16793.244304006348, 555341.0, 557316.0, 560729.0, 561327.0, 565068.0, 55564.72217638886, 55681.16478252829, 56190.15714764282, 56199.438005620235, 56400.43599564034, 1331.5605850069453, 1331.7203387288585, 1333.5863984176804, 1337.4516448256168, 1354.1198221156328, 29127.85436072891, 30501.694983049885, 30827.552105964383, 30965.380692386476, 31176.0, 47489.28766068443, 47821.0, 48074.5192548084, 48147.75926120487, 48226.75886620545, 421236.57526849903, 427778.0, 429272.0, 431215.0, 435081.0, 27210.863945680147, 27440.725592743816, 27634.170974870787, 27679.44641107207, 27750.306242344104, 46673.766631167986, 46945.765271173426, 47142.52857471519, 48005.75997120132, 48040.75979620079, 40396.19207615773, 40723.59276407198, 40767.1846563073, 40827.0, 41780.3732944, 39237.80381098076, 39848.80075599603, 40007.19985600213, 40055.39916901307, 40284.0, 34427.0, 38220.42669360017, 38684.80657596694, 38713.22573548457, 39800.0, 35082.82458587691, 35965.82017089898, 36689.81655091707, 36821.26357472889, 37201.0, 27120.32199195036, 27214.0, 27498.862505687342, 27611.447771044066, 27832.721672783824], "value": 19675.476342408747, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3191221756947, 379.62986088563673, 382.44927304681255, 393.8778978516658, 401.25166564357465, 17580.824191758078, 19190.232390704354, 19306.806931930692, 19856.60286794263, 20024.0, 18499.0750462477, 18511.537211569685, 18668.895788551883, 18883.150258238376, 19187.712184317246, 5584.748686309115, 5694.487496125348, 5791.015527360338, 5801.390853960336, 5806.738696758634, 5667.688277144755, 5669.121286200625, 5688.4311568843195, 5698.715064246791, 5703.942960570404, 5404.756785944642, 5550.0, 5596.132599447072, 5620.9437905620825, 5754.625949313302, 5787.797427090074, 5789.04480760674, 5799.507041901444, 5863.149843272723, 5868.03177475716, 5679.488846003838, 5796.739146738365, 5813.302403711539, 5839.503642190419, 5842.386549412293, 13417.530386436429, 13882.722345553033, 22770.886145569333, 22780.430489237737, 22846.31461056171, 2053.9281125160546, 2280.737715162761, 2382.809375249993, 2459.557279689655, 2649.2582077018465, 9869.703908882744, 10144.239182061301, 10613.57545698171, 11735.765284694344, 14239.928800355932, 1912.3402426162952, 1937.9438206177667, 1941.980580194194, 1966.567355181872, 1977.5649357141406, 65467.67266163686, 69318.99999999949, 71601.64199179022, 78864.10582346872, 81895.5905220476, 10241.48792560369, 10385.169186465064, 10664.187088195025, 10795.676129716121, 10928.142215823329, 14740.968132230855, 14805.481808136663, 14806.555803325917, 14808.259587020606, 14835.777463338058, 7153.248908864494, 7187.640617969185, 7229.09636295463, 7302.926970730331, 7352.264773522605, 6594.769183078569, 6627.701753421107, 6931.514793964374, 7035.683394247271, 7238.52949558277, 4384.714993525475, 4568.2690769477385, 4590.563896429834, 4608.308753686907, 4721.961168542915, 1889.263187356932, 1923.3652894544766, 1937.8159074887863, 1943.504406376365, 1999.5600967787063, 806.2703253555542, 908.1871724806261, 931.4830269200523, 941.3222479814523, 959.5490119643756, 18764.437066888015, 18907.338243161423, 19102.617947641247, 19289.421317360502, 19567.41297761041, 939.492673956056, 952.6713283917038, 1024.800163968034, 1027.0807627173638, 1050.4537640426936, 10459.424731639832, 10822.458877056273, 10839.512221950032, 10850.348979061282, 10894.346339219672, 452098.0, 454099.0, 467379.0, 469031.0, 478900.0, 60128.39871601228, 62156.06765898515, 79697.20302797014, 97084.0, 97430.51284743672, 981.3179840011267, 1001.1290177545582, 1008.0725732326277, 1040.0275742181084, 1040.8542804007445, 17420.216090275713, 17428.651426971643, 17932.731009034615, 18155.546111346794, 18177.636447270717, 42313.0, 43010.56989430191, 43085.78457107695, 43091.56908430876, 45453.09093818171, 58612.41387586069, 59761.40238597558, 60199.09701354571, 60689.69655151696, 60767.08849367175, 8208.958955205186, 8382.0, 8467.0, 8585.82828343442, 8651.48091114535, 12205.328706921204, 12500.687482813002, 12729.363531823186, 13301.401436935168, 13499.932500337436, 11751.47118379692, 11764.117691173025, 11971.521139154336, 12216.511339546318, 12315.44580493862, 11927.522899083939, 11964.282143071443, 12027.639170824888, 12155.331456769962, 12210.57262995791, 11903.523859045541, 12009.0, 12075.818862716891, 12167.391630418266, 12476.750464990831, 7346.77959661211, 8418.284445822173, 8488.363372746946, 8581.914180858112, 8667.393282470166, 11479.713007174887, 11550.537978480766, 11592.188546801643, 11882.16824822254, 12153.45309461094], "value": 9039.726164627215, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.712057588482, 1465.033078168409, 1582.200988500807, 1713.1519897650664, 1724.56023713953, 8084.2724154826055, 8243.381746369016, 8712.520811355382, 8739.388242822997, 8846.867296990551, 9167.633294668205, 9207.217386522154, 9211.263098952084, 9263.212626926703, 9296.488693121875, 2359.4219416243, 2392.820538459614, 2403.51929614077, 2407.711074671033, 2414.2515820095737, 2304.573653874039, 2326.4416540030356, 2356.8350215484925, 2375.3467796355967, 2383.7616238376195, 2344.906203751848, 2355.387599224197, 2357.3635118518077, 2374.430136767172, 2376.9762302376926, 2361.988190059056, 2367.4318163640773, 2372.0867466025534, 2375.3111597636666, 2382.60686986647, 2320.9419764505856, 2323.8489498182735, 2338.018032426385, 2339.7894189523026, 2339.988300058506, 9242.983271840092, 9287.024862389419, 9316.602509623543, 9349.39228950123, 9355.532223388804, 5379.5696344292755, 5470.425605311425, 5502.284702988586, 5509.5041446270025, 5558.194061861048, 3432.8798492052906, 3441.346144232588, 3553.218291975761, 3567.126054116732, 3601.8199090045655, 1176.4882276209876, 1195.940202989847, 1198.2211562484367, 1224.4428784902937, 1225.2709637765515, 13121.14712543672, 13137.474501019948, 13156.144850584777, 13173.934130329382, 13192.934035329858, 4760.500147484534, 4836.879078023007, 4952.727599981963, 4969.105560999054, 4993.176125939252, 10712.125378058809, 10796.136309095253, 10803.081738052197, 10860.511276992554, 10890.455477226107, 5432.130859062531, 5460.372057213392, 5487.780488780484, 5501.202325662756, 5526.696031718294, 4432.977835110803, 4798.640101992364, 4878.463369029475, 4958.727270000112, 4962.20604703253, 3937.8031098444962, 3979.6816254699556, 4075.89810254746, 4113.0, 4132.566080561498, 1289.8903593194684, 1298.4935875008755, 1308.6662900960193, 1311.4819646239682, 1317.038561849855, 950.7100334398075, 954.6038394066524, 974.0794948773341, 974.5030034682363, 980.9215262778961, 6093.0, 6152.138700581832, 6221.906671399933, 6239.625622462667, 6320.968395157995, 476.04552871493127, 476.49491538968806, 485.5363128212619, 485.8323878261994, 488.2675986020969, 4184.811683474251, 4237.597428244373, 4300.4839419269265, 4306.5262821089655, 4361.12777444506, 11221.158413119048, 11525.481353338952, 11575.13186511015, 11664.6500604982, 11689.707757305965, 11423.657290281304, 11435.0, 11475.77048459026, 11479.770404591862, 11483.081353491702, 8138.755837324889, 8462.746117616482, 8489.193526614961, 8669.08974557675, 8694.565271736514, 6110.969445152746, 6272.435480806749, 6290.968545157428, 6319.715612797527, 6370.574676019779, 10405.115565177044, 10633.468326583485, 10692.14462842955, 10784.406857622906, 10886.836697449702, 10581.894181058398, 10704.411257380918, 10814.56741730322, 10833.458327083772, 10866.96763807437, 7617.428692847948, 8014.639341229776, 8067.354611631173, 8326.83346333082, 8372.07907130203, 9224.631014759334, 9234.261259099121, 9260.722178334661, 9263.305252105984, 9316.767080823034, 7988.760337189894, 8269.09040005587, 8269.131741167092, 8290.87563686533, 8334.79163020905, 7828.491148075357, 8080.0, 8090.150534193825, 8260.339172866035, 8281.17188281167, 6816.147981502312, 6994.705979393829, 7346.742863999734, 7432.479726419098, 7435.256474352522, 5199.428062913152, 5239.187925871496, 5246.501582349671, 5272.420033796356, 5292.073887069824, 5175.534201921845, 5199.76601052946, 5210.765515551885, 5247.08176069194, 5291.894162116659], "value": 4725.870596508738, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.5402912936452, 331.06639277238185, 337.46174851112477, 339.4958486647328, 343.95012723155156, 5456.208849716789, 5579.2746942897365, 5592.0, 5666.37669856316, 5709.286339207599, 5479.780808767645, 5588.21764952907, 5615.831525054245, 5619.297587801525, 5641.717914104289, 4324.156789426071, 4350.456192975878, 4356.89107772305, 4359.934600980988, 4401.581849724287, 4137.54487006429, 4366.345048242757, 4371.562843715619, 4388.824447022115, 4393.275109606911, 4301.354796780477, 4310.892227694317, 4317.0, 4326.30779075348, 4334.956650433503, 4340.110277393127, 4340.848070317524, 4341.327094300388, 4343.218220720253, 4349.630281426083, 3760.3419401604883, 3777.6411240932066, 3804.144067584799, 3810.8285127169343, 3827.98558382029, 5456.372517160537, 5472.878059997691, 5482.095454250044, 5493.670379777226, 5500.697461639608, 4881.755152436106, 4912.0, 4944.480829512885, 4947.406311242638, 4960.70235785854, 5718.199452076713, 5759.078547432391, 5879.0, 5892.852678683024, 5904.3762965184915, 4106.630403263691, 4134.235166494208, 4134.689898257643, 4158.480189976253, 4171.10321280923, 6083.17877086592, 6108.175396321529, 6136.9079463808075, 6147.385261473817, 6159.599626024339, 4106.691998100095, 4240.385144154142, 4263.360495925636, 4271.786410679453, 4283.2932566126865, 4276.2796367160145, 4280.143971205771, 4294.0767734937135, 4301.247281725686, 4308.771999980053, 4867.0995865764235, 4896.975515122402, 4945.307656928033, 4962.652614317035, 4969.577585905238, 5747.655140691572, 5892.616979896293, 5896.027155519291, 5908.20239267702, 5950.404959504015, 1455.3378212913099, 1471.5805995291291, 1480.1341215388902, 1485.376142020354, 1486.8661820436212, 916.3516907841282, 923.7829110159107, 926.813678491532, 927.7680579855037, 947.488356287597, 5003.24951257307, 5010.897602527438, 5064.594832413398, 5084.923726144111, 5132.0, 5336.759845806948, 5408.810061786479, 5418.214358918013, 5461.399246082928, 5465.836024919259, 4900.26496025599, 4949.970512090026, 5063.594912406998, 5160.8967820643375, 5173.292813371579, 2806.4106537627326, 2828.618136551539, 2879.8992035278666, 2905.7965942384253, 2936.588877557144, 5486.91769623456, 5517.337919449611, 5535.474129957647, 5547.694876781735, 5574.554035677136, 5435.347758269033, 5685.260916080966, 6273.368924079772, 6299.401556852092, 6302.558820882586, 6308.337624549448, 6332.398422149889, 6338.58799178052, 6362.586431881913, 6362.713677884506, 6022.909656355246, 6127.264728232462, 6140.631562106288, 6164.229471316085, 6202.56582039271, 6057.121717350871, 6080.635161890301, 6086.786962456293, 6089.147519347206, 6104.4505994460715, 5716.485516303553, 6362.904556431565, 6378.2346118466085, 6378.330275321025, 6390.64851433157, 4229.915401691887, 4262.211490874198, 4268.637165840814, 4281.571842815818, 4281.60847724497, 6076.240469941257, 6122.295935967242, 6129.387061293835, 6130.846728831636, 6179.907301390573, 5757.65454072757, 5869.207656966255, 5902.350741418526, 5916.308079823756, 5946.286445626552, 5820.854478638068, 5822.650640961556, 5896.498797602252, 5926.459120628581, 5939.46544810969, 5756.352078044147, 5784.884302314014, 5787.55311172207, 5798.855028624318, 5814.5639077068545, 5642.915356269741, 5942.603488180188, 5956.106584012433, 5989.8203053908455, 5998.25021872266, 5794.82615521535, 5796.449337313117, 5811.970940145272, 5818.6217895836635, 5850.502707269759], "value": 4397.644913886269, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.817466546031, 759.5063208914205, 761.9085709714835, 768.0974854545909, 779.170183754302, 13726.0, 14503.202323872183, 14707.411703531872, 14806.629834254149, 14861.108333499997, 13268.734625307488, 13294.135881167742, 13384.464621415133, 13397.866021339783, 13411.262380569065, 638.6200210874522, 755.6788364944904, 763.1262204775529, 763.4121726270769, 770.0374531835206, 742.5730205132044, 768.827013921866, 771.4484143837155, 772.5982489105662, 775.6393277126135, 817.3461231015194, 818.758466252457, 823.6787652815377, 827.3629305434841, 827.8054657155564, 816.5019338203691, 816.5876232502578, 818.0633175014575, 819.1030821250721, 819.2462934100641, 597.7310210405292, 598.3089531590975, 598.6318414175295, 599.0714392691311, 599.8260504453704, 13790.65523361914, 13856.93071534646, 13878.306084695725, 13938.58184254474, 13943.721125577533, 13851.445942162301, 14130.0, 14171.362288697033, 14178.787318190236, 14265.215413152273, 11536.307821530734, 11572.826407603892, 11717.0, 11807.173497855154, 11859.58491452795, 3234.126785767853, 3282.4091663500562, 3366.0575038989123, 3430.433978393587, 3436.2096717754807, 75240.24759752388, 75698.62150689267, 75975.62012189903, 76219.61890190514, 77945.0, 10666.679999600025, 10900.618478353379, 10918.12654987615, 11026.062784663232, 11460.828087578693, 17801.198946047458, 20232.89883550573, 20239.8988005062, 20294.086766095563, 20304.39086827368, 7794.3764498839955, 7957.7612671619945, 8113.229243221885, 8295.958520207481, 8318.87872081652, 4540.977295113504, 4603.0, 4719.4100737407825, 4733.479317275097, 4772.164871147535, 3570.535830342039, 3581.158427769472, 3592.084018575247, 3592.892213233607, 3597.6941959933697, 647.1910112359551, 662.5097427903316, 667.6027763480721, 670.4502308107305, 689.7344522358827, 664.6909187227963, 701.4143190435941, 702.8734827730955, 709.8118998465411, 711.7900219435176, 9092.181703646704, 9114.817703646022, 9170.174684278447, 9287.257019438428, 9461.101195386427, 568.57502750768, 589.6285340235625, 679.9864002719918, 686.1080595226186, 710.7974227345285, 4363.498197707241, 4485.887852803641, 4497.955020449754, 4514.32285157229, 4577.725336479755, 109880.4505977465, 110817.0, 111633.0, 113653.0, 114728.0, 57546.424535754944, 92772.53613731888, 93657.0, 93825.5308723452, 94244.52877735568, 55183.72408138014, 82619.0, 84114.57942710248, 86198.0, 86300.56849715712, 8382.207118547807, 8472.576371181292, 8522.147785221676, 8525.573721314033, 8687.174718401742, 51154.74422627863, 52252.47747522476, 52783.736081319345, 53040.73479632577, 54408.45591544034, 72504.63747681228, 73200.26799731934, 73630.84172540474, 75443.62278188574, 75495.62252188704, 9720.562574684014, 9995.450250236307, 10003.2997690161, 10079.647212347532, 11884.881151188378, 13149.474021039434, 13858.237796921267, 13862.168269903837, 13878.167309961435, 13913.58259252224, 12336.3215023171, 13006.739865202453, 13202.075854690464, 13510.189388636712, 13673.0, 12436.375975568606, 12844.614661560168, 13088.214707117604, 13202.603921882359, 13223.140495867738, 12421.627351179479, 12588.181768185039, 12995.415206315549, 13123.671908202372, 13248.933755331162, 9628.951855240679, 10051.296409251283, 10096.69709908704, 10119.683958769425, 10129.346883009572, 10400.219983501116, 10841.850698141963, 10851.45742712877, 10936.726581835517, 10966.396848173426], "value": 7168.1153070636565, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 112.0, 109.0, 110.0, 112.0, 112.0, 110.0, 109.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 151.0, 180.0, 126.0, 157.0, 166.0, 128.0, 198.0, 126.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 163.0, 176.0, 172.0, 164.0, 164.0, 161.0, 162.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 158.0, 76.0, 76.0, 75.0, 75.0, 164.0, 74.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 139.0, 86.0, 87.0, 88.0, 149.0, 85.0, 85.0, 139.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 118.0, 121.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 151.0, 147.0, 149.0, 147.0, 148.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 57.0, 58.0, 57.0, 56.0, 56.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 63.0, 60.0, 61.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 86.0, 81.0, 81.0, 80.0, 80.0, 80.0, 113.0, 80.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 133.0, 131.0, 130.0, 134.0, 136.0, 125.0, 127.0, 131.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 156.0, 159.0, 171.0, 159.0, 169.0, 157.0, 157.0, 167.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 68.0, 63.0, 62.0, 63.0, 61.0, 62.0, 61.0, 61.0], "value": 62.7, "unit": "score"}]}]} 02:40:52 INFO - Return code: 0 02:40:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:40:52 ERROR - # TBPL SUCCESS # 02:40:52 INFO - Running post-action listener: _resource_record_post_action 02:40:52 INFO - ##### 02:40:52 INFO - ##### Finished run-tests step (success) 02:40:52 INFO - ##### 02:40:52 INFO - Running post-run listener: _resource_record_post_run 02:40:52 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 16384; Write bytes: 551714816; Read time: 300; Write time: 399192 02:40:52 INFO - TinderboxPrint: CPU usage
13.5% 02:40:52 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 300 02:40:52 INFO - TinderboxPrint: I/O write bytes / time
551,714,816 / 399,192 02:40:52 INFO - TinderboxPrint: CPU idle
8,218.6 (86.5%) 02:40:52 INFO - TinderboxPrint: CPU user
1,225.9 (12.9%) 02:40:52 INFO - TinderboxPrint: Swap in / out
0 / 0 02:40:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 8192; Write bytes: 256380928; Read time: 284; Write time: 220164 02:40:52 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295333888; Read time: 16; Write time: 179028 02:40:53 INFO - Running post-run listener: _upload_blobber_files 02:40:53 INFO - Blob upload gear active. 02:40:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:53 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 02:40:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:40:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:40:53 INFO - (blobuploader) - INFO - Open directory for files ... 02:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:40:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:55 INFO - (blobuploader) - INFO - Done attempting. 02:40:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:40:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:40:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:55 INFO - (blobuploader) - INFO - Done attempting. 02:40:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:40:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:41:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:00 INFO - (blobuploader) - INFO - Done attempting. 02:41:00 INFO - (blobuploader) - INFO - Iteration through files over. 02:41:00 INFO - Return code: 0 02:41:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:41:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:41:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bffa164582cc85ed0ac138ed164dcf980e0dd8bf159e9a84f38c99a215bba837327eef15d6034e65436d2ae4a9513e5f71b3d13220993d16eca96957609b4ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20c5daac508d61bbffff9de7ba7cc581563e4b5493100567678d6440a8929ae012faddf99195841427827e5ccd9d8edd53f2ba6820a0a8a0abe5da33d5310d4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9524d6ee2a923c80a46d2307a64e42a92f680be628e086f1f4a38f5090c3ab39fbd9de21a1b14d580d58cddbd6ed9f87e1e5472540e0d542bdd4921dafa84997"} 02:41:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:41:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:41:00 INFO - Contents: 02:41:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bffa164582cc85ed0ac138ed164dcf980e0dd8bf159e9a84f38c99a215bba837327eef15d6034e65436d2ae4a9513e5f71b3d13220993d16eca96957609b4ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20c5daac508d61bbffff9de7ba7cc581563e4b5493100567678d6440a8929ae012faddf99195841427827e5ccd9d8edd53f2ba6820a0a8a0abe5da33d5310d4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9524d6ee2a923c80a46d2307a64e42a92f680be628e086f1f4a38f5090c3ab39fbd9de21a1b14d580d58cddbd6ed9f87e1e5472540e0d542bdd4921dafa84997"} 02:41:00 INFO - Running post-run listener: copy_logs_to_upload_dir 02:41:00 INFO - Copying logs to upload dir... 02:41:00 INFO - mkdir: /builds/slave/test/build/upload/logs 02:41:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.677246 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-18 02:41:00.047724) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 02:41:00.053788) ========= 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=00204705a9daa57ed339a427000001b9-1466238857.328536-734563074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bffa164582cc85ed0ac138ed164dcf980e0dd8bf159e9a84f38c99a215bba837327eef15d6034e65436d2ae4a9513e5f71b3d13220993d16eca96957609b4ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20c5daac508d61bbffff9de7ba7cc581563e4b5493100567678d6440a8929ae012faddf99195841427827e5ccd9d8edd53f2ba6820a0a8a0abe5da33d5310d4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9524d6ee2a923c80a46d2307a64e42a92f680be628e086f1f4a38f5090c3ab39fbd9de21a1b14d580d58cddbd6ed9f87e1e5472540e0d542bdd4921dafa84997"} build_url:https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/WPS14SmeSl2gvBQojfXlWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bffa164582cc85ed0ac138ed164dcf980e0dd8bf159e9a84f38c99a215bba837327eef15d6034e65436d2ae4a9513e5f71b3d13220993d16eca96957609b4ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20c5daac508d61bbffff9de7ba7cc581563e4b5493100567678d6440a8929ae012faddf99195841427827e5ccd9d8edd53f2ba6820a0a8a0abe5da33d5310d4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9524d6ee2a923c80a46d2307a64e42a92f680be628e086f1f4a38f5090c3ab39fbd9de21a1b14d580d58cddbd6ed9f87e1e5472540e0d542bdd4921dafa84997"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 02:41:00.082053) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:41:00.082692) ========= 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=00204705a9daa57ed339a427000001b9-1466238857.328536-734563074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 02:41:00.167988) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 02:41:00.168656) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 02:41:00.169160) ========= ========= Total master_lag: 0.20 =========