builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1465215266.63 results: success (0) buildid: 20160606030429 builduid: 84cb245a928c442e857bbc9b88c3ffa3 revision: 7fc6eedd33484ae8679bde3ae600563d2b457f4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:26.634747) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:26.635191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:26.635761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:26.650278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:26.650549) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 05:14:27-- 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.5M=0s 2016-06-06 05:14:27 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093425 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:26.757761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:26.758066) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019308 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:26.807274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:26.807727) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7fc6eedd33484ae8679bde3ae600563d2b457f4e --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 7fc6eedd33484ae8679bde3ae600563d2b457f4e --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=5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 05:14:27,694 truncating revision to first 12 chars 2016-06-06 05:14:27,694 Setting DEBUG logging. 2016-06-06 05:14:27,694 attempt 1/10 2016-06-06 05:14:27,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7fc6eedd3348?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 05:14:28,019 unpacking tar archive at: fx-team-7fc6eedd3348/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:27.481030) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:27.481403) ========= script_repo_revision: 7fc6eedd33484ae8679bde3ae600563d2b457f4e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:27.481898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:27.482205) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:14:27.492385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-06 05:14:27.492693) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:14:28 INFO - MultiFileLogger online at 20160606 05:14:28 in /builds/slave/test 05:14:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:14:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:14:28 INFO - {'append_to_log': False, 05:14:28 INFO - 'base_work_dir': '/builds/slave/test', 05:14:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:14:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:14:28 INFO - 'branch': 'Fx-Team-Non-PGO', 05:14:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:14:28 INFO - 'config_files': ('talos/linux_config.py',), 05:14:28 INFO - 'default_actions': ('clobber', 05:14:28 INFO - 'read-buildbot-config', 05:14:28 INFO - 'download-and-extract', 05:14:28 INFO - 'populate-webroot', 05:14:28 INFO - 'create-virtualenv', 05:14:28 INFO - 'install', 05:14:28 INFO - 'run-tests'), 05:14:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:14:28 INFO - 'download_minidump_stackwalk': True, 05:14:28 INFO - 'download_symbols': 'ondemand', 05:14:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:14:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:14:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:14:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:14:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:14:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:14:28 INFO - 'installer_path': 'installer.exe', 05:14:28 INFO - 'log_level': 'info', 05:14:28 INFO - 'log_name': 'talos', 05:14:28 INFO - 'log_to_console': True, 05:14:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:14:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:14:28 INFO - 'opt_config_files': (), 05:14:28 INFO - 'pip_index': False, 05:14:28 INFO - 'sps_profile': False, 05:14:28 INFO - 'sps_profile_interval': 0, 05:14:28 INFO - 'suite': 'dromaeojs-e10s', 05:14:28 INFO - 'system_bits': '32', 05:14:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:14:28 INFO - 'title': 'talos-linux64-ix-051', 05:14:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:14:28 INFO - 'use_talos_json': True, 05:14:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:14:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:14:28 INFO - 'work_dir': 'build'} 05:14:28 INFO - ##### 05:14:28 INFO - ##### Running clobber step. 05:14:28 INFO - ##### 05:14:28 INFO - Running pre-action listener: _resource_record_pre_action 05:14:28 INFO - Running main action method: clobber 05:14:28 INFO - rmtree: /builds/slave/test/build 05:14:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:14:29 INFO - Running post-action listener: _resource_record_post_action 05:14:29 INFO - ##### 05:14:29 INFO - ##### Finished clobber step (success) 05:14:29 INFO - ##### 05:14:29 INFO - ##### 05:14:29 INFO - ##### Running read-buildbot-config step. 05:14:29 INFO - ##### 05:14:29 INFO - Running pre-action listener: _resource_record_pre_action 05:14:29 INFO - Running main action method: read_buildbot_config 05:14:29 INFO - Using buildbot properties: 05:14:29 INFO - { 05:14:29 INFO - "project": "", 05:14:29 INFO - "product": "firefox", 05:14:29 INFO - "script_repo_revision": "production", 05:14:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:14:29 INFO - "repository": "", 05:14:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:14:29 INFO - "buildid": "20160606030429", 05:14:29 INFO - "pgo_build": "False", 05:14:29 INFO - "basedir": "/builds/slave/test", 05:14:29 INFO - "buildnumber": 1348, 05:14:29 INFO - "slavename": "talos-linux64-ix-051", 05:14:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:14:29 INFO - "platform": "ubuntu64_hw", 05:14:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:14:29 INFO - "branch": "fx-team", 05:14:29 INFO - "repo_path": "integration/fx-team", 05:14:29 INFO - "revision": "7fc6eedd33484ae8679bde3ae600563d2b457f4e", 05:14:29 INFO - "stage_platform": "linux64", 05:14:29 INFO - "builduid": "84cb245a928c442e857bbc9b88c3ffa3", 05:14:29 INFO - "slavebuilddir": "test" 05:14:29 INFO - } 05:14:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:14:29 INFO - Running post-action listener: _resource_record_post_action 05:14:29 INFO - ##### 05:14:29 INFO - ##### Finished read-buildbot-config step (success) 05:14:29 INFO - ##### 05:14:29 INFO - ##### 05:14:29 INFO - ##### Running download-and-extract step. 05:14:29 INFO - ##### 05:14:29 INFO - Running pre-action listener: _resource_record_pre_action 05:14:29 INFO - Running main action method: download_and_extract 05:14:29 INFO - mkdir: /builds/slave/test/build/tests 05:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:29 INFO - https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:14:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:14:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:14:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:14:29 INFO - Downloaded 1361 bytes. 05:14:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:14:29 INFO - Using the following test package requirements: 05:14:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:14:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:14:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'jsshell-linux-x86_64.zip'], 05:14:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:14:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:14:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:14:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:14:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:14:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:29 INFO - https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:14:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:14:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:30 INFO - Downloaded 22870980 bytes. 05:14:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:31 INFO - Return code: 0 05:14:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:14:31 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:14:31 INFO - https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:14:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:14:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:32 INFO - Downloaded 22870980 bytes. 05:14:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:34 INFO - Return code: 0 05:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:34 INFO - https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:14:35 INFO - Downloaded 10833369 bytes. 05:14:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:14:35 INFO - Return code: 0 05:14:35 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:14:35 INFO - https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:14:37 INFO - Downloaded 55203306 bytes. 05:14:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:14:37 INFO - mkdir: /builds/slave/test/properties 05:14:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:37 INFO - Contents: 05:14:37 INFO - build_url:https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:14:37 INFO - Running post-action listener: _resource_record_post_action 05:14:37 INFO - Running post-action listener: set_extra_try_arguments 05:14:37 INFO - ##### 05:14:37 INFO - ##### Finished download-and-extract step (success) 05:14:37 INFO - ##### 05:14:37 INFO - ##### 05:14:37 INFO - ##### Running populate-webroot step. 05:14:37 INFO - ##### 05:14:37 INFO - Running pre-action listener: _resource_record_pre_action 05:14:37 INFO - Running main action method: populate_webroot 05:14:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:37 INFO - '--tppagecycles', 05:14:37 INFO - '7'], 05:14:37 INFO - 'tests': ['tsvgm']}}, 05:14:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:14:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:14:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['damp', 'tps']}, 05:14:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'tests': ['damp', 'tps']}, 05:14:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['dromaeo_dom']}, 05:14:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:14:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['a11yr', 05:14:37 INFO - 'ts_paint', 05:14:37 INFO - 'tpaint', 05:14:37 INFO - 'sessionrestore', 05:14:37 INFO - 'sessionrestore_no_auto_restore', 05:14:37 INFO - 'tabpaint']}, 05:14:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['tsvgx', 05:14:37 INFO - 'tsvgr_opacity', 05:14:37 INFO - 'tart', 05:14:37 INFO - 'tscrollx', 05:14:37 INFO - 'cart']}, 05:14:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:14:37 INFO - 'tsvgr_opacity', 05:14:37 INFO - 'tart', 05:14:37 INFO - 'tscrollx', 05:14:37 INFO - 'cart']}, 05:14:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'talos_options': ['--disable-e10s'], 05:14:37 INFO - 'tests': ['tp5o']}, 05:14:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'tests': ['tp5o']}, 05:14:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'talos_options': ['--disable-e10s', 05:14:37 INFO - '--xperf_path', 05:14:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:37 INFO - 'tests': ['tp5n']}, 05:14:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:37 INFO - 'talos_options': ['--xperf_path', 05:14:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:37 INFO - 'tests': ['tp5n']}}, 05:14:37 INFO - 'talos.zip': {'path': '', 05:14:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:37 INFO - Running post-action listener: _resource_record_post_action 05:14:37 INFO - ##### 05:14:37 INFO - ##### Finished populate-webroot step (success) 05:14:37 INFO - ##### 05:14:37 INFO - ##### 05:14:37 INFO - ##### Running create-virtualenv step. 05:14:37 INFO - ##### 05:14:37 INFO - Running pre-action listener: _resource_record_pre_action 05:14:37 INFO - Running main action method: create_virtualenv 05:14:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:14:37 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:14:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:14:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:38 INFO - Using real prefix '/usr' 05:14:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:14:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:14:40 INFO - Installing pip.................done. 05:14:40 INFO - Return code: 0 05:14:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:40 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 0x7f60bc4fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a1c0>, '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 0x1c4b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', '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:14:40 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:14:40 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:14:40 INFO - Using env: {'DISPLAY': ':0', 05:14:40 INFO - 'HOME': '/home/cltbld', 05:14:40 INFO - 'LANG': 'en_US.UTF-8', 05:14:40 INFO - 'LANGUAGE': 'en_US:en', 05:14:40 INFO - 'LOGNAME': 'cltbld', 05:14:40 INFO - 'MAIL': '/var/mail/cltbld', 05:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:40 INFO - 'MOZ_NO_REMOTE': '1', 05:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:40 INFO - 'NO_EM_RESTART': '1', 05:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:40 INFO - 'PWD': '/builds/slave/test', 05:14:40 INFO - 'SHELL': '/bin/bash', 05:14:40 INFO - 'SHLVL': '1', 05:14:40 INFO - 'TERM': 'linux', 05:14:40 INFO - 'TMOUT': '86400', 05:14:40 INFO - 'USER': 'cltbld', 05:14:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', 05:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:40 INFO - '_': '/tools/buildbot/bin/python'} 05:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:40 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:14:40 INFO - Cleaning up... 05:14:40 INFO - Return code: 0 05:14:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:40 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 0x7f60bc4fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a1c0>, '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 0x1c4b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', '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:14:40 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:14:40 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:14:40 INFO - Using env: {'DISPLAY': ':0', 05:14:40 INFO - 'HOME': '/home/cltbld', 05:14:40 INFO - 'LANG': 'en_US.UTF-8', 05:14:40 INFO - 'LANGUAGE': 'en_US:en', 05:14:40 INFO - 'LOGNAME': 'cltbld', 05:14:40 INFO - 'MAIL': '/var/mail/cltbld', 05:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:40 INFO - 'MOZ_NO_REMOTE': '1', 05:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:40 INFO - 'NO_EM_RESTART': '1', 05:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:40 INFO - 'PWD': '/builds/slave/test', 05:14:40 INFO - 'SHELL': '/bin/bash', 05:14:40 INFO - 'SHLVL': '1', 05:14:40 INFO - 'TERM': 'linux', 05:14:40 INFO - 'TMOUT': '86400', 05:14:40 INFO - 'USER': 'cltbld', 05:14:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', 05:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:40 INFO - '_': '/tools/buildbot/bin/python'} 05:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:41 INFO - Downloading/unpacking psutil>=3.1.1 05:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:43 INFO - Installing collected packages: psutil 05:14:43 INFO - Running setup.py install for psutil 05:14:43 INFO - building 'psutil._psutil_linux' extension 05:14:43 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:14:43 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:14:43 INFO - building 'psutil._psutil_posix' extension 05:14:43 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:14:43 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:14:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:43 INFO - Successfully installed psutil 05:14:43 INFO - Cleaning up... 05:14:43 INFO - Return code: 0 05:14:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:14:43 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:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:43 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:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:43 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 0x7f60bc4fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a1c0>, '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 0x1c4b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', '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:14:43 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:14:43 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:14:43 INFO - Using env: {'DISPLAY': ':0', 05:14:43 INFO - 'HOME': '/home/cltbld', 05:14:43 INFO - 'LANG': 'en_US.UTF-8', 05:14:43 INFO - 'LANGUAGE': 'en_US:en', 05:14:43 INFO - 'LOGNAME': 'cltbld', 05:14:43 INFO - 'MAIL': '/var/mail/cltbld', 05:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:43 INFO - 'MOZ_NO_REMOTE': '1', 05:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:43 INFO - 'NO_EM_RESTART': '1', 05:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:43 INFO - 'PWD': '/builds/slave/test', 05:14:43 INFO - 'SHELL': '/bin/bash', 05:14:43 INFO - 'SHLVL': '1', 05:14:43 INFO - 'TERM': 'linux', 05:14:43 INFO - 'TMOUT': '86400', 05:14:43 INFO - 'USER': 'cltbld', 05:14:43 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', 05:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:43 INFO - '_': '/tools/buildbot/bin/python'} 05:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:14:43 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:14:43 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:14:43 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:14:43 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:14:43 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:14:43 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:14:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:14:45 INFO - Installing collected packages: mozsystemmonitor 05:14:45 INFO - Running setup.py install for mozsystemmonitor 05:14:45 INFO - Successfully installed mozsystemmonitor 05:14:45 INFO - Cleaning up... 05:14:45 INFO - Return code: 0 05:14:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:14: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:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:45 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 0x7f60bc4fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a1c0>, '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 0x1c4b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', '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:14:45 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:14:45 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:14:45 INFO - Using env: {'DISPLAY': ':0', 05:14:45 INFO - 'HOME': '/home/cltbld', 05:14:45 INFO - 'LANG': 'en_US.UTF-8', 05:14:45 INFO - 'LANGUAGE': 'en_US:en', 05:14:45 INFO - 'LOGNAME': 'cltbld', 05:14:45 INFO - 'MAIL': '/var/mail/cltbld', 05:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:45 INFO - 'MOZ_NO_REMOTE': '1', 05:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:45 INFO - 'NO_EM_RESTART': '1', 05:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:45 INFO - 'PWD': '/builds/slave/test', 05:14:45 INFO - 'SHELL': '/bin/bash', 05:14:45 INFO - 'SHLVL': '1', 05:14:45 INFO - 'TERM': 'linux', 05:14:45 INFO - 'TMOUT': '86400', 05:14:45 INFO - 'USER': 'cltbld', 05:14:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', 05:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:45 INFO - '_': '/tools/buildbot/bin/python'} 05:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:46 INFO - Downloading/unpacking jsonschema==2.5.1 05:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:14:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:14:48 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:14:48 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:14:48 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:14:48 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:14:48 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:14:48 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:14:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:14:48 INFO - warning: no files found matching '*.txt' 05:14:48 INFO - no previously-included directories found matching 'build' 05:14:48 INFO - no previously-included directories found matching 'dist' 05:14:48 INFO - no previously-included directories found matching '.git*' 05:14:48 INFO - Installing collected packages: jsonschema, functools32 05:14:48 INFO - Running setup.py install for functools32 05:14:48 INFO - warning: no files found matching '*.txt' 05:14:48 INFO - no previously-included directories found matching 'build' 05:14:48 INFO - no previously-included directories found matching 'dist' 05:14:48 INFO - no previously-included directories found matching '.git*' 05:14:48 INFO - Successfully installed jsonschema functools32 05:14:48 INFO - Cleaning up... 05:14:48 INFO - Return code: 0 05:14:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:48 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 0x7f60bc4fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a1c0>, '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 0x1c4b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', '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:14:48 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:14:48 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:14:48 INFO - Using env: {'DISPLAY': ':0', 05:14:48 INFO - 'HOME': '/home/cltbld', 05:14:48 INFO - 'LANG': 'en_US.UTF-8', 05:14:48 INFO - 'LANGUAGE': 'en_US:en', 05:14:48 INFO - 'LOGNAME': 'cltbld', 05:14:48 INFO - 'MAIL': '/var/mail/cltbld', 05:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:48 INFO - 'MOZ_NO_REMOTE': '1', 05:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:48 INFO - 'NO_EM_RESTART': '1', 05:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:48 INFO - 'PWD': '/builds/slave/test', 05:14:48 INFO - 'SHELL': '/bin/bash', 05:14:48 INFO - 'SHLVL': '1', 05:14:48 INFO - 'TERM': 'linux', 05:14:48 INFO - 'TMOUT': '86400', 05:14:48 INFO - 'USER': 'cltbld', 05:14:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', 05:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:48 INFO - '_': '/tools/buildbot/bin/python'} 05:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:14:48 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:14:48 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:14:48 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:14:48 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:14:48 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:14:48 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:14:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:14:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:14:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:51 INFO - Downloading docopt-0.6.1.tar.gz 05:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:14:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:14:51 INFO - Running setup.py install for blobuploader 05:14:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:14:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:14:51 INFO - Running setup.py install for requests 05:14:51 INFO - Running setup.py install for docopt 05:14:51 INFO - Successfully installed blobuploader requests docopt 05:14:51 INFO - Cleaning up... 05:14:52 INFO - Return code: 0 05:14:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 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 0x7f60bc4fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a1c0>, '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 0x1c4b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', '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:14:52 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:14:52 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:14:52 INFO - Using env: {'DISPLAY': ':0', 05:14:52 INFO - 'HOME': '/home/cltbld', 05:14:52 INFO - 'LANG': 'en_US.UTF-8', 05:14:52 INFO - 'LANGUAGE': 'en_US:en', 05:14:52 INFO - 'LOGNAME': 'cltbld', 05:14:52 INFO - 'MAIL': '/var/mail/cltbld', 05:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:52 INFO - 'MOZ_NO_REMOTE': '1', 05:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:52 INFO - 'NO_EM_RESTART': '1', 05:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:52 INFO - 'PWD': '/builds/slave/test', 05:14:52 INFO - 'SHELL': '/bin/bash', 05:14:52 INFO - 'SHLVL': '1', 05:14:52 INFO - 'TERM': 'linux', 05:14:52 INFO - 'TMOUT': '86400', 05:14:52 INFO - 'USER': 'cltbld', 05:14:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', 05:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:52 INFO - '_': '/tools/buildbot/bin/python'} 05:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:52 INFO - Running setup.py (path:/tmp/pip-UQfiOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:52 INFO - Running setup.py (path:/tmp/pip-lg3BnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:52 INFO - Running setup.py (path:/tmp/pip-AKDEFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:52 INFO - Running setup.py (path:/tmp/pip-szsEkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:52 INFO - Running setup.py (path:/tmp/pip-8MWIx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:52 INFO - Running setup.py (path:/tmp/pip-j6RMSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:52 INFO - Running setup.py (path:/tmp/pip-X5kmmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:52 INFO - Running setup.py (path:/tmp/pip-Pd6fRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:52 INFO - Running setup.py (path:/tmp/pip-OdGQos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:52 INFO - Running setup.py (path:/tmp/pip-Gr2el3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:52 INFO - Running setup.py (path:/tmp/pip-jx_RI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:53 INFO - Running setup.py (path:/tmp/pip-kObiCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:53 INFO - Running setup.py (path:/tmp/pip-0qev2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:53 INFO - Running setup.py (path:/tmp/pip-nkG6_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:53 INFO - Running setup.py (path:/tmp/pip-lFgqAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:53 INFO - Running setup.py (path:/tmp/pip-Kwz_nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:53 INFO - Running setup.py (path:/tmp/pip-RLTCka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:14:53 INFO - Running setup.py install for manifestparser 05:14:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:14:53 INFO - Running setup.py install for mozcrash 05:14:53 INFO - Running setup.py install for mozdebug 05:14:53 INFO - Running setup.py install for mozdevice 05:14:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:14:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:14:53 INFO - Running setup.py install for mozfile 05:14:53 INFO - Running setup.py install for mozhttpd 05:14:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for mozinfo 05:14:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for mozInstall 05:14:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for mozleak 05:14:54 INFO - Running setup.py install for mozlog 05:14:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for moznetwork 05:14:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for mozprocess 05:14:54 INFO - Running setup.py install for mozprofile 05:14:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for mozrunner 05:14:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:14:54 INFO - Running setup.py install for mozscreenshot 05:14:55 INFO - Running setup.py install for moztest 05:14:55 INFO - Running setup.py install for mozversion 05:14:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:14:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:14:55 INFO - Cleaning up... 05:14:55 INFO - Return code: 0 05:14:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:55 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:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:55 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:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:55 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 0x7f60bc4fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a1c0>, '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 0x1c4b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', '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:14:55 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:14:55 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:14:55 INFO - Using env: {'DISPLAY': ':0', 05:14:55 INFO - 'HOME': '/home/cltbld', 05:14:55 INFO - 'LANG': 'en_US.UTF-8', 05:14:55 INFO - 'LANGUAGE': 'en_US:en', 05:14:55 INFO - 'LOGNAME': 'cltbld', 05:14:55 INFO - 'MAIL': '/var/mail/cltbld', 05:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:55 INFO - 'MOZ_NO_REMOTE': '1', 05:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:55 INFO - 'NO_EM_RESTART': '1', 05:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:55 INFO - 'PWD': '/builds/slave/test', 05:14:55 INFO - 'SHELL': '/bin/bash', 05:14:55 INFO - 'SHLVL': '1', 05:14:55 INFO - 'TERM': 'linux', 05:14:55 INFO - 'TMOUT': '86400', 05:14:55 INFO - 'USER': 'cltbld', 05:14:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', 05:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:55 INFO - '_': '/tools/buildbot/bin/python'} 05:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:55 INFO - Running setup.py (path:/tmp/pip-sT2IwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:55 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:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:55 INFO - Running setup.py (path:/tmp/pip-RKOeJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:55 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:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:55 INFO - Running setup.py (path:/tmp/pip-wIFZfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:55 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:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:55 INFO - Running setup.py (path:/tmp/pip-cFdJaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:55 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:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:55 INFO - Running setup.py (path:/tmp/pip-pc01Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:55 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:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:55 INFO - Running setup.py (path:/tmp/pip-aHF3lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:55 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:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:55 INFO - Running setup.py (path:/tmp/pip-TTX4I7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:55 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:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:55 INFO - Running setup.py (path:/tmp/pip-QrDb0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:56 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:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:56 INFO - Running setup.py (path:/tmp/pip-sXlLax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:56 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:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:56 INFO - Running setup.py (path:/tmp/pip-b83Ggg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:56 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:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:56 INFO - Running setup.py (path:/tmp/pip-OAzcMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:56 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:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:56 INFO - Running setup.py (path:/tmp/pip-PznA6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:56 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:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:56 INFO - Running setup.py (path:/tmp/pip-nys36h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:56 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:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:56 INFO - Running setup.py (path:/tmp/pip-_pS12l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:56 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:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:56 INFO - Running setup.py (path:/tmp/pip-OpDkq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:56 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:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:56 INFO - Running setup.py (path:/tmp/pip-Og6s5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:56 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:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:56 INFO - Running setup.py (path:/tmp/pip-4zt5qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:56 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:14:56 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:14:56 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:14:56 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:14:56 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:14:56 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:14:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:14:56 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:14:56 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:14:56 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:14:56 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:14:56 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:14:56 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:14:58 INFO - Downloading blessings-1.6.tar.gz 05:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:14:58 INFO - Installing collected packages: blessings 05:14:58 INFO - Running setup.py install for blessings 05:14:58 INFO - Successfully installed blessings 05:14:58 INFO - Cleaning up... 05:14:58 INFO - Return code: 0 05:14:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:14:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:59 INFO - Reading from file tmpfile_stdout 05:14:59 INFO - Current package versions: 05:14:59 INFO - argparse == 1.2.1 05:14:59 INFO - blessings == 1.6 05:14:59 INFO - blobuploader == 1.2.4 05:14:59 INFO - docopt == 0.6.1 05:14:59 INFO - functools32 == 3.2.3-2 05:14:59 INFO - jsonschema == 2.5.1 05:14:59 INFO - manifestparser == 1.1 05:14:59 INFO - mozInstall == 1.12 05:14:59 INFO - mozcrash == 0.17 05:14:59 INFO - mozdebug == 0.1 05:14:59 INFO - mozdevice == 0.48 05:14:59 INFO - mozfile == 1.2 05:14:59 INFO - mozhttpd == 0.7 05:14:59 INFO - mozinfo == 0.9 05:14:59 INFO - mozleak == 0.1 05:14:59 INFO - mozlog == 3.2 05:14:59 INFO - moznetwork == 0.27 05:14:59 INFO - mozprocess == 0.22 05:14:59 INFO - mozprofile == 0.28 05:14:59 INFO - mozrunner == 6.11 05:14:59 INFO - mozscreenshot == 0.1 05:14:59 INFO - mozsystemmonitor == 0.3 05:14:59 INFO - moztest == 0.7 05:14:59 INFO - mozversion == 1.4 05:14:59 INFO - psutil == 3.1.1 05:14:59 INFO - requests == 1.2.3 05:14:59 INFO - wsgiref == 0.1.2 05:14:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:59 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:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 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:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 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 0x7f60bc4fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a1c0>, '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 0x1c4b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', '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:14:59 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:14:59 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:14:59 INFO - Using env: {'DISPLAY': ':0', 05:14:59 INFO - 'HOME': '/home/cltbld', 05:14:59 INFO - 'LANG': 'en_US.UTF-8', 05:14:59 INFO - 'LANGUAGE': 'en_US:en', 05:14:59 INFO - 'LOGNAME': 'cltbld', 05:14:59 INFO - 'MAIL': '/var/mail/cltbld', 05:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:59 INFO - 'MOZ_NO_REMOTE': '1', 05:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:59 INFO - 'NO_EM_RESTART': '1', 05:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:59 INFO - 'PWD': '/builds/slave/test', 05:14:59 INFO - 'SHELL': '/bin/bash', 05:14:59 INFO - 'SHLVL': '1', 05:14:59 INFO - 'TERM': 'linux', 05:14:59 INFO - 'TMOUT': '86400', 05:14:59 INFO - 'USER': 'cltbld', 05:14:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', 05:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:59 INFO - '_': '/tools/buildbot/bin/python'} 05:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:59 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:14:59 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:14:59 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:14:59 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:14:59 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:14:59 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:14:59 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:14:59 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:14:59 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:14:59 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:14:59 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:14:59 INFO - Cleaning up... 05:14:59 INFO - Return code: 0 05:14:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:14:59 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:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 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:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 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 0x7f60bc4fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a1c0>, '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 0x1c4b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', '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:14:59 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:14:59 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:14:59 INFO - Using env: {'DISPLAY': ':0', 05:14:59 INFO - 'HOME': '/home/cltbld', 05:14:59 INFO - 'LANG': 'en_US.UTF-8', 05:14:59 INFO - 'LANGUAGE': 'en_US:en', 05:14:59 INFO - 'LOGNAME': 'cltbld', 05:14:59 INFO - 'MAIL': '/var/mail/cltbld', 05:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:59 INFO - 'MOZ_NO_REMOTE': '1', 05:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:59 INFO - 'NO_EM_RESTART': '1', 05:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:59 INFO - 'PWD': '/builds/slave/test', 05:14:59 INFO - 'SHELL': '/bin/bash', 05:14:59 INFO - 'SHLVL': '1', 05:14:59 INFO - 'TERM': 'linux', 05:14:59 INFO - 'TMOUT': '86400', 05:14:59 INFO - 'USER': 'cltbld', 05:14:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', 05:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:59 INFO - '_': '/tools/buildbot/bin/python'} 05:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:14:59 INFO - Cleaning up... 05:14:59 INFO - Return code: 0 05:14:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:14:59 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:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 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:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 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 0x7f60bc4fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a1c0>, '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 0x1c4b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', '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:14:59 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:14:59 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:14:59 INFO - Using env: {'DISPLAY': ':0', 05:14:59 INFO - 'HOME': '/home/cltbld', 05:14:59 INFO - 'LANG': 'en_US.UTF-8', 05:14:59 INFO - 'LANGUAGE': 'en_US:en', 05:14:59 INFO - 'LOGNAME': 'cltbld', 05:14:59 INFO - 'MAIL': '/var/mail/cltbld', 05:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:59 INFO - 'MOZ_NO_REMOTE': '1', 05:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:59 INFO - 'NO_EM_RESTART': '1', 05:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:59 INFO - 'PWD': '/builds/slave/test', 05:14:59 INFO - 'SHELL': '/bin/bash', 05:14:59 INFO - 'SHLVL': '1', 05:14:59 INFO - 'TERM': 'linux', 05:14:59 INFO - 'TMOUT': '86400', 05:14:59 INFO - 'USER': 'cltbld', 05:14:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', 05:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:59 INFO - '_': '/tools/buildbot/bin/python'} 05:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:59 INFO - Downloading/unpacking flake8 05:14:59 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:14:59 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:14:59 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:14:59 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:14:59 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:14:59 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:15:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:15:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:15:01 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:15:01 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:15:01 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:15:01 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:15:01 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:15:01 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:15:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:15:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:15:01 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:15:01 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:15:01 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:15:01 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:15:01 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:15:01 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:15:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:15:02 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:15:02 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:15:02 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:15:02 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:15:02 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:15:02 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:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:15:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:02 INFO - no previously-included directories found matching 'docs/_build' 05:15:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:15:02 INFO - Running setup.py install for pep8 05:15:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:02 INFO - no previously-included directories found matching 'docs/_build' 05:15:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:15:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:15:02 INFO - Cleaning up... 05:15:02 INFO - Return code: 0 05:15:02 INFO - Running post-action listener: _resource_record_post_action 05:15:02 INFO - Running post-action listener: _start_resource_monitoring 05:15:02 INFO - Starting resource monitoring. 05:15:02 INFO - ##### 05:15:02 INFO - ##### Finished create-virtualenv step (success) 05:15:02 INFO - ##### 05:15:02 INFO - ##### 05:15:02 INFO - ##### Running install step. 05:15:02 INFO - ##### 05:15:02 INFO - Running pre-action listener: _resource_record_pre_action 05:15:02 INFO - Running main action method: install 05:15:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:02 INFO - Reading from file tmpfile_stdout 05:15:02 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:02 INFO - Reading from file tmpfile_stdout 05:15:02 INFO - Output received: 05:15:02 INFO - Usage: mozinstall [options] installer 05:15:02 INFO - Options: 05:15:02 INFO - -h, --help show this help message and exit 05:15:02 INFO - -d DEST, --destination=DEST 05:15:02 INFO - Directory to install application into. [default: 05:15:02 INFO - "/builds/slave/test"] 05:15:02 INFO - --app=APP Application being installed. [default: firefox] 05:15:02 INFO - mkdir: /builds/slave/test/build/application 05:15:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:15:18 INFO - Reading from file tmpfile_stdout 05:15:18 INFO - Output received: 05:15:18 INFO - /builds/slave/test/build/application/firefox/firefox 05:15:18 INFO - Running post-action listener: _resource_record_post_action 05:15:18 INFO - ##### 05:15:18 INFO - ##### Finished install step (success) 05:15:18 INFO - ##### 05:15:18 INFO - ##### 05:15:18 INFO - ##### Running run-tests step. 05:15:18 INFO - ##### 05:15:18 INFO - Running pre-action listener: _resource_record_pre_action 05:15:18 INFO - Running main action method: run_tests 05:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:18 INFO - Python 2.7.3 05:15:18 INFO - Return code: 0 05:15:18 INFO - grabbing minidump binary from tooltool 05:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a1c0>, '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 0x1c4b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:15:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:15:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:15:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:18 INFO - Return code: 0 05:15:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:15:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:15:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:15:19 INFO - Return code: 0 05:15:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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:15:19 INFO - Using env: {'DISPLAY': ':0', 05:15:19 INFO - 'HOME': '/home/cltbld', 05:15:19 INFO - 'LANG': 'en_US.UTF-8', 05:15:19 INFO - 'LANGUAGE': 'en_US:en', 05:15:19 INFO - 'LOGNAME': 'cltbld', 05:15:19 INFO - 'MAIL': '/var/mail/cltbld', 05:15:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:19 INFO - 'MOZ_NO_REMOTE': '1', 05:15:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:19 INFO - 'NO_EM_RESTART': '1', 05:15:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:19 INFO - 'PWD': '/builds/slave/test', 05:15:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:19 INFO - 'SHELL': '/bin/bash', 05:15:19 INFO - 'SHLVL': '1', 05:15:19 INFO - 'TERM': 'linux', 05:15:19 INFO - 'TMOUT': '86400', 05:15:19 INFO - 'USER': 'cltbld', 05:15:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067', 05:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:19 INFO - '_': '/tools/buildbot/bin/python'} 05:15:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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:15:20 INFO - mozversion application_buildid: 20160606030429 05:15:20 INFO - mozversion application_changeset: 7fc6eedd33484ae8679bde3ae600563d2b457f4e 05:15:20 INFO - mozversion application_display_name: Nightly 05:15:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:20 INFO - mozversion application_name: Firefox 05:15:20 INFO - mozversion application_remotingname: firefox 05:15:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:15:20 INFO - mozversion application_vendor: Mozilla 05:15:20 INFO - mozversion application_version: 49.0a1 05:15:20 INFO - mozversion platform_buildid: 20160606030429 05:15:20 INFO - mozversion platform_changeset: 7fc6eedd33484ae8679bde3ae600563d2b457f4e 05:15:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:15:20 INFO - mozversion platform_version: 49.0a1 05:15:20 INFO - using testdate: 1465215320 05:15:20 INFO - actual date: 1465215320 05:15:20 INFO - starting webserver on 'localhost:59986' 05:15:20 INFO - SUITE-START | Running 2 tests 05:15:20 INFO - TEST-START | dromaeo_css 05:15:20 INFO - operating with platform_type : linux_ 05:15:20 INFO - Initialising browser for dromaeo_css test... 05:15:20 INFO - TEST-INFO | started process 16116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFhW1c1/profile http://localhost:59986/getInfo.html) 05:15:24 INFO - PROCESS | 16116 | __metrics Screen width/height:1600/1200 05:15:24 INFO - PROCESS | 16116 | colorDepth:24 05:15:24 INFO - PROCESS | 16116 | Browser inner width/height: 1024/697 05:15:24 INFO - PROCESS | 16116 | __metrics 05:15:25 ERROR - PROCESS | 16116 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 05:15:26 INFO - TEST-INFO | 16116: exit 0 05:15:26 INFO - Browser initialized. 05:15:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:26 INFO - TEST-INFO | started process 16235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFhW1c1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:38 INFO - PROCESS | 16235 | RSS: Main: 168214528 05:15:38 INFO - PROCESS | 16235 | 05:16:28 INFO - PROCESS | 16235 | 1465215388204 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:18:39 INFO - PROCESS | 16235 | Cycle 1(1): loaded http://localhost:59986/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59986/tests/dromaeo/cssquery-ext.html) 05:18:40 INFO - PROCESS | 16235 | RSS: Main: 170790912 05:18:40 INFO - PROCESS | 16235 | 05:21:42 INFO - PROCESS | 16235 | Cycle 1(1): loaded http://localhost:59986/tests/dromaeo/cssquery-ext.html (next: http://localhost:59986/tests/dromaeo/cssquery-jquery.html) 05:21:43 INFO - PROCESS | 16235 | RSS: Main: 170270720 05:21:43 INFO - PROCESS | 16235 | 05:24:45 INFO - PROCESS | 16235 | Cycle 1(1): loaded http://localhost:59986/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59986/tests/dromaeo/cssquery-mootools.html) 05:24:46 INFO - PROCESS | 16235 | RSS: Main: 171655168 05:24:46 INFO - PROCESS | 16235 | 05:27:47 INFO - PROCESS | 16235 | Cycle 1(1): loaded http://localhost:59986/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59986/tests/dromaeo/cssquery-prototype.html) 05:27:48 INFO - PROCESS | 16235 | RSS: Main: 169332736 05:27:48 INFO - PROCESS | 16235 | 05:30:51 INFO - PROCESS | 16235 | Cycle 1(1): loaded http://localhost:59986/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59986/tests/dromaeo/cssquery-yui.html) 05:30:52 INFO - PROCESS | 16235 | RSS: Main: 171515904 05:30:52 INFO - PROCESS | 16235 | 05:33:54 INFO - PROCESS | 16235 | Cycle 1(1): loaded http://localhost:59986/tests/dromaeo/cssquery-yui.html (next: http://localhost:59986/tests/dromaeo/cssquery-dojo.html) 05:33:54 INFO - PROCESS | 16235 | RSS: Main: 172380160 05:33:54 INFO - PROCESS | 16235 | 05:33:54 INFO - PROCESS | 16235 | __start_tp_report 05:33:54 INFO - PROCESS | 16235 | _x_x_mozilla_page_load 05:33:54 INFO - PROCESS | 16235 | _x_x_mozilla_page_load_details 05:33:54 INFO - PROCESS | 16235 | |i|pagename|runs| 05:33:54 INFO - PROCESS | 16235 | |0;dojo.html;2686.5835795451703;2687.7177896320873;2701.2166471723203;2707.363769514165;2737.4661940921515;4703.764811759415;4766;4801.711897286165;4812.037592481504;4863.513648635135;4738.881527961803;4765.737884416356;4810.302506136608;4813.518648135185;4820.0600882827775;4233.44965154531;4349.565043495657;4423.88940276494;4494.550544945512;4530.501644819067;4427.933580996288;4499.257622492285;4506.1663592235545;4553.635709143277;4566.246569316058;4345.261305578059;4389.517153113155;4395.63735242076;4413.404190434282;4418.823247070113;4416.668749843775;4425.645948324126;4431.778411079433;4444.755538445384;4468.5531446855375;4333.71830830995;4377.518472967971;4412.029353542215;4456.353828694853;4456.598906098467;4627.699199552018;4708.176069187913;4722.716637001757;4726.054789042205;4741.596964258042;5154.12379895415;5170.57648557425;5183.50756678115;5187.481251874782;5212.713300768456;5092.821751238689;5144.536991670768;5222.4255331913455;5224.817131400421;5229.241759944786;4806.49531799163;4829;4833.3958255218095;4874.439439464436;4877.12211801879;5267.104592219332;5267.446918073624;5271.235670827785;5277.102892508283;5296.099663057213;5004.124278251292;5049.520295571915;5058.418281897629;5077.949220507821;5097;4978.751062446863;5134.691918484903;5136.4606716295;5164.483551644806;5183.403908550489;5123.2827404163445;5127.589792816566;5131.435542090367;5133.383993920754;5172.069027574998;4900.8774780630765;5049.2173713074535;5101.2603172539775;5128.1282182029145;5143.794248230029;4327.697061205686;4328.891777705582;4332.285172946428;4352.760598167068;4361.542038085955;3738.813059347076;3781.054736315921;3792.070942619021;3794.5446546414605;3821.082940094413;4475.060237350128;4486.147631949919;4545.6817522918645;4547.9312361595;4550.817967281338;5201.375834899836;5206.062908676399;5224.242484839677;5226.033183860998;5236.136037553837;4382.035952090599;4460.955390446119;4525.04973955473;4535.818567257273;4586.036932244266;4603.838865639686;4627.213373726475;4640.443146822403;4642.303654451859;4686.250199968057;4861.27080937855;4866.756662166948;4898.853034408973;4902.8774280643265;4938.703677779345;4953.578945789648;5133.101707201299;5135.8716032098;5177.249298851721;5212.530872221519;4882.316475693477;4905.190643543775;4906.092372911023;4922.92615610759;4961.925571116509;5128.205128205134;5132.5893928486375;5138.049460849755;5141.357330333708;5179.249008893765;5024.171011783015;5143.794248230029;5185.455527169593;5191.32512773337;5192.350956130484;4840.685355451885;4984.102861484967;4997.325361076353;5004.5746111579465;5066.670666406671;5051.368578927634;5063.13926632466;5063.544281014726;5066.518680725325;5111.412187598474;4817.1810792164715;4873.049755297683;4975.577075948585;4978.601711863114;4990.051890141007;5061.898762024665;5107.233914912793;5119.923201151912;5142.6400151989;5173.844784656466;5000.224965130411;5031.723255220998;5033.773480193473;5034.244863270539;5092 05:33:54 INFO - PROCESS | 16235 | |1;ext.html;542.1874151289053;588.8881112588608;598.7186022569391;606.939306069393;625.4089885058621;34274.143146421324;37757.24485510295;37885.62114378855;37916.81041594792;37964.43053354202;37943.4308485373;38554;38713.41929871054;38891;38934.610653893455;7433.33100020998;7553.433492488058;7554.735584254552;7560.357369623589;7568.62156892156;7537.54774713519;7671.731489397872;7686.923130768705;7693.615319234043;7710.460267781257;7668.961655191716;7699.88450173245;7720.227977202291;7728;7744.109427415835;7612.467127301091;7626.122995855492;7627.122880868716;7716.6527506262355;7717.228277172294;7614;7689.807754806118;7693.153753087212;7703.3067023968115;7728.381729461686;36175.81912090423;36330.910072697865;36530.8173459131;36600.26799464023;36675.26649467022;3204.7115759581516;3211.1811488070393;3302.290007648343;3350.5811773528308;3646.6717995380545;28862.855685721435;28923.276918077005;29018.854905725337;29388;29535;3272.918177045569;3390.69483746464;3417.419038763416;3435.553378060836;3460.602030766444;230003.44970677514;230329;231117.84441077855;231194;232377;31680.36639267202;32600.510992335134;51900.74049629728;52374.21438678423;52420.21369679458;33974.49038264428;34064.65935340615;34088.318233635684;34146.317073658385;34305;12059.276443413248;12159.574414895436;12193.45129469176;12236.327002014974;12289.1397602167;9671;9840.409575425498;9846.556904939294;9853.950730246446;9878.753031174134;7906.723264685708;7916;7963.362930965509;7995.440319177718;8054.154313797084;3151.8266495342978;3172.952405713916;3214.3249917517114;3221.597300337458;3239.2286698581775;897.7037577599376;937.7186843946926;981.2640519610293;998.6155330197781;1004.6282875336026;27277.181684549494;28179.43641127207;28415.71584284172;28706.569401458994;28946;1001.47923079998;1022.2026819081128;1046.9371837689612;1071.2661826648614;1100.2243418390176;14912.328945197492;15140.697186056217;15265.923670381577;15442;15549.455769048029;358545;360303;361530;361664;361825;48311.5168848307;48753.268700969515;48838.26742598864;49091;49237.261441078415;1158.1082566423975;1171.2855158353398;1197.6227488341144;1204.8192771084232;1235.0490122605543;26978.190654280403;28040.85979570089;28161.577576336782;28395.716042840133;28457.288567785145;42131.789341054326;42381.57618423776;42456.36315455209;42689.786551067045;42728.78635606802;329387;330661;331612;332267;332417;24992;25111.372215694755;25376.74623253818;25864.741352586232;25867.482650347265;42011.579884200764;42517.787411062745;42834.785826071915;43097;43210.78394608007;36631;36990.44514332341;37076;37532.624673752915;37731;36608.81695591505;36860.81569592135;37106.628933710315;37142.44286335761;37697.2460550793;30690.386192275582;35794.64205358017;36232.81883590565;36320.81839590785;39357.409638856014;31971.040868773973;32994.835025824716;33164.33671326608;33284.33431331311;33395.165120872174;23554.175603853782;23558.764412355657;23658.171963981178;23663;23789.524209516057 05:33:54 INFO - PROCESS | 16235 | |2;jquery.html;346.92887957968605;352.202261876849;359.14702581369244;365.8701161087812;367.94112941929296;15828.762568561466;16576.75134872978;17350.82649173508;17358.56603584911;17639.82360176398;15975.440859569888;16453.25960331785;17300.56748581283;17338.133093345346;17371;4977.328060711812;5123.513266239701;5130.6152038597065;5148.279240906258;5190.662606930538;3713.8700145494913;5045.772940217699;5714.685692286923;6032.125341825433;6050.2437195350585;6046.848828779293;6047.818565443044;6068.393160683919;6071.423214794588;6093.360197179299;4854.635902307324;5151.459096794839;5185;5248.265242866002;5255.500727430888;5094.083065048289;5120.436751957282;5125.718085505296;5288.391834938954;5311.840644780663;11501.252418592849;11575.652730418102;11614.709632259177;11706.122040846885;16283.348666053344;1833.9174737136727;1846.2984066054948;1940.233607724955;1941.679622862226;1998.2107067708173;8248.505089694578;8417.11620279868;8589.35579831509;8624.784380390478;8685.392022558424;1715.5453804741753;1747.484492074841;1804.0979510244877;1825.6531259060869;1828.2778302570543;66145;69781.65109174473;69804;69847.65076174638;69930.30069699288;8348.916510834813;8439.95780021096;9700.835899691941;9752.073553012453;9793.559289831976;13032.152910060815;13067.281299528428;13092.476300948047;13193.47226110964;13199.868001320056;7340.11918569775;7343.816404589928;7348.816279593053;7428.73999410018;7432.2567743225245;7037.824054398681;7217.74737884182;7240.818979525554;7295.890561641473;7349.118105827335;4009.51885773709;4060.6548443382644;4089.591040895946;4098.180363927167;4223.472065991751;1581.6915701438108;1662.3267576631483;1698.8640908727273;1728.87897847152;1738.8435040846384;849.748553936665;858.888344515209;866.1425189062909;948.7580666930027;978.2272005116021;15687;16117.355305787873;16290.83709162917;16959.15204239783;17095.059771712426;874.5670892908051;876.4084243135858;880.7709995401242;890.8262888736764;912.4160537256162;9357.859632105525;9392.577334019848;9427.689857668984;9458.385204961656;9564.569594368131;394165;394513;395162;395460;397469;70594.88215353548;78296.21703783004;79992;80221;81978;912.3795818843117;915.8992510823804;957.5355952363099;962.4369743700014;967.6516454076527;15176.392944282547;15503.689926201187;15507.457238997033;15605.531834044998;16005.03969761818;35536.64463355333;36295;36613.26773464462;36903.44644830383;36975.81512092422;47633;48905.02189956252;49248.50751492439;49785.75107124441;50937.74531127469;7302.795038818748;7475.028246327943;7537.321641052332;7570.735024274124;7822.5697586631;7879.566623835744;11017.614383496539;12053.51785928553;12111.515539378679;12142.453589588313;10100.343477674222;10245.590176392861;10435.217358697977;10457.738556536147;10599.205059620714;10326.380417174994;10367.118794902517;10433.53049112807;10519.631812886511;10645.574177032831;9573.803274590677;10403.075431045281;10484.947575262075;10564.313319634199;10671.57313707443;7250.3112204340505;7593.506422082547;7626.161122276434;7689.692412303445;7694.07671079474;9093.590788414405;9764.316497845082;10109.443980581138;10159.44123073238;10364.896351036394 05:33:54 INFO - PROCESS | 16235 | |3;mootools.html;1421.6090575091846;1464.2971373740604;1585.6749366379893;1751.982480175198;1758.629804934736;6876.2092359378685;7519.097708275008;7771.4171437142295;7946.086200086992;7950.880736788953;7780.92219077809;7980.800479988004;7983.680652773882;7994.880076798838;8036.116027237013;2168.9566208675856;2201.438633148545;2203.4050806282294;2206.58074965756;2215.180383258197;2173.6630822222583;2204.7795220477906;2214.7674494178123;2215.3907675389237;2217.833662475313;2166.880821554814;2170.2295685031822;2188.715466989297;2193.5393567350875;2231.319447568491;2122.7028216049766;2124.5538436928264;2130.137294395772;2132.914683412662;2140;2132.115172203534;2160.3087012156116;2164.448065743241;2184.421128400975;2196.967045494319;7955.204479552056;8026.799330016738;8028.438009339348;8045.155258697811;8049.476784009079;4534.8186072557055;4598.517155698671;4640;4654.069186162781;4670.743109128996;2815.53543665295;2930.208843612234;2978.106568029604;3009.1273530676076;3029.803062800911;879.2438502887512;892.1702816380763;892.2193081054078;896.0591379052034;925.6019911438079;10555;10581.418022008786;10732.892671073267;10763.94618026905;10769.192310576738;4159.542450330461;4231.640310573574;4310.655147588185;4319.632831209319;4328.523862375137;9122.179003889682;9204.171624553688;9206.815863682688;9258.72223833286;9279.907200927904;4451.621612162938;4503.729776213438;4551.249043907718;4576.97711511447;4604.40142781443;3684.613115622875;3930.2532518821904;4107.219628270619;4165.479315085614;4172.4784401949755;3607.422812350064;3630.2013557017412;3707.7589956652732;3776.263628592398;3799.430085487199;1169.561414469574;1202.753435545711;1205.626255860686;1220.926744395339;1238.2694210415898;744.5867543513402;853.4623187392027;868.3096937934231;880.6213328268906;891.0243283604443;5393.8112166074;5604.103343465107;5666.036773748473;5700.344460387026;5764.798232061941;402.98992525187106;420.4492115328929;420.89477630592353;425.75944591305813;426.039281420395;3780.7353485255767;3890.844366225376;3925.2738243425056;3946.131850992777;3946.2896678598127;9389.953050234704;9793.951030244803;9821.607135714634;9837.458939758382;9876.604935802487;9270.814583708288;9587.18508926735;9699.418034917928;9705.951470242744;9769.169620582188;7177.89233161503;7287.052683151051;7290.817729556804;7300.941363502262;7385.889211661829;5590.692511911884;5752.71236438168;5788.681622510802;5835;5968.343482217039;8929.866052009354;9049.32130090259;9114.589843457194;9125.22435592982;9228.907710922806;9147.954260228656;9203.815923681355;9234.353595248269;9360.672376466791;9376.29677774156;6140.324564298013;6564.606123632407;6808.183018037867;6823.38589526945;7024.227334993249;7502.699892004477;7531.171571127281;7733.458657893893;7750.8837367440665;7753.689852405841;6570.145881035626;6684.766033188815;6726.966365168143;6760.391564759196;6777;6705.396514313735;6715.328467153246;6733.562318449285;6823.420009299265;6858.108445902001;6396.456301214263;6616.90074648871;6675.666216689243;6685.364890335605;6708.161479815023;4813.085513752376;4907.0431265904235;4945.2582112683385;5042.243663450512;5043.87390315245;5004.5746111579465;5049.520295571915;5061.089003979172;5071.315372424823;5113.693178409308 05:33:54 INFO - PROCESS | 16235 | |4;prototype.html;280.17209146970714;280.5973428130632;285.39923461114347;288.06092139624815;290.645412596632;4837.201861692825;4929.852104436873;4942.258661200822;5044.4198917124495;5052.646314757963;4828.637852161084;4914.827981020665;4957.677750946186;4960.767654555447;4968.2795994580765;3885.737135430982;3896.162325100103;3903.8243279052513;3908.257431088084;3911.765294082364;3620.294042661682;3877.8836634901;3888.416737489371;3890.455336252927;3924.2936271471126;3762.2475504898994;3797.6012518685416;3799.145192331717;3803.3724435468116;3815.2560250751117;3815.637514436124;3817.1602247505502;3823.350030494809;3830.735857167142;3837.2325534892852;3315.8673653053847;3325.5676762021026;3335.4329763940186;3337.8831740889195;3343.8829640962695;4715.53818316323;4754.477007529169;4760.715106576451;4841;4853.3690620219495;4287.271163902113;4331.935020974688;4347.891302717426;4352.956470435287;4364.039911219526;5180.792768289301;5181.533661970403;5215.895682086375;5225.477452254782;5232.372115346183;3457.59967213279;3613.728970327236;3659.4144936809985;3659.670629643318;3661.340958627446;5442.8025834315995;5450.31871016123;5479.123460183396;5489.313835770528;5506.871091426248;3678;3686.668199862025;3696.6303369663356;3702.185519185775;3703.370427027412;3743.6630703236838;3746.2882052409955;3751.643593858579;3755.830987605564;3757.812109394519;4077.429159917614;4264.552222016706;4273.572642735764;4290.785460726951;4298.237722533746;5199.714015729096;5225.346831646044;5244.396894357122;5263.789448422097;5287;1230.329470438613;1302.2967597497245;1320.8348956380453;1321.6299436157892;1327.6415367850818;846.1792061700141;851.9829603407898;869.8782170496136;872.616048938465;873.5719497446206;4141.461609990682;4156.189543039079;4173.9582604173565;4181.330987042059;4204.078165674888;4815.566599006106;4818.469968303484;4825.638077144158;4849.830255941025;4849.908770526674;4126.484189476316;4131.648809851136;4167.229062623424;4169.020280234143;4213.620774130343;2420.2618201448377;2511.309389917787;2518.5199956130264;2548.7128999854954;2560.257525317674;4486.080353527519;4511.5262897395305;4521.977390113028;4533.526603853761;4556.407667003268;4922.458529561745;4939;4946.455889852114;4966.063235338221;4966.925496117561;4588.325261279676;4684.765761711901;5139.8458046258675;5145.768440420115;5147.613928955268;5414.269073675004;5420.186971954238;5435.211894275387;5443.755031023535;5458.771776350448;5249;5333.839984800462;5355.410904800391;5358.490943360374;5380.650257733235;5064.44291127983;5094.2867998479505;5100.005498927673;5110.207917772751;5126.974605079074;3707.610700876477;3729.254149170231;3755.3052685253315;3755.530558680165;3763.7365384423924;4897.363342765418;5382.039878067126;5408.729563521887;5470.234167216672;5492.670439773627;5181.248718935658;5211.583073354047;5248.160294352885;5255.211718242294;5267.420583735862;5233.450487698737;5238.895222095461;5264.684118952875;5273.789048438173;5282.603804714585;4969.701817890938;5157.174852023658;5197.454267301879;5206.97396513015;5245.554127899019;5310.9734451327495;5312.362516498045;5325.281087053353;5326.721586819213;5334.919976200437;5172.948270517247;5188;5202.24567437727;5243.764030618555;5268.181522885238 05:33:54 INFO - PROCESS | 16235 | |5;yui.html;633.8637193003503;663.293592324175;677.6848765324123;711.2922641971239;719.3849258883654;12216.81674774878;12931.288779117145;13111.475540978361;13113.47546098156;13147.145435546683;12063;12268.63194104176;12281.938590307058;12374.381280935962;12484.126111172221;631.2708821311393;778.9182135875736;788.8698364769834;789.9960500197519;790.3874497264609;778.6068035641993;779.6842278877035;780.6252998560694;801.8516574433719;802.1417083720421;830.1117803949776;830.1408042675831;836.3768992100863;837.5644664774313;837.694241601814;826.050042451186;827.1686954610608;827.896512935883;828.7638023163399;829.9917000829975;598.5032423088826;599.1252770954412;600.6456190847421;601.6089541797822;605.7516418268489;12034.578789742405;12044.759104817855;12046.337451440168;12053.698657533632;12078.69803254917;13209.669758256025;13462;13510.932445337809;13511.527096551574;13724.93137534316;10589.947050264776;10620.57517699291;10669.786604267949;10788.352698838095;10893.237473376867;3369.8652053917813;3383.340248651514;3429.5198672185916;3455.188030812757;3477;51243.48756512462;51883.22175167376;51952.480475195145;56361.71819140919;56497;9883.752906177404;9986;10061.144802691706;10198;10264.897351026544;16812.57968550796;16955.406560770312;17088.145592720564;17159.31362745476;17191.742123868153;6940.583564986117;7113.608751518716;7151.89272160918;7168.856622867514;7245;3893.2408180405114;3921.6274453927404;3925.9214815703526;3973.0663294125857;3986.0234242610168;3069.63164420271;3165.984170079135;3169.207698075481;3171.6669749675953;3172.2386627209767;548.9423610520918;553.6097051578628;564.5737468211474;564.7232855900579;576.2364866551752;577.8468705792968;616.8365383173463;623.5977794322637;630.7508534128993;631.3654776949137;7739.729109481141;7869.763907082796;7999.400044996649;8196.713115040944;8292.792680183044;484.8739327774804;551.6882961126951;594.3462191589304;597.7698586044404;606.5269090109722;3798.8100594970692;3805.296020236265;3912.315344814646;3966.7421617594764;4070.5115386153852;68815.65592172107;71818;72550;83440;88556.5572172148;52229.47770522246;74512.62743686355;75106.24893750992;75693.62153189199;76025;47645.5235447648;71822.64088679523;72323.6383818088;72451.27548724551;72913;8653.740387788377;8897.777555561162;9119.726408207764;9133.497657628894;9176.495292758962;31663.52504712477;39843.402348964206;42237;43813.34279985739;44491.77754111209;36787;53475.465245348605;54766.72616636891;59391.703041484514;61276.38723612707;10810.729731756768;11021.173411994292;11196.552137914718;11199.328040317607;11395.316281023164;11799.49829690226;11899.464524096264;11912.285262884254;12127.878721213028;12159.756804863677;11626.186166968231;11682.357470339213;11744.354060526412;11977;12355.567555135527;11765.294082355085;11839.171258011856;12024.038076953997;12078.094142939139;12187.573434929735;11096.833547496955;11201.495932682887;11339.433028348385;11393.316401015965;11509.366984815915;9634.807303854024;9708.708738737849;9933.227407946488;9966.202703783825;10215.94892025535;9878.357906736039;10029.849552256575;10066.54700538463;10213.08082272599;10250 05:33:54 INFO - PROCESS | 16235 | __end_tp_report 05:33:54 INFO - PROCESS | 16235 | __start_cc_report 05:33:54 INFO - PROCESS | 16235 | _x_x_mozilla_cycle_collect,385 05:33:54 INFO - PROCESS | 16235 | __end_cc_report 05:33:54 INFO - PROCESS | 16235 | __startTimestamp1465216434839__endTimestamp 05:33:54 INFO - PROCESS | 16235 | 05:33:54 INFO - PROCESS | 16235 | ------- Summary: start ------- 05:33:54 INFO - PROCESS | 16235 | Number of tests: 6 05:33:54 INFO - PROCESS | 16235 | 05:33:54 INFO - PROCESS | 16235 | [#0] dojo.html Cycles:165 Average:4768.78 Median:4900.88 stddev:502.01 (10.2%) stddev-sans-first:476.24 05:33:54 INFO - PROCESS | 16235 | Values: 2686.6 2687.7 2701.2 2707.4 2737.5 4703.8 4766.0 4801.7 4812.0 4863.5 4738.9 4765.7 4810.3 4813.5 4820.1 4233.4 4349.6 4423.9 4494.6 4530.5 4427.9 4499.3 4506.2 4553.6 4566.2 4345.3 4389.5 4395.6 4413.4 4418.8 4416.7 4425.6 4431.8 4444.8 4468.6 4333.7 4377.5 4412.0 4456.4 4456.6 4627.7 4708.2 4722.7 4726.1 4741.6 5154.1 5170.6 5183.5 5187.5 5212.7 5092.8 5144.5 5222.4 5224.8 5229.2 4806.5 4829.0 4833.4 4874.4 4877.1 5267.1 5267.4 5271.2 5277.1 5296.1 5004.1 5049.5 5058.4 5077.9 5097.0 4978.8 5134.7 5136.5 5164.5 5183.4 5123.3 5127.6 5131.4 5133.4 5172.1 4900.9 5049.2 5101.3 5128.1 5143.8 4327.7 4328.9 4332.3 4352.8 4361.5 3738.8 3781.1 3792.1 3794.5 3821.1 4475.1 4486.1 4545.7 4547.9 4550.8 5201.4 5206.1 5224.2 5226.0 5236.1 4382.0 4461.0 4525.0 4535.8 4586.0 4603.8 4627.2 4640.4 4642.3 4686.3 4861.3 4866.8 4898.9 4902.9 4938.7 4953.6 5133.1 5135.9 5177.2 5212.5 4882.3 4905.2 4906.1 4922.9 4961.9 5128.2 5132.6 5138.0 5141.4 5179.2 5024.2 5143.8 5185.5 5191.3 5192.4 4840.7 4984.1 4997.3 5004.6 5066.7 5051.4 5063.1 5063.5 5066.5 5111.4 4817.2 4873.0 4975.6 4978.6 4990.1 5061.9 5107.2 5119.9 5142.6 5173.8 5000.2 5031.7 5033.8 5034.2 5092.0 05:33:54 INFO - PROCESS | 16235 | 05:33:54 INFO - PROCESS | 16235 | [#1] ext.html Cycles:180 Average:45064.72 Median:199028.91 stddev:82425.96 (41.4%) stddev-sans-first:82589.40 05:33:54 INFO - PROCESS | 16235 | Values: 542.2 588.9 598.7 606.9 625.4 34274.1 37757.2 37885.6 37916.8 37964.4 37943.4 38554.0 38713.4 38891.0 38934.6 7433.3 7553.4 7554.7 7560.4 7568.6 7537.5 7671.7 7686.9 7693.6 7710.5 7669.0 7699.9 7720.2 7728.0 7744.1 7612.5 7626.1 7627.1 7716.7 7717.2 7614.0 7689.8 7693.2 7703.3 7728.4 36175.8 36330.9 36530.8 36600.3 36675.3 3204.7 3211.2 3302.3 3350.6 3646.7 28862.9 28923.3 29018.9 29388.0 29535.0 3272.9 3390.7 3417.4 3435.6 3460.6 230003.4 230329.0 231117.8 231194.0 232377.0 31680.4 32600.5 51900.7 52374.2 52420.2 33974.5 34064.7 34088.3 34146.3 34305.0 12059.3 12159.6 12193.5 12236.3 12289.1 9671.0 9840.4 9846.6 9854.0 9878.8 7906.7 7916.0 7963.4 7995.4 8054.2 3151.8 3173.0 3214.3 3221.6 3239.2 897.7 937.7 981.3 998.6 1004.6 27277.2 28179.4 28415.7 28706.6 28946.0 1001.5 1022.2 1046.9 1071.3 1100.2 14912.3 15140.7 15265.9 15442.0 15549.5 358545.0 360303.0 361530.0 361664.0 361825.0 48311.5 48753.3 48838.3 49091.0 49237.3 1158.1 1171.3 1197.6 1204.8 1235.0 26978.2 28040.9 28161.6 28395.7 28457.3 42131.8 42381.6 42456.4 42689.8 42728.8 329387.0 330661.0 331612.0 332267.0 332417.0 24992.0 25111.4 25376.7 25864.7 25867.5 42011.6 42517.8 42834.8 43097.0 43210.8 36631.0 36990.4 37076.0 37532.6 37731.0 36608.8 36860.8 37106.6 37142.4 37697.2 30690.4 35794.6 36232.8 36320.8 39357.4 31971.0 32994.8 33164.3 33284.3 33395.2 23554.2 23558.8 23658.2 23663.0 23789.5 05:33:54 INFO - PROCESS | 16235 | 05:33:54 INFO - PROCESS | 16235 | [#2] jquery.html Cycles:180 Average:24119.07 Median:27112.92 stddev:65297.71 (240.8%) stddev-sans-first:65456.50 05:33:54 INFO - PROCESS | 16235 | Values: 346.9 352.2 359.1 365.9 367.9 15828.8 16576.8 17350.8 17358.6 17639.8 15975.4 16453.3 17300.6 17338.1 17371.0 4977.3 5123.5 5130.6 5148.3 5190.7 3713.9 5045.8 5714.7 6032.1 6050.2 6046.8 6047.8 6068.4 6071.4 6093.4 4854.6 5151.5 5185.0 5248.3 5255.5 5094.1 5120.4 5125.7 5288.4 5311.8 11501.3 11575.7 11614.7 11706.1 16283.3 1833.9 1846.3 1940.2 1941.7 1998.2 8248.5 8417.1 8589.4 8624.8 8685.4 1715.5 1747.5 1804.1 1825.7 1828.3 66145.0 69781.7 69804.0 69847.7 69930.3 8348.9 8440.0 9700.8 9752.1 9793.6 13032.2 13067.3 13092.5 13193.5 13199.9 7340.1 7343.8 7348.8 7428.7 7432.3 7037.8 7217.7 7240.8 7295.9 7349.1 4009.5 4060.7 4089.6 4098.2 4223.5 1581.7 1662.3 1698.9 1728.9 1738.8 849.7 858.9 866.1 948.8 978.2 15687.0 16117.4 16290.8 16959.2 17095.1 874.6 876.4 880.8 890.8 912.4 9357.9 9392.6 9427.7 9458.4 9564.6 394165.0 394513.0 395162.0 395460.0 397469.0 70594.9 78296.2 79992.0 80221.0 81978.0 912.4 915.9 957.5 962.4 967.7 15176.4 15503.7 15507.5 15605.5 16005.0 35536.6 36295.0 36613.3 36903.4 36975.8 47633.0 48905.0 49248.5 49785.8 50937.7 7302.8 7475.0 7537.3 7570.7 7822.6 7879.6 11017.6 12053.5 12111.5 12142.5 10100.3 10245.6 10435.2 10457.7 10599.2 10326.4 10367.1 10433.5 10519.6 10645.6 9573.8 10403.1 10484.9 10564.3 10671.6 7250.3 7593.5 7626.2 7689.7 7694.1 9093.6 9764.3 10109.4 10159.4 10364.9 05:33:54 INFO - PROCESS | 16235 | 05:33:54 INFO - PROCESS | 16235 | [#3] mootools.html Cycles:180 Average:5226.89 Median:5492.25 stddev:2926.20 (53.3%) stddev-sans-first:2920.44 05:33:54 INFO - PROCESS | 16235 | Values: 1421.6 1464.3 1585.7 1752.0 1758.6 6876.2 7519.1 7771.4 7946.1 7950.9 7780.9 7980.8 7983.7 7994.9 8036.1 2169.0 2201.4 2203.4 2206.6 2215.2 2173.7 2204.8 2214.8 2215.4 2217.8 2166.9 2170.2 2188.7 2193.5 2231.3 2122.7 2124.6 2130.1 2132.9 2140.0 2132.1 2160.3 2164.4 2184.4 2197.0 7955.2 8026.8 8028.4 8045.2 8049.5 4534.8 4598.5 4640.0 4654.1 4670.7 2815.5 2930.2 2978.1 3009.1 3029.8 879.2 892.2 892.2 896.1 925.6 10555.0 10581.4 10732.9 10763.9 10769.2 4159.5 4231.6 4310.7 4319.6 4328.5 9122.2 9204.2 9206.8 9258.7 9279.9 4451.6 4503.7 4551.2 4577.0 4604.4 3684.6 3930.3 4107.2 4165.5 4172.5 3607.4 3630.2 3707.8 3776.3 3799.4 1169.6 1202.8 1205.6 1220.9 1238.3 744.6 853.5 868.3 880.6 891.0 5393.8 5604.1 5666.0 5700.3 5764.8 403.0 420.4 420.9 425.8 426.0 3780.7 3890.8 3925.3 3946.1 3946.3 9390.0 9794.0 9821.6 9837.5 9876.6 9270.8 9587.2 9699.4 9706.0 9769.2 7177.9 7287.1 7290.8 7300.9 7385.9 5590.7 5752.7 5788.7 5835.0 5968.3 8929.9 9049.3 9114.6 9125.2 9228.9 9148.0 9203.8 9234.4 9360.7 9376.3 6140.3 6564.6 6808.2 6823.4 7024.2 7502.7 7531.2 7733.5 7750.9 7753.7 6570.1 6684.8 6727.0 6760.4 6777.0 6705.4 6715.3 6733.6 6823.4 6858.1 6396.5 6616.9 6675.7 6685.4 6708.2 4813.1 4907.0 4945.3 5042.2 5043.9 5004.6 5049.5 5061.1 5071.3 5113.7 05:33:54 INFO - PROCESS | 16235 | 05:33:54 INFO - PROCESS | 16235 | [#4] prototype.html Cycles:180 Average:4238.48 Median:4817.02 stddev:1264.39 (26.2%) stddev-sans-first:1232.53 05:33:54 INFO - PROCESS | 16235 | Values: 280.2 280.6 285.4 288.1 290.6 4837.2 4929.9 4942.3 5044.4 5052.6 4828.6 4914.8 4957.7 4960.8 4968.3 3885.7 3896.2 3903.8 3908.3 3911.8 3620.3 3877.9 3888.4 3890.5 3924.3 3762.2 3797.6 3799.1 3803.4 3815.3 3815.6 3817.2 3823.4 3830.7 3837.2 3315.9 3325.6 3335.4 3337.9 3343.9 4715.5 4754.5 4760.7 4841.0 4853.4 4287.3 4331.9 4347.9 4353.0 4364.0 5180.8 5181.5 5215.9 5225.5 5232.4 3457.6 3613.7 3659.4 3659.7 3661.3 5442.8 5450.3 5479.1 5489.3 5506.9 3678.0 3686.7 3696.6 3702.2 3703.4 3743.7 3746.3 3751.6 3755.8 3757.8 4077.4 4264.6 4273.6 4290.8 4298.2 5199.7 5225.3 5244.4 5263.8 5287.0 1230.3 1302.3 1320.8 1321.6 1327.6 846.2 852.0 869.9 872.6 873.6 4141.5 4156.2 4174.0 4181.3 4204.1 4815.6 4818.5 4825.6 4849.8 4849.9 4126.5 4131.6 4167.2 4169.0 4213.6 2420.3 2511.3 2518.5 2548.7 2560.3 4486.1 4511.5 4522.0 4533.5 4556.4 4922.5 4939.0 4946.5 4966.1 4966.9 4588.3 4684.8 5139.8 5145.8 5147.6 5414.3 5420.2 5435.2 5443.8 5458.8 5249.0 5333.8 5355.4 5358.5 5380.7 5064.4 5094.3 5100.0 5110.2 5127.0 3707.6 3729.3 3755.3 3755.5 3763.7 4897.4 5382.0 5408.7 5470.2 5492.7 5181.2 5211.6 5248.2 5255.2 5267.4 5233.5 5238.9 5264.7 5273.8 5282.6 4969.7 5157.2 5197.5 5207.0 5245.6 5311.0 5312.4 5325.3 5326.7 5334.9 5172.9 5188.0 5202.2 5243.8 5268.2 05:33:54 INFO - PROCESS | 16235 | 05:33:54 INFO - PROCESS | 16235 | [#5] yui.html Cycles:180 Average:15942.47 Median:25864.18 stddev:21330.26 (82.5%) stddev-sans-first:21359.12 05:33:54 INFO - PROCESS | 16235 | Values: 633.9 663.3 677.7 711.3 719.4 12216.8 12931.3 13111.5 13113.5 13147.1 12063.0 12268.6 12281.9 12374.4 12484.1 631.3 778.9 788.9 790.0 790.4 778.6 779.7 780.6 801.9 802.1 830.1 830.1 836.4 837.6 837.7 826.1 827.2 827.9 828.8 830.0 598.5 599.1 600.6 601.6 605.8 12034.6 12044.8 12046.3 12053.7 12078.7 13209.7 13462.0 13510.9 13511.5 13724.9 10589.9 10620.6 10669.8 10788.4 10893.2 3369.9 3383.3 3429.5 3455.2 3477.0 51243.5 51883.2 51952.5 56361.7 56497.0 9883.8 9986.0 10061.1 10198.0 10264.9 16812.6 16955.4 17088.1 17159.3 17191.7 6940.6 7113.6 7151.9 7168.9 7245.0 3893.2 3921.6 3925.9 3973.1 3986.0 3069.6 3166.0 3169.2 3171.7 3172.2 548.9 553.6 564.6 564.7 576.2 577.8 616.8 623.6 630.8 631.4 7739.7 7869.8 7999.4 8196.7 8292.8 484.9 551.7 594.3 597.8 606.5 3798.8 3805.3 3912.3 3966.7 4070.5 68815.7 71818.0 72550.0 83440.0 88556.6 52229.5 74512.6 75106.2 75693.6 76025.0 47645.5 71822.6 72323.6 72451.3 72913.0 8653.7 8897.8 9119.7 9133.5 9176.5 31663.5 39843.4 42237.0 43813.3 44491.8 36787.0 53475.5 54766.7 59391.7 61276.4 10810.7 11021.2 11196.6 11199.3 11395.3 11799.5 11899.5 11912.3 12127.9 12159.8 11626.2 11682.4 11744.4 11977.0 12355.6 11765.3 11839.2 12024.0 12078.1 12187.6 11096.8 11201.5 11339.4 11393.3 11509.4 9634.8 9708.7 9933.2 9966.2 10215.9 9878.4 10029.8 10066.5 10213.1 10250.0 05:33:54 INFO - PROCESS | 16235 | -------- Summary: end -------- 05:33:54 INFO - PROCESS | 16235 | 05:33:55 INFO - TEST-INFO | 16235: exit 0 05:33:55 INFO - TEST-OK | dromaeo_css | took 1115571ms 05:33:55 INFO - TEST-START | kraken 05:33:55 INFO - operating with platform_type : linux_ 05:33:55 INFO - Initialising browser for kraken test... 05:33:55 INFO - TEST-INFO | started process 16468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7tNCF4/profile http://localhost:59986/getInfo.html) 05:34:00 INFO - PROCESS | 16468 | __metrics Screen width/height:1600/1200 05:34:00 INFO - PROCESS | 16468 | colorDepth:24 05:34:00 INFO - PROCESS | 16468 | Browser inner width/height: 1024/697 05:34:00 INFO - PROCESS | 16468 | __metrics 05:34:00 ERROR - PROCESS | 16468 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 05:34:01 INFO - TEST-INFO | 16468: exit 0 05:34:01 INFO - Browser initialized. 05:34:01 INFO - Running cycle 1/1 for kraken test... 05:34:01 INFO - TEST-INFO | started process 16585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7tNCF4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:13 INFO - PROCESS | 16585 | RSS: Main: 167567360 05:34:13 INFO - PROCESS | 16585 | 05:34:16 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59986/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:17 INFO - PROCESS | 16585 | RSS: Main: 172961792 05:34:17 INFO - PROCESS | 16585 | 05:34:20 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59986/tests/kraken/driver.html?testName=audio-dft) 05:34:20 INFO - PROCESS | 16585 | RSS: Main: 172863488 05:34:20 INFO - PROCESS | 16585 | 05:34:23 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59986/tests/kraken/driver.html?testName=audio-fft) 05:34:24 INFO - PROCESS | 16585 | RSS: Main: 167608320 05:34:24 INFO - PROCESS | 16585 | 05:34:26 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59986/tests/kraken/driver.html?testName=audio-oscillator) 05:34:27 INFO - PROCESS | 16585 | RSS: Main: 168255488 05:34:27 INFO - PROCESS | 16585 | 05:34:29 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59986/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:30 INFO - PROCESS | 16585 | RSS: Main: 168374272 05:34:30 INFO - PROCESS | 16585 | 05:34:33 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59986/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:33 INFO - PROCESS | 16585 | RSS: Main: 168943616 05:34:33 INFO - PROCESS | 16585 | 05:34:37 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59986/tests/kraken/driver.html?testName=imaging-desaturate) 05:34:38 INFO - PROCESS | 16585 | RSS: Main: 166637568 05:34:38 INFO - PROCESS | 16585 | 05:34:41 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59986/tests/kraken/driver.html?testName=json-parse-financial) 05:34:41 INFO - PROCESS | 16585 | RSS: Main: 168026112 05:34:41 INFO - PROCESS | 16585 | 05:34:43 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59986/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:34:44 INFO - PROCESS | 16585 | RSS: Main: 168120320 05:34:44 INFO - PROCESS | 16585 | 05:34:45 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59986/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:34:46 INFO - PROCESS | 16585 | RSS: Main: 168345600 05:34:46 INFO - PROCESS | 16585 | 05:34:48 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59986/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:34:49 INFO - PROCESS | 16585 | RSS: Main: 168583168 05:34:49 INFO - PROCESS | 16585 | 05:34:52 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:34:53 INFO - PROCESS | 16585 | RSS: Main: 168792064 05:34:53 INFO - PROCESS | 16585 | 05:34:55 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:34:56 INFO - PROCESS | 16585 | RSS: Main: 168419328 05:34:56 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | Cycle 1(1): loaded http://localhost:59986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59986/tests/kraken/driver.html?testName=ai-astar) 05:34:58 INFO - PROCESS | 16585 | RSS: Main: 169476096 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | __start_tp_report 05:34:58 INFO - PROCESS | 16585 | _x_x_mozilla_page_load 05:34:58 INFO - PROCESS | 16585 | _x_x_mozilla_page_load_details 05:34:58 INFO - PROCESS | 16585 | |i|pagename|runs| 05:34:58 INFO - PROCESS | 16585 | |0;ai-astar;118;111;119;113;113;117;115;113;113;114 05:34:58 INFO - PROCESS | 16585 | |1;audio-beat-detection;162;131;164;183;130;162;156;133;190;133 05:34:58 INFO - PROCESS | 16585 | |2;audio-dft;163;165;165;179;163;162;164;164;165;162 05:34:58 INFO - PROCESS | 16585 | |3;audio-fft;77;77;77;164;78;78;77;76;161;77 05:34:58 INFO - PROCESS | 16585 | |4;audio-oscillator;86;86;144;87;86;86;127;87;86;146 05:34:58 INFO - PROCESS | 16585 | |5;imaging-gaussian-blur;117;118;118;118;121;118;118;117;118;118 05:34:58 INFO - PROCESS | 16585 | |6;imaging-darkroom;148;152;148;154;148;148;148;149;149;147 05:34:58 INFO - PROCESS | 16585 | |7;imaging-desaturate;98;95;95;95;96;95;99;95;95;96 05:34:58 INFO - PROCESS | 16585 | |8;json-parse-financial;65;67;65;65;66;69;66;68;65;66 05:34:58 INFO - PROCESS | 16585 | |9;json-stringify-tinderbox;65;65;67;65;65;64;66;65;65;65 05:34:58 INFO - PROCESS | 16585 | |10;stanford-crypto-aes;85;83;84;90;86;85;92;86;107;90 05:34:58 INFO - PROCESS | 16585 | |11;stanford-crypto-ccm;142;144;142;143;134;143;131;142;136;132 05:34:58 INFO - PROCESS | 16585 | |12;stanford-crypto-pbkdf2;176;172;175;169;169;169;171;171;175;169 05:34:58 INFO - PROCESS | 16585 | |13;stanford-crypto-sha256-iterative;70;68;69;68;68;69;71;66;67;68 05:34:58 INFO - PROCESS | 16585 | __end_tp_report 05:34:58 INFO - PROCESS | 16585 | __start_cc_report 05:34:58 INFO - PROCESS | 16585 | _x_x_mozilla_cycle_collect,1010 05:34:58 INFO - PROCESS | 16585 | __end_cc_report 05:34:58 INFO - PROCESS | 16585 | __startTimestamp1465216498555__endTimestamp 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | ------- Summary: start ------- 05:34:58 INFO - PROCESS | 16585 | Number of tests: 14 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.50 stddev:2.59 (2.3%) stddev-sans-first:2.44 05:34:58 INFO - PROCESS | 16585 | Values: 118.0 111.0 119.0 113.0 113.0 117.0 115.0 113.0 113.0 114.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:162.00 stddev:22.00 (13.6%) stddev-sans-first:23.16 05:34:58 INFO - PROCESS | 16585 | Values: 162.0 131.0 164.0 183.0 130.0 162.0 156.0 133.0 190.0 133.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:4.98 (3.0%) stddev-sans-first:5.22 05:34:58 INFO - PROCESS | 16585 | Values: 163.0 165.0 165.0 179.0 163.0 162.0 164.0 164.0 165.0 162.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#3] audio-fft Cycles:10 Average:94.20 Median:77.00 stddev:36.01 (46.8%) stddev-sans-first:37.65 05:34:58 INFO - PROCESS | 16585 | Values: 77.0 77.0 77.0 164.0 78.0 78.0 77.0 76.0 161.0 77.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:86.00 stddev:25.94 (30.2%) stddev-sans-first:26.85 05:34:58 INFO - PROCESS | 16585 | Values: 86.0 86.0 144.0 87.0 86.0 86.0 127.0 87.0 86.0 146.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.10 (0.9%) stddev-sans-first:1.09 05:34:58 INFO - PROCESS | 16585 | Values: 117.0 118.0 118.0 118.0 121.0 118.0 118.0 117.0 118.0 118.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:148.50 stddev:2.18 (1.5%) stddev-sans-first:2.28 05:34:58 INFO - PROCESS | 16585 | Values: 148.0 152.0 148.0 154.0 148.0 148.0 148.0 149.0 149.0 147.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.45 (1.5%) stddev-sans-first:1.32 05:34:58 INFO - PROCESS | 16585 | Values: 98.0 95.0 95.0 95.0 96.0 95.0 99.0 95.0 95.0 96.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.41 05:34:58 INFO - PROCESS | 16585 | Values: 65.0 67.0 65.0 65.0 66.0 69.0 66.0 68.0 65.0 66.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 05:34:58 INFO - PROCESS | 16585 | Values: 65.0 65.0 67.0 65.0 65.0 64.0 66.0 65.0 65.0 65.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:86.00 stddev:7.04 (8.2%) stddev-sans-first:7.33 05:34:58 INFO - PROCESS | 16585 | Values: 85.0 83.0 84.0 90.0 86.0 85.0 92.0 86.0 107.0 90.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:142.00 stddev:5.07 (3.6%) stddev-sans-first:5.25 05:34:58 INFO - PROCESS | 16585 | Values: 142.0 144.0 142.0 143.0 134.0 143.0 131.0 142.0 136.0 132.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.50 stddev:2.80 (1.6%) stddev-sans-first:2.47 05:34:58 INFO - PROCESS | 16585 | Values: 176.0 172.0 175.0 169.0 169.0 169.0 171.0 171.0 175.0 169.0 05:34:58 INFO - PROCESS | 16585 | 05:34:58 INFO - PROCESS | 16585 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.43 (2.1%) stddev-sans-first:1.39 05:34:58 INFO - PROCESS | 16585 | Values: 70.0 68.0 69.0 68.0 68.0 69.0 71.0 66.0 67.0 68.0 05:34:58 INFO - PROCESS | 16585 | -------- Summary: end -------- 05:34:58 INFO - PROCESS | 16585 | 05:34:59 INFO - TEST-INFO | 16585: exit 0 05:34:59 INFO - TEST-OK | kraken | took 64105ms 05:34:59 INFO - SUITE-END | took 1179s 05:35:00 INFO - Completed test suite (00:19:40) 05:35:00 INFO - javascript benchmark 05:35:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6309.791045502123, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.5835795451703, 2687.7177896320873, 2701.2166471723203, 2707.363769514165, 2737.4661940921515, 4703.764811759415, 4766.0, 4801.711897286165, 4812.037592481504, 4863.513648635135, 4738.881527961803, 4765.737884416356, 4810.302506136608, 4813.518648135185, 4820.0600882827775, 4233.44965154531, 4349.565043495657, 4423.88940276494, 4494.550544945512, 4530.501644819067, 4427.933580996288, 4499.257622492285, 4506.1663592235545, 4553.635709143277, 4566.246569316058, 4345.261305578059, 4389.517153113155, 4395.63735242076, 4413.404190434282, 4418.823247070113, 4416.668749843775, 4425.645948324126, 4431.778411079433, 4444.755538445384, 4468.5531446855375, 4333.71830830995, 4377.518472967971, 4412.029353542215, 4456.353828694853, 4456.598906098467, 4627.699199552018, 4708.176069187913, 4722.716637001757, 4726.054789042205, 4741.596964258042, 5154.12379895415, 5170.57648557425, 5183.50756678115, 5187.481251874782, 5212.713300768456, 5092.821751238689, 5144.536991670768, 5222.4255331913455, 5224.817131400421, 5229.241759944786, 4806.49531799163, 4829.0, 4833.3958255218095, 4874.439439464436, 4877.12211801879, 5267.104592219332, 5267.446918073624, 5271.235670827785, 5277.102892508283, 5296.099663057213, 5004.124278251292, 5049.520295571915, 5058.418281897629, 5077.949220507821, 5097.0, 4978.751062446863, 5134.691918484903, 5136.4606716295, 5164.483551644806, 5183.403908550489, 5123.2827404163445, 5127.589792816566, 5131.435542090367, 5133.383993920754, 5172.069027574998, 4900.8774780630765, 5049.2173713074535, 5101.2603172539775, 5128.1282182029145, 5143.794248230029, 4327.697061205686, 4328.891777705582, 4332.285172946428, 4352.760598167068, 4361.542038085955, 3738.813059347076, 3781.054736315921, 3792.070942619021, 3794.5446546414605, 3821.082940094413, 4475.060237350128, 4486.147631949919, 4545.6817522918645, 4547.9312361595, 4550.817967281338, 5201.375834899836, 5206.062908676399, 5224.242484839677, 5226.033183860998, 5236.136037553837, 4382.035952090599, 4460.955390446119, 4525.04973955473, 4535.818567257273, 4586.036932244266, 4603.838865639686, 4627.213373726475, 4640.443146822403, 4642.303654451859, 4686.250199968057, 4861.27080937855, 4866.756662166948, 4898.853034408973, 4902.8774280643265, 4938.703677779345, 4953.578945789648, 5133.101707201299, 5135.8716032098, 5177.249298851721, 5212.530872221519, 4882.316475693477, 4905.190643543775, 4906.092372911023, 4922.92615610759, 4961.925571116509, 5128.205128205134, 5132.5893928486375, 5138.049460849755, 5141.357330333708, 5179.249008893765, 5024.171011783015, 5143.794248230029, 5185.455527169593, 5191.32512773337, 5192.350956130484, 4840.685355451885, 4984.102861484967, 4997.325361076353, 5004.5746111579465, 5066.670666406671, 5051.368578927634, 5063.13926632466, 5063.544281014726, 5066.518680725325, 5111.412187598474, 4817.1810792164715, 4873.049755297683, 4975.577075948585, 4978.601711863114, 4990.051890141007, 5061.898762024665, 5107.233914912793, 5119.923201151912, 5142.6400151989, 5173.844784656466, 5000.224965130411, 5031.723255220998, 5033.773480193473, 5034.244863270539, 5092.0], "value": 4736.672096365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.1874151289053, 588.8881112588608, 598.7186022569391, 606.939306069393, 625.4089885058621, 34274.143146421324, 37757.24485510295, 37885.62114378855, 37916.81041594792, 37964.43053354202, 37943.4308485373, 38554.0, 38713.41929871054, 38891.0, 38934.610653893455, 7433.33100020998, 7553.433492488058, 7554.735584254552, 7560.357369623589, 7568.62156892156, 7537.54774713519, 7671.731489397872, 7686.923130768705, 7693.615319234043, 7710.460267781257, 7668.961655191716, 7699.88450173245, 7720.227977202291, 7728.0, 7744.109427415835, 7612.467127301091, 7626.122995855492, 7627.122880868716, 7716.6527506262355, 7717.228277172294, 7614.0, 7689.807754806118, 7693.153753087212, 7703.3067023968115, 7728.381729461686, 36175.81912090423, 36330.910072697865, 36530.8173459131, 36600.26799464023, 36675.26649467022, 3204.7115759581516, 3211.1811488070393, 3302.290007648343, 3350.5811773528308, 3646.6717995380545, 28862.855685721435, 28923.276918077005, 29018.854905725337, 29388.0, 29535.0, 3272.918177045569, 3390.69483746464, 3417.419038763416, 3435.553378060836, 3460.602030766444, 230003.44970677514, 230329.0, 231117.84441077855, 231194.0, 232377.0, 31680.36639267202, 32600.510992335134, 51900.74049629728, 52374.21438678423, 52420.21369679458, 33974.49038264428, 34064.65935340615, 34088.318233635684, 34146.317073658385, 34305.0, 12059.276443413248, 12159.574414895436, 12193.45129469176, 12236.327002014974, 12289.1397602167, 9671.0, 9840.409575425498, 9846.556904939294, 9853.950730246446, 9878.753031174134, 7906.723264685708, 7916.0, 7963.362930965509, 7995.440319177718, 8054.154313797084, 3151.8266495342978, 3172.952405713916, 3214.3249917517114, 3221.597300337458, 3239.2286698581775, 897.7037577599376, 937.7186843946926, 981.2640519610293, 998.6155330197781, 1004.6282875336026, 27277.181684549494, 28179.43641127207, 28415.71584284172, 28706.569401458994, 28946.0, 1001.47923079998, 1022.2026819081128, 1046.9371837689612, 1071.2661826648614, 1100.2243418390176, 14912.328945197492, 15140.697186056217, 15265.923670381577, 15442.0, 15549.455769048029, 358545.0, 360303.0, 361530.0, 361664.0, 361825.0, 48311.5168848307, 48753.268700969515, 48838.26742598864, 49091.0, 49237.261441078415, 1158.1082566423975, 1171.2855158353398, 1197.6227488341144, 1204.8192771084232, 1235.0490122605543, 26978.190654280403, 28040.85979570089, 28161.577576336782, 28395.716042840133, 28457.288567785145, 42131.789341054326, 42381.57618423776, 42456.36315455209, 42689.786551067045, 42728.78635606802, 329387.0, 330661.0, 331612.0, 332267.0, 332417.0, 24992.0, 25111.372215694755, 25376.74623253818, 25864.741352586232, 25867.482650347265, 42011.579884200764, 42517.787411062745, 42834.785826071915, 43097.0, 43210.78394608007, 36631.0, 36990.44514332341, 37076.0, 37532.624673752915, 37731.0, 36608.81695591505, 36860.81569592135, 37106.628933710315, 37142.44286335761, 37697.2460550793, 30690.386192275582, 35794.64205358017, 36232.81883590565, 36320.81839590785, 39357.409638856014, 31971.040868773973, 32994.835025824716, 33164.33671326608, 33284.33431331311, 33395.165120872174, 23554.175603853782, 23558.764412355657, 23658.171963981178, 23663.0, 23789.524209516057], "value": 16297.40125112108, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.92887957968605, 352.202261876849, 359.14702581369244, 365.8701161087812, 367.94112941929296, 15828.762568561466, 16576.75134872978, 17350.82649173508, 17358.56603584911, 17639.82360176398, 15975.440859569888, 16453.25960331785, 17300.56748581283, 17338.133093345346, 17371.0, 4977.328060711812, 5123.513266239701, 5130.6152038597065, 5148.279240906258, 5190.662606930538, 3713.8700145494913, 5045.772940217699, 5714.685692286923, 6032.125341825433, 6050.2437195350585, 6046.848828779293, 6047.818565443044, 6068.393160683919, 6071.423214794588, 6093.360197179299, 4854.635902307324, 5151.459096794839, 5185.0, 5248.265242866002, 5255.500727430888, 5094.083065048289, 5120.436751957282, 5125.718085505296, 5288.391834938954, 5311.840644780663, 11501.252418592849, 11575.652730418102, 11614.709632259177, 11706.122040846885, 16283.348666053344, 1833.9174737136727, 1846.2984066054948, 1940.233607724955, 1941.679622862226, 1998.2107067708173, 8248.505089694578, 8417.11620279868, 8589.35579831509, 8624.784380390478, 8685.392022558424, 1715.5453804741753, 1747.484492074841, 1804.0979510244877, 1825.6531259060869, 1828.2778302570543, 66145.0, 69781.65109174473, 69804.0, 69847.65076174638, 69930.30069699288, 8348.916510834813, 8439.95780021096, 9700.835899691941, 9752.073553012453, 9793.559289831976, 13032.152910060815, 13067.281299528428, 13092.476300948047, 13193.47226110964, 13199.868001320056, 7340.11918569775, 7343.816404589928, 7348.816279593053, 7428.73999410018, 7432.2567743225245, 7037.824054398681, 7217.74737884182, 7240.818979525554, 7295.890561641473, 7349.118105827335, 4009.51885773709, 4060.6548443382644, 4089.591040895946, 4098.180363927167, 4223.472065991751, 1581.6915701438108, 1662.3267576631483, 1698.8640908727273, 1728.87897847152, 1738.8435040846384, 849.748553936665, 858.888344515209, 866.1425189062909, 948.7580666930027, 978.2272005116021, 15687.0, 16117.355305787873, 16290.83709162917, 16959.15204239783, 17095.059771712426, 874.5670892908051, 876.4084243135858, 880.7709995401242, 890.8262888736764, 912.4160537256162, 9357.859632105525, 9392.577334019848, 9427.689857668984, 9458.385204961656, 9564.569594368131, 394165.0, 394513.0, 395162.0, 395460.0, 397469.0, 70594.88215353548, 78296.21703783004, 79992.0, 80221.0, 81978.0, 912.3795818843117, 915.8992510823804, 957.5355952363099, 962.4369743700014, 967.6516454076527, 15176.392944282547, 15503.689926201187, 15507.457238997033, 15605.531834044998, 16005.03969761818, 35536.64463355333, 36295.0, 36613.26773464462, 36903.44644830383, 36975.81512092422, 47633.0, 48905.02189956252, 49248.50751492439, 49785.75107124441, 50937.74531127469, 7302.795038818748, 7475.028246327943, 7537.321641052332, 7570.735024274124, 7822.5697586631, 7879.566623835744, 11017.614383496539, 12053.51785928553, 12111.515539378679, 12142.453589588313, 10100.343477674222, 10245.590176392861, 10435.217358697977, 10457.738556536147, 10599.205059620714, 10326.380417174994, 10367.118794902517, 10433.53049112807, 10519.631812886511, 10645.574177032831, 9573.803274590677, 10403.075431045281, 10484.947575262075, 10564.313319634199, 10671.57313707443, 7250.3112204340505, 7593.506422082547, 7626.161122276434, 7689.692412303445, 7694.07671079474, 9093.590788414405, 9764.316497845082, 10109.443980581138, 10159.44123073238, 10364.896351036394], "value": 8021.8645120648125, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.6090575091846, 1464.2971373740604, 1585.6749366379893, 1751.982480175198, 1758.629804934736, 6876.2092359378685, 7519.097708275008, 7771.4171437142295, 7946.086200086992, 7950.880736788953, 7780.92219077809, 7980.800479988004, 7983.680652773882, 7994.880076798838, 8036.116027237013, 2168.9566208675856, 2201.438633148545, 2203.4050806282294, 2206.58074965756, 2215.180383258197, 2173.6630822222583, 2204.7795220477906, 2214.7674494178123, 2215.3907675389237, 2217.833662475313, 2166.880821554814, 2170.2295685031822, 2188.715466989297, 2193.5393567350875, 2231.319447568491, 2122.7028216049766, 2124.5538436928264, 2130.137294395772, 2132.914683412662, 2140.0, 2132.115172203534, 2160.3087012156116, 2164.448065743241, 2184.421128400975, 2196.967045494319, 7955.204479552056, 8026.799330016738, 8028.438009339348, 8045.155258697811, 8049.476784009079, 4534.8186072557055, 4598.517155698671, 4640.0, 4654.069186162781, 4670.743109128996, 2815.53543665295, 2930.208843612234, 2978.106568029604, 3009.1273530676076, 3029.803062800911, 879.2438502887512, 892.1702816380763, 892.2193081054078, 896.0591379052034, 925.6019911438079, 10555.0, 10581.418022008786, 10732.892671073267, 10763.94618026905, 10769.192310576738, 4159.542450330461, 4231.640310573574, 4310.655147588185, 4319.632831209319, 4328.523862375137, 9122.179003889682, 9204.171624553688, 9206.815863682688, 9258.72223833286, 9279.907200927904, 4451.621612162938, 4503.729776213438, 4551.249043907718, 4576.97711511447, 4604.40142781443, 3684.613115622875, 3930.2532518821904, 4107.219628270619, 4165.479315085614, 4172.4784401949755, 3607.422812350064, 3630.2013557017412, 3707.7589956652732, 3776.263628592398, 3799.430085487199, 1169.561414469574, 1202.753435545711, 1205.626255860686, 1220.926744395339, 1238.2694210415898, 744.5867543513402, 853.4623187392027, 868.3096937934231, 880.6213328268906, 891.0243283604443, 5393.8112166074, 5604.103343465107, 5666.036773748473, 5700.344460387026, 5764.798232061941, 402.98992525187106, 420.4492115328929, 420.89477630592353, 425.75944591305813, 426.039281420395, 3780.7353485255767, 3890.844366225376, 3925.2738243425056, 3946.131850992777, 3946.2896678598127, 9389.953050234704, 9793.951030244803, 9821.607135714634, 9837.458939758382, 9876.604935802487, 9270.814583708288, 9587.18508926735, 9699.418034917928, 9705.951470242744, 9769.169620582188, 7177.89233161503, 7287.052683151051, 7290.817729556804, 7300.941363502262, 7385.889211661829, 5590.692511911884, 5752.71236438168, 5788.681622510802, 5835.0, 5968.343482217039, 8929.866052009354, 9049.32130090259, 9114.589843457194, 9125.22435592982, 9228.907710922806, 9147.954260228656, 9203.815923681355, 9234.353595248269, 9360.672376466791, 9376.29677774156, 6140.324564298013, 6564.606123632407, 6808.183018037867, 6823.38589526945, 7024.227334993249, 7502.699892004477, 7531.171571127281, 7733.458657893893, 7750.8837367440665, 7753.689852405841, 6570.145881035626, 6684.766033188815, 6726.966365168143, 6760.391564759196, 6777.0, 6705.396514313735, 6715.328467153246, 6733.562318449285, 6823.420009299265, 6858.108445902001, 6396.456301214263, 6616.90074648871, 6675.666216689243, 6685.364890335605, 6708.161479815023, 4813.085513752376, 4907.0431265904235, 4945.2582112683385, 5042.243663450512, 5043.87390315245, 5004.5746111579465, 5049.520295571915, 5061.089003979172, 5071.315372424823, 5113.693178409308], "value": 4137.226990073155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.17209146970714, 280.5973428130632, 285.39923461114347, 288.06092139624815, 290.645412596632, 4837.201861692825, 4929.852104436873, 4942.258661200822, 5044.4198917124495, 5052.646314757963, 4828.637852161084, 4914.827981020665, 4957.677750946186, 4960.767654555447, 4968.2795994580765, 3885.737135430982, 3896.162325100103, 3903.8243279052513, 3908.257431088084, 3911.765294082364, 3620.294042661682, 3877.8836634901, 3888.416737489371, 3890.455336252927, 3924.2936271471126, 3762.2475504898994, 3797.6012518685416, 3799.145192331717, 3803.3724435468116, 3815.2560250751117, 3815.637514436124, 3817.1602247505502, 3823.350030494809, 3830.735857167142, 3837.2325534892852, 3315.8673653053847, 3325.5676762021026, 3335.4329763940186, 3337.8831740889195, 3343.8829640962695, 4715.53818316323, 4754.477007529169, 4760.715106576451, 4841.0, 4853.3690620219495, 4287.271163902113, 4331.935020974688, 4347.891302717426, 4352.956470435287, 4364.039911219526, 5180.792768289301, 5181.533661970403, 5215.895682086375, 5225.477452254782, 5232.372115346183, 3457.59967213279, 3613.728970327236, 3659.4144936809985, 3659.670629643318, 3661.340958627446, 5442.8025834315995, 5450.31871016123, 5479.123460183396, 5489.313835770528, 5506.871091426248, 3678.0, 3686.668199862025, 3696.6303369663356, 3702.185519185775, 3703.370427027412, 3743.6630703236838, 3746.2882052409955, 3751.643593858579, 3755.830987605564, 3757.812109394519, 4077.429159917614, 4264.552222016706, 4273.572642735764, 4290.785460726951, 4298.237722533746, 5199.714015729096, 5225.346831646044, 5244.396894357122, 5263.789448422097, 5287.0, 1230.329470438613, 1302.2967597497245, 1320.8348956380453, 1321.6299436157892, 1327.6415367850818, 846.1792061700141, 851.9829603407898, 869.8782170496136, 872.616048938465, 873.5719497446206, 4141.461609990682, 4156.189543039079, 4173.9582604173565, 4181.330987042059, 4204.078165674888, 4815.566599006106, 4818.469968303484, 4825.638077144158, 4849.830255941025, 4849.908770526674, 4126.484189476316, 4131.648809851136, 4167.229062623424, 4169.020280234143, 4213.620774130343, 2420.2618201448377, 2511.309389917787, 2518.5199956130264, 2548.7128999854954, 2560.257525317674, 4486.080353527519, 4511.5262897395305, 4521.977390113028, 4533.526603853761, 4556.407667003268, 4922.458529561745, 4939.0, 4946.455889852114, 4966.063235338221, 4966.925496117561, 4588.325261279676, 4684.765761711901, 5139.8458046258675, 5145.768440420115, 5147.613928955268, 5414.269073675004, 5420.186971954238, 5435.211894275387, 5443.755031023535, 5458.771776350448, 5249.0, 5333.839984800462, 5355.410904800391, 5358.490943360374, 5380.650257733235, 5064.44291127983, 5094.2867998479505, 5100.005498927673, 5110.207917772751, 5126.974605079074, 3707.610700876477, 3729.254149170231, 3755.3052685253315, 3755.530558680165, 3763.7365384423924, 4897.363342765418, 5382.039878067126, 5408.729563521887, 5470.234167216672, 5492.670439773627, 5181.248718935658, 5211.583073354047, 5248.160294352885, 5255.211718242294, 5267.420583735862, 5233.450487698737, 5238.895222095461, 5264.684118952875, 5273.789048438173, 5282.603804714585, 4969.701817890938, 5157.174852023658, 5197.454267301879, 5206.97396513015, 5245.554127899019, 5310.9734451327495, 5312.362516498045, 5325.281087053353, 5326.721586819213, 5334.919976200437, 5172.948270517247, 5188.0, 5202.24567437727, 5243.764030618555, 5268.181522885238], "value": 3832.3996409400584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.8637193003503, 663.293592324175, 677.6848765324123, 711.2922641971239, 719.3849258883654, 12216.81674774878, 12931.288779117145, 13111.475540978361, 13113.47546098156, 13147.145435546683, 12063.0, 12268.63194104176, 12281.938590307058, 12374.381280935962, 12484.126111172221, 631.2708821311393, 778.9182135875736, 788.8698364769834, 789.9960500197519, 790.3874497264609, 778.6068035641993, 779.6842278877035, 780.6252998560694, 801.8516574433719, 802.1417083720421, 830.1117803949776, 830.1408042675831, 836.3768992100863, 837.5644664774313, 837.694241601814, 826.050042451186, 827.1686954610608, 827.896512935883, 828.7638023163399, 829.9917000829975, 598.5032423088826, 599.1252770954412, 600.6456190847421, 601.6089541797822, 605.7516418268489, 12034.578789742405, 12044.759104817855, 12046.337451440168, 12053.698657533632, 12078.69803254917, 13209.669758256025, 13462.0, 13510.932445337809, 13511.527096551574, 13724.93137534316, 10589.947050264776, 10620.57517699291, 10669.786604267949, 10788.352698838095, 10893.237473376867, 3369.8652053917813, 3383.340248651514, 3429.5198672185916, 3455.188030812757, 3477.0, 51243.48756512462, 51883.22175167376, 51952.480475195145, 56361.71819140919, 56497.0, 9883.752906177404, 9986.0, 10061.144802691706, 10198.0, 10264.897351026544, 16812.57968550796, 16955.406560770312, 17088.145592720564, 17159.31362745476, 17191.742123868153, 6940.583564986117, 7113.608751518716, 7151.89272160918, 7168.856622867514, 7245.0, 3893.2408180405114, 3921.6274453927404, 3925.9214815703526, 3973.0663294125857, 3986.0234242610168, 3069.63164420271, 3165.984170079135, 3169.207698075481, 3171.6669749675953, 3172.2386627209767, 548.9423610520918, 553.6097051578628, 564.5737468211474, 564.7232855900579, 576.2364866551752, 577.8468705792968, 616.8365383173463, 623.5977794322637, 630.7508534128993, 631.3654776949137, 7739.729109481141, 7869.763907082796, 7999.400044996649, 8196.713115040944, 8292.792680183044, 484.8739327774804, 551.6882961126951, 594.3462191589304, 597.7698586044404, 606.5269090109722, 3798.8100594970692, 3805.296020236265, 3912.315344814646, 3966.7421617594764, 4070.5115386153852, 68815.65592172107, 71818.0, 72550.0, 83440.0, 88556.5572172148, 52229.47770522246, 74512.62743686355, 75106.24893750992, 75693.62153189199, 76025.0, 47645.5235447648, 71822.64088679523, 72323.6383818088, 72451.27548724551, 72913.0, 8653.740387788377, 8897.777555561162, 9119.726408207764, 9133.497657628894, 9176.495292758962, 31663.52504712477, 39843.402348964206, 42237.0, 43813.34279985739, 44491.77754111209, 36787.0, 53475.465245348605, 54766.72616636891, 59391.703041484514, 61276.38723612707, 10810.729731756768, 11021.173411994292, 11196.552137914718, 11199.328040317607, 11395.316281023164, 11799.49829690226, 11899.464524096264, 11912.285262884254, 12127.878721213028, 12159.756804863677, 11626.186166968231, 11682.357470339213, 11744.354060526412, 11977.0, 12355.567555135527, 11765.294082355085, 11839.171258011856, 12024.038076953997, 12078.094142939139, 12187.573434929735, 11096.833547496955, 11201.495932682887, 11339.433028348385, 11393.316401015965, 11509.366984815915, 9634.807303854024, 9708.708738737849, 9933.227407946488, 9966.202703783825, 10215.94892025535, 9878.357906736039, 10029.849552256575, 10066.54700538463, 10213.08082272599, 10250.0], "value": 6426.838173308332, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 111.0, 119.0, 113.0, 113.0, 117.0, 115.0, 113.0, 113.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 164.0, 183.0, 130.0, 162.0, 156.0, 133.0, 190.0, 133.0], "value": 154.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 179.0, 163.0, 162.0, 164.0, 164.0, 165.0, 162.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 164.0, 78.0, 78.0, 77.0, 76.0, 161.0, 77.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 144.0, 87.0, 86.0, 86.0, 127.0, 87.0, 86.0, 146.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 121.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 152.0, 148.0, 154.0, 148.0, 148.0, 148.0, 149.0, 149.0, 147.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 95.0, 95.0, 96.0, 95.0, 99.0, 95.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 66.0, 69.0, 66.0, 68.0, 65.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 65.0, 65.0, 64.0, 66.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 90.0, 86.0, 85.0, 92.0, 86.0, 107.0, 90.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 144.0, 142.0, 143.0, 134.0, 143.0, 131.0, 142.0, 136.0, 132.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 175.0, 169.0, 169.0, 169.0, 171.0, 171.0, 175.0, 169.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 68.0, 68.0, 69.0, 71.0, 66.0, 67.0, 68.0], "value": 68.4, "unit": "score"}]}]} 05:35:00 INFO - Return code: 0 05:35:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:35:00 ERROR - # TBPL SUCCESS # 05:35:00 INFO - Running post-action listener: _resource_record_post_action 05:35:00 INFO - ##### 05:35:00 INFO - ##### Finished run-tests step (success) 05:35:00 INFO - ##### 05:35:00 INFO - Running post-run listener: _resource_record_post_run 05:35:00 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 529752064; Read time: 24; Write time: 413116 05:35:00 INFO - TinderboxPrint: CPU usage
13.5% 05:35:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 05:35:00 INFO - TinderboxPrint: I/O write bytes / time
529,752,064 / 413,116 05:35:00 INFO - TinderboxPrint: CPU idle
8,263.3 (86.5%) 05:35:00 INFO - TinderboxPrint: CPU user
1,232.7 (12.9%) 05:35:00 INFO - TinderboxPrint: Swap in / out
0 / 0 05:35:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 243650560; Read time: 0; Write time: 195600 05:35:00 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 286101504; Read time: 24; Write time: 217516 05:35:00 INFO - Running post-run listener: _upload_blobber_files 05:35:00 INFO - Blob upload gear active. 05:35:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:00 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:35:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:35:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:35:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:35:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:02 INFO - (blobuploader) - INFO - Done attempting. 05:35:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:35:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:35:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:06 INFO - (blobuploader) - INFO - Done attempting. 05:35:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:35:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:35:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:07 INFO - (blobuploader) - INFO - Done attempting. 05:35:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:07 INFO - Return code: 0 05:35:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:35:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78729444e77c0b535dba970bad7c95ae0ddf61618d65d8b3b726d127eb39d33b34d6e35f081d7b941ce6750844a6d66e684f97b7b3da6782996e3050c6af0130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e66630f4a808f1f0476c7f2c5537851b04c925254fec4941f1d8b8beb38b68e7a1343af5bbe360209bae0006bce50198d3d2dabc6a9540e9644eac44bbec7605", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce26c2fefb610c2321d41f9c07c0b087a5a27cfa56e658fb874306d84a7c0713b3e5ca5b87c0d3123ced8f32dde4478965243bfe49623dfec2c699920570dbb7"} 05:35:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:35:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:35:07 INFO - Contents: 05:35:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78729444e77c0b535dba970bad7c95ae0ddf61618d65d8b3b726d127eb39d33b34d6e35f081d7b941ce6750844a6d66e684f97b7b3da6782996e3050c6af0130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e66630f4a808f1f0476c7f2c5537851b04c925254fec4941f1d8b8beb38b68e7a1343af5bbe360209bae0006bce50198d3d2dabc6a9540e9644eac44bbec7605", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce26c2fefb610c2321d41f9c07c0b087a5a27cfa56e658fb874306d84a7c0713b3e5ca5b87c0d3123ced8f32dde4478965243bfe49623dfec2c699920570dbb7"} 05:35:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:07 INFO - Copying logs to upload dir... 05:35:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:35:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.956762 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-06 05:35:06.456987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 05:35:06.461036) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78729444e77c0b535dba970bad7c95ae0ddf61618d65d8b3b726d127eb39d33b34d6e35f081d7b941ce6750844a6d66e684f97b7b3da6782996e3050c6af0130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e66630f4a808f1f0476c7f2c5537851b04c925254fec4941f1d8b8beb38b68e7a1343af5bbe360209bae0006bce50198d3d2dabc6a9540e9644eac44bbec7605", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce26c2fefb610c2321d41f9c07c0b087a5a27cfa56e658fb874306d84a7c0713b3e5ca5b87c0d3123ced8f32dde4478965243bfe49623dfec2c699920570dbb7"} build_url:https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011183 build_url: 'https://queue.taskcluster.net/v1/task/G5kplpIBRu2XJoJii0BdhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78729444e77c0b535dba970bad7c95ae0ddf61618d65d8b3b726d127eb39d33b34d6e35f081d7b941ce6750844a6d66e684f97b7b3da6782996e3050c6af0130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e66630f4a808f1f0476c7f2c5537851b04c925254fec4941f1d8b8beb38b68e7a1343af5bbe360209bae0006bce50198d3d2dabc6a9540e9644eac44bbec7605", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce26c2fefb610c2321d41f9c07c0b087a5a27cfa56e658fb874306d84a7c0713b3e5ca5b87c0d3123ced8f32dde4478965243bfe49623dfec2c699920570dbb7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 05:35:06.486669) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:35:06.486977) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465215266.792251-1095418067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004389 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:35:06.570347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 05:35:06.570674) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 05:35:06.570978) ========= ========= Total master_lag: 0.16 =========