builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1465311699.12 results: success (0) buildid: 20160607065130 builduid: 451196e533b340df8861c5fce5082aa2 revision: 5c76c7484b9a9ee6855a57b9b04c46b8c6e75728 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:39.122035) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:39.122613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:39.122923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:39.173067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:39.173345) ========= 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=836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 08:01:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-06-07 08:01:39 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154207 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:39.341018) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:39.341330) ========= 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=836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018641 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:39.390556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:39.390883) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c76c7484b9a9ee6855a57b9b04c46b8c6e75728 --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 5c76c7484b9a9ee6855a57b9b04c46b8c6e75728 --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=836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 08:01:39,689 truncating revision to first 12 chars 2016-06-07 08:01:39,690 Setting DEBUG logging. 2016-06-07 08:01:39,690 attempt 1/10 2016-06-07 08:01:39,690 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c76c7484b9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 08:01:40,046 unpacking tar archive at: fx-team-5c76c7484b9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668742 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:40.075012) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:40.075590) ========= script_repo_revision: 5c76c7484b9a9ee6855a57b9b04c46b8c6e75728 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:40.076275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:40.076761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 08:01:40.088706) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-07 08:01:40.089334) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:01:40 INFO - MultiFileLogger online at 20160607 08:01:40 in /builds/slave/test 08:01:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:01:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:01:40 INFO - {'append_to_log': False, 08:01:40 INFO - 'base_work_dir': '/builds/slave/test', 08:01:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:01:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:01:40 INFO - 'branch': 'Fx-Team-Non-PGO', 08:01:40 INFO - 'buildbot_json_path': 'buildprops.json', 08:01:40 INFO - 'config_files': ('talos/linux_config.py',), 08:01:40 INFO - 'default_actions': ('clobber', 08:01:40 INFO - 'read-buildbot-config', 08:01:40 INFO - 'download-and-extract', 08:01:40 INFO - 'populate-webroot', 08:01:40 INFO - 'create-virtualenv', 08:01:40 INFO - 'install', 08:01:40 INFO - 'run-tests'), 08:01:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:01:40 INFO - 'download_minidump_stackwalk': True, 08:01:40 INFO - 'download_symbols': 'ondemand', 08:01:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:01:40 INFO - 'tooltool.py': '/tools/tooltool.py', 08:01:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:01:40 INFO - '/tools/misc-python/virtualenv.py')}, 08:01:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:01:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:01:40 INFO - 'installer_path': 'installer.exe', 08:01:40 INFO - 'log_level': 'info', 08:01:40 INFO - 'log_name': 'talos', 08:01:40 INFO - 'log_to_console': True, 08:01:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:01:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:01:40 INFO - 'opt_config_files': (), 08:01:40 INFO - 'pip_index': False, 08:01:40 INFO - 'sps_profile': False, 08:01:40 INFO - 'sps_profile_interval': 0, 08:01:40 INFO - 'suite': 'dromaeojs-e10s', 08:01:40 INFO - 'system_bits': '32', 08:01:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:01:40 INFO - 'title': 'talos-linux64-ix-028', 08:01:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:01:40 INFO - 'use_talos_json': True, 08:01:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:01:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:01:40 INFO - 'work_dir': 'build'} 08:01:40 INFO - ##### 08:01:40 INFO - ##### Running clobber step. 08:01:40 INFO - ##### 08:01:40 INFO - Running pre-action listener: _resource_record_pre_action 08:01:40 INFO - Running main action method: clobber 08:01:40 INFO - rmtree: /builds/slave/test/build 08:01:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:01:40 INFO - Running post-action listener: _resource_record_post_action 08:01:40 INFO - ##### 08:01:40 INFO - ##### Finished clobber step (success) 08:01:40 INFO - ##### 08:01:40 INFO - ##### 08:01:40 INFO - ##### Running read-buildbot-config step. 08:01:40 INFO - ##### 08:01:40 INFO - Running pre-action listener: _resource_record_pre_action 08:01:40 INFO - Running main action method: read_buildbot_config 08:01:40 INFO - Using buildbot properties: 08:01:40 INFO - { 08:01:40 INFO - "project": "", 08:01:40 INFO - "product": "firefox", 08:01:40 INFO - "script_repo_revision": "production", 08:01:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:01:40 INFO - "repository": "", 08:01:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:01:40 INFO - "buildid": "20160607065130", 08:01:40 INFO - "pgo_build": "False", 08:01:40 INFO - "basedir": "/builds/slave/test", 08:01:40 INFO - "buildnumber": 1565, 08:01:40 INFO - "slavename": "talos-linux64-ix-028", 08:01:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:01:40 INFO - "platform": "ubuntu64_hw", 08:01:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:01:40 INFO - "branch": "fx-team", 08:01:40 INFO - "repo_path": "integration/fx-team", 08:01:40 INFO - "revision": "5c76c7484b9a9ee6855a57b9b04c46b8c6e75728", 08:01:40 INFO - "stage_platform": "linux64", 08:01:40 INFO - "builduid": "451196e533b340df8861c5fce5082aa2", 08:01:40 INFO - "slavebuilddir": "test" 08:01:40 INFO - } 08:01:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:01:40 INFO - Running post-action listener: _resource_record_post_action 08:01:40 INFO - ##### 08:01:40 INFO - ##### Finished read-buildbot-config step (success) 08:01:40 INFO - ##### 08:01:40 INFO - ##### 08:01:40 INFO - ##### Running download-and-extract step. 08:01:40 INFO - ##### 08:01:40 INFO - Running pre-action listener: _resource_record_pre_action 08:01:40 INFO - Running main action method: download_and_extract 08:01:40 INFO - mkdir: /builds/slave/test/build/tests 08:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:40 INFO - https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/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 08:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/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 08:01:41 INFO - Downloaded 1361 bytes. 08:01:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:01:41 INFO - Using the following test package requirements: 08:01:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:01:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:01:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:41 INFO - u'jsshell-linux-x86_64.zip'], 08:01:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:01:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:01:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:01:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:01:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:01:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:41 INFO - https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/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 08:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/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 08:01:46 INFO - Downloaded 22873824 bytes. 08:01:46 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'] 08:01:46 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 08:01:47 INFO - Return code: 0 08:01:47 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 08:01: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')]} 08:01:47 INFO - https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:01:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:01:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/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 08:01:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/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 08:01:58 INFO - Downloaded 22873824 bytes. 08:01:58 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'] 08:01:58 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 08:02:00 INFO - Return code: 0 08:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:00 INFO - https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:02:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:02:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:02:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/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 08:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/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 08:02:01 INFO - Downloaded 10833369 bytes. 08:02:01 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'] 08:02:01 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 08:02:01 INFO - Return code: 0 08:02:01 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')]} 08:02:01 INFO - https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:02:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:02:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:02:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/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 08:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/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 08:02:02 INFO - Downloaded 55206486 bytes. 08:02:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:02:02 INFO - mkdir: /builds/slave/test/properties 08:02:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:02:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:02:02 INFO - Contents: 08:02:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:02:03 INFO - Running post-action listener: _resource_record_post_action 08:02:03 INFO - Running post-action listener: set_extra_try_arguments 08:02:03 INFO - ##### 08:02:03 INFO - ##### Finished download-and-extract step (success) 08:02:03 INFO - ##### 08:02:03 INFO - ##### 08:02:03 INFO - ##### Running populate-webroot step. 08:02:03 INFO - ##### 08:02:03 INFO - Running pre-action listener: _resource_record_pre_action 08:02:03 INFO - Running main action method: populate_webroot 08:02:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:02:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:02:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:02:03 INFO - '--tppagecycles', 08:02:03 INFO - '7'], 08:02:03 INFO - 'tests': ['tsvgm']}}, 08:02:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:02:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:02:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:02:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:02:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:02:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:02:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:03 INFO - 'talos_options': ['--disable-e10s'], 08:02:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:03 INFO - 'talos_options': ['--disable-e10s'], 08:02:03 INFO - 'tests': ['damp', 'tps']}, 08:02:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:03 INFO - 'tests': ['damp', 'tps']}, 08:02:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:02:03 INFO - 'tests': ['dromaeo_dom']}, 08:02:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:02:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:02:03 INFO - 'tests': ['a11yr', 08:02:03 INFO - 'ts_paint', 08:02:03 INFO - 'tpaint', 08:02:03 INFO - 'sessionrestore', 08:02:03 INFO - 'sessionrestore_no_auto_restore', 08:02:03 INFO - 'tabpaint']}, 08:02:03 INFO - 'other-e10s': {'tests': ['a11yr', 08:02:03 INFO - 'ts_paint', 08:02:03 INFO - 'tpaint', 08:02:03 INFO - 'sessionrestore', 08:02:03 INFO - 'sessionrestore_no_auto_restore', 08:02:03 INFO - 'tabpaint']}, 08:02:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:02:03 INFO - 'ts_paint', 08:02:03 INFO - 'tpaint', 08:02:03 INFO - 'sessionrestore', 08:02:03 INFO - 'sessionrestore_no_auto_restore', 08:02:03 INFO - 'tabpaint']}, 08:02:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:02:03 INFO - 'ts_paint', 08:02:03 INFO - 'tpaint', 08:02:03 INFO - 'sessionrestore', 08:02:03 INFO - 'sessionrestore_no_auto_restore', 08:02:03 INFO - 'tabpaint']}, 08:02:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:02:03 INFO - 'tests': ['a11yr', 08:02:03 INFO - 'ts_paint', 08:02:03 INFO - 'tpaint', 08:02:03 INFO - 'sessionrestore', 08:02:03 INFO - 'sessionrestore_no_auto_restore', 08:02:03 INFO - 'tabpaint']}, 08:02:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:02:03 INFO - 'tests': ['a11yr', 08:02:03 INFO - 'ts_paint', 08:02:03 INFO - 'tpaint', 08:02:03 INFO - 'sessionrestore', 08:02:03 INFO - 'sessionrestore_no_auto_restore', 08:02:03 INFO - 'tabpaint']}, 08:02:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:02:03 INFO - 'tests': ['tsvgx', 08:02:03 INFO - 'tsvgr_opacity', 08:02:03 INFO - 'tart', 08:02:03 INFO - 'tscrollx', 08:02:03 INFO - 'cart']}, 08:02:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:02:03 INFO - 'tsvgr_opacity', 08:02:03 INFO - 'tart', 08:02:03 INFO - 'tscrollx', 08:02:03 INFO - 'cart']}, 08:02:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:03 INFO - 'talos_options': ['--disable-e10s'], 08:02:03 INFO - 'tests': ['tp5o']}, 08:02:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:03 INFO - 'tests': ['tp5o']}, 08:02:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:03 INFO - 'talos_options': ['--disable-e10s', 08:02:03 INFO - '--xperf_path', 08:02:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:03 INFO - 'tests': ['tp5n']}, 08:02:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:03 INFO - 'talos_options': ['--xperf_path', 08:02:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:03 INFO - 'tests': ['tp5n']}}, 08:02:03 INFO - 'talos.zip': {'path': '', 08:02:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:02:03 INFO - Running post-action listener: _resource_record_post_action 08:02:03 INFO - ##### 08:02:03 INFO - ##### Finished populate-webroot step (success) 08:02:03 INFO - ##### 08:02:03 INFO - ##### 08:02:03 INFO - ##### Running create-virtualenv step. 08:02:03 INFO - ##### 08:02:03 INFO - Running pre-action listener: _resource_record_pre_action 08:02:03 INFO - Running main action method: create_virtualenv 08:02:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:02:03 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 08:02:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:02:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:02:03 INFO - Using real prefix '/usr' 08:02:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:02:04 INFO - Installing distribute.............................................................................................................................................................................................done. 08:02:06 INFO - Installing pip.................done. 08:02:06 INFO - Return code: 0 08:02:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:02:06 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')]} 08:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:06 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')]} 08:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:06 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 0x7fa366d56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f1c0>, '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 0x29700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970550>, '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': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', '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 08:02:06 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 08:02:06 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 08:02:06 INFO - Using env: {'DISPLAY': ':0', 08:02:06 INFO - 'HOME': '/home/cltbld', 08:02:06 INFO - 'LANG': 'en_US.UTF-8', 08:02:06 INFO - 'LANGUAGE': 'en_US:en', 08:02:06 INFO - 'LOGNAME': 'cltbld', 08:02:06 INFO - 'MAIL': '/var/mail/cltbld', 08:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:06 INFO - 'MOZ_NO_REMOTE': '1', 08:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:06 INFO - 'NO_EM_RESTART': '1', 08:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:06 INFO - 'PWD': '/builds/slave/test', 08:02:06 INFO - 'SHELL': '/bin/bash', 08:02:06 INFO - 'SHLVL': '1', 08:02:06 INFO - 'TERM': 'linux', 08:02:06 INFO - 'TMOUT': '86400', 08:02:06 INFO - 'USER': 'cltbld', 08:02:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', 08:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:06 INFO - '_': '/tools/buildbot/bin/python'} 08:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:06 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 08:02:06 INFO - Cleaning up... 08:02:06 INFO - Return code: 0 08:02:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:02:06 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')]} 08:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:06 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')]} 08:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:06 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 0x7fa366d56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f1c0>, '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 0x29700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970550>, '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': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', '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 08:02:06 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 08:02:06 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 08:02:06 INFO - Using env: {'DISPLAY': ':0', 08:02:06 INFO - 'HOME': '/home/cltbld', 08:02:06 INFO - 'LANG': 'en_US.UTF-8', 08:02:06 INFO - 'LANGUAGE': 'en_US:en', 08:02:06 INFO - 'LOGNAME': 'cltbld', 08:02:06 INFO - 'MAIL': '/var/mail/cltbld', 08:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:06 INFO - 'MOZ_NO_REMOTE': '1', 08:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:06 INFO - 'NO_EM_RESTART': '1', 08:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:06 INFO - 'PWD': '/builds/slave/test', 08:02:06 INFO - 'SHELL': '/bin/bash', 08:02:06 INFO - 'SHLVL': '1', 08:02:06 INFO - 'TERM': 'linux', 08:02:06 INFO - 'TMOUT': '86400', 08:02:06 INFO - 'USER': 'cltbld', 08:02:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', 08:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:06 INFO - '_': '/tools/buildbot/bin/python'} 08:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:06 INFO - Downloading/unpacking psutil>=3.1.1 08:02:06 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 08:02:06 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 08:02:06 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 08:02:06 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 08:02:06 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 08:02:06 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 08:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:02:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:08 INFO - Installing collected packages: psutil 08:02:08 INFO - Running setup.py install for psutil 08:02:08 INFO - building 'psutil._psutil_linux' extension 08:02:08 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 08:02:09 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 08:02:09 INFO - building 'psutil._psutil_posix' extension 08:02:09 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 08:02:09 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 08:02:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:09 INFO - Successfully installed psutil 08:02:09 INFO - Cleaning up... 08:02:09 INFO - Return code: 0 08:02:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa366d56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f1c0>, '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 0x29700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970550>, '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': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', '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 08:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:02:09 INFO - Using env: {'DISPLAY': ':0', 08:02:09 INFO - 'HOME': '/home/cltbld', 08:02:09 INFO - 'LANG': 'en_US.UTF-8', 08:02:09 INFO - 'LANGUAGE': 'en_US:en', 08:02:09 INFO - 'LOGNAME': 'cltbld', 08:02:09 INFO - 'MAIL': '/var/mail/cltbld', 08:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:09 INFO - 'MOZ_NO_REMOTE': '1', 08:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:09 INFO - 'NO_EM_RESTART': '1', 08:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:09 INFO - 'PWD': '/builds/slave/test', 08:02:09 INFO - 'SHELL': '/bin/bash', 08:02:09 INFO - 'SHLVL': '1', 08:02:09 INFO - 'TERM': 'linux', 08:02:09 INFO - 'TMOUT': '86400', 08:02:09 INFO - 'USER': 'cltbld', 08:02:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', 08:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:09 INFO - '_': '/tools/buildbot/bin/python'} 08:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:02:09 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 08:02:09 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 08:02:09 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 08:02:09 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 08:02:09 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 08:02:09 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 08:02:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:02:11 INFO - Installing collected packages: mozsystemmonitor 08:02:11 INFO - Running setup.py install for mozsystemmonitor 08:02:11 INFO - Successfully installed mozsystemmonitor 08:02:11 INFO - Cleaning up... 08:02:11 INFO - Return code: 0 08:02:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:11 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 0x7fa366d56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f1c0>, '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 0x29700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970550>, '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': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', '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 08:02:11 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 08:02:11 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 08:02:11 INFO - Using env: {'DISPLAY': ':0', 08:02:11 INFO - 'HOME': '/home/cltbld', 08:02:11 INFO - 'LANG': 'en_US.UTF-8', 08:02:11 INFO - 'LANGUAGE': 'en_US:en', 08:02:11 INFO - 'LOGNAME': 'cltbld', 08:02:11 INFO - 'MAIL': '/var/mail/cltbld', 08:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:11 INFO - 'MOZ_NO_REMOTE': '1', 08:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:11 INFO - 'NO_EM_RESTART': '1', 08:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:11 INFO - 'PWD': '/builds/slave/test', 08:02:11 INFO - 'SHELL': '/bin/bash', 08:02:11 INFO - 'SHLVL': '1', 08:02:11 INFO - 'TERM': 'linux', 08:02:11 INFO - 'TMOUT': '86400', 08:02:11 INFO - 'USER': 'cltbld', 08:02:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', 08:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:11 INFO - '_': '/tools/buildbot/bin/python'} 08:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:11 INFO - Downloading/unpacking jsonschema==2.5.1 08:02:11 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 08:02:11 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 08:02:11 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 08:02:11 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 08:02:11 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 08:02:11 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 08:02:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:02:13 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 08:02:13 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 08:02:13 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 08:02:13 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 08:02:13 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 08:02:13 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 08:02:13 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:14 INFO - warning: no files found matching '*.txt' 08:02:14 INFO - no previously-included directories found matching 'build' 08:02:14 INFO - no previously-included directories found matching 'dist' 08:02:14 INFO - no previously-included directories found matching '.git*' 08:02:14 INFO - Installing collected packages: jsonschema, functools32 08:02:14 INFO - Running setup.py install for functools32 08:02:14 INFO - warning: no files found matching '*.txt' 08:02:14 INFO - no previously-included directories found matching 'build' 08:02:14 INFO - no previously-included directories found matching 'dist' 08:02:14 INFO - no previously-included directories found matching '.git*' 08:02:14 INFO - Successfully installed jsonschema functools32 08:02:14 INFO - Cleaning up... 08:02:14 INFO - Return code: 0 08:02:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:14 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 0x7fa366d56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f1c0>, '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 0x29700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970550>, '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': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', '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 08:02:14 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 08:02:14 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 08:02:14 INFO - Using env: {'DISPLAY': ':0', 08:02:14 INFO - 'HOME': '/home/cltbld', 08:02:14 INFO - 'LANG': 'en_US.UTF-8', 08:02:14 INFO - 'LANGUAGE': 'en_US:en', 08:02:14 INFO - 'LOGNAME': 'cltbld', 08:02:14 INFO - 'MAIL': '/var/mail/cltbld', 08:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:14 INFO - 'MOZ_NO_REMOTE': '1', 08:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:14 INFO - 'NO_EM_RESTART': '1', 08:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:14 INFO - 'PWD': '/builds/slave/test', 08:02:14 INFO - 'SHELL': '/bin/bash', 08:02:14 INFO - 'SHLVL': '1', 08:02:14 INFO - 'TERM': 'linux', 08:02:14 INFO - 'TMOUT': '86400', 08:02:14 INFO - 'USER': 'cltbld', 08:02:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', 08:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:14 INFO - '_': '/tools/buildbot/bin/python'} 08:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:02:14 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 08:02:14 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 08:02:14 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 08:02:14 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 08:02:14 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 08:02:14 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 08:02:16 INFO - Downloading blobuploader-1.2.4.tar.gz 08:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:02:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:02:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:17 INFO - Downloading docopt-0.6.1.tar.gz 08:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:02:17 INFO - Installing collected packages: blobuploader, requests, docopt 08:02:17 INFO - Running setup.py install for blobuploader 08:02:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:02:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:02:17 INFO - Running setup.py install for requests 08:02:17 INFO - Running setup.py install for docopt 08:02:17 INFO - Successfully installed blobuploader requests docopt 08:02:17 INFO - Cleaning up... 08:02:17 INFO - Return code: 0 08:02:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:17 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 0x7fa366d56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f1c0>, '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 0x29700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970550>, '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': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', '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 08:02:17 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 08:02:17 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 08:02:17 INFO - Using env: {'DISPLAY': ':0', 08:02:17 INFO - 'HOME': '/home/cltbld', 08:02:17 INFO - 'LANG': 'en_US.UTF-8', 08:02:17 INFO - 'LANGUAGE': 'en_US:en', 08:02:17 INFO - 'LOGNAME': 'cltbld', 08:02:17 INFO - 'MAIL': '/var/mail/cltbld', 08:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:17 INFO - 'MOZ_NO_REMOTE': '1', 08:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:17 INFO - 'NO_EM_RESTART': '1', 08:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:17 INFO - 'PWD': '/builds/slave/test', 08:02:17 INFO - 'SHELL': '/bin/bash', 08:02:17 INFO - 'SHLVL': '1', 08:02:17 INFO - 'TERM': 'linux', 08:02:17 INFO - 'TMOUT': '86400', 08:02:17 INFO - 'USER': 'cltbld', 08:02:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', 08:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:17 INFO - '_': '/tools/buildbot/bin/python'} 08:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:17 INFO - Running setup.py (path:/tmp/pip-TDa46Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:18 INFO - Running setup.py (path:/tmp/pip-9HjkJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:18 INFO - Running setup.py (path:/tmp/pip-318mHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:18 INFO - Running setup.py (path:/tmp/pip-47bv1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:18 INFO - Running setup.py (path:/tmp/pip-V6nkAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:18 INFO - Running setup.py (path:/tmp/pip-DdT7N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:18 INFO - Running setup.py (path:/tmp/pip-JV_bXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:18 INFO - Running setup.py (path:/tmp/pip-g8ctNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:18 INFO - Running setup.py (path:/tmp/pip-hvuQeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:18 INFO - Running setup.py (path:/tmp/pip-x9BKq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:18 INFO - Running setup.py (path:/tmp/pip-vz9BQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:18 INFO - Running setup.py (path:/tmp/pip-37qlJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:18 INFO - Running setup.py (path:/tmp/pip-eBGQiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:18 INFO - Running setup.py (path:/tmp/pip-Pp3j0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:18 INFO - Running setup.py (path:/tmp/pip-y21X6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:19 INFO - Running setup.py (path:/tmp/pip-dGlNqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:19 INFO - Running setup.py (path:/tmp/pip-xxQZYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:02:19 INFO - Running setup.py install for manifestparser 08:02:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:02:19 INFO - Running setup.py install for mozcrash 08:02:19 INFO - Running setup.py install for mozdebug 08:02:19 INFO - Running setup.py install for mozdevice 08:02:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:02:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:02:19 INFO - Running setup.py install for mozfile 08:02:19 INFO - Running setup.py install for mozhttpd 08:02:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:02:19 INFO - Running setup.py install for mozinfo 08:02:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:02:19 INFO - Running setup.py install for mozInstall 08:02:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:02:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:02:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:02:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:02:19 INFO - Running setup.py install for mozleak 08:02:20 INFO - Running setup.py install for mozlog 08:02:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:02:20 INFO - Running setup.py install for moznetwork 08:02:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:02:20 INFO - Running setup.py install for mozprocess 08:02:20 INFO - Running setup.py install for mozprofile 08:02:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:02:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:02:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:02:20 INFO - Running setup.py install for mozrunner 08:02:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:02:20 INFO - Running setup.py install for mozscreenshot 08:02:20 INFO - Running setup.py install for moztest 08:02:20 INFO - Running setup.py install for mozversion 08:02:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:02:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:20 INFO - Cleaning up... 08:02:20 INFO - Return code: 0 08:02:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:20 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')]} 08:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:20 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')]} 08:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:20 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 0x7fa366d56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f1c0>, '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 0x29700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970550>, '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': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', '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 08:02:20 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 08:02:20 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 08:02:20 INFO - Using env: {'DISPLAY': ':0', 08:02:20 INFO - 'HOME': '/home/cltbld', 08:02:20 INFO - 'LANG': 'en_US.UTF-8', 08:02:20 INFO - 'LANGUAGE': 'en_US:en', 08:02:20 INFO - 'LOGNAME': 'cltbld', 08:02:20 INFO - 'MAIL': '/var/mail/cltbld', 08:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:20 INFO - 'MOZ_NO_REMOTE': '1', 08:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:20 INFO - 'NO_EM_RESTART': '1', 08:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:20 INFO - 'PWD': '/builds/slave/test', 08:02:20 INFO - 'SHELL': '/bin/bash', 08:02:20 INFO - 'SHLVL': '1', 08:02:20 INFO - 'TERM': 'linux', 08:02:20 INFO - 'TMOUT': '86400', 08:02:20 INFO - 'USER': 'cltbld', 08:02:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', 08:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:20 INFO - '_': '/tools/buildbot/bin/python'} 08:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:21 INFO - Running setup.py (path:/tmp/pip-3x_Zd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:21 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)) 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:21 INFO - Running setup.py (path:/tmp/pip-Z_a5Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:21 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)) 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:21 INFO - Running setup.py (path:/tmp/pip-smCR6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:21 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)) 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:21 INFO - Running setup.py (path:/tmp/pip-Yoex5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:21 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)) 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:21 INFO - Running setup.py (path:/tmp/pip-16bCH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:21 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)) 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:21 INFO - Running setup.py (path:/tmp/pip-TNccYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:21 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)) 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:21 INFO - Running setup.py (path:/tmp/pip-ilnOVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:21 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)) 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:21 INFO - Running setup.py (path:/tmp/pip-6FWdF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:21 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)) 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:21 INFO - Running setup.py (path:/tmp/pip-dRt8RR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:21 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)) 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:21 INFO - Running setup.py (path:/tmp/pip-jE98Xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:21 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)) 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:21 INFO - Running setup.py (path:/tmp/pip-9IovIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:21 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)) 08:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:22 INFO - Running setup.py (path:/tmp/pip-RP0lxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:22 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)) 08:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:22 INFO - Running setup.py (path:/tmp/pip-QHXZvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:22 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)) 08:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:22 INFO - Running setup.py (path:/tmp/pip-YC60k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:22 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)) 08:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:22 INFO - Running setup.py (path:/tmp/pip-2grzBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:22 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)) 08:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:22 INFO - Running setup.py (path:/tmp/pip-DCXsTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:22 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)) 08:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:22 INFO - Running setup.py (path:/tmp/pip-fcT7N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:22 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)) 08:02:22 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)) 08:02:22 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)) 08:02:22 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)) 08:02:22 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)) 08:02:22 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)) 08:02:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:02:22 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 08:02:22 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 08:02:22 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 08:02:22 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 08:02:22 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 08:02:22 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 08:02:24 INFO - Downloading blessings-1.6.tar.gz 08:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:24 INFO - Installing collected packages: blessings 08:02:24 INFO - Running setup.py install for blessings 08:02:24 INFO - Successfully installed blessings 08:02:24 INFO - Cleaning up... 08:02:24 INFO - Return code: 0 08:02:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:24 INFO - Reading from file tmpfile_stdout 08:02:24 INFO - Current package versions: 08:02:24 INFO - argparse == 1.2.1 08:02:24 INFO - blessings == 1.6 08:02:24 INFO - blobuploader == 1.2.4 08:02:24 INFO - docopt == 0.6.1 08:02:24 INFO - functools32 == 3.2.3-2 08:02:24 INFO - jsonschema == 2.5.1 08:02:24 INFO - manifestparser == 1.1 08:02:24 INFO - mozInstall == 1.12 08:02:24 INFO - mozcrash == 0.17 08:02:24 INFO - mozdebug == 0.1 08:02:24 INFO - mozdevice == 0.48 08:02:24 INFO - mozfile == 1.2 08:02:24 INFO - mozhttpd == 0.7 08:02:24 INFO - mozinfo == 0.9 08:02:24 INFO - mozleak == 0.1 08:02:24 INFO - mozlog == 3.2 08:02:24 INFO - moznetwork == 0.27 08:02:24 INFO - mozprocess == 0.22 08:02:24 INFO - mozprofile == 0.28 08:02:24 INFO - mozrunner == 6.11 08:02:24 INFO - mozscreenshot == 0.1 08:02:24 INFO - mozsystemmonitor == 0.3 08:02:24 INFO - moztest == 0.7 08:02:24 INFO - mozversion == 1.4 08:02:24 INFO - psutil == 3.1.1 08:02:24 INFO - requests == 1.2.3 08:02:24 INFO - wsgiref == 0.1.2 08:02:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:24 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')]} 08:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 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')]} 08:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 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 0x7fa366d56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f1c0>, '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 0x29700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970550>, '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': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', '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 08:02:24 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 08:02:24 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 08:02:24 INFO - Using env: {'DISPLAY': ':0', 08:02:24 INFO - 'HOME': '/home/cltbld', 08:02:24 INFO - 'LANG': 'en_US.UTF-8', 08:02:24 INFO - 'LANGUAGE': 'en_US:en', 08:02:24 INFO - 'LOGNAME': 'cltbld', 08:02:24 INFO - 'MAIL': '/var/mail/cltbld', 08:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:24 INFO - 'MOZ_NO_REMOTE': '1', 08:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:24 INFO - 'NO_EM_RESTART': '1', 08:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:24 INFO - 'PWD': '/builds/slave/test', 08:02:24 INFO - 'SHELL': '/bin/bash', 08:02:24 INFO - 'SHLVL': '1', 08:02:24 INFO - 'TERM': 'linux', 08:02:24 INFO - 'TMOUT': '86400', 08:02:24 INFO - 'USER': 'cltbld', 08:02:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', 08:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:24 INFO - '_': '/tools/buildbot/bin/python'} 08:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:24 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)) 08:02:24 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)) 08:02:24 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)) 08:02:24 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)) 08:02:24 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)) 08:02:24 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)) 08:02:24 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)) 08:02:24 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)) 08:02:24 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)) 08:02:24 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)) 08:02:24 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)) 08:02:24 INFO - Cleaning up... 08:02:24 INFO - Return code: 0 08:02:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:02:24 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')]} 08:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 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')]} 08:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:24 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 0x7fa366d56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f1c0>, '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 0x29700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970550>, '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': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', '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 08:02:25 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 08:02:25 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 08:02:25 INFO - Using env: {'DISPLAY': ':0', 08:02:25 INFO - 'HOME': '/home/cltbld', 08:02:25 INFO - 'LANG': 'en_US.UTF-8', 08:02:25 INFO - 'LANGUAGE': 'en_US:en', 08:02:25 INFO - 'LOGNAME': 'cltbld', 08:02:25 INFO - 'MAIL': '/var/mail/cltbld', 08:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:25 INFO - 'MOZ_NO_REMOTE': '1', 08:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:25 INFO - 'NO_EM_RESTART': '1', 08:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:25 INFO - 'PWD': '/builds/slave/test', 08:02:25 INFO - 'SHELL': '/bin/bash', 08:02:25 INFO - 'SHLVL': '1', 08:02:25 INFO - 'TERM': 'linux', 08:02:25 INFO - 'TMOUT': '86400', 08:02:25 INFO - 'USER': 'cltbld', 08:02:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', 08:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:25 INFO - '_': '/tools/buildbot/bin/python'} 08:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:02:25 INFO - Cleaning up... 08:02:25 INFO - Return code: 0 08:02:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:02:25 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')]} 08:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:25 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')]} 08:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:25 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 0x7fa366d56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f1c0>, '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 0x29700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970550>, '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': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', '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 08:02:25 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 08:02:25 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 08:02:25 INFO - Using env: {'DISPLAY': ':0', 08:02:25 INFO - 'HOME': '/home/cltbld', 08:02:25 INFO - 'LANG': 'en_US.UTF-8', 08:02:25 INFO - 'LANGUAGE': 'en_US:en', 08:02:25 INFO - 'LOGNAME': 'cltbld', 08:02:25 INFO - 'MAIL': '/var/mail/cltbld', 08:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:25 INFO - 'MOZ_NO_REMOTE': '1', 08:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:25 INFO - 'NO_EM_RESTART': '1', 08:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:25 INFO - 'PWD': '/builds/slave/test', 08:02:25 INFO - 'SHELL': '/bin/bash', 08:02:25 INFO - 'SHLVL': '1', 08:02:25 INFO - 'TERM': 'linux', 08:02:25 INFO - 'TMOUT': '86400', 08:02:25 INFO - 'USER': 'cltbld', 08:02:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', 08:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:25 INFO - '_': '/tools/buildbot/bin/python'} 08:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:25 INFO - Downloading/unpacking flake8 08:02:25 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 08:02:25 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 08:02:25 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 08:02:25 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 08:02:25 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 08:02:25 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 08:02:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:02:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:02:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 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 08:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:02:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:02:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:02:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:02:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:02:28 INFO - no previously-included directories found matching 'docs/_build' 08:02:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:02:28 INFO - Running setup.py install for pep8 08:02:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:02:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:02:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:02:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:02:28 INFO - no previously-included directories found matching 'docs/_build' 08:02:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:02:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:02:28 INFO - Cleaning up... 08:02:28 INFO - Return code: 0 08:02:28 INFO - Running post-action listener: _resource_record_post_action 08:02:28 INFO - Running post-action listener: _start_resource_monitoring 08:02:28 INFO - Starting resource monitoring. 08:02:28 INFO - ##### 08:02:28 INFO - ##### Finished create-virtualenv step (success) 08:02:28 INFO - ##### 08:02:28 INFO - ##### 08:02:28 INFO - ##### Running install step. 08:02:28 INFO - ##### 08:02:28 INFO - Running pre-action listener: _resource_record_pre_action 08:02:28 INFO - Running main action method: install 08:02:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:28 INFO - Reading from file tmpfile_stdout 08:02:28 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:02:28 INFO - Reading from file tmpfile_stdout 08:02:28 INFO - Output received: 08:02:28 INFO - Usage: mozinstall [options] installer 08:02:28 INFO - Options: 08:02:28 INFO - -h, --help show this help message and exit 08:02:28 INFO - -d DEST, --destination=DEST 08:02:28 INFO - Directory to install application into. [default: 08:02:28 INFO - "/builds/slave/test"] 08:02:28 INFO - --app=APP Application being installed. [default: firefox] 08:02:28 INFO - mkdir: /builds/slave/test/build/application 08:02:28 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'] 08:02:28 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 08:02:44 INFO - Reading from file tmpfile_stdout 08:02:44 INFO - Output received: 08:02:44 INFO - /builds/slave/test/build/application/firefox/firefox 08:02:44 INFO - Running post-action listener: _resource_record_post_action 08:02:44 INFO - ##### 08:02:44 INFO - ##### Finished install step (success) 08:02:44 INFO - ##### 08:02:44 INFO - ##### 08:02:44 INFO - ##### Running run-tests step. 08:02:44 INFO - ##### 08:02:44 INFO - Running pre-action listener: _resource_record_pre_action 08:02:44 INFO - Running main action method: run_tests 08:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:02:44 INFO - Python 2.7.3 08:02:44 INFO - Return code: 0 08:02:44 INFO - grabbing minidump binary from tooltool 08:02: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')]} 08:02:44 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 0x296f1c0>, '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 0x29700c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:02:44 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 08:02:44 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 08:02:44 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 08:02:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:02:44 INFO - Return code: 0 08:02:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:02:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:02:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:02:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:02:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:02:45 INFO - Return code: 0 08:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 08:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 08:02:45 INFO - Using env: {'DISPLAY': ':0', 08:02:45 INFO - 'HOME': '/home/cltbld', 08:02:45 INFO - 'LANG': 'en_US.UTF-8', 08:02:45 INFO - 'LANGUAGE': 'en_US:en', 08:02:45 INFO - 'LOGNAME': 'cltbld', 08:02:45 INFO - 'MAIL': '/var/mail/cltbld', 08:02:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:02:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:45 INFO - 'MOZ_NO_REMOTE': '1', 08:02:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:45 INFO - 'NO_EM_RESTART': '1', 08:02:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:45 INFO - 'PWD': '/builds/slave/test', 08:02:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:02:45 INFO - 'SHELL': '/bin/bash', 08:02:45 INFO - 'SHLVL': '1', 08:02:45 INFO - 'TERM': 'linux', 08:02:45 INFO - 'TMOUT': '86400', 08:02:45 INFO - 'USER': 'cltbld', 08:02:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035', 08:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:45 INFO - '_': '/tools/buildbot/bin/python'} 08:02:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 08:02:45 INFO - mozversion application_buildid: 20160607065130 08:02:45 INFO - mozversion application_changeset: 5c76c7484b9a9ee6855a57b9b04c46b8c6e75728 08:02:45 INFO - mozversion application_display_name: Nightly 08:02:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:02:45 INFO - mozversion application_name: Firefox 08:02:45 INFO - mozversion application_remotingname: firefox 08:02:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:02:45 INFO - mozversion application_vendor: Mozilla 08:02:45 INFO - mozversion application_version: 50.0a1 08:02:45 INFO - mozversion platform_buildid: 20160607065130 08:02:45 INFO - mozversion platform_changeset: 5c76c7484b9a9ee6855a57b9b04c46b8c6e75728 08:02:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:02:45 INFO - mozversion platform_version: 50.0a1 08:02:45 INFO - using testdate: 1465311765 08:02:45 INFO - actual date: 1465311765 08:02:45 INFO - starting webserver on 'localhost:58318' 08:02:45 INFO - SUITE-START | Running 2 tests 08:02:45 INFO - TEST-START | dromaeo_css 08:02:45 INFO - operating with platform_type : linux_ 08:02:45 INFO - Initialising browser for dromaeo_css test... 08:02:45 INFO - TEST-INFO | started process 25719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Cocxl/profile http://localhost:58318/getInfo.html) 08:02:50 INFO - PROCESS | 25719 | __metrics Screen width/height:1600/1200 08:02:50 INFO - PROCESS | 25719 | colorDepth:24 08:02:50 INFO - PROCESS | 25719 | Browser inner width/height: 1024/697 08:02:50 INFO - PROCESS | 25719 | __metrics 08:02:51 ERROR - PROCESS | 25719 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 08:02:52 INFO - TEST-INFO | 25719: exit 0 08:02:52 INFO - Browser initialized. 08:02:52 INFO - Running cycle 1/1 for dromaeo_css test... 08:02:52 INFO - TEST-INFO | started process 25839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Cocxl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:04 INFO - PROCESS | 25839 | RSS: Main: 168067072 08:03:04 INFO - PROCESS | 25839 | 08:03:54 INFO - PROCESS | 25839 | 1465311834234 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] 08:06:06 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:58318/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58318/tests/dromaeo/cssquery-ext.html) 08:06:07 INFO - PROCESS | 25839 | RSS: Main: 170528768 08:06:07 INFO - PROCESS | 25839 | 08:09:09 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:58318/tests/dromaeo/cssquery-ext.html (next: http://localhost:58318/tests/dromaeo/cssquery-jquery.html) 08:09:09 INFO - PROCESS | 25839 | RSS: Main: 169684992 08:09:09 INFO - PROCESS | 25839 | 08:12:11 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:58318/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58318/tests/dromaeo/cssquery-mootools.html) 08:12:12 INFO - PROCESS | 25839 | RSS: Main: 170926080 08:12:12 INFO - PROCESS | 25839 | 08:15:14 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:58318/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58318/tests/dromaeo/cssquery-prototype.html) 08:15:15 INFO - PROCESS | 25839 | RSS: Main: 169185280 08:15:15 INFO - PROCESS | 25839 | 08:18:17 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:58318/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58318/tests/dromaeo/cssquery-yui.html) 08:18:18 INFO - PROCESS | 25839 | RSS: Main: 169893888 08:18:18 INFO - PROCESS | 25839 | 08:21:20 INFO - PROCESS | 25839 | Cycle 1(1): loaded http://localhost:58318/tests/dromaeo/cssquery-yui.html (next: http://localhost:58318/tests/dromaeo/cssquery-dojo.html) 08:21:21 INFO - PROCESS | 25839 | RSS: Main: 171835392 08:21:21 INFO - PROCESS | 25839 | 08:21:21 INFO - PROCESS | 25839 | __start_tp_report 08:21:21 INFO - PROCESS | 25839 | _x_x_mozilla_page_load 08:21:21 INFO - PROCESS | 25839 | _x_x_mozilla_page_load_details 08:21:21 INFO - PROCESS | 25839 | |i|pagename|runs| 08:21:21 INFO - PROCESS | 25839 | |0;dojo.html;2607.0875193682214;2662.480816240834;2666.280104371819;2668.959965600516;2684.691260505041;4634;4650.790714417851;4656.161890859644;4796.2086255767845;4818.204996175627;4700.788464519096;4786.904261914759;4790.568848803607;4814.590759785414;4823.541763532458;4353.86938391848;4419.403380543634;4485.237509623372;4517.09658068386;4517.593416592506;559.9574071523442;4322.157179350028;4409.4047303613925;4421.0494743630115;4421.270490369086;4434.889127771799;4438.334249862514;4445.8221671133115;4448.621867141297;4516.390287311204;4446.7998940047455;4475.440569928759;4484.327350897359;4484.775761211927;4533.795979180912;4337.327714204303;4375.846845360397;4383.8684839454545;4385.6710746694125;4389.473263208403;4649.5350464953235;4682.391289132425;4708.152532544141;4736.64475164364;4739.336492890998;5084.923726144111;5173.560247378978;5197.350331208599;5204.219367094928;5234.345706786652;5132.281480592683;5217;5221.791128354899;5232.136697444955;5264;4823.9517604824205;4866.732329721864;4869.975650121727;4884.0476107159475;4921.434035085939;5293.973530132324;5305.495977882095;5342.6260161788305;5343.011542864505;5356.651817631841;5132.8460146195675;5153.768080436389;5155.407128180307;5156.896862062813;5163;5210.270562121306;5234.607404444682;5251.10731175701;5264.684118952875;5269.762860671279;4984.700917944935;5062.265971434122;5090.363704536933;5120.103981803244;5134.691918484903;5104.03023425548;5133.076046311625;5133.383993920754;5134.127198376285;5176.275321454999;4310.418093557392;4384.539623339567;4401.713888597231;4422.867313980586;4457.64338852891;3776.546814382237;3803.54357477099;3805.6574908257835;3839.6544311012144;3844.7116466265143;4363.105563359503;4375.971646663032;4381.408509851193;4394.868153955386;4425.402570652985;5168.767405466763;5183.81856635016;5186.351706036746;5194.22086687;5224.242484839753;4305.268104422255;4386.8025938832825;4417.845375411845;4439.578240067189;4447.844325448594;4661.906761864744;4665.393498845128;4673.042026384583;4673.135469938073;4720.95279047212;4639.072185562968;4789.736564488987;4824.445188803333;4833.226683730657;4846.321514987834;5038.244263360525;5082.491750824888;5152.948470515247;5182.274481572658;5263.000029994442;4829.5653391193555;4836.371271734652;4844.588210002189;4846.491118432514;4878.048780487771;5100.413452453015;5103.948960510347;5124.923126153036;5130.538251557377;5160.200168973815;5031.069252188357;5067.949320506747;5147.536721695065;5147.794088236578;5186.273921651047;5019.824306149268;5031.169856973558;5043.420006699276;5054.241863720325;5107.387113546398;4838.661293709407;5057.949420505748;5058.9494105058475;5062.594992400673;5069.960658065162;4863.148948933852;4867.853964381075;4884.8046078157895;4895.143349913822;4920.089783390084;5067.949320506747;5068;5075.264086707481;5087;5093.745312734422;4812.230043193073;4947.925781113214;4961.8511444656715;4994.5754610858485;5032.3206367139965 08:21:21 INFO - PROCESS | 25839 | |1;ext.html;541.3012882970663;577.3014652270753;594.0762114911311;595.6872641863022;602.0848310567935;34601.65398346016;38778.61221387785;38918;38939.80530097352;38941.41587876184;38756.22487550247;39628.60371396285;39700.80149599255;39749.40375894364;39751;7639.236076392344;7769.961150194241;7787.143414224431;7795.298423141916;7819.296263336299;7713.498622589514;7765.378769698439;7772.766816995471;7779.2998630123275;7812.062552493709;7763.107242667109;7808.336291415237;7814.0623125224765;7834.843303133934;7849.489783164105;7732.342750866183;7751.496152750082;7792;7821.569813660247;7823.10034346049;7620.161782203953;7724.304812566896;7731.265529774662;7736;7763;34293.14267143316;34308.656913430794;34480;34497.31005379903;34528.30943381143;2893.9276518087004;3067.2025273428844;3124.3438877835683;3300.8475417320174;3497.9825100874586;28500.714992850222;28759.42481150386;28877.56683649747;29189;29378.85310573455;3283.770136090475;3291.2265617580088;3298.983505082459;3315.436375816117;3320.4023275810346;241952;243457;243824;245632.99999999822;246654;32219.35561288761;33219.3356132876;52610;52775.47224527782;52823.73588132112;33478;33747.13149382281;33847.83076084604;33966.660333396845;34031;13617.387217575233;13808.585742427744;13814.240216787972;13858.792118118236;13924.651883702785;10552.894471055344;10577.100946419487;10585.100266477435;10595.09941654968;10618.203634727271;7897.644605992744;7916.089649690244;7933.087694915159;7978.960105199553;7999.3200577950365;3119.906402807919;3125.5311703244697;3133.5143052826847;3139.1681204480833;3141.513065474855;903.4579252448478;908.7864351877304;940.1303793990668;970.3256236915418;1000.8248556502583;26821;28325.43349133006;28624.713752862204;28717.425651486854;28776;965.9227261819037;984.7291994701515;986.8815742110993;1000.1898462245459;1028.341861208827;14584.708305833823;14740.336684849208;14817.481388151364;15102.471413500474;15231.695366092838;392302;394242;395825;396000;396393;48751;48944.26583601249;49111.50888491069;49115;49288.260676089885;1185.2769810415639;1201.9399030048462;1206.1135065726685;1207.8429804125408;1231.1074471008446;26885.596716048884;27710.722892770813;28026.159215223575;28055.158345249674;28556.143315700563;43768;43770.78114609534;44089;44147;44151.558484414745;332147;333000;333178;334658;335840;25244.74755252424;25255.242342729747;25430.872845635655;25543.489130217662;26140.477190456466;41914.37128443137;42473;42702.78648606737;42746;43442;35543.82228088843;36707.63292367042;36815.26369472649;36979;37073.25853482969;35461.64538354584;35636.64363356333;35783.642163579076;35817;36191.81904090463;34813.477797832544;35004.47493287552;36934.63065369312;37393.6260637401;40436.3934540988;32162.678373216906;33154;33723.32553348968;33891.4916276261;33903.32193356168;25735.613965790904;25794.871025644752;26039.218823435327;26059;26464.470710586065 08:21:21 INFO - PROCESS | 25839 | |2;jquery.html;360.30641016044126;371.9014461167791;374.6553171082605;381.8753770146918;390.4514157608559;15695.764563531557;16499.25753341101;17345.91327043363;17407.216675249612;17451.56371090722;16152.919235403806;16363;17163.91418042911;17296.30814767411;17356.305747770104;4956.380452443454;5064.848054558369;5152;5154.098032844256;5156.355455568054;3724.9813750931207;5088.211327244265;5608.747606357703;5930.051191809312;5935.28776546815;5940.04959206527;5941.792037278696;5977.641341519501;5978.551608629348;5993.041113421853;5716;5851.853703657422;5881.088431293157;5882.205902203191;5888.970555147197;4509.368688383629;5167.819126330561;5171.276021357013;5185.922211166798;5188.481151884819;11638.127140464414;12159;12272.877271227262;12281;12308.692282693004;1710.538154698237;1762.2510433065895;1788.803231644518;1796.5778042160082;1826.6985947318676;8620.525871077089;8648.264897483721;9009.954950225207;9202.631894724203;9357.398428854243;1640.1061421525296;1664.0265444714855;1677.5722190841257;1680.1011458869446;1701.931922723102;66648.3335166647;69029;70382.64808675976;70532.29467705308;72053.639731801;9707.854382184272;9950.452725100044;9971.601135954481;10207.387556746618;10290.331128476626;13834.584962451143;13848.723025539433;13854.099483533539;13882.722345553033;13973.79039314411;6892.310768923067;7079.398251148607;7146;7177.569345839266;7228.168760592494;6754.155730533684;6768.153980752406;6804.251532331439;6842.55523390978;6897.965510172417;4184.4141820145205;4302.300591266432;4307.353896915488;4313.50394704613;4461.955380446219;1654.6525229701897;1691.2389424758908;1736.5571779196225;1845.5755176309524;1854.6661600911966;800.6557180412362;869.4739682492001;884.1070518776082;891.7146513115871;906.8618883301415;16367.263473143737;16524.504264872074;16616.25226864794;16715.749263761052;16936.491905242863;855.7261676263536;883.9425437346551;903.421810041574;912.7079334612993;939.7697564096703;9190;9493.288003399774;9528.428294302365;9623.759406014766;9729.805403891882;371245;391456;418421;419636;422259;73345;75072;75481.24518754742;75776.24223757802;77443.2255677436;917.9219766319804;922.395830730859;925.9120383563551;929.7536152919482;936.321167153808;15116.848831511545;15132.924335378693;15206.391744330103;15295.541133766004;15334.539963801104;35453.645463545035;35649.82175089108;35799.82100089483;36328.4550731734;36626.81686591657;48722.5127748718;49590.50409496003;50251.24623130729;50851.491485084676;50992.49007509877;7677.193894640982;7792;7835.725749598737;7900.881486777818;7934.008248968879;8087.353011759163;8620.78448038804;8919.687810926587;11926.522939082339;12092.576759813364;10082.495875206063;10344.689659310232;10593.682189534326;10641.255112142077;10759.623413180814;10577.100946419641;10620.415877126832;10702.411367374869;10705.732356691145;10758.73103172427;10550.841737373792;10587.417692027013;10610.575576976835;10726.839097413702;10785.568577256821;7338.596377199306;7490.288422599844;7657.770266892002;7720.459567830198;7961.363090952594;8858;9351.438913665203;9990.500474976367;10284.845727314247;10981.231313807957 08:21:21 INFO - PROCESS | 25839 | |3;mootools.html;1407.5144075294027;1438.5612388221593;1544.8146222453308;1734;1738.1569938579787;6513.21841379034;7456.142543607487;7493.437992150583;7934.285914267722;8025.077116131647;7589.316961473466;7753.147153813076;7834.64744086516;7863.370930325575;7874.488158269708;2153.9784602153973;2178.9999999999923;2188.8248940084754;2190.9561808763815;2195.758466568684;2107.3677896631025;2107.525806693497;2185.2460900989213;2210.3148024112497;2210.6794514795347;2145.4743587821004;2154.429076294783;2158.6114499390105;2160.503084290614;2194.319760874126;2087.123408168573;2095.706601075851;2099.9265025724103;2100.6638937770035;2100.9474763130893;2031.1266155553105;2072.927447539329;2091.0903756865814;2112.324056301984;2113.1019316790303;7723;7731.342835858959;7790.727324543614;7804.765857024298;7837.608119594054;4364.388985542027;4455.754933478657;4456.93314600278;4500.167469018242;4502.684812063157;2708.79684023697;2748.9037883673977;2854.743073123408;2904.8257104573795;2918.1974956886816;894.9731508054704;924.1820988425225;931.0968360690119;937.6718148647986;939.8543225800012;10536.631217907336;10568.365898046064;10574.682759517227;10598.682039538826;10610.62862799806;3981.2833689936087;4077.368007958771;4154.833806647761;4155.563665815106;4169;8995.505247211335;9009.189172974464;9016.59425325862;9066.320025997944;9088.818223635622;4510.300903359985;4555.658325625592;4562.5665561771575;4586.082783443325;4587.655925805511;3589.6769290763955;4074.5314288856566;4205.411242426063;4220.11377610699;4254.234237837157;3599.5680518337967;3648.416253399443;3698.3158115748674;3707.9814600926825;3728.12389088564;1137.9886201137883;1190.4226450171832;1195.384377045822;1205.3189947679532;1206.8189771534164;863.9416714524782;913.5980168725739;922.9307801914883;931.7158266728712;933.118203297877;5417.295751552352;5430.212619170198;5562.221289019541;5600.299962504687;5651.237082993825;382.5027464296459;383.3502213747727;390.4904100149276;391.7453655124192;391.86676529979945;3799.297130030953;3843.2505661396317;3845.615438456132;3895.4156876468755;3904.1606054698377;8940.552972351357;9220.216281616003;9261.44431334122;9270;9278.48968306736;8821.60302786376;9135.360524763202;9140.725778226664;9168.770780730536;9182.17360437564;6990.335918087773;7003.54476958996;7023.578585284899;7028.0863487746265;7089.078419805495;5153.613478989166;5180.6891586504935;5225.843224703265;5310.601704872072;5319.6808191508635;8380.287675547646;8434.114417986024;8442.493450392996;8668.393212475066;8669.60986755585;8492.938382702163;8702.08628094041;8702.564871756513;8708.129187081495;8712.78218044554;5801.970990145022;6519.315471875385;6626.4367528760595;6820.079289295882;6925.515213934977;7605.809854753676;7609.086909570887;7658.195889431529;7701.229877012254;7707.537547747153;6785.219699734594;6906.067680863019;7015.824604384931;7034.929650703428;7058.223595404604;6709.463242940651;6754.86490270182;6775.390214880685;6822.795316140524;7009.439244860501;6150.446459818638;6191.226096737908;6206.565540412128;6207.565470417208;6456.063870738811;4569.1547063793305;4622.214223582067;4622.329762184531;4680.110778951988;4701.905961880811;4408.537103604075;4450.1989641864775;4481.7535035573355;4485.237509623306;4571.0629320988455 08:21:21 INFO - PROCESS | 25839 | |4;prototype.html;289.5743257411606;297.87489254513105;299.8246026074746;304.22878004259206;307.26256983240233;4865.245886887538;4926.926096108561;5096.77064532096;5104.4385117637075;5108.8978220435565;4972.154733695272;5018.172001619729;5025.673331233476;5026.271190677358;5056.393232812058;3922.646961773447;3924.54867690215;3932.921341573167;3949.3878448840474;3969.960300396988;3871.5741268460447;3933.5083114610675;3985.980070099645;3992.5608183099835;4001.2197621463824;3898.785566793825;3900.941485877714;3911.963329717613;3928.469656596366;3936.7441116327345;3878.1855810279876;3940.8423663053445;3942.802859856996;3943.507061617298;3952.9011774705573;3200.439923013487;3257.397381484433;3260.2664400509934;3309.520119582671;3496.947545786815;4817.614590832725;4833;4847.297141914438;4847.5637192652475;4859.663592512052;4333.133373325348;4339.218940590692;4349.717268377577;4368.322909948963;4385.627221686129;5113.437521872591;5255.3168088148295;5259.15853463444;5264.42091369949;5275.182346736262;3660.798656073915;3692.2246328271094;3707.6663100321102;3714.461403096536;3716.3867961786273;5505.697186654733;5516.448355164492;5537.197106419587;5546.140348246028;5558.277423934903;3695.3717867961973;3786.8674596388996;3816.561095474056;3823.6941044716355;3843.8078096095082;3835.5972622874756;3850.8652197173524;3851.691864650821;3853.7687738735203;3878.2437424702475;4416.624586910084;4427.645788336926;4434.17967675981;4449.755263460541;4466;5212.914834066404;5279.234510995961;5317.494837990462;5330.120530112566;5340.836961030789;1317.4730107956702;1331.993340033313;1336.85294617592;1340.1088276296348;1340.9463621455031;820.4216027700456;821.2608652213056;836.5440834745078;843.6372359885308;853.4623187392027;4140.896477588024;4144.6529877789235;4145.5697784264385;4159.648114362844;4200.894977625584;4847.945794149663;4848.393950756155;4871.829485968045;4875.95124048762;4903.670756390758;4150.149219410014;4190.198214767618;4197.706160568731;4212.241796476664;4221.050263690645;2491.327341617753;2580.574205256112;2596.857172855511;2608.9217323480325;2640.2211347652487;4530.388397566352;4551.748269225923;4555.635549156126;4577.427821522309;4581.633469322446;4888.633352498577;4929.260610908321;4941.431735350408;4962.727050012212;4964.304997300381;4225.71115809681;4551.408316918845;4569.337446070234;4579.38178345919;4586.743412177325;4811.663183577256;4819.445763737215;4833.154198015263;4856.838706775592;4885.169521181479;4699;4759.42886853566;4791.592714619296;4798.712077275374;4802.591779698765;4339.826406943813;4460.929376949573;4536.387587675622;4536.818527258873;4558.8632341029825;3444.8297572529145;3560.2345495718546;3630.382834918123;3730.0861288984374;3745.8127093645753;5387.218853266176;5397.190421436816;5432.619716619799;5449.863753406196;5469.562435005269;5164.870878228075;5234.869128271824;5239.554637855825;5251.006926052114;5270.683758974474;5073.103913764176;5104.081265372269;5170.22446632993;5171.612129090258;5182.818601348935;5043.839916819079;5049.26785616091;5115.184109641173;5131.820386286462;5178.352705911761;5274.630775845808;5304.814331498534;5307.230451584422;5316.229146773773;5316.920246196388;4971.676841005323;5237.931017248089;5279.6040296978645;5301.1783173608155;5319.2287118368395 08:21:21 INFO - PROCESS | 25839 | |5;yui.html;641.579765253759;647.4140902483255;719.1314798812043;745.1579714922138;758.2495664660901;12309.38453077346;12465.439055242514;12476.189047711916;12509.374531273446;12612.558560450374;13091;13162.670933226675;13261.734765304687;13294.667633309147;13325.800112998313;773.7330620935796;802.2098233240254;804.4208170117506;805.2028491793142;806.4193780478075;617.8640699046202;769.4959801330137;791.4499422901057;796.760971708488;801.4550105927966;833.4999000599622;840.2899549880341;843.2326582809644;847.1951645936355;848.7284069097891;834.6619619054293;842.389267780857;843.4348986179275;843.5655637346771;844.7845799321195;612.1796792298297;615.6829232945037;615.7690865925279;618.4866560754563;618.8545691762432;12572.30852303123;12645.178063425848;12660.11379203456;12693.746125077447;12700.682482937907;11635.301881887113;11760.29475726015;11762;11762.294262344201;12292.508299668003;10026.498675066217;10062.748431289203;10373.222008349328;10407.635732749393;10885.23803333767;3250.4961730931745;3253.7071663550396;3322.734181265493;3338.849751761177;3386.102682789063;57148.428515714724;58303;58423.41576584222;58956.41043589552;60019;9444.602620392754;9536.666216682383;9598.944116147219;9647.951760241154;9670.56482458291;18150.27398904029;18721.625567488845;18760.71858922117;18784.812151878305;18818.623627527646;5898.262717160355;6002.459778619946;6020.036794113009;6023.045903556003;6126.724297406628;3169.16658784409;3258.7881787683723;3258.951115733266;3313.188268874141;3324.5345651608795;2942.367391010943;3063.678313777066;3077.7999430036975;3085.6760040195904;3094.6131733533307;506.36704119850185;509.08619028843316;510.64510165434666;531.7447625139877;538.9973050134724;541.7237209023426;563.9876421822756;565.5758181363977;566.0999011571621;592.3277080513562;7409.296116868889;7632.542047477169;7702.537847729154;7755;7846.136924938252;477.1054273237679;534.2947309551355;574.7814632978029;616.5899676714935;648.9221293444817;3460.636633153533;3727.6645101940953;3732.2162345907122;3786.2238241160494;3825.2731980923536;85435.5728221355;86276;88793;91427.54286228526;92893;48752.5124748748;48890.26664600034;60637;62691.373086269465;72665.6366718163;69585;71202;71626.64186679137;72366;72878.27121728715;7052.682629281592;7172.856542869009;7183.317584829433;7252.2747725227055;7318.597477138595;40404.3939340916;41651.166976660905;42363.364549531165;42755.786221068694;43447.565524344354;52685.47314526806;60026;60720.39279607324;60853.69573152106;61007;9221.907780922373;9300.953495232481;9394.95302523483;9732.367396119229;9758.316917815684;11027.22809403334;11208.103351732005;11223.4388280584;11544.94227528857;11795.764084718086;9522.619095236112;9631.181349585364;9683.854742178732;10752.0323170915;10954.671359859218;9675.322727409013;9704.660336888457;9867.55595998196;9879.407235565888;9926.553305101143;10262;10448.634297799541;11070.5571777128;11087.778244435227;11286.604968826052;9578.090081442251;9601.279904007368;9823.508824558601;9922.107010369102;10310.845337320095;9590.136887680143;9609.951950240204;9621.51892405391;9667.27495437859;9790.75523111928 08:21:21 INFO - PROCESS | 25839 | __end_tp_report 08:21:21 INFO - PROCESS | 25839 | __start_cc_report 08:21:21 INFO - PROCESS | 25839 | _x_x_mozilla_cycle_collect,381 08:21:21 INFO - PROCESS | 25839 | __end_cc_report 08:21:21 INFO - PROCESS | 25839 | __startTimestamp1465312881158__endTimestamp 08:21:21 INFO - PROCESS | 25839 | 08:21:21 INFO - PROCESS | 25839 | ------- Summary: start ------- 08:21:21 INFO - PROCESS | 25839 | Number of tests: 6 08:21:21 INFO - PROCESS | 25839 | 08:21:21 INFO - PROCESS | 25839 | [#0] dojo.html Cycles:165 Average:4737.34 Median:4866.73 stddev:606.73 (12.5%) stddev-sans-first:585.12 08:21:21 INFO - PROCESS | 25839 | Values: 2607.1 2662.5 2666.3 2669.0 2684.7 4634.0 4650.8 4656.2 4796.2 4818.2 4700.8 4786.9 4790.6 4814.6 4823.5 4353.9 4419.4 4485.2 4517.1 4517.6 560.0 4322.2 4409.4 4421.0 4421.3 4434.9 4438.3 4445.8 4448.6 4516.4 4446.8 4475.4 4484.3 4484.8 4533.8 4337.3 4375.8 4383.9 4385.7 4389.5 4649.5 4682.4 4708.2 4736.6 4739.3 5084.9 5173.6 5197.4 5204.2 5234.3 5132.3 5217.0 5221.8 5232.1 5264.0 4824.0 4866.7 4870.0 4884.0 4921.4 5294.0 5305.5 5342.6 5343.0 5356.7 5132.8 5153.8 5155.4 5156.9 5163.0 5210.3 5234.6 5251.1 5264.7 5269.8 4984.7 5062.3 5090.4 5120.1 5134.7 5104.0 5133.1 5133.4 5134.1 5176.3 4310.4 4384.5 4401.7 4422.9 4457.6 3776.5 3803.5 3805.7 3839.7 3844.7 4363.1 4376.0 4381.4 4394.9 4425.4 5168.8 5183.8 5186.4 5194.2 5224.2 4305.3 4386.8 4417.8 4439.6 4447.8 4661.9 4665.4 4673.0 4673.1 4721.0 4639.1 4789.7 4824.4 4833.2 4846.3 5038.2 5082.5 5152.9 5182.3 5263.0 4829.6 4836.4 4844.6 4846.5 4878.0 5100.4 5103.9 5124.9 5130.5 5160.2 5031.1 5067.9 5147.5 5147.8 5186.3 5019.8 5031.2 5043.4 5054.2 5107.4 4838.7 5057.9 5058.9 5062.6 5070.0 4863.1 4867.9 4884.8 4895.1 4920.1 5067.9 5068.0 5075.3 5087.0 5093.7 4812.2 4947.9 4961.9 4994.6 5032.3 08:21:21 INFO - PROCESS | 25839 | 08:21:21 INFO - PROCESS | 25839 | [#1] ext.html Cycles:180 Average:46608.38 Median:19155.73 stddev:87203.09 (455.2%) stddev-sans-first:87379.12 08:21:21 INFO - PROCESS | 25839 | Values: 541.3 577.3 594.1 595.7 602.1 34601.7 38778.6 38918.0 38939.8 38941.4 38756.2 39628.6 39700.8 39749.4 39751.0 7639.2 7770.0 7787.1 7795.3 7819.3 7713.5 7765.4 7772.8 7779.3 7812.1 7763.1 7808.3 7814.1 7834.8 7849.5 7732.3 7751.5 7792.0 7821.6 7823.1 7620.2 7724.3 7731.3 7736.0 7763.0 34293.1 34308.7 34480.0 34497.3 34528.3 2893.9 3067.2 3124.3 3300.8 3498.0 28500.7 28759.4 28877.6 29189.0 29378.9 3283.8 3291.2 3299.0 3315.4 3320.4 241952.0 243457.0 243824.0 245633.0 246654.0 32219.4 33219.3 52610.0 52775.5 52823.7 33478.0 33747.1 33847.8 33966.7 34031.0 13617.4 13808.6 13814.2 13858.8 13924.7 10552.9 10577.1 10585.1 10595.1 10618.2 7897.6 7916.1 7933.1 7979.0 7999.3 3119.9 3125.5 3133.5 3139.2 3141.5 903.5 908.8 940.1 970.3 1000.8 26821.0 28325.4 28624.7 28717.4 28776.0 965.9 984.7 986.9 1000.2 1028.3 14584.7 14740.3 14817.5 15102.5 15231.7 392302.0 394242.0 395825.0 396000.0 396393.0 48751.0 48944.3 49111.5 49115.0 49288.3 1185.3 1201.9 1206.1 1207.8 1231.1 26885.6 27710.7 28026.2 28055.2 28556.1 43768.0 43770.8 44089.0 44147.0 44151.6 332147.0 333000.0 333178.0 334658.0 335840.0 25244.7 25255.2 25430.9 25543.5 26140.5 41914.4 42473.0 42702.8 42746.0 43442.0 35543.8 36707.6 36815.3 36979.0 37073.3 35461.6 35636.6 35783.6 35817.0 36191.8 34813.5 35004.5 36934.6 37393.6 40436.4 32162.7 33154.0 33723.3 33891.5 33903.3 25735.6 25794.9 26039.2 26059.0 26464.5 08:21:21 INFO - PROCESS | 25839 | 08:21:21 INFO - PROCESS | 25839 | [#2] jquery.html Cycles:180 Average:24353.76 Median:49920.88 stddev:66797.74 (133.8%) stddev-sans-first:66960.84 08:21:21 INFO - PROCESS | 25839 | Values: 360.3 371.9 374.7 381.9 390.5 15695.8 16499.3 17345.9 17407.2 17451.6 16152.9 16363.0 17163.9 17296.3 17356.3 4956.4 5064.8 5152.0 5154.1 5156.4 3725.0 5088.2 5608.7 5930.1 5935.3 5940.0 5941.8 5977.6 5978.6 5993.0 5716.0 5851.9 5881.1 5882.2 5889.0 4509.4 5167.8 5171.3 5185.9 5188.5 11638.1 12159.0 12272.9 12281.0 12308.7 1710.5 1762.3 1788.8 1796.6 1826.7 8620.5 8648.3 9010.0 9202.6 9357.4 1640.1 1664.0 1677.6 1680.1 1701.9 66648.3 69029.0 70382.6 70532.3 72053.6 9707.9 9950.5 9971.6 10207.4 10290.3 13834.6 13848.7 13854.1 13882.7 13973.8 6892.3 7079.4 7146.0 7177.6 7228.2 6754.2 6768.2 6804.3 6842.6 6898.0 4184.4 4302.3 4307.4 4313.5 4462.0 1654.7 1691.2 1736.6 1845.6 1854.7 800.7 869.5 884.1 891.7 906.9 16367.3 16524.5 16616.3 16715.7 16936.5 855.7 883.9 903.4 912.7 939.8 9190.0 9493.3 9528.4 9623.8 9729.8 371245.0 391456.0 418421.0 419636.0 422259.0 73345.0 75072.0 75481.2 75776.2 77443.2 917.9 922.4 925.9 929.8 936.3 15116.8 15132.9 15206.4 15295.5 15334.5 35453.6 35649.8 35799.8 36328.5 36626.8 48722.5 49590.5 50251.2 50851.5 50992.5 7677.2 7792.0 7835.7 7900.9 7934.0 8087.4 8620.8 8919.7 11926.5 12092.6 10082.5 10344.7 10593.7 10641.3 10759.6 10577.1 10620.4 10702.4 10705.7 10758.7 10550.8 10587.4 10610.6 10726.8 10785.6 7338.6 7490.3 7657.8 7720.5 7961.4 8858.0 9351.4 9990.5 10284.8 10981.2 08:21:21 INFO - PROCESS | 25839 | 08:21:21 INFO - PROCESS | 25839 | [#3] mootools.html Cycles:180 Average:5068.95 Median:5167.15 stddev:2818.34 (54.5%) stddev-sans-first:2812.82 08:21:21 INFO - PROCESS | 25839 | Values: 1407.5 1438.6 1544.8 1734.0 1738.2 6513.2 7456.1 7493.4 7934.3 8025.1 7589.3 7753.1 7834.6 7863.4 7874.5 2154.0 2179.0 2188.8 2191.0 2195.8 2107.4 2107.5 2185.2 2210.3 2210.7 2145.5 2154.4 2158.6 2160.5 2194.3 2087.1 2095.7 2099.9 2100.7 2100.9 2031.1 2072.9 2091.1 2112.3 2113.1 7723.0 7731.3 7790.7 7804.8 7837.6 4364.4 4455.8 4456.9 4500.2 4502.7 2708.8 2748.9 2854.7 2904.8 2918.2 895.0 924.2 931.1 937.7 939.9 10536.6 10568.4 10574.7 10598.7 10610.6 3981.3 4077.4 4154.8 4155.6 4169.0 8995.5 9009.2 9016.6 9066.3 9088.8 4510.3 4555.7 4562.6 4586.1 4587.7 3589.7 4074.5 4205.4 4220.1 4254.2 3599.6 3648.4 3698.3 3708.0 3728.1 1138.0 1190.4 1195.4 1205.3 1206.8 863.9 913.6 922.9 931.7 933.1 5417.3 5430.2 5562.2 5600.3 5651.2 382.5 383.4 390.5 391.7 391.9 3799.3 3843.3 3845.6 3895.4 3904.2 8940.6 9220.2 9261.4 9270.0 9278.5 8821.6 9135.4 9140.7 9168.8 9182.2 6990.3 7003.5 7023.6 7028.1 7089.1 5153.6 5180.7 5225.8 5310.6 5319.7 8380.3 8434.1 8442.5 8668.4 8669.6 8492.9 8702.1 8702.6 8708.1 8712.8 5802.0 6519.3 6626.4 6820.1 6925.5 7605.8 7609.1 7658.2 7701.2 7707.5 6785.2 6906.1 7015.8 7034.9 7058.2 6709.5 6754.9 6775.4 6822.8 7009.4 6150.4 6191.2 6206.6 6207.6 6456.1 4569.2 4622.2 4622.3 4680.1 4701.9 4408.5 4450.2 4481.8 4485.2 4571.1 08:21:21 INFO - PROCESS | 25839 | 08:21:21 INFO - PROCESS | 25839 | [#4] prototype.html Cycles:180 Average:4209.86 Median:4573.38 stddev:1226.67 (26.8%) stddev-sans-first:1194.30 08:21:21 INFO - PROCESS | 25839 | Values: 289.6 297.9 299.8 304.2 307.3 4865.2 4926.9 5096.8 5104.4 5108.9 4972.2 5018.2 5025.7 5026.3 5056.4 3922.6 3924.5 3932.9 3949.4 3970.0 3871.6 3933.5 3986.0 3992.6 4001.2 3898.8 3900.9 3912.0 3928.5 3936.7 3878.2 3940.8 3942.8 3943.5 3952.9 3200.4 3257.4 3260.3 3309.5 3496.9 4817.6 4833.0 4847.3 4847.6 4859.7 4333.1 4339.2 4349.7 4368.3 4385.6 5113.4 5255.3 5259.2 5264.4 5275.2 3660.8 3692.2 3707.7 3714.5 3716.4 5505.7 5516.4 5537.2 5546.1 5558.3 3695.4 3786.9 3816.6 3823.7 3843.8 3835.6 3850.9 3851.7 3853.8 3878.2 4416.6 4427.6 4434.2 4449.8 4466.0 5212.9 5279.2 5317.5 5330.1 5340.8 1317.5 1332.0 1336.9 1340.1 1340.9 820.4 821.3 836.5 843.6 853.5 4140.9 4144.7 4145.6 4159.6 4200.9 4847.9 4848.4 4871.8 4876.0 4903.7 4150.1 4190.2 4197.7 4212.2 4221.1 2491.3 2580.6 2596.9 2608.9 2640.2 4530.4 4551.7 4555.6 4577.4 4581.6 4888.6 4929.3 4941.4 4962.7 4964.3 4225.7 4551.4 4569.3 4579.4 4586.7 4811.7 4819.4 4833.2 4856.8 4885.2 4699.0 4759.4 4791.6 4798.7 4802.6 4339.8 4460.9 4536.4 4536.8 4558.9 3444.8 3560.2 3630.4 3730.1 3745.8 5387.2 5397.2 5432.6 5449.9 5469.6 5164.9 5234.9 5239.6 5251.0 5270.7 5073.1 5104.1 5170.2 5171.6 5182.8 5043.8 5049.3 5115.2 5131.8 5178.4 5274.6 5304.8 5307.2 5316.2 5316.9 4971.7 5237.9 5279.6 5301.2 5319.2 08:21:21 INFO - PROCESS | 25839 | 08:21:21 INFO - PROCESS | 25839 | [#5] yui.html Cycles:180 Average:16090.97 Median:33014.23 stddev:22457.47 (68.0%) stddev-sans-first:22490.51 08:21:21 INFO - PROCESS | 25839 | Values: 641.6 647.4 719.1 745.2 758.2 12309.4 12465.4 12476.2 12509.4 12612.6 13091.0 13162.7 13261.7 13294.7 13325.8 773.7 802.2 804.4 805.2 806.4 617.9 769.5 791.4 796.8 801.5 833.5 840.3 843.2 847.2 848.7 834.7 842.4 843.4 843.6 844.8 612.2 615.7 615.8 618.5 618.9 12572.3 12645.2 12660.1 12693.7 12700.7 11635.3 11760.3 11762.0 11762.3 12292.5 10026.5 10062.7 10373.2 10407.6 10885.2 3250.5 3253.7 3322.7 3338.8 3386.1 57148.4 58303.0 58423.4 58956.4 60019.0 9444.6 9536.7 9598.9 9648.0 9670.6 18150.3 18721.6 18760.7 18784.8 18818.6 5898.3 6002.5 6020.0 6023.0 6126.7 3169.2 3258.8 3259.0 3313.2 3324.5 2942.4 3063.7 3077.8 3085.7 3094.6 506.4 509.1 510.6 531.7 539.0 541.7 564.0 565.6 566.1 592.3 7409.3 7632.5 7702.5 7755.0 7846.1 477.1 534.3 574.8 616.6 648.9 3460.6 3727.7 3732.2 3786.2 3825.3 85435.6 86276.0 88793.0 91427.5 92893.0 48752.5 48890.3 60637.0 62691.4 72665.6 69585.0 71202.0 71626.6 72366.0 72878.3 7052.7 7172.9 7183.3 7252.3 7318.6 40404.4 41651.2 42363.4 42755.8 43447.6 52685.5 60026.0 60720.4 60853.7 61007.0 9221.9 9301.0 9395.0 9732.4 9758.3 11027.2 11208.1 11223.4 11544.9 11795.8 9522.6 9631.2 9683.9 10752.0 10954.7 9675.3 9704.7 9867.6 9879.4 9926.6 10262.0 10448.6 11070.6 11087.8 11286.6 9578.1 9601.3 9823.5 9922.1 10310.8 9590.1 9610.0 9621.5 9667.3 9790.8 08:21:21 INFO - PROCESS | 25839 | -------- Summary: end -------- 08:21:21 INFO - PROCESS | 25839 | 08:21:21 INFO - TEST-INFO | 25839: exit 0 08:21:21 INFO - TEST-OK | dromaeo_css | took 1116133ms 08:21:21 INFO - TEST-START | kraken 08:21:21 INFO - operating with platform_type : linux_ 08:21:21 INFO - Initialising browser for kraken test... 08:21:21 INFO - TEST-INFO | started process 26074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaAtkgM/profile http://localhost:58318/getInfo.html) 08:21:26 INFO - PROCESS | 26074 | __metrics Screen width/height:1600/1200 08:21:26 INFO - PROCESS | 26074 | colorDepth:24 08:21:26 INFO - PROCESS | 26074 | Browser inner width/height: 1024/697 08:21:26 INFO - PROCESS | 26074 | __metrics 08:21:27 ERROR - PROCESS | 26074 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 08:21:28 INFO - TEST-INFO | 26074: exit 0 08:21:28 INFO - Browser initialized. 08:21:28 INFO - Running cycle 1/1 for kraken test... 08:21:28 INFO - TEST-INFO | started process 26192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaAtkgM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:40 INFO - PROCESS | 26192 | RSS: Main: 167489536 08:21:40 INFO - PROCESS | 26192 | 08:21:43 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58318/tests/kraken/driver.html?testName=audio-beat-detection) 08:21:44 INFO - PROCESS | 26192 | RSS: Main: 172851200 08:21:44 INFO - PROCESS | 26192 | 08:21:46 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58318/tests/kraken/driver.html?testName=audio-dft) 08:21:47 INFO - PROCESS | 26192 | RSS: Main: 172380160 08:21:47 INFO - PROCESS | 26192 | 08:21:50 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58318/tests/kraken/driver.html?testName=audio-fft) 08:21:51 INFO - PROCESS | 26192 | RSS: Main: 167211008 08:21:51 INFO - PROCESS | 26192 | 08:21:53 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58318/tests/kraken/driver.html?testName=audio-oscillator) 08:21:53 INFO - PROCESS | 26192 | RSS: Main: 167915520 08:21:53 INFO - PROCESS | 26192 | 08:21:56 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58318/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:21:56 INFO - PROCESS | 26192 | RSS: Main: 168341504 08:21:56 INFO - PROCESS | 26192 | 08:22:00 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58318/tests/kraken/driver.html?testName=imaging-darkroom) 08:22:00 INFO - PROCESS | 26192 | RSS: Main: 168857600 08:22:00 INFO - PROCESS | 26192 | 08:22:04 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58318/tests/kraken/driver.html?testName=imaging-desaturate) 08:22:04 INFO - PROCESS | 26192 | RSS: Main: 166109184 08:22:04 INFO - PROCESS | 26192 | 08:22:07 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58318/tests/kraken/driver.html?testName=json-parse-financial) 08:22:08 INFO - PROCESS | 26192 | RSS: Main: 167698432 08:22:08 INFO - PROCESS | 26192 | 08:22:10 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58318/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:22:10 INFO - PROCESS | 26192 | RSS: Main: 168120320 08:22:10 INFO - PROCESS | 26192 | 08:22:12 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58318/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:22:13 INFO - PROCESS | 26192 | RSS: Main: 168480768 08:22:13 INFO - PROCESS | 26192 | 08:22:15 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58318/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:22:16 INFO - PROCESS | 26192 | RSS: Main: 168955904 08:22:16 INFO - PROCESS | 26192 | 08:22:19 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:22:19 INFO - PROCESS | 26192 | RSS: Main: 168894464 08:22:19 INFO - PROCESS | 26192 | 08:22:22 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:22:23 INFO - PROCESS | 26192 | RSS: Main: 168361984 08:22:23 INFO - PROCESS | 26192 | 08:22:24 INFO - PROCESS | 26192 | Cycle 1(1): loaded http://localhost:58318/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58318/tests/kraken/driver.html?testName=ai-astar) 08:22:25 INFO - PROCESS | 26192 | RSS: Main: 169349120 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | __start_tp_report 08:22:25 INFO - PROCESS | 26192 | _x_x_mozilla_page_load 08:22:25 INFO - PROCESS | 26192 | _x_x_mozilla_page_load_details 08:22:25 INFO - PROCESS | 26192 | |i|pagename|runs| 08:22:25 INFO - PROCESS | 26192 | |0;ai-astar;116;111;116;116;117;115;115;115;115;119 08:22:25 INFO - PROCESS | 26192 | |1;audio-beat-detection;164;136;157;187;140;159;165;133;201;138 08:22:25 INFO - PROCESS | 26192 | |2;audio-dft;163;162;165;175;162;162;165;166;163;163 08:22:25 INFO - PROCESS | 26192 | |3;audio-fft;77;78;75;165;76;77;76;76;164;77 08:22:25 INFO - PROCESS | 26192 | |4;audio-oscillator;89;86;135;87;86;86;131;85;88;144 08:22:25 INFO - PROCESS | 26192 | |5;imaging-gaussian-blur;118;119;118;118;118;117;118;119;118;118 08:22:25 INFO - PROCESS | 26192 | |6;imaging-darkroom;148;148;148;147;147;149;149;147;149;147 08:22:25 INFO - PROCESS | 26192 | |7;imaging-desaturate;95;96;95;95;95;96;95;96;96;96 08:22:25 INFO - PROCESS | 26192 | |8;json-parse-financial;64;64;64;64;63;63;63;63;63;64 08:22:25 INFO - PROCESS | 26192 | |9;json-stringify-tinderbox;65;65;67;66;65;66;66;68;65;65 08:22:25 INFO - PROCESS | 26192 | |10;stanford-crypto-aes;85;84;83;88;86;85;93;85;110;86 08:22:25 INFO - PROCESS | 26192 | |11;stanford-crypto-ccm;133;147;135;134;132;134;134;133;137;136 08:22:25 INFO - PROCESS | 26192 | |12;stanford-crypto-pbkdf2;170;174;168;171;183;168;174;179;170;168 08:22:25 INFO - PROCESS | 26192 | |13;stanford-crypto-sha256-iterative;67;69;68;69;69;74;68;77;68;68 08:22:25 INFO - PROCESS | 26192 | __end_tp_report 08:22:25 INFO - PROCESS | 26192 | __start_cc_report 08:22:25 INFO - PROCESS | 26192 | _x_x_mozilla_cycle_collect,984 08:22:25 INFO - PROCESS | 26192 | __end_cc_report 08:22:25 INFO - PROCESS | 26192 | __startTimestamp1465312945241__endTimestamp 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | ------- Summary: start ------- 08:22:25 INFO - PROCESS | 26192 | Number of tests: 14 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:2.01 (1.7%) stddev-sans-first:2.13 08:22:25 INFO - PROCESS | 26192 | Values: 116.0 111.0 116.0 116.0 117.0 115.0 115.0 115.0 115.0 119.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#1] audio-beat-detection Cycles:10 Average:158.00 Median:161.50 stddev:22.63 (14.0%) stddev-sans-first:23.90 08:22:25 INFO - PROCESS | 26192 | Values: 164.0 136.0 157.0 187.0 140.0 159.0 165.0 133.0 201.0 138.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.92 (2.4%) stddev-sans-first:4.12 08:22:25 INFO - PROCESS | 26192 | Values: 163.0 162.0 165.0 175.0 162.0 162.0 165.0 166.0 163.0 163.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.50 stddev:37.11 (48.5%) stddev-sans-first:38.85 08:22:25 INFO - PROCESS | 26192 | Values: 77.0 78.0 75.0 165.0 76.0 77.0 76.0 76.0 164.0 77.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:86.00 stddev:24.36 (28.3%) stddev-sans-first:25.40 08:22:25 INFO - PROCESS | 26192 | Values: 89.0 86.0 135.0 87.0 86.0 86.0 131.0 85.0 88.0 144.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:22:25 INFO - PROCESS | 26192 | Values: 118.0 119.0 118.0 118.0 118.0 117.0 118.0 119.0 118.0 118.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 08:22:25 INFO - PROCESS | 26192 | Values: 148.0 148.0 148.0 147.0 147.0 149.0 149.0 147.0 149.0 147.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:22:25 INFO - PROCESS | 26192 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:22:25 INFO - PROCESS | 26192 | Values: 64.0 64.0 64.0 64.0 63.0 63.0 63.0 63.0 63.0 64.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 08:22:25 INFO - PROCESS | 26192 | Values: 65.0 65.0 67.0 66.0 65.0 66.0 66.0 68.0 65.0 65.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:85.50 stddev:8.05 (9.4%) stddev-sans-first:8.43 08:22:25 INFO - PROCESS | 26192 | Values: 85.0 84.0 83.0 88.0 86.0 85.0 93.0 85.0 110.0 86.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:134.50 stddev:4.30 (3.2%) stddev-sans-first:4.47 08:22:25 INFO - PROCESS | 26192 | Values: 133.0 147.0 135.0 134.0 132.0 134.0 134.0 133.0 137.0 136.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:172.50 stddev:5.08 (2.9%) stddev-sans-first:5.31 08:22:25 INFO - PROCESS | 26192 | Values: 170.0 174.0 168.0 171.0 183.0 168.0 174.0 179.0 170.0 168.0 08:22:25 INFO - PROCESS | 26192 | 08:22:25 INFO - PROCESS | 26192 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.00 stddev:3.20 (4.6%) stddev-sans-first:3.24 08:22:25 INFO - PROCESS | 26192 | Values: 67.0 69.0 68.0 69.0 69.0 74.0 68.0 77.0 68.0 68.0 08:22:25 INFO - PROCESS | 26192 | -------- Summary: end -------- 08:22:25 INFO - PROCESS | 26192 | 08:22:26 INFO - TEST-INFO | 26192: exit 0 08:22:26 INFO - TEST-OK | kraken | took 64500ms 08:22:26 INFO - SUITE-END | took 1180s 08:22:26 INFO - Completed test suite (00:19:40) 08:22:26 INFO - javascript benchmark 08:22:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6246.673979270922, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.0875193682214, 2662.480816240834, 2666.280104371819, 2668.959965600516, 2684.691260505041, 4634.0, 4650.790714417851, 4656.161890859644, 4796.2086255767845, 4818.204996175627, 4700.788464519096, 4786.904261914759, 4790.568848803607, 4814.590759785414, 4823.541763532458, 4353.86938391848, 4419.403380543634, 4485.237509623372, 4517.09658068386, 4517.593416592506, 559.9574071523442, 4322.157179350028, 4409.4047303613925, 4421.0494743630115, 4421.270490369086, 4434.889127771799, 4438.334249862514, 4445.8221671133115, 4448.621867141297, 4516.390287311204, 4446.7998940047455, 4475.440569928759, 4484.327350897359, 4484.775761211927, 4533.795979180912, 4337.327714204303, 4375.846845360397, 4383.8684839454545, 4385.6710746694125, 4389.473263208403, 4649.5350464953235, 4682.391289132425, 4708.152532544141, 4736.64475164364, 4739.336492890998, 5084.923726144111, 5173.560247378978, 5197.350331208599, 5204.219367094928, 5234.345706786652, 5132.281480592683, 5217.0, 5221.791128354899, 5232.136697444955, 5264.0, 4823.9517604824205, 4866.732329721864, 4869.975650121727, 4884.0476107159475, 4921.434035085939, 5293.973530132324, 5305.495977882095, 5342.6260161788305, 5343.011542864505, 5356.651817631841, 5132.8460146195675, 5153.768080436389, 5155.407128180307, 5156.896862062813, 5163.0, 5210.270562121306, 5234.607404444682, 5251.10731175701, 5264.684118952875, 5269.762860671279, 4984.700917944935, 5062.265971434122, 5090.363704536933, 5120.103981803244, 5134.691918484903, 5104.03023425548, 5133.076046311625, 5133.383993920754, 5134.127198376285, 5176.275321454999, 4310.418093557392, 4384.539623339567, 4401.713888597231, 4422.867313980586, 4457.64338852891, 3776.546814382237, 3803.54357477099, 3805.6574908257835, 3839.6544311012144, 3844.7116466265143, 4363.105563359503, 4375.971646663032, 4381.408509851193, 4394.868153955386, 4425.402570652985, 5168.767405466763, 5183.81856635016, 5186.351706036746, 5194.22086687, 5224.242484839753, 4305.268104422255, 4386.8025938832825, 4417.845375411845, 4439.578240067189, 4447.844325448594, 4661.906761864744, 4665.393498845128, 4673.042026384583, 4673.135469938073, 4720.95279047212, 4639.072185562968, 4789.736564488987, 4824.445188803333, 4833.226683730657, 4846.321514987834, 5038.244263360525, 5082.491750824888, 5152.948470515247, 5182.274481572658, 5263.000029994442, 4829.5653391193555, 4836.371271734652, 4844.588210002189, 4846.491118432514, 4878.048780487771, 5100.413452453015, 5103.948960510347, 5124.923126153036, 5130.538251557377, 5160.200168973815, 5031.069252188357, 5067.949320506747, 5147.536721695065, 5147.794088236578, 5186.273921651047, 5019.824306149268, 5031.169856973558, 5043.420006699276, 5054.241863720325, 5107.387113546398, 4838.661293709407, 5057.949420505748, 5058.9494105058475, 5062.594992400673, 5069.960658065162, 4863.148948933852, 4867.853964381075, 4884.8046078157895, 4895.143349913822, 4920.089783390084, 5067.949320506747, 5068.0, 5075.264086707481, 5087.0, 5093.745312734422, 4812.230043193073, 4947.925781113214, 4961.8511444656715, 4994.5754610858485, 5032.3206367139965], "value": 4699.674269968218, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.3012882970663, 577.3014652270753, 594.0762114911311, 595.6872641863022, 602.0848310567935, 34601.65398346016, 38778.61221387785, 38918.0, 38939.80530097352, 38941.41587876184, 38756.22487550247, 39628.60371396285, 39700.80149599255, 39749.40375894364, 39751.0, 7639.236076392344, 7769.961150194241, 7787.143414224431, 7795.298423141916, 7819.296263336299, 7713.498622589514, 7765.378769698439, 7772.766816995471, 7779.2998630123275, 7812.062552493709, 7763.107242667109, 7808.336291415237, 7814.0623125224765, 7834.843303133934, 7849.489783164105, 7732.342750866183, 7751.496152750082, 7792.0, 7821.569813660247, 7823.10034346049, 7620.161782203953, 7724.304812566896, 7731.265529774662, 7736.0, 7763.0, 34293.14267143316, 34308.656913430794, 34480.0, 34497.31005379903, 34528.30943381143, 2893.9276518087004, 3067.2025273428844, 3124.3438877835683, 3300.8475417320174, 3497.9825100874586, 28500.714992850222, 28759.42481150386, 28877.56683649747, 29189.0, 29378.85310573455, 3283.770136090475, 3291.2265617580088, 3298.983505082459, 3315.436375816117, 3320.4023275810346, 241952.0, 243457.0, 243824.0, 245632.99999999822, 246654.0, 32219.35561288761, 33219.3356132876, 52610.0, 52775.47224527782, 52823.73588132112, 33478.0, 33747.13149382281, 33847.83076084604, 33966.660333396845, 34031.0, 13617.387217575233, 13808.585742427744, 13814.240216787972, 13858.792118118236, 13924.651883702785, 10552.894471055344, 10577.100946419487, 10585.100266477435, 10595.09941654968, 10618.203634727271, 7897.644605992744, 7916.089649690244, 7933.087694915159, 7978.960105199553, 7999.3200577950365, 3119.906402807919, 3125.5311703244697, 3133.5143052826847, 3139.1681204480833, 3141.513065474855, 903.4579252448478, 908.7864351877304, 940.1303793990668, 970.3256236915418, 1000.8248556502583, 26821.0, 28325.43349133006, 28624.713752862204, 28717.425651486854, 28776.0, 965.9227261819037, 984.7291994701515, 986.8815742110993, 1000.1898462245459, 1028.341861208827, 14584.708305833823, 14740.336684849208, 14817.481388151364, 15102.471413500474, 15231.695366092838, 392302.0, 394242.0, 395825.0, 396000.0, 396393.0, 48751.0, 48944.26583601249, 49111.50888491069, 49115.0, 49288.260676089885, 1185.2769810415639, 1201.9399030048462, 1206.1135065726685, 1207.8429804125408, 1231.1074471008446, 26885.596716048884, 27710.722892770813, 28026.159215223575, 28055.158345249674, 28556.143315700563, 43768.0, 43770.78114609534, 44089.0, 44147.0, 44151.558484414745, 332147.0, 333000.0, 333178.0, 334658.0, 335840.0, 25244.74755252424, 25255.242342729747, 25430.872845635655, 25543.489130217662, 26140.477190456466, 41914.37128443137, 42473.0, 42702.78648606737, 42746.0, 43442.0, 35543.82228088843, 36707.63292367042, 36815.26369472649, 36979.0, 37073.25853482969, 35461.64538354584, 35636.64363356333, 35783.642163579076, 35817.0, 36191.81904090463, 34813.477797832544, 35004.47493287552, 36934.63065369312, 37393.6260637401, 40436.3934540988, 32162.678373216906, 33154.0, 33723.32553348968, 33891.4916276261, 33903.32193356168, 25735.613965790904, 25794.871025644752, 26039.218823435327, 26059.0, 26464.470710586065], "value": 16447.84587760985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.30641016044126, 371.9014461167791, 374.6553171082605, 381.8753770146918, 390.4514157608559, 15695.764563531557, 16499.25753341101, 17345.91327043363, 17407.216675249612, 17451.56371090722, 16152.919235403806, 16363.0, 17163.91418042911, 17296.30814767411, 17356.305747770104, 4956.380452443454, 5064.848054558369, 5152.0, 5154.098032844256, 5156.355455568054, 3724.9813750931207, 5088.211327244265, 5608.747606357703, 5930.051191809312, 5935.28776546815, 5940.04959206527, 5941.792037278696, 5977.641341519501, 5978.551608629348, 5993.041113421853, 5716.0, 5851.853703657422, 5881.088431293157, 5882.205902203191, 5888.970555147197, 4509.368688383629, 5167.819126330561, 5171.276021357013, 5185.922211166798, 5188.481151884819, 11638.127140464414, 12159.0, 12272.877271227262, 12281.0, 12308.692282693004, 1710.538154698237, 1762.2510433065895, 1788.803231644518, 1796.5778042160082, 1826.6985947318676, 8620.525871077089, 8648.264897483721, 9009.954950225207, 9202.631894724203, 9357.398428854243, 1640.1061421525296, 1664.0265444714855, 1677.5722190841257, 1680.1011458869446, 1701.931922723102, 66648.3335166647, 69029.0, 70382.64808675976, 70532.29467705308, 72053.639731801, 9707.854382184272, 9950.452725100044, 9971.601135954481, 10207.387556746618, 10290.331128476626, 13834.584962451143, 13848.723025539433, 13854.099483533539, 13882.722345553033, 13973.79039314411, 6892.310768923067, 7079.398251148607, 7146.0, 7177.569345839266, 7228.168760592494, 6754.155730533684, 6768.153980752406, 6804.251532331439, 6842.55523390978, 6897.965510172417, 4184.4141820145205, 4302.300591266432, 4307.353896915488, 4313.50394704613, 4461.955380446219, 1654.6525229701897, 1691.2389424758908, 1736.5571779196225, 1845.5755176309524, 1854.6661600911966, 800.6557180412362, 869.4739682492001, 884.1070518776082, 891.7146513115871, 906.8618883301415, 16367.263473143737, 16524.504264872074, 16616.25226864794, 16715.749263761052, 16936.491905242863, 855.7261676263536, 883.9425437346551, 903.421810041574, 912.7079334612993, 939.7697564096703, 9190.0, 9493.288003399774, 9528.428294302365, 9623.759406014766, 9729.805403891882, 371245.0, 391456.0, 418421.0, 419636.0, 422259.0, 73345.0, 75072.0, 75481.24518754742, 75776.24223757802, 77443.2255677436, 917.9219766319804, 922.395830730859, 925.9120383563551, 929.7536152919482, 936.321167153808, 15116.848831511545, 15132.924335378693, 15206.391744330103, 15295.541133766004, 15334.539963801104, 35453.645463545035, 35649.82175089108, 35799.82100089483, 36328.4550731734, 36626.81686591657, 48722.5127748718, 49590.50409496003, 50251.24623130729, 50851.491485084676, 50992.49007509877, 7677.193894640982, 7792.0, 7835.725749598737, 7900.881486777818, 7934.008248968879, 8087.353011759163, 8620.78448038804, 8919.687810926587, 11926.522939082339, 12092.576759813364, 10082.495875206063, 10344.689659310232, 10593.682189534326, 10641.255112142077, 10759.623413180814, 10577.100946419641, 10620.415877126832, 10702.411367374869, 10705.732356691145, 10758.73103172427, 10550.841737373792, 10587.417692027013, 10610.575576976835, 10726.839097413702, 10785.568577256821, 7338.596377199306, 7490.288422599844, 7657.770266892002, 7720.459567830198, 7961.363090952594, 8858.0, 9351.438913665203, 9990.500474976367, 10284.845727314247, 10981.231313807957], "value": 8042.2374703916175, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.5144075294027, 1438.5612388221593, 1544.8146222453308, 1734.0, 1738.1569938579787, 6513.21841379034, 7456.142543607487, 7493.437992150583, 7934.285914267722, 8025.077116131647, 7589.316961473466, 7753.147153813076, 7834.64744086516, 7863.370930325575, 7874.488158269708, 2153.9784602153973, 2178.9999999999923, 2188.8248940084754, 2190.9561808763815, 2195.758466568684, 2107.3677896631025, 2107.525806693497, 2185.2460900989213, 2210.3148024112497, 2210.6794514795347, 2145.4743587821004, 2154.429076294783, 2158.6114499390105, 2160.503084290614, 2194.319760874126, 2087.123408168573, 2095.706601075851, 2099.9265025724103, 2100.6638937770035, 2100.9474763130893, 2031.1266155553105, 2072.927447539329, 2091.0903756865814, 2112.324056301984, 2113.1019316790303, 7723.0, 7731.342835858959, 7790.727324543614, 7804.765857024298, 7837.608119594054, 4364.388985542027, 4455.754933478657, 4456.93314600278, 4500.167469018242, 4502.684812063157, 2708.79684023697, 2748.9037883673977, 2854.743073123408, 2904.8257104573795, 2918.1974956886816, 894.9731508054704, 924.1820988425225, 931.0968360690119, 937.6718148647986, 939.8543225800012, 10536.631217907336, 10568.365898046064, 10574.682759517227, 10598.682039538826, 10610.62862799806, 3981.2833689936087, 4077.368007958771, 4154.833806647761, 4155.563665815106, 4169.0, 8995.505247211335, 9009.189172974464, 9016.59425325862, 9066.320025997944, 9088.818223635622, 4510.300903359985, 4555.658325625592, 4562.5665561771575, 4586.082783443325, 4587.655925805511, 3589.6769290763955, 4074.5314288856566, 4205.411242426063, 4220.11377610699, 4254.234237837157, 3599.5680518337967, 3648.416253399443, 3698.3158115748674, 3707.9814600926825, 3728.12389088564, 1137.9886201137883, 1190.4226450171832, 1195.384377045822, 1205.3189947679532, 1206.8189771534164, 863.9416714524782, 913.5980168725739, 922.9307801914883, 931.7158266728712, 933.118203297877, 5417.295751552352, 5430.212619170198, 5562.221289019541, 5600.299962504687, 5651.237082993825, 382.5027464296459, 383.3502213747727, 390.4904100149276, 391.7453655124192, 391.86676529979945, 3799.297130030953, 3843.2505661396317, 3845.615438456132, 3895.4156876468755, 3904.1606054698377, 8940.552972351357, 9220.216281616003, 9261.44431334122, 9270.0, 9278.48968306736, 8821.60302786376, 9135.360524763202, 9140.725778226664, 9168.770780730536, 9182.17360437564, 6990.335918087773, 7003.54476958996, 7023.578585284899, 7028.0863487746265, 7089.078419805495, 5153.613478989166, 5180.6891586504935, 5225.843224703265, 5310.601704872072, 5319.6808191508635, 8380.287675547646, 8434.114417986024, 8442.493450392996, 8668.393212475066, 8669.60986755585, 8492.938382702163, 8702.08628094041, 8702.564871756513, 8708.129187081495, 8712.78218044554, 5801.970990145022, 6519.315471875385, 6626.4367528760595, 6820.079289295882, 6925.515213934977, 7605.809854753676, 7609.086909570887, 7658.195889431529, 7701.229877012254, 7707.537547747153, 6785.219699734594, 6906.067680863019, 7015.824604384931, 7034.929650703428, 7058.223595404604, 6709.463242940651, 6754.86490270182, 6775.390214880685, 6822.795316140524, 7009.439244860501, 6150.446459818638, 6191.226096737908, 6206.565540412128, 6207.565470417208, 6456.063870738811, 4569.1547063793305, 4622.214223582067, 4622.329762184531, 4680.110778951988, 4701.905961880811, 4408.537103604075, 4450.1989641864775, 4481.7535035573355, 4485.237509623306, 4571.0629320988455], "value": 4031.393076686355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.5743257411606, 297.87489254513105, 299.8246026074746, 304.22878004259206, 307.26256983240233, 4865.245886887538, 4926.926096108561, 5096.77064532096, 5104.4385117637075, 5108.8978220435565, 4972.154733695272, 5018.172001619729, 5025.673331233476, 5026.271190677358, 5056.393232812058, 3922.646961773447, 3924.54867690215, 3932.921341573167, 3949.3878448840474, 3969.960300396988, 3871.5741268460447, 3933.5083114610675, 3985.980070099645, 3992.5608183099835, 4001.2197621463824, 3898.785566793825, 3900.941485877714, 3911.963329717613, 3928.469656596366, 3936.7441116327345, 3878.1855810279876, 3940.8423663053445, 3942.802859856996, 3943.507061617298, 3952.9011774705573, 3200.439923013487, 3257.397381484433, 3260.2664400509934, 3309.520119582671, 3496.947545786815, 4817.614590832725, 4833.0, 4847.297141914438, 4847.5637192652475, 4859.663592512052, 4333.133373325348, 4339.218940590692, 4349.717268377577, 4368.322909948963, 4385.627221686129, 5113.437521872591, 5255.3168088148295, 5259.15853463444, 5264.42091369949, 5275.182346736262, 3660.798656073915, 3692.2246328271094, 3707.6663100321102, 3714.461403096536, 3716.3867961786273, 5505.697186654733, 5516.448355164492, 5537.197106419587, 5546.140348246028, 5558.277423934903, 3695.3717867961973, 3786.8674596388996, 3816.561095474056, 3823.6941044716355, 3843.8078096095082, 3835.5972622874756, 3850.8652197173524, 3851.691864650821, 3853.7687738735203, 3878.2437424702475, 4416.624586910084, 4427.645788336926, 4434.17967675981, 4449.755263460541, 4466.0, 5212.914834066404, 5279.234510995961, 5317.494837990462, 5330.120530112566, 5340.836961030789, 1317.4730107956702, 1331.993340033313, 1336.85294617592, 1340.1088276296348, 1340.9463621455031, 820.4216027700456, 821.2608652213056, 836.5440834745078, 843.6372359885308, 853.4623187392027, 4140.896477588024, 4144.6529877789235, 4145.5697784264385, 4159.648114362844, 4200.894977625584, 4847.945794149663, 4848.393950756155, 4871.829485968045, 4875.95124048762, 4903.670756390758, 4150.149219410014, 4190.198214767618, 4197.706160568731, 4212.241796476664, 4221.050263690645, 2491.327341617753, 2580.574205256112, 2596.857172855511, 2608.9217323480325, 2640.2211347652487, 4530.388397566352, 4551.748269225923, 4555.635549156126, 4577.427821522309, 4581.633469322446, 4888.633352498577, 4929.260610908321, 4941.431735350408, 4962.727050012212, 4964.304997300381, 4225.71115809681, 4551.408316918845, 4569.337446070234, 4579.38178345919, 4586.743412177325, 4811.663183577256, 4819.445763737215, 4833.154198015263, 4856.838706775592, 4885.169521181479, 4699.0, 4759.42886853566, 4791.592714619296, 4798.712077275374, 4802.591779698765, 4339.826406943813, 4460.929376949573, 4536.387587675622, 4536.818527258873, 4558.8632341029825, 3444.8297572529145, 3560.2345495718546, 3630.382834918123, 3730.0861288984374, 3745.8127093645753, 5387.218853266176, 5397.190421436816, 5432.619716619799, 5449.863753406196, 5469.562435005269, 5164.870878228075, 5234.869128271824, 5239.554637855825, 5251.006926052114, 5270.683758974474, 5073.103913764176, 5104.081265372269, 5170.22446632993, 5171.612129090258, 5182.818601348935, 5043.839916819079, 5049.26785616091, 5115.184109641173, 5131.820386286462, 5178.352705911761, 5274.630775845808, 5304.814331498534, 5307.230451584422, 5316.229146773773, 5316.920246196388, 4971.676841005323, 5237.931017248089, 5279.6040296978645, 5301.1783173608155, 5319.2287118368395], "value": 3819.3578214534336, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.579765253759, 647.4140902483255, 719.1314798812043, 745.1579714922138, 758.2495664660901, 12309.38453077346, 12465.439055242514, 12476.189047711916, 12509.374531273446, 12612.558560450374, 13091.0, 13162.670933226675, 13261.734765304687, 13294.667633309147, 13325.800112998313, 773.7330620935796, 802.2098233240254, 804.4208170117506, 805.2028491793142, 806.4193780478075, 617.8640699046202, 769.4959801330137, 791.4499422901057, 796.760971708488, 801.4550105927966, 833.4999000599622, 840.2899549880341, 843.2326582809644, 847.1951645936355, 848.7284069097891, 834.6619619054293, 842.389267780857, 843.4348986179275, 843.5655637346771, 844.7845799321195, 612.1796792298297, 615.6829232945037, 615.7690865925279, 618.4866560754563, 618.8545691762432, 12572.30852303123, 12645.178063425848, 12660.11379203456, 12693.746125077447, 12700.682482937907, 11635.301881887113, 11760.29475726015, 11762.0, 11762.294262344201, 12292.508299668003, 10026.498675066217, 10062.748431289203, 10373.222008349328, 10407.635732749393, 10885.23803333767, 3250.4961730931745, 3253.7071663550396, 3322.734181265493, 3338.849751761177, 3386.102682789063, 57148.428515714724, 58303.0, 58423.41576584222, 58956.41043589552, 60019.0, 9444.602620392754, 9536.666216682383, 9598.944116147219, 9647.951760241154, 9670.56482458291, 18150.27398904029, 18721.625567488845, 18760.71858922117, 18784.812151878305, 18818.623627527646, 5898.262717160355, 6002.459778619946, 6020.036794113009, 6023.045903556003, 6126.724297406628, 3169.16658784409, 3258.7881787683723, 3258.951115733266, 3313.188268874141, 3324.5345651608795, 2942.367391010943, 3063.678313777066, 3077.7999430036975, 3085.6760040195904, 3094.6131733533307, 506.36704119850185, 509.08619028843316, 510.64510165434666, 531.7447625139877, 538.9973050134724, 541.7237209023426, 563.9876421822756, 565.5758181363977, 566.0999011571621, 592.3277080513562, 7409.296116868889, 7632.542047477169, 7702.537847729154, 7755.0, 7846.136924938252, 477.1054273237679, 534.2947309551355, 574.7814632978029, 616.5899676714935, 648.9221293444817, 3460.636633153533, 3727.6645101940953, 3732.2162345907122, 3786.2238241160494, 3825.2731980923536, 85435.5728221355, 86276.0, 88793.0, 91427.54286228526, 92893.0, 48752.5124748748, 48890.26664600034, 60637.0, 62691.373086269465, 72665.6366718163, 69585.0, 71202.0, 71626.64186679137, 72366.0, 72878.27121728715, 7052.682629281592, 7172.856542869009, 7183.317584829433, 7252.2747725227055, 7318.597477138595, 40404.3939340916, 41651.166976660905, 42363.364549531165, 42755.786221068694, 43447.565524344354, 52685.47314526806, 60026.0, 60720.39279607324, 60853.69573152106, 61007.0, 9221.907780922373, 9300.953495232481, 9394.95302523483, 9732.367396119229, 9758.316917815684, 11027.22809403334, 11208.103351732005, 11223.4388280584, 11544.94227528857, 11795.764084718086, 9522.619095236112, 9631.181349585364, 9683.854742178732, 10752.0323170915, 10954.671359859218, 9675.322727409013, 9704.660336888457, 9867.55595998196, 9879.407235565888, 9926.553305101143, 10262.0, 10448.634297799541, 11070.5571777128, 11087.778244435227, 11286.604968826052, 9578.090081442251, 9601.279904007368, 9823.508824558601, 9922.107010369102, 10310.845337320095, 9590.136887680143, 9609.951950240204, 9621.51892405391, 9667.27495437859, 9790.75523111928], "value": 6206.500598914303, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 116.0, 116.0, 117.0, 115.0, 115.0, 115.0, 115.0, 119.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 136.0, 157.0, 187.0, 140.0, 159.0, 165.0, 133.0, 201.0, 138.0], "value": 158.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 175.0, 162.0, 162.0, 165.0, 166.0, 163.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 75.0, 165.0, 76.0, 77.0, 76.0, 76.0, 164.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 135.0, 87.0, 86.0, 86.0, 131.0, 85.0, 88.0, 144.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 118.0, 117.0, 118.0, 119.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 149.0, 149.0, 147.0, 149.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 66.0, 65.0, 66.0, 66.0, 68.0, 65.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 88.0, 86.0, 85.0, 93.0, 85.0, 110.0, 86.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 147.0, 135.0, 134.0, 132.0, 134.0, 134.0, 133.0, 137.0, 136.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 168.0, 171.0, 183.0, 168.0, 174.0, 179.0, 170.0, 168.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 69.0, 69.0, 74.0, 68.0, 77.0, 68.0, 68.0], "value": 69.7, "unit": "score"}]}]} 08:22:26 INFO - Return code: 0 08:22:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:22:26 ERROR - # TBPL SUCCESS # 08:22:26 INFO - Running post-action listener: _resource_record_post_action 08:22:26 INFO - ##### 08:22:26 INFO - ##### Finished run-tests step (success) 08:22:26 INFO - ##### 08:22:26 INFO - Running post-run listener: _resource_record_post_run 08:22:26 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 4096; Write bytes: 537706496; Read time: 12; Write time: 583604 08:22:26 INFO - TinderboxPrint: CPU usage
13.5% 08:22:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:22:26 INFO - TinderboxPrint: I/O write bytes / time
537,706,496 / 583,604 08:22:26 INFO - TinderboxPrint: CPU idle
8,264.1 (86.4%) 08:22:26 INFO - TinderboxPrint: CPU user
1,237.5 (12.9%) 08:22:26 INFO - TinderboxPrint: Swap in / out
0 / 0 08:22:26 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237502464; Read time: 0; Write time: 293460 08:22:26 INFO - run-tests - Wall time: 1182s; CPU: 14.0%; Read bytes: 4096; Write bytes: 300146688; Read time: 12; Write time: 290124 08:22:27 INFO - Running post-run listener: _upload_blobber_files 08:22:27 INFO - Blob upload gear active. 08:22:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:22:27 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 08:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:22:27 INFO - (blobuploader) - INFO - Open directory for files ... 08:22:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:22:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:22:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:28 INFO - (blobuploader) - INFO - Done attempting. 08:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:22:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:31 INFO - (blobuploader) - INFO - Done attempting. 08:22:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:22:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:22:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:32 INFO - (blobuploader) - INFO - Done attempting. 08:22:32 INFO - (blobuploader) - INFO - Iteration through files over. 08:22:32 INFO - Return code: 0 08:22:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:22:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:22:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26f3c46362005f4c26be685e82d47bbe298f076cb272e39cb4e1f0a2d13c7e9ef73d24d1d342cd201f89176ef8e46f0e438a2044d5906f28b8470d38fb2c6f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb49998bbf5815f562af3200309a9a6b55c10d7caa6ddc40d879a22089c46991f8b583e7a0fe448f93edf7bc540a3471c6a701a27ae31e07b02e99acf985c2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c787ee21a4841e3e7e5d8ab8620d6ddf32be3d293219e570fdadf62fc1c0bfe9a883d9fe66b6b21874844b8be045cc6cde3b9f27dd6e111fe2ee986666b90275"} 08:22:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:22:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:22:32 INFO - Contents: 08:22:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26f3c46362005f4c26be685e82d47bbe298f076cb272e39cb4e1f0a2d13c7e9ef73d24d1d342cd201f89176ef8e46f0e438a2044d5906f28b8470d38fb2c6f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb49998bbf5815f562af3200309a9a6b55c10d7caa6ddc40d879a22089c46991f8b583e7a0fe448f93edf7bc540a3471c6a701a27ae31e07b02e99acf985c2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c787ee21a4841e3e7e5d8ab8620d6ddf32be3d293219e570fdadf62fc1c0bfe9a883d9fe66b6b21874844b8be045cc6cde3b9f27dd6e111fe2ee986666b90275"} 08:22:32 INFO - Running post-run listener: copy_logs_to_upload_dir 08:22:32 INFO - Copying logs to upload dir... 08:22:32 INFO - mkdir: /builds/slave/test/build/upload/logs 08:22:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.260485 ========= master_lag: -0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-07 08:22:32.229409) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:22:32.232616) ========= 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=836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26f3c46362005f4c26be685e82d47bbe298f076cb272e39cb4e1f0a2d13c7e9ef73d24d1d342cd201f89176ef8e46f0e438a2044d5906f28b8470d38fb2c6f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb49998bbf5815f562af3200309a9a6b55c10d7caa6ddc40d879a22089c46991f8b583e7a0fe448f93edf7bc540a3471c6a701a27ae31e07b02e99acf985c2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c787ee21a4841e3e7e5d8ab8620d6ddf32be3d293219e570fdadf62fc1c0bfe9a883d9fe66b6b21874844b8be045cc6cde3b9f27dd6e111fe2ee986666b90275"} build_url:https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/Lzj7SAD8QPu7Pm7wLFcWcQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26f3c46362005f4c26be685e82d47bbe298f076cb272e39cb4e1f0a2d13c7e9ef73d24d1d342cd201f89176ef8e46f0e438a2044d5906f28b8470d38fb2c6f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb49998bbf5815f562af3200309a9a6b55c10d7caa6ddc40d879a22089c46991f8b583e7a0fe448f93edf7bc540a3471c6a701a27ae31e07b02e99acf985c2c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c787ee21a4841e3e7e5d8ab8620d6ddf32be3d293219e570fdadf62fc1c0bfe9a883d9fe66b6b21874844b8be045cc6cde3b9f27dd6e111fe2ee986666b90275"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:22:32.261267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:22:32.261974) ========= 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=836cfdc75598d54cb747368e000001a9-1465311400.61117-1808484035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:22:32.344823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:22:32.345585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:22:32.346081) ========= ========= Total master_lag: 0.03 =========