builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1465171909.09 results: success (0) buildid: 20160605143012 builduid: 2e2378f7909542089380c6200e867538 revision: 87207eee5e4785e29d405e7f3586d7bde08b91ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:49.088696) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:49.089209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:49.089716) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:49.127402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:49.127742) ========= 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=fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 17:11:49-- 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% 60.4M=0s 2016-06-05 17:11:49 (60.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090911 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:49.233659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:49.234128) ========= 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=fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021607 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:49.284759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:49.285169) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 87207eee5e4785e29d405e7f3586d7bde08b91ce --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 87207eee5e4785e29d405e7f3586d7bde08b91ce --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=fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 17:11:49,731 truncating revision to first 12 chars 2016-06-05 17:11:49,731 Setting DEBUG logging. 2016-06-05 17:11:49,731 attempt 1/10 2016-06-05 17:11:49,731 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/87207eee5e47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-05 17:11:50,161 unpacking tar archive at: fx-team-87207eee5e47/testing/mozharness/ program finished with exit code 0 elapsedTime=0.748057 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:50.046730) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:50.047060) ========= script_repo_revision: 87207eee5e4785e29d405e7f3586d7bde08b91ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:50.047502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:50.047880) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 17:11:50.062977) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-05 17:11:50.063294) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:11:50 INFO - MultiFileLogger online at 20160605 17:11:50 in /builds/slave/test 17:11:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:11:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:11:50 INFO - {'append_to_log': False, 17:11:50 INFO - 'base_work_dir': '/builds/slave/test', 17:11:50 INFO - 'blob_upload_branch': 'Fx-Team', 17:11:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:11:50 INFO - 'branch': 'Fx-Team', 17:11:50 INFO - 'buildbot_json_path': 'buildprops.json', 17:11:50 INFO - 'config_files': ('talos/linux_config.py',), 17:11:50 INFO - 'default_actions': ('clobber', 17:11:50 INFO - 'read-buildbot-config', 17:11:50 INFO - 'download-and-extract', 17:11:50 INFO - 'populate-webroot', 17:11:50 INFO - 'create-virtualenv', 17:11:50 INFO - 'install', 17:11:50 INFO - 'run-tests'), 17:11:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:11:50 INFO - 'download_minidump_stackwalk': True, 17:11:50 INFO - 'download_symbols': 'ondemand', 17:11:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:11:50 INFO - 'tooltool.py': '/tools/tooltool.py', 17:11:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:11:50 INFO - '/tools/misc-python/virtualenv.py')}, 17:11:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:11:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:11:50 INFO - 'installer_path': 'installer.exe', 17:11:50 INFO - 'log_level': 'info', 17:11:50 INFO - 'log_name': 'talos', 17:11:50 INFO - 'log_to_console': True, 17:11:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:11:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:11:50 INFO - 'opt_config_files': (), 17:11:50 INFO - 'pip_index': False, 17:11:50 INFO - 'sps_profile': False, 17:11:50 INFO - 'sps_profile_interval': 0, 17:11:50 INFO - 'suite': 'dromaeojs-e10s', 17:11:50 INFO - 'system_bits': '32', 17:11:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:11:50 INFO - 'title': 'talos-linux64-ix-048', 17:11:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:11:50 INFO - 'use_talos_json': True, 17:11:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:11:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:11:50 INFO - 'work_dir': 'build'} 17:11:50 INFO - ##### 17:11:50 INFO - ##### Running clobber step. 17:11:50 INFO - ##### 17:11:50 INFO - Running pre-action listener: _resource_record_pre_action 17:11:50 INFO - Running main action method: clobber 17:11:50 INFO - rmtree: /builds/slave/test/build 17:11:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:11:51 INFO - Running post-action listener: _resource_record_post_action 17:11:51 INFO - ##### 17:11:51 INFO - ##### Finished clobber step (success) 17:11:51 INFO - ##### 17:11:51 INFO - ##### 17:11:51 INFO - ##### Running read-buildbot-config step. 17:11:51 INFO - ##### 17:11:51 INFO - Running pre-action listener: _resource_record_pre_action 17:11:51 INFO - Running main action method: read_buildbot_config 17:11:51 INFO - Using buildbot properties: 17:11:51 INFO - { 17:11:51 INFO - "project": "", 17:11:51 INFO - "product": "firefox", 17:11:51 INFO - "script_repo_revision": "production", 17:11:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:11:51 INFO - "repository": "", 17:11:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:11:51 INFO - "buildid": "20160605143012", 17:11:51 INFO - "pgo_build": "True", 17:11:51 INFO - "basedir": "/builds/slave/test", 17:11:51 INFO - "buildnumber": 810, 17:11:51 INFO - "slavename": "talos-linux64-ix-048", 17:11:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:11:51 INFO - "platform": "ubuntu64_hw", 17:11:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:11:51 INFO - "branch": "fx-team", 17:11:51 INFO - "repo_path": "integration/fx-team", 17:11:51 INFO - "revision": "87207eee5e4785e29d405e7f3586d7bde08b91ce", 17:11:51 INFO - "stage_platform": "linux64-pgo", 17:11:51 INFO - "builduid": "2e2378f7909542089380c6200e867538", 17:11:51 INFO - "slavebuilddir": "test" 17:11:51 INFO - } 17:11:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:11:51 INFO - Running post-action listener: _resource_record_post_action 17:11:51 INFO - ##### 17:11:51 INFO - ##### Finished read-buildbot-config step (success) 17:11:51 INFO - ##### 17:11:51 INFO - ##### 17:11:51 INFO - ##### Running download-and-extract step. 17:11:51 INFO - ##### 17:11:51 INFO - Running pre-action listener: _resource_record_pre_action 17:11:51 INFO - Running main action method: download_and_extract 17:11:51 INFO - mkdir: /builds/slave/test/build/tests 17:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:51 INFO - https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:11:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:11:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:11:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/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 17:11:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/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 17:12:02 INFO - Downloaded 1361 bytes. 17:12:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:12:02 INFO - Using the following test package requirements: 17:12:02 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:02 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:12:02 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:12:02 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:02 INFO - u'jsshell-linux-x86_64.zip'], 17:12:02 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:12:02 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:02 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:12:02 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:12:02 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:12:02 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:12:02 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:02 INFO - https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:12:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:12:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/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 17:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/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 17:12:14 INFO - Downloaded 24440968 bytes. 17:12:14 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'] 17:12:14 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 17:12:15 INFO - Return code: 0 17:12:15 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 17:12:15 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')]} 17:12:15 INFO - https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/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 17:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/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 17:12:17 INFO - Downloaded 24440968 bytes. 17:12:17 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'] 17:12:17 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 17:12:18 INFO - Return code: 0 17:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:18 INFO - https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:12:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/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 17:12:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/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 17:12:20 INFO - Downloaded 10833369 bytes. 17:12:20 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'] 17:12:20 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 17:12:20 INFO - Return code: 0 17:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:20 INFO - https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:12:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:12:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:12:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/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 17:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MrTY-ce5TEOWwUBxxmUKsA/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 17:12:30 INFO - Downloaded 59154984 bytes. 17:12:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:12:30 INFO - mkdir: /builds/slave/test/properties 17:12:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:12:30 INFO - Writing to file /builds/slave/test/properties/build_url 17:12:30 INFO - Contents: 17:12:30 INFO - build_url:https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:12:31 INFO - Running post-action listener: _resource_record_post_action 17:12:31 INFO - Running post-action listener: set_extra_try_arguments 17:12:31 INFO - ##### 17:12:31 INFO - ##### Finished download-and-extract step (success) 17:12:31 INFO - ##### 17:12:31 INFO - ##### 17:12:31 INFO - ##### Running populate-webroot step. 17:12:31 INFO - ##### 17:12:31 INFO - Running pre-action listener: _resource_record_pre_action 17:12:31 INFO - Running main action method: populate_webroot 17:12:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:12:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:12:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:12:31 INFO - '--tppagecycles', 17:12:31 INFO - '7'], 17:12:31 INFO - 'tests': ['tsvgm']}}, 17:12:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:12:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:12:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:12:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:12:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:12:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:12:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'talos_options': ['--disable-e10s'], 17:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'talos_options': ['--disable-e10s'], 17:12:31 INFO - 'tests': ['damp', 'tps']}, 17:12:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'tests': ['damp', 'tps']}, 17:12:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:12:31 INFO - 'tests': ['dromaeo_dom']}, 17:12:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:12:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:12:31 INFO - 'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'other-e10s': {'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:12:31 INFO - 'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:12:31 INFO - 'tests': ['a11yr', 17:12:31 INFO - 'ts_paint', 17:12:31 INFO - 'tpaint', 17:12:31 INFO - 'sessionrestore', 17:12:31 INFO - 'sessionrestore_no_auto_restore', 17:12:31 INFO - 'tabpaint']}, 17:12:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:12:31 INFO - 'tests': ['tsvgx', 17:12:31 INFO - 'tsvgr_opacity', 17:12:31 INFO - 'tart', 17:12:31 INFO - 'tscrollx', 17:12:31 INFO - 'cart']}, 17:12:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:12:31 INFO - 'tsvgr_opacity', 17:12:31 INFO - 'tart', 17:12:31 INFO - 'tscrollx', 17:12:31 INFO - 'cart']}, 17:12:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'talos_options': ['--disable-e10s'], 17:12:31 INFO - 'tests': ['tp5o']}, 17:12:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'tests': ['tp5o']}, 17:12:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'talos_options': ['--disable-e10s', 17:12:31 INFO - '--xperf_path', 17:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:31 INFO - 'tests': ['tp5n']}, 17:12:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:31 INFO - 'talos_options': ['--xperf_path', 17:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:31 INFO - 'tests': ['tp5n']}}, 17:12:31 INFO - 'talos.zip': {'path': '', 17:12:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:12:31 INFO - Running post-action listener: _resource_record_post_action 17:12:31 INFO - ##### 17:12:31 INFO - ##### Finished populate-webroot step (success) 17:12:31 INFO - ##### 17:12:31 INFO - ##### 17:12:31 INFO - ##### Running create-virtualenv step. 17:12:31 INFO - ##### 17:12:31 INFO - Running pre-action listener: _resource_record_pre_action 17:12:31 INFO - Running main action method: create_virtualenv 17:12:31 INFO - Creating virtualenv /builds/slave/test/build/venv 17:12:31 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 17:12:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:12:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:31 INFO - Using real prefix '/usr' 17:12:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:12:31 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:33 INFO - Installing pip.................done. 17:12:33 INFO - Return code: 0 17:12:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:33 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 0x7ffad2ec4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1308350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13971c0>, '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 0x13980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1398550>, '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': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', '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 17:12:33 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 17:12:33 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 17:12:33 INFO - Using env: {'DISPLAY': ':0', 17:12:33 INFO - 'HOME': '/home/cltbld', 17:12:33 INFO - 'LANG': 'en_US.UTF-8', 17:12:33 INFO - 'LANGUAGE': 'en_US:en', 17:12:33 INFO - 'LOGNAME': 'cltbld', 17:12:33 INFO - 'MAIL': '/var/mail/cltbld', 17:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:33 INFO - 'MOZ_NO_REMOTE': '1', 17:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:33 INFO - 'NO_EM_RESTART': '1', 17:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:33 INFO - 'PWD': '/builds/slave/test', 17:12:33 INFO - 'SHELL': '/bin/bash', 17:12:33 INFO - 'SHLVL': '1', 17:12:33 INFO - 'TERM': 'linux', 17:12:33 INFO - 'TMOUT': '86400', 17:12:33 INFO - 'USER': 'cltbld', 17:12:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', 17:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:33 INFO - '_': '/tools/buildbot/bin/python'} 17:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:34 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 17:12:34 INFO - Cleaning up... 17:12:34 INFO - Return code: 0 17:12:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:34 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 0x7ffad2ec4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1308350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13971c0>, '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 0x13980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1398550>, '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': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', '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 17:12:34 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 17:12:34 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 17:12:34 INFO - Using env: {'DISPLAY': ':0', 17:12:34 INFO - 'HOME': '/home/cltbld', 17:12:34 INFO - 'LANG': 'en_US.UTF-8', 17:12:34 INFO - 'LANGUAGE': 'en_US:en', 17:12:34 INFO - 'LOGNAME': 'cltbld', 17:12:34 INFO - 'MAIL': '/var/mail/cltbld', 17:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:34 INFO - 'MOZ_NO_REMOTE': '1', 17:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:34 INFO - 'NO_EM_RESTART': '1', 17:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:34 INFO - 'PWD': '/builds/slave/test', 17:12:34 INFO - 'SHELL': '/bin/bash', 17:12:34 INFO - 'SHLVL': '1', 17:12:34 INFO - 'TERM': 'linux', 17:12:34 INFO - 'TMOUT': '86400', 17:12:34 INFO - 'USER': 'cltbld', 17:12:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', 17:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:34 INFO - '_': '/tools/buildbot/bin/python'} 17:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:34 INFO - Downloading/unpacking psutil>=3.1.1 17:12:34 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 17:12:34 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 17:12:34 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 17:12:34 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 17:12:34 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 17:12:34 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 17:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:36 INFO - Installing collected packages: psutil 17:12:36 INFO - Running setup.py install for psutil 17:12:36 INFO - building 'psutil._psutil_linux' extension 17:12:36 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 17:12:36 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 17:12:36 INFO - building 'psutil._psutil_posix' extension 17:12:36 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 17:12:36 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 17:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:36 INFO - Successfully installed psutil 17:12:36 INFO - Cleaning up... 17:12:37 INFO - Return code: 0 17:12:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:37 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 0x7ffad2ec4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1308350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13971c0>, '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 0x13980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1398550>, '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': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', '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 17:12:37 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 17:12:37 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 17:12:37 INFO - Using env: {'DISPLAY': ':0', 17:12:37 INFO - 'HOME': '/home/cltbld', 17:12:37 INFO - 'LANG': 'en_US.UTF-8', 17:12:37 INFO - 'LANGUAGE': 'en_US:en', 17:12:37 INFO - 'LOGNAME': 'cltbld', 17:12:37 INFO - 'MAIL': '/var/mail/cltbld', 17:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:37 INFO - 'MOZ_NO_REMOTE': '1', 17:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:37 INFO - 'NO_EM_RESTART': '1', 17:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:37 INFO - 'PWD': '/builds/slave/test', 17:12:37 INFO - 'SHELL': '/bin/bash', 17:12:37 INFO - 'SHLVL': '1', 17:12:37 INFO - 'TERM': 'linux', 17:12:37 INFO - 'TMOUT': '86400', 17:12:37 INFO - 'USER': 'cltbld', 17:12:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', 17:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:37 INFO - '_': '/tools/buildbot/bin/python'} 17:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:37 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 17:12:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:12:39 INFO - Installing collected packages: mozsystemmonitor 17:12:39 INFO - Running setup.py install for mozsystemmonitor 17:12:39 INFO - Successfully installed mozsystemmonitor 17:12:39 INFO - Cleaning up... 17:12:39 INFO - Return code: 0 17:12:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffad2ec4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1308350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13971c0>, '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 0x13980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1398550>, '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': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', '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 17:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:12:39 INFO - Using env: {'DISPLAY': ':0', 17:12:39 INFO - 'HOME': '/home/cltbld', 17:12:39 INFO - 'LANG': 'en_US.UTF-8', 17:12:39 INFO - 'LANGUAGE': 'en_US:en', 17:12:39 INFO - 'LOGNAME': 'cltbld', 17:12:39 INFO - 'MAIL': '/var/mail/cltbld', 17:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:39 INFO - 'MOZ_NO_REMOTE': '1', 17:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:39 INFO - 'NO_EM_RESTART': '1', 17:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:39 INFO - 'PWD': '/builds/slave/test', 17:12:39 INFO - 'SHELL': '/bin/bash', 17:12:39 INFO - 'SHLVL': '1', 17:12:39 INFO - 'TERM': 'linux', 17:12:39 INFO - 'TMOUT': '86400', 17:12:39 INFO - 'USER': 'cltbld', 17:12:39 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', 17:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:39 INFO - '_': '/tools/buildbot/bin/python'} 17:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:39 INFO - Downloading/unpacking jsonschema==2.5.1 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:12:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:41 INFO - Downloading functools32-3.2.3-2.tar.gz 17:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:12:41 INFO - warning: no files found matching '*.txt' 17:12:41 INFO - no previously-included directories found matching 'build' 17:12:41 INFO - no previously-included directories found matching 'dist' 17:12:41 INFO - no previously-included directories found matching '.git*' 17:12:41 INFO - Installing collected packages: jsonschema, functools32 17:12:41 INFO - Running setup.py install for functools32 17:12:41 INFO - warning: no files found matching '*.txt' 17:12:41 INFO - no previously-included directories found matching 'build' 17:12:41 INFO - no previously-included directories found matching 'dist' 17:12:41 INFO - no previously-included directories found matching '.git*' 17:12:41 INFO - Successfully installed jsonschema functools32 17:12:41 INFO - Cleaning up... 17:12:41 INFO - Return code: 0 17:12:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:41 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 0x7ffad2ec4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1308350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13971c0>, '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 0x13980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1398550>, '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': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', '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 17:12:41 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 17:12:41 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 17:12:41 INFO - Using env: {'DISPLAY': ':0', 17:12:41 INFO - 'HOME': '/home/cltbld', 17:12:41 INFO - 'LANG': 'en_US.UTF-8', 17:12:41 INFO - 'LANGUAGE': 'en_US:en', 17:12:41 INFO - 'LOGNAME': 'cltbld', 17:12:41 INFO - 'MAIL': '/var/mail/cltbld', 17:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:41 INFO - 'MOZ_NO_REMOTE': '1', 17:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:41 INFO - 'NO_EM_RESTART': '1', 17:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:41 INFO - 'PWD': '/builds/slave/test', 17:12:41 INFO - 'SHELL': '/bin/bash', 17:12:41 INFO - 'SHLVL': '1', 17:12:41 INFO - 'TERM': 'linux', 17:12:41 INFO - 'TMOUT': '86400', 17:12:41 INFO - 'USER': 'cltbld', 17:12:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', 17:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:41 INFO - '_': '/tools/buildbot/bin/python'} 17:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:42 INFO - Downloading/unpacking blobuploader==1.2.4 17:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:43 INFO - Downloading blobuploader-1.2.4.tar.gz 17:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:12:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:12:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:44 INFO - Downloading docopt-0.6.1.tar.gz 17:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:12:44 INFO - Installing collected packages: blobuploader, requests, docopt 17:12:44 INFO - Running setup.py install for blobuploader 17:12:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:12:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:12:44 INFO - Running setup.py install for requests 17:12:45 INFO - Running setup.py install for docopt 17:12:45 INFO - Successfully installed blobuploader requests docopt 17:12:45 INFO - Cleaning up... 17:12:45 INFO - Return code: 0 17:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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')]} 17:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:45 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 0x7ffad2ec4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1308350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13971c0>, '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 0x13980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1398550>, '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': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', '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 17:12:45 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 17:12:45 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 17:12:45 INFO - Using env: {'DISPLAY': ':0', 17:12:45 INFO - 'HOME': '/home/cltbld', 17:12:45 INFO - 'LANG': 'en_US.UTF-8', 17:12:45 INFO - 'LANGUAGE': 'en_US:en', 17:12:45 INFO - 'LOGNAME': 'cltbld', 17:12:45 INFO - 'MAIL': '/var/mail/cltbld', 17:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:45 INFO - 'MOZ_NO_REMOTE': '1', 17:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:45 INFO - 'NO_EM_RESTART': '1', 17:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:45 INFO - 'PWD': '/builds/slave/test', 17:12:45 INFO - 'SHELL': '/bin/bash', 17:12:45 INFO - 'SHLVL': '1', 17:12:45 INFO - 'TERM': 'linux', 17:12:45 INFO - 'TMOUT': '86400', 17:12:45 INFO - 'USER': 'cltbld', 17:12:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', 17:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:45 INFO - '_': '/tools/buildbot/bin/python'} 17:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:45 INFO - Running setup.py (path:/tmp/pip-j2rTgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:45 INFO - Running setup.py (path:/tmp/pip-oECoQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:45 INFO - Running setup.py (path:/tmp/pip-Ds4v27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:45 INFO - Running setup.py (path:/tmp/pip-YRQkPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:45 INFO - Running setup.py (path:/tmp/pip-gYS_aU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:45 INFO - Running setup.py (path:/tmp/pip-Hk5y56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:45 INFO - Running setup.py (path:/tmp/pip-jEhFLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:46 INFO - Running setup.py (path:/tmp/pip-czgVdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:46 INFO - Running setup.py (path:/tmp/pip-VwxsEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:46 INFO - Running setup.py (path:/tmp/pip-IW8TC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:46 INFO - Running setup.py (path:/tmp/pip-FSYlwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:46 INFO - Running setup.py (path:/tmp/pip-8niMGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:46 INFO - Running setup.py (path:/tmp/pip-s7IETb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:46 INFO - Running setup.py (path:/tmp/pip-PkSa8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:46 INFO - Running setup.py (path:/tmp/pip-Btq8I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:46 INFO - Running setup.py (path:/tmp/pip-jL5J06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:46 INFO - Running setup.py (path:/tmp/pip-mw2Pa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:12:46 INFO - Running setup.py install for manifestparser 17:12:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:12:46 INFO - Running setup.py install for mozcrash 17:12:46 INFO - Running setup.py install for mozdebug 17:12:47 INFO - Running setup.py install for mozdevice 17:12:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Running setup.py install for mozfile 17:12:47 INFO - Running setup.py install for mozhttpd 17:12:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Running setup.py install for mozinfo 17:12:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Running setup.py install for mozInstall 17:12:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Running setup.py install for mozleak 17:12:47 INFO - Running setup.py install for mozlog 17:12:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Running setup.py install for moznetwork 17:12:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:12:47 INFO - Running setup.py install for mozprocess 17:12:47 INFO - Running setup.py install for mozprofile 17:12:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Running setup.py install for mozrunner 17:12:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Running setup.py install for mozscreenshot 17:12:48 INFO - Running setup.py install for moztest 17:12:48 INFO - Running setup.py install for mozversion 17:12:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:12:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:12:48 INFO - Cleaning up... 17:12:48 INFO - Return code: 0 17:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:48 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')]} 17:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:48 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')]} 17:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:48 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 0x7ffad2ec4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1308350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13971c0>, '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 0x13980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1398550>, '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': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', '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 17:12:48 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 17:12:48 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 17:12:48 INFO - Using env: {'DISPLAY': ':0', 17:12:48 INFO - 'HOME': '/home/cltbld', 17:12:48 INFO - 'LANG': 'en_US.UTF-8', 17:12:48 INFO - 'LANGUAGE': 'en_US:en', 17:12:48 INFO - 'LOGNAME': 'cltbld', 17:12:48 INFO - 'MAIL': '/var/mail/cltbld', 17:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:48 INFO - 'MOZ_NO_REMOTE': '1', 17:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:48 INFO - 'NO_EM_RESTART': '1', 17:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:48 INFO - 'PWD': '/builds/slave/test', 17:12:48 INFO - 'SHELL': '/bin/bash', 17:12:48 INFO - 'SHLVL': '1', 17:12:48 INFO - 'TERM': 'linux', 17:12:48 INFO - 'TMOUT': '86400', 17:12:48 INFO - 'USER': 'cltbld', 17:12:48 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', 17:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:48 INFO - '_': '/tools/buildbot/bin/python'} 17:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:48 INFO - Running setup.py (path:/tmp/pip-07ddV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:48 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)) 17:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:48 INFO - Running setup.py (path:/tmp/pip-NsnpXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:48 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)) 17:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:48 INFO - Running setup.py (path:/tmp/pip-jxsqAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:48 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)) 17:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:48 INFO - Running setup.py (path:/tmp/pip-nKDPs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:49 INFO - Running setup.py (path:/tmp/pip-rq1ruN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:49 INFO - Running setup.py (path:/tmp/pip-6X5B2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:49 INFO - Running setup.py (path:/tmp/pip-vEGR61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:49 INFO - Running setup.py (path:/tmp/pip-TdFDiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:49 INFO - Running setup.py (path:/tmp/pip-nYtqD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:49 INFO - Running setup.py (path:/tmp/pip-TItpCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:49 INFO - Running setup.py (path:/tmp/pip-fYHZrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:49 INFO - Running setup.py (path:/tmp/pip-kBYN9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:49 INFO - Running setup.py (path:/tmp/pip-QsxUZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:49 INFO - Running setup.py (path:/tmp/pip-paX9O7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:49 INFO - Running setup.py (path:/tmp/pip-TdHbSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:49 INFO - Running setup.py (path:/tmp/pip-g45GCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:49 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)) 17:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:49 INFO - Running setup.py (path:/tmp/pip-pHX13Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:49 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)) 17:12:49 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)) 17:12:49 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)) 17:12:50 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)) 17:12:50 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)) 17:12:50 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)) 17:12:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:51 INFO - Downloading blessings-1.6.tar.gz 17:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:12:51 INFO - Installing collected packages: blessings 17:12:51 INFO - Running setup.py install for blessings 17:12:52 INFO - Successfully installed blessings 17:12:52 INFO - Cleaning up... 17:12:52 INFO - Return code: 0 17:12:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:52 INFO - Reading from file tmpfile_stdout 17:12:52 INFO - Current package versions: 17:12:52 INFO - argparse == 1.2.1 17:12:52 INFO - blessings == 1.6 17:12:52 INFO - blobuploader == 1.2.4 17:12:52 INFO - docopt == 0.6.1 17:12:52 INFO - functools32 == 3.2.3-2 17:12:52 INFO - jsonschema == 2.5.1 17:12:52 INFO - manifestparser == 1.1 17:12:52 INFO - mozInstall == 1.12 17:12:52 INFO - mozcrash == 0.17 17:12:52 INFO - mozdebug == 0.1 17:12:52 INFO - mozdevice == 0.48 17:12:52 INFO - mozfile == 1.2 17:12:52 INFO - mozhttpd == 0.7 17:12:52 INFO - mozinfo == 0.9 17:12:52 INFO - mozleak == 0.1 17:12:52 INFO - mozlog == 3.2 17:12:52 INFO - moznetwork == 0.27 17:12:52 INFO - mozprocess == 0.22 17:12:52 INFO - mozprofile == 0.28 17:12:52 INFO - mozrunner == 6.11 17:12:52 INFO - mozscreenshot == 0.1 17:12:52 INFO - mozsystemmonitor == 0.3 17:12:52 INFO - moztest == 0.7 17:12:52 INFO - mozversion == 1.4 17:12:52 INFO - psutil == 3.1.1 17:12:52 INFO - requests == 1.2.3 17:12:52 INFO - wsgiref == 0.1.2 17:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:52 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')]} 17:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:52 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')]} 17:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:52 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 0x7ffad2ec4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1308350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13971c0>, '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 0x13980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1398550>, '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': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', '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 17:12:52 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 17:12:52 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 17:12:52 INFO - Using env: {'DISPLAY': ':0', 17:12:52 INFO - 'HOME': '/home/cltbld', 17:12:52 INFO - 'LANG': 'en_US.UTF-8', 17:12:52 INFO - 'LANGUAGE': 'en_US:en', 17:12:52 INFO - 'LOGNAME': 'cltbld', 17:12:52 INFO - 'MAIL': '/var/mail/cltbld', 17:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:52 INFO - 'MOZ_NO_REMOTE': '1', 17:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:52 INFO - 'NO_EM_RESTART': '1', 17:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:52 INFO - 'PWD': '/builds/slave/test', 17:12:52 INFO - 'SHELL': '/bin/bash', 17:12:52 INFO - 'SHLVL': '1', 17:12:52 INFO - 'TERM': 'linux', 17:12:52 INFO - 'TMOUT': '86400', 17:12:52 INFO - 'USER': 'cltbld', 17:12:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', 17:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:52 INFO - '_': '/tools/buildbot/bin/python'} 17:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:52 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)) 17:12:52 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)) 17:12:52 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)) 17:12:52 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)) 17:12:52 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)) 17:12:52 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)) 17:12:52 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)) 17:12:52 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)) 17:12:52 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)) 17:12:52 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)) 17:12:52 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)) 17:12:52 INFO - Cleaning up... 17:12:52 INFO - Return code: 0 17:12:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:12:52 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')]} 17:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:52 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')]} 17:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:52 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 0x7ffad2ec4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1308350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13971c0>, '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 0x13980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1398550>, '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': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', '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 17:12:52 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 17:12:52 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 17:12:52 INFO - Using env: {'DISPLAY': ':0', 17:12:52 INFO - 'HOME': '/home/cltbld', 17:12:52 INFO - 'LANG': 'en_US.UTF-8', 17:12:52 INFO - 'LANGUAGE': 'en_US:en', 17:12:52 INFO - 'LOGNAME': 'cltbld', 17:12:52 INFO - 'MAIL': '/var/mail/cltbld', 17:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:52 INFO - 'MOZ_NO_REMOTE': '1', 17:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:52 INFO - 'NO_EM_RESTART': '1', 17:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:52 INFO - 'PWD': '/builds/slave/test', 17:12:52 INFO - 'SHELL': '/bin/bash', 17:12:52 INFO - 'SHLVL': '1', 17:12:52 INFO - 'TERM': 'linux', 17:12:52 INFO - 'TMOUT': '86400', 17:12:52 INFO - 'USER': 'cltbld', 17:12:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', 17:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:52 INFO - '_': '/tools/buildbot/bin/python'} 17:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:12:52 INFO - Cleaning up... 17:12:52 INFO - Return code: 0 17:12:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:12:52 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')]} 17:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:52 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')]} 17:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:52 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 0x7ffad2ec4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1308350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13971c0>, '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 0x13980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1398550>, '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': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', '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 17:12:52 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 17:12:52 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 17:12:52 INFO - Using env: {'DISPLAY': ':0', 17:12:52 INFO - 'HOME': '/home/cltbld', 17:12:52 INFO - 'LANG': 'en_US.UTF-8', 17:12:52 INFO - 'LANGUAGE': 'en_US:en', 17:12:52 INFO - 'LOGNAME': 'cltbld', 17:12:52 INFO - 'MAIL': '/var/mail/cltbld', 17:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:52 INFO - 'MOZ_NO_REMOTE': '1', 17:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:52 INFO - 'NO_EM_RESTART': '1', 17:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:52 INFO - 'PWD': '/builds/slave/test', 17:12:52 INFO - 'SHELL': '/bin/bash', 17:12:52 INFO - 'SHLVL': '1', 17:12:52 INFO - 'TERM': 'linux', 17:12:52 INFO - 'TMOUT': '86400', 17:12:52 INFO - 'USER': 'cltbld', 17:12:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', 17:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:52 INFO - '_': '/tools/buildbot/bin/python'} 17:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:52 INFO - Downloading/unpacking flake8 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:12:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:12:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:12:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:12:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:12:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:12:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:12:55 INFO - no previously-included directories found matching 'docs/_build' 17:12:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:12:55 INFO - Running setup.py install for pep8 17:12:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:12:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:12:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:12:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:12:55 INFO - no previously-included directories found matching 'docs/_build' 17:12:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:12:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:12:55 INFO - Cleaning up... 17:12:55 INFO - Return code: 0 17:12:55 INFO - Running post-action listener: _resource_record_post_action 17:12:55 INFO - Running post-action listener: _start_resource_monitoring 17:12:55 INFO - Starting resource monitoring. 17:12:55 INFO - ##### 17:12:55 INFO - ##### Finished create-virtualenv step (success) 17:12:55 INFO - ##### 17:12:55 INFO - ##### 17:12:55 INFO - ##### Running install step. 17:12:55 INFO - ##### 17:12:55 INFO - Running pre-action listener: _resource_record_pre_action 17:12:55 INFO - Running main action method: install 17:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:56 INFO - Reading from file tmpfile_stdout 17:12:56 INFO - Detecting whether we're running mozinstall >=1.0... 17:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:12:56 INFO - Reading from file tmpfile_stdout 17:12:56 INFO - Output received: 17:12:56 INFO - Usage: mozinstall [options] installer 17:12:56 INFO - Options: 17:12:56 INFO - -h, --help show this help message and exit 17:12:56 INFO - -d DEST, --destination=DEST 17:12:56 INFO - Directory to install application into. [default: 17:12:56 INFO - "/builds/slave/test"] 17:12:56 INFO - --app=APP Application being installed. [default: firefox] 17:12:56 INFO - mkdir: /builds/slave/test/build/application 17:12:56 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'] 17:12:56 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 17:13:12 INFO - Reading from file tmpfile_stdout 17:13:12 INFO - Output received: 17:13:12 INFO - /builds/slave/test/build/application/firefox/firefox 17:13:12 INFO - Running post-action listener: _resource_record_post_action 17:13:12 INFO - ##### 17:13:12 INFO - ##### Finished install step (success) 17:13:12 INFO - ##### 17:13:12 INFO - ##### 17:13:12 INFO - ##### Running run-tests step. 17:13:12 INFO - ##### 17:13:12 INFO - Running pre-action listener: _resource_record_pre_action 17:13:12 INFO - Running main action method: run_tests 17:13:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:13:12 INFO - Python 2.7.3 17:13:12 INFO - Return code: 0 17:13:12 INFO - grabbing minidump binary from tooltool 17:13:12 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')]} 17:13:12 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 0x13971c0>, '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 0x13980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1398550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:13:12 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 17:13:12 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 17:13:12 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 17:13:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:13:13 INFO - Return code: 0 17:13:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:13:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:13:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:13:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:13:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:13:13 INFO - Return code: 0 17:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:13:13 INFO - Using env: {'DISPLAY': ':0', 17:13:13 INFO - 'HOME': '/home/cltbld', 17:13:13 INFO - 'LANG': 'en_US.UTF-8', 17:13:13 INFO - 'LANGUAGE': 'en_US:en', 17:13:13 INFO - 'LOGNAME': 'cltbld', 17:13:13 INFO - 'MAIL': '/var/mail/cltbld', 17:13:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:13:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:13 INFO - 'MOZ_NO_REMOTE': '1', 17:13:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:13 INFO - 'NO_EM_RESTART': '1', 17:13:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:13 INFO - 'PWD': '/builds/slave/test', 17:13:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:13:13 INFO - 'SHELL': '/bin/bash', 17:13:13 INFO - 'SHLVL': '1', 17:13:13 INFO - 'TERM': 'linux', 17:13:13 INFO - 'TMOUT': '86400', 17:13:13 INFO - 'USER': 'cltbld', 17:13:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883', 17:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:13 INFO - '_': '/tools/buildbot/bin/python'} 17:13:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:13:14 INFO - mozversion application_buildid: 20160605143012 17:13:14 INFO - mozversion application_changeset: 87207eee5e4785e29d405e7f3586d7bde08b91ce 17:13:14 INFO - mozversion application_display_name: Nightly 17:13:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:13:14 INFO - mozversion application_name: Firefox 17:13:14 INFO - mozversion application_remotingname: firefox 17:13:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:13:14 INFO - mozversion application_vendor: Mozilla 17:13:14 INFO - mozversion application_version: 49.0a1 17:13:14 INFO - mozversion platform_buildid: 20160605143012 17:13:14 INFO - mozversion platform_changeset: 87207eee5e4785e29d405e7f3586d7bde08b91ce 17:13:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:13:14 INFO - mozversion platform_version: 49.0a1 17:13:14 INFO - using testdate: 1465171994 17:13:14 INFO - actual date: 1465171994 17:13:14 INFO - starting webserver on 'localhost:34054' 17:13:14 INFO - SUITE-START | Running 2 tests 17:13:14 INFO - TEST-START | dromaeo_css 17:13:14 INFO - operating with platform_type : linux_ 17:13:14 INFO - Initialising browser for dromaeo_css test... 17:13:14 INFO - TEST-INFO | started process 4475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxZnmPe/profile http://localhost:34054/getInfo.html) 17:13:19 INFO - PROCESS | 4475 | __metrics Screen width/height:1600/1200 17:13:19 INFO - PROCESS | 4475 | colorDepth:24 17:13:19 INFO - PROCESS | 4475 | Browser inner width/height: 1024/697 17:13:19 INFO - PROCESS | 4475 | __metrics 17:13:19 ERROR - PROCESS | 4475 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 17:13:20 INFO - TEST-INFO | 4475: exit 0 17:13:20 INFO - Browser initialized. 17:13:20 INFO - Running cycle 1/1 for dromaeo_css test... 17:13:20 INFO - TEST-INFO | started process 4594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxZnmPe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:32 INFO - PROCESS | 4594 | RSS: Main: 167153664 17:13:32 INFO - PROCESS | 4594 | 17:14:21 INFO - PROCESS | 4594 | 1465172061998 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] 17:16:29 INFO - PROCESS | 4594 | Cycle 1(1): loaded http://localhost:34054/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34054/tests/dromaeo/cssquery-ext.html) 17:16:30 INFO - PROCESS | 4594 | RSS: Main: 170872832 17:16:30 INFO - PROCESS | 4594 | 17:19:32 INFO - PROCESS | 4594 | Cycle 1(1): loaded http://localhost:34054/tests/dromaeo/cssquery-ext.html (next: http://localhost:34054/tests/dromaeo/cssquery-jquery.html) 17:19:33 INFO - PROCESS | 4594 | RSS: Main: 170196992 17:19:33 INFO - PROCESS | 4594 | 17:22:35 INFO - PROCESS | 4594 | Cycle 1(1): loaded http://localhost:34054/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34054/tests/dromaeo/cssquery-mootools.html) 17:22:35 INFO - PROCESS | 4594 | RSS: Main: 171495424 17:22:35 INFO - PROCESS | 4594 | 17:25:37 INFO - PROCESS | 4594 | Cycle 1(1): loaded http://localhost:34054/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34054/tests/dromaeo/cssquery-prototype.html) 17:25:38 INFO - PROCESS | 4594 | RSS: Main: 168947712 17:25:38 INFO - PROCESS | 4594 | 17:28:40 INFO - PROCESS | 4594 | Cycle 1(1): loaded http://localhost:34054/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34054/tests/dromaeo/cssquery-yui.html) 17:28:41 INFO - PROCESS | 4594 | RSS: Main: 171274240 17:28:41 INFO - PROCESS | 4594 | 17:31:44 INFO - PROCESS | 4594 | Cycle 1(1): loaded http://localhost:34054/tests/dromaeo/cssquery-yui.html (next: http://localhost:34054/tests/dromaeo/cssquery-dojo.html) 17:31:44 INFO - PROCESS | 4594 | RSS: Main: 171675648 17:31:44 INFO - PROCESS | 4594 | 17:31:44 INFO - PROCESS | 4594 | __start_tp_report 17:31:44 INFO - PROCESS | 4594 | _x_x_mozilla_page_load 17:31:44 INFO - PROCESS | 4594 | _x_x_mozilla_page_load_details 17:31:44 INFO - PROCESS | 4594 | |i|pagename|runs| 17:31:44 INFO - PROCESS | 4594 | |0;dojo.html;3078.8614512346944;3115.937681246375;3125.9843700781494;3142.5757522734425;3160.5417214503896;5389.407165211834;5417.214503896933;5435.347758269008;5486.643368181066;5508.7521061552225;5310.468953104688;5425.457454254572;5510.889782204354;5513.917291240635;5528.281323427958;4920.827771028024;4953.9504604953845;5057.671251368668;5091.363579552556;5136.229565565158;732.9645895923124;4989.052080104787;4999.975000124994;5005.399352077756;5022.096022715909;4906.484819093997;4922.729249891255;4947.183714687072;4956.553910148086;4978.029284289583;4827.155247831615;4935.728534930578;4941;4962.4789397113145;5000.1999680051385;4851.054044461332;4854.417469903598;4875.146849301358;4901.09329773993;4923.212286034253;5329.973350133263;5408.432114627947;5431.131019036935;5441.945580544183;5457.508824205841;5797.681127537984;5832.387599302055;5858.355580886099;5862.853428664275;5873.412658734135;5886.499647529965;5886.764529418818;5887.264091988502;5919.112133180014;5959.463648271676;5502.98194833953;5525.811950430637;5529.198266251371;5532.6680399176175;5565.109582466826;5708.828735137952;5927.407259274124;5954.7320370582565;5964;6071.878562428727;5779.162021506858;5782.392848750905;5791.420857914175;5806.65160090396;5812.447817457335;5871.882562348729;5879.265091863517;5879.735411906475;5886.8822623547285;5893.970530147321;5677.545796336366;5798.623089499169;5823.650580965155;5861.70691465425;5887.264091988502;5695.202671625976;5719.370869204384;5751;5798.797042103506;5914.645121292736;4418.955810441855;4423.049044455457;4431.0694754102;4438.134563760036;4485.968227307738;3822.961770382316;3937.350337194388;3967.0875698589484;4006.6794656427414;4017.015831121394;5696.743646535916;5710.857228569236;5724;5733.996550603628;5777.653340799566;5760;5952.196453478811;6032.245969253843;6050.6974651267265;6053.092036194518;5568.109102543654;5576.972115139399;5593.468620481048;5605.383407825136;5627.212190293362;5046.646734728533;5053.823116190989;5075.314832497639;5103.8468845934685;5144.254083157921;5811.186433899257;6002.54980876436;6087.939120608826;6098.512119030467;6105.358937311518;5884.47039766423;5920.851978700567;5943.435373639497;5971.5222782177325;5976.731047102804;6077.665728384981;6087.299960504599;6112.419320164578;6121.724522396592;6123.7244324006415;5599.776008959759;5714.79998200061;5731.627444216113;5813.651180928989;5823.912641310469;5887.852803679943;5925.348211696623;5934.821955341346;5938.762449501972;5993.550483713826;5735.168400581976;5778.8266352009505;5791.9131213031;5796.913046304225;5799.9130013049;5604.467575580314;5665.093585026376;5755;5849.736761845642;5891.793787217427;5519.586031047607;5576.605848537865;5589.692566908859;5611.410801865745;5696;5769.336526299361;5788.971055144697;5802.506786923159;5809.128630705428;5815.185873977731;5484.369297530835;5659.745311461076;5683.829485115453;5700.315962084576;5712.485876271156 17:31:44 INFO - PROCESS | 4594 | |1;ext.html;574.752856271803;617.1945610977674;618.366174670962;621.5617989317528;636.7484843486824;42942.355864662015;44002.55997440025;44080.77959610202;44193.55806441935;47255;45436.54563454365;45984.31023534641;46381;46458.53541464584;46637.30044049334;8751.212390884819;8877.511736854503;8931.24084452819;8935.731928042136;8969.955150224272;8695.956520217422;8787.077356877531;8791.032986371494;8814.691485798;8867.822643547126;8876.955615221947;8930.732078037669;8931.55342232889;8944.821103577924;8960.507172105532;8798.47209167452;8900.198982091579;8906.198442140174;8908.331875109392;8913.019567847565;8754;8822.69120580783;8860.822783544358;8874.023857375683;8880.467171969638;42936.57063429357;43838.123237535074;43871.56128438707;43900.56099439029;43954.780226098985;3440.8107554084513;3638.1268495560876;4137.379393091031;4137.40007698882;4225.852095176654;32998.83500582482;33002.6699733002;33507.6649233507;33743.83128084368;34710.82644586786;3997.360422332413;4362.978185109086;4464.553544645542;4482.708623939434;4558.156741002892;352960;354851;356844;357441;359524;57710;57842.132368014514;57915.710421448464;57968.71015644895;58025.70987145037;36221.45667814985;36917.81541092331;36964.63035369666;60334.698326508085;60551;16866;17004.744928826076;17055.403060892808;17164.570885727706;17233.310667573158;11725.706857328634;11767.88232117685;11767.941160294144;11779.234349767237;11804.76390472203;20034;20187.39437816868;20341.694874576893;20353;20533.58932821335;7128.6435678215885;7147.106611673541;7255.310745479171;7256.7097316106765;7370.373518251009;967.1295833749682;1085.8696956365286;1091.6506717850211;1104.1072390337367;1144.2676686920377;32479.675203248138;32540.349193016005;33224.416534858894;33461.3307733844;33729;1098.1489345756943;1141.9200655954169;1145.6391236760394;1166.0729719872722;1211.1340391620033;16714.247858846382;17147.571310717332;17367.3053077878;17481.038542880262;18260.543486412946;510130;511810.0866469656;512455;518481;518599;59583.70208148932;60045;60337.69831150816;60658.39341606616;60764.69617651883;1385.8129152564275;1388.2503448138095;1402.1306789790192;1407.4018542119559;1410.9981912841793;31256.843715781277;33488.66511334856;33518.83240583781;33548;33581;51713;52751;52966;53028.73485632547;53236;482307;488848;492889;493889;495563;28340.433191335644;28541;28750.568741468476;28790.712092878803;28822.42355152927;48351.75824120857;48685;48816.511834881196;49878.75060624674;49994.25008624946;40110;42210.36684449674;42608;43072.35391469068;43230.351544726225;41331.586684133974;41550.376744349465;41750.44763090448;42046.36930445985;42680;35652.46521302131;40474.797626011685;40486;40506.1898762029;41469.170616588104;34767;36740.63259367372;36929.44605830861;37487.6251237495;37498.625013749515;27658.585121222794;28275.293117672223;28776.712232877402;28851.422971540873;28908.7109128906 17:31:44 INFO - PROCESS | 4594 | |2;jquery.html;400.14968192590754;402.20363679913754;405.11280296151426;407.3482428115016;413.33168132821214;18096.72854907176;19411.902940485277;19450.51373715658;19592.510187245327;19605.11776970038;18060.81939180608;18782.906085469553;18802.623947521042;19538.41384758456;19570.31503897364;5558.221848941152;5687.687177205252;5692.402297758737;5697.344805347397;5704.971475142639;5544.77820887164;5661;5670.659760414388;5679.2049113123985;5690.374058853523;5472;5569.66582005079;5638.859028524299;5644.435556444343;5646.943530564703;5600.327960644729;5640.464155905182;5669.376368599472;5674.829755107354;5687.118496633007;5076.416212135615;5409.9459005409835;5413.864653383657;5417.377001644822;5465.152901300305;13644.249566273851;13957.511487098005;17282.827171728248;23221.419464513354;23391.532169356688;2292.6102562564406;2382.6187809950497;2563.910263140781;2657.6545049143683;2777.3056735816044;9928.45393503357;10425.322354046963;13570.728585428236;13707.657308567266;13826.23955682437;1783.4649605118543;1838.8528917686688;1892.3660573707825;1892.5552495163627;1898.7816401113773;77184.61407692982;77706.6114669423;78285.60857195735;79377.60311198464;79498.60250698768;10925.617603383844;11089.500972456259;11161.330320180816;11301.604443844426;11500;15663;15828;15841;15847.841521584636;15899.125548094966;8190.344772418312;8311.002679678477;8454.915450845412;8563.314934805201;8573.699920502753;7875.173106823816;7913.9604301978125;7990.881276621278;8078.151794061657;8079.394045446615;4755.096531658974;4816.735079570587;4892.363992680928;4897.877553061131;4922.581580565692;1986.652490553422;2000.3198912369865;2016.5765189310116;2018.3339497965635;2048.9692654610194;819.7049062337554;962.1418113365315;973.0707174648194;976.8241716490958;980.4901451245313;18297.908510457364;19413.4175974721;19592.608147837247;19612.654543287;19803.900980495004;980.6077568972468;1039.5218199628105;1043.2540733375672;1070.3043022035583;1116.625930313338;10649.84025239622;11234.988851003449;11235.887641123647;11257.662270131908;11319.434028298552;517634;520587;521910;536888;537735;66109.66945165243;106709;108070.45964770125;108520.91479085266;110137.44931275453;1008.0725732326277;1038.2576457832686;1047.7485403503256;1058.1217589400778;1058.4760543531002;17850.375236866646;17955.281788728826;18012.729809053137;18373.265069397075;18567;42659.57340426556;42755;43216.78391608022;43484.34773478337;44224.33663495114;56836.715816420656;60327.69836150791;61432.692836535534;62017.37982620297;66910.33089669042;8278.668853245803;8698.739037828875;8793.252573531066;8803.163699448542;8958.283337333129;10081;13207.273599952096;13400.195988240737;13593.59219223425;13826.377812998238;11450.541978320774;11588.594399195988;11938.880611193777;11941.626712928124;12041.698957526132;11896.643100706993;11900.642980710592;11971.16201865861;11998;12161.635150945485;11448.599299024494;11735.647930562096;11778.057755379721;11785.528578856749;12012;8605.784855378415;8714.520701361233;8790.208881200722;8795.828128407957;8930.910690893008;11177.273477223955;11205.991460768244;11275.210735248455;11376.829347559627;11442.82835757481 17:31:44 INFO - PROCESS | 4594 | |3;mootools.html;1472.9558113256599;1490.1059364381372;1627.7721119043335;1717.6908156531836;1765.3556451895054;8065.758027259177;8663.653453861845;8733.519656418894;9353.532323383837;9364.719058428249;8856.070112638161;9147.771305717344;9185.035571265005;9243.491607961576;9254.120858518447;2353.564590550745;2389.6176611742126;2391.641253811925;2393.270052633946;2394.2338451695464;2361.197192954395;2389.6176611742126;2411.746766589509;2422.2248880358293;2432.817538684597;2366.7633236676365;2378.4648454097864;2394.5570069537193;2417;2433.6227884677814;2333.265021518225;2345.542619189259;2350.835441519103;2357.2456813819585;2397.1250493569723;2287.5081857400573;2292.1862738727677;2292.415434064303;2296.2307626944994;2304.4699719064542;9015.27877769777;9051.23064539515;9068.909310906873;9082.909170908273;9131.680391186277;5324.787008519655;5424.294841670558;5425.3489581250105;5451.2640793492765;5465.125579907235;3416.26550291686;3482.7387945903906;3514.947275790865;3517.6306487818924;3548.769329993542;1176.7764124816258;1195.7548702515962;1198.6104516032324;1228.729679470515;1244.8630650628425;12937.48250069996;12969;12993.740125197537;13065.934670326682;13089.934550327283;4617.607503362252;4778.402699662543;4833.540813622701;4843.4430040545785;4844.539768721966;10927;10938.289011214245;10938.906109388998;10952.123830093573;11001.22991390611;5421.756020979065;5449.427810079964;5462.562994960394;5471.8084867029465;5472.124460086447;4279.807408666617;4748.525147485224;4754.9286760698615;4911.091448082117;4911.508849115131;3908.296506628777;4000.2599519089063;4039.818208180639;4056.1684854604737;4174.853880114181;1250.3810613746255;1272.4274076665351;1275.7639836630253;1285.1774864086992;1291.199456337077;916.706653870755;1025.1337619711333;1029.583018877356;1043.608646757466;1044.4151275285712;6148.231471066117;6193.504519638418;6229.53278504114;6238.344973777779;6309.116723658692;450.4122120632606;453.510208974307;453.8048639085225;462.83800669765986;464.4241140985222;4282.357646353072;4287.957120428819;4295.248331541968;4313.956860431418;4334.544872788312;11286.54853805855;11604.477798499087;11627.418629068512;11627.6511704649;11739.589114380955;10250.282480226462;10564;11496.94251528737;11585.826212606818;11610.709732256591;8430.662773489114;8536.70121545743;8566.700165494303;8622.223999840044;8675.91324086751;5782.421757824352;6027.78902738402;6072.362401947732;6087.604305720114;6183.196184495987;9847;9983.450910199717;10016.098551130433;10031.598736050768;10038.548265328223;10264.178865690876;10324.328918620266;10347.327423717434;10380.32527885685;10380.429076400871;7366.4106871449085;7702.383809295131;7892.36861051126;8052.8792068117855;8092.312153467021;9021.594028268612;9089.681861134828;9117.863232051392;9145.5884485197;9150.63397464094;7792.493487923267;8057.556834374166;8069.757907262791;8119.5534245617055;8175.1416101308505;7867.606619668879;7934.166912474338;7992.200779921961;8032.919670803451;8062.879056814035;6795.830104247433;6823.38589526945;6888.242293347627;6912.412444942236;7067.328603782633;5286.233496142961;5287.444818294024;5325.414204437431;5331.680099194061;5353.598480114085;5130.923036154535;5213.113770658922;5214.2960700304975;5259.105951988095;5326.3874654413685 17:31:44 INFO - PROCESS | 4594 | |4;prototype.html;325.6434204546023;338.02311320284383;339.743493662285;340.4008944258106;345.3679766028169;5499.340079190502;5571.8607034824045;5607.355154157273;5614.242077319565;5724.883647688697;5597.916031259534;5611.494965453108;5632.901584191084;5639.577031722617;5652.915206271899;4282.743035417885;4312.22379971605;4327.480702315726;4357.281048626973;4357.433533640622;4097.344424892018;4317.84107946027;4344.4786625604975;4370.2570563004365;4399.802008909591;4288.914221715564;4290.978545107286;4297.742135471866;4336.241157797373;4346.6088052075465;4295.420118284054;4334.739915605058;4341.913161736779;4361.869143925655;4378.846740364103;3774.962250377516;3788.6211378862167;3817.9691483299353;3840.347140986039;3858.7105967052303;5387.81142660005;5389.51494365509;5415.241866138744;5426.647267927572;5476.972615136939;4934.777934992934;4948.282499037619;4969.7515124244;4971.602271818246;4974.502549744997;5624.3531993820825;5822.922759289502;5848.824535263949;5885;5891.558133139989;4140.991619064751;4156.875293741193;4157.688173386978;4158.625723684883;4182.602652747984;6153.815385538441;6194.38056194377;6202.96898515509;6205.968970155121;6225.87548249037;4142.813573389205;4255.5957184067465;4287.678424118204;4293.608049640811;4312.223799716081;4304.526502084768;4325.545817689097;4329.848455304049;4340.088581397878;4364.476262848479;4953.356063711694;4973.577245934136;4979.253112033151;4999.75001249936;5020.573251273682;5749.655020698771;5907.675077870758;5945.137954996501;5948.405159484104;5950.274420418117;1494.8355680875095;1501.3844323827398;1503.2183264702512;1505.6235941014747;1517.1731406383547;921.203159267229;955.2405837359316;961.6489981156827;962.6823148361024;971.9125278724948;5094.363204599425;5115.411727651293;5131.7163862081015;5141.305923700253;5189.870253243699;5169.707573106723;5435.755391007414;5439.972800135974;5475.808346707846;5477.794885125266;4952.851414457572;5083.7203953782155;5091.719955402415;5142.742862856842;5213.3222681051975;2825.265430987958;2845.2886778305424;2855.343271047629;2855.8572071396347;2949.9262518437213;5521.73000209954;5526.171074338801;5528.710417301699;5535.782127931849;5556.499915007668;5313.54834839043;5370.570354371719;5454.7818087276855;5488;5564.4713752193475;5499.477549632778;5523.944760552424;5535.944640553624;5539.335279766373;5557.110862262019;5127.282180494808;5288.074586947192;5294.2852714883;5403.756830942539;5407.270018547446;5259.368875734784;5343.812966546152;5351.518363347317;5356.973215133899;5358.6248962572245;5508.55931525485;5544.695041772741;5559.555235581063;5644.915326270191;6051.335882632311;4221.261279276176;4291;4305.70828751367;4316.9136617268105;4323.329883868006;5994.280686317496;6019.909701354396;6023.3073196582955;6031.341381120227;6081.179040829608;5704.743286552032;5856.736446859816;5889.911651325319;5905.350411454822;5931.9110213345975;5742.7702891883855;5764.616492041963;5785.566082543742;5855.824325270249;5864;5677.460641239076;5692.914606280992;5810.854728631818;5831.8833623326445;5836.824895253149;5628.85927851807;5937.435943585352;5975.8328086114425;6057;6069.692017850371;5749.367569567428;5776.826695199151;5812.82561523155;5816.389279125631;5816.970915145397 17:31:44 INFO - PROCESS | 4594 | |5;yui.html;756.1908757629338;787.7715462515871;798.56079156464;815.7152484836383;850.485456298939;14618.853811461882;15905.522834314974;16187.595310117253;16233.594160146002;16242.83757162428;14890.925545372285;14910.329035193416;14949;14977.176255305954;14984.400623975056;808.5957021489255;827.8220182660726;832.8042909916165;832.9588014981273;834.6202477872554;683.040328338685;797.9840403191932;823.279630323467;826.2233500509532;826.2687521543418;861.2076889261895;863.3438586674141;863.8920134983127;865.4331412924545;866.6360128745911;855.8373908957278;858.5535521528801;860.7460799064291;862.5256109139948;863.6329559937064;629.3234772619452;631.7567736421465;632.1623848400841;633.0946746152999;633.2084893882646;14579.927100364537;14697.33861976203;14700.264986750726;14705.632359190999;14721.411143554245;14938.477153299691;14964.700705985928;14982.925085374613;15204;15643.296051677702;12042;12100.939495302555;12133.090018248668;12230.266184028987;12306.81539776904;3878.2437424702193;4072.1652061327654;4129;4137.627613514768;4153.480814898137;73097.63451182764;74040.62979685067;75980.24019759787;75994.24005759927;76115.61942190309;11708.648740537797;11943.283402995849;11954.706509080928;12153;12319.445624946899;23122.768772312396;23156.3053108407;23158.76841231566;23166;23174.884125579265;8550.1449855014;8799.111522812082;8852.336074794417;8881.955590222007;8981.685641002534;4792.472827988919;4877.195262781602;4897.216445368796;4995.475475075064;5227.921581176285;3586.5337506124038;3682.0794801299676;3700.2784457031157;3707.647773461517;3720.813959302024;595.1727099331932;632.5603705424686;633.5311869216838;635.1140159477503;635.7520566978882;662.9303923088006;744.0847757258495;750.5421692767408;757.6704133701858;781.4959351218432;9909.256805739598;10106.595736170471;10327.657404537362;10452.16382689383;10561.524731387106;611.7858749437661;721.8989341492195;758.0789340950771;760.9657565409569;766.7469734987441;4476.127155204769;4653.7207767534055;4745.288206768943;4754.8853608494355;4921.212605983025;66745.6662716693;70693.64653176701;70800.2919970804;112749.2888175622;116202;60906.39093609007;81278.59360703158;92609.53695231481;96586;100699;62220.68889655613;86562.56718716492;87885;87996.5600171995;89392;8530.189631984951;8772.517511536671;8790.604422800861;8829.823403532022;9031.942601111781;52398.21402678887;52795.47204527906;53761.19358209552;54931;55982.44017559772;71647;76847;77411.22588774265;77994;78337.60831195807;12418.937905310415;12750.553730619384;12880.935595322338;12902.612921612366;12977.026722995624;13072.215667060007;13726;13743.587692369245;13923.930380348034;14514.491992780202;11918.523259069887;12704.872951270369;13005.804912926504;13078.346082696018;13546.296618901;11426.714332141762;11668.94165529167;12477.5008999639;12812.61562153137;12971.156874803484;11411.885881141083;11846.289222646668;11916.76166476683;11969.16215864916;12256.448459819152;9123.31575131881;9392.95303523478;9504.14043727798;9591.376560523544;9623.422594644344;9313.39664177067;9689.951550242486;9771.02878041033;9901.05898196601;9955.651552195639 17:31:44 INFO - PROCESS | 4594 | __end_tp_report 17:31:44 INFO - PROCESS | 4594 | __start_cc_report 17:31:44 INFO - PROCESS | 4594 | _x_x_mozilla_cycle_collect,345 17:31:44 INFO - PROCESS | 4594 | __end_cc_report 17:31:44 INFO - PROCESS | 4594 | __startTimestamp1465173104330__endTimestamp 17:31:44 INFO - PROCESS | 4594 | 17:31:44 INFO - PROCESS | 4594 | ------- Summary: start ------- 17:31:44 INFO - PROCESS | 4594 | Number of tests: 6 17:31:44 INFO - PROCESS | 4594 | 17:31:44 INFO - PROCESS | 4594 | [#0] dojo.html Cycles:165 Average:5422.31 Median:5696.74 stddev:735.38 (12.9%) stddev-sans-first:714.29 17:31:44 INFO - PROCESS | 4594 | Values: 3078.9 3115.9 3126.0 3142.6 3160.5 5389.4 5417.2 5435.3 5486.6 5508.8 5310.5 5425.5 5510.9 5513.9 5528.3 4920.8 4954.0 5057.7 5091.4 5136.2 733.0 4989.1 5000.0 5005.4 5022.1 4906.5 4922.7 4947.2 4956.6 4978.0 4827.2 4935.7 4941.0 4962.5 5000.2 4851.1 4854.4 4875.1 4901.1 4923.2 5330.0 5408.4 5431.1 5441.9 5457.5 5797.7 5832.4 5858.4 5862.9 5873.4 5886.5 5886.8 5887.3 5919.1 5959.5 5503.0 5525.8 5529.2 5532.7 5565.1 5708.8 5927.4 5954.7 5964.0 6071.9 5779.2 5782.4 5791.4 5806.7 5812.4 5871.9 5879.3 5879.7 5886.9 5894.0 5677.5 5798.6 5823.7 5861.7 5887.3 5695.2 5719.4 5751.0 5798.8 5914.6 4419.0 4423.0 4431.1 4438.1 4486.0 3823.0 3937.4 3967.1 4006.7 4017.0 5696.7 5710.9 5724.0 5734.0 5777.7 5760.0 5952.2 6032.2 6050.7 6053.1 5568.1 5577.0 5593.5 5605.4 5627.2 5046.6 5053.8 5075.3 5103.8 5144.3 5811.2 6002.5 6087.9 6098.5 6105.4 5884.5 5920.9 5943.4 5971.5 5976.7 6077.7 6087.3 6112.4 6121.7 6123.7 5599.8 5714.8 5731.6 5813.7 5823.9 5887.9 5925.3 5934.8 5938.8 5993.6 5735.2 5778.8 5791.9 5796.9 5799.9 5604.5 5665.1 5755.0 5849.7 5891.8 5519.6 5576.6 5589.7 5611.4 5696.0 5769.3 5789.0 5802.5 5809.1 5815.2 5484.4 5659.7 5683.8 5700.3 5712.5 17:31:44 INFO - PROCESS | 4594 | 17:31:44 INFO - PROCESS | 4594 | [#1] ext.html Cycles:180 Average:61388.52 Median:42808.29 stddev:121690.82 (284.3%) stddev-sans-first:121946.53 17:31:44 INFO - PROCESS | 4594 | Values: 574.8 617.2 618.4 621.6 636.7 42942.4 44002.6 44080.8 44193.6 47255.0 45436.5 45984.3 46381.0 46458.5 46637.3 8751.2 8877.5 8931.2 8935.7 8970.0 8696.0 8787.1 8791.0 8814.7 8867.8 8877.0 8930.7 8931.6 8944.8 8960.5 8798.5 8900.2 8906.2 8908.3 8913.0 8754.0 8822.7 8860.8 8874.0 8880.5 42936.6 43838.1 43871.6 43900.6 43954.8 3440.8 3638.1 4137.4 4137.4 4225.9 32998.8 33002.7 33507.7 33743.8 34710.8 3997.4 4363.0 4464.6 4482.7 4558.2 352960.0 354851.0 356844.0 357441.0 359524.0 57710.0 57842.1 57915.7 57968.7 58025.7 36221.5 36917.8 36964.6 60334.7 60551.0 16866.0 17004.7 17055.4 17164.6 17233.3 11725.7 11767.9 11767.9 11779.2 11804.8 20034.0 20187.4 20341.7 20353.0 20533.6 7128.6 7147.1 7255.3 7256.7 7370.4 967.1 1085.9 1091.7 1104.1 1144.3 32479.7 32540.3 33224.4 33461.3 33729.0 1098.1 1141.9 1145.6 1166.1 1211.1 16714.2 17147.6 17367.3 17481.0 18260.5 510130.0 511810.1 512455.0 518481.0 518599.0 59583.7 60045.0 60337.7 60658.4 60764.7 1385.8 1388.3 1402.1 1407.4 1411.0 31256.8 33488.7 33518.8 33548.0 33581.0 51713.0 52751.0 52966.0 53028.7 53236.0 482307.0 488848.0 492889.0 493889.0 495563.0 28340.4 28541.0 28750.6 28790.7 28822.4 48351.8 48685.0 48816.5 49878.8 49994.3 40110.0 42210.4 42608.0 43072.4 43230.4 41331.6 41550.4 41750.4 42046.4 42680.0 35652.5 40474.8 40486.0 40506.2 41469.2 34767.0 36740.6 36929.4 37487.6 37498.6 27658.6 28275.3 28776.7 28851.4 28908.7 17:31:44 INFO - PROCESS | 4594 | 17:31:44 INFO - PROCESS | 4594 | [#2] jquery.html Cycles:180 Average:30295.04 Median:12757.01 stddev:86913.82 (681.3%) stddev-sans-first:87128.65 17:31:44 INFO - PROCESS | 4594 | Values: 400.1 402.2 405.1 407.3 413.3 18096.7 19411.9 19450.5 19592.5 19605.1 18060.8 18782.9 18802.6 19538.4 19570.3 5558.2 5687.7 5692.4 5697.3 5705.0 5544.8 5661.0 5670.7 5679.2 5690.4 5472.0 5569.7 5638.9 5644.4 5646.9 5600.3 5640.5 5669.4 5674.8 5687.1 5076.4 5409.9 5413.9 5417.4 5465.2 13644.2 13957.5 17282.8 23221.4 23391.5 2292.6 2382.6 2563.9 2657.7 2777.3 9928.5 10425.3 13570.7 13707.7 13826.2 1783.5 1838.9 1892.4 1892.6 1898.8 77184.6 77706.6 78285.6 79377.6 79498.6 10925.6 11089.5 11161.3 11301.6 11500.0 15663.0 15828.0 15841.0 15847.8 15899.1 8190.3 8311.0 8454.9 8563.3 8573.7 7875.2 7914.0 7990.9 8078.2 8079.4 4755.1 4816.7 4892.4 4897.9 4922.6 1986.7 2000.3 2016.6 2018.3 2049.0 819.7 962.1 973.1 976.8 980.5 18297.9 19413.4 19592.6 19612.7 19803.9 980.6 1039.5 1043.3 1070.3 1116.6 10649.8 11235.0 11235.9 11257.7 11319.4 517634.0 520587.0 521910.0 536888.0 537735.0 66109.7 106709.0 108070.5 108520.9 110137.4 1008.1 1038.3 1047.7 1058.1 1058.5 17850.4 17955.3 18012.7 18373.3 18567.0 42659.6 42755.0 43216.8 43484.3 44224.3 56836.7 60327.7 61432.7 62017.4 66910.3 8278.7 8698.7 8793.3 8803.2 8958.3 10081.0 13207.3 13400.2 13593.6 13826.4 11450.5 11588.6 11938.9 11941.6 12041.7 11896.6 11900.6 11971.2 11998.0 12161.6 11448.6 11735.6 11778.1 11785.5 12012.0 8605.8 8714.5 8790.2 8795.8 8930.9 11177.3 11206.0 11275.2 11376.8 11442.8 17:31:44 INFO - PROCESS | 4594 | 17:31:44 INFO - PROCESS | 4594 | [#3] mootools.html Cycles:180 Average:5967.69 Median:2535.71 stddev:3449.71 (136.0%) stddev-sans-first:3442.85 17:31:44 INFO - PROCESS | 4594 | Values: 1473.0 1490.1 1627.8 1717.7 1765.4 8065.8 8663.7 8733.5 9353.5 9364.7 8856.1 9147.8 9185.0 9243.5 9254.1 2353.6 2389.6 2391.6 2393.3 2394.2 2361.2 2389.6 2411.7 2422.2 2432.8 2366.8 2378.5 2394.6 2417.0 2433.6 2333.3 2345.5 2350.8 2357.2 2397.1 2287.5 2292.2 2292.4 2296.2 2304.5 9015.3 9051.2 9068.9 9082.9 9131.7 5324.8 5424.3 5425.3 5451.3 5465.1 3416.3 3482.7 3514.9 3517.6 3548.8 1176.8 1195.8 1198.6 1228.7 1244.9 12937.5 12969.0 12993.7 13065.9 13089.9 4617.6 4778.4 4833.5 4843.4 4844.5 10927.0 10938.3 10938.9 10952.1 11001.2 5421.8 5449.4 5462.6 5471.8 5472.1 4279.8 4748.5 4754.9 4911.1 4911.5 3908.3 4000.3 4039.8 4056.2 4174.9 1250.4 1272.4 1275.8 1285.2 1291.2 916.7 1025.1 1029.6 1043.6 1044.4 6148.2 6193.5 6229.5 6238.3 6309.1 450.4 453.5 453.8 462.8 464.4 4282.4 4288.0 4295.2 4314.0 4334.5 11286.5 11604.5 11627.4 11627.7 11739.6 10250.3 10564.0 11496.9 11585.8 11610.7 8430.7 8536.7 8566.7 8622.2 8675.9 5782.4 6027.8 6072.4 6087.6 6183.2 9847.0 9983.5 10016.1 10031.6 10038.5 10264.2 10324.3 10347.3 10380.3 10380.4 7366.4 7702.4 7892.4 8052.9 8092.3 9021.6 9089.7 9117.9 9145.6 9150.6 7792.5 8057.6 8069.8 8119.6 8175.1 7867.6 7934.2 7992.2 8032.9 8062.9 6795.8 6823.4 6888.2 6912.4 7067.3 5286.2 5287.4 5325.4 5331.7 5353.6 5130.9 5213.1 5214.3 5259.1 5326.4 17:31:44 INFO - PROCESS | 4594 | 17:31:44 INFO - PROCESS | 4594 | [#4] prototype.html Cycles:180 Average:4776.08 Median:5379.19 stddev:1384.75 (25.7%) stddev-sans-first:1347.74 17:31:44 INFO - PROCESS | 4594 | Values: 325.6 338.0 339.7 340.4 345.4 5499.3 5571.9 5607.4 5614.2 5724.9 5597.9 5611.5 5632.9 5639.6 5652.9 4282.7 4312.2 4327.5 4357.3 4357.4 4097.3 4317.8 4344.5 4370.3 4399.8 4288.9 4291.0 4297.7 4336.2 4346.6 4295.4 4334.7 4341.9 4361.9 4378.8 3775.0 3788.6 3818.0 3840.3 3858.7 5387.8 5389.5 5415.2 5426.6 5477.0 4934.8 4948.3 4969.8 4971.6 4974.5 5624.4 5822.9 5848.8 5885.0 5891.6 4141.0 4156.9 4157.7 4158.6 4182.6 6153.8 6194.4 6203.0 6206.0 6225.9 4142.8 4255.6 4287.7 4293.6 4312.2 4304.5 4325.5 4329.8 4340.1 4364.5 4953.4 4973.6 4979.3 4999.8 5020.6 5749.7 5907.7 5945.1 5948.4 5950.3 1494.8 1501.4 1503.2 1505.6 1517.2 921.2 955.2 961.6 962.7 971.9 5094.4 5115.4 5131.7 5141.3 5189.9 5169.7 5435.8 5440.0 5475.8 5477.8 4952.9 5083.7 5091.7 5142.7 5213.3 2825.3 2845.3 2855.3 2855.9 2949.9 5521.7 5526.2 5528.7 5535.8 5556.5 5313.5 5370.6 5454.8 5488.0 5564.5 5499.5 5523.9 5535.9 5539.3 5557.1 5127.3 5288.1 5294.3 5403.8 5407.3 5259.4 5343.8 5351.5 5357.0 5358.6 5508.6 5544.7 5559.6 5644.9 6051.3 4221.3 4291.0 4305.7 4316.9 4323.3 5994.3 6019.9 6023.3 6031.3 6081.2 5704.7 5856.7 5889.9 5905.4 5931.9 5742.8 5764.6 5785.6 5855.8 5864.0 5677.5 5692.9 5810.9 5831.9 5836.8 5628.9 5937.4 5975.8 6057.0 6069.7 5749.4 5776.8 5812.8 5816.4 5817.0 17:31:44 INFO - PROCESS | 4594 | 17:31:44 INFO - PROCESS | 4594 | [#5] yui.html Cycles:180 Average:19583.20 Median:55456.72 stddev:27182.35 (49.0%) stddev-sans-first:27221.84 17:31:44 INFO - PROCESS | 4594 | Values: 756.2 787.8 798.6 815.7 850.5 14618.9 15905.5 16187.6 16233.6 16242.8 14890.9 14910.3 14949.0 14977.2 14984.4 808.6 827.8 832.8 833.0 834.6 683.0 798.0 823.3 826.2 826.3 861.2 863.3 863.9 865.4 866.6 855.8 858.6 860.7 862.5 863.6 629.3 631.8 632.2 633.1 633.2 14579.9 14697.3 14700.3 14705.6 14721.4 14938.5 14964.7 14982.9 15204.0 15643.3 12042.0 12100.9 12133.1 12230.3 12306.8 3878.2 4072.2 4129.0 4137.6 4153.5 73097.6 74040.6 75980.2 75994.2 76115.6 11708.6 11943.3 11954.7 12153.0 12319.4 23122.8 23156.3 23158.8 23166.0 23174.9 8550.1 8799.1 8852.3 8882.0 8981.7 4792.5 4877.2 4897.2 4995.5 5227.9 3586.5 3682.1 3700.3 3707.6 3720.8 595.2 632.6 633.5 635.1 635.8 662.9 744.1 750.5 757.7 781.5 9909.3 10106.6 10327.7 10452.2 10561.5 611.8 721.9 758.1 761.0 766.7 4476.1 4653.7 4745.3 4754.9 4921.2 66745.7 70693.6 70800.3 112749.3 116202.0 60906.4 81278.6 92609.5 96586.0 100699.0 62220.7 86562.6 87885.0 87996.6 89392.0 8530.2 8772.5 8790.6 8829.8 9031.9 52398.2 52795.5 53761.2 54931.0 55982.4 71647.0 76847.0 77411.2 77994.0 78337.6 12418.9 12750.6 12880.9 12902.6 12977.0 13072.2 13726.0 13743.6 13923.9 14514.5 11918.5 12704.9 13005.8 13078.3 13546.3 11426.7 11668.9 12477.5 12812.6 12971.2 11411.9 11846.3 11916.8 11969.2 12256.4 9123.3 9393.0 9504.1 9591.4 9623.4 9313.4 9690.0 9771.0 9901.1 9955.7 17:31:44 INFO - PROCESS | 4594 | -------- Summary: end -------- 17:31:44 INFO - PROCESS | 4594 | 17:31:45 INFO - TEST-INFO | 4594: exit 0 17:31:45 INFO - TEST-OK | dromaeo_css | took 1110919ms 17:31:45 INFO - TEST-START | kraken 17:31:45 INFO - operating with platform_type : linux_ 17:31:45 INFO - Initialising browser for kraken test... 17:31:45 INFO - TEST-INFO | started process 4828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpytA_hw/profile http://localhost:34054/getInfo.html) 17:31:49 INFO - PROCESS | 4828 | __metrics Screen width/height:1600/1200 17:31:49 INFO - PROCESS | 4828 | colorDepth:24 17:31:49 INFO - PROCESS | 4828 | Browser inner width/height: 1024/697 17:31:49 INFO - PROCESS | 4828 | __metrics 17:31:50 ERROR - PROCESS | 4828 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 17:31:51 INFO - TEST-INFO | 4828: exit 0 17:31:51 INFO - Browser initialized. 17:31:51 INFO - Running cycle 1/1 for kraken test... 17:31:51 INFO - TEST-INFO | started process 4947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpytA_hw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:03 INFO - PROCESS | 4947 | RSS: Main: 167260160 17:32:03 INFO - PROCESS | 4947 | 17:32:05 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34054/tests/kraken/driver.html?testName=audio-beat-detection) 17:32:06 INFO - PROCESS | 4947 | RSS: Main: 172933120 17:32:06 INFO - PROCESS | 4947 | 17:32:09 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34054/tests/kraken/driver.html?testName=audio-dft) 17:32:09 INFO - PROCESS | 4947 | RSS: Main: 172093440 17:32:09 INFO - PROCESS | 4947 | 17:32:12 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34054/tests/kraken/driver.html?testName=audio-fft) 17:32:13 INFO - PROCESS | 4947 | RSS: Main: 167051264 17:32:13 INFO - PROCESS | 4947 | 17:32:15 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34054/tests/kraken/driver.html?testName=audio-oscillator) 17:32:16 INFO - PROCESS | 4947 | RSS: Main: 167886848 17:32:16 INFO - PROCESS | 4947 | 17:32:18 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34054/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:32:19 INFO - PROCESS | 4947 | RSS: Main: 168136704 17:32:19 INFO - PROCESS | 4947 | 17:32:22 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34054/tests/kraken/driver.html?testName=imaging-darkroom) 17:32:22 INFO - PROCESS | 4947 | RSS: Main: 168235008 17:32:22 INFO - PROCESS | 4947 | 17:32:26 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34054/tests/kraken/driver.html?testName=imaging-desaturate) 17:32:27 INFO - PROCESS | 4947 | RSS: Main: 168648704 17:32:27 INFO - PROCESS | 4947 | 17:32:29 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34054/tests/kraken/driver.html?testName=json-parse-financial) 17:32:30 INFO - PROCESS | 4947 | RSS: Main: 168435712 17:32:30 INFO - PROCESS | 4947 | 17:32:32 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34054/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:32:32 INFO - PROCESS | 4947 | RSS: Main: 168398848 17:32:32 INFO - PROCESS | 4947 | 17:32:34 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34054/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:35 INFO - PROCESS | 4947 | RSS: Main: 168783872 17:32:35 INFO - PROCESS | 4947 | 17:32:37 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34054/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:37 INFO - PROCESS | 4947 | RSS: Main: 169115648 17:32:37 INFO - PROCESS | 4947 | 17:32:40 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:32:41 INFO - PROCESS | 4947 | RSS: Main: 169189376 17:32:41 INFO - PROCESS | 4947 | 17:32:43 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:44 INFO - PROCESS | 4947 | RSS: Main: 169377792 17:32:44 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | Cycle 1(1): loaded http://localhost:34054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34054/tests/kraken/driver.html?testName=ai-astar) 17:32:46 INFO - PROCESS | 4947 | RSS: Main: 169730048 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | __start_tp_report 17:32:46 INFO - PROCESS | 4947 | _x_x_mozilla_page_load 17:32:46 INFO - PROCESS | 4947 | _x_x_mozilla_page_load_details 17:32:46 INFO - PROCESS | 4947 | |i|pagename|runs| 17:32:46 INFO - PROCESS | 4947 | |0;ai-astar;111;107;113;112;115;112;111;111;112;112 17:32:46 INFO - PROCESS | 4947 | |1;audio-beat-detection;156;125;154;190;128;149;166;133;184;135 17:32:46 INFO - PROCESS | 4947 | |2;audio-dft;164;162;163;164;163;176;163;164;162;163 17:32:46 INFO - PROCESS | 4947 | |3;audio-fft;73;76;76;162;75;78;75;74;170;75 17:32:46 INFO - PROCESS | 4947 | |4;audio-oscillator;85;86;145;85;85;86;152;86;85;139 17:32:46 INFO - PROCESS | 4947 | |5;imaging-gaussian-blur;117;119;117;118;117;118;117;117;118;117 17:32:46 INFO - PROCESS | 4947 | |6;imaging-darkroom;148;148;148;147;147;147;148;146;147;147 17:32:46 INFO - PROCESS | 4947 | |7;imaging-desaturate;96;96;95;95;96;96;97;96;96;96 17:32:46 INFO - PROCESS | 4947 | |8;json-parse-financial;55;58;58;53;54;57;56;60;54;54 17:32:46 INFO - PROCESS | 4947 | |9;json-stringify-tinderbox;62;62;67;61;62;62;61;61;62;62 17:32:46 INFO - PROCESS | 4947 | |10;stanford-crypto-aes;79;80;80;79;80;80;82;79;106;95 17:32:46 INFO - PROCESS | 4947 | |11;stanford-crypto-ccm;130;137;137;121;121;130;135;140;129;123 17:32:46 INFO - PROCESS | 4947 | |12;stanford-crypto-pbkdf2;160;158;161;164;159;158;162;159;161;164 17:32:46 INFO - PROCESS | 4947 | |13;stanford-crypto-sha256-iterative;69;63;63;63;62;64;66;65;62;61 17:32:46 INFO - PROCESS | 4947 | __end_tp_report 17:32:46 INFO - PROCESS | 4947 | __start_cc_report 17:32:46 INFO - PROCESS | 4947 | _x_x_mozilla_cycle_collect,944 17:32:46 INFO - PROCESS | 4947 | __end_cc_report 17:32:46 INFO - PROCESS | 4947 | __startTimestamp1465173166277__endTimestamp 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | ------- Summary: start ------- 17:32:46 INFO - PROCESS | 4947 | Number of tests: 14 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:2.01 (1.8%) stddev-sans-first:2.12 17:32:46 INFO - PROCESS | 4947 | Values: 111.0 107.0 113.0 112.0 115.0 112.0 111.0 111.0 112.0 112.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:155.00 stddev:22.73 (14.7%) stddev-sans-first:24.06 17:32:46 INFO - PROCESS | 4947 | Values: 156.0 125.0 154.0 190.0 128.0 149.0 166.0 133.0 184.0 135.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:4.14 (2.5%) stddev-sans-first:4.39 17:32:46 INFO - PROCESS | 4947 | Values: 164.0 162.0 163.0 164.0 163.0 176.0 163.0 164.0 162.0 163.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:38.33 (51.1%) stddev-sans-first:39.94 17:32:46 INFO - PROCESS | 4947 | Values: 73.0 76.0 76.0 162.0 75.0 78.0 75.0 74.0 170.0 75.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:85.00 stddev:29.10 (34.2%) stddev-sans-first:30.10 17:32:46 INFO - PROCESS | 4947 | Values: 85.0 86.0 145.0 85.0 85.0 86.0 152.0 86.0 85.0 139.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 17:32:46 INFO - PROCESS | 4947 | Values: 117.0 119.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 17:32:46 INFO - PROCESS | 4947 | Values: 148.0 148.0 148.0 147.0 147.0 147.0 148.0 146.0 147.0 147.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:32:46 INFO - PROCESS | 4947 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.50 stddev:2.28 (4.0%) stddev-sans-first:2.40 17:32:46 INFO - PROCESS | 4947 | Values: 55.0 58.0 58.0 53.0 54.0 57.0 56.0 60.0 54.0 54.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:1.75 (2.8%) stddev-sans-first:1.86 17:32:46 INFO - PROCESS | 4947 | Values: 62.0 62.0 67.0 61.0 62.0 62.0 61.0 61.0 62.0 62.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:80.00 stddev:9.12 (11.4%) stddev-sans-first:9.49 17:32:46 INFO - PROCESS | 4947 | Values: 79.0 80.0 80.0 79.0 80.0 80.0 82.0 79.0 106.0 95.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:132.50 stddev:6.95 (5.2%) stddev-sans-first:7.37 17:32:46 INFO - PROCESS | 4947 | Values: 130.0 137.0 137.0 121.0 121.0 130.0 135.0 140.0 129.0 123.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.00 stddev:2.22 (1.4%) stddev-sans-first:2.35 17:32:46 INFO - PROCESS | 4947 | Values: 160.0 158.0 161.0 164.0 159.0 158.0 162.0 159.0 161.0 164.0 17:32:46 INFO - PROCESS | 4947 | 17:32:46 INFO - PROCESS | 4947 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:2.35 (3.7%) stddev-sans-first:1.56 17:32:46 INFO - PROCESS | 4947 | Values: 69.0 63.0 63.0 63.0 62.0 64.0 66.0 65.0 62.0 61.0 17:32:46 INFO - PROCESS | 4947 | -------- Summary: end -------- 17:32:46 INFO - PROCESS | 4947 | 17:32:47 INFO - TEST-INFO | 4947: exit 0 17:32:47 INFO - TEST-OK | kraken | took 62216ms 17:32:47 INFO - SUITE-END | took 1173s 17:32:47 INFO - Completed test suite (00:19:33) 17:32:47 INFO - javascript benchmark 17:32:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7322.962061502522, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.8614512346944, 3115.937681246375, 3125.9843700781494, 3142.5757522734425, 3160.5417214503896, 5389.407165211834, 5417.214503896933, 5435.347758269008, 5486.643368181066, 5508.7521061552225, 5310.468953104688, 5425.457454254572, 5510.889782204354, 5513.917291240635, 5528.281323427958, 4920.827771028024, 4953.9504604953845, 5057.671251368668, 5091.363579552556, 5136.229565565158, 732.9645895923124, 4989.052080104787, 4999.975000124994, 5005.399352077756, 5022.096022715909, 4906.484819093997, 4922.729249891255, 4947.183714687072, 4956.553910148086, 4978.029284289583, 4827.155247831615, 4935.728534930578, 4941.0, 4962.4789397113145, 5000.1999680051385, 4851.054044461332, 4854.417469903598, 4875.146849301358, 4901.09329773993, 4923.212286034253, 5329.973350133263, 5408.432114627947, 5431.131019036935, 5441.945580544183, 5457.508824205841, 5797.681127537984, 5832.387599302055, 5858.355580886099, 5862.853428664275, 5873.412658734135, 5886.499647529965, 5886.764529418818, 5887.264091988502, 5919.112133180014, 5959.463648271676, 5502.98194833953, 5525.811950430637, 5529.198266251371, 5532.6680399176175, 5565.109582466826, 5708.828735137952, 5927.407259274124, 5954.7320370582565, 5964.0, 6071.878562428727, 5779.162021506858, 5782.392848750905, 5791.420857914175, 5806.65160090396, 5812.447817457335, 5871.882562348729, 5879.265091863517, 5879.735411906475, 5886.8822623547285, 5893.970530147321, 5677.545796336366, 5798.623089499169, 5823.650580965155, 5861.70691465425, 5887.264091988502, 5695.202671625976, 5719.370869204384, 5751.0, 5798.797042103506, 5914.645121292736, 4418.955810441855, 4423.049044455457, 4431.0694754102, 4438.134563760036, 4485.968227307738, 3822.961770382316, 3937.350337194388, 3967.0875698589484, 4006.6794656427414, 4017.015831121394, 5696.743646535916, 5710.857228569236, 5724.0, 5733.996550603628, 5777.653340799566, 5760.0, 5952.196453478811, 6032.245969253843, 6050.6974651267265, 6053.092036194518, 5568.109102543654, 5576.972115139399, 5593.468620481048, 5605.383407825136, 5627.212190293362, 5046.646734728533, 5053.823116190989, 5075.314832497639, 5103.8468845934685, 5144.254083157921, 5811.186433899257, 6002.54980876436, 6087.939120608826, 6098.512119030467, 6105.358937311518, 5884.47039766423, 5920.851978700567, 5943.435373639497, 5971.5222782177325, 5976.731047102804, 6077.665728384981, 6087.299960504599, 6112.419320164578, 6121.724522396592, 6123.7244324006415, 5599.776008959759, 5714.79998200061, 5731.627444216113, 5813.651180928989, 5823.912641310469, 5887.852803679943, 5925.348211696623, 5934.821955341346, 5938.762449501972, 5993.550483713826, 5735.168400581976, 5778.8266352009505, 5791.9131213031, 5796.913046304225, 5799.9130013049, 5604.467575580314, 5665.093585026376, 5755.0, 5849.736761845642, 5891.793787217427, 5519.586031047607, 5576.605848537865, 5589.692566908859, 5611.410801865745, 5696.0, 5769.336526299361, 5788.971055144697, 5802.506786923159, 5809.128630705428, 5815.185873977731, 5484.369297530835, 5659.745311461076, 5683.829485115453, 5700.315962084576, 5712.485876271156], "value": 5373.037062050656, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.752856271803, 617.1945610977674, 618.366174670962, 621.5617989317528, 636.7484843486824, 42942.355864662015, 44002.55997440025, 44080.77959610202, 44193.55806441935, 47255.0, 45436.54563454365, 45984.31023534641, 46381.0, 46458.53541464584, 46637.30044049334, 8751.212390884819, 8877.511736854503, 8931.24084452819, 8935.731928042136, 8969.955150224272, 8695.956520217422, 8787.077356877531, 8791.032986371494, 8814.691485798, 8867.822643547126, 8876.955615221947, 8930.732078037669, 8931.55342232889, 8944.821103577924, 8960.507172105532, 8798.47209167452, 8900.198982091579, 8906.198442140174, 8908.331875109392, 8913.019567847565, 8754.0, 8822.69120580783, 8860.822783544358, 8874.023857375683, 8880.467171969638, 42936.57063429357, 43838.123237535074, 43871.56128438707, 43900.56099439029, 43954.780226098985, 3440.8107554084513, 3638.1268495560876, 4137.379393091031, 4137.40007698882, 4225.852095176654, 32998.83500582482, 33002.6699733002, 33507.6649233507, 33743.83128084368, 34710.82644586786, 3997.360422332413, 4362.978185109086, 4464.553544645542, 4482.708623939434, 4558.156741002892, 352960.0, 354851.0, 356844.0, 357441.0, 359524.0, 57710.0, 57842.132368014514, 57915.710421448464, 57968.71015644895, 58025.70987145037, 36221.45667814985, 36917.81541092331, 36964.63035369666, 60334.698326508085, 60551.0, 16866.0, 17004.744928826076, 17055.403060892808, 17164.570885727706, 17233.310667573158, 11725.706857328634, 11767.88232117685, 11767.941160294144, 11779.234349767237, 11804.76390472203, 20034.0, 20187.39437816868, 20341.694874576893, 20353.0, 20533.58932821335, 7128.6435678215885, 7147.106611673541, 7255.310745479171, 7256.7097316106765, 7370.373518251009, 967.1295833749682, 1085.8696956365286, 1091.6506717850211, 1104.1072390337367, 1144.2676686920377, 32479.675203248138, 32540.349193016005, 33224.416534858894, 33461.3307733844, 33729.0, 1098.1489345756943, 1141.9200655954169, 1145.6391236760394, 1166.0729719872722, 1211.1340391620033, 16714.247858846382, 17147.571310717332, 17367.3053077878, 17481.038542880262, 18260.543486412946, 510130.0, 511810.0866469656, 512455.0, 518481.0, 518599.0, 59583.70208148932, 60045.0, 60337.69831150816, 60658.39341606616, 60764.69617651883, 1385.8129152564275, 1388.2503448138095, 1402.1306789790192, 1407.4018542119559, 1410.9981912841793, 31256.843715781277, 33488.66511334856, 33518.83240583781, 33548.0, 33581.0, 51713.0, 52751.0, 52966.0, 53028.73485632547, 53236.0, 482307.0, 488848.0, 492889.0, 493889.0, 495563.0, 28340.433191335644, 28541.0, 28750.568741468476, 28790.712092878803, 28822.42355152927, 48351.75824120857, 48685.0, 48816.511834881196, 49878.75060624674, 49994.25008624946, 40110.0, 42210.36684449674, 42608.0, 43072.35391469068, 43230.351544726225, 41331.586684133974, 41550.376744349465, 41750.44763090448, 42046.36930445985, 42680.0, 35652.46521302131, 40474.797626011685, 40486.0, 40506.1898762029, 41469.170616588104, 34767.0, 36740.63259367372, 36929.44605830861, 37487.6251237495, 37498.625013749515, 27658.585121222794, 28275.293117672223, 28776.712232877402, 28851.422971540873, 28908.7109128906], "value": 20377.078195084952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.14968192590754, 402.20363679913754, 405.11280296151426, 407.3482428115016, 413.33168132821214, 18096.72854907176, 19411.902940485277, 19450.51373715658, 19592.510187245327, 19605.11776970038, 18060.81939180608, 18782.906085469553, 18802.623947521042, 19538.41384758456, 19570.31503897364, 5558.221848941152, 5687.687177205252, 5692.402297758737, 5697.344805347397, 5704.971475142639, 5544.77820887164, 5661.0, 5670.659760414388, 5679.2049113123985, 5690.374058853523, 5472.0, 5569.66582005079, 5638.859028524299, 5644.435556444343, 5646.943530564703, 5600.327960644729, 5640.464155905182, 5669.376368599472, 5674.829755107354, 5687.118496633007, 5076.416212135615, 5409.9459005409835, 5413.864653383657, 5417.377001644822, 5465.152901300305, 13644.249566273851, 13957.511487098005, 17282.827171728248, 23221.419464513354, 23391.532169356688, 2292.6102562564406, 2382.6187809950497, 2563.910263140781, 2657.6545049143683, 2777.3056735816044, 9928.45393503357, 10425.322354046963, 13570.728585428236, 13707.657308567266, 13826.23955682437, 1783.4649605118543, 1838.8528917686688, 1892.3660573707825, 1892.5552495163627, 1898.7816401113773, 77184.61407692982, 77706.6114669423, 78285.60857195735, 79377.60311198464, 79498.60250698768, 10925.617603383844, 11089.500972456259, 11161.330320180816, 11301.604443844426, 11500.0, 15663.0, 15828.0, 15841.0, 15847.841521584636, 15899.125548094966, 8190.344772418312, 8311.002679678477, 8454.915450845412, 8563.314934805201, 8573.699920502753, 7875.173106823816, 7913.9604301978125, 7990.881276621278, 8078.151794061657, 8079.394045446615, 4755.096531658974, 4816.735079570587, 4892.363992680928, 4897.877553061131, 4922.581580565692, 1986.652490553422, 2000.3198912369865, 2016.5765189310116, 2018.3339497965635, 2048.9692654610194, 819.7049062337554, 962.1418113365315, 973.0707174648194, 976.8241716490958, 980.4901451245313, 18297.908510457364, 19413.4175974721, 19592.608147837247, 19612.654543287, 19803.900980495004, 980.6077568972468, 1039.5218199628105, 1043.2540733375672, 1070.3043022035583, 1116.625930313338, 10649.84025239622, 11234.988851003449, 11235.887641123647, 11257.662270131908, 11319.434028298552, 517634.0, 520587.0, 521910.0, 536888.0, 537735.0, 66109.66945165243, 106709.0, 108070.45964770125, 108520.91479085266, 110137.44931275453, 1008.0725732326277, 1038.2576457832686, 1047.7485403503256, 1058.1217589400778, 1058.4760543531002, 17850.375236866646, 17955.281788728826, 18012.729809053137, 18373.265069397075, 18567.0, 42659.57340426556, 42755.0, 43216.78391608022, 43484.34773478337, 44224.33663495114, 56836.715816420656, 60327.69836150791, 61432.692836535534, 62017.37982620297, 66910.33089669042, 8278.668853245803, 8698.739037828875, 8793.252573531066, 8803.163699448542, 8958.283337333129, 10081.0, 13207.273599952096, 13400.195988240737, 13593.59219223425, 13826.377812998238, 11450.541978320774, 11588.594399195988, 11938.880611193777, 11941.626712928124, 12041.698957526132, 11896.643100706993, 11900.642980710592, 11971.16201865861, 11998.0, 12161.635150945485, 11448.599299024494, 11735.647930562096, 11778.057755379721, 11785.528578856749, 12012.0, 8605.784855378415, 8714.520701361233, 8790.208881200722, 8795.828128407957, 8930.910690893008, 11177.273477223955, 11205.991460768244, 11275.210735248455, 11376.829347559627, 11442.82835757481], "value": 9326.10856935657, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.9558113256599, 1490.1059364381372, 1627.7721119043335, 1717.6908156531836, 1765.3556451895054, 8065.758027259177, 8663.653453861845, 8733.519656418894, 9353.532323383837, 9364.719058428249, 8856.070112638161, 9147.771305717344, 9185.035571265005, 9243.491607961576, 9254.120858518447, 2353.564590550745, 2389.6176611742126, 2391.641253811925, 2393.270052633946, 2394.2338451695464, 2361.197192954395, 2389.6176611742126, 2411.746766589509, 2422.2248880358293, 2432.817538684597, 2366.7633236676365, 2378.4648454097864, 2394.5570069537193, 2417.0, 2433.6227884677814, 2333.265021518225, 2345.542619189259, 2350.835441519103, 2357.2456813819585, 2397.1250493569723, 2287.5081857400573, 2292.1862738727677, 2292.415434064303, 2296.2307626944994, 2304.4699719064542, 9015.27877769777, 9051.23064539515, 9068.909310906873, 9082.909170908273, 9131.680391186277, 5324.787008519655, 5424.294841670558, 5425.3489581250105, 5451.2640793492765, 5465.125579907235, 3416.26550291686, 3482.7387945903906, 3514.947275790865, 3517.6306487818924, 3548.769329993542, 1176.7764124816258, 1195.7548702515962, 1198.6104516032324, 1228.729679470515, 1244.8630650628425, 12937.48250069996, 12969.0, 12993.740125197537, 13065.934670326682, 13089.934550327283, 4617.607503362252, 4778.402699662543, 4833.540813622701, 4843.4430040545785, 4844.539768721966, 10927.0, 10938.289011214245, 10938.906109388998, 10952.123830093573, 11001.22991390611, 5421.756020979065, 5449.427810079964, 5462.562994960394, 5471.8084867029465, 5472.124460086447, 4279.807408666617, 4748.525147485224, 4754.9286760698615, 4911.091448082117, 4911.508849115131, 3908.296506628777, 4000.2599519089063, 4039.818208180639, 4056.1684854604737, 4174.853880114181, 1250.3810613746255, 1272.4274076665351, 1275.7639836630253, 1285.1774864086992, 1291.199456337077, 916.706653870755, 1025.1337619711333, 1029.583018877356, 1043.608646757466, 1044.4151275285712, 6148.231471066117, 6193.504519638418, 6229.53278504114, 6238.344973777779, 6309.116723658692, 450.4122120632606, 453.510208974307, 453.8048639085225, 462.83800669765986, 464.4241140985222, 4282.357646353072, 4287.957120428819, 4295.248331541968, 4313.956860431418, 4334.544872788312, 11286.54853805855, 11604.477798499087, 11627.418629068512, 11627.6511704649, 11739.589114380955, 10250.282480226462, 10564.0, 11496.94251528737, 11585.826212606818, 11610.709732256591, 8430.662773489114, 8536.70121545743, 8566.700165494303, 8622.223999840044, 8675.91324086751, 5782.421757824352, 6027.78902738402, 6072.362401947732, 6087.604305720114, 6183.196184495987, 9847.0, 9983.450910199717, 10016.098551130433, 10031.598736050768, 10038.548265328223, 10264.178865690876, 10324.328918620266, 10347.327423717434, 10380.32527885685, 10380.429076400871, 7366.4106871449085, 7702.383809295131, 7892.36861051126, 8052.8792068117855, 8092.312153467021, 9021.594028268612, 9089.681861134828, 9117.863232051392, 9145.5884485197, 9150.63397464094, 7792.493487923267, 8057.556834374166, 8069.757907262791, 8119.5534245617055, 8175.1416101308505, 7867.606619668879, 7934.166912474338, 7992.200779921961, 8032.919670803451, 8062.879056814035, 6795.830104247433, 6823.38589526945, 6888.242293347627, 6912.412444942236, 7067.328603782633, 5286.233496142961, 5287.444818294024, 5325.414204437431, 5331.680099194061, 5353.598480114085, 5130.923036154535, 5213.113770658922, 5214.2960700304975, 5259.105951988095, 5326.3874654413685], "value": 4681.131687347008, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.6434204546023, 338.02311320284383, 339.743493662285, 340.4008944258106, 345.3679766028169, 5499.340079190502, 5571.8607034824045, 5607.355154157273, 5614.242077319565, 5724.883647688697, 5597.916031259534, 5611.494965453108, 5632.901584191084, 5639.577031722617, 5652.915206271899, 4282.743035417885, 4312.22379971605, 4327.480702315726, 4357.281048626973, 4357.433533640622, 4097.344424892018, 4317.84107946027, 4344.4786625604975, 4370.2570563004365, 4399.802008909591, 4288.914221715564, 4290.978545107286, 4297.742135471866, 4336.241157797373, 4346.6088052075465, 4295.420118284054, 4334.739915605058, 4341.913161736779, 4361.869143925655, 4378.846740364103, 3774.962250377516, 3788.6211378862167, 3817.9691483299353, 3840.347140986039, 3858.7105967052303, 5387.81142660005, 5389.51494365509, 5415.241866138744, 5426.647267927572, 5476.972615136939, 4934.777934992934, 4948.282499037619, 4969.7515124244, 4971.602271818246, 4974.502549744997, 5624.3531993820825, 5822.922759289502, 5848.824535263949, 5885.0, 5891.558133139989, 4140.991619064751, 4156.875293741193, 4157.688173386978, 4158.625723684883, 4182.602652747984, 6153.815385538441, 6194.38056194377, 6202.96898515509, 6205.968970155121, 6225.87548249037, 4142.813573389205, 4255.5957184067465, 4287.678424118204, 4293.608049640811, 4312.223799716081, 4304.526502084768, 4325.545817689097, 4329.848455304049, 4340.088581397878, 4364.476262848479, 4953.356063711694, 4973.577245934136, 4979.253112033151, 4999.75001249936, 5020.573251273682, 5749.655020698771, 5907.675077870758, 5945.137954996501, 5948.405159484104, 5950.274420418117, 1494.8355680875095, 1501.3844323827398, 1503.2183264702512, 1505.6235941014747, 1517.1731406383547, 921.203159267229, 955.2405837359316, 961.6489981156827, 962.6823148361024, 971.9125278724948, 5094.363204599425, 5115.411727651293, 5131.7163862081015, 5141.305923700253, 5189.870253243699, 5169.707573106723, 5435.755391007414, 5439.972800135974, 5475.808346707846, 5477.794885125266, 4952.851414457572, 5083.7203953782155, 5091.719955402415, 5142.742862856842, 5213.3222681051975, 2825.265430987958, 2845.2886778305424, 2855.343271047629, 2855.8572071396347, 2949.9262518437213, 5521.73000209954, 5526.171074338801, 5528.710417301699, 5535.782127931849, 5556.499915007668, 5313.54834839043, 5370.570354371719, 5454.7818087276855, 5488.0, 5564.4713752193475, 5499.477549632778, 5523.944760552424, 5535.944640553624, 5539.335279766373, 5557.110862262019, 5127.282180494808, 5288.074586947192, 5294.2852714883, 5403.756830942539, 5407.270018547446, 5259.368875734784, 5343.812966546152, 5351.518363347317, 5356.973215133899, 5358.6248962572245, 5508.55931525485, 5544.695041772741, 5559.555235581063, 5644.915326270191, 6051.335882632311, 4221.261279276176, 4291.0, 4305.70828751367, 4316.9136617268105, 4323.329883868006, 5994.280686317496, 6019.909701354396, 6023.3073196582955, 6031.341381120227, 6081.179040829608, 5704.743286552032, 5856.736446859816, 5889.911651325319, 5905.350411454822, 5931.9110213345975, 5742.7702891883855, 5764.616492041963, 5785.566082543742, 5855.824325270249, 5864.0, 5677.460641239076, 5692.914606280992, 5810.854728631818, 5831.8833623326445, 5836.824895253149, 5628.85927851807, 5937.435943585352, 5975.8328086114425, 6057.0, 6069.692017850371, 5749.367569567428, 5776.826695199151, 5812.82561523155, 5816.389279125631, 5816.970915145397], "value": 4333.219702454741, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.1908757629338, 787.7715462515871, 798.56079156464, 815.7152484836383, 850.485456298939, 14618.853811461882, 15905.522834314974, 16187.595310117253, 16233.594160146002, 16242.83757162428, 14890.925545372285, 14910.329035193416, 14949.0, 14977.176255305954, 14984.400623975056, 808.5957021489255, 827.8220182660726, 832.8042909916165, 832.9588014981273, 834.6202477872554, 683.040328338685, 797.9840403191932, 823.279630323467, 826.2233500509532, 826.2687521543418, 861.2076889261895, 863.3438586674141, 863.8920134983127, 865.4331412924545, 866.6360128745911, 855.8373908957278, 858.5535521528801, 860.7460799064291, 862.5256109139948, 863.6329559937064, 629.3234772619452, 631.7567736421465, 632.1623848400841, 633.0946746152999, 633.2084893882646, 14579.927100364537, 14697.33861976203, 14700.264986750726, 14705.632359190999, 14721.411143554245, 14938.477153299691, 14964.700705985928, 14982.925085374613, 15204.0, 15643.296051677702, 12042.0, 12100.939495302555, 12133.090018248668, 12230.266184028987, 12306.81539776904, 3878.2437424702193, 4072.1652061327654, 4129.0, 4137.627613514768, 4153.480814898137, 73097.63451182764, 74040.62979685067, 75980.24019759787, 75994.24005759927, 76115.61942190309, 11708.648740537797, 11943.283402995849, 11954.706509080928, 12153.0, 12319.445624946899, 23122.768772312396, 23156.3053108407, 23158.76841231566, 23166.0, 23174.884125579265, 8550.1449855014, 8799.111522812082, 8852.336074794417, 8881.955590222007, 8981.685641002534, 4792.472827988919, 4877.195262781602, 4897.216445368796, 4995.475475075064, 5227.921581176285, 3586.5337506124038, 3682.0794801299676, 3700.2784457031157, 3707.647773461517, 3720.813959302024, 595.1727099331932, 632.5603705424686, 633.5311869216838, 635.1140159477503, 635.7520566978882, 662.9303923088006, 744.0847757258495, 750.5421692767408, 757.6704133701858, 781.4959351218432, 9909.256805739598, 10106.595736170471, 10327.657404537362, 10452.16382689383, 10561.524731387106, 611.7858749437661, 721.8989341492195, 758.0789340950771, 760.9657565409569, 766.7469734987441, 4476.127155204769, 4653.7207767534055, 4745.288206768943, 4754.8853608494355, 4921.212605983025, 66745.6662716693, 70693.64653176701, 70800.2919970804, 112749.2888175622, 116202.0, 60906.39093609007, 81278.59360703158, 92609.53695231481, 96586.0, 100699.0, 62220.68889655613, 86562.56718716492, 87885.0, 87996.5600171995, 89392.0, 8530.189631984951, 8772.517511536671, 8790.604422800861, 8829.823403532022, 9031.942601111781, 52398.21402678887, 52795.47204527906, 53761.19358209552, 54931.0, 55982.44017559772, 71647.0, 76847.0, 77411.22588774265, 77994.0, 78337.60831195807, 12418.937905310415, 12750.553730619384, 12880.935595322338, 12902.612921612366, 12977.026722995624, 13072.215667060007, 13726.0, 13743.587692369245, 13923.930380348034, 14514.491992780202, 11918.523259069887, 12704.872951270369, 13005.804912926504, 13078.346082696018, 13546.296618901, 11426.714332141762, 11668.94165529167, 12477.5008999639, 12812.61562153137, 12971.156874803484, 11411.885881141083, 11846.289222646668, 11916.76166476683, 11969.16215864916, 12256.448459819152, 9123.31575131881, 9392.95303523478, 9504.14043727798, 9591.376560523544, 9623.422594644344, 9313.39664177067, 9689.951550242486, 9771.02878041033, 9901.05898196601, 9955.651552195639], "value": 7444.794672864623, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 113.0, 112.0, 115.0, 112.0, 111.0, 111.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 154.0, 190.0, 128.0, 149.0, 166.0, 133.0, 184.0, 135.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 164.0, 163.0, 176.0, 163.0, 164.0, 162.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 76.0, 162.0, 75.0, 78.0, 75.0, 74.0, 170.0, 75.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 145.0, 85.0, 85.0, 86.0, 152.0, 86.0, 85.0, 139.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 58.0, 53.0, 54.0, 57.0, 56.0, 60.0, 54.0, 54.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 67.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 79.0, 80.0, 80.0, 82.0, 79.0, 106.0, 95.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 137.0, 137.0, 121.0, 121.0, 130.0, 135.0, 140.0, 129.0, 123.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 161.0, 164.0, 159.0, 158.0, 162.0, 159.0, 161.0, 164.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 63.0, 63.0, 63.0, 62.0, 64.0, 66.0, 65.0, 62.0, 61.0], "value": 63.8, "unit": "score"}]}]} 17:32:47 INFO - Return code: 0 17:32:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:32:47 ERROR - # TBPL SUCCESS # 17:32:47 INFO - Running post-action listener: _resource_record_post_action 17:32:47 INFO - ##### 17:32:47 INFO - ##### Finished run-tests step (success) 17:32:47 INFO - ##### 17:32:47 INFO - Running post-run listener: _resource_record_post_run 17:32:47 INFO - Total resource usage - Wall time: 1191s; CPU: 14.0%; Read bytes: 4096; Write bytes: 309030912; Read time: 0; Write time: 281792 17:32:47 INFO - TinderboxPrint: CPU usage
13.5% 17:32:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 0 17:32:47 INFO - TinderboxPrint: I/O write bytes / time
309,030,912 / 281,792 17:32:47 INFO - TinderboxPrint: CPU idle
8,215.7 (86.5%) 17:32:47 INFO - TinderboxPrint: CPU user
1,229.5 (12.9%) 17:32:47 INFO - TinderboxPrint: Swap in / out
0 / 0 17:32:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20893696; Read time: 0; Write time: 4080 17:32:47 INFO - run-tests - Wall time: 1175s; CPU: 14.0%; Read bytes: 4096; Write bytes: 288137216; Read time: 0; Write time: 277712 17:32:48 INFO - Running post-run listener: _upload_blobber_files 17:32:48 INFO - Blob upload gear active. 17:32:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:32:48 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 17:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:32:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:32:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:32:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:32:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:49 INFO - (blobuploader) - INFO - Done attempting. 17:32:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:32:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:32:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:50 INFO - (blobuploader) - INFO - Done attempting. 17:32:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:32:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:32:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:53 INFO - (blobuploader) - INFO - Done attempting. 17:32:53 INFO - (blobuploader) - INFO - Iteration through files over. 17:32:53 INFO - Return code: 0 17:32:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:32:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:32:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09fda3a12a9f5a1f591f933305cb3b7eddb234cc2be4d8bd858570ff437ee2caa0126b542468278b4ef46b2bd3ac73d42841a34341200f51cebc2f3b25a2379d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c66d09b6f325e59d4cf52bc3ef1d6404a4d37e351b464d738afb174bdd07eb43349d621eb497fac654b33f4beaf57511a8cbe4734e5055531f0a3412761ed3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d4f2f963bd088de7495d7c7c7a0194699b5b3256a5ff4848cb102dd75fddecf0eb6f0df62995d590d2648ded081f0b6bfbc5efc61c20009aacc3220ffeb4dae"} 17:32:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:32:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:32:53 INFO - Contents: 17:32:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09fda3a12a9f5a1f591f933305cb3b7eddb234cc2be4d8bd858570ff437ee2caa0126b542468278b4ef46b2bd3ac73d42841a34341200f51cebc2f3b25a2379d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c66d09b6f325e59d4cf52bc3ef1d6404a4d37e351b464d738afb174bdd07eb43349d621eb497fac654b33f4beaf57511a8cbe4734e5055531f0a3412761ed3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d4f2f963bd088de7495d7c7c7a0194699b5b3256a5ff4848cb102dd75fddecf0eb6f0df62995d590d2648ded081f0b6bfbc5efc61c20009aacc3220ffeb4dae"} 17:32:53 INFO - Running post-run listener: copy_logs_to_upload_dir 17:32:53 INFO - Copying logs to upload dir... 17:32:53 INFO - mkdir: /builds/slave/test/build/upload/logs 17:32:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.963623 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-05 17:32:53.039347) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 17:32:53.043126) ========= 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=fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09fda3a12a9f5a1f591f933305cb3b7eddb234cc2be4d8bd858570ff437ee2caa0126b542468278b4ef46b2bd3ac73d42841a34341200f51cebc2f3b25a2379d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c66d09b6f325e59d4cf52bc3ef1d6404a4d37e351b464d738afb174bdd07eb43349d621eb497fac654b33f4beaf57511a8cbe4734e5055531f0a3412761ed3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d4f2f963bd088de7495d7c7c7a0194699b5b3256a5ff4848cb102dd75fddecf0eb6f0df62995d590d2648ded081f0b6bfbc5efc61c20009aacc3220ffeb4dae"} build_url:https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011484 build_url: 'https://queue.taskcluster.net/v1/task/MrTY-ce5TEOWwUBxxmUKsA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09fda3a12a9f5a1f591f933305cb3b7eddb234cc2be4d8bd858570ff437ee2caa0126b542468278b4ef46b2bd3ac73d42841a34341200f51cebc2f3b25a2379d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c66d09b6f325e59d4cf52bc3ef1d6404a4d37e351b464d738afb174bdd07eb43349d621eb497fac654b33f4beaf57511a8cbe4734e5055531f0a3412761ed3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d4f2f963bd088de7495d7c7c7a0194699b5b3256a5ff4848cb102dd75fddecf0eb6f0df62995d590d2648ded081f0b6bfbc5efc61c20009aacc3220ffeb4dae"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 17:32:53.069259) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:32:53.069700) ========= 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=fa44defc139c4ba8574fe040000001db-1465170785.149901-601727883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 17:32:53.154911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 17:32:53.155612) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 17:32:53.156455) ========= ========= Total master_lag: 0.17 =========