builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1464983714.3 results: success (0) buildid: 20160603122625 builduid: 7896b0d4d72143e98bf31ad2ac9d891b revision: f5253aba046fab63710ccee19bcfc3300d9e6a25 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:14.297170) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:14.297692) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:14.297973) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:14.350653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:14.351000) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 12:55:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.8M=0s 2016-06-03 12:55:14 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086842 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:14.456339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:14.456665) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017580 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:14.530955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:14.531359) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5253aba046fab63710ccee19bcfc3300d9e6a25 --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 f5253aba046fab63710ccee19bcfc3300d9e6a25 --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=74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 12:55:14,957 truncating revision to first 12 chars 2016-06-03 12:55:14,957 Setting DEBUG logging. 2016-06-03 12:55:14,957 attempt 1/10 2016-06-03 12:55:14,957 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5253aba046f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 12:55:15,254 unpacking tar archive at: fx-team-f5253aba046f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677551 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:15.226754) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:15.227056) ========= script_repo_revision: f5253aba046fab63710ccee19bcfc3300d9e6a25 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:15.227451) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:15.227732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 12:55:15.237494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2016-06-03 12:55:15.237776) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:55:15 INFO - MultiFileLogger online at 20160603 12:55:15 in /builds/slave/test 12:55:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:55:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:55:15 INFO - {'append_to_log': False, 12:55:15 INFO - 'base_work_dir': '/builds/slave/test', 12:55:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:55:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:55:15 INFO - 'branch': 'Fx-Team-Non-PGO', 12:55:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:55:15 INFO - 'config_files': ('talos/linux_config.py',), 12:55:15 INFO - 'default_actions': ('clobber', 12:55:15 INFO - 'read-buildbot-config', 12:55:15 INFO - 'download-and-extract', 12:55:15 INFO - 'populate-webroot', 12:55:15 INFO - 'create-virtualenv', 12:55:15 INFO - 'install', 12:55:15 INFO - 'run-tests'), 12:55:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:55:15 INFO - 'download_minidump_stackwalk': True, 12:55:15 INFO - 'download_symbols': 'ondemand', 12:55:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:55:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:55:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:55:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:55:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:55:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:55:15 INFO - 'installer_path': 'installer.exe', 12:55:15 INFO - 'log_level': 'info', 12:55:15 INFO - 'log_name': 'talos', 12:55:15 INFO - 'log_to_console': True, 12:55:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:55:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:55:15 INFO - 'opt_config_files': (), 12:55:15 INFO - 'pip_index': False, 12:55:15 INFO - 'sps_profile': False, 12:55:15 INFO - 'sps_profile_interval': 0, 12:55:15 INFO - 'suite': 'dromaeojs', 12:55:15 INFO - 'system_bits': '32', 12:55:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:55:15 INFO - 'title': 'talos-linux64-ix-042', 12:55:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:55:15 INFO - 'use_talos_json': True, 12:55:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:55:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:55:15 INFO - 'work_dir': 'build'} 12:55:15 INFO - ##### 12:55:15 INFO - ##### Running clobber step. 12:55:15 INFO - ##### 12:55:15 INFO - Running pre-action listener: _resource_record_pre_action 12:55:15 INFO - Running main action method: clobber 12:55:15 INFO - rmtree: /builds/slave/test/build 12:55:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:55:16 INFO - Running post-action listener: _resource_record_post_action 12:55:16 INFO - ##### 12:55:16 INFO - ##### Finished clobber step (success) 12:55:16 INFO - ##### 12:55:16 INFO - ##### 12:55:16 INFO - ##### Running read-buildbot-config step. 12:55:16 INFO - ##### 12:55:16 INFO - Running pre-action listener: _resource_record_pre_action 12:55:16 INFO - Running main action method: read_buildbot_config 12:55:16 INFO - Using buildbot properties: 12:55:16 INFO - { 12:55:16 INFO - "project": "", 12:55:16 INFO - "product": "firefox", 12:55:16 INFO - "script_repo_revision": "production", 12:55:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:55:16 INFO - "repository": "", 12:55:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:55:16 INFO - "buildid": "20160603122625", 12:55:16 INFO - "pgo_build": "False", 12:55:16 INFO - "basedir": "/builds/slave/test", 12:55:16 INFO - "buildnumber": 3042, 12:55:16 INFO - "slavename": "talos-linux64-ix-042", 12:55:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:55:16 INFO - "platform": "ubuntu64_hw", 12:55:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:55:16 INFO - "branch": "fx-team", 12:55:16 INFO - "repo_path": "integration/fx-team", 12:55:16 INFO - "revision": "f5253aba046fab63710ccee19bcfc3300d9e6a25", 12:55:16 INFO - "stage_platform": "linux64", 12:55:16 INFO - "builduid": "7896b0d4d72143e98bf31ad2ac9d891b", 12:55:16 INFO - "slavebuilddir": "test" 12:55:16 INFO - } 12:55:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:55:16 INFO - Running post-action listener: _resource_record_post_action 12:55:16 INFO - ##### 12:55:16 INFO - ##### Finished read-buildbot-config step (success) 12:55:16 INFO - ##### 12:55:16 INFO - ##### 12:55:16 INFO - ##### Running download-and-extract step. 12:55:16 INFO - ##### 12:55:16 INFO - Running pre-action listener: _resource_record_pre_action 12:55:16 INFO - Running main action method: download_and_extract 12:55:16 INFO - mkdir: /builds/slave/test/build/tests 12:55:16 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')]} 12:55:16 INFO - https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:55:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:55:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:55:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:55:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:55:24 INFO - Downloaded 1361 bytes. 12:55:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:55:24 INFO - Using the following test package requirements: 12:55:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:55:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:55:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:55:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:24 INFO - u'jsshell-linux-x86_64.zip'], 12:55:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:55:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:55:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:55:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:55:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:55:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:55:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:55: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')]} 12:55:24 INFO - https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:55:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:55:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:55:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:55:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:56:00 INFO - Downloaded 22868152 bytes. 12:56:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:56:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:56:01 INFO - Return code: 0 12:56:01 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:56: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')]} 12:56:01 INFO - https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:56:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:56:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:56:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:56:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:56:03 INFO - Downloaded 22868152 bytes. 12:56:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:56:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:56:05 INFO - Return code: 0 12:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:05 INFO - https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:56:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:56:23 INFO - Downloaded 10833369 bytes. 12:56:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:56:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:56:23 INFO - Return code: 0 12:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:23 INFO - https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:56:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:56:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:56:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:56:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:56:26 INFO - Downloaded 55185530 bytes. 12:56:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:56:26 INFO - mkdir: /builds/slave/test/properties 12:56:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:56:26 INFO - Writing to file /builds/slave/test/properties/build_url 12:56:26 INFO - Contents: 12:56:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:56:26 INFO - Running post-action listener: _resource_record_post_action 12:56:26 INFO - Running post-action listener: set_extra_try_arguments 12:56:26 INFO - ##### 12:56:26 INFO - ##### Finished download-and-extract step (success) 12:56:26 INFO - ##### 12:56:26 INFO - ##### 12:56:26 INFO - ##### Running populate-webroot step. 12:56:26 INFO - ##### 12:56:26 INFO - Running pre-action listener: _resource_record_pre_action 12:56:26 INFO - Running main action method: populate_webroot 12:56:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:56:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:56:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:56:26 INFO - '--tppagecycles', 12:56:26 INFO - '7'], 12:56:26 INFO - 'tests': ['tsvgm']}}, 12:56:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:56:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:56:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:56:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:56:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:56:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:56:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:26 INFO - 'talos_options': ['--disable-e10s'], 12:56:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:26 INFO - 'talos_options': ['--disable-e10s'], 12:56:26 INFO - 'tests': ['damp', 'tps']}, 12:56:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:26 INFO - 'tests': ['damp', 'tps']}, 12:56:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:56:26 INFO - 'tests': ['dromaeo_dom']}, 12:56:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:56:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:56:26 INFO - 'tests': ['a11yr', 12:56:26 INFO - 'ts_paint', 12:56:26 INFO - 'tpaint', 12:56:26 INFO - 'sessionrestore', 12:56:26 INFO - 'sessionrestore_no_auto_restore', 12:56:26 INFO - 'tabpaint']}, 12:56:26 INFO - 'other-e10s': {'tests': ['a11yr', 12:56:26 INFO - 'ts_paint', 12:56:26 INFO - 'tpaint', 12:56:26 INFO - 'sessionrestore', 12:56:26 INFO - 'sessionrestore_no_auto_restore', 12:56:26 INFO - 'tabpaint']}, 12:56:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:56:26 INFO - 'ts_paint', 12:56:26 INFO - 'tpaint', 12:56:26 INFO - 'sessionrestore', 12:56:26 INFO - 'sessionrestore_no_auto_restore', 12:56:26 INFO - 'tabpaint']}, 12:56:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:56:26 INFO - 'ts_paint', 12:56:26 INFO - 'tpaint', 12:56:26 INFO - 'sessionrestore', 12:56:26 INFO - 'sessionrestore_no_auto_restore', 12:56:26 INFO - 'tabpaint']}, 12:56:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:56:26 INFO - 'tests': ['a11yr', 12:56:26 INFO - 'ts_paint', 12:56:26 INFO - 'tpaint', 12:56:26 INFO - 'sessionrestore', 12:56:26 INFO - 'sessionrestore_no_auto_restore', 12:56:26 INFO - 'tabpaint']}, 12:56:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:56:26 INFO - 'tests': ['a11yr', 12:56:26 INFO - 'ts_paint', 12:56:26 INFO - 'tpaint', 12:56:26 INFO - 'sessionrestore', 12:56:26 INFO - 'sessionrestore_no_auto_restore', 12:56:26 INFO - 'tabpaint']}, 12:56:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:56:26 INFO - 'tests': ['tsvgx', 12:56:26 INFO - 'tsvgr_opacity', 12:56:26 INFO - 'tart', 12:56:26 INFO - 'tscrollx', 12:56:26 INFO - 'cart']}, 12:56:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:56:26 INFO - 'tsvgr_opacity', 12:56:26 INFO - 'tart', 12:56:26 INFO - 'tscrollx', 12:56:26 INFO - 'cart']}, 12:56:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:26 INFO - 'talos_options': ['--disable-e10s'], 12:56:26 INFO - 'tests': ['tp5o']}, 12:56:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:26 INFO - 'tests': ['tp5o']}, 12:56:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:26 INFO - 'talos_options': ['--disable-e10s', 12:56:26 INFO - '--xperf_path', 12:56:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:26 INFO - 'tests': ['tp5n']}, 12:56:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:26 INFO - 'talos_options': ['--xperf_path', 12:56:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:26 INFO - 'tests': ['tp5n']}}, 12:56:26 INFO - 'talos.zip': {'path': '', 12:56:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:56:26 INFO - Running post-action listener: _resource_record_post_action 12:56:26 INFO - ##### 12:56:26 INFO - ##### Finished populate-webroot step (success) 12:56:26 INFO - ##### 12:56:26 INFO - ##### 12:56:26 INFO - ##### Running create-virtualenv step. 12:56:26 INFO - ##### 12:56:26 INFO - Running pre-action listener: _resource_record_pre_action 12:56:26 INFO - Running main action method: create_virtualenv 12:56:26 INFO - Creating virtualenv /builds/slave/test/build/venv 12:56:26 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 12:56:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:56:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:56:27 INFO - Using real prefix '/usr' 12:56:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:56:27 INFO - Installing distribute.............................................................................................................................................................................................done. 12:56:29 INFO - Installing pip.................done. 12:56:29 INFO - Return code: 0 12:56:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:29 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 0x7f2307541f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12182e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1212e20>, '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 0x12163a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216830>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', '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 12:56:29 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 12:56:29 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 12:56:29 INFO - Using env: {'DISPLAY': ':0', 12:56:29 INFO - 'HOME': '/home/cltbld', 12:56:29 INFO - 'LANG': 'en_US.UTF-8', 12:56:29 INFO - 'LANGUAGE': 'en_US:en', 12:56:29 INFO - 'LOGNAME': 'cltbld', 12:56:29 INFO - 'MAIL': '/var/mail/cltbld', 12:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:29 INFO - 'MOZ_NO_REMOTE': '1', 12:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:29 INFO - 'NO_EM_RESTART': '1', 12:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:29 INFO - 'PWD': '/builds/slave/test', 12:56:29 INFO - 'SHELL': '/bin/bash', 12:56:29 INFO - 'SHLVL': '1', 12:56:29 INFO - 'TERM': 'linux', 12:56:29 INFO - 'TMOUT': '86400', 12:56:29 INFO - 'USER': 'cltbld', 12:56:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', 12:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:29 INFO - '_': '/tools/buildbot/bin/python'} 12:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:29 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 12:56:29 INFO - Cleaning up... 12:56:29 INFO - Return code: 0 12:56:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:29 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 0x7f2307541f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12182e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1212e20>, '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 0x12163a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216830>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', '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 12:56:29 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 12:56:29 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 12:56:29 INFO - Using env: {'DISPLAY': ':0', 12:56:29 INFO - 'HOME': '/home/cltbld', 12:56:29 INFO - 'LANG': 'en_US.UTF-8', 12:56:29 INFO - 'LANGUAGE': 'en_US:en', 12:56:29 INFO - 'LOGNAME': 'cltbld', 12:56:29 INFO - 'MAIL': '/var/mail/cltbld', 12:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:29 INFO - 'MOZ_NO_REMOTE': '1', 12:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:29 INFO - 'NO_EM_RESTART': '1', 12:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:29 INFO - 'PWD': '/builds/slave/test', 12:56:29 INFO - 'SHELL': '/bin/bash', 12:56:29 INFO - 'SHLVL': '1', 12:56:29 INFO - 'TERM': 'linux', 12:56:29 INFO - 'TMOUT': '86400', 12:56:29 INFO - 'USER': 'cltbld', 12:56:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', 12:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:29 INFO - '_': '/tools/buildbot/bin/python'} 12:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:29 INFO - Downloading/unpacking psutil>=3.1.1 12:56:29 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 12:56:29 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 12:56:29 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 12:56:29 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 12:56:29 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 12:56:29 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 12:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:56:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:32 INFO - Installing collected packages: psutil 12:56:32 INFO - Running setup.py install for psutil 12:56:32 INFO - building 'psutil._psutil_linux' extension 12:56:32 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 12:56:32 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 12:56:32 INFO - building 'psutil._psutil_posix' extension 12:56:32 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 12:56:32 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 12:56:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:32 INFO - Successfully installed psutil 12:56:32 INFO - Cleaning up... 12:56:32 INFO - Return code: 0 12:56:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:56:32 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')]} 12:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:32 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')]} 12:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:32 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 0x7f2307541f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12182e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1212e20>, '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 0x12163a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216830>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', '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 12:56:32 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 12:56:32 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 12:56:32 INFO - Using env: {'DISPLAY': ':0', 12:56:32 INFO - 'HOME': '/home/cltbld', 12:56:32 INFO - 'LANG': 'en_US.UTF-8', 12:56:32 INFO - 'LANGUAGE': 'en_US:en', 12:56:32 INFO - 'LOGNAME': 'cltbld', 12:56:32 INFO - 'MAIL': '/var/mail/cltbld', 12:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:32 INFO - 'MOZ_NO_REMOTE': '1', 12:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:32 INFO - 'NO_EM_RESTART': '1', 12:56:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:32 INFO - 'PWD': '/builds/slave/test', 12:56:32 INFO - 'SHELL': '/bin/bash', 12:56:32 INFO - 'SHLVL': '1', 12:56:32 INFO - 'TERM': 'linux', 12:56:32 INFO - 'TMOUT': '86400', 12:56:32 INFO - 'USER': 'cltbld', 12:56:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', 12:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:32 INFO - '_': '/tools/buildbot/bin/python'} 12:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:56:32 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 12:56:32 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 12:56:32 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 12:56:32 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 12:56:32 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 12:56:32 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 12:56:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:56:35 INFO - Installing collected packages: mozsystemmonitor 12:56:35 INFO - Running setup.py install for mozsystemmonitor 12:56:35 INFO - Successfully installed mozsystemmonitor 12:56:35 INFO - Cleaning up... 12:56:36 INFO - Return code: 0 12:56:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:56:36 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')]} 12:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:36 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')]} 12:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:36 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 0x7f2307541f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12182e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1212e20>, '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 0x12163a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216830>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', '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 12:56:36 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 12:56:36 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 12:56:36 INFO - Using env: {'DISPLAY': ':0', 12:56:36 INFO - 'HOME': '/home/cltbld', 12:56:36 INFO - 'LANG': 'en_US.UTF-8', 12:56:36 INFO - 'LANGUAGE': 'en_US:en', 12:56:36 INFO - 'LOGNAME': 'cltbld', 12:56:36 INFO - 'MAIL': '/var/mail/cltbld', 12:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:36 INFO - 'MOZ_NO_REMOTE': '1', 12:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:36 INFO - 'NO_EM_RESTART': '1', 12:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:36 INFO - 'PWD': '/builds/slave/test', 12:56:36 INFO - 'SHELL': '/bin/bash', 12:56:36 INFO - 'SHLVL': '1', 12:56:36 INFO - 'TERM': 'linux', 12:56:36 INFO - 'TMOUT': '86400', 12:56:36 INFO - 'USER': 'cltbld', 12:56:36 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', 12:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:36 INFO - '_': '/tools/buildbot/bin/python'} 12:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:36 INFO - Downloading/unpacking jsonschema==2.5.1 12:56:36 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 12:56:36 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 12:56:36 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 12:56:36 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 12:56:36 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 12:56:36 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 12:56:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:56:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:56:38 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 12:56:38 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 12:56:38 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 12:56:38 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 12:56:38 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 12:56:38 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 12:56:38 INFO - Downloading functools32-3.2.3-2.tar.gz 12:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:56:38 INFO - warning: no files found matching '*.txt' 12:56:38 INFO - no previously-included directories found matching 'build' 12:56:38 INFO - no previously-included directories found matching 'dist' 12:56:38 INFO - no previously-included directories found matching '.git*' 12:56:38 INFO - Installing collected packages: jsonschema, functools32 12:56:38 INFO - Running setup.py install for functools32 12:56:38 INFO - warning: no files found matching '*.txt' 12:56:38 INFO - no previously-included directories found matching 'build' 12:56:38 INFO - no previously-included directories found matching 'dist' 12:56:38 INFO - no previously-included directories found matching '.git*' 12:56:38 INFO - Successfully installed jsonschema functools32 12:56:38 INFO - Cleaning up... 12:56:38 INFO - Return code: 0 12:56:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:38 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 0x7f2307541f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12182e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1212e20>, '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 0x12163a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216830>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', '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 12:56:38 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 12:56:38 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 12:56:38 INFO - Using env: {'DISPLAY': ':0', 12:56:38 INFO - 'HOME': '/home/cltbld', 12:56:38 INFO - 'LANG': 'en_US.UTF-8', 12:56:38 INFO - 'LANGUAGE': 'en_US:en', 12:56:38 INFO - 'LOGNAME': 'cltbld', 12:56:38 INFO - 'MAIL': '/var/mail/cltbld', 12:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:38 INFO - 'MOZ_NO_REMOTE': '1', 12:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:38 INFO - 'NO_EM_RESTART': '1', 12:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:38 INFO - 'PWD': '/builds/slave/test', 12:56:38 INFO - 'SHELL': '/bin/bash', 12:56:38 INFO - 'SHLVL': '1', 12:56:38 INFO - 'TERM': 'linux', 12:56:38 INFO - 'TMOUT': '86400', 12:56:38 INFO - 'USER': 'cltbld', 12:56:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', 12:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:38 INFO - '_': '/tools/buildbot/bin/python'} 12:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:39 INFO - Downloading/unpacking blobuploader==1.2.4 12:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:40 INFO - Downloading blobuploader-1.2.4.tar.gz 12:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:56:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:56:41 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 12:56:41 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 12:56:41 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 12:56:41 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 12:56:41 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 12:56:41 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 12:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:56:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:56:41 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 12:56:41 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 12:56:41 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 12:56:41 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 12:56:41 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 12:56:41 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 12:56:41 INFO - Downloading docopt-0.6.1.tar.gz 12:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:56:41 INFO - Installing collected packages: blobuploader, requests, docopt 12:56:41 INFO - Running setup.py install for blobuploader 12:56:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:56:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:56:41 INFO - Running setup.py install for requests 12:56:42 INFO - Running setup.py install for docopt 12:56:42 INFO - Successfully installed blobuploader requests docopt 12:56:42 INFO - Cleaning up... 12:56:42 INFO - Return code: 0 12:56:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:42 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 0x7f2307541f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12182e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1212e20>, '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 0x12163a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216830>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', '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 12:56:42 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 12:56:42 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 12:56:42 INFO - Using env: {'DISPLAY': ':0', 12:56:42 INFO - 'HOME': '/home/cltbld', 12:56:42 INFO - 'LANG': 'en_US.UTF-8', 12:56:42 INFO - 'LANGUAGE': 'en_US:en', 12:56:42 INFO - 'LOGNAME': 'cltbld', 12:56:42 INFO - 'MAIL': '/var/mail/cltbld', 12:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:42 INFO - 'MOZ_NO_REMOTE': '1', 12:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:42 INFO - 'NO_EM_RESTART': '1', 12:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:42 INFO - 'PWD': '/builds/slave/test', 12:56:42 INFO - 'SHELL': '/bin/bash', 12:56:42 INFO - 'SHLVL': '1', 12:56:42 INFO - 'TERM': 'linux', 12:56:42 INFO - 'TMOUT': '86400', 12:56:42 INFO - 'USER': 'cltbld', 12:56:42 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', 12:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:42 INFO - '_': '/tools/buildbot/bin/python'} 12:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:56:42 INFO - Running setup.py (path:/tmp/pip-BXnog6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:56:42 INFO - Running setup.py (path:/tmp/pip-OHDuIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:56:42 INFO - Running setup.py (path:/tmp/pip-LoS2vX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:56:42 INFO - Running setup.py (path:/tmp/pip-UU2gTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:56:42 INFO - Running setup.py (path:/tmp/pip-i0m5EG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:56:42 INFO - Running setup.py (path:/tmp/pip-FN7sXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:56:42 INFO - Running setup.py (path:/tmp/pip-epa8V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:56:43 INFO - Running setup.py (path:/tmp/pip-d1yqYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:56:43 INFO - Running setup.py (path:/tmp/pip-zYNQ9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:56:43 INFO - Running setup.py (path:/tmp/pip-Ygp1FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:56:43 INFO - Running setup.py (path:/tmp/pip-UCPaJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:56:43 INFO - Running setup.py (path:/tmp/pip-NrmeCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:56:43 INFO - Running setup.py (path:/tmp/pip-SK0aBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:56:43 INFO - Running setup.py (path:/tmp/pip-5dwukZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:56:43 INFO - Running setup.py (path:/tmp/pip-9gvDQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:56:43 INFO - Running setup.py (path:/tmp/pip-dxoYmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:56:43 INFO - Running setup.py (path:/tmp/pip-9vXVVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:56:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:56:43 INFO - Running setup.py install for manifestparser 12:56:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:56:43 INFO - Running setup.py install for mozcrash 12:56:43 INFO - Running setup.py install for mozdebug 12:56:44 INFO - Running setup.py install for mozdevice 12:56:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:56:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:56:44 INFO - Running setup.py install for mozfile 12:56:44 INFO - Running setup.py install for mozhttpd 12:56:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:56:44 INFO - Running setup.py install for mozinfo 12:56:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:56:44 INFO - Running setup.py install for mozInstall 12:56:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:56:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:56:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:56:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:56:44 INFO - Running setup.py install for mozleak 12:56:44 INFO - Running setup.py install for mozlog 12:56:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:56:44 INFO - Running setup.py install for moznetwork 12:56:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:56:44 INFO - Running setup.py install for mozprocess 12:56:45 INFO - Running setup.py install for mozprofile 12:56:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:56:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:56:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:56:45 INFO - Running setup.py install for mozrunner 12:56:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:56:45 INFO - Running setup.py install for mozscreenshot 12:56:45 INFO - Running setup.py install for moztest 12:56:45 INFO - Running setup.py install for mozversion 12:56:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:56:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:56:45 INFO - Cleaning up... 12:56:45 INFO - Return code: 0 12:56:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:45 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 0x7f2307541f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12182e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1212e20>, '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 0x12163a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216830>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', '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 12:56:45 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 12:56:45 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 12:56:45 INFO - Using env: {'DISPLAY': ':0', 12:56:45 INFO - 'HOME': '/home/cltbld', 12:56:45 INFO - 'LANG': 'en_US.UTF-8', 12:56:45 INFO - 'LANGUAGE': 'en_US:en', 12:56:45 INFO - 'LOGNAME': 'cltbld', 12:56:45 INFO - 'MAIL': '/var/mail/cltbld', 12:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:45 INFO - 'MOZ_NO_REMOTE': '1', 12:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:45 INFO - 'NO_EM_RESTART': '1', 12:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:45 INFO - 'PWD': '/builds/slave/test', 12:56:45 INFO - 'SHELL': '/bin/bash', 12:56:45 INFO - 'SHLVL': '1', 12:56:45 INFO - 'TERM': 'linux', 12:56:45 INFO - 'TMOUT': '86400', 12:56:45 INFO - 'USER': 'cltbld', 12:56:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', 12:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:45 INFO - '_': '/tools/buildbot/bin/python'} 12:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:56:45 INFO - Running setup.py (path:/tmp/pip-YRhRar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:56:45 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)) 12:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:56:45 INFO - Running setup.py (path:/tmp/pip-UTN5Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:56:45 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)) 12:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:56:45 INFO - Running setup.py (path:/tmp/pip-gf24W0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:56:46 INFO - Running setup.py (path:/tmp/pip-MChhTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:56:46 INFO - Running setup.py (path:/tmp/pip-iC4xdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:56:46 INFO - Running setup.py (path:/tmp/pip-_ZP2_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:56:46 INFO - Running setup.py (path:/tmp/pip-g5z3CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:56:46 INFO - Running setup.py (path:/tmp/pip-5oob8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:56:46 INFO - Running setup.py (path:/tmp/pip-GP0D9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:56:46 INFO - Running setup.py (path:/tmp/pip-82bOhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:56:46 INFO - Running setup.py (path:/tmp/pip-72gMCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:56:46 INFO - Running setup.py (path:/tmp/pip-kdWv2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:56:46 INFO - Running setup.py (path:/tmp/pip-luQeu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:56:46 INFO - Running setup.py (path:/tmp/pip-lfRTVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:56:46 INFO - Running setup.py (path:/tmp/pip-iDHser-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:56:46 INFO - Running setup.py (path:/tmp/pip-7dcxoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:56:46 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)) 12:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:56:46 INFO - Running setup.py (path:/tmp/pip-2yrV7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:56:47 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)) 12:56:47 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)) 12:56:47 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)) 12:56:47 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)) 12:56:47 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)) 12:56:47 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)) 12:56:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:48 INFO - Downloading blessings-1.6.tar.gz 12:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:56:49 INFO - Installing collected packages: blessings 12:56:49 INFO - Running setup.py install for blessings 12:56:49 INFO - Successfully installed blessings 12:56:49 INFO - Cleaning up... 12:56:49 INFO - Return code: 0 12:56:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:56:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:56:49 INFO - Reading from file tmpfile_stdout 12:56:49 INFO - Current package versions: 12:56:49 INFO - argparse == 1.2.1 12:56:49 INFO - blessings == 1.6 12:56:49 INFO - blobuploader == 1.2.4 12:56:49 INFO - docopt == 0.6.1 12:56:49 INFO - functools32 == 3.2.3-2 12:56:49 INFO - jsonschema == 2.5.1 12:56:49 INFO - manifestparser == 1.1 12:56:49 INFO - mozInstall == 1.12 12:56:49 INFO - mozcrash == 0.17 12:56:49 INFO - mozdebug == 0.1 12:56:49 INFO - mozdevice == 0.48 12:56:49 INFO - mozfile == 1.2 12:56:49 INFO - mozhttpd == 0.7 12:56:49 INFO - mozinfo == 0.9 12:56:49 INFO - mozleak == 0.1 12:56:49 INFO - mozlog == 3.2 12:56:49 INFO - moznetwork == 0.27 12:56:49 INFO - mozprocess == 0.22 12:56:49 INFO - mozprofile == 0.28 12:56:49 INFO - mozrunner == 6.11 12:56:49 INFO - mozscreenshot == 0.1 12:56:49 INFO - mozsystemmonitor == 0.3 12:56:49 INFO - moztest == 0.7 12:56:49 INFO - mozversion == 1.4 12:56:49 INFO - psutil == 3.1.1 12:56:49 INFO - requests == 1.2.3 12:56:49 INFO - wsgiref == 0.1.2 12:56:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:56:49 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')]} 12:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:49 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')]} 12:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:49 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 0x7f2307541f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12182e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1212e20>, '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 0x12163a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216830>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', '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 12:56:49 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 12:56:49 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 12:56:49 INFO - Using env: {'DISPLAY': ':0', 12:56:49 INFO - 'HOME': '/home/cltbld', 12:56:49 INFO - 'LANG': 'en_US.UTF-8', 12:56:49 INFO - 'LANGUAGE': 'en_US:en', 12:56:49 INFO - 'LOGNAME': 'cltbld', 12:56:49 INFO - 'MAIL': '/var/mail/cltbld', 12:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:49 INFO - 'MOZ_NO_REMOTE': '1', 12:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:49 INFO - 'NO_EM_RESTART': '1', 12:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:49 INFO - 'PWD': '/builds/slave/test', 12:56:49 INFO - 'SHELL': '/bin/bash', 12:56:49 INFO - 'SHLVL': '1', 12:56:49 INFO - 'TERM': 'linux', 12:56:49 INFO - 'TMOUT': '86400', 12:56:49 INFO - 'USER': 'cltbld', 12:56:49 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', 12:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:49 INFO - '_': '/tools/buildbot/bin/python'} 12:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:49 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)) 12:56:49 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)) 12:56:49 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)) 12:56:49 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)) 12:56:49 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)) 12:56:49 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)) 12:56:49 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)) 12:56:49 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)) 12:56:49 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)) 12:56:49 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)) 12:56:49 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)) 12:56:49 INFO - Cleaning up... 12:56:49 INFO - Return code: 0 12:56:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:56:49 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')]} 12:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:49 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')]} 12:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:49 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 0x7f2307541f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12182e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1212e20>, '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 0x12163a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216830>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', '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 12:56:49 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 12:56:49 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 12:56:49 INFO - Using env: {'DISPLAY': ':0', 12:56:49 INFO - 'HOME': '/home/cltbld', 12:56:49 INFO - 'LANG': 'en_US.UTF-8', 12:56:49 INFO - 'LANGUAGE': 'en_US:en', 12:56:49 INFO - 'LOGNAME': 'cltbld', 12:56:49 INFO - 'MAIL': '/var/mail/cltbld', 12:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:49 INFO - 'MOZ_NO_REMOTE': '1', 12:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:49 INFO - 'NO_EM_RESTART': '1', 12:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:49 INFO - 'PWD': '/builds/slave/test', 12:56:49 INFO - 'SHELL': '/bin/bash', 12:56:49 INFO - 'SHLVL': '1', 12:56:49 INFO - 'TERM': 'linux', 12:56:49 INFO - 'TMOUT': '86400', 12:56:49 INFO - 'USER': 'cltbld', 12:56:49 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', 12:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:49 INFO - '_': '/tools/buildbot/bin/python'} 12:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:56:49 INFO - Cleaning up... 12:56:49 INFO - Return code: 0 12:56:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:56:49 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')]} 12:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:49 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')]} 12:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:49 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 0x7f2307541f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12182e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1212e20>, '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 0x12163a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216830>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', '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 12:56:49 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 12:56:49 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 12:56:49 INFO - Using env: {'DISPLAY': ':0', 12:56:49 INFO - 'HOME': '/home/cltbld', 12:56:49 INFO - 'LANG': 'en_US.UTF-8', 12:56:49 INFO - 'LANGUAGE': 'en_US:en', 12:56:49 INFO - 'LOGNAME': 'cltbld', 12:56:49 INFO - 'MAIL': '/var/mail/cltbld', 12:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:49 INFO - 'MOZ_NO_REMOTE': '1', 12:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:49 INFO - 'NO_EM_RESTART': '1', 12:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:49 INFO - 'PWD': '/builds/slave/test', 12:56:49 INFO - 'SHELL': '/bin/bash', 12:56:49 INFO - 'SHLVL': '1', 12:56:49 INFO - 'TERM': 'linux', 12:56:49 INFO - 'TMOUT': '86400', 12:56:49 INFO - 'USER': 'cltbld', 12:56:49 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', 12:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:49 INFO - '_': '/tools/buildbot/bin/python'} 12:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:50 INFO - Downloading/unpacking flake8 12:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:56:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:56:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:56:52 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 12:56:52 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 12:56:52 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 12:56:52 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 12:56:52 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 12:56:52 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 12:56:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:56:52 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 12:56:52 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 12:56:52 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 12:56:52 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 12:56:52 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 12:56:52 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 12:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:56:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:56:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:56:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:56:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:56:52 INFO - no previously-included directories found matching 'docs/_build' 12:56:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:56:52 INFO - Running setup.py install for pep8 12:56:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:56:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:56:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:56:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:56:52 INFO - no previously-included directories found matching 'docs/_build' 12:56:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:56:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:56:52 INFO - Cleaning up... 12:56:52 INFO - Return code: 0 12:56:52 INFO - Running post-action listener: _resource_record_post_action 12:56:52 INFO - Running post-action listener: _start_resource_monitoring 12:56:52 INFO - Starting resource monitoring. 12:56:52 INFO - ##### 12:56:52 INFO - ##### Finished create-virtualenv step (success) 12:56:52 INFO - ##### 12:56:52 INFO - ##### 12:56:52 INFO - ##### Running install step. 12:56:52 INFO - ##### 12:56:52 INFO - Running pre-action listener: _resource_record_pre_action 12:56:52 INFO - Running main action method: install 12:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:56:53 INFO - Reading from file tmpfile_stdout 12:56:53 INFO - Detecting whether we're running mozinstall >=1.0... 12:56:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:56:53 INFO - Reading from file tmpfile_stdout 12:56:53 INFO - Output received: 12:56:53 INFO - Usage: mozinstall [options] installer 12:56:53 INFO - Options: 12:56:53 INFO - -h, --help show this help message and exit 12:56:53 INFO - -d DEST, --destination=DEST 12:56:53 INFO - Directory to install application into. [default: 12:56:53 INFO - "/builds/slave/test"] 12:56:53 INFO - --app=APP Application being installed. [default: firefox] 12:56:53 INFO - mkdir: /builds/slave/test/build/application 12:56:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:57:09 INFO - Reading from file tmpfile_stdout 12:57:09 INFO - Output received: 12:57:09 INFO - /builds/slave/test/build/application/firefox/firefox 12:57:09 INFO - Running post-action listener: _resource_record_post_action 12:57:09 INFO - ##### 12:57:09 INFO - ##### Finished install step (success) 12:57:09 INFO - ##### 12:57:09 INFO - ##### 12:57:09 INFO - ##### Running run-tests step. 12:57:09 INFO - ##### 12:57:09 INFO - Running pre-action listener: _resource_record_pre_action 12:57:09 INFO - Running main action method: run_tests 12:57:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:57:09 INFO - Python 2.7.3 12:57:09 INFO - Return code: 0 12:57:09 INFO - grabbing minidump binary from tooltool 12:57: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')]} 12:57:09 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 0x1212e20>, '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 0x12163a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:57:09 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 12:57:09 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 12:57:09 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 12:57:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:57:09 INFO - Return code: 0 12:57:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:57:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:57:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:57:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:57:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:57:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:57:10 INFO - Return code: 0 12:57:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:57:10 INFO - Using env: {'DISPLAY': ':0', 12:57:10 INFO - 'HOME': '/home/cltbld', 12:57:10 INFO - 'LANG': 'en_US.UTF-8', 12:57:10 INFO - 'LANGUAGE': 'en_US:en', 12:57:10 INFO - 'LOGNAME': 'cltbld', 12:57:10 INFO - 'MAIL': '/var/mail/cltbld', 12:57:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:57:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:10 INFO - 'MOZ_NO_REMOTE': '1', 12:57:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:10 INFO - 'NO_EM_RESTART': '1', 12:57:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:10 INFO - 'PWD': '/builds/slave/test', 12:57:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:57:10 INFO - 'SHELL': '/bin/bash', 12:57:10 INFO - 'SHLVL': '1', 12:57:10 INFO - 'TERM': 'linux', 12:57:10 INFO - 'TMOUT': '86400', 12:57:10 INFO - 'USER': 'cltbld', 12:57:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088', 12:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:10 INFO - '_': '/tools/buildbot/bin/python'} 12:57:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:57:10 INFO - mozversion application_buildid: 20160603122625 12:57:10 INFO - mozversion application_changeset: f5253aba046fab63710ccee19bcfc3300d9e6a25 12:57:10 INFO - mozversion application_display_name: Nightly 12:57:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:57:10 INFO - mozversion application_name: Firefox 12:57:10 INFO - mozversion application_remotingname: firefox 12:57:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:57:10 INFO - mozversion application_vendor: Mozilla 12:57:10 INFO - mozversion application_version: 49.0a1 12:57:10 INFO - mozversion platform_buildid: 20160603122625 12:57:10 INFO - mozversion platform_changeset: f5253aba046fab63710ccee19bcfc3300d9e6a25 12:57:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:57:10 INFO - mozversion platform_version: 49.0a1 12:57:10 INFO - using testdate: 1464983830 12:57:10 INFO - actual date: 1464983830 12:57:10 INFO - starting webserver on 'localhost:40283' 12:57:10 INFO - SUITE-START | Running 2 tests 12:57:10 INFO - TEST-START | dromaeo_css 12:57:10 INFO - operating with platform_type : linux_ 12:57:10 INFO - Initialising browser for dromaeo_css test... 12:57:10 INFO - TEST-INFO | started process 3428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0GTNoM/profile http://localhost:40283/getInfo.html) 12:57:14 INFO - PROCESS | 3428 | __metrics Screen width/height:1600/1200 12:57:14 INFO - PROCESS | 3428 | colorDepth:24 12:57:14 INFO - PROCESS | 3428 | Browser inner width/height: 1024/697 12:57:14 INFO - PROCESS | 3428 | __metrics 12:57:15 ERROR - PROCESS | 3428 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:57:16 INFO - TEST-INFO | 3428: exit 0 12:57:16 INFO - Browser initialized. 12:57:16 INFO - Running cycle 1/1 for dromaeo_css test... 12:57:16 INFO - TEST-INFO | started process 3509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0GTNoM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:57:28 INFO - PROCESS | 3509 | RSS: Main: 158117888 12:57:28 INFO - PROCESS | 3509 | 12:58:20 INFO - PROCESS | 3509 | 1464983900417 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] 13:00:32 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:40283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40283/tests/dromaeo/cssquery-ext.html) 13:00:33 INFO - PROCESS | 3509 | RSS: Main: 241270784 13:00:33 INFO - PROCESS | 3509 | 13:03:35 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:40283/tests/dromaeo/cssquery-ext.html (next: http://localhost:40283/tests/dromaeo/cssquery-jquery.html) 13:03:36 INFO - PROCESS | 3509 | RSS: Main: 243789824 13:03:36 INFO - PROCESS | 3509 | 13:06:38 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:40283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40283/tests/dromaeo/cssquery-mootools.html) 13:06:39 INFO - PROCESS | 3509 | RSS: Main: 245501952 13:06:39 INFO - PROCESS | 3509 | 13:09:41 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:40283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40283/tests/dromaeo/cssquery-prototype.html) 13:09:42 INFO - PROCESS | 3509 | RSS: Main: 241246208 13:09:42 INFO - PROCESS | 3509 | 13:12:45 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:40283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40283/tests/dromaeo/cssquery-yui.html) 13:12:45 INFO - PROCESS | 3509 | RSS: Main: 226934784 13:12:45 INFO - PROCESS | 3509 | 13:15:48 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:40283/tests/dromaeo/cssquery-yui.html (next: http://localhost:40283/tests/dromaeo/cssquery-dojo.html) 13:15:48 INFO - PROCESS | 3509 | RSS: Main: 278372352 13:15:48 INFO - PROCESS | 3509 | 13:15:48 INFO - PROCESS | 3509 | __start_tp_report 13:15:48 INFO - PROCESS | 3509 | _x_x_mozilla_page_load 13:15:48 INFO - PROCESS | 3509 | _x_x_mozilla_page_load_details 13:15:48 INFO - PROCESS | 3509 | |i|pagename|runs| 13:15:48 INFO - PROCESS | 3509 | |0;dojo.html;2629.815912886098;2702.567589185731;2703.6620422447195;2748.120601407549;2748.931276718083;4570.817167313304;4654.255319148937;4706.458757242918;4780.067886762083;4855.0289942011605;4706.98799758052;4713.8114475421025;4718.669693121483;4784.545468180526;4798.712077275366;4250.341197114444;4327.632151267146;4376;4410.206162890679;4542.341360502725;4406.71356361837;4429.357743127244;4432.268675668511;4447.288433850585;4485.102979404116;4254.170436764832;4259.616634502879;4313.1804957058375;4320.870373888788;4367.890802729926;4345.239583072981;4348.869533913956;4355.73865568067;4361.956380436219;4468.173387923244;4391.341298805173;4396.164728701537;4407.691461597689;4412.3077537251565;4446.421965144543;4527.954720452786;4588.105319462706;4625.653076019312;4742.478327383985;4775.164346239429;5073.949260507385;5084.13569693153;5129.333186685707;5133.768980395891;5140.408852981917;5142.897142057175;5156.20078887773;5162.277281180638;5164.612654050961;5169.276301317781;4671.813127474863;4733.242681170997;4790.592799612003;4792.880177995578;4797.304390863305;5259.737013149327;5262.184361423985;5275.340582427197;5332.786688532493;5334.226537152092;5057.418396884332;5101.9489805101475;5104.03023425548;5109.642325037212;5117.820876269388;4934.5312195341385;5031.723255220998;5068.214426763858;5093.516115968977;5174.016936781999;5031.823886163967;5036.974815125975;5042.142835717864;5051;5072.568831649277;4980.452150263468;4995.475475075064;4997.975010124999;5051.898962020739;5057.595392368602;4200.474940632421;4248.532661407243;4249.936250956238;4303.892402689958;4337.327714204303;3778.7732736035928;3800.6959443245028;3809.314323421755;3818.1218319786603;3821.7898015608853;4337.024169561823;4381.67137464685;4387.42963414754;4401.669874759342;4405.7797110144365;5102.387713474407;5103.795848166032;5107.106256405114;5114.693118412907;5194.92207616886;4395.7142785718825;4396.714213576107;4398.516163222043;4402.097569998143;4450.087732014929;4451.10977804434;4522.186006518858;4550.453945526558;4565.977170114128;4649.279361698942;4790.952090479121;4792.664513484023;4796.904061918673;4840.806367745251;4842.806287748521;5089.949100509096;5132.589392848488;5144.331236939174;5144.897102058013;5145.974270128625;4692.741899195577;4715.24556071027;4766.45185803637;4775.498572649822;4855.417349918032;5015.924761128659;5034.597232221487;5038.269450929668;5038.949610503994;5048.343715316985;5078.162103253069;5085.694858308513;5089.51649593288;5095.541401273903;5096.23556466533;4847.418309802846;4907.60739140875;4936.975315123402;4960.131976903956;4993.400791904995;4954.430240522386;4955.157623204136;4989.376327959005;4991.226359914219;5039.2944987702485;4757.072370887644;4884.438289596742;4891.046245981999;4891.31521586971;4944;4967;5024.723640199824;5025.3718285214345;5031.144705400017;5044.596432285482;4903.264510323337;4907;4911.557959783494;4916.975415122902;4965.304857319906 13:15:48 INFO - PROCESS | 3509 | |1;ext.html;579.1920271221646;582.1326223926351;585.6076428792709;600.5855959388022;613.2855223664432;40499.797501012494;42043;42046.36930446046;46329.305060424034;46334;43140.78429607848;44003;44038.55961440384;44068.77965610175;44134;7749.4962827416175;7931.801704957365;7933.404994625397;7934.285914267714;7940.086890007666;7616.695332186706;7713.6914523419;7744.070711514626;7746.728864489744;7747.845043099134;7743.496672716284;7783;7784.844303113934;7796.454248202628;7796.649150788228;7731.497452665559;7765.223477652246;7785.493942893694;7785.727499537489;7787.883181752279;7694.923050769533;7725.072991241031;7768.689252429953;7777.144514103444;7777.494462859896;38833.22333553341;39258.214835703126;39350.80324598359;39358;39363.40954885679;3088.845557722105;3166.3825554016976;3283.8998935356685;3379.1214284286016;3635.127569383329;25883.482330353476;26197.345066373302;26702.866485667448;26766.063187788528;27333.589996150073;3326.6839650233187;3376.57792775903;3377.0713053910126;3379.898603041913;3440.2603440260464;245566;248404;248585;248695;249004;48319.75840120777;53773;54242.45757542374;54341;54351.45648543464;57753.71123144357;59604.70197649071;59855;62583.37416625775;62608.686956564925;14212.715745685235;14220.075695079786;14296.070755400866;14301.141931483937;14423.92788036053;10245.59017639301;10699.946500267604;11505.654830355103;11588.594399196156;11625.24435911663;17434.912825435793;17623.911880440774;17630.236976302524;17643;17670.293188272582;5708.71456427177;5766.192733017381;5822.7670893163795;5932.911006334908;5973.536483561468;839.7774589733725;897.3987428422972;970.4565443351604;1026.9986762906256;1033.1579762493543;25956;26730.096041647907;26761.598576021373;27036;27353.179404617895;936.0686117313181;962.3504134709183;979.6823272698209;1043.6347278452633;1109.57836022311;14585.197814120113;14693.92653036728;14711.970162088764;14787.63030924214;14960.775588366183;372544;373644;373680;374075;375522;51251.743741281054;51433.48566514287;51495.74252128715;51559.48440515622;51591.226131608055;1072.6781965410346;1191.5353012325374;1204.6386084174712;1213.2902252182218;1222.407132540717;27430.725692742817;28429.715702842706;28977.42045159127;29090.12729618115;29533.409331813673;35736.28527429489;36119.638803611626;36142.09644758902;36191.45712814362;36238;240238;240661;241603;241647;241918;29179;33775.66224337823;38370;40868;41203;37863.62136378601;42797.14405711931;42834;43203.13593728171;43345.133097338505;36200.63799362078;36402.27195456129;36902.26195476129;37082;37418.251634967695;35585.28829423449;35862.46206306855;36059;36185.27629447449;36423.45364819583;35499.290014199054;36222;36428.81785591055;36659.45010824893;37105.25789484141;29290.85354573299;29385.70614293915;29950.70049299479;30144.54783178298;30350.544741829333;24219.75780242175;24263.636045459687;24378.634320484853;24574.973653337405;24829 13:15:48 INFO - PROCESS | 3509 | |2;jquery.html;356.10439744043725;362.93830048891704;368.73819588092454;377.2417440943706;382.5199374784645;15763.921180394096;16913;17121.65756684867;17431.47705568832;17610.55973600659;15366.923165384185;15471.92264038681;15590.688186236268;15625.062496250204;15663;5018.774155163008;5206.114960456732;5247.422783493813;5247.790088396459;5252.3171987641745;3771.094937215062;3951.0319971606996;5132.409772876111;5712.2574065371655;6001.189839371695;6050.304215015263;6058.091286307045;6063.242094738158;6068.939310606882;6085.543584231178;5859.355470898197;5992.310884248302;6020.4581587656885;6063.787767428141;6063.939360606404;3344.2642618623863;4804.735739534324;5137.845864624067;5141.974290128563;5232.555232805216;19355.225790968343;20117.396478105533;20121.496962575908;20126.899365503225;20138.39584812458;1873.4098758890905;2069.079259729421;2121.9151233950624;2221.2114699281847;2293.312006398074;12612.117151799377;12748.745025099446;12912.870871291261;13084.542041028613;13445.932770336183;1655.5281744702822;1701.7107091794426;1701.753245779355;1720.096949101719;1743.4508129939156;64649;64738.67630661864;65426.67286663536;65701.34298657048;66435;9105.863412048824;9204.401713888576;9333.160015598629;9554.710114134503;9606.615735370646;12780.744385112246;12869.4208760606;12900.741985160244;12900.80648790269;12910.289934053717;6840.794776156723;6847.246802851682;6877.415419689282;6958.130233720785;6985.952107183862;6367.490600752021;6507.642079685568;6529.053287273318;6626.469882409396;6647.900281495781;5866.941330586725;6047.03247480401;6055.333913269536;6073.817785466443;6165.969170154121;1520.4602366159854;1601.8398160184122;1720.5440558252074;1721.5610019444962;1738.8869723467933;815.9265666090081;899.9730008099767;931.8648795924553;962.6823148361024;981.3081777346953;15569.766453503207;16071.517854464384;16119.435819746253;16183.029018258942;16593.751093733605;919.6689191890914;935.4013431403907;939.1313035442189;993.7267251505749;997.7156510394648;9660.420374777535;9669.564869580885;9819.754506137404;9868.358556693793;10015.098641122187;349687;360587;360612;361404;363846;65084.674576626814;73988.63005684938;79231;79825.20174798294;80462.59768701119;944.6882528765491;960.1790469148917;967.4437198610686;983.3853841349156;984.8719666443317;15510.534683959499;15682.215889205267;15726.135062571668;15873.682526349177;16272.105034222757;25643.487130257665;29260.707392925797;30510.694893051674;35452.46821297734;37219.62780372162;49399.50600493949;49535.256971146184;49642.25536617026;49944.50055499544;50180.247296289854;6656.2345330287635;7369.447291453055;7535.510191837513;7582.128055273714;7917.247861453153;10894.509747061244;11418.942905285752;11565.363904985306;11692.35692036946;11860.584879529175;9291.907080929104;9791.363561368773;9967.50162491887;10054.14539764099;10581.365118092632;10049.497525123861;10134.138598219233;10136.797264054825;10236.33463824849;10549.472526373496;10100.797984040424;10451.68644940653;10536.10443112344;10703.892961070289;10827.133829293794;7748.57382843949;7807.86442157891;7901.604919754104;8067.233612806774;8076.919230807616;10229.079382855578;10294.433806140734;10458.320209186379;10494.632687855888;10912.290701104403 13:15:48 INFO - PROCESS | 3509 | |3;mootools.html;1311.1608570514866;1422.1396055386488;1445.385711072794;1568.1688704986361;1793.9820601793979;6720.3951644352;7248.311410416015;7464.402847772172;7484.326410623043;7487.73792917248;7150.39221666159;7351.852962940738;7354.411647068235;7571.167171611119;7584.582847943361;1831.7252412138153;2099.769025407204;2102.3272552783114;2151.569686062786;2176.064292354287;2176.8258539316894;2181.9127234910584;2185.868847869133;2186.4533866533366;2188.3544354415485;2063.3912995666315;2113.2286715348864;2165.71845660064;2168.490404754881;2171.0121894537947;1781.4655603319018;1976.545394559245;2047.2220556188702;2050.1082029317295;2062.566860959193;2101.95796084079;2127.1066152215953;2152.9354119376444;2153.870767753924;2154.7198864147563;7539.396848252127;7665.386769058462;7671.884921726179;7701.268379503938;7706.075270967463;4382.320740285261;4509.323601459807;4513.097380523908;4518.751468669222;4519.028408892104;2913.0969399486225;3012.578239046535;3082.2756652186717;3084.552739852731;3095.520194369854;875.7985663297413;885.4996926736374;896.0322851320558;899.6221586933439;913.1735779119907;10211.183105351629;10493.632722854663;10517.52671129801;10531;10545.420001899893;4052.1895620875944;4140.296149654566;4195.727277726938;4200.285951388271;4206.789660516962;9031.051739567381;9109.27125829932;9115.453072815651;9129.087091290818;9144.588493517807;4484.170428470743;4484.955150448453;4489.236829738952;4491.124230774967;4494.393256910275;3608.783472991629;3911.100446897173;4010.258102251093;4011.839526418969;4043.454133691973;3584.8207589620415;3587.0852932502567;3662.0661731258892;3685.7419980601635;3721.423179407196;1153.2446247707765;1157.3808012713157;1174.5477990973536;1179.988200118005;1182.869884312725;757.4886951307845;768.9231076892378;786.8741001439856;787.1066339704362;789.4749991255866;5281.181416880389;5331.546818520392;5383.111786555174;5552.500274975271;5562.749676264497;388.089929116222;399.6682753314742;408.0349972315453;410.14075511802724;412.70904012671593;3730.7948062856804;3805.60041195676;3851.017990412427;3856.4986551748093;3857.633524815138;9167.633294668272;9540.427574345562;9565.426074435418;9570;9608.327417080876;8936.46381217129;9331.973482916874;9442.858357124649;9451.054894510631;9468;6943.965280173667;7221.205667376689;7260.52806567582;7284.380827629605;7296.562206267535;5208.218767184952;5270;5418.160185171305;5500.614956953135;5842.591018628656;8651.653933842828;8653.221210091122;8691.304695624209;8870.379073464796;8893.28853691716;8715.782105447415;8952.68665596701;8955.373123881265;8964.14840590143;9063.95468022682;5978.970105149447;6118.143459915526;6230.563860529719;6265.561410701207;6317.494600432046;7239.095113110861;7262.9273707264365;7311.159216690149;7323.304286092813;7331.193568707545;6246.625202487865;6390.297067322684;6406.615603063831;6473.093766872547;6495.447886929664;6153.753849846135;6191.81424557264;6249.187605611241;6296.496280297657;6328.050792381179;6009.609375390585;6058.848528786815;6074.210352654127;6088.51291896656;6092.847678808065;4606.332081848046;4661.114388266218;4712.59942904857;4760.928586071281;4769.403824521934;4703.905921881475;4725.952740472551;4747.382840230748;4771.71369717818;4799.568038876518 13:15:48 INFO - PROCESS | 3509 | |4;prototype.html;276.8975479072743;283.7231219463803;289.68569102523765;291.6092436135578;293.21564814122246;4694.17851875922;4773.164696178168;4782.13921494131;4787.593054590359;4792.7603619819;4346.934795978055;4538.2511885538925;4538.954610453894;4558.247889098295;4642.187617166991;3544.16712072664;3581.570211574615;3591;3699.7420876901847;3748.850045998157;3691.3724666806706;3731.6641502264793;3733.365327894251;3734.439834024891;3742.9064273393246;3499.5450591423078;3679.8528058877614;3706.8331925063435;3707.8702245421414;3720.516332876722;3695.907602309937;3713.498677678506;3713.6286371362785;3717.4609681596016;3737.9065523362133;3256.788308759923;3289.7039266465895;3292.5555050068174;3296.868125274986;3301.6203136639356;4500.234960056799;4510.353720891883;4564.6348292136545;4591.449026116854;4604.240300350438;4126.94762835478;4212.578742125794;4216.62050415461;4220.354061915856;4254.659627229814;4871.610271178332;4884.7543876311665;4884.92531643038;4950.752462376867;4967.751612419364;3578.964210357889;3601.8559257629663;3602.9099272518133;3602.981985090084;3603.4955106285142;5045.167547354682;5078.923816142724;5185.222216667492;5195.9740201298755;5197.922031169535;3613.6567026132475;3639.5086663300644;3639.763415377992;3661.1030297577263;3661.992951938185;3679.5400574928135;3687.1703866629796;3714.7028237740915;3721.2371463850386;3723.6276372362545;4120.866761640573;4135.655911828668;4149.842082117342;4150.5641907599265;4199.94202840612;4638.373819534319;4946.826861059918;4947.183714687037;4963.5036496350795;4970.90058198834;1279.9808002879963;1292.4377895615437;1299.2399446323818;1301.9349032548334;1307.3724612186204;838.9136068790931;870.3168013109679;907.1654078248027;907.5552979040223;910.9251083721273;4348;4372.475302963601;4380.561943805657;4411.3824064630335;4413.8234470621455;5026;5044.924326135111;5052.621053421009;5121.820736274212;5142.537171654569;4183.309753890574;4365.607095361369;4366.585174408426;4379.321205213133;4440;2697.3121853927123;2704.067096851583;2711.5797051457057;2716.7826573874045;2726.413821028488;4797.856064318006;4802.303665968415;4822.059698358787;4838.250071238893;4850.563449289581;5007.974960125176;5171.2676253454765;5176.9741151294;5179.65911986774;5240.34495688039;4765.0946320199055;4766.523347665206;4793.9280910785665;4795.472498025214;4820.396985627722;5092.541671249605;5103.821366252163;5104;5117.334746482933;5127.5897928166405;4754.619630429488;5027.824026159067;5028.522290382408;5055.443901170795;5061.266116413026;4821.963277895269;4857.489963553776;4863.90272194547;4867.80528778859;4877.536738978363;3588.3540962626976;3596.9100772480897;3628.5282913221113;3629.5825980012637;3637.472566477793;5050.873728156826;5085.847424577269;5103.974480127576;5196.2465442509865;5204.8178313758835;4862.100511405401;4898.338724272177;4924.261360795909;4930.975345123252;4937.851864444073;4895.143349913822;4897.338859253955;4903.6077113831525;4921.680090794087;4928.728919909296;4676.907148759188;4712.983690438054;4836.975815120902;4845.176320025534;4871.634627402888;4930.926036109533;4932.753362331798;4955.761059735066;4959.801607935787;4965.702057876539;4784.40194975628;4811.903761924672;4813.566778989908;4826.372571565815;4828.444728856086 13:15:48 INFO - PROCESS | 3509 | |5;yui.html;653.3433898931576;718.479102650578;725.6915810780418;732.9152853776411;738.2469880721665;12269.938650306747;12300.077494187939;12364.876351236486;12441.253524788508;12458;11724.706882327946;11751.059915206784;11789.7642047159;11801.055915526758;11829.231099978495;626.9059641053856;760.4372764154514;795.4630624328584;800.6677228950008;804.7947773317825;785.5365334452672;789.6920201121567;793.1354823242665;793.8412317536487;793.8888555602191;661.4774328280653;857.3269983063296;858.7509622209583;858.9527575983318;859.1751918158575;823.3289868756943;838.3879767769502;841.4236248169962;846.724814435311;848.893888263967;613.9201903752528;614.088079202384;614.3457218062749;614.4930432393248;615.1510914937403;11845.526178952832;11867.287962722177;11869.347185904771;11879.465424055852;11898.464569094325;12328.81506777399;12457.75084498305;12911.289879056649;12939.547115850994;13072.346382680827;11416.60041898538;11616.186866919319;11629.423506747602;11773.293602383885;12013.099017573717;4065.2276067547073;4139.287470385769;4145.341863254692;4161.167766446722;4168.312228482297;55610;56083.43916560864;56428.71785641087;56828.43171568314;56952.430475695124;10134.54394552247;10208.285420020527;10443.791124177475;10459.424731639681;10732.946335268274;17625.7356139658;19084.14121364542;19085.332013379466;19103.235870565022;19123.80876191248;6787.5588086774205;6946.861062778716;6954.756583519553;6970.721171153198;7030.718771249195;3735.6451137141926;3739.2521495700967;3745.6816170625257;3806.7906265155684;3823.1589050408866;2894.5513445415995;2958.2752225704407;2976.7023297670494;2977.2556860784803;2979.702029797046;491.616539099503;527.6781163490268;535.6250624562822;542.1298815401303;583.0787355977545;611.1718621268118;618.3939739055751;620.950323974081;625.5121005615628;645.9580127291711;8041.151894510988;8172.795680107926;8372.288355489729;8649.610767515476;8654.653813847375;619.4208415131866;619.5311682943467;621.4624349937271;623.1991890420878;648.6765706565781;3977.162038632733;4079.796010199478;4133.297339452301;4139.379093136054;4175.394567787654;57991.420085799444;87999;96535.51732241434;97567;97802;52148;61509.38490615126;73498;86605;86699.49753768493;46005.539944600794;46462.30306545404;48915.75542122267;74652.62673686596;75078;7830.843383132419;7842.333401660694;7866.7639970800965;7985.5208687478935;8137.430379873589;45530;46105.69784474828;47274.527254727014;47605.28592071191;48258.27612585884;58594.707026464595;58723.41276587179;64194.679026604565;66811;67056;8821.911780882108;8835.33734969867;8935.285177185939;8962.507062111647;9059.501727405055;10880.564777408816;10948.343099413742;11241.044511216638;11388.487518061542;11729.35488548138;10700.892991070301;10703.250772445854;10965.443356504102;10996.450177491253;11106.444677766242;9532.428054316762;9585.760355991157;9699.418034917928;9724.367916085432;10005.199584033115;11330.108343661415;11362;11744.236624619372;12148.453319600463;12186;9850.852237216304;10099.394036357842;10178.949105254427;10251.948740256252;10299.639512617023;10224.087543998692;10305.793884122126;10354.948225258826;10376.533056012648;10490.423026733602 13:15:48 INFO - PROCESS | 3509 | __end_tp_report 13:15:48 INFO - PROCESS | 3509 | __start_cc_report 13:15:48 INFO - PROCESS | 3509 | _x_x_mozilla_cycle_collect,972 13:15:48 INFO - PROCESS | 3509 | __end_cc_report 13:15:48 INFO - PROCESS | 3509 | __startTimestamp1464984948611__endTimestamp 13:15:48 INFO - PROCESS | 3509 | 13:15:48 INFO - PROCESS | 3509 | ------- Summary: start ------- 13:15:48 INFO - PROCESS | 3509 | Number of tests: 6 13:15:48 INFO - PROCESS | 3509 | 13:15:48 INFO - PROCESS | 3509 | [#0] dojo.html Cycles:165 Average:4708.07 Median:4840.81 stddev:492.69 (10.2%) stddev-sans-first:466.45 13:15:48 INFO - PROCESS | 3509 | Values: 2629.8 2702.6 2703.7 2748.1 2748.9 4570.8 4654.3 4706.5 4780.1 4855.0 4707.0 4713.8 4718.7 4784.5 4798.7 4250.3 4327.6 4376.0 4410.2 4542.3 4406.7 4429.4 4432.3 4447.3 4485.1 4254.2 4259.6 4313.2 4320.9 4367.9 4345.2 4348.9 4355.7 4362.0 4468.2 4391.3 4396.2 4407.7 4412.3 4446.4 4528.0 4588.1 4625.7 4742.5 4775.2 5073.9 5084.1 5129.3 5133.8 5140.4 5142.9 5156.2 5162.3 5164.6 5169.3 4671.8 4733.2 4790.6 4792.9 4797.3 5259.7 5262.2 5275.3 5332.8 5334.2 5057.4 5101.9 5104.0 5109.6 5117.8 4934.5 5031.7 5068.2 5093.5 5174.0 5031.8 5037.0 5042.1 5051.0 5072.6 4980.5 4995.5 4998.0 5051.9 5057.6 4200.5 4248.5 4249.9 4303.9 4337.3 3778.8 3800.7 3809.3 3818.1 3821.8 4337.0 4381.7 4387.4 4401.7 4405.8 5102.4 5103.8 5107.1 5114.7 5194.9 4395.7 4396.7 4398.5 4402.1 4450.1 4451.1 4522.2 4550.5 4566.0 4649.3 4791.0 4792.7 4796.9 4840.8 4842.8 5089.9 5132.6 5144.3 5144.9 5146.0 4692.7 4715.2 4766.5 4775.5 4855.4 5015.9 5034.6 5038.3 5038.9 5048.3 5078.2 5085.7 5089.5 5095.5 5096.2 4847.4 4907.6 4937.0 4960.1 4993.4 4954.4 4955.2 4989.4 4991.2 5039.3 4757.1 4884.4 4891.0 4891.3 4944.0 4967.0 5024.7 5025.4 5031.1 5044.6 4903.3 4907.0 4911.6 4917.0 4965.3 13:15:48 INFO - PROCESS | 3509 | 13:15:48 INFO - PROCESS | 3509 | [#1] ext.html Cycles:180 Average:45219.83 Median:36544.13 stddev:77270.00 (211.4%) stddev-sans-first:77414.07 13:15:48 INFO - PROCESS | 3509 | Values: 579.2 582.1 585.6 600.6 613.3 40499.8 42043.0 42046.4 46329.3 46334.0 43140.8 44003.0 44038.6 44068.8 44134.0 7749.5 7931.8 7933.4 7934.3 7940.1 7616.7 7713.7 7744.1 7746.7 7747.8 7743.5 7783.0 7784.8 7796.5 7796.6 7731.5 7765.2 7785.5 7785.7 7787.9 7694.9 7725.1 7768.7 7777.1 7777.5 38833.2 39258.2 39350.8 39358.0 39363.4 3088.8 3166.4 3283.9 3379.1 3635.1 25883.5 26197.3 26702.9 26766.1 27333.6 3326.7 3376.6 3377.1 3379.9 3440.3 245566.0 248404.0 248585.0 248695.0 249004.0 48319.8 53773.0 54242.5 54341.0 54351.5 57753.7 59604.7 59855.0 62583.4 62608.7 14212.7 14220.1 14296.1 14301.1 14423.9 10245.6 10699.9 11505.7 11588.6 11625.2 17434.9 17623.9 17630.2 17643.0 17670.3 5708.7 5766.2 5822.8 5932.9 5973.5 839.8 897.4 970.5 1027.0 1033.2 25956.0 26730.1 26761.6 27036.0 27353.2 936.1 962.4 979.7 1043.6 1109.6 14585.2 14693.9 14712.0 14787.6 14960.8 372544.0 373644.0 373680.0 374075.0 375522.0 51251.7 51433.5 51495.7 51559.5 51591.2 1072.7 1191.5 1204.6 1213.3 1222.4 27430.7 28429.7 28977.4 29090.1 29533.4 35736.3 36119.6 36142.1 36191.5 36238.0 240238.0 240661.0 241603.0 241647.0 241918.0 29179.0 33775.7 38370.0 40868.0 41203.0 37863.6 42797.1 42834.0 43203.1 43345.1 36200.6 36402.3 36902.3 37082.0 37418.3 35585.3 35862.5 36059.0 36185.3 36423.5 35499.3 36222.0 36428.8 36659.5 37105.3 29290.9 29385.7 29950.7 30144.5 30350.5 24219.8 24263.6 24378.6 24575.0 24829.0 13:15:48 INFO - PROCESS | 3509 | 13:15:48 INFO - PROCESS | 3509 | [#2] jquery.html Cycles:180 Average:23171.01 Median:4377.88 stddev:59371.13 (1356.2%) stddev-sans-first:59512.97 13:15:48 INFO - PROCESS | 3509 | Values: 356.1 362.9 368.7 377.2 382.5 15763.9 16913.0 17121.7 17431.5 17610.6 15366.9 15471.9 15590.7 15625.1 15663.0 5018.8 5206.1 5247.4 5247.8 5252.3 3771.1 3951.0 5132.4 5712.3 6001.2 6050.3 6058.1 6063.2 6068.9 6085.5 5859.4 5992.3 6020.5 6063.8 6063.9 3344.3 4804.7 5137.8 5142.0 5232.6 19355.2 20117.4 20121.5 20126.9 20138.4 1873.4 2069.1 2121.9 2221.2 2293.3 12612.1 12748.7 12912.9 13084.5 13445.9 1655.5 1701.7 1701.8 1720.1 1743.5 64649.0 64738.7 65426.7 65701.3 66435.0 9105.9 9204.4 9333.2 9554.7 9606.6 12780.7 12869.4 12900.7 12900.8 12910.3 6840.8 6847.2 6877.4 6958.1 6986.0 6367.5 6507.6 6529.1 6626.5 6647.9 5866.9 6047.0 6055.3 6073.8 6166.0 1520.5 1601.8 1720.5 1721.6 1738.9 815.9 900.0 931.9 962.7 981.3 15569.8 16071.5 16119.4 16183.0 16593.8 919.7 935.4 939.1 993.7 997.7 9660.4 9669.6 9819.8 9868.4 10015.1 349687.0 360587.0 360612.0 361404.0 363846.0 65084.7 73988.6 79231.0 79825.2 80462.6 944.7 960.2 967.4 983.4 984.9 15510.5 15682.2 15726.1 15873.7 16272.1 25643.5 29260.7 30510.7 35452.5 37219.6 49399.5 49535.3 49642.3 49944.5 50180.2 6656.2 7369.4 7535.5 7582.1 7917.2 10894.5 11418.9 11565.4 11692.4 11860.6 9291.9 9791.4 9967.5 10054.1 10581.4 10049.5 10134.1 10136.8 10236.3 10549.5 10100.8 10451.7 10536.1 10703.9 10827.1 7748.6 7807.9 7901.6 8067.2 8076.9 10229.1 10294.4 10458.3 10494.6 10912.3 13:15:48 INFO - PROCESS | 3509 | 13:15:48 INFO - PROCESS | 3509 | [#3] mootools.html Cycles:180 Average:5026.17 Median:5239.11 stddev:2818.23 (53.8%) stddev-sans-first:2812.30 13:15:48 INFO - PROCESS | 3509 | Values: 1311.2 1422.1 1445.4 1568.2 1794.0 6720.4 7248.3 7464.4 7484.3 7487.7 7150.4 7351.9 7354.4 7571.2 7584.6 1831.7 2099.8 2102.3 2151.6 2176.1 2176.8 2181.9 2185.9 2186.5 2188.4 2063.4 2113.2 2165.7 2168.5 2171.0 1781.5 1976.5 2047.2 2050.1 2062.6 2102.0 2127.1 2152.9 2153.9 2154.7 7539.4 7665.4 7671.9 7701.3 7706.1 4382.3 4509.3 4513.1 4518.8 4519.0 2913.1 3012.6 3082.3 3084.6 3095.5 875.8 885.5 896.0 899.6 913.2 10211.2 10493.6 10517.5 10531.0 10545.4 4052.2 4140.3 4195.7 4200.3 4206.8 9031.1 9109.3 9115.5 9129.1 9144.6 4484.2 4485.0 4489.2 4491.1 4494.4 3608.8 3911.1 4010.3 4011.8 4043.5 3584.8 3587.1 3662.1 3685.7 3721.4 1153.2 1157.4 1174.5 1180.0 1182.9 757.5 768.9 786.9 787.1 789.5 5281.2 5331.5 5383.1 5552.5 5562.7 388.1 399.7 408.0 410.1 412.7 3730.8 3805.6 3851.0 3856.5 3857.6 9167.6 9540.4 9565.4 9570.0 9608.3 8936.5 9332.0 9442.9 9451.1 9468.0 6944.0 7221.2 7260.5 7284.4 7296.6 5208.2 5270.0 5418.2 5500.6 5842.6 8651.7 8653.2 8691.3 8870.4 8893.3 8715.8 8952.7 8955.4 8964.1 9064.0 5979.0 6118.1 6230.6 6265.6 6317.5 7239.1 7262.9 7311.2 7323.3 7331.2 6246.6 6390.3 6406.6 6473.1 6495.4 6153.8 6191.8 6249.2 6296.5 6328.1 6009.6 6058.8 6074.2 6088.5 6092.8 4606.3 4661.1 4712.6 4760.9 4769.4 4703.9 4726.0 4747.4 4771.7 4799.6 13:15:48 INFO - PROCESS | 3509 | 13:15:48 INFO - PROCESS | 3509 | [#4] prototype.html Cycles:180 Average:4109.60 Median:4659.55 stddev:1179.71 (25.3%) stddev-sans-first:1147.41 13:15:48 INFO - PROCESS | 3509 | Values: 276.9 283.7 289.7 291.6 293.2 4694.2 4773.2 4782.1 4787.6 4792.8 4346.9 4538.3 4539.0 4558.2 4642.2 3544.2 3581.6 3591.0 3699.7 3748.9 3691.4 3731.7 3733.4 3734.4 3742.9 3499.5 3679.9 3706.8 3707.9 3720.5 3695.9 3713.5 3713.6 3717.5 3737.9 3256.8 3289.7 3292.6 3296.9 3301.6 4500.2 4510.4 4564.6 4591.4 4604.2 4126.9 4212.6 4216.6 4220.4 4254.7 4871.6 4884.8 4884.9 4950.8 4967.8 3579.0 3601.9 3602.9 3603.0 3603.5 5045.2 5078.9 5185.2 5196.0 5197.9 3613.7 3639.5 3639.8 3661.1 3662.0 3679.5 3687.2 3714.7 3721.2 3723.6 4120.9 4135.7 4149.8 4150.6 4199.9 4638.4 4946.8 4947.2 4963.5 4970.9 1280.0 1292.4 1299.2 1301.9 1307.4 838.9 870.3 907.2 907.6 910.9 4348.0 4372.5 4380.6 4411.4 4413.8 5026.0 5044.9 5052.6 5121.8 5142.5 4183.3 4365.6 4366.6 4379.3 4440.0 2697.3 2704.1 2711.6 2716.8 2726.4 4797.9 4802.3 4822.1 4838.3 4850.6 5008.0 5171.3 5177.0 5179.7 5240.3 4765.1 4766.5 4793.9 4795.5 4820.4 5092.5 5103.8 5104.0 5117.3 5127.6 4754.6 5027.8 5028.5 5055.4 5061.3 4822.0 4857.5 4863.9 4867.8 4877.5 3588.4 3596.9 3628.5 3629.6 3637.5 5050.9 5085.8 5104.0 5196.2 5204.8 4862.1 4898.3 4924.3 4931.0 4937.9 4895.1 4897.3 4903.6 4921.7 4928.7 4676.9 4713.0 4837.0 4845.2 4871.6 4930.9 4932.8 4955.8 4959.8 4965.7 4784.4 4811.9 4813.6 4826.4 4828.4 13:15:48 INFO - PROCESS | 3509 | 13:15:48 INFO - PROCESS | 3509 | [#5] yui.html Cycles:180 Average:16430.44 Median:531.65 stddev:22869.98 (4301.7%) stddev-sans-first:22903.45 13:15:48 INFO - PROCESS | 3509 | Values: 653.3 718.5 725.7 732.9 738.2 12269.9 12300.1 12364.9 12441.3 12458.0 11724.7 11751.1 11789.8 11801.1 11829.2 626.9 760.4 795.5 800.7 804.8 785.5 789.7 793.1 793.8 793.9 661.5 857.3 858.8 859.0 859.2 823.3 838.4 841.4 846.7 848.9 613.9 614.1 614.3 614.5 615.2 11845.5 11867.3 11869.3 11879.5 11898.5 12328.8 12457.8 12911.3 12939.5 13072.3 11416.6 11616.2 11629.4 11773.3 12013.1 4065.2 4139.3 4145.3 4161.2 4168.3 55610.0 56083.4 56428.7 56828.4 56952.4 10134.5 10208.3 10443.8 10459.4 10732.9 17625.7 19084.1 19085.3 19103.2 19123.8 6787.6 6946.9 6954.8 6970.7 7030.7 3735.6 3739.3 3745.7 3806.8 3823.2 2894.6 2958.3 2976.7 2977.3 2979.7 491.6 527.7 535.6 542.1 583.1 611.2 618.4 621.0 625.5 646.0 8041.2 8172.8 8372.3 8649.6 8654.7 619.4 619.5 621.5 623.2 648.7 3977.2 4079.8 4133.3 4139.4 4175.4 57991.4 87999.0 96535.5 97567.0 97802.0 52148.0 61509.4 73498.0 86605.0 86699.5 46005.5 46462.3 48915.8 74652.6 75078.0 7830.8 7842.3 7866.8 7985.5 8137.4 45530.0 46105.7 47274.5 47605.3 48258.3 58594.7 58723.4 64194.7 66811.0 67056.0 8821.9 8835.3 8935.3 8962.5 9059.5 10880.6 10948.3 11241.0 11388.5 11729.4 10700.9 10703.3 10965.4 10996.5 11106.4 9532.4 9585.8 9699.4 9724.4 10005.2 11330.1 11362.0 11744.2 12148.5 12186.0 9850.9 10099.4 10178.9 10251.9 10299.6 10224.1 10305.8 10354.9 10376.5 10490.4 13:15:48 INFO - PROCESS | 3509 | -------- Summary: end -------- 13:15:48 INFO - PROCESS | 3509 | 13:15:49 INFO - TEST-INFO | 3509: exit 0 13:15:49 INFO - TEST-OK | dromaeo_css | took 1119044ms 13:15:49 INFO - TEST-START | kraken 13:15:49 INFO - operating with platform_type : linux_ 13:15:49 INFO - Initialising browser for kraken test... 13:15:49 INFO - TEST-INFO | started process 3684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEsCvdm/profile http://localhost:40283/getInfo.html) 13:15:53 INFO - PROCESS | 3684 | __metrics Screen width/height:1600/1200 13:15:53 INFO - PROCESS | 3684 | colorDepth:24 13:15:53 INFO - PROCESS | 3684 | Browser inner width/height: 1024/697 13:15:53 INFO - PROCESS | 3684 | __metrics 13:15:54 ERROR - PROCESS | 3684 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:15:55 INFO - TEST-INFO | 3684: exit 0 13:15:55 INFO - Browser initialized. 13:15:55 INFO - Running cycle 1/1 for kraken test... 13:15:55 INFO - TEST-INFO | started process 3763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEsCvdm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:07 INFO - PROCESS | 3763 | RSS: Main: 157593600 13:16:07 INFO - PROCESS | 3763 | 13:16:10 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40283/tests/kraken/driver.html?testName=audio-beat-detection) 13:16:11 INFO - PROCESS | 3763 | RSS: Main: 214753280 13:16:11 INFO - PROCESS | 3763 | 13:16:14 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40283/tests/kraken/driver.html?testName=audio-dft) 13:16:14 INFO - PROCESS | 3763 | RSS: Main: 201891840 13:16:14 INFO - PROCESS | 3763 | 13:16:18 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40283/tests/kraken/driver.html?testName=audio-fft) 13:16:18 INFO - PROCESS | 3763 | RSS: Main: 270385152 13:16:18 INFO - PROCESS | 3763 | 13:16:20 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40283/tests/kraken/driver.html?testName=audio-oscillator) 13:16:21 INFO - PROCESS | 3763 | RSS: Main: 180338688 13:16:21 INFO - PROCESS | 3763 | 13:16:23 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:16:24 INFO - PROCESS | 3763 | RSS: Main: 184164352 13:16:24 INFO - PROCESS | 3763 | 13:16:27 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40283/tests/kraken/driver.html?testName=imaging-darkroom) 13:16:28 INFO - PROCESS | 3763 | RSS: Main: 220405760 13:16:28 INFO - PROCESS | 3763 | 13:16:31 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40283/tests/kraken/driver.html?testName=imaging-desaturate) 13:16:32 INFO - PROCESS | 3763 | RSS: Main: 216227840 13:16:32 INFO - PROCESS | 3763 | 13:16:35 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40283/tests/kraken/driver.html?testName=json-parse-financial) 13:16:35 INFO - PROCESS | 3763 | RSS: Main: 219521024 13:16:35 INFO - PROCESS | 3763 | 13:16:37 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:16:37 INFO - PROCESS | 3763 | RSS: Main: 207446016 13:16:37 INFO - PROCESS | 3763 | 13:16:39 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40283/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:16:40 INFO - PROCESS | 3763 | RSS: Main: 210391040 13:16:40 INFO - PROCESS | 3763 | 13:16:42 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:16:43 INFO - PROCESS | 3763 | RSS: Main: 216621056 13:16:43 INFO - PROCESS | 3763 | 13:16:46 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:16:46 INFO - PROCESS | 3763 | RSS: Main: 222875648 13:16:46 INFO - PROCESS | 3763 | 13:16:49 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:16:50 INFO - PROCESS | 3763 | RSS: Main: 220917760 13:16:50 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:40283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40283/tests/kraken/driver.html?testName=ai-astar) 13:16:52 INFO - PROCESS | 3763 | RSS: Main: 263245824 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | __start_tp_report 13:16:52 INFO - PROCESS | 3763 | _x_x_mozilla_page_load 13:16:52 INFO - PROCESS | 3763 | _x_x_mozilla_page_load_details 13:16:52 INFO - PROCESS | 3763 | |i|pagename|runs| 13:16:52 INFO - PROCESS | 3763 | |0;ai-astar;111;106;112;112;113;112;111;111;112;112 13:16:52 INFO - PROCESS | 3763 | |1;audio-beat-detection;159;134;138;178;131;161;157;132;195;134 13:16:52 INFO - PROCESS | 3763 | |2;audio-dft;161;161;160;161;162;163;161;161;161;161 13:16:52 INFO - PROCESS | 3763 | |3;audio-fft;76;76;76;104;76;78;86;76;99;75 13:16:52 INFO - PROCESS | 3763 | |4;audio-oscillator;89;87;116;87;88;87;116;86;87;129 13:16:52 INFO - PROCESS | 3763 | |5;imaging-gaussian-blur;117;117;116;117;118;117;119;118;117;118 13:16:52 INFO - PROCESS | 3763 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;146;145 13:16:52 INFO - PROCESS | 3763 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;94;95 13:16:52 INFO - PROCESS | 3763 | |8;json-parse-financial;64;63;64;64;64;64;64;64;64;63 13:16:52 INFO - PROCESS | 3763 | |9;json-stringify-tinderbox;65;65;65;65;64;65;65;66;66;66 13:16:52 INFO - PROCESS | 3763 | |10;stanford-crypto-aes;84;84;83;84;85;84;86;85;113;85 13:16:52 INFO - PROCESS | 3763 | |11;stanford-crypto-ccm;143;146;132;132;130;133;131;141;133;134 13:16:52 INFO - PROCESS | 3763 | |12;stanford-crypto-pbkdf2;170;169;165;166;165;164;165;166;166;163 13:16:52 INFO - PROCESS | 3763 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;69;67;67;67;68 13:16:52 INFO - PROCESS | 3763 | __end_tp_report 13:16:52 INFO - PROCESS | 3763 | __start_cc_report 13:16:52 INFO - PROCESS | 3763 | _x_x_mozilla_cycle_collect,1906 13:16:52 INFO - PROCESS | 3763 | __end_cc_report 13:16:52 INFO - PROCESS | 3763 | __startTimestamp1464985012279__endTimestamp 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | ------- Summary: start ------- 13:16:52 INFO - PROCESS | 3763 | Number of tests: 14 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:1.93 (1.7%) stddev-sans-first:2.05 13:16:52 INFO - PROCESS | 3763 | Values: 111.0 106.0 112.0 112.0 113.0 112.0 111.0 111.0 112.0 112.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:158.00 stddev:22.02 (13.9%) stddev-sans-first:23.21 13:16:52 INFO - PROCESS | 3763 | Values: 159.0 134.0 138.0 178.0 131.0 161.0 157.0 132.0 195.0 134.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 13:16:52 INFO - PROCESS | 3763 | Values: 161.0 161.0 160.0 161.0 162.0 163.0 161.0 161.0 161.0 161.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:10.72 (14.1%) stddev-sans-first:11.13 13:16:52 INFO - PROCESS | 3763 | Values: 76.0 76.0 76.0 104.0 76.0 78.0 86.0 76.0 99.0 75.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:87.00 stddev:16.37 (18.8%) stddev-sans-first:17.09 13:16:52 INFO - PROCESS | 3763 | Values: 89.0 87.0 116.0 87.0 88.0 87.0 116.0 86.0 87.0 129.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 13:16:52 INFO - PROCESS | 3763 | Values: 117.0 117.0 116.0 117.0 118.0 117.0 119.0 118.0 117.0 118.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 13:16:52 INFO - PROCESS | 3763 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:16:52 INFO - PROCESS | 3763 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 13:16:52 INFO - PROCESS | 3763 | Values: 64.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 63.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 13:16:52 INFO - PROCESS | 3763 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 65.0 66.0 66.0 66.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:84.50 stddev:9.07 (10.7%) stddev-sans-first:9.54 13:16:52 INFO - PROCESS | 3763 | Values: 84.0 84.0 83.0 84.0 85.0 84.0 86.0 85.0 113.0 85.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:133.50 stddev:5.64 (4.2%) stddev-sans-first:5.29 13:16:52 INFO - PROCESS | 3763 | Values: 143.0 146.0 132.0 132.0 130.0 133.0 131.0 141.0 133.0 134.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:166.00 stddev:2.13 (1.3%) stddev-sans-first:1.67 13:16:52 INFO - PROCESS | 3763 | Values: 170.0 169.0 165.0 166.0 165.0 164.0 165.0 166.0 166.0 163.0 13:16:52 INFO - PROCESS | 3763 | 13:16:52 INFO - PROCESS | 3763 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 13:16:52 INFO - PROCESS | 3763 | Values: 67.0 67.0 67.0 67.0 67.0 69.0 67.0 67.0 67.0 68.0 13:16:52 INFO - PROCESS | 3763 | -------- Summary: end -------- 13:16:52 INFO - PROCESS | 3763 | 13:16:53 INFO - TEST-INFO | 3763: exit 0 13:16:53 INFO - TEST-OK | kraken | took 63935ms 13:16:53 INFO - SUITE-END | took 1182s 13:16:53 INFO - Completed test suite (00:19:43) 13:16:53 INFO - javascript benchmark 13:16:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2629.815912886098, 2702.567589185731, 2703.6620422447195, 2748.120601407549, 2748.931276718083, 4570.817167313304, 4654.255319148937, 4706.458757242918, 4780.067886762083, 4855.0289942011605, 4706.98799758052, 4713.8114475421025, 4718.669693121483, 4784.545468180526, 4798.712077275366, 4250.341197114444, 4327.632151267146, 4376.0, 4410.206162890679, 4542.341360502725, 4406.71356361837, 4429.357743127244, 4432.268675668511, 4447.288433850585, 4485.102979404116, 4254.170436764832, 4259.616634502879, 4313.1804957058375, 4320.870373888788, 4367.890802729926, 4345.239583072981, 4348.869533913956, 4355.73865568067, 4361.956380436219, 4468.173387923244, 4391.341298805173, 4396.164728701537, 4407.691461597689, 4412.3077537251565, 4446.421965144543, 4527.954720452786, 4588.105319462706, 4625.653076019312, 4742.478327383985, 4775.164346239429, 5073.949260507385, 5084.13569693153, 5129.333186685707, 5133.768980395891, 5140.408852981917, 5142.897142057175, 5156.20078887773, 5162.277281180638, 5164.612654050961, 5169.276301317781, 4671.813127474863, 4733.242681170997, 4790.592799612003, 4792.880177995578, 4797.304390863305, 5259.737013149327, 5262.184361423985, 5275.340582427197, 5332.786688532493, 5334.226537152092, 5057.418396884332, 5101.9489805101475, 5104.03023425548, 5109.642325037212, 5117.820876269388, 4934.5312195341385, 5031.723255220998, 5068.214426763858, 5093.516115968977, 5174.016936781999, 5031.823886163967, 5036.974815125975, 5042.142835717864, 5051.0, 5072.568831649277, 4980.452150263468, 4995.475475075064, 4997.975010124999, 5051.898962020739, 5057.595392368602, 4200.474940632421, 4248.532661407243, 4249.936250956238, 4303.892402689958, 4337.327714204303, 3778.7732736035928, 3800.6959443245028, 3809.314323421755, 3818.1218319786603, 3821.7898015608853, 4337.024169561823, 4381.67137464685, 4387.42963414754, 4401.669874759342, 4405.7797110144365, 5102.387713474407, 5103.795848166032, 5107.106256405114, 5114.693118412907, 5194.92207616886, 4395.7142785718825, 4396.714213576107, 4398.516163222043, 4402.097569998143, 4450.087732014929, 4451.10977804434, 4522.186006518858, 4550.453945526558, 4565.977170114128, 4649.279361698942, 4790.952090479121, 4792.664513484023, 4796.904061918673, 4840.806367745251, 4842.806287748521, 5089.949100509096, 5132.589392848488, 5144.331236939174, 5144.897102058013, 5145.974270128625, 4692.741899195577, 4715.24556071027, 4766.45185803637, 4775.498572649822, 4855.417349918032, 5015.924761128659, 5034.597232221487, 5038.269450929668, 5038.949610503994, 5048.343715316985, 5078.162103253069, 5085.694858308513, 5089.51649593288, 5095.541401273903, 5096.23556466533, 4847.418309802846, 4907.60739140875, 4936.975315123402, 4960.131976903956, 4993.400791904995, 4954.430240522386, 4955.157623204136, 4989.376327959005, 4991.226359914219, 5039.2944987702485, 4757.072370887644, 4884.438289596742, 4891.046245981999, 4891.31521586971, 4944.0, 4967.0, 5024.723640199824, 5025.3718285214345, 5031.144705400017, 5044.596432285482, 4903.264510323337, 4907.0, 4911.557959783494, 4916.975415122902, 4965.304857319906], "value": 4677.157176353673, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.1920271221646, 582.1326223926351, 585.6076428792709, 600.5855959388022, 613.2855223664432, 40499.797501012494, 42043.0, 42046.36930446046, 46329.305060424034, 46334.0, 43140.78429607848, 44003.0, 44038.55961440384, 44068.77965610175, 44134.0, 7749.4962827416175, 7931.801704957365, 7933.404994625397, 7934.285914267714, 7940.086890007666, 7616.695332186706, 7713.6914523419, 7744.070711514626, 7746.728864489744, 7747.845043099134, 7743.496672716284, 7783.0, 7784.844303113934, 7796.454248202628, 7796.649150788228, 7731.497452665559, 7765.223477652246, 7785.493942893694, 7785.727499537489, 7787.883181752279, 7694.923050769533, 7725.072991241031, 7768.689252429953, 7777.144514103444, 7777.494462859896, 38833.22333553341, 39258.214835703126, 39350.80324598359, 39358.0, 39363.40954885679, 3088.845557722105, 3166.3825554016976, 3283.8998935356685, 3379.1214284286016, 3635.127569383329, 25883.482330353476, 26197.345066373302, 26702.866485667448, 26766.063187788528, 27333.589996150073, 3326.6839650233187, 3376.57792775903, 3377.0713053910126, 3379.898603041913, 3440.2603440260464, 245566.0, 248404.0, 248585.0, 248695.0, 249004.0, 48319.75840120777, 53773.0, 54242.45757542374, 54341.0, 54351.45648543464, 57753.71123144357, 59604.70197649071, 59855.0, 62583.37416625775, 62608.686956564925, 14212.715745685235, 14220.075695079786, 14296.070755400866, 14301.141931483937, 14423.92788036053, 10245.59017639301, 10699.946500267604, 11505.654830355103, 11588.594399196156, 11625.24435911663, 17434.912825435793, 17623.911880440774, 17630.236976302524, 17643.0, 17670.293188272582, 5708.71456427177, 5766.192733017381, 5822.7670893163795, 5932.911006334908, 5973.536483561468, 839.7774589733725, 897.3987428422972, 970.4565443351604, 1026.9986762906256, 1033.1579762493543, 25956.0, 26730.096041647907, 26761.598576021373, 27036.0, 27353.179404617895, 936.0686117313181, 962.3504134709183, 979.6823272698209, 1043.6347278452633, 1109.57836022311, 14585.197814120113, 14693.92653036728, 14711.970162088764, 14787.63030924214, 14960.775588366183, 372544.0, 373644.0, 373680.0, 374075.0, 375522.0, 51251.743741281054, 51433.48566514287, 51495.74252128715, 51559.48440515622, 51591.226131608055, 1072.6781965410346, 1191.5353012325374, 1204.6386084174712, 1213.2902252182218, 1222.407132540717, 27430.725692742817, 28429.715702842706, 28977.42045159127, 29090.12729618115, 29533.409331813673, 35736.28527429489, 36119.638803611626, 36142.09644758902, 36191.45712814362, 36238.0, 240238.0, 240661.0, 241603.0, 241647.0, 241918.0, 29179.0, 33775.66224337823, 38370.0, 40868.0, 41203.0, 37863.62136378601, 42797.14405711931, 42834.0, 43203.13593728171, 43345.133097338505, 36200.63799362078, 36402.27195456129, 36902.26195476129, 37082.0, 37418.251634967695, 35585.28829423449, 35862.46206306855, 36059.0, 36185.27629447449, 36423.45364819583, 35499.290014199054, 36222.0, 36428.81785591055, 36659.45010824893, 37105.25789484141, 29290.85354573299, 29385.70614293915, 29950.70049299479, 30144.54783178298, 30350.544741829333, 24219.75780242175, 24263.636045459687, 24378.634320484853, 24574.973653337405, 24829.0], "value": 17509.39329821991, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.10439744043725, 362.93830048891704, 368.73819588092454, 377.2417440943706, 382.5199374784645, 15763.921180394096, 16913.0, 17121.65756684867, 17431.47705568832, 17610.55973600659, 15366.923165384185, 15471.92264038681, 15590.688186236268, 15625.062496250204, 15663.0, 5018.774155163008, 5206.114960456732, 5247.422783493813, 5247.790088396459, 5252.3171987641745, 3771.094937215062, 3951.0319971606996, 5132.409772876111, 5712.2574065371655, 6001.189839371695, 6050.304215015263, 6058.091286307045, 6063.242094738158, 6068.939310606882, 6085.543584231178, 5859.355470898197, 5992.310884248302, 6020.4581587656885, 6063.787767428141, 6063.939360606404, 3344.2642618623863, 4804.735739534324, 5137.845864624067, 5141.974290128563, 5232.555232805216, 19355.225790968343, 20117.396478105533, 20121.496962575908, 20126.899365503225, 20138.39584812458, 1873.4098758890905, 2069.079259729421, 2121.9151233950624, 2221.2114699281847, 2293.312006398074, 12612.117151799377, 12748.745025099446, 12912.870871291261, 13084.542041028613, 13445.932770336183, 1655.5281744702822, 1701.7107091794426, 1701.753245779355, 1720.096949101719, 1743.4508129939156, 64649.0, 64738.67630661864, 65426.67286663536, 65701.34298657048, 66435.0, 9105.863412048824, 9204.401713888576, 9333.160015598629, 9554.710114134503, 9606.615735370646, 12780.744385112246, 12869.4208760606, 12900.741985160244, 12900.80648790269, 12910.289934053717, 6840.794776156723, 6847.246802851682, 6877.415419689282, 6958.130233720785, 6985.952107183862, 6367.490600752021, 6507.642079685568, 6529.053287273318, 6626.469882409396, 6647.900281495781, 5866.941330586725, 6047.03247480401, 6055.333913269536, 6073.817785466443, 6165.969170154121, 1520.4602366159854, 1601.8398160184122, 1720.5440558252074, 1721.5610019444962, 1738.8869723467933, 815.9265666090081, 899.9730008099767, 931.8648795924553, 962.6823148361024, 981.3081777346953, 15569.766453503207, 16071.517854464384, 16119.435819746253, 16183.029018258942, 16593.751093733605, 919.6689191890914, 935.4013431403907, 939.1313035442189, 993.7267251505749, 997.7156510394648, 9660.420374777535, 9669.564869580885, 9819.754506137404, 9868.358556693793, 10015.098641122187, 349687.0, 360587.0, 360612.0, 361404.0, 363846.0, 65084.674576626814, 73988.63005684938, 79231.0, 79825.20174798294, 80462.59768701119, 944.6882528765491, 960.1790469148917, 967.4437198610686, 983.3853841349156, 984.8719666443317, 15510.534683959499, 15682.215889205267, 15726.135062571668, 15873.682526349177, 16272.105034222757, 25643.487130257665, 29260.707392925797, 30510.694893051674, 35452.46821297734, 37219.62780372162, 49399.50600493949, 49535.256971146184, 49642.25536617026, 49944.50055499544, 50180.247296289854, 6656.2345330287635, 7369.447291453055, 7535.510191837513, 7582.128055273714, 7917.247861453153, 10894.509747061244, 11418.942905285752, 11565.363904985306, 11692.35692036946, 11860.584879529175, 9291.907080929104, 9791.363561368773, 9967.50162491887, 10054.14539764099, 10581.365118092632, 10049.497525123861, 10134.138598219233, 10136.797264054825, 10236.33463824849, 10549.472526373496, 10100.797984040424, 10451.68644940653, 10536.10443112344, 10703.892961070289, 10827.133829293794, 7748.57382843949, 7807.86442157891, 7901.604919754104, 8067.233612806774, 8076.919230807616, 10229.079382855578, 10294.433806140734, 10458.320209186379, 10494.632687855888, 10912.290701104403], "value": 8250.62646023971, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.1608570514866, 1422.1396055386488, 1445.385711072794, 1568.1688704986361, 1793.9820601793979, 6720.3951644352, 7248.311410416015, 7464.402847772172, 7484.326410623043, 7487.73792917248, 7150.39221666159, 7351.852962940738, 7354.411647068235, 7571.167171611119, 7584.582847943361, 1831.7252412138153, 2099.769025407204, 2102.3272552783114, 2151.569686062786, 2176.064292354287, 2176.8258539316894, 2181.9127234910584, 2185.868847869133, 2186.4533866533366, 2188.3544354415485, 2063.3912995666315, 2113.2286715348864, 2165.71845660064, 2168.490404754881, 2171.0121894537947, 1781.4655603319018, 1976.545394559245, 2047.2220556188702, 2050.1082029317295, 2062.566860959193, 2101.95796084079, 2127.1066152215953, 2152.9354119376444, 2153.870767753924, 2154.7198864147563, 7539.396848252127, 7665.386769058462, 7671.884921726179, 7701.268379503938, 7706.075270967463, 4382.320740285261, 4509.323601459807, 4513.097380523908, 4518.751468669222, 4519.028408892104, 2913.0969399486225, 3012.578239046535, 3082.2756652186717, 3084.552739852731, 3095.520194369854, 875.7985663297413, 885.4996926736374, 896.0322851320558, 899.6221586933439, 913.1735779119907, 10211.183105351629, 10493.632722854663, 10517.52671129801, 10531.0, 10545.420001899893, 4052.1895620875944, 4140.296149654566, 4195.727277726938, 4200.285951388271, 4206.789660516962, 9031.051739567381, 9109.27125829932, 9115.453072815651, 9129.087091290818, 9144.588493517807, 4484.170428470743, 4484.955150448453, 4489.236829738952, 4491.124230774967, 4494.393256910275, 3608.783472991629, 3911.100446897173, 4010.258102251093, 4011.839526418969, 4043.454133691973, 3584.8207589620415, 3587.0852932502567, 3662.0661731258892, 3685.7419980601635, 3721.423179407196, 1153.2446247707765, 1157.3808012713157, 1174.5477990973536, 1179.988200118005, 1182.869884312725, 757.4886951307845, 768.9231076892378, 786.8741001439856, 787.1066339704362, 789.4749991255866, 5281.181416880389, 5331.546818520392, 5383.111786555174, 5552.500274975271, 5562.749676264497, 388.089929116222, 399.6682753314742, 408.0349972315453, 410.14075511802724, 412.70904012671593, 3730.7948062856804, 3805.60041195676, 3851.017990412427, 3856.4986551748093, 3857.633524815138, 9167.633294668272, 9540.427574345562, 9565.426074435418, 9570.0, 9608.327417080876, 8936.46381217129, 9331.973482916874, 9442.858357124649, 9451.054894510631, 9468.0, 6943.965280173667, 7221.205667376689, 7260.52806567582, 7284.380827629605, 7296.562206267535, 5208.218767184952, 5270.0, 5418.160185171305, 5500.614956953135, 5842.591018628656, 8651.653933842828, 8653.221210091122, 8691.304695624209, 8870.379073464796, 8893.28853691716, 8715.782105447415, 8952.68665596701, 8955.373123881265, 8964.14840590143, 9063.95468022682, 5978.970105149447, 6118.143459915526, 6230.563860529719, 6265.561410701207, 6317.494600432046, 7239.095113110861, 7262.9273707264365, 7311.159216690149, 7323.304286092813, 7331.193568707545, 6246.625202487865, 6390.297067322684, 6406.615603063831, 6473.093766872547, 6495.447886929664, 6153.753849846135, 6191.81424557264, 6249.187605611241, 6296.496280297657, 6328.050792381179, 6009.609375390585, 6058.848528786815, 6074.210352654127, 6088.51291896656, 6092.847678808065, 4606.332081848046, 4661.114388266218, 4712.59942904857, 4760.928586071281, 4769.403824521934, 4703.905921881475, 4725.952740472551, 4747.382840230748, 4771.71369717818, 4799.568038876518], "value": 3981.6787655861744, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.8975479072743, 283.7231219463803, 289.68569102523765, 291.6092436135578, 293.21564814122246, 4694.17851875922, 4773.164696178168, 4782.13921494131, 4787.593054590359, 4792.7603619819, 4346.934795978055, 4538.2511885538925, 4538.954610453894, 4558.247889098295, 4642.187617166991, 3544.16712072664, 3581.570211574615, 3591.0, 3699.7420876901847, 3748.850045998157, 3691.3724666806706, 3731.6641502264793, 3733.365327894251, 3734.439834024891, 3742.9064273393246, 3499.5450591423078, 3679.8528058877614, 3706.8331925063435, 3707.8702245421414, 3720.516332876722, 3695.907602309937, 3713.498677678506, 3713.6286371362785, 3717.4609681596016, 3737.9065523362133, 3256.788308759923, 3289.7039266465895, 3292.5555050068174, 3296.868125274986, 3301.6203136639356, 4500.234960056799, 4510.353720891883, 4564.6348292136545, 4591.449026116854, 4604.240300350438, 4126.94762835478, 4212.578742125794, 4216.62050415461, 4220.354061915856, 4254.659627229814, 4871.610271178332, 4884.7543876311665, 4884.92531643038, 4950.752462376867, 4967.751612419364, 3578.964210357889, 3601.8559257629663, 3602.9099272518133, 3602.981985090084, 3603.4955106285142, 5045.167547354682, 5078.923816142724, 5185.222216667492, 5195.9740201298755, 5197.922031169535, 3613.6567026132475, 3639.5086663300644, 3639.763415377992, 3661.1030297577263, 3661.992951938185, 3679.5400574928135, 3687.1703866629796, 3714.7028237740915, 3721.2371463850386, 3723.6276372362545, 4120.866761640573, 4135.655911828668, 4149.842082117342, 4150.5641907599265, 4199.94202840612, 4638.373819534319, 4946.826861059918, 4947.183714687037, 4963.5036496350795, 4970.90058198834, 1279.9808002879963, 1292.4377895615437, 1299.2399446323818, 1301.9349032548334, 1307.3724612186204, 838.9136068790931, 870.3168013109679, 907.1654078248027, 907.5552979040223, 910.9251083721273, 4348.0, 4372.475302963601, 4380.561943805657, 4411.3824064630335, 4413.8234470621455, 5026.0, 5044.924326135111, 5052.621053421009, 5121.820736274212, 5142.537171654569, 4183.309753890574, 4365.607095361369, 4366.585174408426, 4379.321205213133, 4440.0, 2697.3121853927123, 2704.067096851583, 2711.5797051457057, 2716.7826573874045, 2726.413821028488, 4797.856064318006, 4802.303665968415, 4822.059698358787, 4838.250071238893, 4850.563449289581, 5007.974960125176, 5171.2676253454765, 5176.9741151294, 5179.65911986774, 5240.34495688039, 4765.0946320199055, 4766.523347665206, 4793.9280910785665, 4795.472498025214, 4820.396985627722, 5092.541671249605, 5103.821366252163, 5104.0, 5117.334746482933, 5127.5897928166405, 4754.619630429488, 5027.824026159067, 5028.522290382408, 5055.443901170795, 5061.266116413026, 4821.963277895269, 4857.489963553776, 4863.90272194547, 4867.80528778859, 4877.536738978363, 3588.3540962626976, 3596.9100772480897, 3628.5282913221113, 3629.5825980012637, 3637.472566477793, 5050.873728156826, 5085.847424577269, 5103.974480127576, 5196.2465442509865, 5204.8178313758835, 4862.100511405401, 4898.338724272177, 4924.261360795909, 4930.975345123252, 4937.851864444073, 4895.143349913822, 4897.338859253955, 4903.6077113831525, 4921.680090794087, 4928.728919909296, 4676.907148759188, 4712.983690438054, 4836.975815120902, 4845.176320025534, 4871.634627402888, 4930.926036109533, 4932.753362331798, 4955.761059735066, 4959.801607935787, 4965.702057876539, 4784.40194975628, 4811.903761924672, 4813.566778989908, 4826.372571565815, 4828.444728856086], "value": 3736.6892586480935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.3433898931576, 718.479102650578, 725.6915810780418, 732.9152853776411, 738.2469880721665, 12269.938650306747, 12300.077494187939, 12364.876351236486, 12441.253524788508, 12458.0, 11724.706882327946, 11751.059915206784, 11789.7642047159, 11801.055915526758, 11829.231099978495, 626.9059641053856, 760.4372764154514, 795.4630624328584, 800.6677228950008, 804.7947773317825, 785.5365334452672, 789.6920201121567, 793.1354823242665, 793.8412317536487, 793.8888555602191, 661.4774328280653, 857.3269983063296, 858.7509622209583, 858.9527575983318, 859.1751918158575, 823.3289868756943, 838.3879767769502, 841.4236248169962, 846.724814435311, 848.893888263967, 613.9201903752528, 614.088079202384, 614.3457218062749, 614.4930432393248, 615.1510914937403, 11845.526178952832, 11867.287962722177, 11869.347185904771, 11879.465424055852, 11898.464569094325, 12328.81506777399, 12457.75084498305, 12911.289879056649, 12939.547115850994, 13072.346382680827, 11416.60041898538, 11616.186866919319, 11629.423506747602, 11773.293602383885, 12013.099017573717, 4065.2276067547073, 4139.287470385769, 4145.341863254692, 4161.167766446722, 4168.312228482297, 55610.0, 56083.43916560864, 56428.71785641087, 56828.43171568314, 56952.430475695124, 10134.54394552247, 10208.285420020527, 10443.791124177475, 10459.424731639681, 10732.946335268274, 17625.7356139658, 19084.14121364542, 19085.332013379466, 19103.235870565022, 19123.80876191248, 6787.5588086774205, 6946.861062778716, 6954.756583519553, 6970.721171153198, 7030.718771249195, 3735.6451137141926, 3739.2521495700967, 3745.6816170625257, 3806.7906265155684, 3823.1589050408866, 2894.5513445415995, 2958.2752225704407, 2976.7023297670494, 2977.2556860784803, 2979.702029797046, 491.616539099503, 527.6781163490268, 535.6250624562822, 542.1298815401303, 583.0787355977545, 611.1718621268118, 618.3939739055751, 620.950323974081, 625.5121005615628, 645.9580127291711, 8041.151894510988, 8172.795680107926, 8372.288355489729, 8649.610767515476, 8654.653813847375, 619.4208415131866, 619.5311682943467, 621.4624349937271, 623.1991890420878, 648.6765706565781, 3977.162038632733, 4079.796010199478, 4133.297339452301, 4139.379093136054, 4175.394567787654, 57991.420085799444, 87999.0, 96535.51732241434, 97567.0, 97802.0, 52148.0, 61509.38490615126, 73498.0, 86605.0, 86699.49753768493, 46005.539944600794, 46462.30306545404, 48915.75542122267, 74652.62673686596, 75078.0, 7830.843383132419, 7842.333401660694, 7866.7639970800965, 7985.5208687478935, 8137.430379873589, 45530.0, 46105.69784474828, 47274.527254727014, 47605.28592071191, 48258.27612585884, 58594.707026464595, 58723.41276587179, 64194.679026604565, 66811.0, 67056.0, 8821.911780882108, 8835.33734969867, 8935.285177185939, 8962.507062111647, 9059.501727405055, 10880.564777408816, 10948.343099413742, 11241.044511216638, 11388.487518061542, 11729.35488548138, 10700.892991070301, 10703.250772445854, 10965.443356504102, 10996.450177491253, 11106.444677766242, 9532.428054316762, 9585.760355991157, 9699.418034917928, 9724.367916085432, 10005.199584033115, 11330.108343661415, 11362.0, 11744.236624619372, 12148.453319600463, 12186.0, 9850.852237216304, 10099.394036357842, 10178.949105254427, 10251.948740256252, 10299.639512617023, 10224.087543998692, 10305.793884122126, 10354.948225258826, 10376.533056012648, 10490.423026733602], "value": 6444.368965527859, "unit": "score"}], "name": "dromaeo_css", "value": 6337.5427059327185, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 112.0, 113.0, 112.0, 111.0, 111.0, 112.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 134.0, 138.0, 178.0, 131.0, 161.0, 157.0, 132.0, 195.0, 134.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 162.0, 163.0, 161.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 104.0, 76.0, 78.0, 86.0, 76.0, 99.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 116.0, 87.0, 88.0, 87.0, 116.0, 86.0, 87.0, 129.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 119.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 84.0, 85.0, 84.0, 86.0, 85.0, 113.0, 85.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 146.0, 132.0, 132.0, 130.0, 133.0, 131.0, 141.0, 133.0, 134.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 165.0, 166.0, 165.0, 164.0, 165.0, 166.0, 166.0, 163.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 69.0, 67.0, 67.0, 67.0, 68.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1546.6000000000001, "alertThreshold": 2.0}]} 13:16:53 INFO - Return code: 0 13:16:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:16:53 ERROR - # TBPL SUCCESS # 13:16:53 INFO - Running post-action listener: _resource_record_post_action 13:16:53 INFO - ##### 13:16:53 INFO - ##### Finished run-tests step (success) 13:16:53 INFO - ##### 13:16:53 INFO - Running post-run listener: _resource_record_post_run 13:16:53 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 381927424; Read time: 0; Write time: 399820 13:16:53 INFO - TinderboxPrint: CPU usage
13.1% 13:16:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:16:53 INFO - TinderboxPrint: I/O write bytes / time
381,927,424 / 399,820 13:16:53 INFO - TinderboxPrint: CPU idle
8,323.7 (86.9%) 13:16:53 INFO - TinderboxPrint: CPU user
1,210.6 (12.6%) 13:16:53 INFO - TinderboxPrint: Swap in / out
0 / 0 13:16:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101535744; Read time: 0; Write time: 103004 13:16:53 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 280391680; Read time: 0; Write time: 296816 13:16:54 INFO - Running post-run listener: _upload_blobber_files 13:16:54 INFO - Blob upload gear active. 13:16:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:16:54 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 13:16:54 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'] 13:16:54 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 13:16:54 INFO - (blobuploader) - INFO - Open directory for files ... 13:16:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:16:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:16:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:16:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:16:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:16:55 INFO - (blobuploader) - INFO - Done attempting. 13:16:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:16:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:16:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:16:56 INFO - (blobuploader) - INFO - Done attempting. 13:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:00 INFO - (blobuploader) - INFO - Done attempting. 13:17:00 INFO - (blobuploader) - INFO - Iteration through files over. 13:17:00 INFO - Return code: 0 13:17:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:17:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:17:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c884368f7823086fc573703076c7dc6b183c315b915f91aa2bc25c621ba95a0f543bf419386d4975b706bdbe3203e69cf70fbe88cf6f8f1bbdbad285608b9c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18cdae4a3c5f37fc089d9fc6950d8ecb37392ab6e493e211bb5f1699a414320c3f8b65850d2f57e5d975fdd88ba37f3b1a46381808dc728bcdf95b1cc2b6090c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b00d315405a9ed6080859c9802eb88a29600dee787a3378ae3546f590533e9f7d581a88cc3a73d31940059bff212256719f7d509158b9479dc416d92192bba"} 13:17:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:17:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:17:00 INFO - Contents: 13:17:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c884368f7823086fc573703076c7dc6b183c315b915f91aa2bc25c621ba95a0f543bf419386d4975b706bdbe3203e69cf70fbe88cf6f8f1bbdbad285608b9c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18cdae4a3c5f37fc089d9fc6950d8ecb37392ab6e493e211bb5f1699a414320c3f8b65850d2f57e5d975fdd88ba37f3b1a46381808dc728bcdf95b1cc2b6090c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b00d315405a9ed6080859c9802eb88a29600dee787a3378ae3546f590533e9f7d581a88cc3a73d31940059bff212256719f7d509158b9479dc416d92192bba"} 13:17:01 INFO - Running post-run listener: copy_logs_to_upload_dir 13:17:01 INFO - Copying logs to upload dir... 13:17:01 INFO - mkdir: /builds/slave/test/build/upload/logs 13:17:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1305.413225 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2016-06-03 13:17:00.661044) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 13:17:00.664105) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c884368f7823086fc573703076c7dc6b183c315b915f91aa2bc25c621ba95a0f543bf419386d4975b706bdbe3203e69cf70fbe88cf6f8f1bbdbad285608b9c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18cdae4a3c5f37fc089d9fc6950d8ecb37392ab6e493e211bb5f1699a414320c3f8b65850d2f57e5d975fdd88ba37f3b1a46381808dc728bcdf95b1cc2b6090c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b00d315405a9ed6080859c9802eb88a29600dee787a3378ae3546f590533e9f7d581a88cc3a73d31940059bff212256719f7d509158b9479dc416d92192bba"} build_url:https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/Tv7WftI0T7uckmDKxJeC9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c884368f7823086fc573703076c7dc6b183c315b915f91aa2bc25c621ba95a0f543bf419386d4975b706bdbe3203e69cf70fbe88cf6f8f1bbdbad285608b9c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18cdae4a3c5f37fc089d9fc6950d8ecb37392ab6e493e211bb5f1699a414320c3f8b65850d2f57e5d975fdd88ba37f3b1a46381808dc728bcdf95b1cc2b6090c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39b00d315405a9ed6080859c9802eb88a29600dee787a3378ae3546f590533e9f7d581a88cc3a73d31940059bff212256719f7d509158b9479dc416d92192bba"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 13:17:00.689442) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 13:17:00.689792) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464981140.385804-30825088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 13:17:00.772730) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 13:17:00.773083) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 13:17:00.773396) ========= ========= Total master_lag: 0.20 =========