builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1465646785.76 results: success (0) buildid: 20160611023005 builduid: c495368f2dc34a9aa9b6e4cb1351b203 revision: 9694e371363590c8dace6629dc4d57f1af7206f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:25.765219) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:25.765767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:25.766062) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:25.782447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:25.782872) ========= 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=eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-11 05:06:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-06-11 05:06:26 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129735 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:25.927055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:25.927450) ========= 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=eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018761 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:26.004518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:26.004845) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9694e371363590c8dace6629dc4d57f1af7206f2 --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 9694e371363590c8dace6629dc4d57f1af7206f2 --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=eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-11 05:06:26,443 truncating revision to first 12 chars 2016-06-11 05:06:26,444 Setting DEBUG logging. 2016-06-11 05:06:26,444 attempt 1/10 2016-06-11 05:06:26,444 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9694e3713635?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-11 05:06:26,755 unpacking tar archive at: fx-team-9694e3713635/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619334 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:26.638252) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:26.638610) ========= script_repo_revision: 9694e371363590c8dace6629dc4d57f1af7206f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:26.639043) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:26.639334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 05:06:26.650125) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-11 05:06:26.650579) ========= /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=eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:06:27 INFO - MultiFileLogger online at 20160611 05:06:27 in /builds/slave/test 05:06:27 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 05:06:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:06:27 INFO - {'append_to_log': False, 05:06:27 INFO - 'base_work_dir': '/builds/slave/test', 05:06:27 INFO - 'blob_upload_branch': 'Fx-Team', 05:06:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:06:27 INFO - 'branch': 'Fx-Team', 05:06:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:06:27 INFO - 'config_files': ('talos/linux_config.py',), 05:06:27 INFO - 'default_actions': ('clobber', 05:06:27 INFO - 'read-buildbot-config', 05:06:27 INFO - 'download-and-extract', 05:06:27 INFO - 'populate-webroot', 05:06:27 INFO - 'create-virtualenv', 05:06:27 INFO - 'install', 05:06:27 INFO - 'run-tests'), 05:06:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:06:27 INFO - 'download_minidump_stackwalk': True, 05:06:27 INFO - 'download_symbols': 'ondemand', 05:06:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:06:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:06:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:06:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:06:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:06:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:06:27 INFO - 'installer_path': 'installer.exe', 05:06:27 INFO - 'log_level': 'info', 05:06:27 INFO - 'log_name': 'talos', 05:06:27 INFO - 'log_to_console': True, 05:06:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:06:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:06:27 INFO - 'opt_config_files': (), 05:06:27 INFO - 'pip_index': False, 05:06:27 INFO - 'sps_profile': False, 05:06:27 INFO - 'sps_profile_interval': 0, 05:06:27 INFO - 'suite': 'dromaeojs-e10s', 05:06:27 INFO - 'system_bits': '32', 05:06:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:06:27 INFO - 'title': 'talos-linux64-ix-010', 05:06:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:06:27 INFO - 'use_talos_json': True, 05:06:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:06:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:06:27 INFO - 'work_dir': 'build'} 05:06:27 INFO - ##### 05:06:27 INFO - ##### Running clobber step. 05:06:27 INFO - ##### 05:06:27 INFO - Running pre-action listener: _resource_record_pre_action 05:06:27 INFO - Running main action method: clobber 05:06:27 INFO - rmtree: /builds/slave/test/build 05:06:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:06:28 INFO - Running post-action listener: _resource_record_post_action 05:06:28 INFO - ##### 05:06:28 INFO - ##### Finished clobber step (success) 05:06:28 INFO - ##### 05:06:28 INFO - ##### 05:06:28 INFO - ##### Running read-buildbot-config step. 05:06:28 INFO - ##### 05:06:28 INFO - Running pre-action listener: _resource_record_pre_action 05:06:28 INFO - Running main action method: read_buildbot_config 05:06:28 INFO - Using buildbot properties: 05:06:28 INFO - { 05:06:28 INFO - "project": "", 05:06:28 INFO - "product": "firefox", 05:06:28 INFO - "script_repo_revision": "production", 05:06:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:06:28 INFO - "repository": "", 05:06:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:06:28 INFO - "buildid": "20160611023005", 05:06:28 INFO - "pgo_build": "True", 05:06:28 INFO - "basedir": "/builds/slave/test", 05:06:28 INFO - "buildnumber": 463, 05:06:28 INFO - "slavename": "talos-linux64-ix-010", 05:06:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:06:28 INFO - "platform": "ubuntu64_hw", 05:06:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:06:28 INFO - "branch": "fx-team", 05:06:28 INFO - "repo_path": "integration/fx-team", 05:06:28 INFO - "revision": "9694e371363590c8dace6629dc4d57f1af7206f2", 05:06:28 INFO - "stage_platform": "linux64-pgo", 05:06:28 INFO - "builduid": "c495368f2dc34a9aa9b6e4cb1351b203", 05:06:28 INFO - "slavebuilddir": "test" 05:06:28 INFO - } 05:06:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:06:28 INFO - Running post-action listener: _resource_record_post_action 05:06:28 INFO - ##### 05:06:28 INFO - ##### Finished read-buildbot-config step (success) 05:06:28 INFO - ##### 05:06:28 INFO - ##### 05:06:28 INFO - ##### Running download-and-extract step. 05:06:28 INFO - ##### 05:06:28 INFO - Running pre-action listener: _resource_record_pre_action 05:06:28 INFO - Running main action method: download_and_extract 05:06:28 INFO - mkdir: /builds/slave/test/build/tests 05:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:28 INFO - https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:06:36 INFO - Downloaded 1361 bytes. 05:06:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:06:36 INFO - Using the following test package requirements: 05:06:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:06:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:06:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'jsshell-linux-x86_64.zip'], 05:06:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:06:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:06:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:06:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:06:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:06:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:36 INFO - https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:06:53 INFO - Downloaded 24464076 bytes. 05:06:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:06:54 INFO - Return code: 0 05:06:54 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:54 INFO - https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:06:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:06:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:06:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:06:57 INFO - Downloaded 24464076 bytes. 05:06:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:06:58 INFO - Return code: 0 05:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:58 INFO - https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:06:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:07:00 INFO - Downloaded 10833377 bytes. 05:07:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:07:00 INFO - Return code: 0 05:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:00 INFO - https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:07:03 INFO - Downloaded 59360225 bytes. 05:07:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:03 INFO - mkdir: /builds/slave/test/properties 05:07:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:03 INFO - Contents: 05:07:03 INFO - build_url:https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:07:03 INFO - Running post-action listener: _resource_record_post_action 05:07:03 INFO - Running post-action listener: set_extra_try_arguments 05:07:03 INFO - ##### 05:07:03 INFO - ##### Finished download-and-extract step (success) 05:07:03 INFO - ##### 05:07:03 INFO - ##### 05:07:03 INFO - ##### Running populate-webroot step. 05:07:03 INFO - ##### 05:07:03 INFO - Running pre-action listener: _resource_record_pre_action 05:07:03 INFO - Running main action method: populate_webroot 05:07:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:03 INFO - '--tppagecycles', 05:07:03 INFO - '7'], 05:07:03 INFO - 'tests': ['tsvgm']}}, 05:07:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:03 INFO - 'talos_options': ['--disable-e10s'], 05:07:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:03 INFO - 'talos_options': ['--disable-e10s'], 05:07:03 INFO - 'tests': ['damp', 'tps']}, 05:07:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:03 INFO - 'tests': ['damp', 'tps']}, 05:07:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:03 INFO - 'tests': ['dromaeo_dom']}, 05:07:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:03 INFO - 'tests': ['a11yr', 05:07:03 INFO - 'ts_paint', 05:07:03 INFO - 'tpaint', 05:07:03 INFO - 'sessionrestore', 05:07:03 INFO - 'sessionrestore_no_auto_restore', 05:07:03 INFO - 'tabpaint']}, 05:07:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:03 INFO - 'ts_paint', 05:07:03 INFO - 'tpaint', 05:07:03 INFO - 'sessionrestore', 05:07:03 INFO - 'sessionrestore_no_auto_restore', 05:07:03 INFO - 'tabpaint']}, 05:07:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:03 INFO - 'ts_paint', 05:07:03 INFO - 'tpaint', 05:07:03 INFO - 'sessionrestore', 05:07:03 INFO - 'sessionrestore_no_auto_restore', 05:07:03 INFO - 'tabpaint']}, 05:07:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:03 INFO - 'ts_paint', 05:07:03 INFO - 'tpaint', 05:07:03 INFO - 'sessionrestore', 05:07:03 INFO - 'sessionrestore_no_auto_restore', 05:07:03 INFO - 'tabpaint']}, 05:07:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:03 INFO - 'tests': ['a11yr', 05:07:03 INFO - 'ts_paint', 05:07:03 INFO - 'tpaint', 05:07:03 INFO - 'sessionrestore', 05:07:03 INFO - 'sessionrestore_no_auto_restore', 05:07:03 INFO - 'tabpaint']}, 05:07:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:03 INFO - 'tests': ['a11yr', 05:07:03 INFO - 'ts_paint', 05:07:03 INFO - 'tpaint', 05:07:03 INFO - 'sessionrestore', 05:07:03 INFO - 'sessionrestore_no_auto_restore', 05:07:03 INFO - 'tabpaint']}, 05:07:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:03 INFO - 'tests': ['tsvgx', 05:07:03 INFO - 'tsvgr_opacity', 05:07:03 INFO - 'tart', 05:07:03 INFO - 'tscrollx', 05:07:03 INFO - 'cart']}, 05:07:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:03 INFO - 'tsvgr_opacity', 05:07:03 INFO - 'tart', 05:07:03 INFO - 'tscrollx', 05:07:03 INFO - 'cart']}, 05:07:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:03 INFO - 'talos_options': ['--disable-e10s'], 05:07:03 INFO - 'tests': ['tp5o']}, 05:07:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:03 INFO - 'tests': ['tp5o']}, 05:07:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:03 INFO - 'talos_options': ['--disable-e10s', 05:07:03 INFO - '--xperf_path', 05:07:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:03 INFO - 'tests': ['tp5n']}, 05:07:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:03 INFO - 'talos_options': ['--xperf_path', 05:07:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:03 INFO - 'tests': ['tp5n']}}, 05:07:03 INFO - 'talos.zip': {'path': '', 05:07:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:03 INFO - Running post-action listener: _resource_record_post_action 05:07:03 INFO - ##### 05:07:03 INFO - ##### Finished populate-webroot step (success) 05:07:03 INFO - ##### 05:07:03 INFO - ##### 05:07:03 INFO - ##### Running create-virtualenv step. 05:07:03 INFO - ##### 05:07:03 INFO - Running pre-action listener: _resource_record_pre_action 05:07:03 INFO - Running main action method: create_virtualenv 05:07:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:07:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:04 INFO - Using real prefix '/usr' 05:07:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:06 INFO - Installing pip.................done. 05:07:06 INFO - Return code: 0 05:07:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042bba7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1726110>, '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 0x1692230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16926c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', '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 05:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:07:06 INFO - Using env: {'DISPLAY': ':0', 05:07:06 INFO - 'HOME': '/home/cltbld', 05:07:06 INFO - 'LANG': 'en_US.UTF-8', 05:07:06 INFO - 'LANGUAGE': 'en_US:en', 05:07:06 INFO - 'LOGNAME': 'cltbld', 05:07:06 INFO - 'MAIL': '/var/mail/cltbld', 05:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:06 INFO - 'MOZ_NO_REMOTE': '1', 05:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:06 INFO - 'NO_EM_RESTART': '1', 05:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:06 INFO - 'PWD': '/builds/slave/test', 05:07:06 INFO - 'SHELL': '/bin/bash', 05:07:06 INFO - 'SHLVL': '1', 05:07:06 INFO - 'TERM': 'linux', 05:07:06 INFO - 'TMOUT': '86400', 05:07:06 INFO - 'USER': 'cltbld', 05:07:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', 05:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:06 INFO - '_': '/tools/buildbot/bin/python'} 05:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:07:06 INFO - Cleaning up... 05:07:06 INFO - Return code: 0 05:07:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042bba7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1726110>, '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 0x1692230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16926c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', '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 05:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:07:06 INFO - Using env: {'DISPLAY': ':0', 05:07:06 INFO - 'HOME': '/home/cltbld', 05:07:06 INFO - 'LANG': 'en_US.UTF-8', 05:07:06 INFO - 'LANGUAGE': 'en_US:en', 05:07:06 INFO - 'LOGNAME': 'cltbld', 05:07:06 INFO - 'MAIL': '/var/mail/cltbld', 05:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:06 INFO - 'MOZ_NO_REMOTE': '1', 05:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:06 INFO - 'NO_EM_RESTART': '1', 05:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:06 INFO - 'PWD': '/builds/slave/test', 05:07:06 INFO - 'SHELL': '/bin/bash', 05:07:06 INFO - 'SHLVL': '1', 05:07:06 INFO - 'TERM': 'linux', 05:07:06 INFO - 'TMOUT': '86400', 05:07:06 INFO - 'USER': 'cltbld', 05:07:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', 05:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:06 INFO - '_': '/tools/buildbot/bin/python'} 05:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:06 INFO - Downloading/unpacking psutil>=3.1.1 05:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:08 INFO - Installing collected packages: psutil 05:07:08 INFO - Running setup.py install for psutil 05:07:08 INFO - building 'psutil._psutil_linux' extension 05:07:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:07:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:07:09 INFO - building 'psutil._psutil_posix' extension 05:07:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:07:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:07:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:09 INFO - Successfully installed psutil 05:07:09 INFO - Cleaning up... 05:07:09 INFO - Return code: 0 05:07:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042bba7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1726110>, '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 0x1692230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16926c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', '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 05:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:07:09 INFO - Using env: {'DISPLAY': ':0', 05:07:09 INFO - 'HOME': '/home/cltbld', 05:07:09 INFO - 'LANG': 'en_US.UTF-8', 05:07:09 INFO - 'LANGUAGE': 'en_US:en', 05:07:09 INFO - 'LOGNAME': 'cltbld', 05:07:09 INFO - 'MAIL': '/var/mail/cltbld', 05:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:09 INFO - 'MOZ_NO_REMOTE': '1', 05:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:09 INFO - 'NO_EM_RESTART': '1', 05:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:09 INFO - 'PWD': '/builds/slave/test', 05:07:09 INFO - 'SHELL': '/bin/bash', 05:07:09 INFO - 'SHLVL': '1', 05:07:09 INFO - 'TERM': 'linux', 05:07:09 INFO - 'TMOUT': '86400', 05:07:09 INFO - 'USER': 'cltbld', 05:07:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', 05:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:09 INFO - '_': '/tools/buildbot/bin/python'} 05:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:07:11 INFO - Installing collected packages: mozsystemmonitor 05:07:11 INFO - Running setup.py install for mozsystemmonitor 05:07:11 INFO - Successfully installed mozsystemmonitor 05:07:11 INFO - Cleaning up... 05:07:11 INFO - Return code: 0 05:07:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042bba7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1726110>, '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 0x1692230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16926c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', '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 05:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:07:11 INFO - Using env: {'DISPLAY': ':0', 05:07:11 INFO - 'HOME': '/home/cltbld', 05:07:11 INFO - 'LANG': 'en_US.UTF-8', 05:07:11 INFO - 'LANGUAGE': 'en_US:en', 05:07:11 INFO - 'LOGNAME': 'cltbld', 05:07:11 INFO - 'MAIL': '/var/mail/cltbld', 05:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:11 INFO - 'MOZ_NO_REMOTE': '1', 05:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:11 INFO - 'NO_EM_RESTART': '1', 05:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:11 INFO - 'PWD': '/builds/slave/test', 05:07:11 INFO - 'SHELL': '/bin/bash', 05:07:11 INFO - 'SHLVL': '1', 05:07:11 INFO - 'TERM': 'linux', 05:07:11 INFO - 'TMOUT': '86400', 05:07:11 INFO - 'USER': 'cltbld', 05:07:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', 05:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:11 INFO - '_': '/tools/buildbot/bin/python'} 05:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:11 INFO - Downloading/unpacking jsonschema==2.5.1 05:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:14 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:14 INFO - warning: no files found matching '*.txt' 05:07:14 INFO - no previously-included directories found matching 'build' 05:07:14 INFO - no previously-included directories found matching 'dist' 05:07:14 INFO - no previously-included directories found matching '.git*' 05:07:14 INFO - Installing collected packages: jsonschema, functools32 05:07:14 INFO - Running setup.py install for functools32 05:07:14 INFO - warning: no files found matching '*.txt' 05:07:14 INFO - no previously-included directories found matching 'build' 05:07:14 INFO - no previously-included directories found matching 'dist' 05:07:14 INFO - no previously-included directories found matching '.git*' 05:07:14 INFO - Successfully installed jsonschema functools32 05:07:14 INFO - Cleaning up... 05:07:14 INFO - Return code: 0 05:07:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042bba7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1726110>, '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 0x1692230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16926c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', '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 05:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:07:14 INFO - Using env: {'DISPLAY': ':0', 05:07:14 INFO - 'HOME': '/home/cltbld', 05:07:14 INFO - 'LANG': 'en_US.UTF-8', 05:07:14 INFO - 'LANGUAGE': 'en_US:en', 05:07:14 INFO - 'LOGNAME': 'cltbld', 05:07:14 INFO - 'MAIL': '/var/mail/cltbld', 05:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:14 INFO - 'MOZ_NO_REMOTE': '1', 05:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:14 INFO - 'NO_EM_RESTART': '1', 05:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:14 INFO - 'PWD': '/builds/slave/test', 05:07:14 INFO - 'SHELL': '/bin/bash', 05:07:14 INFO - 'SHLVL': '1', 05:07:14 INFO - 'TERM': 'linux', 05:07:14 INFO - 'TMOUT': '86400', 05:07:14 INFO - 'USER': 'cltbld', 05:07:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', 05:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:14 INFO - '_': '/tools/buildbot/bin/python'} 05:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:17 INFO - Downloading docopt-0.6.1.tar.gz 05:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:17 INFO - Running setup.py install for blobuploader 05:07:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:17 INFO - Running setup.py install for requests 05:07:17 INFO - Running setup.py install for docopt 05:07:17 INFO - Successfully installed blobuploader requests docopt 05:07:17 INFO - Cleaning up... 05:07:17 INFO - Return code: 0 05:07:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042bba7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1726110>, '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 0x1692230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16926c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', '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 05:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:07:17 INFO - Using env: {'DISPLAY': ':0', 05:07:17 INFO - 'HOME': '/home/cltbld', 05:07:17 INFO - 'LANG': 'en_US.UTF-8', 05:07:17 INFO - 'LANGUAGE': 'en_US:en', 05:07:17 INFO - 'LOGNAME': 'cltbld', 05:07:17 INFO - 'MAIL': '/var/mail/cltbld', 05:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:17 INFO - 'MOZ_NO_REMOTE': '1', 05:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:17 INFO - 'NO_EM_RESTART': '1', 05:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:17 INFO - 'PWD': '/builds/slave/test', 05:07:17 INFO - 'SHELL': '/bin/bash', 05:07:17 INFO - 'SHLVL': '1', 05:07:17 INFO - 'TERM': 'linux', 05:07:17 INFO - 'TMOUT': '86400', 05:07:17 INFO - 'USER': 'cltbld', 05:07:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', 05:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:17 INFO - '_': '/tools/buildbot/bin/python'} 05:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:18 INFO - Running setup.py (path:/tmp/pip-86vsrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:18 INFO - Running setup.py (path:/tmp/pip-TgyQSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:18 INFO - Running setup.py (path:/tmp/pip-1x7FrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:18 INFO - Running setup.py (path:/tmp/pip-TKG0Zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:18 INFO - Running setup.py (path:/tmp/pip-ilyTE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:18 INFO - Running setup.py (path:/tmp/pip-dPepL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:18 INFO - Running setup.py (path:/tmp/pip-NPrrVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:18 INFO - Running setup.py (path:/tmp/pip-n_Va6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:18 INFO - Running setup.py (path:/tmp/pip-lZFUqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:18 INFO - Running setup.py (path:/tmp/pip-XRbcJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:18 INFO - Running setup.py (path:/tmp/pip-gWUddk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:18 INFO - Running setup.py (path:/tmp/pip-ZjPiDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:18 INFO - Running setup.py (path:/tmp/pip-v0qvux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:19 INFO - Running setup.py (path:/tmp/pip-NJmeZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:19 INFO - Running setup.py (path:/tmp/pip-taTPQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:19 INFO - Running setup.py (path:/tmp/pip-wzh8Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:19 INFO - Running setup.py (path:/tmp/pip-RDd9ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:19 INFO - Running setup.py install for manifestparser 05:07:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:19 INFO - Running setup.py install for mozcrash 05:07:19 INFO - Running setup.py install for mozdebug 05:07:19 INFO - Running setup.py install for mozdevice 05:07:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:07:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:07:19 INFO - Running setup.py install for mozfile 05:07:19 INFO - Running setup.py install for mozhttpd 05:07:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:07:19 INFO - Running setup.py install for mozinfo 05:07:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:07:20 INFO - Running setup.py install for mozInstall 05:07:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:07:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:07:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:07:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:07:20 INFO - Running setup.py install for mozleak 05:07:20 INFO - Running setup.py install for mozlog 05:07:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:07:20 INFO - Running setup.py install for moznetwork 05:07:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:07:20 INFO - Running setup.py install for mozprocess 05:07:20 INFO - Running setup.py install for mozprofile 05:07:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:07:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:07:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:07:20 INFO - Running setup.py install for mozrunner 05:07:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:07:20 INFO - Running setup.py install for mozscreenshot 05:07:20 INFO - Running setup.py install for moztest 05:07:20 INFO - Running setup.py install for mozversion 05:07:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:07:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:07:21 INFO - Cleaning up... 05:07:21 INFO - Return code: 0 05:07:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:21 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')]} 05:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:21 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')]} 05:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:21 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 0x7f042bba7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1726110>, '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 0x1692230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16926c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', '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 05:07:21 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 05:07:21 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 05:07:21 INFO - Using env: {'DISPLAY': ':0', 05:07:21 INFO - 'HOME': '/home/cltbld', 05:07:21 INFO - 'LANG': 'en_US.UTF-8', 05:07:21 INFO - 'LANGUAGE': 'en_US:en', 05:07:21 INFO - 'LOGNAME': 'cltbld', 05:07:21 INFO - 'MAIL': '/var/mail/cltbld', 05:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:21 INFO - 'MOZ_NO_REMOTE': '1', 05:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:21 INFO - 'NO_EM_RESTART': '1', 05:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:21 INFO - 'PWD': '/builds/slave/test', 05:07:21 INFO - 'SHELL': '/bin/bash', 05:07:21 INFO - 'SHLVL': '1', 05:07:21 INFO - 'TERM': 'linux', 05:07:21 INFO - 'TMOUT': '86400', 05:07:21 INFO - 'USER': 'cltbld', 05:07:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', 05:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:21 INFO - '_': '/tools/buildbot/bin/python'} 05:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:21 INFO - Running setup.py (path:/tmp/pip-fWioaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:21 INFO - Running setup.py (path:/tmp/pip-3zVrfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:21 INFO - Running setup.py (path:/tmp/pip-HFapro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:21 INFO - Running setup.py (path:/tmp/pip-qYZJmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:21 INFO - Running setup.py (path:/tmp/pip-XVooQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:21 INFO - Running setup.py (path:/tmp/pip-O0mZHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:21 INFO - Running setup.py (path:/tmp/pip-BwhRc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:21 INFO - Running setup.py (path:/tmp/pip-nUJQq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:21 INFO - Running setup.py (path:/tmp/pip-A0aPj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:21 INFO - Running setup.py (path:/tmp/pip-puK0H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:22 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)) 05:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:22 INFO - Running setup.py (path:/tmp/pip-ToMoHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:22 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)) 05:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:22 INFO - Running setup.py (path:/tmp/pip-MilBEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:22 INFO - Running setup.py (path:/tmp/pip-zJpPzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:22 INFO - Running setup.py (path:/tmp/pip-I7fhW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:22 INFO - Running setup.py (path:/tmp/pip-1Usn0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:22 INFO - Running setup.py (path:/tmp/pip-AwSfZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:22 INFO - Running setup.py (path:/tmp/pip-zSXFOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:07:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:24 INFO - Downloading blessings-1.6.tar.gz 05:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:07:24 INFO - Installing collected packages: blessings 05:07:24 INFO - Running setup.py install for blessings 05:07:24 INFO - Successfully installed blessings 05:07:24 INFO - Cleaning up... 05:07:24 INFO - Return code: 0 05:07:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:24 INFO - Reading from file tmpfile_stdout 05:07:24 INFO - Current package versions: 05:07:24 INFO - argparse == 1.2.1 05:07:24 INFO - blessings == 1.6 05:07:24 INFO - blobuploader == 1.2.4 05:07:24 INFO - docopt == 0.6.1 05:07:24 INFO - functools32 == 3.2.3-2 05:07:24 INFO - jsonschema == 2.5.1 05:07:24 INFO - manifestparser == 1.1 05:07:24 INFO - mozInstall == 1.12 05:07:24 INFO - mozcrash == 0.17 05:07:24 INFO - mozdebug == 0.1 05:07:24 INFO - mozdevice == 0.48 05:07:24 INFO - mozfile == 1.2 05:07:24 INFO - mozhttpd == 0.7 05:07:24 INFO - mozinfo == 0.9 05:07:24 INFO - mozleak == 0.1 05:07:24 INFO - mozlog == 3.2 05:07:24 INFO - moznetwork == 0.27 05:07:24 INFO - mozprocess == 0.22 05:07:24 INFO - mozprofile == 0.28 05:07:24 INFO - mozrunner == 6.11 05:07:24 INFO - mozscreenshot == 0.1 05:07:24 INFO - mozsystemmonitor == 0.3 05:07:24 INFO - moztest == 0.7 05:07:24 INFO - mozversion == 1.4 05:07:24 INFO - psutil == 3.1.1 05:07:24 INFO - requests == 1.2.3 05:07:24 INFO - wsgiref == 0.1.2 05:07:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042bba7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1726110>, '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 0x1692230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16926c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', '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 05:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:07:24 INFO - Using env: {'DISPLAY': ':0', 05:07:24 INFO - 'HOME': '/home/cltbld', 05:07:24 INFO - 'LANG': 'en_US.UTF-8', 05:07:24 INFO - 'LANGUAGE': 'en_US:en', 05:07:24 INFO - 'LOGNAME': 'cltbld', 05:07:24 INFO - 'MAIL': '/var/mail/cltbld', 05:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:24 INFO - 'MOZ_NO_REMOTE': '1', 05:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:24 INFO - 'NO_EM_RESTART': '1', 05:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:24 INFO - 'PWD': '/builds/slave/test', 05:07:24 INFO - 'SHELL': '/bin/bash', 05:07:24 INFO - 'SHLVL': '1', 05:07:24 INFO - 'TERM': 'linux', 05:07:24 INFO - 'TMOUT': '86400', 05:07:24 INFO - 'USER': 'cltbld', 05:07:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', 05:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:24 INFO - '_': '/tools/buildbot/bin/python'} 05:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:25 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)) 05:07:25 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)) 05:07:25 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)) 05:07:25 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)) 05:07:25 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)) 05:07:25 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)) 05:07:25 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)) 05:07:25 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)) 05:07:25 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)) 05:07:25 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)) 05:07:25 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)) 05:07:25 INFO - Cleaning up... 05:07:25 INFO - Return code: 0 05:07:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042bba7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1726110>, '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 0x1692230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16926c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', '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 05:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:07:25 INFO - Using env: {'DISPLAY': ':0', 05:07:25 INFO - 'HOME': '/home/cltbld', 05:07:25 INFO - 'LANG': 'en_US.UTF-8', 05:07:25 INFO - 'LANGUAGE': 'en_US:en', 05:07:25 INFO - 'LOGNAME': 'cltbld', 05:07:25 INFO - 'MAIL': '/var/mail/cltbld', 05:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:25 INFO - 'MOZ_NO_REMOTE': '1', 05:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:25 INFO - 'NO_EM_RESTART': '1', 05:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:25 INFO - 'PWD': '/builds/slave/test', 05:07:25 INFO - 'SHELL': '/bin/bash', 05:07:25 INFO - 'SHLVL': '1', 05:07:25 INFO - 'TERM': 'linux', 05:07:25 INFO - 'TMOUT': '86400', 05:07:25 INFO - 'USER': 'cltbld', 05:07:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', 05:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:25 INFO - '_': '/tools/buildbot/bin/python'} 05:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:07:25 INFO - Cleaning up... 05:07:25 INFO - Return code: 0 05:07:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042bba7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1694190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1726110>, '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 0x1692230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16926c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', '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 05:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:07:25 INFO - Using env: {'DISPLAY': ':0', 05:07:25 INFO - 'HOME': '/home/cltbld', 05:07:25 INFO - 'LANG': 'en_US.UTF-8', 05:07:25 INFO - 'LANGUAGE': 'en_US:en', 05:07:25 INFO - 'LOGNAME': 'cltbld', 05:07:25 INFO - 'MAIL': '/var/mail/cltbld', 05:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:25 INFO - 'MOZ_NO_REMOTE': '1', 05:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:25 INFO - 'NO_EM_RESTART': '1', 05:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:25 INFO - 'PWD': '/builds/slave/test', 05:07:25 INFO - 'SHELL': '/bin/bash', 05:07:25 INFO - 'SHLVL': '1', 05:07:25 INFO - 'TERM': 'linux', 05:07:25 INFO - 'TMOUT': '86400', 05:07:25 INFO - 'USER': 'cltbld', 05:07:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', 05:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:25 INFO - '_': '/tools/buildbot/bin/python'} 05:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:25 INFO - Downloading/unpacking flake8 05:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:07:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:07:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:28 INFO - no previously-included directories found matching 'docs/_build' 05:07:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:07:28 INFO - Running setup.py install for pep8 05:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:28 INFO - no previously-included directories found matching 'docs/_build' 05:07:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:07:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:07:28 INFO - Cleaning up... 05:07:28 INFO - Return code: 0 05:07:28 INFO - Running post-action listener: _resource_record_post_action 05:07:28 INFO - Running post-action listener: _start_resource_monitoring 05:07:28 INFO - Starting resource monitoring. 05:07:28 INFO - ##### 05:07:28 INFO - ##### Finished create-virtualenv step (success) 05:07:28 INFO - ##### 05:07:28 INFO - ##### 05:07:28 INFO - ##### Running install step. 05:07:28 INFO - ##### 05:07:28 INFO - Running pre-action listener: _resource_record_pre_action 05:07:28 INFO - Running main action method: install 05:07:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:28 INFO - Reading from file tmpfile_stdout 05:07:28 INFO - Detecting whether we're running mozinstall >=1.0... 05:07:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:07:28 INFO - Reading from file tmpfile_stdout 05:07:28 INFO - Output received: 05:07:28 INFO - Usage: mozinstall [options] installer 05:07:28 INFO - Options: 05:07:28 INFO - -h, --help show this help message and exit 05:07:28 INFO - -d DEST, --destination=DEST 05:07:28 INFO - Directory to install application into. [default: 05:07:28 INFO - "/builds/slave/test"] 05:07:28 INFO - --app=APP Application being installed. [default: firefox] 05:07:28 INFO - mkdir: /builds/slave/test/build/application 05:07:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:07:45 INFO - Reading from file tmpfile_stdout 05:07:45 INFO - Output received: 05:07:45 INFO - /builds/slave/test/build/application/firefox/firefox 05:07:45 INFO - Running post-action listener: _resource_record_post_action 05:07:45 INFO - ##### 05:07:45 INFO - ##### Finished install step (success) 05:07:45 INFO - ##### 05:07:45 INFO - ##### 05:07:45 INFO - ##### Running run-tests step. 05:07:45 INFO - ##### 05:07:45 INFO - Running pre-action listener: _resource_record_pre_action 05:07:45 INFO - Running main action method: run_tests 05:07:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:07:45 INFO - Python 2.7.3 05:07:45 INFO - Return code: 0 05:07:45 INFO - grabbing minidump binary from tooltool 05:07: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')]} 05:07:45 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 0x1726110>, '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 0x1692230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16926c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:07:45 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 05:07:45 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 05:07:45 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 05:07:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:07:45 INFO - Return code: 0 05:07:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:07:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:07:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:07:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:07:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:07:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:07:46 INFO - Return code: 0 05:07:46 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/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 05:07:46 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/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 05:07:46 INFO - Using env: {'DISPLAY': ':0', 05:07:46 INFO - 'HOME': '/home/cltbld', 05:07:46 INFO - 'LANG': 'en_US.UTF-8', 05:07:46 INFO - 'LANGUAGE': 'en_US:en', 05:07:46 INFO - 'LOGNAME': 'cltbld', 05:07:46 INFO - 'MAIL': '/var/mail/cltbld', 05:07:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:07:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:46 INFO - 'MOZ_NO_REMOTE': '1', 05:07:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:46 INFO - 'NO_EM_RESTART': '1', 05:07:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:46 INFO - 'PWD': '/builds/slave/test', 05:07:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:07:46 INFO - 'SHELL': '/bin/bash', 05:07:46 INFO - 'SHLVL': '1', 05:07:46 INFO - 'TERM': 'linux', 05:07:46 INFO - 'TMOUT': '86400', 05:07:46 INFO - 'USER': 'cltbld', 05:07:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551', 05:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:46 INFO - '_': '/tools/buildbot/bin/python'} 05:07:46 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/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 05:07:46 INFO - mozversion application_buildid: 20160611023005 05:07:46 INFO - mozversion application_changeset: 9694e371363590c8dace6629dc4d57f1af7206f2 05:07:46 INFO - mozversion application_display_name: Nightly 05:07:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:07:46 INFO - mozversion application_name: Firefox 05:07:46 INFO - mozversion application_remotingname: firefox 05:07:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:07:46 INFO - mozversion application_vendor: Mozilla 05:07:46 INFO - mozversion application_version: 50.0a1 05:07:46 INFO - mozversion platform_buildid: 20160611023005 05:07:46 INFO - mozversion platform_changeset: 9694e371363590c8dace6629dc4d57f1af7206f2 05:07:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:07:46 INFO - mozversion platform_version: 50.0a1 05:07:46 INFO - using testdate: 1465646866 05:07:46 INFO - actual date: 1465646866 05:07:46 INFO - starting webserver on 'localhost:35930' 05:07:46 INFO - SUITE-START | Running 2 tests 05:07:46 INFO - TEST-START | dromaeo_css 05:07:46 INFO - operating with platform_type : linux_ 05:07:46 INFO - Initialising browser for dromaeo_css test... 05:07:46 INFO - TEST-INFO | started process 25198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvs6Mr/profile http://localhost:35930/getInfo.html) 05:07:51 INFO - PROCESS | 25198 | __metrics Screen width/height:1600/1200 05:07:51 INFO - PROCESS | 25198 | colorDepth:24 05:07:51 INFO - PROCESS | 25198 | Browser inner width/height: 1024/697 05:07:51 INFO - PROCESS | 25198 | __metrics 05:07:52 ERROR - PROCESS | 25198 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:07:53 INFO - TEST-INFO | 25198: exit 0 05:07:53 INFO - Browser initialized. 05:07:53 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:53 INFO - TEST-INFO | started process 25318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvs6Mr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:05 INFO - PROCESS | 25318 | RSS: Main: 185229312 05:08:05 INFO - PROCESS | 25318 | 05:08:55 INFO - PROCESS | 25318 | 1465646935063 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] 05:11:02 INFO - PROCESS | 25318 | Cycle 1(1): loaded http://localhost:35930/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35930/tests/dromaeo/cssquery-ext.html) 05:11:03 INFO - PROCESS | 25318 | RSS: Main: 189321216 05:11:03 INFO - PROCESS | 25318 | 05:14:06 INFO - PROCESS | 25318 | Cycle 1(1): loaded http://localhost:35930/tests/dromaeo/cssquery-ext.html (next: http://localhost:35930/tests/dromaeo/cssquery-jquery.html) 05:14:06 INFO - PROCESS | 25318 | RSS: Main: 188014592 05:14:06 INFO - PROCESS | 25318 | 05:17:08 INFO - PROCESS | 25318 | Cycle 1(1): loaded http://localhost:35930/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35930/tests/dromaeo/cssquery-mootools.html) 05:17:09 INFO - PROCESS | 25318 | RSS: Main: 188928000 05:17:09 INFO - PROCESS | 25318 | 05:20:10 INFO - PROCESS | 25318 | Cycle 1(1): loaded http://localhost:35930/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35930/tests/dromaeo/cssquery-prototype.html) 05:20:11 INFO - PROCESS | 25318 | RSS: Main: 186654720 05:20:11 INFO - PROCESS | 25318 | 05:23:13 INFO - PROCESS | 25318 | Cycle 1(1): loaded http://localhost:35930/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35930/tests/dromaeo/cssquery-yui.html) 05:23:14 INFO - PROCESS | 25318 | RSS: Main: 188801024 05:23:14 INFO - PROCESS | 25318 | 05:26:17 INFO - PROCESS | 25318 | Cycle 1(1): loaded http://localhost:35930/tests/dromaeo/cssquery-yui.html (next: http://localhost:35930/tests/dromaeo/cssquery-dojo.html) 05:26:17 INFO - PROCESS | 25318 | RSS: Main: 189841408 05:26:17 INFO - PROCESS | 25318 | 05:26:17 INFO - PROCESS | 25318 | __start_tp_report 05:26:17 INFO - PROCESS | 25318 | _x_x_mozilla_page_load 05:26:17 INFO - PROCESS | 25318 | _x_x_mozilla_page_load_details 05:26:17 INFO - PROCESS | 25318 | |i|pagename|runs| 05:26:17 INFO - PROCESS | 25318 | |0;dojo.html;3104.146359751067;3124.406362791068;3129.170769746017;3130.8747650093983;3133.98433007835;5354.866128346788;5378.596605254607;5418.106012507937;5463.235147079412;5533.142362933741;5208.661437006602;5325.387580428252;5391.703456309901;5408.296921400222;5432.945670543293;4855.708657480544;4878.0487804877885;4990.6756060856105;5045.545900868921;5082.949170508285;637.238328280889;4830.227163653816;4858.17411040124;4902.166631672606;4924.138275801721;4866.732329721864;4881.951180488185;4891.16850135476;4907.730074845882;4925.556699897026;4907.582855457291;4909.337239472661;4912.091263116335;4923.556879880792;4977.527134922177;4726.4328280606205;4767.785449654774;4775.617950563947;4796.856094317176;4808.2547205183255;5241.816536421207;5287.365516138088;5300.416954135042;5305.7877684892555;5310.283111779899;5627.521660658849;5680.0627896397045;5685.658860468385;5697.6011679182475;5720.513756330717;5717.885642287172;5765.106408506688;5804.216430781833;5826.359100498942;5878.676672783038;5463.535599474049;5464.590155738296;5465.863353416156;5474.835754927359;5489.752961116759;5741.540676745851;5881.264841894763;5925.674087925119;5934.9406505934385;5943.851403714942;5662.773489060474;5720.885582288414;5743.9425605744245;5768.538516918637;5787.652740835563;5815.069588865761;5827.213326200994;5828.737706803119;5847;5847.502962248172;5556.194351818964;5706.543476521868;5712.428757124338;5775.27809023872;5801.12983052537;5756.798512052058;5808.709564521757;5828.388019257917;5834.970825145847;5845.240118784531;4374.993751437124;4424.623906967944;4431.889202769892;4434.977825110854;4439.023414848728;3840.577536470986;3859.517560304962;3864.401017842239;3895.0846551060476;3978.8010599469912;5304.257403963448;5518.144687573433;5526.530244929226;5540.639858409271;5583.860403489864;5924.140999555127;5927.851803704942;5933.643981361132;5944.494717949023;5945.10823376497;5435.402105768441;5501.202325662836;5529.4470552944385;5547.889042219133;5631.746571404296;4876.317315575822;4885.60915126789;4898.21628539432;4901.36282283308;4928.605711543068;5995.61028533144;6011.969940150271;6013.218281623361;6027.276726792813;6028.849278767978;5619.719014049363;5728.054870946247;5745.770169193185;5759.395263497272;5848.766049357978;5990.880182396415;5993.9700301498215;5996.850078748066;6002.399760023963;6012;5472.315960504937;5714.399988001366;5714.742836572281;5717.799877004285;5725.914111288417;5771.365149833431;5789.421057894346;5814.244148260699;5844.620099693677;5854.707264636836;5692;5693;5694.544436444991;5707.6575405475805;5724.599278050497;5450.209719590558;5626.521745651666;5644.88710225785;5698.658080515016;5701.885962280814;5580.21876937221;5583.8883222336135;5604.215409842707;5647.661140331593;5686.60193786431;5666.46168613981;5676.545876329801;5725.255716756795;5773.451522105393;5779.162021506774;5375.408705042364;5532.059549876451;5547.44525547442;5621.606487545832;5643.548516118619 05:26:17 INFO - PROCESS | 25318 | |1;ext.html;578.4215784215784;620.8851362497938;622.1290193728777;633.3349982518355;641.9358064193581;38684.22631547371;42141.3678794818;42188.78905605475;42235.78882105589;42465;42468.575314246846;43126;43138;43256.78371608145;43272.567274327244;8813.471191728484;8820.426672266281;8910;8965.058668839776;9003.279737620975;8829.955850220773;8914.108589141066;8939.508327042011;8941.552922353889;8944.552772361356;8903.510306933116;8931.64273429062;8963.372563920528;8976.59605317759;8979.102089791002;8872.245859101984;8897.911020889773;8942.73171804847;8964.910350896538;8975.640974361018;8863.822723545558;8917.866232006525;8947.32895032875;8960.46237225762;8968.282537396992;40871.79564102161;41132.38301425481;41149.38275925864;41247.587524124974;41252;2834.588984597222;3305.4876494143446;3322.5680661513848;3356.3622911646708;3384.272381437978;30884.691153088406;31034.689653103407;31144.688553114633;31263.218419539466;32455.188620284447;4144.896377590554;4167.395727619509;4224.704270701052;4265.9786701066605;4297.35539669049;301253;301415;302263;302344;302891;35871.28257434837;35907;35990;36038.099047524025;36051.278974420886;35752.106197345274;35853;36123.09692257662;37527.62472375296;37566.24867502635;15243.23783810805;15339.156346400832;15388.769168462259;15415.61460963485;15487.845121548866;11993.64019079429;12087.093467989936;12093.516259349528;12102.576409825613;12182.208156469802;19365.020701503894;19453.221871124995;19517;19549.51126221856;19620.70568941467;7116.932460131022;7123.394511466583;7153.89269160963;7184.353408193288;7403.296686814744;952.8189643967625;1019.5717798524489;1020.9438480883474;1112.6439539347493;1167.4688016952437;33013.50479742806;33261.667383325854;33265.66734332674;33364.16589585231;33868.32263354769;1084.512367420853;1121.332806979862;1131.4399372310759;1196.1806162778526;1222.0956492195712;17202.741958870625;17371.218295176746;17544.385946491813;17579.384721534683;17594.38419655306;571344;573022;573866;578468;580103;59262.70368648129;60056;60135.097973530435;60198.699006504685;60227.193184204545;1262.9881762809096;1273.3124112978887;1348.265195468472;1354.6410201296665;1355.6543081514349;30972.0708378749;32124.19689507781;32738.345233095682;32942.34115317728;32944.51749671318;50731;50839;51287;51336;51435.228471572205;463409;466726;468713;468921;470479;28319.29201769972;28461.715382845905;28795.28011799722;28812.279693007844;28844.134675959755;49334.02663893404;49819.25271120864;50221.24668129908;50503;50605.49394506008;40738;42085;42333;43196;43265.567344326155;41586;42342;42495.57504424916;42545.78727106345;42863.3570496449;42285;42560;44549.55450445454;45492.545074548834;45536.54463455323;38862.93688184069;44063.11873762571;45204.77397612991;45803.08393832171;45962.31056534088;34262.65737342694;34875;34998.47502287519;35324.293514130084;35356.823215883756 05:26:17 INFO - PROCESS | 25318 | |2;jquery.html;392.51720383927784;396.1206122408256;396.36383604315074;399.4308110941908;418.878525227684;13301.201927884335;17877.195526201318;18061.548461288443;18646.720299195506;18711.251549938002;17682.292708291654;18041.90979045103;18369.54076148097;18640.347587834396;18823.058847057662;5089.3638295213095;5528.806491772779;5686.601937864351;5708.828735137952;5736;5539.833804985837;5567.582431317647;5582.637128586649;5597.776088956437;5608.327000759894;5312.973435132819;5488.313960754906;5523.530499907512;5629.3526244482;5629.577781666371;5603.495685388335;5604.411536788619;5618.690971996539;5627.6904770237625;5637.887242255152;4861.781219845116;4991.351124353847;5004.949950500485;5052.242163675442;5065.39215294167;21049;21916.780832191635;22174.334769956928;22205.888970555206;22246.332610021724;2255.729312482513;2661.8003649726347;2673.278214881971;2743.0947787230166;2777.3334399744117;14100.788488172686;14307.928460357736;14490.275486225646;14525.346359413852;14846.480373186887;1870.1303893689499;2000.4266783093547;2004.468815763809;2004.859659823813;2019.6061767955255;71227;72545.82362529132;72774;73696.26303737001;74052.99999999946;9374.296927730311;9751.90248097524;10518.526666300035;10523.421211833424;10565.524551395052;14354.856451435351;14407.135571865721;14437.566872993826;14446.855531444551;14463.855361446462;7745.496542724705;7763.262490063435;7782.688692452239;7906.802329941797;7947.801304967422;7493;7586.393088552903;7727.304542591194;7746.109197442366;7749.7287594933905;6386.137871387304;6432.774852880127;6454.774082907075;6484.351564843478;6574;1868.3834334669527;1892.7917929027797;1918.4820098573307;1936.0803618281204;1948.2499237793268;932.2635118256501;981.8969008254173;989.3717489394287;1022.4683164754434;1072.672834785398;19185.32851350196;19242.518937026685;19792.50518737014;19799.30702425408;19877.503062423264;1025.195221750922;1037.0296436770197;1062.5749700120014;1063.8457423673678;1089.716673664837;10653.9467302663;11147.498362573704;11195.104391648649;11303.604373846876;11321.830172547418;469415;539365;567505;568194;575170.2414879239;80155.59922200351;94588.52705736565;97770.5111474438;100206.69492327345;100631;987.1362557761959;997.491279447487;1013.8124446977333;1023.65195833417;1024.390487659856;15756.68486630284;16144.434944776876;16286.104264265105;16335.101569413797;16723.080230587435;40983.79508102441;40989.79505102456;41205;41896.162076758905;42309.36535952025;53046;53645.73177134089;56902.71548642396;59542;63362.683186583774;7105.538140020882;7350.301721336678;7757.534547927143;7799.6100194988885;8008.439409241297;12152;12709;12913.806292905427;13042.478300867859;13172;6624.8343791405605;10024.298299119284;11368.261063030877;11616.535338586362;11658.18392712502;10934.234603577674;11282.774344513227;11480.383679141043;11841.111916606116;11912.821307680219;10801.891981080089;11606.941965290458;11830;11904.940475297915;11952;7157.821054473679;7332.266773322625;7393.778186654409;7406.629668516445;7681.8463630725955;10629.787404251718;11734.94132529332;11770.117241206772;11821.290722556674;11895.46470408851 05:26:17 INFO - PROCESS | 25318 | |3;mootools.html;1440.848710885357;1455.3087283540317;1597.5846279967204;1744.8080711121765;1756.5432987423274;7626.31363177314;8486.957565212173;8521.36089793265;9042.367034307601;9054.637814487422;8585.527795971218;8770.122987701227;8920.420172688771;8942.463452192856;8953.104689531043;2047.8976051197455;2069.8965051747427;2077.3767869639123;2078.833693304532;2081.354780018199;2144.406631241669;2150.892455377225;2182.8581142225785;2193.7915897989665;2195.034184958621;2158.4927542027613;2158.9784102158933;2165.7834216578294;2171.7176767020264;2218.0794970087395;2099.338708306886;2105.536781907978;2109.599176156533;2112.5563631637374;2115.3548167808813;2100.222917520512;2135.7970992755663;2157;2162.7945345192184;2172.728408948881;8839.425437346552;8916.955415222947;8919.286457083417;8920.910790892072;8934.86597701035;4847.321375007502;4944.505549445063;4971.105201063807;5013.147764879979;5015.874603134915;3101.65881753007;3162.826044567548;3325.9168520786934;3326.9168270793425;3329.467285234375;1050.6532844161484;1073.1629329123296;1084.4035780320871;1094.8576685030896;1102.735343517558;12133.93933030338;12204.633860984184;12209.511619535208;12213.511459541696;12234.571789987396;4198.790060497024;4206.137741762931;4285.785710714452;4328;4333.43665323506;9609.423434593948;9646.951765241269;9711.174550163316;9713.854292185622;9718.416894986323;4950.975245123751;4951.306817045616;4951.72765497901;4952.8761780955765;4958.628102892298;4013.7391069580967;4364.60718535327;4451.154280686659;4581.862544123682;4650.697704649187;3619.696909112717;3622.42041273395;3714.7028237741456;3775.867844625425;3812.218495208476;1074.4949873559415;1086.5490821309227;1090.2041509697965;1094.6114129484079;1098.549594666199;875.7110153649407;891.772597987509;987.2694206287439;998.3444038856751;1007.5919252702668;5923.792667256712;5930.229070220844;5938.376470470625;6007.939920600738;6111.266648002179;356.81623963658734;365.34238370932746;372.4562139276632;373.395099938102;375.06982682946443;4141.503019637663;4265.402843601898;4316.870493885189;4343.500497442771;4347.804348804311;10652.30760000613;11036.172287078341;11135.443227838576;11142.941420565034;11166.553337866395;10917.454127293604;11005.834912476319;11068.391238481961;11069.335839849635;11074.667759967213;7833.1775163608145;8008.7597372078935;8028.197180281925;8277.54473503963;8339.041010283774;5820.650760954356;6038.788642397495;6062;6215.502759779117;6234.688265586612;10074.345167564084;10113.342632728849;10117.140043096419;10231.28381013322;10301.072903438726;10125.493725313852;10279.743006424898;10364.326318789255;10432.530536126045;10434.739131521772;7194.928050719635;7713.807154821175;7728.574928378768;7914.564698941614;8210.876836847332;8200.05699344559;8471.449355791854;8493.278071364004;8528.829423411373;8549.102344253764;7484.363829074589;7652.65563049653;7676.731314403969;7775.261350171724;7797.376209903081;7471.850562988819;7487.513311634726;7583.165851756192;7647.273509016634;7664.271894170045;7060.152781666233;7128.465365097535;7131.465140114408;7143.964280178566;7163.0329905462095;4949.876253093557;5178.32681751385;5230.8169214077325;5411.512963833274;5436.293281873332;5230.686158830483;5282.418933917189;5345.839624811262;5370.785168593213;5395.649282796762 05:26:17 INFO - PROCESS | 25318 | |4;prototype.html;324.41281280881606;325.75893838559466;325.9217787730944;331.99571296827094;334.12292731579606;5644.887102257952;5652.576056795741;5671.234383358245;5677.098172112347;5734.913976290359;5629.662220266777;5636.774529018845;5643.915341269874;5670.327253460229;5679.57403194761;4117.794110294488;4214.452121224252;4321.28698764705;4332.675049371294;4365.192439398706;4388.210122178007;4389.31965545341;4393.824247030115;4394.011347446831;4411.228035093845;4288.541895755443;4321.848735294266;4339.522652508222;4340.240457919867;4354.54277300882;4238.512571054322;4269.3595960606;4351.325544540601;4354.107407981356;4361.956380436187;3830.0999265172663;3842.5773164951834;3843.0968722350226;3853.421986701989;3856.2287542491335;5445.918311225335;5450.509454149145;5490.368607610096;5491.7254137292975;5492.752826122794;4883.633727470454;4981.402231732215;4988.127077761377;5002.549770520634;5010.3737032870895;5877.9118313225335;5885.823425297248;5899.852503687399;5926.466618004357;5930.7034648267845;4191.580841915815;4216.388623649554;4227.513835908879;4232.788360581959;4242.024334403104;5983.6110652807865;6073.665948372838;6101.389861013908;6108.633481991051;6129.724162412702;4323.913521729548;4324.8159679361725;4332.761698106634;4358.259095953696;4358.4769827620885;4367.213901497697;4380.671449641226;4381.890452738643;4391.538888416734;4399.6040356368085;4864.80540778372;4898.632602554822;4900.607951363882;4946.406431228275;4952.950470495249;5871.236739223959;5894.498967587803;5905.704714764244;5910.60620448719;5941.970290148522;1478.4012474947663;1483.5697647682052;1491.4183468447313;1498.9625259368604;1499.635331848013;925.1396201532639;939.534930209537;960.1166926427703;978.1685567267765;986.7089208683456;5487.75305111271;5518.972405137949;5560.749766260528;5585.972070139624;5645;5960.509872531867;6000.039993601003;6008.639481631116;6016.819495415145;6025.246844144482;5409.594280428905;5662.8301150965535;5663.433656634386;5679.261695979496;5700.230468886647;3218.8712451502147;3224.8068214760688;3251.64231934487;3259.7066264036353;3276.6887145721116;5986.580939334205;6180.690965451709;6213.65824879627;6245.781397651152;6301.275353334425;6269.341719119427;6280.748770049238;6283.874322513524;6292.150559674477;6346.524010699216;6194.442500174916;6324.9051264231075;6401.679916004181;6407.231132264158;6408.519361047846;6166.1983942087245;6182.258129024546;6204.472619827366;6223.439890409703;6231.594946328474;6177.84555386119;6212.285587157535;6221.657808820558;6224.4168670003255;6245.5628106032145;5977.953858074732;6225.564210505221;6234.220722409699;6257.904866648228;6423.646699431576;4175.728577642443;4175.958240417678;4190.392393102922;4197.727147735387;4218.578142185757;5944.5838791284195;6164.4143806338325;6173.38266173397;6186.628802271878;6197.318294987638;5971.880562388641;5985.970070149621;5992.790252341147;6014.346054834956;6033.818985430444;5983.311919129356;5996.88006239864;6002.579819412599;6018.699065046642;6031.823794360058;5689.146628005667;5776.931267715318;5803.825885223281;5835.474807267196;5903.291605007426;5934.554908381802;5963.671998040149;5970.984932561388;5992;6086.6348019119;5680.4319568042865;5681.137020028673;5740.167675687086;5843.152742852348;5880 05:26:17 INFO - PROCESS | 25318 | |5;yui.html;732.721565804994;741.8850078237875;764.8317370178559;792.414325178567;848.3467729848018;13499.122557033787;15004.249787510622;15287.312070956807;15313.0812151271;15331.233438328067;14616.269186540683;15128.16795076273;15851.682966340666;15951;16494.83505164948;675.1155985658778;788.9723859664913;808.3896658023184;818.4843548564396;819.8442295963778;801.6152246921481;802.7912742686914;802.8755542890862;806.891069705591;807.6204184033495;844.5734903873566;848.1349023995521;848.4485084694936;848.4485084694967;849.9490030598184;846.4540371460404;846.6105591427951;846.9618867150994;848.4485084694936;850.2093053460279;615.5814046448413;616.824205101544;617.5491890919653;618.2827919613272;619.0343064818896;14234.715305693931;14303.570892873231;14345.211013394259;14440;14490.92754536231;14358.353874075587;14515.346809393603;14558.636034099127;14606.12363258208;14837.703245935021;12309.506935806045;12403.62789116328;12516.18644788095;12534.81197782034;12717.554885579053;3919.6668283195963;3957.208558288325;4031.637152656275;4090.8568200112854;4128.958710412888;85523;85731.99999999937;86049.56975215147;86296.56851715763;86723;10617.362958222531;10812.67561973142;11139.498722557504;11219;11345.205835591429;20011.699824502644;20181.798182017992;20188.192472301238;20214.191432342835;20250.291239806535;8221.136780637948;8609.741707748777;8824.294056475595;8825.205731484197;8847.778805529913;4805.111054454867;4852.636052296092;4869.70781753096;4876.4879687633;5073.416557095981;3527.753057286017;3656.469811877263;3662.560492740888;3678.282734866729;3679.963200368016;583.2942140010634;586.61576667283;593.9227900373011;596.1832289763053;611.944924956756;607.7604029152587;625.562106525434;701.3792793377795;765.261522630653;766.9041369828772;10450.964937067112;10467;10479.266451348332;10506.159507239403;10624.521896514676;725.4051677624403;733.6405161470948;736.948413611042;743.5390058163973;758.1395116542764;4729.881752956135;4838.758062096881;4878.853634390974;4942.827001054946;4965.329680493087;124015;126028;126294.94820207273;127079;127628.36185819011;107244.46377768218;108539;110735.44632276786;111254;113597;97754.51122744483;100425;100869;101210;101810;9117.544122793966;9384.859227111463;9393.060693930553;9454.574544145393;9463;45783;56688;57531.712341438026;57676;58215.417845822696;56650.43349566452;82462.17537824785;83542;83803.16196838197;84312.57843710743;11590.652280431601;11667.59163429276;11905.761884762083;12362.38188090574;12565.18326308787;13780.793288100887;13833.515826946008;13914.582562523141;14044.929775351058;14803.333849976992;12571.245725256515;12777.16948398351;13108.617960638323;13564.932175339454;13742.244176570384;13152.736945261233;13213.14114582549;13486.1599829751;13661.112027718564;14029.438822447397;12317.199382040139;13212.207267563592;13296;13524;13604;10937.45312734376;11274.323540587591;11426.714332141762;11507.194496385173;12203.816942746043;11894.643160705193;11998.160128790902;12221.144519883523;12642.55751048709;12684.87315126874 05:26:17 INFO - PROCESS | 25318 | __end_tp_report 05:26:17 INFO - PROCESS | 25318 | __start_cc_report 05:26:17 INFO - PROCESS | 25318 | _x_x_mozilla_cycle_collect,360 05:26:17 INFO - PROCESS | 25318 | __end_cc_report 05:26:17 INFO - PROCESS | 25318 | __startTimestamp1465647977730__endTimestamp 05:26:17 INFO - PROCESS | 25318 | 05:26:17 INFO - PROCESS | 25318 | ------- Summary: start ------- 05:26:17 INFO - PROCESS | 25318 | Number of tests: 6 05:26:17 INFO - PROCESS | 25318 | 05:26:17 INFO - PROCESS | 25318 | [#0] dojo.html Cycles:165 Average:5343.82 Median:5619.72 stddev:725.57 (12.9%) stddev-sans-first:706.20 05:26:17 INFO - PROCESS | 25318 | Values: 3104.1 3124.4 3129.2 3130.9 3134.0 5354.9 5378.6 5418.1 5463.2 5533.1 5208.7 5325.4 5391.7 5408.3 5432.9 4855.7 4878.0 4990.7 5045.5 5082.9 637.2 4830.2 4858.2 4902.2 4924.1 4866.7 4882.0 4891.2 4907.7 4925.6 4907.6 4909.3 4912.1 4923.6 4977.5 4726.4 4767.8 4775.6 4796.9 4808.3 5241.8 5287.4 5300.4 5305.8 5310.3 5627.5 5680.1 5685.7 5697.6 5720.5 5717.9 5765.1 5804.2 5826.4 5878.7 5463.5 5464.6 5465.9 5474.8 5489.8 5741.5 5881.3 5925.7 5934.9 5943.9 5662.8 5720.9 5743.9 5768.5 5787.7 5815.1 5827.2 5828.7 5847.0 5847.5 5556.2 5706.5 5712.4 5775.3 5801.1 5756.8 5808.7 5828.4 5835.0 5845.2 4375.0 4424.6 4431.9 4435.0 4439.0 3840.6 3859.5 3864.4 3895.1 3978.8 5304.3 5518.1 5526.5 5540.6 5583.9 5924.1 5927.9 5933.6 5944.5 5945.1 5435.4 5501.2 5529.4 5547.9 5631.7 4876.3 4885.6 4898.2 4901.4 4928.6 5995.6 6012.0 6013.2 6027.3 6028.8 5619.7 5728.1 5745.8 5759.4 5848.8 5990.9 5994.0 5996.9 6002.4 6012.0 5472.3 5714.4 5714.7 5717.8 5725.9 5771.4 5789.4 5814.2 5844.6 5854.7 5692.0 5693.0 5694.5 5707.7 5724.6 5450.2 5626.5 5644.9 5698.7 5701.9 5580.2 5583.9 5604.2 5647.7 5686.6 5666.5 5676.5 5725.3 5773.5 5779.2 5375.4 5532.1 5547.4 5621.6 5643.5 05:26:17 INFO - PROCESS | 25318 | 05:26:17 INFO - PROCESS | 25318 | [#1] ext.html Cycles:180 Average:60160.56 Median:42113.18 stddev:122988.81 (292.0%) stddev-sans-first:123252.46 05:26:17 INFO - PROCESS | 25318 | Values: 578.4 620.9 622.1 633.3 641.9 38684.2 42141.4 42188.8 42235.8 42465.0 42468.6 43126.0 43138.0 43256.8 43272.6 8813.5 8820.4 8910.0 8965.1 9003.3 8830.0 8914.1 8939.5 8941.6 8944.6 8903.5 8931.6 8963.4 8976.6 8979.1 8872.2 8897.9 8942.7 8964.9 8975.6 8863.8 8917.9 8947.3 8960.5 8968.3 40871.8 41132.4 41149.4 41247.6 41252.0 2834.6 3305.5 3322.6 3356.4 3384.3 30884.7 31034.7 31144.7 31263.2 32455.2 4144.9 4167.4 4224.7 4266.0 4297.4 301253.0 301415.0 302263.0 302344.0 302891.0 35871.3 35907.0 35990.0 36038.1 36051.3 35752.1 35853.0 36123.1 37527.6 37566.2 15243.2 15339.2 15388.8 15415.6 15487.8 11993.6 12087.1 12093.5 12102.6 12182.2 19365.0 19453.2 19517.0 19549.5 19620.7 7116.9 7123.4 7153.9 7184.4 7403.3 952.8 1019.6 1020.9 1112.6 1167.5 33013.5 33261.7 33265.7 33364.2 33868.3 1084.5 1121.3 1131.4 1196.2 1222.1 17202.7 17371.2 17544.4 17579.4 17594.4 571344.0 573022.0 573866.0 578468.0 580103.0 59262.7 60056.0 60135.1 60198.7 60227.2 1263.0 1273.3 1348.3 1354.6 1355.7 30972.1 32124.2 32738.3 32942.3 32944.5 50731.0 50839.0 51287.0 51336.0 51435.2 463409.0 466726.0 468713.0 468921.0 470479.0 28319.3 28461.7 28795.3 28812.3 28844.1 49334.0 49819.3 50221.2 50503.0 50605.5 40738.0 42085.0 42333.0 43196.0 43265.6 41586.0 42342.0 42495.6 42545.8 42863.4 42285.0 42560.0 44549.6 45492.5 45536.5 38862.9 44063.1 45204.8 45803.1 45962.3 34262.7 34875.0 34998.5 35324.3 35356.8 05:26:17 INFO - PROCESS | 25318 | 05:26:17 INFO - PROCESS | 25318 | [#2] jquery.html Cycles:180 Average:30158.12 Median:2667.54 stddev:89619.16 (3359.6%) stddev-sans-first:89842.69 05:26:17 INFO - PROCESS | 25318 | Values: 392.5 396.1 396.4 399.4 418.9 13301.2 17877.2 18061.5 18646.7 18711.3 17682.3 18041.9 18369.5 18640.3 18823.1 5089.4 5528.8 5686.6 5708.8 5736.0 5539.8 5567.6 5582.6 5597.8 5608.3 5313.0 5488.3 5523.5 5629.4 5629.6 5603.5 5604.4 5618.7 5627.7 5637.9 4861.8 4991.4 5004.9 5052.2 5065.4 21049.0 21916.8 22174.3 22205.9 22246.3 2255.7 2661.8 2673.3 2743.1 2777.3 14100.8 14307.9 14490.3 14525.3 14846.5 1870.1 2000.4 2004.5 2004.9 2019.6 71227.0 72545.8 72774.0 73696.3 74053.0 9374.3 9751.9 10518.5 10523.4 10565.5 14354.9 14407.1 14437.6 14446.9 14463.9 7745.5 7763.3 7782.7 7906.8 7947.8 7493.0 7586.4 7727.3 7746.1 7749.7 6386.1 6432.8 6454.8 6484.4 6574.0 1868.4 1892.8 1918.5 1936.1 1948.2 932.3 981.9 989.4 1022.5 1072.7 19185.3 19242.5 19792.5 19799.3 19877.5 1025.2 1037.0 1062.6 1063.8 1089.7 10653.9 11147.5 11195.1 11303.6 11321.8 469415.0 539365.0 567505.0 568194.0 575170.2 80155.6 94588.5 97770.5 100206.7 100631.0 987.1 997.5 1013.8 1023.7 1024.4 15756.7 16144.4 16286.1 16335.1 16723.1 40983.8 40989.8 41205.0 41896.2 42309.4 53046.0 53645.7 56902.7 59542.0 63362.7 7105.5 7350.3 7757.5 7799.6 8008.4 12152.0 12709.0 12913.8 13042.5 13172.0 6624.8 10024.3 11368.3 11616.5 11658.2 10934.2 11282.8 11480.4 11841.1 11912.8 10801.9 11606.9 11830.0 11904.9 11952.0 7157.8 7332.3 7393.8 7406.6 7681.8 10629.8 11734.9 11770.1 11821.3 11895.5 05:26:17 INFO - PROCESS | 25318 | 05:26:17 INFO - PROCESS | 25318 | [#3] mootools.html Cycles:180 Average:5711.35 Median:4345.65 stddev:3356.66 (77.2%) stddev-sans-first:3350.74 05:26:17 INFO - PROCESS | 25318 | Values: 1440.8 1455.3 1597.6 1744.8 1756.5 7626.3 8487.0 8521.4 9042.4 9054.6 8585.5 8770.1 8920.4 8942.5 8953.1 2047.9 2069.9 2077.4 2078.8 2081.4 2144.4 2150.9 2182.9 2193.8 2195.0 2158.5 2159.0 2165.8 2171.7 2218.1 2099.3 2105.5 2109.6 2112.6 2115.4 2100.2 2135.8 2157.0 2162.8 2172.7 8839.4 8917.0 8919.3 8920.9 8934.9 4847.3 4944.5 4971.1 5013.1 5015.9 3101.7 3162.8 3325.9 3326.9 3329.5 1050.7 1073.2 1084.4 1094.9 1102.7 12133.9 12204.6 12209.5 12213.5 12234.6 4198.8 4206.1 4285.8 4328.0 4333.4 9609.4 9647.0 9711.2 9713.9 9718.4 4951.0 4951.3 4951.7 4952.9 4958.6 4013.7 4364.6 4451.2 4581.9 4650.7 3619.7 3622.4 3714.7 3775.9 3812.2 1074.5 1086.5 1090.2 1094.6 1098.5 875.7 891.8 987.3 998.3 1007.6 5923.8 5930.2 5938.4 6007.9 6111.3 356.8 365.3 372.5 373.4 375.1 4141.5 4265.4 4316.9 4343.5 4347.8 10652.3 11036.2 11135.4 11142.9 11166.6 10917.5 11005.8 11068.4 11069.3 11074.7 7833.2 8008.8 8028.2 8277.5 8339.0 5820.7 6038.8 6062.0 6215.5 6234.7 10074.3 10113.3 10117.1 10231.3 10301.1 10125.5 10279.7 10364.3 10432.5 10434.7 7194.9 7713.8 7728.6 7914.6 8210.9 8200.1 8471.4 8493.3 8528.8 8549.1 7484.4 7652.7 7676.7 7775.3 7797.4 7471.9 7487.5 7583.2 7647.3 7664.3 7060.2 7128.5 7131.5 7144.0 7163.0 4949.9 5178.3 5230.8 5411.5 5436.3 5230.7 5282.4 5345.8 5370.8 5395.6 05:26:17 INFO - PROCESS | 25318 | 05:26:17 INFO - PROCESS | 25318 | [#4] prototype.html Cycles:180 Average:4978.95 Median:5678.18 stddev:1488.42 (26.2%) stddev-sans-first:1451.02 05:26:17 INFO - PROCESS | 25318 | Values: 324.4 325.8 325.9 332.0 334.1 5644.9 5652.6 5671.2 5677.1 5734.9 5629.7 5636.8 5643.9 5670.3 5679.6 4117.8 4214.5 4321.3 4332.7 4365.2 4388.2 4389.3 4393.8 4394.0 4411.2 4288.5 4321.8 4339.5 4340.2 4354.5 4238.5 4269.4 4351.3 4354.1 4362.0 3830.1 3842.6 3843.1 3853.4 3856.2 5445.9 5450.5 5490.4 5491.7 5492.8 4883.6 4981.4 4988.1 5002.5 5010.4 5877.9 5885.8 5899.9 5926.5 5930.7 4191.6 4216.4 4227.5 4232.8 4242.0 5983.6 6073.7 6101.4 6108.6 6129.7 4323.9 4324.8 4332.8 4358.3 4358.5 4367.2 4380.7 4381.9 4391.5 4399.6 4864.8 4898.6 4900.6 4946.4 4953.0 5871.2 5894.5 5905.7 5910.6 5942.0 1478.4 1483.6 1491.4 1499.0 1499.6 925.1 939.5 960.1 978.2 986.7 5487.8 5519.0 5560.7 5586.0 5645.0 5960.5 6000.0 6008.6 6016.8 6025.2 5409.6 5662.8 5663.4 5679.3 5700.2 3218.9 3224.8 3251.6 3259.7 3276.7 5986.6 6180.7 6213.7 6245.8 6301.3 6269.3 6280.7 6283.9 6292.2 6346.5 6194.4 6324.9 6401.7 6407.2 6408.5 6166.2 6182.3 6204.5 6223.4 6231.6 6177.8 6212.3 6221.7 6224.4 6245.6 5978.0 6225.6 6234.2 6257.9 6423.6 4175.7 4176.0 4190.4 4197.7 4218.6 5944.6 6164.4 6173.4 6186.6 6197.3 5971.9 5986.0 5992.8 6014.3 6033.8 5983.3 5996.9 6002.6 6018.7 6031.8 5689.1 5776.9 5803.8 5835.5 5903.3 5934.6 5963.7 5971.0 5992.0 6086.6 5680.4 5681.1 5740.2 5843.2 5880.0 05:26:17 INFO - PROCESS | 25318 | 05:26:17 INFO - PROCESS | 25318 | [#5] yui.html Cycles:180 Average:22272.06 Median:3659.52 stddev:33468.83 (914.6%) stddev-sans-first:33523.64 05:26:17 INFO - PROCESS | 25318 | Values: 732.7 741.9 764.8 792.4 848.3 13499.1 15004.2 15287.3 15313.1 15331.2 14616.3 15128.2 15851.7 15951.0 16494.8 675.1 789.0 808.4 818.5 819.8 801.6 802.8 802.9 806.9 807.6 844.6 848.1 848.4 848.4 849.9 846.5 846.6 847.0 848.4 850.2 615.6 616.8 617.5 618.3 619.0 14234.7 14303.6 14345.2 14440.0 14490.9 14358.4 14515.3 14558.6 14606.1 14837.7 12309.5 12403.6 12516.2 12534.8 12717.6 3919.7 3957.2 4031.6 4090.9 4129.0 85523.0 85732.0 86049.6 86296.6 86723.0 10617.4 10812.7 11139.5 11219.0 11345.2 20011.7 20181.8 20188.2 20214.2 20250.3 8221.1 8609.7 8824.3 8825.2 8847.8 4805.1 4852.6 4869.7 4876.5 5073.4 3527.8 3656.5 3662.6 3678.3 3680.0 583.3 586.6 593.9 596.2 611.9 607.8 625.6 701.4 765.3 766.9 10451.0 10467.0 10479.3 10506.2 10624.5 725.4 733.6 736.9 743.5 758.1 4729.9 4838.8 4878.9 4942.8 4965.3 124015.0 126028.0 126294.9 127079.0 127628.4 107244.5 108539.0 110735.4 111254.0 113597.0 97754.5 100425.0 100869.0 101210.0 101810.0 9117.5 9384.9 9393.1 9454.6 9463.0 45783.0 56688.0 57531.7 57676.0 58215.4 56650.4 82462.2 83542.0 83803.2 84312.6 11590.7 11667.6 11905.8 12362.4 12565.2 13780.8 13833.5 13914.6 14044.9 14803.3 12571.2 12777.2 13108.6 13564.9 13742.2 13152.7 13213.1 13486.2 13661.1 14029.4 12317.2 13212.2 13296.0 13524.0 13604.0 10937.5 11274.3 11426.7 11507.2 12203.8 11894.6 11998.2 12221.1 12642.6 12684.9 05:26:17 INFO - PROCESS | 25318 | -------- Summary: end -------- 05:26:17 INFO - PROCESS | 25318 | 05:26:18 INFO - TEST-INFO | 25318: exit 0 05:26:18 INFO - TEST-OK | dromaeo_css | took 1111673ms 05:26:18 INFO - TEST-START | kraken 05:26:18 INFO - operating with platform_type : linux_ 05:26:18 INFO - Initialising browser for kraken test... 05:26:18 INFO - TEST-INFO | started process 25558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp25ZRvh/profile http://localhost:35930/getInfo.html) 05:26:23 INFO - PROCESS | 25558 | __metrics Screen width/height:1600/1200 05:26:23 INFO - PROCESS | 25558 | colorDepth:24 05:26:23 INFO - PROCESS | 25558 | Browser inner width/height: 1024/697 05:26:23 INFO - PROCESS | 25558 | __metrics 05:26:24 ERROR - PROCESS | 25558 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:26:25 INFO - TEST-INFO | 25558: exit 0 05:26:25 INFO - Browser initialized. 05:26:25 INFO - Running cycle 1/1 for kraken test... 05:26:25 INFO - TEST-INFO | started process 25678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp25ZRvh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:37 INFO - PROCESS | 25678 | RSS: Main: 184672256 05:26:37 INFO - PROCESS | 25678 | 05:26:39 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35930/tests/kraken/driver.html?testName=audio-beat-detection) 05:26:40 INFO - PROCESS | 25678 | RSS: Main: 190095360 05:26:40 INFO - PROCESS | 25678 | 05:26:43 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35930/tests/kraken/driver.html?testName=audio-dft) 05:26:44 INFO - PROCESS | 25678 | RSS: Main: 189775872 05:26:44 INFO - PROCESS | 25678 | 05:26:46 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35930/tests/kraken/driver.html?testName=audio-fft) 05:26:47 INFO - PROCESS | 25678 | RSS: Main: 185401344 05:26:47 INFO - PROCESS | 25678 | 05:26:49 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35930/tests/kraken/driver.html?testName=audio-oscillator) 05:26:50 INFO - PROCESS | 25678 | RSS: Main: 185827328 05:26:50 INFO - PROCESS | 25678 | 05:26:52 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35930/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:53 INFO - PROCESS | 25678 | RSS: Main: 186118144 05:26:53 INFO - PROCESS | 25678 | 05:26:56 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35930/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:56 INFO - PROCESS | 25678 | RSS: Main: 186355712 05:26:56 INFO - PROCESS | 25678 | 05:27:00 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35930/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:01 INFO - PROCESS | 25678 | RSS: Main: 183226368 05:27:01 INFO - PROCESS | 25678 | 05:27:03 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35930/tests/kraken/driver.html?testName=json-parse-financial) 05:27:04 INFO - PROCESS | 25678 | RSS: Main: 184635392 05:27:04 INFO - PROCESS | 25678 | 05:27:06 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35930/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:06 INFO - PROCESS | 25678 | RSS: Main: 185585664 05:27:06 INFO - PROCESS | 25678 | 05:27:08 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35930/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:09 INFO - PROCESS | 25678 | RSS: Main: 185450496 05:27:09 INFO - PROCESS | 25678 | 05:27:11 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35930/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:11 INFO - PROCESS | 25678 | RSS: Main: 185913344 05:27:11 INFO - PROCESS | 25678 | 05:27:14 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35930/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:27:15 INFO - PROCESS | 25678 | RSS: Main: 186241024 05:27:15 INFO - PROCESS | 25678 | 05:27:17 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35930/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:18 INFO - PROCESS | 25678 | RSS: Main: 185921536 05:27:18 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | Cycle 1(1): loaded http://localhost:35930/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35930/tests/kraken/driver.html?testName=ai-astar) 05:27:20 INFO - PROCESS | 25678 | RSS: Main: 187314176 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | __start_tp_report 05:27:20 INFO - PROCESS | 25678 | _x_x_mozilla_page_load 05:27:20 INFO - PROCESS | 25678 | _x_x_mozilla_page_load_details 05:27:20 INFO - PROCESS | 25678 | |i|pagename|runs| 05:27:20 INFO - PROCESS | 25678 | |0;ai-astar;113;108;114;112;112;114;113;112;114;113 05:27:20 INFO - PROCESS | 25678 | |1;audio-beat-detection;150;129;152;179;127;152;152;135;188;127 05:27:20 INFO - PROCESS | 25678 | |2;audio-dft;162;162;162;162;164;172;163;164;163;163 05:27:20 INFO - PROCESS | 25678 | |3;audio-fft;75;75;75;158;76;76;76;74;170;75 05:27:20 INFO - PROCESS | 25678 | |4;audio-oscillator;86;85;137;86;85;85;138;85;86;144 05:27:20 INFO - PROCESS | 25678 | |5;imaging-gaussian-blur;117;118;118;118;118;118;120;119;118;118 05:27:20 INFO - PROCESS | 25678 | |6;imaging-darkroom;150;147;147;149;146;148;148;147;148;146 05:27:20 INFO - PROCESS | 25678 | |7;imaging-desaturate;101;96;96;97;96;96;95;97;96;95 05:27:20 INFO - PROCESS | 25678 | |8;json-parse-financial;56;54;57;53;56;58;55;55;57;55 05:27:20 INFO - PROCESS | 25678 | |9;json-stringify-tinderbox;64;63;65;64;63;63;63;62;63;63 05:27:20 INFO - PROCESS | 25678 | |10;stanford-crypto-aes;79;81;81;81;81;86;81;80;110;80 05:27:20 INFO - PROCESS | 25678 | |11;stanford-crypto-ccm;127;127;123;123;121;131;132;135;125;136 05:27:20 INFO - PROCESS | 25678 | |12;stanford-crypto-pbkdf2;164;168;160;159;165;161;165;164;162;159 05:27:20 INFO - PROCESS | 25678 | |13;stanford-crypto-sha256-iterative;66;65;65;64;62;62;63;63;62;66 05:27:20 INFO - PROCESS | 25678 | __end_tp_report 05:27:20 INFO - PROCESS | 25678 | __start_cc_report 05:27:20 INFO - PROCESS | 25678 | _x_x_mozilla_cycle_collect,869 05:27:20 INFO - PROCESS | 25678 | __end_cc_report 05:27:20 INFO - PROCESS | 25678 | __startTimestamp1465648040436__endTimestamp 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | ------- Summary: start ------- 05:27:20 INFO - PROCESS | 25678 | Number of tests: 14 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.78 (1.6%) stddev-sans-first:1.88 05:27:20 INFO - PROCESS | 25678 | Values: 113.0 108.0 114.0 112.0 112.0 114.0 113.0 112.0 114.0 113.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:152.00 stddev:21.12 (13.9%) stddev-sans-first:22.39 05:27:20 INFO - PROCESS | 25678 | Values: 150.0 129.0 152.0 179.0 127.0 152.0 152.0 135.0 188.0 127.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.02 (1.9%) stddev-sans-first:3.14 05:27:20 INFO - PROCESS | 25678 | Values: 162.0 162.0 162.0 162.0 164.0 172.0 163.0 164.0 163.0 163.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:37.53 (50.0%) stddev-sans-first:39.24 05:27:20 INFO - PROCESS | 25678 | Values: 75.0 75.0 75.0 158.0 76.0 76.0 76.0 74.0 170.0 75.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:85.00 stddev:26.26 (30.9%) stddev-sans-first:27.24 05:27:20 INFO - PROCESS | 25678 | Values: 86.0 85.0 137.0 86.0 85.0 85.0 138.0 85.0 86.0 144.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 05:27:20 INFO - PROCESS | 25678 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 120.0 119.0 118.0 118.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.26 (0.9%) stddev-sans-first:1.00 05:27:20 INFO - PROCESS | 25678 | Values: 150.0 147.0 147.0 149.0 146.0 148.0 148.0 147.0 148.0 146.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.72 (1.8%) stddev-sans-first:0.71 05:27:20 INFO - PROCESS | 25678 | Values: 101.0 96.0 96.0 97.0 96.0 96.0 95.0 97.0 96.0 95.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.51 (2.7%) stddev-sans-first:1.59 05:27:20 INFO - PROCESS | 25678 | Values: 56.0 54.0 57.0 53.0 56.0 58.0 55.0 55.0 57.0 55.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 05:27:20 INFO - PROCESS | 25678 | Values: 64.0 63.0 65.0 64.0 63.0 63.0 63.0 62.0 63.0 63.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:81.00 stddev:9.32 (11.5%) stddev-sans-first:9.71 05:27:20 INFO - PROCESS | 25678 | Values: 79.0 81.0 81.0 81.0 81.0 86.0 81.0 80.0 110.0 80.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:129.00 stddev:5.25 (4.1%) stddev-sans-first:5.56 05:27:20 INFO - PROCESS | 25678 | Values: 127.0 127.0 123.0 123.0 121.0 131.0 132.0 135.0 125.0 136.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:164.00 stddev:2.98 (1.8%) stddev-sans-first:3.13 05:27:20 INFO - PROCESS | 25678 | Values: 164.0 168.0 160.0 159.0 165.0 161.0 165.0 164.0 162.0 159.0 05:27:20 INFO - PROCESS | 25678 | 05:27:20 INFO - PROCESS | 25678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.50 stddev:1.62 (2.5%) stddev-sans-first:1.51 05:27:20 INFO - PROCESS | 25678 | Values: 66.0 65.0 65.0 64.0 62.0 62.0 63.0 63.0 62.0 66.0 05:27:20 INFO - PROCESS | 25678 | -------- Summary: end -------- 05:27:20 INFO - PROCESS | 25678 | 05:27:21 INFO - TEST-INFO | 25678: exit 0 05:27:21 INFO - TEST-OK | kraken | took 62938ms 05:27:21 INFO - SUITE-END | took 1174s 05:27:21 INFO - Completed test suite (00:19:34) 05:27:21 INFO - javascript benchmark 05:27:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7260.42206504039, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.146359751067, 3124.406362791068, 3129.170769746017, 3130.8747650093983, 3133.98433007835, 5354.866128346788, 5378.596605254607, 5418.106012507937, 5463.235147079412, 5533.142362933741, 5208.661437006602, 5325.387580428252, 5391.703456309901, 5408.296921400222, 5432.945670543293, 4855.708657480544, 4878.0487804877885, 4990.6756060856105, 5045.545900868921, 5082.949170508285, 637.238328280889, 4830.227163653816, 4858.17411040124, 4902.166631672606, 4924.138275801721, 4866.732329721864, 4881.951180488185, 4891.16850135476, 4907.730074845882, 4925.556699897026, 4907.582855457291, 4909.337239472661, 4912.091263116335, 4923.556879880792, 4977.527134922177, 4726.4328280606205, 4767.785449654774, 4775.617950563947, 4796.856094317176, 4808.2547205183255, 5241.816536421207, 5287.365516138088, 5300.416954135042, 5305.7877684892555, 5310.283111779899, 5627.521660658849, 5680.0627896397045, 5685.658860468385, 5697.6011679182475, 5720.513756330717, 5717.885642287172, 5765.106408506688, 5804.216430781833, 5826.359100498942, 5878.676672783038, 5463.535599474049, 5464.590155738296, 5465.863353416156, 5474.835754927359, 5489.752961116759, 5741.540676745851, 5881.264841894763, 5925.674087925119, 5934.9406505934385, 5943.851403714942, 5662.773489060474, 5720.885582288414, 5743.9425605744245, 5768.538516918637, 5787.652740835563, 5815.069588865761, 5827.213326200994, 5828.737706803119, 5847.0, 5847.502962248172, 5556.194351818964, 5706.543476521868, 5712.428757124338, 5775.27809023872, 5801.12983052537, 5756.798512052058, 5808.709564521757, 5828.388019257917, 5834.970825145847, 5845.240118784531, 4374.993751437124, 4424.623906967944, 4431.889202769892, 4434.977825110854, 4439.023414848728, 3840.577536470986, 3859.517560304962, 3864.401017842239, 3895.0846551060476, 3978.8010599469912, 5304.257403963448, 5518.144687573433, 5526.530244929226, 5540.639858409271, 5583.860403489864, 5924.140999555127, 5927.851803704942, 5933.643981361132, 5944.494717949023, 5945.10823376497, 5435.402105768441, 5501.202325662836, 5529.4470552944385, 5547.889042219133, 5631.746571404296, 4876.317315575822, 4885.60915126789, 4898.21628539432, 4901.36282283308, 4928.605711543068, 5995.61028533144, 6011.969940150271, 6013.218281623361, 6027.276726792813, 6028.849278767978, 5619.719014049363, 5728.054870946247, 5745.770169193185, 5759.395263497272, 5848.766049357978, 5990.880182396415, 5993.9700301498215, 5996.850078748066, 6002.399760023963, 6012.0, 5472.315960504937, 5714.399988001366, 5714.742836572281, 5717.799877004285, 5725.914111288417, 5771.365149833431, 5789.421057894346, 5814.244148260699, 5844.620099693677, 5854.707264636836, 5692.0, 5693.0, 5694.544436444991, 5707.6575405475805, 5724.599278050497, 5450.209719590558, 5626.521745651666, 5644.88710225785, 5698.658080515016, 5701.885962280814, 5580.21876937221, 5583.8883222336135, 5604.215409842707, 5647.661140331593, 5686.60193786431, 5666.46168613981, 5676.545876329801, 5725.255716756795, 5773.451522105393, 5779.162021506774, 5375.408705042364, 5532.059549876451, 5547.44525547442, 5621.606487545832, 5643.548516118619], "value": 5295.560801276529, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.4215784215784, 620.8851362497938, 622.1290193728777, 633.3349982518355, 641.9358064193581, 38684.22631547371, 42141.3678794818, 42188.78905605475, 42235.78882105589, 42465.0, 42468.575314246846, 43126.0, 43138.0, 43256.78371608145, 43272.567274327244, 8813.471191728484, 8820.426672266281, 8910.0, 8965.058668839776, 9003.279737620975, 8829.955850220773, 8914.108589141066, 8939.508327042011, 8941.552922353889, 8944.552772361356, 8903.510306933116, 8931.64273429062, 8963.372563920528, 8976.59605317759, 8979.102089791002, 8872.245859101984, 8897.911020889773, 8942.73171804847, 8964.910350896538, 8975.640974361018, 8863.822723545558, 8917.866232006525, 8947.32895032875, 8960.46237225762, 8968.282537396992, 40871.79564102161, 41132.38301425481, 41149.38275925864, 41247.587524124974, 41252.0, 2834.588984597222, 3305.4876494143446, 3322.5680661513848, 3356.3622911646708, 3384.272381437978, 30884.691153088406, 31034.689653103407, 31144.688553114633, 31263.218419539466, 32455.188620284447, 4144.896377590554, 4167.395727619509, 4224.704270701052, 4265.9786701066605, 4297.35539669049, 301253.0, 301415.0, 302263.0, 302344.0, 302891.0, 35871.28257434837, 35907.0, 35990.0, 36038.099047524025, 36051.278974420886, 35752.106197345274, 35853.0, 36123.09692257662, 37527.62472375296, 37566.24867502635, 15243.23783810805, 15339.156346400832, 15388.769168462259, 15415.61460963485, 15487.845121548866, 11993.64019079429, 12087.093467989936, 12093.516259349528, 12102.576409825613, 12182.208156469802, 19365.020701503894, 19453.221871124995, 19517.0, 19549.51126221856, 19620.70568941467, 7116.932460131022, 7123.394511466583, 7153.89269160963, 7184.353408193288, 7403.296686814744, 952.8189643967625, 1019.5717798524489, 1020.9438480883474, 1112.6439539347493, 1167.4688016952437, 33013.50479742806, 33261.667383325854, 33265.66734332674, 33364.16589585231, 33868.32263354769, 1084.512367420853, 1121.332806979862, 1131.4399372310759, 1196.1806162778526, 1222.0956492195712, 17202.741958870625, 17371.218295176746, 17544.385946491813, 17579.384721534683, 17594.38419655306, 571344.0, 573022.0, 573866.0, 578468.0, 580103.0, 59262.70368648129, 60056.0, 60135.097973530435, 60198.699006504685, 60227.193184204545, 1262.9881762809096, 1273.3124112978887, 1348.265195468472, 1354.6410201296665, 1355.6543081514349, 30972.0708378749, 32124.19689507781, 32738.345233095682, 32942.34115317728, 32944.51749671318, 50731.0, 50839.0, 51287.0, 51336.0, 51435.228471572205, 463409.0, 466726.0, 468713.0, 468921.0, 470479.0, 28319.29201769972, 28461.715382845905, 28795.28011799722, 28812.279693007844, 28844.134675959755, 49334.02663893404, 49819.25271120864, 50221.24668129908, 50503.0, 50605.49394506008, 40738.0, 42085.0, 42333.0, 43196.0, 43265.567344326155, 41586.0, 42342.0, 42495.57504424916, 42545.78727106345, 42863.3570496449, 42285.0, 42560.0, 44549.55450445454, 45492.545074548834, 45536.54463455323, 38862.93688184069, 44063.11873762571, 45204.77397612991, 45803.08393832171, 45962.31056534088, 34262.65737342694, 34875.0, 34998.47502287519, 35324.293514130084, 35356.823215883756], "value": 19824.265759267095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.51720383927784, 396.1206122408256, 396.36383604315074, 399.4308110941908, 418.878525227684, 13301.201927884335, 17877.195526201318, 18061.548461288443, 18646.720299195506, 18711.251549938002, 17682.292708291654, 18041.90979045103, 18369.54076148097, 18640.347587834396, 18823.058847057662, 5089.3638295213095, 5528.806491772779, 5686.601937864351, 5708.828735137952, 5736.0, 5539.833804985837, 5567.582431317647, 5582.637128586649, 5597.776088956437, 5608.327000759894, 5312.973435132819, 5488.313960754906, 5523.530499907512, 5629.3526244482, 5629.577781666371, 5603.495685388335, 5604.411536788619, 5618.690971996539, 5627.6904770237625, 5637.887242255152, 4861.781219845116, 4991.351124353847, 5004.949950500485, 5052.242163675442, 5065.39215294167, 21049.0, 21916.780832191635, 22174.334769956928, 22205.888970555206, 22246.332610021724, 2255.729312482513, 2661.8003649726347, 2673.278214881971, 2743.0947787230166, 2777.3334399744117, 14100.788488172686, 14307.928460357736, 14490.275486225646, 14525.346359413852, 14846.480373186887, 1870.1303893689499, 2000.4266783093547, 2004.468815763809, 2004.859659823813, 2019.6061767955255, 71227.0, 72545.82362529132, 72774.0, 73696.26303737001, 74052.99999999946, 9374.296927730311, 9751.90248097524, 10518.526666300035, 10523.421211833424, 10565.524551395052, 14354.856451435351, 14407.135571865721, 14437.566872993826, 14446.855531444551, 14463.855361446462, 7745.496542724705, 7763.262490063435, 7782.688692452239, 7906.802329941797, 7947.801304967422, 7493.0, 7586.393088552903, 7727.304542591194, 7746.109197442366, 7749.7287594933905, 6386.137871387304, 6432.774852880127, 6454.774082907075, 6484.351564843478, 6574.0, 1868.3834334669527, 1892.7917929027797, 1918.4820098573307, 1936.0803618281204, 1948.2499237793268, 932.2635118256501, 981.8969008254173, 989.3717489394287, 1022.4683164754434, 1072.672834785398, 19185.32851350196, 19242.518937026685, 19792.50518737014, 19799.30702425408, 19877.503062423264, 1025.195221750922, 1037.0296436770197, 1062.5749700120014, 1063.8457423673678, 1089.716673664837, 10653.9467302663, 11147.498362573704, 11195.104391648649, 11303.604373846876, 11321.830172547418, 469415.0, 539365.0, 567505.0, 568194.0, 575170.2414879239, 80155.59922200351, 94588.52705736565, 97770.5111474438, 100206.69492327345, 100631.0, 987.1362557761959, 997.491279447487, 1013.8124446977333, 1023.65195833417, 1024.390487659856, 15756.68486630284, 16144.434944776876, 16286.104264265105, 16335.101569413797, 16723.080230587435, 40983.79508102441, 40989.79505102456, 41205.0, 41896.162076758905, 42309.36535952025, 53046.0, 53645.73177134089, 56902.71548642396, 59542.0, 63362.683186583774, 7105.538140020882, 7350.301721336678, 7757.534547927143, 7799.6100194988885, 8008.439409241297, 12152.0, 12709.0, 12913.806292905427, 13042.478300867859, 13172.0, 6624.8343791405605, 10024.298299119284, 11368.261063030877, 11616.535338586362, 11658.18392712502, 10934.234603577674, 11282.774344513227, 11480.383679141043, 11841.111916606116, 11912.821307680219, 10801.891981080089, 11606.941965290458, 11830.0, 11904.940475297915, 11952.0, 7157.821054473679, 7332.266773322625, 7393.778186654409, 7406.629668516445, 7681.8463630725955, 10629.787404251718, 11734.94132529332, 11770.117241206772, 11821.290722556674, 11895.46470408851], "value": 9156.65870033832, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.848710885357, 1455.3087283540317, 1597.5846279967204, 1744.8080711121765, 1756.5432987423274, 7626.31363177314, 8486.957565212173, 8521.36089793265, 9042.367034307601, 9054.637814487422, 8585.527795971218, 8770.122987701227, 8920.420172688771, 8942.463452192856, 8953.104689531043, 2047.8976051197455, 2069.8965051747427, 2077.3767869639123, 2078.833693304532, 2081.354780018199, 2144.406631241669, 2150.892455377225, 2182.8581142225785, 2193.7915897989665, 2195.034184958621, 2158.4927542027613, 2158.9784102158933, 2165.7834216578294, 2171.7176767020264, 2218.0794970087395, 2099.338708306886, 2105.536781907978, 2109.599176156533, 2112.5563631637374, 2115.3548167808813, 2100.222917520512, 2135.7970992755663, 2157.0, 2162.7945345192184, 2172.728408948881, 8839.425437346552, 8916.955415222947, 8919.286457083417, 8920.910790892072, 8934.86597701035, 4847.321375007502, 4944.505549445063, 4971.105201063807, 5013.147764879979, 5015.874603134915, 3101.65881753007, 3162.826044567548, 3325.9168520786934, 3326.9168270793425, 3329.467285234375, 1050.6532844161484, 1073.1629329123296, 1084.4035780320871, 1094.8576685030896, 1102.735343517558, 12133.93933030338, 12204.633860984184, 12209.511619535208, 12213.511459541696, 12234.571789987396, 4198.790060497024, 4206.137741762931, 4285.785710714452, 4328.0, 4333.43665323506, 9609.423434593948, 9646.951765241269, 9711.174550163316, 9713.854292185622, 9718.416894986323, 4950.975245123751, 4951.306817045616, 4951.72765497901, 4952.8761780955765, 4958.628102892298, 4013.7391069580967, 4364.60718535327, 4451.154280686659, 4581.862544123682, 4650.697704649187, 3619.696909112717, 3622.42041273395, 3714.7028237741456, 3775.867844625425, 3812.218495208476, 1074.4949873559415, 1086.5490821309227, 1090.2041509697965, 1094.6114129484079, 1098.549594666199, 875.7110153649407, 891.772597987509, 987.2694206287439, 998.3444038856751, 1007.5919252702668, 5923.792667256712, 5930.229070220844, 5938.376470470625, 6007.939920600738, 6111.266648002179, 356.81623963658734, 365.34238370932746, 372.4562139276632, 373.395099938102, 375.06982682946443, 4141.503019637663, 4265.402843601898, 4316.870493885189, 4343.500497442771, 4347.804348804311, 10652.30760000613, 11036.172287078341, 11135.443227838576, 11142.941420565034, 11166.553337866395, 10917.454127293604, 11005.834912476319, 11068.391238481961, 11069.335839849635, 11074.667759967213, 7833.1775163608145, 8008.7597372078935, 8028.197180281925, 8277.54473503963, 8339.041010283774, 5820.650760954356, 6038.788642397495, 6062.0, 6215.502759779117, 6234.688265586612, 10074.345167564084, 10113.342632728849, 10117.140043096419, 10231.28381013322, 10301.072903438726, 10125.493725313852, 10279.743006424898, 10364.326318789255, 10432.530536126045, 10434.739131521772, 7194.928050719635, 7713.807154821175, 7728.574928378768, 7914.564698941614, 8210.876836847332, 8200.05699344559, 8471.449355791854, 8493.278071364004, 8528.829423411373, 8549.102344253764, 7484.363829074589, 7652.65563049653, 7676.731314403969, 7775.261350171724, 7797.376209903081, 7471.850562988819, 7487.513311634726, 7583.165851756192, 7647.273509016634, 7664.271894170045, 7060.152781666233, 7128.465365097535, 7131.465140114408, 7143.964280178566, 7163.0329905462095, 4949.876253093557, 5178.32681751385, 5230.8169214077325, 5411.512963833274, 5436.293281873332, 5230.686158830483, 5282.418933917189, 5345.839624811262, 5370.785168593213, 5395.649282796762], "value": 4410.11458915271, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.41281280881606, 325.75893838559466, 325.9217787730944, 331.99571296827094, 334.12292731579606, 5644.887102257952, 5652.576056795741, 5671.234383358245, 5677.098172112347, 5734.913976290359, 5629.662220266777, 5636.774529018845, 5643.915341269874, 5670.327253460229, 5679.57403194761, 4117.794110294488, 4214.452121224252, 4321.28698764705, 4332.675049371294, 4365.192439398706, 4388.210122178007, 4389.31965545341, 4393.824247030115, 4394.011347446831, 4411.228035093845, 4288.541895755443, 4321.848735294266, 4339.522652508222, 4340.240457919867, 4354.54277300882, 4238.512571054322, 4269.3595960606, 4351.325544540601, 4354.107407981356, 4361.956380436187, 3830.0999265172663, 3842.5773164951834, 3843.0968722350226, 3853.421986701989, 3856.2287542491335, 5445.918311225335, 5450.509454149145, 5490.368607610096, 5491.7254137292975, 5492.752826122794, 4883.633727470454, 4981.402231732215, 4988.127077761377, 5002.549770520634, 5010.3737032870895, 5877.9118313225335, 5885.823425297248, 5899.852503687399, 5926.466618004357, 5930.7034648267845, 4191.580841915815, 4216.388623649554, 4227.513835908879, 4232.788360581959, 4242.024334403104, 5983.6110652807865, 6073.665948372838, 6101.389861013908, 6108.633481991051, 6129.724162412702, 4323.913521729548, 4324.8159679361725, 4332.761698106634, 4358.259095953696, 4358.4769827620885, 4367.213901497697, 4380.671449641226, 4381.890452738643, 4391.538888416734, 4399.6040356368085, 4864.80540778372, 4898.632602554822, 4900.607951363882, 4946.406431228275, 4952.950470495249, 5871.236739223959, 5894.498967587803, 5905.704714764244, 5910.60620448719, 5941.970290148522, 1478.4012474947663, 1483.5697647682052, 1491.4183468447313, 1498.9625259368604, 1499.635331848013, 925.1396201532639, 939.534930209537, 960.1166926427703, 978.1685567267765, 986.7089208683456, 5487.75305111271, 5518.972405137949, 5560.749766260528, 5585.972070139624, 5645.0, 5960.509872531867, 6000.039993601003, 6008.639481631116, 6016.819495415145, 6025.246844144482, 5409.594280428905, 5662.8301150965535, 5663.433656634386, 5679.261695979496, 5700.230468886647, 3218.8712451502147, 3224.8068214760688, 3251.64231934487, 3259.7066264036353, 3276.6887145721116, 5986.580939334205, 6180.690965451709, 6213.65824879627, 6245.781397651152, 6301.275353334425, 6269.341719119427, 6280.748770049238, 6283.874322513524, 6292.150559674477, 6346.524010699216, 6194.442500174916, 6324.9051264231075, 6401.679916004181, 6407.231132264158, 6408.519361047846, 6166.1983942087245, 6182.258129024546, 6204.472619827366, 6223.439890409703, 6231.594946328474, 6177.84555386119, 6212.285587157535, 6221.657808820558, 6224.4168670003255, 6245.5628106032145, 5977.953858074732, 6225.564210505221, 6234.220722409699, 6257.904866648228, 6423.646699431576, 4175.728577642443, 4175.958240417678, 4190.392393102922, 4197.727147735387, 4218.578142185757, 5944.5838791284195, 6164.4143806338325, 6173.38266173397, 6186.628802271878, 6197.318294987638, 5971.880562388641, 5985.970070149621, 5992.790252341147, 6014.346054834956, 6033.818985430444, 5983.311919129356, 5996.88006239864, 6002.579819412599, 6018.699065046642, 6031.823794360058, 5689.146628005667, 5776.931267715318, 5803.825885223281, 5835.474807267196, 5903.291605007426, 5934.554908381802, 5963.671998040149, 5970.984932561388, 5992.0, 6086.6348019119, 5680.4319568042865, 5681.137020028673, 5740.167675687086, 5843.152742852348, 5880.0], "value": 4493.245215312727, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.721565804994, 741.8850078237875, 764.8317370178559, 792.414325178567, 848.3467729848018, 13499.122557033787, 15004.249787510622, 15287.312070956807, 15313.0812151271, 15331.233438328067, 14616.269186540683, 15128.16795076273, 15851.682966340666, 15951.0, 16494.83505164948, 675.1155985658778, 788.9723859664913, 808.3896658023184, 818.4843548564396, 819.8442295963778, 801.6152246921481, 802.7912742686914, 802.8755542890862, 806.891069705591, 807.6204184033495, 844.5734903873566, 848.1349023995521, 848.4485084694936, 848.4485084694967, 849.9490030598184, 846.4540371460404, 846.6105591427951, 846.9618867150994, 848.4485084694936, 850.2093053460279, 615.5814046448413, 616.824205101544, 617.5491890919653, 618.2827919613272, 619.0343064818896, 14234.715305693931, 14303.570892873231, 14345.211013394259, 14440.0, 14490.92754536231, 14358.353874075587, 14515.346809393603, 14558.636034099127, 14606.12363258208, 14837.703245935021, 12309.506935806045, 12403.62789116328, 12516.18644788095, 12534.81197782034, 12717.554885579053, 3919.6668283195963, 3957.208558288325, 4031.637152656275, 4090.8568200112854, 4128.958710412888, 85523.0, 85731.99999999937, 86049.56975215147, 86296.56851715763, 86723.0, 10617.362958222531, 10812.67561973142, 11139.498722557504, 11219.0, 11345.205835591429, 20011.699824502644, 20181.798182017992, 20188.192472301238, 20214.191432342835, 20250.291239806535, 8221.136780637948, 8609.741707748777, 8824.294056475595, 8825.205731484197, 8847.778805529913, 4805.111054454867, 4852.636052296092, 4869.70781753096, 4876.4879687633, 5073.416557095981, 3527.753057286017, 3656.469811877263, 3662.560492740888, 3678.282734866729, 3679.963200368016, 583.2942140010634, 586.61576667283, 593.9227900373011, 596.1832289763053, 611.944924956756, 607.7604029152587, 625.562106525434, 701.3792793377795, 765.261522630653, 766.9041369828772, 10450.964937067112, 10467.0, 10479.266451348332, 10506.159507239403, 10624.521896514676, 725.4051677624403, 733.6405161470948, 736.948413611042, 743.5390058163973, 758.1395116542764, 4729.881752956135, 4838.758062096881, 4878.853634390974, 4942.827001054946, 4965.329680493087, 124015.0, 126028.0, 126294.94820207273, 127079.0, 127628.36185819011, 107244.46377768218, 108539.0, 110735.44632276786, 111254.0, 113597.0, 97754.51122744483, 100425.0, 100869.0, 101210.0, 101810.0, 9117.544122793966, 9384.859227111463, 9393.060693930553, 9454.574544145393, 9463.0, 45783.0, 56688.0, 57531.712341438026, 57676.0, 58215.417845822696, 56650.43349566452, 82462.17537824785, 83542.0, 83803.16196838197, 84312.57843710743, 11590.652280431601, 11667.59163429276, 11905.761884762083, 12362.38188090574, 12565.18326308787, 13780.793288100887, 13833.515826946008, 13914.582562523141, 14044.929775351058, 14803.333849976992, 12571.245725256515, 12777.16948398351, 13108.617960638323, 13564.932175339454, 13742.244176570384, 13152.736945261233, 13213.14114582549, 13486.1599829751, 13661.112027718564, 14029.438822447397, 12317.199382040139, 13212.207267563592, 13296.0, 13524.0, 13604.0, 10937.45312734376, 11274.323540587591, 11426.714332141762, 11507.194496385173, 12203.816942746043, 11894.643160705193, 11998.160128790902, 12221.144519883523, 12642.55751048709, 12684.87315126874], "value": 7689.021346052692, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 114.0, 112.0, 112.0, 114.0, 113.0, 112.0, 114.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 129.0, 152.0, 179.0, 127.0, 152.0, 152.0, 135.0, 188.0, 127.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 164.0, 172.0, 163.0, 164.0, 163.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 158.0, 76.0, 76.0, 76.0, 74.0, 170.0, 75.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 137.0, 86.0, 85.0, 85.0, 138.0, 85.0, 86.0, 144.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 120.0, 119.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 147.0, 149.0, 146.0, 148.0, 148.0, 147.0, 148.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 97.0, 96.0, 95.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 57.0, 53.0, 56.0, 58.0, 55.0, 55.0, 57.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 64.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 81.0, 81.0, 81.0, 86.0, 81.0, 80.0, 110.0, 80.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 123.0, 123.0, 121.0, 131.0, 132.0, 135.0, 125.0, 136.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 160.0, 159.0, 165.0, 161.0, 165.0, 164.0, 162.0, 159.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 64.0, 62.0, 62.0, 63.0, 63.0, 62.0, 66.0], "value": 63.8, "unit": "score"}]}]} 05:27:21 INFO - Return code: 0 05:27:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:27:21 ERROR - # TBPL SUCCESS # 05:27:21 INFO - Running post-action listener: _resource_record_post_action 05:27:21 INFO - ##### 05:27:21 INFO - ##### Finished run-tests step (success) 05:27:21 INFO - ##### 05:27:21 INFO - Running post-run listener: _resource_record_post_run 05:27:21 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542728192; Read time: 152; Write time: 582780 05:27:21 INFO - TinderboxPrint: CPU usage
13.4% 05:27:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 152 05:27:21 INFO - TinderboxPrint: I/O write bytes / time
542,728,192 / 582,780 05:27:21 INFO - TinderboxPrint: CPU idle
8,236.5 (86.5%) 05:27:21 INFO - TinderboxPrint: CPU user
1,222.3 (12.8%) 05:27:21 INFO - TinderboxPrint: Swap in / out
0 / 0 05:27:21 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254971904; Read time: 0; Write time: 334728 05:27:21 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287756288; Read time: 152; Write time: 248052 05:27:22 INFO - Running post-run listener: _upload_blobber_files 05:27:22 INFO - Blob upload gear active. 05:27:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:27:22 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 05:27:22 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'] 05:27:22 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 05:27:22 INFO - (blobuploader) - INFO - Open directory for files ... 05:27:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:27:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:27:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:26 INFO - (blobuploader) - INFO - Done attempting. 05:27:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:27:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:27:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:27 INFO - (blobuploader) - INFO - Done attempting. 05:27:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:27:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:27:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:27 INFO - (blobuploader) - INFO - Done attempting. 05:27:27 INFO - (blobuploader) - INFO - Iteration through files over. 05:27:27 INFO - Return code: 0 05:27:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:27:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:27:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/505dab0c1a16d83e4aba6423805134e017b374782c25c25d37f9bc85aa1e16250591d53c081ac77204d56640b45f657b3b10bf5f6ed852d77d6e58dac54525bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/128cbf0c6cf676f15fe2c6830aac87827cb90067e1db6cc0f11ffb999847918dd83aed4809c979ce30921be3eeb085c8ca43566386c1789b84929d014dd6eab6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0989844758f4fee7201c09954cf12b9eefd4d38e22d388bc3db619e64584764d08b105ac1a8fea3f108c19542446bafab30a9470320d6e3aae1d03542c068ea"} 05:27:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:27:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:27:27 INFO - Contents: 05:27:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/505dab0c1a16d83e4aba6423805134e017b374782c25c25d37f9bc85aa1e16250591d53c081ac77204d56640b45f657b3b10bf5f6ed852d77d6e58dac54525bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/128cbf0c6cf676f15fe2c6830aac87827cb90067e1db6cc0f11ffb999847918dd83aed4809c979ce30921be3eeb085c8ca43566386c1789b84929d014dd6eab6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0989844758f4fee7201c09954cf12b9eefd4d38e22d388bc3db619e64584764d08b105ac1a8fea3f108c19542446bafab30a9470320d6e3aae1d03542c068ea"} 05:27:27 INFO - Running post-run listener: copy_logs_to_upload_dir 05:27:27 INFO - Copying logs to upload dir... 05:27:27 INFO - mkdir: /builds/slave/test/build/upload/logs 05:27:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.710940 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-11 05:27:27.394367) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 05:27:27.399011) ========= 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=eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551 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/505dab0c1a16d83e4aba6423805134e017b374782c25c25d37f9bc85aa1e16250591d53c081ac77204d56640b45f657b3b10bf5f6ed852d77d6e58dac54525bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/128cbf0c6cf676f15fe2c6830aac87827cb90067e1db6cc0f11ffb999847918dd83aed4809c979ce30921be3eeb085c8ca43566386c1789b84929d014dd6eab6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0989844758f4fee7201c09954cf12b9eefd4d38e22d388bc3db619e64584764d08b105ac1a8fea3f108c19542446bafab30a9470320d6e3aae1d03542c068ea"} build_url:https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/505dab0c1a16d83e4aba6423805134e017b374782c25c25d37f9bc85aa1e16250591d53c081ac77204d56640b45f657b3b10bf5f6ed852d77d6e58dac54525bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/128cbf0c6cf676f15fe2c6830aac87827cb90067e1db6cc0f11ffb999847918dd83aed4809c979ce30921be3eeb085c8ca43566386c1789b84929d014dd6eab6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0989844758f4fee7201c09954cf12b9eefd4d38e22d388bc3db619e64584764d08b105ac1a8fea3f108c19542446bafab30a9470320d6e3aae1d03542c068ea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 05:27:27.424402) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:27:27.424756) ========= 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=eca2ab57546de7b41f256b19000001ef-1465645168.445741-136643551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:27:27.509684) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 05:27:27.510048) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 05:27:27.510346) ========= ========= Total master_lag: 0.21 =========